vm-test-run-systemd-initrd-luks-tpm2
checks.aarch64-linux.systemd-initrd-luks-tpm2
· build #22
· 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=2522873856 backing_file=/nix/store/y8cl64ic9zz1y8vqc1q98xhcgj40cfr8-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: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'19machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)20machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(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'25machine: Guest shell says: b'\x1b[0m\x1b[37m\x1b[40m------------------------------------------'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.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 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=0x45a6a018 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\0d25fnkrmshwfx4rlzkifpabvrih975i-initrd-linux-6.18.49-initrd.efi init=/nix/store/xzh47bdh54r80g3ypvjp6isjmdcz7avn-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 74886 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 @0x0000000040920000133machine # [ 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.000034] arm-pv: using stolen time PV139machine # [ 0.000396] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)140machine # [ 0.000488] Console: colour dummy device 80x25141machine # [ 0.000492] printk: legacy console [tty0] enabled142machine # [ 0.000705] ACPI: Core revision 20250807143machine # [ 0.000780] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)144machine # [ 0.000787] pid_max: default: 32768 minimum: 301145machine # [ 0.000844] LSM: initializing lsm=capability,landlock,yama,bpf,ima146machine # [ 0.000977] landlock: Up and running.147machine # [ 0.000980] Yama: becoming mindful.148machine # [ 0.001425] LSM support for eBPF active149machine # [ 0.001504] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)150machine # [ 0.001512] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151machine # [ 0.002520] rcu: Hierarchical SRCU implementation.152machine # [ 0.002524] rcu: Max phase no-delay instances is 1000.153machine # [ 0.003200] fsl-mc MSI: ITS@0x8080000 domain created154machine # [ 0.003219] Remapping and enabling EFI services.155machine # [ 0.003343] smp: Bringing up secondary CPUs ...156machine # [ 0.003353] smp: Brought up 1 node, 1 CPU157machine # [ 0.003356] SMP: Total of 1 processors activated.158machine # [ 0.003358] CPU: All CPU(s) started at EL1159machine # [ 0.003369] CPU features: detected: Branch Target Identification160machine # [ 0.003374] CPU features: detected: ARMv8.4 Translation Table Level161machine # [ 0.003377] CPU features: detected: Instruction cache invalidation not required for I/D coherence162machine # [ 0.003381] CPU features: detected: Data cache clean to the PoU not required for I/D coherence163machine # [ 0.003385] CPU features: detected: Common not Private translations164machine # [ 0.003388] CPU features: detected: CRC32 instructions165machine # [ 0.003391] CPU features: detected: Data cache clean to Point of Deep Persistence166machine # [ 0.003394] CPU features: detected: Data cache clean to Point of Persistence167machine # [ 0.003397] CPU features: detected: Data independent timing control (DIT)168machine # [ 0.003400] CPU features: detected: E0PD169machine # [ 0.003403] CPU features: detected: Enhanced Counter Virtualization170machine # [ 0.003407] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)171machine # [ 0.003410] CPU features: detected: Enhanced Virtualization Traps172machine # [ 0.003413] CPU features: detected: Fine Grained Traps173machine # [ 0.003418] CPU features: detected: Generic authentication (architected QARMA5 algorithm)174machine # [ 0.003423] CPU features: detected: RCpc load-acquire (LDAPR)175machine # [ 0.003426] CPU features: detected: LSE atomic instructions176machine # [ 0.003429] CPU features: detected: Privileged Access Never177machine # [ 0.003431] CPU features: detected: PMUv3178machine # [ 0.003434] CPU features: detected: RAS Extension Support179machine # [ 0.003437] CPU features: detected: RASv1p1 Extension Support180machine # [ 0.003439] CPU features: detected: Random Number Generator181machine # [ 0.003442] CPU features: detected: Speculation barrier (SB)182machine # [ 0.003445] CPU features: detected: Stage-2 Force Write-Back183machine # [ 0.003447] CPU features: detected: TLB range maintenance instructions184machine # [ 0.003452] CPU features: detected: Speculative Store Bypassing Safe (SSBS)185machine # [ 0.003494] alternatives: applying system-wide alternatives186machine # [ 0.006253] CPU features: detected: BBM Level 2 without TLB conflict abort187machine # [ 0.006369] Memory: 887772K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 119508K reserved, 32768K cma-reserved)188machine # [ 0.006628] devtmpfs: initialized189machine # [ 0.007527] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)190machine # [ 0.007536] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).191machine # [ 0.007705] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL192machine # [ 0.007709] 0 pages in range for non-PLT usage193machine # [ 0.007710] 508288 pages in range for PLT usage194machine # [ 0.007792] pinctrl core: initialized pinctrl subsystem195machine # [ 0.008335] SMBIOS 3.0.0 present.196machine # [ 0.008341] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022197machine # [ 0.008349] DMI: Memory slots populated: 1/1198machine # [ 0.009660] NET: Registered PF_NETLINK/PF_ROUTE protocol family199machine # [ 0.010304] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations200machine # [ 0.010442] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations201machine # [ 0.010599] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202machine # [ 0.010618] audit: initializing netlink subsys (disabled)203machine # [ 0.011032] thermal_sys: Registered thermal governor 'fair_share'204machine # [ 0.011035] thermal_sys: Registered thermal governor 'bang_bang'205machine # [ 0.011039] thermal_sys: Registered thermal governor 'step_wise'206machine # [ 0.011041] thermal_sys: Registered thermal governor 'user_space'207machine # [ 0.011044] thermal_sys: Registered thermal governor 'power_allocator'208machine # [ 0.011069] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1209machine # [ 0.011081] cpuidle: using governor ladder210machine # [ 0.011089] cpuidle: using governor menu211machine # [ 0.011250] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.212machine # [ 0.011269] ASID allocator initialised with 65536 entries213machine # [ 0.011954] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5214machine # [ 0.012136] Serial: AMBA PL011 UART driver215machine # [ 0.018495] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages216machine # [ 0.018501] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page217machine # [ 0.018505] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages218machine # [ 0.018508] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page219machine # [ 0.018511] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages220machine # [ 0.018513] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page221machine # [ 0.018516] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages222machine # [ 0.018519] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page223machine # [ 0.019304] fbcon: Taking over console224machine # [ 0.019337] ACPI: Added _OSI(Module Device)225machine # [ 0.019341] ACPI: Added _OSI(Processor Device)226machine # [ 0.019343] ACPI: Added _OSI(Processor Aggregator Device)227machine # [ 0.020367] ACPI: 1 ACPI AML tables successfully acquired and loaded228machine # [ 0.026359] ACPI: Interpreter enabled229machine # [ 0.026363] ACPI: Using GIC for interrupt routing230machine # [ 0.026390] ACPI: MCFG table detected, 1 entries231machine # [ 0.030107] ACPI: CPU0 has been hot-added232machine # [ 0.030521] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA233machine # [ 0.030590] printk: console [ttyAMA0] enabled234machine # [ 0.097935] ACPI: PCI: Interrupt link L000 configured for IRQ 35235machine # [ 0.097951] ACPI: PCI: Interrupt link L001 configured for IRQ 36236machine # [ 0.097961] ACPI: PCI: Interrupt link L002 configured for IRQ 37237machine # [ 0.097972] ACPI: PCI: Interrupt link L003 configured for IRQ 38238machine # [ 0.097989] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])239machine # [ 0.098028] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]240machine # [ 0.098115] acpi PNP0A08:00: _OSC: platform does not support [LTR]241machine # [ 0.098211] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]242machine # [ 0.098459] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00243machine # [ 0.098477] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]244machine # [ 0.098498] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]245machine # [ 0.098830] PCI host bridge to bus 0000:00246machine # [ 0.098858] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]247machine # [ 0.098863] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]248machine # [ 0.098866] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]249machine # [ 0.098871] pci_bus 0000:00: root bus resource [bus 00-ff]250machine # [ 0.098874] PCI: OF: of_root node is NULL, cannot create PCI host bridge node251machine # [ 0.098948] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint252machine # [ 0.099436] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint253machine # [ 0.099611] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]254machine # [ 0.099623] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]255machine # [ 0.099647] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]256machine # [ 0.099659] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]257machine # [ 0.100131] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint258machine # [ 0.101115] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]259machine # [ 0.101128] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]260machine # [ 0.101153] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]261machine # [ 0.101700] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint262machine # [ 0.101883] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]263machine # [ 0.101894] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]264machine # [ 0.101920] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]265machine # [ 0.102427] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint266machine # [ 0.102599] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]267machine # [ 0.102610] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]268machine # [ 0.102635] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]269machine # [ 0.215478] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint270machine # [ 0.215673] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]271machine # [ 0.215690] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]272machine # [ 0.215719] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]273machine # [ 0.216212] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.217046] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]275machine # [ 0.217067] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]276machine # [ 0.217098] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]277machine # [ 0.217690] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint278machine # [ 0.217885] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]279machine # [ 0.217901] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]280machine # [ 0.217934] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]281machine # [ 0.227921] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint282machine # [ 0.228106] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]283machine # [ 0.228123] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]284machine # [ 0.228153] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]285machine # [ 0.228170] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]286machine # [ 0.228659] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint287machine # [ 0.229891] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]288machine # [ 0.229928] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]289machine # [ 0.230436] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint290machine # [ 0.230621] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]291machine # [ 0.230651] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]292machine # [ 0.240365] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint293machine # [ 0.241426] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]294machine # [ 0.241826] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.242557] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]296machine # [ 0.242577] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]297machine # [ 0.242607] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]298machine # [ 0.243124] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.243799] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]300machine # [ 0.243818] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]301machine # [ 0.243847] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]302machine # [ 0.252417] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.252435] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.252441] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.252786] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.252833] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.252880] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.252927] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.252974] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.253021] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.253069] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.262413] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.263478] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.263533] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.263581] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned316machine # [ 0.263626] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.263648] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.263670] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.263693] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.263715] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.263737] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.263759] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.263781] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.263803] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.264303] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.264329] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.264852] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.264877] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned329machine # [ 0.264899] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.265381] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned331machine # [ 0.265405] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned332machine # [ 0.265427] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned333machine # [ 0.265954] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned334machine # [ 0.265978] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned335machine # [ 0.286169] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned336machine # [ 0.286201] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned337machine # [ 0.286225] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned338machine # [ 0.286248] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned339machine # [ 0.286885] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]340machine # [ 0.286898] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]341machine # [ 0.286905] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]342machine # [ 0.295189] iommu: Default domain type: Translated343machine # [ 0.295204] iommu: DMA domain TLB invalidation policy: strict mode344machine # [ 0.296770] SCSI subsystem initialized345machine # [ 0.297374] ACPI: bus type USB registered346machine # [ 0.297416] usbcore: registered new interface driver usbfs347machine # [ 0.297437] usbcore: registered new interface driver hub348machine # [ 0.297453] usbcore: registered new device driver usb349machine # [ 0.297671] pps_core: LinuxPPS API ver. 1 registered350machine # [ 0.297679] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>351machine # [ 0.297695] PTP clock support registered352machine # [ 0.297737] EDAC MC: Ver: 3.0.0353machine # [ 0.302929] scmi_core: SCMI protocol bus registered354machine # [ 0.303656] efivars: Registered efivars operations355machine # [ 0.304623] FPGA manager framework356machine # [ 0.305469] vgaarb: loaded357machine # [ 0.306036] clocksource: Switched to clocksource arch_sys_counter358machine # [ 0.306350] VFS: Disk quotas dquot_6.6.0359machine # [ 0.306377] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360machine # [ 0.309947] netfs: FS-Cache loaded361machine # [ 0.310486] pnp: PnP ACPI init362machine # [ 0.310672] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved363machine # [ 0.310723] pnp: PnP ACPI: found 1 devices364machine # [ 0.315340] NET: Registered PF_INET protocol family365machine # [ 0.315406] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)366machine # [ 0.335208] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)367machine # [ 0.335252] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)368machine # [ 0.335276] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)369machine # [ 0.335324] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370machine # [ 0.335402] TCP: Hash tables configured (established 8192 bind 8192)371machine # [ 0.335475] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)372machine # [ 0.335505] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)373machine # [ 0.335530] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)374machine # [ 0.335616] NET: Registered PF_UNIX/PF_LOCAL protocol family375machine # [ 0.335638] NET: Registered PF_XDP protocol family376machine # [ 0.336336] PCI: CLS 0 bytes, default 64377machine # [ 0.336549] Trying to unpack rootfs image as initramfs...378machine # [ 0.351581] kvm [1]: HYP mode not available379machine # [ 0.447307] Initialise system trusted keyrings380machine # [ 0.448056] workingset: timestamp_bits=42 max_order=18 bucket_order=0381machine # [ 0.449268] squashfs: version 4.0 (2009/01/31) Phillip Lougher382machine # [ 0.450056] 9p: Installing v9fs 9p2000 file system support383machine # [ 0.469932] Key type asymmetric registered384machine # [ 0.469962] Asymmetric key parser 'x509' registered385machine # [ 0.478070] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)386machine # [ 0.479175] io scheduler mq-deadline registered387machine # [ 0.479190] io scheduler kyber registered388machine # [ 0.490084] ledtrig-cpu: registered to indicate activity on CPUs389machine # [ 0.492222] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0390machine # [ 0.492293] ACPI: button: Power Button [PWRB]391machine # [ 0.520688] ACPI: \_SB_.L001: Enabled at IRQ 36392machine # [ 0.520751] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)393machine # [ 0.524466] ACPI: \_SB_.L002: Enabled at IRQ 37394machine # [ 0.524513] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)395machine # [ 0.527480] ACPI: \_SB_.L003: Enabled at IRQ 38396machine # [ 0.527514] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)397machine # [ 0.529623] ACPI: \_SB_.L000: Enabled at IRQ 35398machine # [ 0.529658] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)399machine # [ 0.539714] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)400machine # [ 0.542024] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)401machine # [ 0.552673] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)402machine # [ 0.559512] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)403machine # [ 0.567296] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)404machine # [ 0.569329] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)405machine # [ 0.579479] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)406machine # [ 0.587917] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled407machine # [ 0.590335] msm_serial: driver initialized408machine # [ 0.590454] SuperH (H)SCI(F) driver initialized409machine # [ 0.590492] STM32 USART driver initialized410machine # [ 0.615771] ACPI: bus type drm_connector registered411machine # [ 0.622265] loop: module loaded412machine # [ 0.622460] virtio_blk virtio5: 1/0/0 default/read/poll queues413machine # [ 0.623110] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)414machine # [ 0.666096] vda: vda1 vda2415machine # [ 0.666513] virtio_blk virtio6: 1/0/0 default/read/poll queues416machine # [ 0.667298] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)417machine # [ 0.674688] megasas: 07.734.00.00-rc1418machine # [ 0.676980] tun: Universal TUN/TAP device driver, 1.6419machine # [ 0.679954] thunder_xcv, ver 1.0420machine # [ 0.679995] thunder_bgx, ver 1.0421machine # [ 0.680019] nicpf, ver 1.0422machine # [ 0.680551] e1000: Intel(R) PRO/1000 Network Driver423machine # [ 0.680560] e1000: Copyright (c) 1999-2006 Intel Corporation.424machine # [ 0.680584] e1000e: Intel(R) PRO/1000 Network Driver425machine # [ 0.680591] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.426machine # [ 0.680625] igb: Intel(R) Gigabit Ethernet Network Driver427machine # [ 0.680632] igb: Copyright (c) 2007-2014 Intel Corporation.428machine # [ 0.680655] igbvf: Intel(R) Gigabit Virtual Function Network Driver429machine # [ 0.680662] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.430machine # [ 0.680794] sky2: driver version 1.30431machine # [ 0.683073] ehci-pci 0000:00:0b.0: EHCI Host Controller432machine # [ 0.683103] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 1433machine # [ 0.683287] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a000434machine # [ 0.693905] usbcore: registered new interface driver usb-storage435machine # [ 0.693972] usbcore: registered new interface driver usbserial_generic436machine # [ 0.693988] usbserial: USB Serial support registered for generic437machine # [ 0.694067] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.00438machine # [ 0.697588] hv_vmbus: registering driver hyperv_keyboard439machine # [ 0.697958] hub 1-0:1.0: USB hub found440machine # [ 0.697980] hub 1-0:1.0: 6 ports detected441machine # [ 0.700589] rtc-efi rtc-efi.0: registered as rtc0442machine # [ 0.701205] rtc-efi rtc-efi.0: setting system clock to 2026-09-06T07:01:02 UTC (1788678062)443machine # [ 0.701525] i2c_dev: i2c /dev entries driver444machine # [ 0.705462] sdhci: Secure Digital Host Controller Interface driver445machine # [ 0.705476] sdhci: Copyright(c) Pierre Ossman446machine # [ 0.705705] Synopsys Designware Multimedia Card Interface Driver447machine # [ 0.714113] sdhci-pltfm: SDHCI platform and OF driver helper448machine # [ 0.715301] pstore: Using crash dump compression: deflate449machine # [ 0.715311] pstore: Registered efi_pstore as persistent store backend450machine # [ 0.716196] hid: raw HID events driver (C) Jiri Kosina451machine # [ 0.716459] usbcore: registered new interface driver usbhid452machine # [ 0.716468] usbhid: USB HID core driver453machine # [ 0.721406] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available454machine # [ 0.722783] drop_monitor: Initializing network drop monitor service455machine # [ 0.722962] NET: Registered PF_INET6 protocol family456machine # [ 0.730582] Segment Routing with IPv6457machine # [ 0.730612] In-situ OAM (IOAM) with IPv6458machine # [ 0.730643] NET: Registered PF_PACKET protocol family459machine # [ 0.732352] 9pnet: Installing 9P2000 support460machine # [ 0.735153] Key type dns_resolver registered461machine # [ 0.749407] registered taskstats version 1462machine # [ 0.749599] Loading compiled-in X.509 certificates463machine # [ 0.774078] Demotion targets for Node 0: null464machine # [ 0.774895] Key type .fscrypt registered465machine # [ 0.774908] Key type fscrypt-provisioning registered466machine # [ 0.775047] ima: No TPM chip found, activating TPM-bypass!467machine # [ 0.775068] ima: Allocated hash algorithm: sha1468machine # [ 0.775091] ima: No architecture policies found469machine # [ 0.811342] clk: Disabling unused clocks470machine # [ 0.811375] PM: genpd: Disabling unused power domains471machine # [ 0.934404] Freeing initrd memory: 25580K472machine # [ 0.937895] Freeing unused kernel memory: 4736K473machine # [ 0.938687] Run /init as init process474machine # [ 0.946086] usb 1-1: new high-speed USB device number 2 using ehci-pci475machine # [ 0.957237] fuse: init (API version 7.45)476machine # [ 0.969734] systemd[1]: Successfully made /usr/ read-only.477machine # [ 1.096338] 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.166490] 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.290123] usb 1-2: new high-speed USB device number 3 using ehci-pci480machine # [ 1.304865] systemd[1]: systemd 262-726e17a 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.316904] systemd[1]: Detected virtualization kvm.482machine # [ 1.318890] systemd[1]: Detected architecture arm64.483machine # [ 1.320762] systemd[1]: Running in initrd.484machine # [ 1.323514] systemd[1]: Initializing machine ID from random generator.485machine # [ 1.326312] systemd[1]: Hostname set to <machine>.486machine # [ 1.455986] 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.458270] 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.480447] systemd[1]: bpf-restrict-fs: LSM BPF program attached489machine # [ 1.536823] systemd[1]: Queued start job for default target Initrd Default Target.490machine # [ 1.548070] systemd[1]: Created slice Slice /system/modprobe.491machine # [ 1.549032] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492machine # [ 1.550527] systemd[1]: Expecting device /dev/disk/by-label/nixos...493machine # [ 1.551675] systemd[1]: Expecting device /dev/tpm0...494machine # [ 1.552338] systemd[1]: Expecting device /dev/tpmrm0...495machine # [ 1.553015] systemd[1]: Reached target Path Units.496machine # [ 1.553636] systemd[1]: Reached target Slice Units.497machine # [ 1.554321] systemd[1]: Reached target Swaps.498machine # [ 1.554884] systemd[1]: Reached target Timer Units.499machine # [ 1.555731] systemd[1]: Listening on D-Bus System Message Bus Socket.500machine # [ 1.556690] systemd[1]: Listening on Journal Socket (/dev/log).501machine # [ 1.557560] systemd[1]: Listening on Journal Sockets.502machine # [ 1.558272] systemd[1]: Listening on udev Kernel Socket.503machine # [ 1.558972] systemd[1]: Reached target Socket Units.504machine # [ 1.561189] systemd[1]: Starting Create List of Static Device Nodes...505machine # [ 1.570108] systemd[1]: Starting Load Kernel Module 9pnet_virtio...506machine # [ 1.571212] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs507machine # [ 1.583635] systemd[1]: Mounting Kernel Configuration File System...508machine # [ 1.600696] systemd[1]: Starting Journal Service...509machine # [ 1.614295] systemd[1]: Starting Load Kernel Modules...510machine # [ 1.622348] systemd[1]: Starting Coldplug All udev Devices...511machine # [ 1.628060] systemd[1]: Finished Create List of Static Device Nodes.512machine # [ 1.631013] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513machine # [ 1.642452] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514machine # [ 1.643047] systemd[1]: Mounted Kernel Configuration File System.515machine # [ 1.654732] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...516machine # [ 1.699187] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.517machine # [ 1.705107] systemd-journald[72]: Collecting audit messages is disabled.518machine # [ 1.718232] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev519machine # [ 1.723240] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0520machine # [ 1.723501] [drm] features: -virgl +edid -resource_blob -host_visible521machine # [ 1.723514] [drm] features: -context_init522machine # [ 1.724265] [drm] number of scanouts: 1523machine # [ 1.724287] [drm] number of cap sets: 0524machine # [ 1.738881] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.525machine # [ 1.741920] systemd[1]: Starting Create Static Device Nodes in /dev...526machine # [ 1.746620] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic527machine # [ 1.746655] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0528machine # [ 1.766549] Console: switching to colour frame buffer device 160x50529machine # [ 1.798727] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device530machine # [ 1.802977] systemd[1]: Finished Create Static Device Nodes in /dev.531machine # [ 1.803238] systemd[1]: Reached target Preparation for Local File Systems.532machine # [ 1.803282] systemd[1]: Reached target Local File Systems.533machine # [ 1.809323] systemd[1]: Starting Rule-based Manager for Device Events and Files...534machine # [ 1.826234] systemd[1]: Finished Load Kernel Modules.535machine # [ 1.830437] systemd[1]: Starting Apply Kernel Variables...536machine # [ 1.886751] systemd[1]: Finished Apply Kernel Variables.537machine # [ 1.895546] systemd[1]: Started Journal Service.538machine # [ 1.876383] systemd-modules-load[73]: Inserted module 'dm_mod'539machine # [ 1.877621] systemd-modules-load[73]: Module 'virtio_balloon' is built in540machine # [ 1.878682] systemd-modules-load[73]: Module 'virtio_console' is built in541machine # [ 1.879772] systemd-modules-load[73]: Inserted module 'virtio_gpu'542machine # [ 1.892529] systemd-modules-load[73]: Module 'virtio_rng' is built in543machine # [ 1.895661] systemd[1]: Starting Create System Files and Directories...544machine # [ 1.909931] systemd-udevd[78]: Using default interface naming scheme 'v261'.545machine # [ 1.933228] systemd[1]: Finished Create System Files and Directories.546machine # [ 1.946998] systemd[1]: Started Rule-based Manager for Device Events and Files.547machine # [ 2.020175] systemd[1]: Starting Virtual Console Setup...548machine # [ 2.072561] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 2.076486] systemd[1]: Finished Virtual Console Setup.550machine # [ 2.742154] systemd[1]: Finished Coldplug All udev Devices.551machine # [ 2.871463] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.552machine # [ 2.910031] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.553machine # [ 2.913132] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.554machine # [ 3.070093] systemd[1]: Found device /dev/disk/by-label/nixos.555machine # [ 3.086508] systemd[1]: Reached target Initrd Root Device.556machine # [ 3.091627] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...557machine # [ 3.139347] systemd-fsck[110]: nixos: clean, 67477/137632 files, 417058/549888 blocks558machine # [ 3.149447] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.559machine # [ 3.153506] systemd[1]: Mounting /sysroot...560machine # [ 3.228436] EXT4-fs (vda2): mounted filesystem f222513b-ded1-49fa-b591-20ce86a2fe7f r/w with ordered data mode. Quota mode: none.561machine # [ 3.205111] systemd[1]: Mounted /sysroot.562machine # [ 3.207263] systemd[1]: Reached target Initrd Root File System.563machine # [ 3.212220] systemd[1]: Starting Mountpoints Configured in the Real Root...564machine # [ 3.240399] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.565machine # [ 3.247514] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...566machine # [ 3.249406] systemd[1]: Reloading...567machine # [ 3.485719] systemd[1]: Reloading finished in 234 ms.568machine # [ 3.515825] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...569machine # [ 3.522372] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...570machine # [ 3.528744] systemd[1]: Starting Load Kernel Module 9pnet_virtio...571machine # [ 3.538223] systemd[1]: initrd-parse-etc.service: Deactivated successfully.572machine # [ 3.553023] systemd[1]: Finished Mountpoints Configured in the Real Root.573machine # [ 3.554062] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.574machine # [ 3.561321] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 3.564535] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 3.599248] systemd[1]: Mounting /sysroot/nix/.ro-store...577machine # [ 3.610306] systemd[1]: Mounting /sysroot/nix/.rw-store...578machine # [ 3.614963] systemd[1]: sysroot-run.mount: Directory /sysroot/run to mount over is not empty, mounting anyway.579machine # [ 3.629496] systemd[1]: Mounting /sysroot/run...580machine # [ 3.642484] systemd[1]: Mounting /sysroot/tmp/shared...581machine # [ 3.680728] systemd[1]: Mounting /sysroot/tmp/xchg...582machine # [ 3.708591] systemd[1]: Mounted /sysroot/nix/.rw-store.583machine # [ 3.719402] systemd[1]: Mounted /sysroot/run.584machine # [ 3.721574] systemd[1]: Mounted /sysroot/nix/.ro-store.585machine # [ 3.739368] systemd[1]: Starting rw-sysroot-nix-store.service...586machine # [ 3.741805] systemd[1]: Mounted /sysroot/tmp/shared.587machine # [ 3.770355] systemd[1]: Mounted /sysroot/tmp/xchg.588machine # [ 3.781003] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.589machine # [ 3.782400] systemd[1]: Finished rw-sysroot-nix-store.service.590machine # [ 4.293236] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)591machine # [ 4.406237] systemd[1]: Found device /dev/tpm0.592machine # [ 4.412880] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.593machine # [ 4.416581] systemd[1]: Stopped Virtual Console Setup.594machine # [ 4.420217] systemd[1]: Stopping Virtual Console Setup...595machine # [ 4.424204] systemd[1]: Starting Virtual Console Setup...596machine # [ 4.452267] systemd[1]: Found device /dev/tpmrm0.597machine # [ 4.454205] systemd[1]: Reached target Trusted Platform Module.598machine # [ 4.456216] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os599machine # [ 4.460459] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.600machine # [ 4.464247] systemd[1]: Stopped Virtual Console Setup.601machine # [ 4.466619] systemd[1]: Starting Virtual Console Setup...602machine # [ 4.494227] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.603machine # [ 4.497614] systemd[1]: Finished Virtual Console Setup.604machine # [ 4.499193] systemd[1]: Reached target System Initialization.605machine # [ 4.500150] systemd[1]: Reached target Basic System.606machine # [ 4.600220] systemd[1]: sysroot-nix-store.mount: Directory /sysroot/nix/store to mount over is not empty, mounting anyway.607machine # [ 4.608502] systemd[1]: Mounting /sysroot/nix/store...608machine # [ 4.665412] systemd[1]: Mounted /sysroot/nix/store.609machine # [ 4.668623] systemd[1]: Reached target Initrd File Systems.610machine # [ 4.673016] systemd[1]: Starting Find NixOS closure...611machine # [ 4.681131] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...612machine # [ 4.734345] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.613machine # [ 4.737781] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.614machine # [ 4.748726] systemd[1]: Finished Find NixOS closure.615machine # [ 4.751324] systemd[1]: Reached target Initrd Default Target.616machine # [ 4.753129] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...617machine # [ 4.780315] systemd[1]: Stopped target Initrd Default Target.618machine # [ 4.782859] systemd[1]: Stopped target Basic System.619machine # [ 4.788438] systemd[1]: Stopped target Initrd Root Device.620machine # [ 4.789610] systemd[1]: Stopped target Path Units.621machine # [ 4.790543] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.622machine # [ 4.792780] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.623machine # [ 4.795928] systemd[1]: Stopped target Slice Units.624machine # [ 4.798336] systemd[1]: Stopped target Socket Units.625machine # [ 4.804168] systemd[1]: Stopped target System Initialization.626machine # [ 4.805270] systemd[1]: Stopped target Swaps.627machine # [ 4.806025] systemd[1]: Stopped target Timer Units.628machine # [ 4.806835] systemd[1]: Stopped target Trusted Platform Module.629machine # [ 4.807784] systemd[1]: dbus.socket: Deactivated successfully.630machine # [ 4.812278] systemd[1]: Closed D-Bus System Message Bus Socket.631machine # [ 4.813274] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.632machine # [ 4.814396] systemd[1]: Stopped Find NixOS closure.633machine # [ 4.815147] systemd[1]: Starting Load Kernel Module 9pnet_virtio...634machine # [ 4.820950] systemd[1]: Starting rw-sysroot-nix-store.service...635machine # [ 4.823312] systemd[1]: systemd-sysctl.service: Deactivated successfully.636machine # [ 4.828565] systemd[1]: Stopped Apply Kernel Variables.637machine # [ 4.829431] systemd[1]: systemd-modules-load.service: Deactivated successfully.638machine # [ 4.830424] systemd[1]: Stopped Load Kernel Modules.639machine # [ 4.831132] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.640machine # [ 4.850922] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.641machine # [ 4.854382] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.642machine # [ 4.858452] systemd[1]: Stopped Create System Files and Directories.643machine # [ 4.859948] systemd[1]: Stopped target Local File Systems.644machine # [ 4.863210] systemd[1]: Stopped target Preparation for Local File Systems.645machine # [ 4.866881] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.646machine # [ 4.867936] systemd[1]: Stopped Coldplug All udev Devices.647machine # [ 4.869894] systemd[1]: Stopping Rule-based Manager for Device Events and Files...648machine # [ 4.872327] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.649machine # [ 4.876474] systemd[1]: Stopped Virtual Console Setup.650machine # [ 4.877342] systemd[1]: initrd-cleanup.service: Deactivated successfully.651machine # [ 4.878401] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.652machine # [ 4.879432] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.653machine # [ 4.880644] systemd[1]: Finished Load Kernel Module 9pnet_virtio.654machine # [ 4.881527] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.655machine # [ 4.882528] systemd[1]: Finished rw-sysroot-nix-store.service.656machine # [ 4.883352] systemd[1]: systemd-udevd.service: Deactivated successfully.657machine # [ 4.888303] systemd[1]: Stopped Rule-based Manager for Device Events and Files.658machine # [ 4.889419] systemd[1]: systemd-udevd.service: Consumed 1.506s CPU time over 3.085s wall clock time, 22.8M memory peak.659machine # [ 4.896206] systemd[1]: Starting Cleanup udev Database...660machine # [ 4.897114] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.661machine # [ 4.898187] systemd[1]: Stopped Create Static Device Nodes in /dev.662machine # [ 4.899060] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.663machine # [ 4.904253] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.664machine # [ 4.905257] systemd[1]: kmod-static-nodes.service: Deactivated successfully.665machine # [ 4.906206] systemd[1]: Stopped Create List of Static Device Nodes.666machine # [ 4.937062] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.667machine # [ 4.939580] systemd[1]: Finished Cleanup udev Database.668machine # [ 4.941168] systemd[1]: Reached target Switch Root.669machine # [ 4.944209] systemd[1]: Starting NixOS Activation...670machine # [ 5.119580] initrd-nixos-activation-start[179]: booting system configuration /nix/store/xzh47bdh54r80g3ypvjp6isjmdcz7avn-nixos-system-machine-test671machine # [ 5.190593] initrd-nixos-activation-start[179]: running activation script...672machine # [ 5.644002] initrd-nixos-activation-start[202]: setting up /etc...673machine # [ 6.001205] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.674machine # [ 6.004077] systemd[1]: Finished NixOS Activation.675machine # [ 6.008233] systemd[1]: Starting Switch Root...676machine # [ 6.024751] systemd[1]: Switching root.677machine # [ 6.221394] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).678machine # [ 6.409280] NET: Registered PF_VSOCK protocol family679machine # [ 6.804523] systemd[1]: systemd 262-726e17a 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)680machine # [ 6.817059] systemd[1]: Detected virtualization kvm.681machine # [ 6.820181] systemd[1]: Detected architecture arm64.682machine # [ 6.824403] systemd[1]: Detected first boot.683machine # [ 6.831384] systemd[1]: Initializing machine ID from random generator.684machine # [ 6.999946] systemd[1]: bpf-restrict-fs: LSM BPF program attached685machine # [ 7.159865] systemd[1]: Applying preset policy.686machine # [ 7.670636] systemd[1]: Populated /etc with preset unit settings.687machine # [ 8.205451] systemd[1]: initrd-switch-root.service: Deactivated successfully.688machine # [ 8.207013] systemd[1]: Stopped initrd-switch-root.service.689machine # [ 8.210217] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.690machine # [ 8.212952] systemd[1]: Created slice Slice /system/getty.691machine # [ 8.214997] systemd[1]: Created slice Slice /system/systemd-fsck.692machine # [ 8.216943] systemd[1]: Created slice User and Session Slice.693machine # [ 8.218347] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.694machine # [ 8.220033] systemd[1]: Started Forward Password Requests to Wall Directory Watch.695machine # [ 8.222656] systemd[1]: Expecting device /dev/disk/by-label/ESP...696machine # [ 8.223794] systemd[1]: Expecting device /dev/hvc0...697machine # [ 8.226337] systemd[1]: Expecting device /dev/ttyAMA0...698machine # [ 8.228319] systemd[1]: Reached target Local Encrypted Volumes.699machine # [ 8.230400] systemd[1]: Stopped target initrd-fs.target.700machine # [ 8.232710] systemd[1]: Stopped target initrd-root-fs.target.701machine # [ 8.234908] systemd[1]: Stopped target initrd-switch-root.target.702machine # [ 8.236992] systemd[1]: Reached target Virtual Machines and Containers.703machine # [ 8.239363] systemd[1]: Reached target Path Units.704machine # [ 8.241273] systemd[1]: Reached target Remote File Systems.705machine # [ 8.243374] systemd[1]: Reached target Slice Units.706machine # [ 8.245299] systemd[1]: Reached target Swaps.707machine # [ 8.249821] systemd[1]: Listening on Query the User Interactively for a Password.708machine # [ 8.255267] systemd[1]: Listening on Process Core Dump Socket.709machine # [ 8.259881] systemd[1]: Listening on Credential Encryption/Decryption.710machine # [ 8.264153] systemd[1]: Listening on Factory Reset Management.711machine # [ 8.265506] systemd[1]: Listening on Hostname Service Socket.712machine # [ 8.272511] systemd[1]: Starting Journal Log Access Socket...713machine # [ 8.275084] systemd[1]: Listening on Journal Audit Socket.714machine # [ 8.280562] systemd[1]: Listening on Console Output Muting Service Socket.715machine # [ 8.282344] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.716machine # [ 8.284100] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os717machine # [ 8.287130] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki718machine # [ 8.299131] systemd[1]: Listening on Disk Repartitioning Service Socket.719machine # [ 8.300694] systemd[1]: Listening on udev Varlink Socket.720machine # [ 8.305752] systemd[1]: Mounting Huge Pages File System...721machine # [ 8.310963] systemd[1]: Mounting POSIX Message Queue File System...722machine # [ 8.319411] systemd[1]: Mounting Kernel Debug File System...723machine # [ 8.334381] systemd[1]: Mounting Kernel Trace File System...724machine # [ 8.346499] systemd[1]: Starting Create List of Static Device Nodes...725machine # [ 8.361455] systemd[1]: Starting Load Kernel Module 9pnet_virtio...726machine # [ 8.364089] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs727machine # [ 8.382869] systemd[1]: Mounting Kernel Configuration File System...728machine # [ 8.391311] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm729machine # [ 8.393570] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore730machine # [ 8.399352] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 8.476073] systemd[1]: Mounting FUSE Control File System...732machine # [ 8.485622] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67733machine # [ 8.525392] systemd[1]: Starting Journal Service...734machine # [ 8.555785] systemd[1]: Starting Load Kernel Modules...735machine # [ 8.586226] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...736machine # [ 8.595291] systemd[1]: Starting Remount Root and Kernel File Systems...737machine # [ 8.597059] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os738machine # [ 8.621758] systemd-journald[274]: Collecting audit messages is enabled.739machine # [ 8.603887] systemd[1]: Queued start job for default target Multi-User System.[ 8.641366] systemd[1]: Starting Coldplug All udev Devices...740machine # 741machine # [ 8.616211] systemd[1]: systemd-journald.service: Deactivated successfully.742machine # [ 8.661272] systemd[1]: Started Journal Service.743machine # [ 8.633762] systemd-modules-load[276]: Module 'atkbd' is built in744machine # [ 8.635621] systemd-modules-load[276]: Module 'loop' is built in745machine # [ 8.651570] systemd[1]: Listening on Journal Log Access Socket.746machine # [ 8.657364] systemd[1]: Mounted Huge Pages File System.747machine # [ 8.663732] systemd[1]: Mounted POSIX Message Queue File System.748machine # [ 8.695003] EXT4-fs (vda2): re-mounted f222513b-ded1-49fa-b591-20ce86a2fe7f.749machine # [ 8.671779] systemd[1]: Mounted Kernel Debug File System.750machine # [ 8.674293] systemd[1]: Mounted Kernel Trace File System.751machine # [ 8.679391] systemd[1]: Finished Create List of Static Device Nodes.752machine # [ 8.683918] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.753machine # [ 8.691221] systemd[1]: Finished Load Kernel Module 9pnet_virtio.754machine # [ 8.696530] systemd[1]: Mounted Kernel Configuration File System.755machine # [ 8.697445] systemd[1]: Mounted FUSE Control File System.756machine # [ 8.698212] systemd[1]: Finished Load Kernel Modules.757machine # [ 8.698937] systemd[1]: Finished Remount Root and Kernel File Systems.758machine # [ 8.708184] systemd[1]: Listening on Disk Image Download Service Socket.759machine # [ 8.721824] systemd[1]: Starting Firewall...760machine # [ 8.750612] systemd[1]: Starting Flush Journal to Persistent Storage...761machine # [ 8.759813] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore762machine # [ 8.768243] systemd-oomd[277]: No swap; memory pressure usage will be degraded763machine # [ 8.779860] systemd[1]: Starting Load/Save OS Random Seed...764machine # [ 8.788754] systemd[1]: Starting Apply Kernel Variables...765machine # [ 8.822022] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...766machine # [ 8.827942] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os767machine # [ 8.836598] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.768machine # [ 8.890319] systemd-journald[274]: Received client request to flush runtime journal.769machine # [ 8.935112] systemd[1]: Finished Load/Save OS Random Seed.770machine # [ 8.942488] systemd[1]: Reached target First Boot Complete.771machine # [ 8.946293] systemd[1]: Finished Flush Journal to Persistent Storage.772machine # [ 8.966406] systemd[1]: Finished Apply Kernel Variables.773machine # [ 9.010774] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.774machine # [ 9.014237] systemd[1]: Starting Create Static Device Nodes in /dev...775machine # [ 9.122665] systemd[1]: Finished Create Static Device Nodes in /dev.776machine # [ 9.126161] systemd[1]: Reached target Preparation for Local File Systems.777machine # [ 9.132331] systemd[1]: Starting Rule-based Manager for Device Events and Files...778machine # [ 9.185096] systemd[1]: Mounting /run/wrappers...779machine # [ 9.250487] systemd[1]: Mounted /run/wrappers.780machine # [ 9.266508] systemd[1]: Starting Create SUID/SGID Wrappers...781machine # [ 9.285210] systemd-udevd[316]: Using default interface naming scheme 'v261'.782machine # [ 9.499657] systemd[1]: Started Rule-based Manager for Device Events and Files.783machine # [ 10.056711] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.784machine # [ 10.060251] systemd[1]: Finished Create SUID/SGID Wrappers.785machine # [ 10.498116] systemd[1]: Finished Coldplug All udev Devices.786machine # [ 10.540431] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs787machine # [ 10.569244] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse788machine # [ 10.638542] systemd[1]: Finished Firewall.789machine # [ 10.692980] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.790machine # [ 10.730918] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.791machine # [ 10.758095] systemd[1]: Found device /dev/tpmrm0.792machine # [ 10.760174] systemd[1]: Expecting device /dev/tpm0...793machine # [ 10.765040] (udev-worker)[362]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.794machine # [ 10.769556] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line.795machine # [ 10.772909] (udev-worker)[357]: Network interface NamePolicy= disabled on kernel command line.796machine # [ 10.891325] systemd[1]: Condition check resulted in Virtio network device being skipped.797machine # [ 10.895301] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore798machine # [ 10.901161] systemd[1]: Starting Create SUID/SGID Wrappers...799machine # [ 10.904318] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67800machine # [ 10.912459] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore801machine # [ 10.983230] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.802machine # [ 10.990566] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...803machine # [ 11.103113] systemd-fsck[490]: fsck.fat 4.2 (2021-01-31)804machine # [ 11.105879] systemd-fsck[490]: /dev/vda1: 20 files, 28713/63671 clusters805machine # [ 11.115805] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.806machine # [ 11.125452] systemd[1]: Mounting /boot...807machine # [ 11.234752] systemd[1]: Mounted /boot.808machine # [ 11.236974] systemd[1]: Reached target Local File Systems.809machine # [ 11.242975] systemd[1]: Listening on Boot Loader Control Service Socket.810machine # [ 11.248302] systemd[1]: Starting register-nix-paths.service...811machine # [ 11.254633] systemd[1]: Starting Update Boot Loader Random Seed...812machine # [ 11.274166] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 11.310494] systemd[1]: Starting Create System Files and Directories...814machine # [ 11.369706] mousedev: PS/2 mouse device common for all mice815machine # [ 11.359589] systemd[1]: Finished register-nix-paths.service.816machine # [ 11.411123] bootctl[514]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 817machine # [ 11.426427] bootctl[514]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!818machine # [ 11.431576] bootctl[514]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).819machine # [ 11.443028] bootctl[514]: Successfully initialized system token in EFI variable with 32 bytes.820machine # [ 11.450150] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.821machine # [ 11.455249] systemd[1]: Finished Save Transient machine-id to Disk.822machine # [ 11.461445] systemd[1]: Finished Update Boot Loader Random Seed.823machine # [ 11.505226] systemd[1]: Finished Create System Files and Directories.824machine # [ 11.514610] systemd[1]: Starting Rebuild Journal Catalog...825machine # [ 11.519467] systemd[1]: Starting Record System Boot/Shutdown in UTMP...826machine # [ 11.596694] systemd[1]: Finished Record System Boot/Shutdown in UTMP.827machine # [ 11.648273] systemd[1]: Finished Rebuild Journal Catalog.828machine # [ 11.656000] systemd[1]: Starting Update is Completed...829machine # [ 11.711025] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.830machine # [ 11.713968] systemd[1]: Finished Create SUID/SGID Wrappers.831machine # [ 11.718239] systemd[1]: Finished Update is Completed.832machine # [ 12.516057] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input3833machine # [ 12.526009] systemd[1]: Found device /dev/tpm0.834machine # [ 12.531383] systemd[1]: Reached target Trusted Platform Module.835machine # [ 12.533390] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os836machine # [ 12.534706] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os837machine # [ 12.535915] systemd[1]: Reached target System Initialization.838machine # [ 12.540209] systemd[1]: Started Discard unused filesystem blocks once a week.839machine # [ 12.545416] systemd[1]: Started Daily Cleanup of Temporary Directories.840machine # [ 12.553936] systemd[1]: Reached target Timer Units.841machine # [ 12.555631] systemd[1]: Listening on D-Bus System Message Bus Socket.842machine # [ 12.559089] systemd[1]: Listening on Nix Daemon Socket.843machine # [ 12.568203] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.844machine # [ 12.569532] systemd[1]: Reached target Socket Units.845machine # [ 12.570289] systemd[1]: Reached target Basic System.846machine # [ 12.571044] systemd[1]: Started backdoor.service.847machine # [ 12.573923] systemd[1]: Starting Import lastlog data into lastlog2 database...848machine # [ 12.584240] systemd[1]: Starting Name Service Cache Daemon (nsncd)...849machine # [ 12.592310] systemd[1]: Starting Post-Boot Actions...850machine # [ 12.622405] systemd[1]: Started Reset console on configuration changes.851machine # [ 12.652428] systemd[1]: Starting resolvconf update...852machine # connecting to host...853machine # [ 12.743638] systemd[1]: Starting D-Bus System Message Bus...854machine # [ 12.753604] systemd[1]: Finished Post-Boot Actions.855machine: Guest shell says: b'Spawning backdoor root shell...\n'856machine # [ 12.777239] nsncd[573]: Sep 06 07:01:14.604 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"857machine # [ 12.786048] systemd[1]: Started Name Service Cache Daemon (nsncd).858machine # [ 12.791571] systemd[1]: Reached target Host and Network Name Lookups.859machine # [ 12.797184] systemd[1]: Reached target User and Group Name Lookups.860machine: connected to guest root shell861machine: (connecting took 27.05 seconds)862machine: (finished: waiting for the VM to finish booting, in 27.36 seconds)863machine # [ 12.812379] systemd[1]: Starting User Login Management...864machine # [ 12.817917] systemd[1]: Finished Import lastlog data into lastlog2 database.865machine # [ 13.006025] dbus-broker-launch[584]: Looking up NSS user entry for 'systemd-timesync'...866machine # [ 13.032694] systemd-logind[599]: New seat seat0.867machine # [ 13.044455] systemd-logind[599]: Watching system buttons on /dev/input/event0 (Power Button)868machine # [ 13.045699] systemd-logind[599]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)869machine # [ 13.055895] systemd[1]: Started User Login Management.870machine # [ 13.070102] dbus-broker-launch[584]: NSS returned no entry for 'systemd-timesync'871machine # [ 13.072370] dbus-broker-launch[584]: Invalid user-name in /nix/store/di6jljjmh662biv26zb9c3v7zgbzxryi-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"872machine # [ 13.084676] systemd[1]: Starting linger-users.service...873machine # [ 13.124842] systemd[1]: Started D-Bus System Message Bus.874machine # [ 13.151671] systemd[1]: Stopped target Host and Network Name Lookups.875machine # [ 13.164097] systemd[1]: Stopping Host and Network Name Lookups...876machine # [ 13.164990] systemd[1]: Stopped target User and Group Name Lookups.877machine # [ 13.165839] systemd[1]: Stopping User and Group Name Lookups...878machine # [ 13.166640] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...879machine # [ 13.180466] systemd[1]: Starting Virtual Console Setup...880machine # [ 13.192651] dbus-broker-launch[584]: Ready881machine # [ 13.196725] systemd[1]: nscd.service: Deactivated successfully.882machine # [ 13.202221] systemd[1]: Stopped Name Service Cache Daemon (nsncd).883machine # [ 13.220553] systemd[1]: linger-users.service: Deactivated successfully.884machine # [ 13.223903] systemd[1]: Finished linger-users.service.885machine # [ 13.260654] systemd[1]: Starting Name Service Cache Daemon (nsncd)...886machine # [ 13.286867] systemd[1]: Finished resolvconf update.887machine # [ 13.292405] systemd[1]: Reached target Preparation for Network.888machine # [ 13.300210] systemd[1]: Starting DHCP Client...889machine # [ 13.310312] systemd[1]: Starting Address configuration of eth1...890machine # [ 13.328561] systemd-logind[599]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)891machine # [ 13.335567] systemd[1]: Starting Extra networking commands....892machine # [ 13.352428] nsncd[670]: Sep 06 07:01:15.180 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"893machine # [ 13.358437] systemd[1]: Started Name Service Cache Daemon (nsncd).894machine # [ 13.383992] systemd[1]: Reached target Host and Network Name Lookups.895machine # [ 13.388853] systemd[1]: Reached target User and Group Name Lookups.896machine # [ 13.488921] network-addresses-eth1-start[677]: adding address 192.168.1.1/24... done897machine # [ 13.509377] network-addresses-eth1-start[677]: adding address 2001:db8:1::1/64... done898machine # [ 13.536721] systemd[1]: Finished Address configuration of eth1.899machine # [ 13.607764] dhcpcd[697]: dhcpcd-10.3.2 starting900machine # [ 13.622433] dhcpcd[749]: dev: loaded udev901machine # [ 13.632864] systemd[1]: Finished Extra networking commands..902machine # [ 13.636431] systemd[1]: Reached target Network.903machine # [ 13.639418] systemd[1]: Starting Permit User Sessions...904machine # [ 13.700450] 8021q: 802.1Q VLAN Support v1.8905machine # [ 13.700866] 8021q: adding VLAN 0 to HW filter on device eth1906machine # [ 13.694476] systemd[1]: Finished Permit User Sessions.907machine # [ 13.706377] systemd[1]: Started Getty on tty1.908machine # [ 13.709583] systemd[1]: Reached target Login Prompts.909machine # [ 13.729664] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.910machine # [ 13.791981] cfg80211: Loading compiled-in X.509 certificates for regulatory database911machine # [ 13.824697] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'912machine # [ 13.825171] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'913machine # [ 13.830266] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2914machine # [ 13.830606] cfg80211: failed to load regulatory.db915machine # [ 13.892569] 8021q: adding VLAN 0 to HW filter on device eth0916machine # [ 13.864492] dhcpcd[749]: eth0: waiting for carrier917machine # [ 13.866495] dhcpcd[749]: eth0: carrier acquired918machine # [ 13.878524] dhcpcd[749]: DUID 00:01:00:01:32:2f:cc:3b:52:54:00:12:34:56919machine # [ 13.879731] dhcpcd[749]: eth0: IAID 00:12:34:56920machine # [ 13.880879] dhcpcd[749]: eth0: adding address fe80::5054:ff:fe12:3456921machine # [ 13.915605] systemd-vconsole-setup[658]: Configuration of first virtual console was skipped, ignoring remaining ones.922machine # [ 13.920120] systemd[1]: Finished Virtual Console Setup.923machine # [ 15.305957] dhcpcd[749]: eth0: soliciting an IPv6 router924machine # [ 15.308835] dhcpcd[749]: eth0: Router Advertisement from fe80::2925machine # [ 15.311378] dhcpcd[749]: eth0: adding address fec0::5054:ff:fe12:3456/64926machine # [ 15.315354] dhcpcd[749]: eth0: adding route to fec0::/64927machine # [ 15.318141] dhcpcd[749]: eth0: adding default route via fe80::2928machine # [ 15.709335] dhcpcd[749]: eth0: soliciting a DHCP lease929machine # [ 15.713169] dhcpcd[749]: eth0: offered 10.0.2.15 from 10.0.2.2930machine # [ 15.716510] dhcpcd[749]: eth0: probing address 10.0.2.15/24931machine # [ 20.409132] dhcpcd[749]: eth0: leased 10.0.2.15 for 86400 seconds932machine # [ 20.414212] dhcpcd[749]: eth0: adding route to 10.0.2.0/24933machine # [ 20.418806] dhcpcd[749]: eth0: adding default route via 10.0.2.2934machine # [ 20.615580] systemd[1]: Started DHCP Client.935machine # [ 20.618005] systemd[1]: Reached target Multi-User System.936machine # [ 20.619292] systemd[1]: Startup finished in 7.189s (firmware) + 6.407s (loader) + 912ms (kernel) + 5.407s (initrd) + 14.299s (userspace) = 34.216s.937machine: (finished: waiting for unit multi-user.target, in 35.68 seconds)938machine: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -939machine: (finished: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -, in 2.62 seconds)940machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot941machine # [ 24.363854] Key type trusted registered942machine # [ 24.369220] Key type encrypted registered943machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.66 seconds)944machine: must succeed: mkfs.ext4 /dev/mapper/cryptroot945machine # mke2fs 1.47.4 (6-Mar-2025)946machine: (finished: must succeed: mkfs.ext4 /dev/mapper/cryptroot, in 0.11 seconds)947machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat948machine # [ 24.557752] cat[923]: Successfully called mlockall().949machine # [ 24.558626] cat[923]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory950machine # [ 24.568086] cat[923]: Loaded shared library 'libcryptsetup.so.12' via dlopen().951machine # [ 24.569974] cat[923]: Allocating context for crypt device /dev/vdb.952machine # [ 24.570995] cat[923]: Trying to open device /dev/vdb with direct-io.953machine # [ 24.572477] cat[923]: Initialising device-mapper backend library.954machine # [ 24.573352] cat[923]: Trying to load LUKS2 crypt type from device /dev/vdb.955machine # [ 24.574442] cat[923]: Crypto backend (OpenSSL 3.6.3 9 Jun 2026 [default][legacy][threads][argon2]) initialized in cryptsetup library version 2.8.7.956machine # [ 24.576868] cat[923]: Detected kernel Linux 6.18.49 aarch64.957machine # [ 24.579091] cat[923]: Loading LUKS2 header (repair disabled).958machine # [ 24.580268] cat[923]: Acquiring read lock for device /dev/vdb.959machine # [ 24.581657] cat[923]: Opening lock resource file /run/cryptsetup/L_254:16960machine # [ 24.582713] cat[923]: Verifying lock handle for /dev/vdb.961machine # [ 24.583470] cat[923]: Device /dev/vdb READ lock taken.962machine # [ 24.588110] cat[923]: Trying to read primary LUKS2 header at offset 0x0.963machine # [ 24.589088] cat[923]: Opening locked device /dev/vdb964machine # [ 24.589789] cat[923]: Verifying locked device handle (bdev)965machine # [ 24.590554] cat[923]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.966machine # [ 24.591689] cat[923]: Checksum:681969d6e0719ff1a1f7d42c1d1725e0bc3454354fc45df19a552a81bc4d9f4d (on-disk)967machine # [ 24.600122] cat[923]: Checksum:681969d6e0719ff1a1f7d42c1d1725e0bc3454354fc45df19a552a81bc4d9f4d (in-memory)968machine # [ 24.601423] cat[923]: Trying to read secondary LUKS2 header at offset 0x4000.969machine # [ 24.602410] cat[923]: Reusing open ro fd on device /dev/vdb970machine # [ 24.603184] cat[923]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.971machine # [ 24.608091] cat[923]: Checksum:761b7ad76290aa33bd728a2f5664590282284b2185c9affbc14951e5b745bce0 (on-disk)972machine # [ 24.609382] cat[923]: Checksum:761b7ad76290aa33bd728a2f5664590282284b2185c9affbc14951e5b745bce0 (in-memory)973machine # [ 24.610648] cat[923]: Device size 536870912, offset 16777216.974machine # [ 24.611435] cat[923]: Device /dev/vdb READ lock released.975machine # [ 24.616079] cat[923]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1.976machine # [ 24.617185] cat[923]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 357886kB.977machine # [ 24.618525] cat[923]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 357886, parallel_threads 1.978machine # [ 24.619836] cat[923]: Requesting JSON for token 0.979machine # [ 24.624088] cat[923]: Requesting JSON for token 1.980machine # [ 24.624805] cat[923]: Requesting JSON for token 2.981machine # [ 24.625518] cat[923]: Requesting JSON for token 3.982machine # [ 24.626206] cat[923]: Requesting JSON for token 4.983machine # [ 24.626889] cat[923]: Requesting JSON for token 5.984machine # [ 24.627571] cat[923]: Requesting JSON for token 6.985machine # [ 24.632083] cat[923]: Requesting JSON for token 7.986machine # [ 24.632840] cat[923]: Requesting JSON for token 8.987machine # [ 24.633525] cat[923]: Requesting JSON for token 9.988machine # [ 24.634217] cat[923]: Requesting JSON for token 10.989machine # [ 24.634910] cat[923]: Requesting JSON for token 11.990machine # [ 24.635604] cat[923]: Requesting JSON for token 12.991machine # [ 24.640533] cat[923]: Requesting JSON for token 13.992machine # [ 24.641256] cat[923]: Requesting JSON for token 14.993machine # [ 24.641943] cat[923]: Requesting JSON for token 15.994machine # [ 24.642631] cat[923]: Requesting JSON for token 16.995machine # [ 24.643319] cat[923]: Requesting JSON for token 17.996machine # [ 24.648070] cat[923]: Requesting JSON for token 18.997machine # [ 24.648932] cat[923]: Requesting JSON for token 19.998machine # [ 24.649636] cat[923]: Requesting JSON for token 20.999machine # [ 24.650324] cat[923]: Requesting JSON for token 21.1000machine # [ 24.651020] cat[923]: Requesting JSON for token 22.1001machine # [ 24.651697] cat[923]: Requesting JSON for token 23.1002machine # [ 24.656178] cat[923]: Requesting JSON for token 24.1003machine # [ 24.657065] cat[923]: Requesting JSON for token 25.1004machine # [ 24.657745] cat[923]: Requesting JSON for token 26.1005machine # [ 24.658422] cat[923]: Requesting JSON for token 27.1006machine # [ 24.659095] cat[923]: Requesting JSON for token 28.1007machine # [ 24.659772] cat[923]: Requesting JSON for token 29.1008machine # [ 24.668148] cat[923]: Requesting JSON for token 30.1009machine # [ 24.668909] cat[923]: Requesting JSON for token 31.1010machine # [ 24.669597] cat[923]: Keyslot 0 priority 1 != 2 (required), skipped.1011machine # [ 24.670466] cat[923]: Trying to open LUKS2 keyslot 0.1012machine # [ 24.671182] cat[923]: Running keyslot key derivation.1013machine # [ 24.947292] cat[923]: Reading keyslot area [0x8000].1014machine # [ 24.949571] cat[923]: Acquiring read lock for device /dev/vdb.1015machine # [ 24.952143] cat[923]: Opening lock resource file /run/cryptsetup/L_254:161016machine # [ 24.953137] cat[923]: Verifying lock handle for /dev/vdb.1017machine # [ 24.953881] cat[923]: Device /dev/vdb READ lock taken.1018machine # [ 24.954670] cat[923]: Reusing open ro fd on device /dev/vdb1019machine # [ 24.955489] cat[923]: Device /dev/vdb READ lock released.1020machine # [ 24.960036] cat[923]: Verifying key from keyslot 0, digest 0.1021machine # [ 25.024638] cat[923]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory1022machine # [ 25.026170] cat[923]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory1023machine # [ 25.030923] cat[923]: Loaded shared library 'libtss2-esys.so.0' via dlopen().1024machine # [ 25.033000] cat[923]: Loaded shared library 'libtss2-rc.so.0' via dlopen().1025machine # [ 25.034132] cat[923]: Loaded shared library 'libtss2-mu.so.0' via dlopen().1026machine # [ 25.036033] cat[923]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen().1027machine # [ 25.037474] cat[923]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'.1028machine # [ 25.038936] cat[923]: Loaded 'libtss2-tcti-device.so.0' via dlopen()1029machine # [ 25.039832] cat[923]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2]1030machine # [ 25.041889] cat[923]: TPM successfully started up.1031machine # [ 25.042597] cat[923]: Getting TPM2 capability 0x0000 property 0x0001 count 127.1032machine # [ 25.044937] cat[923]: Getting TPM2 capability 0x0002 property 0x011f count 256.1033machine # [ 25.055081] cat[923]: Getting TPM2 capability 0x0008 property 0x0000 count 508.1034machine # [ 25.057552] cat[923]: Getting TPM2 capability 0x0005 property 0x0000 count 1.1035machine # [ 25.060061] cat[923]: Getting TPM2 capability 0x0006 property 0x012c count 1.1036machine # [ 25.065378] cat[923]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.468ms.1037machine # [ 25.066504] cat[923]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1038machine # [ 25.068932] cat[923]: TPM handle 0x81000001 not populated.1039machine # [ 25.071118] cat[923]: Creating primary key on TPM.1040machine # [ 25.082771] cat[923]: Successfully created primary key on TPM in 10ms.1041machine # [ 25.093803] cat[923]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1042machine # [ 25.132330] cat[923]: Starting HMAC encryption session.1043machine # [ 25.150682] cat[923]: Generating secret key data.1044machine # [ 25.155315] cat[923]: Creating HMAC key on TPM for shard 0.1045machine # [ 25.158537] cat[923]: Creating object on TPM.1046machine # [ 25.170228] cat[923]: Successfully created object on TPM in 18ms.1047machine # [ 25.171328] cat[923]: Marshalling private and public part of HMAC key for shard 0.1048machine # [ 25.174764] cat[923]: Completed TPM2 key sealing in 108.803ms.1049machine # [ 25.178969] cat[923]: Requesting JSON for token 0.1050machine # [ 25.179779] cat[923]: Requesting JSON for token 1.1051machine # [ 25.181126] cat[923]: Requesting JSON for token 2.1052machine # [ 25.182011] cat[923]: Requesting JSON for token 3.1053machine # [ 25.182936] cat[923]: Requesting JSON for token 4.1054machine # [ 25.183917] cat[923]: Requesting JSON for token 5.1055machine # [ 25.186217] cat[923]: Requesting JSON for token 6.1056machine # [ 25.187015] cat[923]: Requesting JSON for token 7.1057machine # [ 25.188320] cat[923]: Requesting JSON for token 8.1058machine # [ 25.189109] cat[923]: Requesting JSON for token 9.1059machine # [ 25.192248] cat[923]: Requesting JSON for token 10.1060machine # [ 25.193037] cat[923]: Requesting JSON for token 11.1061machine # [ 25.193839] cat[923]: Requesting JSON for token 12.1062machine # [ 25.194592] cat[923]: Requesting JSON for token 13.1063machine # [ 25.195335] cat[923]: Requesting JSON for token 14.1064machine # [ 25.203231] cat[923]: Requesting JSON for token 15.1065machine # [ 25.203994] cat[923]: Requesting JSON for token 16.1066machine # [ 25.205647] cat[923]: Requesting JSON for token 17.1067machine # [ 25.206446] cat[923]: Requesting JSON for token 18.1068machine # [ 25.207174] cat[923]: Requesting JSON for token 19.1069machine # [ 25.208328] cat[923]: Requesting JSON for token 20.1070machine # [ 25.209181] cat[923]: Requesting JSON for token 21.1071machine # [ 25.212095] cat[923]: Requesting JSON for token 22.1072machine # [ 25.212845] cat[923]: Requesting JSON for token 23.1073machine # [ 25.213787] cat[923]: Requesting JSON for token 24.1074machine # [ 25.214493] cat[923]: Requesting JSON for token 25.1075machine # [ 25.217037] cat[923]: Requesting JSON for token 26.1076machine # [ 25.217735] cat[923]: Requesting JSON for token 27.1077machine # [ 25.218412] cat[923]: Requesting JSON for token 28.1078machine # [ 25.219090] cat[923]: Requesting JSON for token 29.1079machine # [ 25.219769] cat[923]: Requesting JSON for token 30.1080machine # [ 25.224110] cat[923]: Requesting JSON for token 31.1081machine # [ 25.224887] cat[923]: PCR policy hash not yet enrolled, enrolling now.1082machine # [ 25.225762] cat[923]: Unsealing for verification...1083machine # [ 25.226456] cat[923]: Loading HMAC key into TPM for shard 0.1084machine # [ 25.227217] cat[923]: Loading object into TPM.1085machine # [ 25.227840] cat[923]: Starting HMAC encryption session.1086machine # [ 25.232959] cat[923]: Starting policy session.1087machine # [ 25.252541] cat[923]: Building sealing policy.1088machine # [ 25.253383] cat[923]: Acquiring policy digest.1089machine # [ 25.275041] cat[923]: Session policy digest: 00000000000000000000000000000000000000000000000000000000000000001090machine # [ 25.280115] cat[923]: Unsealing HMAC key for shard 0.1091machine # [ 25.348107] cat[923]: Completed TPM2 key unsealing in 162.895ms.1092machine # [ 25.349299] cat[923]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000).1093machine # [ 25.350410] cat[923]: Adding new keyslot -1 by passphrase, volume key provided by key (-1).1094machine # [ 25.351747] cat[923]: Selected keyslot 1.1095machine # [ 25.414776] cat[923]: Keyslot 1 assigned to digest 0.1096machine # [ 25.416078] cat[923]: Trying to allocate LUKS2 keyslot 1.1097machine # [ 25.416866] cat[923]: Found area 290816 -> 5488641098machine # [ 25.417560] cat[923]: Reusing PBKDF values (no benchmark flag is set).1099machine # [ 25.418448] cat[923]: Calculating attributes for LUKS2 keyslot 1.1100machine # [ 25.419279] cat[923]: Acquiring write lock for device /dev/vdb.1101machine # [ 25.420180] cat[923]: Opening lock resource file /run/cryptsetup/L_254:161102machine # [ 25.427187] cat[923]: Verifying lock handle for /dev/vdb.1103machine # [ 25.427980] cat[923]: Device /dev/vdb WRITE lock taken.1104machine # [ 25.428746] cat[923]: Checking context sequence id matches value stored on disk.1105machine # [ 25.429732] cat[923]: Reusing open ro fd on device /dev/vdb1106machine # [ 25.430519] cat[923]: Running keyslot key derivation.1107machine # [ 25.431709] cat[923]: Updating keyslot area [0x47000].1108machine # [ 25.433100] cat[923]: Opening locked device /dev/vdb1109machine # [ 25.433925] cat[923]: Verifying locked device handle (bdev)1110machine # [ 25.434835] cat[923]: Device size 536870912, offset 16777216.1111machine # [ 25.435883] cat[923]: Device /dev/vdb WRITE lock already held.1112machine # [ 25.436821] cat[923]: Trying to write LUKS2 header (1039 bytes) at offset 0.1113machine # [ 25.437759] cat[923]: Reusing open rw fd on device /dev/vdb1114machine # [ 25.438533] cat[923]: Checksum:694ccc8e19a54df171227d62016cf1005afbb3f42749d1e8628ddf3bd993d3c3 (in-memory)1115machine # [ 25.439928] cat[923]: Trying to write LUKS2 header (1039 bytes) at offset 16384.1116machine # [ 25.441176] cat[923]: Reusing open rw fd on device /dev/vdb1117machine # [ 25.442395] cat[923]: Checksum:b8208910ec0f5a82a7cf41f93160a9b693f44dd52b7ba3ae0252a457669a1bcd (in-memory)1118machine # [ 25.444424] cat[923]: Device /dev/vdb WRITE lock released.1119machine # [ 25.445605] cat[923]: Unknown hash algorithm id 0x01120machine # [ 25.446464] cat[923]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AIP0e5cFsfdlKBSifmREOTOhBmFp8KaleojadBzHL5IksABD9wqTSs1509V9VK/8/irN3PpsiWJTzBsaj5Oom1vCtipANUqRzZe4YUY5bSNn5G0Akn3buMxVpyK0ybRajbTzqaewlRQs0Ege9RpBE1ul2gDJ2KNd926HPY7foFy/MUlln41ZfJb60FV2kDEloKB8ql8H6EUq3AIu6EwBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAINVGMyggB14kty7vyyEN5JxvrhsTbYKRA1AR9N1tlraN","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAtDRVS4KCymWphzcAgzL74d8SSHg6/h8X6LBGvBB6DQPwAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAILJ8GoHVHuNdGsYrXLjpCcN1TNhWNd4dzTf1FfCSD5auACCqr/1mXznxdHbr03KTdMliS6L5vzqeMw6OzN6yKdurOg=="}>1121machine # [ 25.469927] cat[923]: Updating JSON for token -1.1122machine # [ 25.470731] cat[923]: Trying to load libcryptsetup-token-systemd-tpm2.so.1123machine # [ 25.471745] cat[923]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0.1124machine # [ 25.475240] cat[923]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0.1125machine # [ 25.478344] [923]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0.1126machine # [ 25.479497] [923]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0.1127machine # [ 25.484190] [923]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0.1128machine # [ 25.486039] [923]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0.1129machine # [ 25.487059] [923]: Token handler systemd-tpm2-1.0 systemd-v262~rc1 (262-726e17a) loaded successfully.1130machine # [ 25.491936] [923]: Device size 536870912, offset 16777216.1131machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 0.98 seconds)1132machine # [ 25.492891] [923]: Acquiring write lock for device /dev/vdb.1133machine: must succeed: /nix/store/pwdn3pg9462pbdvhdscclq72zv8h9lg9-nixos-system-machine-test/bin/switch-to-configuration boot1134machine # [ 25.493613] [923]: Opening lock resource file /run/cryptsetup/L_254:161135machine # [ 25.494425] [923]: Verifying lock handle for /dev/vdb.1136machine # [ 25.495074] [923]: Device /dev/vdb WRITE lock taken.1137machine # [ 25.495735] [923]: Checking context sequence id matches value stored on disk.1138machine # [ 25.496800] [923]: Reusing open ro fd on device /dev/vdb1139machine # [ 25.497484] [923]: Trying to write LUKS2 header (1742 bytes) at offset 0.1140machine # [ 25.498334] [923]: Reusing open rw fd on device /dev/vdb1141machine # [ 25.499012] [923]: Checksum:87078dfe0a9d019918bfc5a6cac5e04de5d9456f590df848be3667e6cea2f34d (in-memory)1142machine # [ 25.500233] [923]: Trying to write LUKS2 header (1742 bytes) at offset 16384.1143machine # [ 25.501128] [923]: Reusing open rw fd on device /dev/vdb1144machine # [ 25.501804] [923]: Checksum:ecb1e1de89350d1b0e926fffe92bc947caed43d06eca5362ba539ac5807d35a4 (in-memory)1145machine # [ 25.504939] [923]: Device /dev/vdb WRITE lock released.1146machine # [ 25.505888] [923]: New TPM2 token enrolled as key slot 1.1147machine # [ 25.506771] [923]: Releasing crypt device /dev/vdb context.1148machine # [ 25.507656] [923]: Releasing device-mapper backend.1149machine # [ 25.508817] [923]: Closing read only fd for /dev/vdb.1150machine # [ 25.509747] [923]: Closing read write fd for /dev/vdb.1151machine # [ 25.510893] [923]: Unloading systemd-tpm2 token handler.1152machine # Not checking switch inhibitors (action = boot)1153machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.1154machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.1155machine: (finished: must succeed: /nix/store/pwdn3pg9462pbdvhdscclq72zv8h9lg9-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.99 seconds)1156machine: must succeed: sync1157machine: (finished: must succeed: sync, in 0.04 seconds)1158machine: forced crash1159machine: waiting for the VM to power off1160additionally exposed symbols:1161 machine,1162 vlan1,1163 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_ssh1164machine: (finished: waiting for the VM to power off, in 0.00 seconds)1165machine: waiting for unit multi-user.target1166machine: waiting for the VM to finish booting1167machine: starting vm1168machine: QEMU running (pid 92)1169machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)1170machine: 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'1171machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1172machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1173machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1174machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1175machine: 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'1176machine: 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'1177machine: Guest shell says: b'nterface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot '1178machine: Guest shell says: b'in 5s. \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 4s. '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 3s. '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 2s. '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[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '1190machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'1191machine: Guest shell says: b'---------------------'1192machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'1193machine # 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]1194machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 20261195machine # [ 0.000000] KASLR enabled1196machine # [ 0.000000] efi: EFI v2.7 by EDK II1197machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fc0000 MEMATTR=0x45ae8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a7a018 INITRD=0x45ae0418 MEMRESERVE=0x45ae22981198machine # [ 0.000000] random: crng init done1199machine # [ 0.000000] ACPI: Early table checksum verification disabled1200machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )1201machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013)1202machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)1203machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001811 (v02 BOCHS BXPC 00000001 BXPC 00000001)1204machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)1205machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)1206machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)1207machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1208machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)1209machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)1210machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)1211machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)1212machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013)1213machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,96001214machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1215machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf1880-0x7fdf4fff]1216machine # [ 0.000000] Zone ranges:1217machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1218machine # [ 0.000000] DMA32 empty1219machine # [ 0.000000] Normal empty1220machine # [ 0.000000] Device empty1221machine # [ 0.000000] Movable zone start for each node1222machine # [ 0.000000] Early memory node ranges1223machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045b0ffff]1224machine # [ 0.000000] node 0: [mem 0x0000000045b10000-0x0000000045b1ffff]1225machine # [ 0.000000] node 0: [mem 0x0000000045b20000-0x0000000045fcffff]1226machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff]1227machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff]1228machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]1229machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]1230machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]1231machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]1232machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]1233machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]1234machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1235machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001236machine # [ 0.000000] psci: probing for conduit method from ACPI.1237machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1238machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1239machine # [ 0.000000] psci: Trusted OS migration not required1240machine # [ 0.000000] psci: SMC Calling Convention v1.11241machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1242machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961243machine # [ 0.000000] Detected PIPT I-cache on CPU01244machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1245machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1246machine # [ 0.000000] CPU features: detected: Spectre-v41247machine # [ 0.000000] CPU features: detected: Spectre-BHB1248machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381249machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231250machine # [ 0.000000] alternatives: applying boot alternatives1251machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\jkrxpmqdbv9gh6w9k6ydcf96vblwsmrc-initrd-linux-6.18.49-initrd.efi init=/nix/store/pwdn3pg9462pbdvhdscclq72zv8h9lg9-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,bpf1252machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1253machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1254machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1255machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1256machine # [ 0.000000] software IO TLB: area num 1.1257machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1258machine # [ 0.000000] Fallback order for Node 0: 01259machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441260machine # [ 0.000000] Policy zone: DMA1261machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1262machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11263machine # [ 0.000000] allocated 2097152 bytes of page_ext1264machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages1265machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1266machine # [ 0.000000] rcu: Hierarchical RCU implementation.1267machine # [ 0.000000] rcu: RCU event tracing is enabled.1268machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1269machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1270machine # [ 0.000000] Rude variant of Tasks RCU enabled.1271machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1272machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1273machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11274machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1275machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1276machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1277machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01278machine # [ 0.000000] GICv3: 256 SPIs implemented1279machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1280machine # [ 0.000000] Root IRQ handler: gic_handle_irq1281machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1282machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01283machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001284machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1285machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)1286machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)1287machine # [ 0.000000] GICv3: using LPI property table @0x00000000409100001288machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000409200001289machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1290machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1291machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1292machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1293machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1294machine # [ 0.000034] arm-pv: using stolen time PV1295machine # [ 0.000391] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1296machine # [ 0.000483] Console: colour dummy device 80x251297machine # [ 0.000487] printk: legacy console [tty0] enabled1298machine # [ 0.000697] ACPI: Core revision 202508071299machine # [ 0.000774] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1300machine # [ 0.000781] pid_max: default: 32768 minimum: 3011301machine # [ 0.000836] LSM: initializing lsm=capability,landlock,yama,bpf,ima1302machine # [ 0.000962] landlock: Up and running.1303machine # [ 0.000965] Yama: becoming mindful.1304machine # [ 0.001402] LSM support for eBPF active1305machine # [ 0.001490] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1306machine # [ 0.001498] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1307machine # [ 0.002557] rcu: Hierarchical SRCU implementation.1308machine # [ 0.002562] rcu: Max phase no-delay instances is 1000.1309machine # [ 0.003200] fsl-mc MSI: ITS@0x8080000 domain created1310machine # [ 0.003221] Remapping and enabling EFI services.1311machine # [ 0.003346] smp: Bringing up secondary CPUs ...1312machine # [ 0.003356] smp: Brought up 1 node, 1 CPU1313machine # [ 0.003360] SMP: Total of 1 processors activated.1314machine # [ 0.003362] CPU: All CPU(s) started at EL11315machine # [ 0.003373] CPU features: detected: Branch Target Identification1316machine # [ 0.003378] CPU features: detected: ARMv8.4 Translation Table Level1317machine # [ 0.003381] CPU features: detected: Instruction cache invalidation not required for I/D coherence1318machine # [ 0.003385] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1319machine # [ 0.003389] CPU features: detected: Common not Private translations1320machine # [ 0.003392] CPU features: detected: CRC32 instructions1321machine # [ 0.003395] CPU features: detected: Data cache clean to Point of Deep Persistence1322machine # [ 0.003399] CPU features: detected: Data cache clean to Point of Persistence1323machine # [ 0.003402] CPU features: detected: Data independent timing control (DIT)1324machine # [ 0.003405] CPU features: detected: E0PD1325machine # [ 0.003408] CPU features: detected: Enhanced Counter Virtualization1326machine # [ 0.003411] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1327machine # [ 0.003414] CPU features: detected: Enhanced Virtualization Traps1328machine # [ 0.003417] CPU features: detected: Fine Grained Traps1329machine # [ 0.003421] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1330machine # [ 0.003425] CPU features: detected: RCpc load-acquire (LDAPR)1331machine # [ 0.003428] CPU features: detected: LSE atomic instructions1332machine # [ 0.003431] CPU features: detected: Privileged Access Never1333machine # [ 0.003434] CPU features: detected: PMUv31334machine # [ 0.003436] CPU features: detected: RAS Extension Support1335machine # [ 0.003439] CPU features: detected: RASv1p1 Extension Support1336machine # [ 0.003442] CPU features: detected: Random Number Generator1337machine # [ 0.003444] CPU features: detected: Speculation barrier (SB)1338machine # [ 0.003447] CPU features: detected: Stage-2 Force Write-Back1339machine # [ 0.003450] CPU features: detected: TLB range maintenance instructions1340machine # [ 0.003455] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1341machine # [ 0.003496] alternatives: applying system-wide alternatives1342machine # [ 0.006244] CPU features: detected: BBM Level 2 without TLB conflict abort1343machine # [ 0.006369] Memory: 887152K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120080K reserved, 32768K cma-reserved)1344machine # [ 0.006643] devtmpfs: initialized1345machine # [ 0.007520] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1346machine # [ 0.007529] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1347machine # [ 0.007685] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1348machine # [ 0.007689] 0 pages in range for non-PLT usage1349machine # [ 0.007691] 508288 pages in range for PLT usage1350machine # [ 0.007770] pinctrl core: initialized pinctrl subsystem1351machine # [ 0.008359] SMBIOS 3.0.0 present.1352machine # [ 0.008365] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/20221353machine # [ 0.008373] DMI: Memory slots populated: 1/11354machine # [ 0.009628] NET: Registered PF_NETLINK/PF_ROUTE protocol family1355machine # [ 0.010271] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1356machine # [ 0.010409] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1357machine # [ 0.010567] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1358machine # [ 0.010587] audit: initializing netlink subsys (disabled)1359machine # [ 0.010981] thermal_sys: Registered thermal governor 'fair_share'1360machine # [ 0.010983] thermal_sys: Registered thermal governor 'bang_bang'1361machine # [ 0.010987] thermal_sys: Registered thermal governor 'step_wise'1362machine # [ 0.010990] thermal_sys: Registered thermal governor 'user_space'1363machine # [ 0.010992] thermal_sys: Registered thermal governor 'power_allocator'1364machine # [ 0.011017] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=11365machine # [ 0.011029] cpuidle: using governor ladder1366machine # [ 0.011037] cpuidle: using governor menu1367machine # [ 0.011191] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1368machine # [ 0.011211] ASID allocator initialised with 65536 entries1369machine # [ 0.011993] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51370machine # [ 0.012193] Serial: AMBA PL011 UART driver1371machine # [ 0.018502] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1372machine # [ 0.018508] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1373machine # [ 0.018512] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1374machine # [ 0.018514] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1375machine # [ 0.018517] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1376machine # [ 0.018520] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1377machine # [ 0.018522] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1378machine # [ 0.018525] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1379machine # [ 0.019295] fbcon: Taking over console1380machine # [ 0.019330] ACPI: Added _OSI(Module Device)1381machine # [ 0.019333] ACPI: Added _OSI(Processor Device)1382machine # [ 0.019336] ACPI: Added _OSI(Processor Aggregator Device)1383machine # [ 0.020358] ACPI: 1 ACPI AML tables successfully acquired and loaded1384machine # [ 0.026372] ACPI: Interpreter enabled1385machine # [ 0.026376] ACPI: Using GIC for interrupt routing1386machine # [ 0.026397] ACPI: MCFG table detected, 1 entries1387machine # [ 0.030260] ACPI: CPU0 has been hot-added1388machine # [ 0.030650] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA1389machine # [ 0.030715] printk: console [ttyAMA0] enabled1390machine # [ 0.098615] ACPI: PCI: Interrupt link L000 configured for IRQ 351391machine # [ 0.098637] ACPI: PCI: Interrupt link L001 configured for IRQ 361392machine # [ 0.098649] ACPI: PCI: Interrupt link L002 configured for IRQ 371393machine # [ 0.098662] ACPI: PCI: Interrupt link L003 configured for IRQ 381394machine # [ 0.098683] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1395machine # [ 0.098729] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1396machine # [ 0.098822] acpi PNP0A08:00: _OSC: platform does not support [LTR]1397machine # [ 0.098918] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]1398machine # [ 0.099165] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:001399machine # [ 0.099184] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1400machine # [ 0.099206] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]1401machine # [ 0.099570] PCI host bridge to bus 0000:001402machine # [ 0.099599] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]1403machine # [ 0.099604] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]1404machine # [ 0.099607] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]1405machine # [ 0.099612] pci_bus 0000:00: root bus resource [bus 00-ff]1406machine # [ 0.099615] PCI: OF: of_root node is NULL, cannot create PCI host bridge node1407machine # [ 0.099663] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1408machine # [ 0.100146] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1409machine # [ 0.100324] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]1410machine # [ 0.100335] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]1411machine # [ 0.100359] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]1412machine # [ 0.100371] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]1413machine # [ 0.100849] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1414machine # [ 0.102576] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]1415machine # [ 0.102590] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]1416machine # [ 0.102615] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]1417machine # [ 0.103127] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1418machine # [ 0.103312] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]1419machine # [ 0.103323] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]1420machine # [ 0.103348] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]1421machine # [ 0.209670] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1422machine # [ 0.209864] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]1423machine # [ 0.209881] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]1424machine # [ 0.209910] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]1425machine # [ 0.210404] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1426machine # [ 0.210581] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]1427machine # [ 0.210597] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]1428machine # [ 0.210627] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]1429machine # [ 0.211121] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1430machine # [ 0.219945] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]1431machine # [ 0.219973] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]1432machine # [ 0.220002] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]1433machine # [ 0.220543] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1434machine # [ 0.220724] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]1435machine # [ 0.220740] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]1436machine # [ 0.220770] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]1437machine # [ 0.226492] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1438machine # [ 0.226677] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]1439machine # [ 0.226693] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]1440machine # [ 0.226724] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]1441machine # [ 0.226741] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]1442machine # [ 0.227222] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1443machine # [ 0.228484] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]1444machine # [ 0.228528] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]1445machine # [ 0.229077] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1446machine # [ 0.229265] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]1447machine # [ 0.237226] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]1448machine # [ 0.237762] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1449machine # [ 0.240714] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]1450machine # [ 0.241055] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1451machine # [ 0.242040] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]1452machine # [ 0.242063] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]1453machine # [ 0.242094] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]1454machine # [ 0.246419] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1455machine # [ 0.247137] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]1456machine # [ 0.247161] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]1457machine # [ 0.247190] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]1458machine # [ 0.247751] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1459machine # [ 0.247765] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1460machine # [ 0.247773] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1461machine # [ 0.247819] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1462machine # [ 0.247874] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1463machine # [ 0.247921] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1464machine # [ 0.247967] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1465machine # [ 0.248013] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1466machine # [ 0.248059] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1467machine # [ 0.248106] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1468machine # [ 0.248154] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1469machine # [ 0.249171] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1470machine # [ 0.249231] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1471machine # [ 0.249278] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1472machine # [ 0.249323] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1473machine # [ 0.249345] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1474machine # [ 0.249368] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1475machine # [ 0.249390] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1476machine # [ 0.249413] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1477machine # [ 0.249435] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1478machine # [ 0.249458] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1479machine # [ 0.249481] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1480machine # [ 0.249503] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1481machine # [ 0.250023] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1482machine # [ 0.250051] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned1483machine # [ 0.275918] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1484machine # [ 0.275953] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1485machine # [ 0.275977] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1486machine # [ 0.276596] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned1487machine # [ 0.276625] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned1488machine # [ 0.276647] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned1489machine # [ 0.277218] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned1490machine # [ 0.277248] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned1491machine # [ 0.283800] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned1492machine # [ 0.283833] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned1493machine # [ 0.283862] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned1494machine # [ 0.283885] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned1495machine # [ 0.284429] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]1496machine # [ 0.284445] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]1497machine # [ 0.284452] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]1498machine # [ 0.293614] iommu: Default domain type: Translated1499machine # [ 0.293633] iommu: DMA domain TLB invalidation policy: strict mode1500machine # [ 0.295213] SCSI subsystem initialized1501machine # [ 0.295832] ACPI: bus type USB registered1502machine # [ 0.295887] usbcore: registered new interface driver usbfs1503machine # [ 0.295910] usbcore: registered new interface driver hub1504machine # [ 0.295929] usbcore: registered new device driver usb1505machine # [ 0.296162] pps_core: LinuxPPS API ver. 1 registered1506machine # [ 0.296171] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1507machine # [ 0.296182] PTP clock support registered1508machine # [ 0.296224] EDAC MC: Ver: 3.0.01509machine # [ 0.301381] scmi_core: SCMI protocol bus registered1510machine # [ 0.302105] efivars: Registered efivars operations1511machine # [ 0.303089] FPGA manager framework1512machine # [ 0.303995] vgaarb: loaded1513machine # [ 0.304588] clocksource: Switched to clocksource arch_sys_counter1514machine # [ 0.304911] VFS: Disk quotas dquot_6.6.01515machine # [ 0.304941] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1516machine # [ 0.308524] netfs: FS-Cache loaded1517machine # [ 0.309078] pnp: PnP ACPI init1518machine # [ 0.309294] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved1519machine # [ 0.309356] pnp: PnP ACPI: found 1 devices1520machine # [ 0.314299] NET: Registered PF_INET protocol family1521machine # [ 0.314370] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1522machine # [ 0.333972] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1523machine # [ 0.334027] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1524machine # [ 0.334056] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1525machine # [ 0.334101] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1526machine # [ 0.334179] TCP: Hash tables configured (established 8192 bind 8192)1527machine # [ 0.334258] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1528machine # [ 0.334295] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1529machine # [ 0.334322] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1530machine # [ 0.334417] NET: Registered PF_UNIX/PF_LOCAL protocol family1531machine # [ 0.334441] NET: Registered PF_XDP protocol family1532machine # [ 0.335197] PCI: CLS 0 bytes, default 641533machine # [ 0.335438] Trying to unpack rootfs image as initramfs...1534machine # [ 0.349900] kvm [1]: HYP mode not available1535machine # [ 0.443740] Initialise system trusted keyrings1536machine # [ 0.444520] workingset: timestamp_bits=42 max_order=18 bucket_order=01537machine # [ 0.445785] squashfs: version 4.0 (2009/01/31) Phillip Lougher1538machine # [ 0.446545] 9p: Installing v9fs 9p2000 file system support1539machine # [ 0.470526] Key type asymmetric registered1540machine # [ 0.470561] Asymmetric key parser 'x509' registered1541machine # [ 0.470637] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1542machine # [ 0.476701] io scheduler mq-deadline registered1543machine # [ 0.476733] io scheduler kyber registered1544machine # [ 0.481458] ledtrig-cpu: registered to indicate activity on CPUs1545machine # [ 0.488972] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input01546machine # [ 0.489057] ACPI: button: Power Button [PWRB]1547machine # [ 0.510622] ACPI: \_SB_.L001: Enabled at IRQ 361548machine # [ 0.510686] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1549machine # [ 0.517085] ACPI: \_SB_.L002: Enabled at IRQ 371550machine # [ 0.517142] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)1551machine # [ 0.518779] ACPI: \_SB_.L003: Enabled at IRQ 381552machine # [ 0.518830] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1553machine # [ 0.533055] ACPI: \_SB_.L000: Enabled at IRQ 351554machine # [ 0.533112] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1555machine # [ 0.535420] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1556machine # [ 0.537748] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)1557machine # [ 0.539376] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1558machine # [ 0.558322] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)1559machine # [ 0.563014] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1560machine # [ 0.565973] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)1561machine # [ 0.567699] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)1562machine # [ 0.585818] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1563machine # [ 0.588326] msm_serial: driver initialized1564machine # [ 0.588458] SuperH (H)SCI(F) driver initialized1565machine # [ 0.588500] STM32 USART driver initialized1566machine # [ 0.609950] ACPI: bus type drm_connector registered1567machine # [ 0.618643] loop: module loaded1568machine # [ 0.618831] virtio_blk virtio5: 1/0/0 default/read/poll queues1569machine # [ 0.619561] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)1570machine # [ 0.660701] vda: vda1 vda21571machine # [ 0.661086] virtio_blk virtio6: 1/0/0 default/read/poll queues1572machine # [ 0.661793] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1573machine # [ 0.669247] megasas: 07.734.00.00-rc11574machine # [ 0.671493] tun: Universal TUN/TAP device driver, 1.61575machine # [ 0.674366] thunder_xcv, ver 1.01576machine # [ 0.674409] thunder_bgx, ver 1.01577machine # [ 0.674432] nicpf, ver 1.01578machine # [ 0.674970] e1000: Intel(R) PRO/1000 Network Driver1579machine # [ 0.674979] e1000: Copyright (c) 1999-2006 Intel Corporation.1580machine # [ 0.675005] e1000e: Intel(R) PRO/1000 Network Driver1581machine # [ 0.675013] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1582machine # [ 0.675048] igb: Intel(R) Gigabit Ethernet Network Driver1583machine # [ 0.675056] igb: Copyright (c) 2007-2014 Intel Corporation.1584machine # [ 0.675079] igbvf: Intel(R) Gigabit Virtual Function Network Driver1585machine # [ 0.675087] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1586machine # [ 0.675222] sky2: driver version 1.301587machine # [ 0.677484] ehci-pci 0000:00:0b.0: EHCI Host Controller1588machine # [ 0.677512] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 11589machine # [ 0.677781] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a0001590machine # [ 0.687976] usbcore: registered new interface driver usb-storage1591machine # [ 0.688060] usbcore: registered new interface driver usbserial_generic1592machine # [ 0.688076] usbserial: USB Serial support registered for generic1593machine # [ 0.688630] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.001594machine # [ 0.688959] hub 1-0:1.0: USB hub found1595machine # [ 0.688985] hub 1-0:1.0: 6 ports detected1596machine # [ 0.693242] hv_vmbus: registering driver hyperv_keyboard1597machine # [ 0.694488] rtc-efi rtc-efi.0: registered as rtc01598machine # [ 0.695083] rtc-efi rtc-efi.0: setting system clock to 2026-09-06T07:01:42 UTC (1788678102)1599machine # [ 0.695399] i2c_dev: i2c /dev entries driver1600machine # [ 0.699377] sdhci: Secure Digital Host Controller Interface driver1601machine # [ 0.699390] sdhci: Copyright(c) Pierre Ossman1602machine # [ 0.699620] Synopsys Designware Multimedia Card Interface Driver1603machine # [ 0.699961] sdhci-pltfm: SDHCI platform and OF driver helper1604machine # [ 0.709147] pstore: Using crash dump compression: deflate1605machine # [ 0.709167] pstore: Registered efi_pstore as persistent store backend1606machine # [ 0.711382] hid: raw HID events driver (C) Jiri Kosina1607machine # [ 0.711660] usbcore: registered new interface driver usbhid1608machine # [ 0.711669] usbhid: USB HID core driver1609machine # [ 0.714580] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available1610machine # [ 0.715944] drop_monitor: Initializing network drop monitor service1611machine # [ 0.716066] NET: Registered PF_INET6 protocol family1612machine # [ 0.721057] Segment Routing with IPv61613machine # [ 0.721093] In-situ OAM (IOAM) with IPv61614machine # [ 0.721124] NET: Registered PF_PACKET protocol family1615machine # [ 0.722715] 9pnet: Installing 9P2000 support1616machine # [ 0.728902] Key type dns_resolver registered1617machine # [ 0.745029] registered taskstats version 11618machine # [ 0.745185] Loading compiled-in X.509 certificates1619machine # [ 0.760637] Demotion targets for Node 0: null1620machine # [ 0.761409] Key type .fscrypt registered1621machine # [ 0.761424] Key type fscrypt-provisioning registered1622machine # [ 0.761513] ima: No TPM chip found, activating TPM-bypass!1623machine # [ 0.761535] ima: Allocated hash algorithm: sha11624machine # [ 0.761557] ima: No architecture policies found1625machine # [ 0.801123] clk: Disabling unused clocks1626machine # [ 0.801153] PM: genpd: Disabling unused power domains1627machine # [ 0.906976] Freeing initrd memory: 26084K1628machine # [ 0.910400] Freeing unused kernel memory: 4736K1629machine # [ 0.910617] Run /init as init process1630machine # [ 0.927630] fuse: init (API version 7.45)1631machine # [ 0.936627] usb 1-1: new high-speed USB device number 2 using ehci-pci1632machine # [ 0.941725] systemd[1]: Successfully made /usr/ read-only.1633machine # [ 1.088965] 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/input11634machine # [ 1.161018] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0b.0-1/input01635machine # [ 1.276660] systemd[1]: systemd 262-726e17a 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)1636machine # [ 1.288273] usb 1-2: new high-speed USB device number 3 using ehci-pci1637machine # [ 1.291328] systemd[1]: Detected virtualization kvm.1638machine # [ 1.293297] systemd[1]: Detected architecture arm64.1639machine # [ 1.295206] systemd[1]: Running in initrd.1640machine # [ 1.297728] systemd[1]: Initializing machine ID from random generator.1641machine # [ 1.301106] systemd[1]: Hostname set to <machine>.1642machine # [ 1.440060] systemd[1]: bpf-restrict-fs: LSM BPF program attached1643machine # [ 1.448903] 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/input21644machine # [ 1.449064] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input01645machine # [ 1.505613] systemd[1]: Queued start job for default target Initrd Default Target.1646machine # [ 1.514493] systemd[1]: Created slice Slice /system/modprobe.1647machine # [ 1.515804] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1648machine # [ 1.516767] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1649machine # [ 1.517738] systemd[1]: Expecting device /dev/mapper/cryptroot...1650machine # [ 1.518500] systemd[1]: Expecting device /dev/tpm0...1651machine # [ 1.519127] systemd[1]: Expecting device /dev/tpmrm0...1652machine # [ 1.519775] systemd[1]: Expecting device /dev/vdb...1653machine # [ 1.520422] systemd[1]: Reached target Path Units.1654machine # [ 1.521084] systemd[1]: Reached target Slice Units.1655machine # [ 1.521701] systemd[1]: Reached target Swaps.1656machine # [ 1.522259] systemd[1]: Reached target Timer Units.1657machine # [ 1.523024] systemd[1]: Listening on D-Bus System Message Bus Socket.1658machine # [ 1.524016] systemd[1]: Listening on Journal Socket (/dev/log).1659machine # [ 1.524137] systemd[1]: Listening on Journal Sockets.1660machine # [ 1.524207] systemd[1]: Listening on udev Kernel Socket.1661machine # [ 1.524228] systemd[1]: Reached target Socket Units.1662machine # [ 1.527942] systemd[1]: Starting Create List of Static Device Nodes...1663machine # [ 1.534019] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1664machine # [ 1.534098] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1665machine # [ 1.540821] systemd[1]: Mounting Kernel Configuration File System...1666machine # [ 1.565870] systemd[1]: Starting Journal Service...1667machine # [ 1.571785] systemd[1]: Starting Load Kernel Modules...1668machine # [ 1.581977] systemd[1]: Starting Coldplug All udev Devices...1669machine # [ 1.595671] systemd[1]: Finished Create List of Static Device Nodes.1670machine # [ 1.597713] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1671machine # [ 1.606584] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1672machine # [ 1.616845] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1673machine # [ 1.617235] systemd[1]: Mounted Kernel Configuration File System.1674machine # [ 1.619943] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1675machine # [ 1.624752] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1676machine # [ 1.628289] systemd-journald[73]: Collecting audit messages is disabled.1677machine # [ 1.640280] [drm] pci: virtio-gpu-pci detected at 0000:00:09.01678machine # [ 1.640519] [drm] features: -virgl +edid -resource_blob -host_visible1679machine # [ 1.640530] [drm] features: -context_init1680machine # [ 1.649454] [drm] number of scanouts: 11681machine # [ 1.649483] [drm] number of cap sets: 01682machine # [ 1.654529] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic1683machine # [ 1.654551] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 01684machine # [ 1.661203] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1685machine # [ 1.663476] systemd[1]: Starting Create Static Device Nodes in /dev...1686machine # [ 1.676928] Console: switching to colour frame buffer device 160x501687machine # [ 1.705241] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device1688machine # [ 1.706786] systemd[1]: Finished Create Static Device Nodes in /dev.1689machine # [ 1.706955] systemd[1]: Reached target Preparation for Local File Systems.1690machine # [ 1.706998] systemd[1]: Reached target Local File Systems.1691machine # [ 1.710832] systemd[1]: Starting Rule-based Manager for Device Events and Files...1692machine # [ 1.728727] systemd[1]: Finished Load Kernel Modules.1693machine # [ 1.732929] systemd[1]: Starting Apply Kernel Variables...1694machine # [ 1.781204] systemd[1]: Finished Apply Kernel Variables.1695machine # [ 1.798445] systemd[1]: Started Journal Service.1696machine # [ 1.784369] systemd-modules-load[74]: Inserted module 'dm_mod'1697machine # [ 1.785381] systemd-modules-load[74]: Module 'virtio_balloon' is built in1698machine # [ 1.786448] systemd-modules-load[74]: Module 'virtio_console' is built in1699machine # [ 1.787609] systemd-modules-load[74]: Inserted module 'virtio_gpu'1700machine # [ 1.802598] systemd-modules-load[74]: Module 'virtio_rng' is built in1701machine # [ 1.803680] systemd[1]: Starting Create System Files and Directories...1702machine # [ 1.812644] systemd-udevd[81]: Using default interface naming scheme 'v261'.1703machine # [ 1.816126] systemd[1]: Finished Create System Files and Directories.1704machine # [ 1.839019] systemd[1]: Started Rule-based Manager for Device Events and Files.1705machine # [ 1.903618] systemd[1]: Starting Virtual Console Setup...1706machine # [ 1.940459] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1707machine # [ 1.943885] systemd[1]: Finished Virtual Console Setup.1708machine # [ 2.608692] systemd[1]: Finished Coldplug All udev Devices.1709machine # [ 2.739616] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1710machine # [ 2.772826] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1711machine # [ 2.775695] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.1712machine # [ 2.790598] systemd[1]: Found device /dev/vdb.1713machine # [ 3.786975] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)1714machine # [ 3.900937] systemd[1]: Found device /dev/tpm0.1715machine # [ 3.918974] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1716machine # [ 3.923833] systemd[1]: Stopped Virtual Console Setup.1717machine # [ 3.926146] systemd[1]: Stopping Virtual Console Setup...1718machine # [ 3.928625] systemd[1]: Starting Virtual Console Setup...1719machine # [ 3.935013] systemd[1]: Found device /dev/tpmrm0.1720machine # [ 3.936938] systemd[1]: Reached target Trusted Platform Module.1721machine # [ 3.938291] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 3.945903] systemd[1]: Starting Cryptography Setup for cryptroot...1723machine # [ 3.975986] systemd-vconsole-setup[115]: Configuration of first virtual console was skipped, ignoring remaining ones.1724machine # [ 3.980155] systemd[1]: Finished Virtual Console Setup.1725machine # [ 4.344265] Key type trusted registered1726machine # [ 4.348114] Key type encrypted registered1727machine # [ 4.362089] systemd[1]: Finished Cryptography Setup for cryptroot.1728machine # [ 4.364208] systemd[1]: Reached target Local Encrypted Volumes.1729machine # [ 4.365760] systemd[1]: Reached target System Initialization.1730machine # [ 4.368207] systemd[1]: Reached target Basic System.1731machine # [ 4.370850] systemd[1]: Found device /dev/mapper/cryptroot.1732machine # [ 4.372280] systemd[1]: Reached target Initrd Root Device.1733machine # [ 4.374167] systemd[1]: Starting File System Check on /dev/mapper/cryptroot...1734machine # [ 4.402645] systemd-fsck[130]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks1735machine # [ 4.411270] systemd[1]: Finished File System Check on /dev/mapper/cryptroot.1736machine # [ 4.413026] systemd[1]: Mounting /sysroot...1737machine # [ 4.514198] EXT4-fs (dm-0): mounted filesystem 1fb7216e-13b1-4a95-b653-e089383ad672 r/w with ordered data mode. Quota mode: none.1738machine # [ 4.489066] systemd[1]: Mounted /sysroot.1739machine # [ 4.491687] systemd[1]: Reached target Initrd Root File System.1740machine # [ 4.496316] systemd[1]: Starting Mountpoints Configured in the Real Root...1741machine # [ 4.512229] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.1742machine # [ 4.515558] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...1743machine # [ 4.519485] systemd[1]: Reloading...1744machine # [ 4.639535] systemd[1]: Reloading finished in 121 ms.1745machine # [ 4.667293] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...1746machine # [ 4.669944] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...1747machine # [ 4.673907] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1748machine # [ 4.675761] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1749machine # [ 4.680538] systemd[1]: Finished Mountpoints Configured in the Real Root.1750machine # [ 4.681624] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1751machine # [ 4.700302] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1752machine # [ 4.701833] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1753machine # [ 4.951273] systemd[1]: Mounting /sysroot/nix/.ro-store...1754machine # [ 4.962125] systemd[1]: Mounting /sysroot/nix/.rw-store...1755machine # [ 4.980538] systemd[1]: Mounting /sysroot/run...1756machine # [ 5.002783] systemd[1]: Mounting /sysroot/tmp/shared...1757machine # [ 5.020813] systemd[1]: Mounting /sysroot/tmp/xchg...1758machine # [ 5.061682] systemd[1]: Mounted /sysroot/nix/.ro-store.1759machine # [ 5.079099] systemd[1]: Mounted /sysroot/nix/.rw-store.1760machine # [ 5.080926] systemd[1]: Mounted /sysroot/run.1761machine # [ 5.087161] systemd[1]: Mounted /sysroot/tmp/shared.1762machine # [ 5.089132] systemd[1]: Mounted /sysroot/tmp/xchg.1763machine # [ 5.093471] systemd[1]: Starting rw-sysroot-nix-store.service...1764machine # [ 5.114721] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1765machine # [ 5.116439] systemd[1]: Finished rw-sysroot-nix-store.service.1766machine # [ 5.953220] systemd[1]: Mounting /sysroot/nix/store...1767machine # [ 6.020931] systemd[1]: Mounted /sysroot/nix/store.1768machine # [ 6.024791] systemd[1]: Reached target Initrd File Systems.1769machine # [ 6.029961] systemd[1]: Starting Find NixOS closure...1770machine # [ 6.038937] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1771machine # [ 6.090539] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1772machine # [ 6.092598] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1773machine # [ 6.109224] systemd[1]: Finished Find NixOS closure.1774machine # [ 6.112326] systemd[1]: Reached target Initrd Default Target.1775machine # [ 6.114352] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1776machine # [ 6.151554] systemd[1]: initrd-cleanup.service: Deactivated successfully.1777machine # [ 6.154272] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1778machine # [ 6.157759] systemd[1]: Stopped target Initrd Default Target.1779machine # [ 6.160178] systemd[1]: Stopped target Basic System.1780machine # [ 6.163348] systemd[1]: Stopped target Initrd Root Device.1781machine # [ 6.164595] systemd[1]: Stopped target Path Units.1782machine # [ 6.165727] systemd[1]: Stopped target Slice Units.1783machine # [ 6.167778] systemd[1]: Stopped target Socket Units.1784machine # [ 6.172293] systemd[1]: Stopped target System Initialization.1785machine # [ 6.173247] systemd[1]: Stopped target Local Encrypted Volumes.1786machine # [ 6.174182] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1787machine # [ 6.175353] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1788machine # [ 6.180246] systemd[1]: Stopped target Swaps.1789machine # [ 6.180984] systemd[1]: Stopped target Timer Units.1790machine # [ 6.181740] systemd[1]: Stopped target Trusted Platform Module.1791machine # [ 6.182625] systemd[1]: dbus.socket: Deactivated successfully.1792machine # [ 6.183524] systemd[1]: Closed D-Bus System Message Bus Socket.1793machine # [ 6.189341] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1794machine # [ 6.192256] systemd[1]: Stopped Find NixOS closure.1795machine # [ 6.194976] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1796machine # [ 6.203804] systemd[1]: Starting rw-sysroot-nix-store.service...1797machine # [ 6.205751] systemd[1]: systemd-sysctl.service: Deactivated successfully.1798machine # [ 6.206757] systemd[1]: Stopped Apply Kernel Variables.1799machine # [ 6.207667] systemd[1]: systemd-modules-load.service: Deactivated successfully.1800machine # [ 6.216319] systemd[1]: Stopped Load Kernel Modules.1801machine # [ 6.218957] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1802machine # [ 6.223887] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1803machine # [ 6.225329] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1804machine # [ 6.226590] systemd[1]: Stopped Create System Files and Directories.1805machine # [ 6.231767] systemd[1]: Stopped target Local File Systems.1806machine # [ 6.233172] systemd[1]: Stopped target Preparation for Local File Systems.1807machine # [ 6.234120] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1808machine # [ 6.235086] systemd[1]: Stopped Coldplug All udev Devices.1809machine # [ 6.235852] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1810machine # [ 6.237297] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1811machine # [ 6.238313] systemd[1]: Stopped Virtual Console Setup.1812machine # [ 6.239034] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1813machine # [ 6.240582] systemd[1]: Finished rw-sysroot-nix-store.service.1814machine # [ 6.241578] systemd[1]: systemd-udevd.service: Deactivated successfully.1815machine # [ 6.242489] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1816machine # [ 6.243474] systemd[1]: systemd-udevd.service: Consumed 1.532s CPU time over 4.538s wall clock time, 24M memory peak.1817machine # [ 6.252617] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1818machine # [ 6.253676] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1819machine # [ 6.254778] systemd[1]: Starting Cleanup udev Database...1820machine # [ 6.256153] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1821machine # [ 6.260224] systemd[1]: Stopped Create Static Device Nodes in /dev.1822machine # [ 6.261122] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1823machine # [ 6.264147] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1824machine # [ 6.265162] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1825machine # [ 6.268407] systemd[1]: Stopped Create List of Static Device Nodes.1826machine # [ 6.296096] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1827machine # [ 6.299417] systemd[1]: Finished Cleanup udev Database.1828machine # [ 6.304302] systemd[1]: Reached target Switch Root.1829machine # [ 6.305029] systemd[1]: Starting NixOS Activation...1830machine # [ 6.477937] initrd-nixos-activation-start[193]: booting system configuration /nix/store/pwdn3pg9462pbdvhdscclq72zv8h9lg9-nixos-system-machine-test1831machine # [ 6.549058] initrd-nixos-activation-start[193]: running activation script...1832machine # [ 6.997493] initrd-nixos-activation-start[216]: setting up /etc...1833machine # [ 7.269403] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1834machine # [ 7.272230] systemd[1]: Finished NixOS Activation.1835machine # [ 7.273422] systemd[1]: Starting Switch Root...1836machine # [ 7.295804] systemd[1]: Switching root.1837machine # [ 7.502938] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1838machine # [ 7.693047] NET: Registered PF_VSOCK protocol family1839machine # [ 8.087992] systemd[1]: systemd 262-726e17a 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)1840machine # [ 8.100939] systemd[1]: Detected virtualization kvm.1841machine # [ 8.103853] systemd[1]: Detected architecture arm64.1842machine # [ 8.106959] systemd[1]: Detected first boot.1843machine # [ 8.115055] systemd[1]: Initializing machine ID from random generator.1844machine # [ 8.297361] systemd[1]: bpf-restrict-fs: LSM BPF program attached1845machine # [ 8.463773] systemd[1]: Applying preset policy.1846machine # [ 8.968253] systemd[1]: Populated /etc with preset unit settings.1847machine # [ 9.512947] systemd[1]: initrd-switch-root.service: Deactivated successfully.1848machine # [ 9.514592] systemd[1]: Stopped initrd-switch-root.service.1849machine # [ 9.517644] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1850machine # [ 9.520319] systemd[1]: Created slice Slice /system/getty.1851machine # [ 9.523203] systemd[1]: Created slice Slice /system/systemd-fsck.1852machine # [ 9.526282] systemd[1]: Created slice User and Session Slice.1853machine # [ 9.527526] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1854machine # [ 9.530362] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1855machine # [ 9.531664] systemd[1]: Expecting device /dev/disk/by-label/ESP...1856machine # [ 9.533341] systemd[1]: Expecting device /dev/hvc0...1857machine # [ 9.535625] systemd[1]: Expecting device /dev/ttyAMA0...1858machine # [ 9.536690] systemd[1]: Reached target Local Encrypted Volumes.1859machine # [ 9.538229] systemd[1]: Stopped target initrd-fs.target.1860machine # [ 9.540534] systemd[1]: Stopped target initrd-root-fs.target.1861machine # [ 9.541652] systemd[1]: Stopped target initrd-switch-root.target.1862machine # [ 9.543209] systemd[1]: Reached target Virtual Machines and Containers.1863machine # [ 9.544989] systemd[1]: Reached target Path Units.1864machine # [ 9.546371] systemd[1]: Reached target Remote File Systems.1865machine # [ 9.547897] systemd[1]: Reached target Slice Units.1866machine # [ 9.549405] systemd[1]: Reached target Swaps.1867machine # [ 9.553730] systemd[1]: Listening on Query the User Interactively for a Password.1868machine # [ 9.558405] systemd[1]: Listening on Process Core Dump Socket.1869machine # [ 9.562268] systemd[1]: Listening on Credential Encryption/Decryption.1870machine # [ 9.566002] systemd[1]: Listening on Factory Reset Management.1871machine # [ 9.567248] systemd[1]: Listening on Hostname Service Socket.1872machine # [ 9.573434] systemd[1]: Starting Journal Log Access Socket...1873machine # [ 9.575852] systemd[1]: Listening on Journal Audit Socket.1874machine # [ 9.579931] systemd[1]: Listening on Console Output Muting Service Socket.1875machine # [ 9.582363] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1876machine # [ 9.584958] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1877machine # [ 9.587354] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1878machine # [ 9.598426] systemd[1]: Listening on Disk Repartitioning Service Socket.1879machine # [ 9.601000] systemd[1]: Listening on udev Varlink Socket.1880machine # [ 9.605736] systemd[1]: Mounting Huge Pages File System...1881machine # [ 9.611029] systemd[1]: Mounting POSIX Message Queue File System...1882machine # [ 9.620765] systemd[1]: Mounting Kernel Debug File System...1883machine # [ 9.626825] systemd[1]: Mounting Kernel Trace File System...1884machine # [ 9.639392] systemd[1]: Starting Create List of Static Device Nodes...1885machine # [ 9.657370] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1886machine # [ 9.658814] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1887machine # [ 9.669882] systemd[1]: Mounting Kernel Configuration File System...1888machine # [ 9.671076] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1889machine # [ 9.673491] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1890machine # [ 9.676025] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1891machine # [ 9.725600] systemd[1]: Mounting FUSE Control File System...1892machine # [ 9.730531] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully.1893machine # [ 9.737294] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service.1894machine # [ 9.747733] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671895machine # [ 9.769896] systemd[1]: Starting Journal Service...1896machine # [ 9.784206] systemd[1]: Starting Load Kernel Modules...1897machine # [ 9.806966] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1898machine # [ 9.818908] systemd[1]: Starting Remount Root and Kernel File Systems...1899machine # [ 9.822789] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1900machine # [ 9.845849] systemd[1]: Starting Coldplug All udev Devices...1901machine # [ 9.860574] systemd[1]: Listening on Journal Log Access Socket.1902machine # [ 9.873516] systemd[1]: Mounted Huge Pages File System.1903machine # [ 9.876327] systemd[1]: Mounted POSIX Message Queue File System.1904machine # [ 9.882205] systemd-journald[288]: Collecting audit messages is enabled.1905machine # [ 9.886747] systemd[1]: Mounted Kernel Debug File System.1906machine # [ 9.889406] systemd[1]: Mounted Kernel Trace File System.1907machine # [ 9.893382] systemd[1]: Finished Create List of Static Device Nodes.1908machine # [ 9.899682] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1909machine # [ 9.874921] systemd[1]: Queued start job for default target Multi-User System.1910machine # [ 9.905167] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1911machine # [ 9.907235] systemd[1]: Started Journal Service.1912machine # [ 9.881707] systemd[1]: systemd-journald.service: Deactivated successfully.1913machine # [ 9.891825] systemd-modules-load[289]: Module 'atkbd' is built in1914machine # [ 9.894613] systemd-modules-load[289]: Module 'loop' is built in1915machine # [ 9.901931] systemd[1]: Mounted Kernel Configuration File System.1916machine # [ 9.902959] systemd[1]: Mounted FUSE Control File System.1917machine # [ 9.903855] systemd[1]: Finished Load Kernel Modules.1918machine # [ 9.915303] systemd[1]: Starting Firewall...1919machine # [ 9.923258] systemd[1]: Starting Apply Kernel Variables...1920machine # [ 9.978529] EXT4-fs (dm-0): re-mounted 1fb7216e-13b1-4a95-b653-e089383ad672.1921machine # [ 9.958561] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1922machine # [ 9.992935] systemd[1]: Finished Remount Root and Kernel File Systems.1923machine # [ 10.038206] systemd[1]: Listening on Disk Image Download Service Socket.1924machine # [ 10.042308] systemd-oomd[290]: No swap; memory pressure usage will be degraded1925machine # [ 10.050929] systemd[1]: Starting Flush Journal to Persistent Storage...1926machine # [ 10.056675] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1927machine # [ 10.066684] systemd[1]: Starting Load/Save OS Random Seed...1928machine # [ 10.071633] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1929machine # [ 10.080828] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1930machine # [ 10.107193] systemd[1]: Finished Apply Kernel Variables.1931machine # [ 10.183002] systemd-journald[288]: Received client request to flush runtime journal.1932machine # [ 10.204466] systemd[1]: Finished Load/Save OS Random Seed.1933machine # [ 10.206725] systemd[1]: Reached target First Boot Complete.1934machine # [ 10.208840] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1935machine # [ 10.213223] systemd[1]: Starting Create Static Device Nodes in /dev...1936machine # [ 10.217298] systemd[1]: Finished Flush Journal to Persistent Storage.1937machine # [ 10.299336] systemd[1]: Finished Create Static Device Nodes in /dev.1938machine # [ 10.304286] systemd[1]: Reached target Preparation for Local File Systems.1939machine # [ 10.307306] systemd[1]: Starting Rule-based Manager for Device Events and Files...1940machine # [ 10.432534] systemd-udevd[329]: Using default interface naming scheme 'v261'.1941machine # [ 10.488648] systemd[1]: Mounting /run/wrappers...1942machine # [ 10.554906] systemd[1]: Mounted /run/wrappers.1943machine # [ 10.558661] systemd[1]: Starting Create SUID/SGID Wrappers...1944machine # [ 10.637354] systemd[1]: Started Rule-based Manager for Device Events and Files.1945machine # [ 11.368719] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1946machine # [ 11.370575] systemd[1]: Finished Create SUID/SGID Wrappers.1947machine # [ 11.697040] systemd[1]: Finished Coldplug All udev Devices.1948machine # [ 11.743379] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1949machine # [ 11.749186] systemd[1]: Finished Firewall.1950machine # [ 11.761488] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1951machine # [ 11.865666] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1952machine # [ 11.881665] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1953machine # [ 11.918556] (udev-worker)[358]: Network interface NamePolicy= disabled on kernel command line.1954machine # [ 11.924481] systemd[1]: Found device /dev/tpmrm0.1955machine # [ 11.925981] systemd[1]: Expecting device /dev/tpm0...1956machine # [ 11.934468] (udev-worker)[370]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1957machine # [ 11.936913] (udev-worker)[370]: Network interface NamePolicy= disabled on kernel command line.1958machine # [ 12.044661] systemd[1]: Condition check resulted in Virtio network device being skipped.1959machine # [ 12.047745] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1960machine # [ 12.052883] systemd[1]: Starting Create SUID/SGID Wrappers...1961machine # [ 12.054903] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671962machine # [ 12.064710] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1963machine # [ 12.169312] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.1964machine # [ 12.180493] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...1965machine # [ 12.293501] systemd-fsck[510]: fsck.fat 4.2 (2021-01-31)1966machine # [ 12.296607] systemd-fsck[510]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.1967machine # [ 12.303795] systemd-fsck[510]: Automatically removing dirty bit.1968machine # [ 12.307753] systemd-fsck[510]: *** Filesystem was changed ***1969machine # [ 12.311630] systemd-fsck[510]: Writing changes.1970machine # [ 12.314688] systemd-fsck[510]: /dev/vda1: 20 files, 28713/63671 clusters1971machine # [ 12.323426] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.1972machine # [ 12.326562] systemd[1]: Mounting /boot...1973machine # [ 12.427951] systemd[1]: Mounted /boot.1974machine # [ 12.431881] systemd[1]: Reached target Local File Systems.1975machine # [ 12.436161] systemd[1]: Listening on Boot Loader Control Service Socket.1976machine # [ 12.441810] systemd[1]: Starting register-nix-paths.service...1977machine # [ 12.448361] systemd[1]: Starting Update Boot Loader Random Seed...1978machine # [ 12.469150] systemd[1]: Starting Save Transient machine-id to Disk...1979machine # [ 12.495245] systemd[1]: Starting Create System Files and Directories...1980machine # [ 12.541946] mousedev: PS/2 mouse device common for all mice1981machine # [ 12.596860] bootctl[534]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 1982machine # [ 12.614973] bootctl[534]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!1983machine # [ 12.625766] systemd[1]: Finished register-nix-paths.service.1984machine # [ 12.631405] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1985machine # [ 12.638588] bootctl[534]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).1986machine # [ 12.641753] systemd[1]: Finished Save Transient machine-id to Disk.1987machine # [ 12.645866] systemd[1]: Finished Update Boot Loader Random Seed.1988machine # [ 12.693391] systemd[1]: Finished Create System Files and Directories.1989machine # [ 12.699787] systemd[1]: Starting Rebuild Journal Catalog...1990machine # [ 12.708456] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1991machine # [ 12.803484] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1992machine # [ 12.831654] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1993machine # [ 12.835999] systemd[1]: Finished Create SUID/SGID Wrappers.1994machine # [ 12.862428] systemd[1]: Finished Rebuild Journal Catalog.1995machine # [ 12.870510] systemd[1]: Starting Update is Completed...1996machine # [ 12.935989] systemd[1]: Finished Update is Completed.1997machine # [ 13.891584] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input31998machine # [ 13.925823] systemd[1]: Found device /dev/tpm0.1999machine # [ 13.929955] systemd[1]: Reached target Trusted Platform Module.2000machine # [ 13.933524] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2001machine # [ 13.937771] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2002machine # [ 13.942633] systemd[1]: Reached target System Initialization.2003machine # [ 13.945139] systemd[1]: Started Discard unused filesystem blocks once a week.2004machine # [ 13.948280] systemd[1]: Started Daily Cleanup of Temporary Directories.2005machine # [ 13.951763] systemd[1]: Reached target Timer Units.2006machine # [ 13.956295] systemd[1]: Listening on D-Bus System Message Bus Socket.2007machine # [ 13.957247] systemd[1]: Listening on Nix Daemon Socket.2008machine # [ 13.958026] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2009machine # [ 13.959172] systemd[1]: Reached target Socket Units.2010machine # [ 13.959945] systemd[1]: Reached target Basic System.2011machine # [ 13.969048] systemd[1]: Started backdoor.service.2012machine # [ 13.970762] systemd[1]: Starting Import lastlog data into lastlog2 database...2013machine # [ 13.974942] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2014machine # [ 14.002909] systemd[1]: Starting Post-Boot Actions...2015machine # [ 14.049657] systemd[1]: Started Reset console on configuration changes.2016machine # [ 14.092576] systemd[1]: Starting resolvconf update...2017machine # connecting to host...2018machine # [ 14.205280] systemd[1]: Starting D-Bus System Message Bus...2019machine # [ 14.214818] systemd[1]: Finished Post-Boot Actions.2020machine # [ 14.222779] nsncd[587]: Sep 06 07:01:56.054 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2021machine # [ 14.234157] systemd[1]: Started Name Service Cache Daemon (nsncd).2022machine # [ 14.240784] systemd[1]: Reached target Host and Network Name Lookups.2023machine # [ 14.252740] systemd[1]: Reached target User and Group Name Lookups.2024machine: Guest shell says: b'Spawning backdoor root shell...\n'2025machine # [ 14.287681] systemd[1]: Starting User Login Management...2026machine # [ 14.298006] systemd[1]: Finished Import lastlog data into lastlog2 database.2027machine: connected to guest root shell2028machine: (connecting took 28.33 seconds)2029machine: (finished: waiting for the VM to finish booting, in 28.54 seconds)2030machine # [ 14.521428] dbus-broker-launch[597]: Looking up NSS user entry for 'systemd-timesync'...2031machine # [ 14.553356] systemd-logind[613]: New seat seat0.2032machine # [ 14.568148] systemd-logind[613]: Watching system buttons on /dev/input/event0 (Power Button)2033machine # [ 14.571014] systemd-logind[613]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2034machine # [ 14.612573] systemd[1]: Started User Login Management.2035machine # [ 14.642720] systemd[1]: Stopped target Host and Network Name Lookups.2036machine # [ 14.647629] dbus-broker-launch[597]: NSS returned no entry for 'systemd-timesync'2037machine # [ 14.651127] dbus-broker-launch[597]: Invalid user-name in /nix/store/gm9klhq8g47cnz60qs9yf7xqbdk3i45s-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2038machine # [ 14.664706] systemd[1]: Stopping Host and Network Name Lookups...2039machine # [ 14.675456] systemd[1]: Stopped target User and Group Name Lookups.2040machine # [ 14.677444] systemd[1]: Stopping User and Group Name Lookups...2041machine # [ 14.678286] systemd[1]: Starting linger-users.service...2042machine # [ 14.679000] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2043machine # [ 14.679889] systemd[1]: nscd.service: Deactivated successfully.2044machine # [ 14.696202] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2045machine # [ 14.730550] systemd[1]: Started D-Bus System Message Bus.2046machine # [ 14.780392] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2047machine # [ 14.787382] dbus-broker-launch[597]: Ready2048machine # [ 14.795874] systemd[1]: Starting Virtual Console Setup...2049machine # [ 14.838349] systemd[1]: linger-users.service: Deactivated successfully.2050machine # [ 14.850154] systemd[1]: Finished linger-users.service.2051machine # [ 14.865013] systemd-logind[613]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2052machine # [ 14.944535] systemd[1]: Started Name Service Cache Daemon (nsncd).2053machine # [ 14.952444] nsncd[673]: Sep 06 07:01:56.780 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2054machine # [ 14.954477] systemd[1]: Reached target Host and Network Name Lookups.2055machine # [ 14.955405] systemd[1]: Reached target User and Group Name Lookups.2056machine # [ 14.974220] systemd[1]: Finished resolvconf update.2057machine # [ 14.977125] systemd[1]: Reached target Preparation for Network.2058machine # [ 14.985540] systemd[1]: Starting DHCP Client...2059machine # [ 14.990396] systemd[1]: Starting Address configuration of eth1...2060machine # [ 15.002291] systemd[1]: Starting Extra networking commands....2061machine # [ 15.173460] network-addresses-eth1-start[701]: adding address 192.168.1.1/24... done2062machine # [ 15.197786] network-addresses-eth1-start[701]: adding address 2001:db8:1::1/64... done2063machine # [ 15.241127] systemd[1]: Finished Address configuration of eth1.2064machine # [ 15.321028] dhcpcd[709]: dhcpcd-10.3.2 starting2065machine # [ 15.338475] dhcpcd[759]: dev: loaded udev2066machine # [ 15.369791] systemd[1]: Finished Extra networking commands..2067machine # [ 15.374140] systemd[1]: Reached target Network.2068machine # [ 15.384527] systemd[1]: Starting Permit User Sessions...2069machine # [ 15.435319] 8021q: 802.1Q VLAN Support v1.82070machine # [ 15.436511] 8021q: adding VLAN 0 to HW filter on device eth12071machine # [ 15.455993] systemd[1]: Finished Permit User Sessions.2072machine # [ 15.474761] systemd[1]: Started Getty on tty1.2073machine # [ 15.479793] systemd[1]: Reached target Login Prompts.2074machine # [ 15.511233] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2075machine # [ 15.567101] cfg80211: Loading compiled-in X.509 certificates for regulatory database2076machine # [ 15.604520] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2077machine # [ 15.607222] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2078machine # [ 15.612262] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22079machine # [ 15.614145] cfg80211: failed to load regulatory.db2080machine # [ 15.677512] 8021q: adding VLAN 0 to HW filter on device eth02081machine # [ 15.650591] dhcpcd[759]: eth0: waiting for carrier2082machine # [ 15.652634] dhcpcd[759]: eth0: carrier acquired2083machine # [ 15.664162] dhcpcd[759]: DUID 00:01:00:01:32:2f:cc:65:52:54:00:12:34:562084machine # [ 15.665277] dhcpcd[759]: eth0: IAID 00:12:34:562085machine # [ 15.666142] dhcpcd[759]: eth0: adding address fe80::5054:ff:fe12:34562086machine # [ 15.694159] systemd-vconsole-setup[675]: Configuration of first virtual console was skipped, ignoring remaining ones.2087machine # [ 15.698182] systemd[1]: Finished Virtual Console Setup.2088machine # [ 16.917031] dhcpcd[759]: eth0: soliciting a DHCP lease2089machine # [ 16.921219] dhcpcd[759]: eth0: offered 10.0.2.15 from 10.0.2.22090machine # [ 16.928487] dhcpcd[759]: eth0: probing address 10.0.2.15/242091machine # [ 17.196546] dhcpcd[759]: eth0: soliciting an IPv6 router2092machine # [ 17.200128] dhcpcd[759]: eth0: Router Advertisement from fe80::22093machine # [ 17.202623] dhcpcd[759]: eth0: adding address fec0::5054:ff:fe12:3456/642094machine # [ 17.205506] dhcpcd[759]: eth0: adding route to fec0::/642095machine # [ 17.207701] dhcpcd[759]: eth0: adding default route via fe80::22096machine # [ 21.519604] dhcpcd[759]: eth0: leased 10.0.2.15 for 86400 seconds2097machine # [ 21.529222] dhcpcd[759]: eth0: adding route to 10.0.2.0/242098machine # [ 21.531639] dhcpcd[759]: eth0: adding default route via 10.0.2.22099machine # [ 21.723105] systemd[1]: Started DHCP Client.2100machine # [ 21.725159] systemd[1]: Reached target Multi-User System.2101machine # [ 21.726254] systemd[1]: Startup finished in 7.065s (firmware) + 6.278s (loader) + 886ms (kernel) + 6.715s (initrd) + 14.123s (userspace) = 35.070s.2102machine: (finished: waiting for unit multi-user.target, in 36.96 seconds)2103machine: must succeed: mount2104machine: (finished: must succeed: mount, in 0.03 seconds)2105(finished: run the VM test script, in 78.09 seconds)2106test script finished in 78.15s2107cleanup2108kill QemuMachine (pid 92)2109machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2110(finished: cleanup, in 0.10 seconds)