vm-test-run-systemd-initrd-luks-tpm2
checks.aarch64-linux.systemd-initrd-luks-tpm2
· build #18
· 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/xjq158ipba1bh3adkv2jnywncrv8lg5a-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\x1b[0m\x1b[37m\x1b[40m'25machine: Guest shell says: b'------------------------------------------'26machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. '27machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'28machine: Guest shell says: b'---------------------'29machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. '30machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'31machine: Guest shell says: b'---------------------'32machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. '33machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'34machine: Guest shell says: b'------------------------------------------'35machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '36machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'37machine: Guest shell says: b'---------------------'38machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'39machine # NixOS (boot-luks) NixOS Reboot Into Firmware Interface Boot in 5s. ------------------------------------------ Boot in 4s. ------------------------------------------ Boot in 3s. ------------------------------------------ Boot in 2s. ------------------------------------------ Boot in 1s. ------------------------------------------[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 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\myz4kdr7ddksf3vyi9bg29agnkq8mk6x-initrd-linux-6.18.48-initrd.efi init=/nix/store/lvrpyayslq959672dwh1pslar35nvlq1-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.000033] arm-pv: using stolen time PV139machine # [ 0.000410] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)140machine # [ 0.000497] Console: colour dummy device 80x25141machine # [ 0.000502] printk: legacy console [tty0] enabled142machine # [ 0.000712] ACPI: Core revision 20250807143machine # [ 0.000788] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)144machine # [ 0.000795] pid_max: default: 32768 minimum: 301145machine # [ 0.000856] LSM: initializing lsm=capability,landlock,yama,bpf,ima146machine # [ 0.000990] landlock: Up and running.147machine # [ 0.000994] Yama: becoming mindful.148machine # [ 0.001435] LSM support for eBPF active149machine # [ 0.001518] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)150machine # [ 0.001525] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151machine # [ 0.002512] rcu: Hierarchical SRCU implementation.152machine # [ 0.002517] rcu: Max phase no-delay instances is 1000.153machine # [ 0.003171] fsl-mc MSI: ITS@0x8080000 domain created154machine # [ 0.003191] Remapping and enabling EFI services.155machine # [ 0.003296] smp: Bringing up secondary CPUs ...156machine # [ 0.003306] smp: Brought up 1 node, 1 CPU157machine # [ 0.003309] SMP: Total of 1 processors activated.158machine # [ 0.003312] CPU: All CPU(s) started at EL1159machine # [ 0.003322] CPU features: detected: Branch Target Identification160machine # [ 0.003327] CPU features: detected: ARMv8.4 Translation Table Level161machine # [ 0.003330] CPU features: detected: Instruction cache invalidation not required for I/D coherence162machine # [ 0.003334] CPU features: detected: Data cache clean to the PoU not required for I/D coherence163machine # [ 0.003337] CPU features: detected: Common not Private translations164machine # [ 0.003341] CPU features: detected: CRC32 instructions165machine # [ 0.003344] CPU features: detected: Data cache clean to Point of Deep Persistence166machine # [ 0.003347] CPU features: detected: Data cache clean to Point of Persistence167machine # [ 0.003350] CPU features: detected: Data independent timing control (DIT)168machine # [ 0.003354] CPU features: detected: E0PD169machine # [ 0.003356] CPU features: detected: Enhanced Counter Virtualization170machine # [ 0.003360] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)171machine # [ 0.003363] CPU features: detected: Enhanced Virtualization Traps172machine # [ 0.003366] CPU features: detected: Fine Grained Traps173machine # [ 0.003370] CPU features: detected: Generic authentication (architected QARMA5 algorithm)174machine # [ 0.003374] CPU features: detected: RCpc load-acquire (LDAPR)175machine # [ 0.003377] CPU features: detected: LSE atomic instructions176machine # [ 0.003380] CPU features: detected: Privileged Access Never177machine # [ 0.003383] CPU features: detected: PMUv3178machine # [ 0.003385] CPU features: detected: RAS Extension Support179machine # [ 0.003388] CPU features: detected: RASv1p1 Extension Support180machine # [ 0.003391] CPU features: detected: Random Number Generator181machine # [ 0.003393] CPU features: detected: Speculation barrier (SB)182machine # [ 0.003396] CPU features: detected: Stage-2 Force Write-Back183machine # [ 0.003399] CPU features: detected: TLB range maintenance instructions184machine # [ 0.003403] CPU features: detected: Speculative Store Bypassing Safe (SSBS)185machine # [ 0.003443] alternatives: applying system-wide alternatives186machine # [ 0.006143] CPU features: detected: BBM Level 2 without TLB conflict abort187machine # [ 0.006265] Memory: 887748K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 119500K reserved, 32768K cma-reserved)188machine # [ 0.006504] devtmpfs: initialized189machine # [ 0.007376] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)190machine # [ 0.007385] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).191machine # [ 0.007541] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL192machine # [ 0.007546] 0 pages in range for non-PLT usage193machine # [ 0.007547] 508288 pages in range for PLT usage194machine # [ 0.007625] pinctrl core: initialized pinctrl subsystem195machine # [ 0.008189] SMBIOS 3.0.0 present.196machine # [ 0.008195] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022197machine # [ 0.008203] DMI: Memory slots populated: 1/1198machine # [ 0.009485] NET: Registered PF_NETLINK/PF_ROUTE protocol family199machine # [ 0.010090] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations200machine # [ 0.010248] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations201machine # [ 0.010409] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202machine # [ 0.010428] audit: initializing netlink subsys (disabled)203machine # [ 0.010842] thermal_sys: Registered thermal governor 'fair_share'204machine # [ 0.010844] thermal_sys: Registered thermal governor 'bang_bang'205machine # [ 0.010848] thermal_sys: Registered thermal governor 'step_wise'206machine # [ 0.010851] thermal_sys: Registered thermal governor 'user_space'207machine # [ 0.010853] thermal_sys: Registered thermal governor 'power_allocator'208machine # [ 0.010878] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1209machine # [ 0.010887] cpuidle: using governor ladder210machine # [ 0.010894] cpuidle: using governor menu211machine # [ 0.011053] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.212machine # [ 0.011070] ASID allocator initialised with 65536 entries213machine # [ 0.011809] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5214machine # [ 0.011996] Serial: AMBA PL011 UART driver215machine # [ 0.018382] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages216machine # [ 0.018387] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page217machine # [ 0.018391] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages218machine # [ 0.018393] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page219machine # [ 0.018396] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages220machine # [ 0.018399] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page221machine # [ 0.018402] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages222machine # [ 0.018405] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page223machine # [ 0.019158] fbcon: Taking over console224machine # [ 0.019189] ACPI: Added _OSI(Module Device)225machine # [ 0.019192] ACPI: Added _OSI(Processor Device)226machine # [ 0.019195] ACPI: Added _OSI(Processor Aggregator Device)227machine # [ 0.020204] ACPI: 1 ACPI AML tables successfully acquired and loaded228machine # [ 0.026257] ACPI: Interpreter enabled229machine # [ 0.026262] ACPI: Using GIC for interrupt routing230machine # [ 0.026294] ACPI: MCFG table detected, 1 entries231machine # [ 0.030092] ACPI: CPU0 has been hot-added232machine # [ 0.030445] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA233machine # [ 0.030504] printk: console [ttyAMA0] enabled234machine # [ 0.105349] ACPI: PCI: Interrupt link L000 configured for IRQ 35235machine # [ 0.105370] ACPI: PCI: Interrupt link L001 configured for IRQ 36236machine # [ 0.105384] ACPI: PCI: Interrupt link L002 configured for IRQ 37237machine # [ 0.105395] ACPI: PCI: Interrupt link L003 configured for IRQ 38238machine # [ 0.105411] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])239machine # [ 0.105443] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]240machine # [ 0.105520] acpi PNP0A08:00: _OSC: platform does not support [LTR]241machine # [ 0.105612] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]242machine # [ 0.105844] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00243machine # [ 0.105859] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]244machine # [ 0.105881] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]245machine # [ 0.106209] PCI host bridge to bus 0000:00246machine # [ 0.106236] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]247machine # [ 0.106241] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]248machine # [ 0.106244] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]249machine # [ 0.106248] pci_bus 0000:00: root bus resource [bus 00-ff]250machine # [ 0.106251] PCI: OF: of_root node is NULL, cannot create PCI host bridge node251machine # [ 0.106326] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint252machine # [ 0.106804] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint253machine # [ 0.106982] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]254machine # [ 0.106995] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]255machine # [ 0.107019] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]256machine # [ 0.107031] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]257machine # [ 0.107508] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint258machine # [ 0.108495] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]259machine # [ 0.108508] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]260machine # [ 0.108534] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]261machine # [ 0.109146] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint262machine # [ 0.109327] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]263machine # [ 0.109338] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]264machine # [ 0.109363] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]265machine # [ 0.109877] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint266machine # [ 0.110053] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]267machine # [ 0.110064] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]268machine # [ 0.110089] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]269machine # [ 0.211673] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint270machine # [ 0.211866] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]271machine # [ 0.211882] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]272machine # [ 0.211913] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]273machine # [ 0.212404] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.213196] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]275machine # [ 0.213216] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]276machine # [ 0.213247] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]277machine # [ 0.213846] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint278machine # [ 0.214030] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]279machine # [ 0.214046] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]280machine # [ 0.214079] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]281machine # [ 0.214592] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint282machine # [ 0.214785] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]283machine # [ 0.214803] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]284machine # [ 0.214832] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]285machine # [ 0.214849] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]286machine # [ 0.215335] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint287machine # [ 0.230655] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]288machine # [ 0.230697] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]289machine # [ 0.231217] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint290machine # [ 0.231406] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]291machine # [ 0.231436] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]292machine # [ 0.231874] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint293machine # [ 0.232591] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]294machine # [ 0.232896] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.241052] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]296machine # [ 0.241077] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]297machine # [ 0.241108] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]298machine # [ 0.241622] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.245772] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]300machine # [ 0.245795] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]301machine # [ 0.245826] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]302machine # [ 0.248558] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.248574] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.248582] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.248626] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.248672] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.248718] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.248765] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.248812] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.248858] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.248905] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.248953] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.250011] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.250064] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.262744] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned316machine # [ 0.262795] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.262818] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.262840] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.262863] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.262885] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.262907] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.262930] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.262952] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.262975] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.263498] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.263524] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.274129] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.274161] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned329machine # [ 0.274185] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.275336] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned331machine # [ 0.275362] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned332machine # [ 0.275384] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned333machine # [ 0.275897] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned334machine # [ 0.275921] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned335machine # [ 0.282443] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned336machine # [ 0.282471] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned337machine # [ 0.282495] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned338machine # [ 0.282518] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned339machine # [ 0.283197] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]340machine # [ 0.283210] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]341machine # [ 0.283217] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]342machine # [ 0.292106] iommu: Default domain type: Translated343machine # [ 0.292120] iommu: DMA domain TLB invalidation policy: strict mode344machine # [ 0.293631] SCSI subsystem initialized345machine # [ 0.294226] ACPI: bus type USB registered346machine # [ 0.294271] usbcore: registered new interface driver usbfs347machine # [ 0.294292] usbcore: registered new interface driver hub348machine # [ 0.294309] usbcore: registered new device driver usb349machine # [ 0.294511] pps_core: LinuxPPS API ver. 1 registered350machine # [ 0.294518] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>351machine # [ 0.294530] PTP clock support registered352machine # [ 0.294576] EDAC MC: Ver: 3.0.0353machine # [ 0.299652] scmi_core: SCMI protocol bus registered354machine # [ 0.300337] efivars: Registered efivars operations355machine # [ 0.301286] FPGA manager framework356machine # [ 0.302142] vgaarb: loaded357machine # [ 0.302710] clocksource: Switched to clocksource arch_sys_counter358machine # [ 0.302994] VFS: Disk quotas dquot_6.6.0359machine # [ 0.303021] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360machine # [ 0.306604] netfs: FS-Cache loaded361machine # [ 0.307152] pnp: PnP ACPI init362machine # [ 0.307333] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved363machine # [ 0.307384] pnp: PnP ACPI: found 1 devices364machine # [ 0.311971] NET: Registered PF_INET protocol family365machine # [ 0.312027] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)366machine # [ 0.331365] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)367machine # [ 0.331404] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)368machine # [ 0.331429] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)369machine # [ 0.331475] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370machine # [ 0.331553] TCP: Hash tables configured (established 8192 bind 8192)371machine # [ 0.331619] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)372machine # [ 0.331649] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)373machine # [ 0.331674] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)374machine # [ 0.331749] NET: Registered PF_UNIX/PF_LOCAL protocol family375machine # [ 0.331777] NET: Registered PF_XDP protocol family376machine # [ 0.332345] PCI: CLS 0 bytes, default 64377machine # [ 0.332563] Trying to unpack rootfs image as initramfs...378machine # [ 0.348168] kvm [1]: HYP mode not available379machine # [ 0.439267] Initialise system trusted keyrings380machine # [ 0.439989] workingset: timestamp_bits=42 max_order=18 bucket_order=0381machine # [ 0.441202] squashfs: version 4.0 (2009/01/31) Phillip Lougher382machine # [ 0.441969] 9p: Installing v9fs 9p2000 file system support383machine # [ 0.462585] Key type asymmetric registered384machine # [ 0.462614] Asymmetric key parser 'x509' registered385machine # [ 0.462676] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)386machine # [ 0.470774] io scheduler mq-deadline registered387machine # [ 0.470796] io scheduler kyber registered388machine # [ 0.478750] ledtrig-cpu: registered to indicate activity on CPUs389machine # [ 0.480579] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0390machine # [ 0.480634] ACPI: button: Power Button [PWRB]391machine # [ 0.505122] ACPI: \_SB_.L001: Enabled at IRQ 36392machine # [ 0.505171] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)393machine # [ 0.515559] ACPI: \_SB_.L002: Enabled at IRQ 37394machine # [ 0.515604] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)395machine # [ 0.517721] ACPI: \_SB_.L003: Enabled at IRQ 38396machine # [ 0.517754] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)397machine # [ 0.523071] ACPI: \_SB_.L000: Enabled at IRQ 35398machine # [ 0.523107] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)399machine # [ 0.525185] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)400machine # [ 0.535351] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)401machine # [ 0.537156] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)402machine # [ 0.547360] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)403machine # [ 0.552596] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)404machine # [ 0.554527] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)405machine # [ 0.563820] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)406machine # [ 0.571959] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled407machine # [ 0.574311] msm_serial: driver initialized408machine # [ 0.574463] SuperH (H)SCI(F) driver initialized409machine # [ 0.574507] STM32 USART driver initialized410machine # [ 0.600894] ACPI: bus type drm_connector registered411machine # [ 0.608342] loop: module loaded412machine # [ 0.608506] virtio_blk virtio5: 1/0/0 default/read/poll queues413machine # [ 0.609165] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)414machine # [ 0.650754] vda: vda1 vda2415machine # [ 0.651103] virtio_blk virtio6: 1/0/0 default/read/poll queues416machine # [ 0.651774] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)417machine # [ 0.659244] megasas: 07.734.00.00-rc1418machine # [ 0.661496] tun: Universal TUN/TAP device driver, 1.6419machine # [ 0.664215] thunder_xcv, ver 1.0420machine # [ 0.664258] thunder_bgx, ver 1.0421machine # [ 0.664282] nicpf, ver 1.0422machine # [ 0.664858] e1000: Intel(R) PRO/1000 Network Driver423machine # [ 0.664866] e1000: Copyright (c) 1999-2006 Intel Corporation.424machine # [ 0.664893] e1000e: Intel(R) PRO/1000 Network Driver425machine # [ 0.664900] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.426machine # [ 0.664933] igb: Intel(R) Gigabit Ethernet Network Driver427machine # [ 0.664941] igb: Copyright (c) 2007-2014 Intel Corporation.428machine # [ 0.664965] igbvf: Intel(R) Gigabit Virtual Function Network Driver429machine # [ 0.664972] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.430machine # [ 0.665104] sky2: driver version 1.30431machine # [ 0.666521] usbcore: registered new interface driver usb-storage432machine # [ 0.666618] usbcore: registered new interface driver usbserial_generic433machine # [ 0.666634] usbserial: USB Serial support registered for generic434machine # [ 0.667538] ehci-pci 0000:00:0b.0: EHCI Host Controller435machine # [ 0.667564] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 1436machine # [ 0.667864] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a000437machine # [ 0.680358] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.00438machine # [ 0.680664] hub 1-0:1.0: USB hub found439machine # [ 0.680688] hub 1-0:1.0: 6 ports detected440machine # [ 0.683219] hv_vmbus: registering driver hyperv_keyboard441machine # [ 0.684498] rtc-efi rtc-efi.0: registered as rtc0442machine # [ 0.685096] rtc-efi rtc-efi.0: setting system clock to 2026-09-02T02:39:02 UTC (1788316742)443machine # [ 0.685422] i2c_dev: i2c /dev entries driver444machine # [ 0.689411] sdhci: Secure Digital Host Controller Interface driver445machine # [ 0.689425] sdhci: Copyright(c) Pierre Ossman446machine # [ 0.689660] Synopsys Designware Multimedia Card Interface Driver447machine # [ 0.689988] sdhci-pltfm: SDHCI platform and OF driver helper448machine # [ 0.699140] pstore: Using crash dump compression: deflate449machine # [ 0.699160] pstore: Registered efi_pstore as persistent store backend450machine # [ 0.699989] hid: raw HID events driver (C) Jiri Kosina451machine # [ 0.700263] usbcore: registered new interface driver usbhid452machine # [ 0.700272] usbhid: USB HID core driver453machine # [ 0.704524] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available454machine # [ 0.705879] drop_monitor: Initializing network drop monitor service455machine # [ 0.705994] NET: Registered PF_INET6 protocol family456machine # [ 0.710951] Segment Routing with IPv6457machine # [ 0.710976] In-situ OAM (IOAM) with IPv6458machine # [ 0.711016] NET: Registered PF_PACKET protocol family459machine # [ 0.712629] 9pnet: Installing 9P2000 support460machine # [ 0.714638] Key type dns_resolver registered461machine # [ 0.729047] registered taskstats version 1462machine # [ 0.729203] Loading compiled-in X.509 certificates463machine # [ 0.750812] Demotion targets for Node 0: null464machine # [ 0.751582] Key type .fscrypt registered465machine # [ 0.751594] Key type fscrypt-provisioning registered466machine # [ 0.751703] ima: No TPM chip found, activating TPM-bypass!467machine # [ 0.751724] ima: Allocated hash algorithm: sha1468machine # [ 0.751754] ima: No architecture policies found469machine # [ 0.787641] clk: Disabling unused clocks470machine # [ 0.787666] PM: genpd: Disabling unused power domains471machine # [ 0.901604] Freeing initrd memory: 25572K472machine # [ 0.905110] Freeing unused kernel memory: 4736K473machine # [ 0.905322] Run /init as init process474machine # [ 0.922536] fuse: init (API version 7.45)475machine # [ 0.930742] usb 1-1: new high-speed USB device number 2 using ehci-pci476machine # [ 0.935472] systemd[1]: Successfully made /usr/ read-only.477machine # [ 1.083054] 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.155154] 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.270319] systemd[1]: systemd 262-d2a5296 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)480machine # [ 1.282072] usb 1-2: new high-speed USB device number 3 using ehci-pci481machine # [ 1.285131] systemd[1]: Detected virtualization kvm.482machine # [ 1.287095] systemd[1]: Detected architecture arm64.483machine # [ 1.289020] systemd[1]: Running in initrd.484machine # [ 1.291657] systemd[1]: Initializing machine ID from random generator.485machine # [ 1.294903] systemd[1]: Hostname set to <machine>.486machine # [ 1.432853] systemd[1]: bpf-restrict-fs: LSM BPF program attached487machine # [ 1.440592] 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/input2488machine # [ 1.442228] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input0489machine # [ 1.494229] systemd[1]: Queued start job for default target Initrd Default Target.490machine # [ 1.504744] systemd[1]: Created slice Slice /system/modprobe.491machine # [ 1.505749] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492machine # [ 1.506962] systemd[1]: Expecting device /dev/disk/by-label/nixos...493machine # [ 1.507826] systemd[1]: Expecting device /dev/tpm0...494machine # [ 1.508520] systemd[1]: Expecting device /dev/tpmrm0...495machine # [ 1.509252] systemd[1]: Reached target Path Units.496machine # [ 1.509923] systemd[1]: Reached target Slice Units.497machine # [ 1.510633] systemd[1]: Reached target Swaps.498machine # [ 1.511265] systemd[1]: Reached target Timer Units.499machine # [ 1.512025] systemd[1]: Listening on D-Bus System Message Bus Socket.500machine # [ 1.512961] systemd[1]: Listening on Journal Socket (/dev/log).501machine # [ 1.513842] systemd[1]: Listening on Journal Sockets.502machine # [ 1.514504] systemd[1]: Listening on udev Kernel Socket.503machine # [ 1.515306] systemd[1]: Reached target Socket Units.504machine # [ 1.517205] systemd[1]: Starting Create List of Static Device Nodes...505machine # [ 1.521252] systemd[1]: Starting Load Kernel Module 9pnet_virtio...506machine # [ 1.522131] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs507machine # [ 1.530876] systemd[1]: Mounting Kernel Configuration File System...508machine # [ 1.550990] systemd[1]: Starting Journal Service...509machine # [ 1.558041] systemd[1]: Starting Load Kernel Modules...510machine # [ 1.572035] systemd[1]: Starting Coldplug All udev Devices...511machine # [ 1.590853] systemd[1]: Finished Create List of Static Device Nodes.512machine # [ 1.592020] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.513machine # [ 1.592309] systemd[1]: Finished Load Kernel Module 9pnet_virtio.514machine # [ 1.592539] systemd[1]: Mounted Kernel Configuration File System.515machine # [ 1.603184] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...516machine # [ 1.616435] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.517machine # [ 1.621267] systemd-journald[72]: Collecting audit messages is disabled.518machine # [ 1.631256] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev519machine # [ 1.635620] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0520machine # [ 1.635858] [drm] features: -virgl +edid -resource_blob -host_visible521machine # [ 1.635869] [drm] features: -context_init522machine # [ 1.636576] [drm] number of scanouts: 1523machine # [ 1.636594] [drm] number of cap sets: 0524machine # [ 1.655314] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.525machine # [ 1.657657] systemd[1]: Starting Create Static Device Nodes in /dev...526machine # [ 1.663073] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic527machine # [ 1.663093] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0528machine # [ 1.683233] Console: switching to colour frame buffer device 160x50529machine # [ 1.707292] systemd[1]: Finished Create Static Device Nodes in /dev.530machine # [ 1.707472] systemd[1]: Reached target Preparation for Local File Systems.531machine # [ 1.707496] systemd[1]: Reached target Local File Systems.532machine # [ 1.711287] systemd[1]: Starting Rule-based Manager for Device Events and Files...533machine # [ 1.719418] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device534machine # [ 1.731872] systemd[1]: Finished Load Kernel Modules.535machine # [ 1.734861] systemd[1]: Starting Apply Kernel Variables...536machine # [ 1.791351] systemd[1]: Finished Apply Kernel Variables.537machine # [ 1.786093] systemd-modules-load[73]: Inserted module 'dm_mod'538machine # [ 1.813916] systemd[1]: Started Journal Service.539machine # [ 1.796407] systemd-modules-load[73]: Module 'virtio_balloon' is built in540machine # [ 1.797539] systemd-modules-load[73]: Module 'virtio_console' is built in541machine # [ 1.798588] systemd-modules-load[73]: Inserted module 'virtio_gpu'542machine # [ 1.799546] systemd-modules-load[73]: Module 'virtio_rng' is built in543machine # [ 1.812714] systemd-udevd[78]: Using default interface naming scheme 'v261'.544machine # [ 1.813837] systemd[1]: Starting Create System Files and Directories...545machine # [ 1.828684] systemd[1]: Finished Create System Files and Directories.546machine # [ 1.847097] systemd[1]: Started Rule-based Manager for Device Events and Files.547machine # [ 1.911648] systemd[1]: Starting Virtual Console Setup...548machine # [ 1.956476] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 1.959638] systemd[1]: Finished Virtual Console Setup.550machine # [ 2.634009] systemd[1]: Finished Coldplug All udev Devices.551machine # [ 2.772433] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.552machine # [ 2.778525] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.553machine # [ 2.806592] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.554machine # [ 2.957067] systemd[1]: Found device /dev/disk/by-label/nixos.555machine # [ 2.977124] systemd[1]: Reached target Initrd Root Device.556machine # [ 2.984125] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...557machine # [ 3.030000] systemd-fsck[110]: nixos: clean, 67477/137632 files, 417042/549888 blocks558machine # [ 3.043136] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.559machine # [ 3.044641] systemd[1]: Mounting /sysroot...560machine # [ 3.109518] EXT4-fs (vda2): mounted filesystem f222513b-ded1-49fa-b591-20ce86a2fe7f r/w with ordered data mode. Quota mode: none.561machine # [ 3.088372] systemd[1]: Mounted /sysroot.562machine # [ 3.090262] systemd[1]: Reached target Initrd Root File System.563machine # [ 3.092845] systemd[1]: Starting Mountpoints Configured in the Real Root...564machine # [ 3.119471] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.565machine # [ 3.127640] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...566machine # [ 3.130738] systemd[1]: Reloading...567machine # [ 3.359383] systemd[1]: Reloading finished in 232 ms.568machine # [ 3.392874] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...569machine # [ 3.396949] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...570machine # [ 3.403001] systemd[1]: Starting Load Kernel Module 9pnet_virtio...571machine # [ 3.405699] systemd[1]: initrd-parse-etc.service: Deactivated successfully.572machine # [ 3.411699] systemd[1]: Finished Mountpoints Configured in the Real Root.573machine # [ 3.413630] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.574machine # [ 3.433793] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 3.435201] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 3.550062] systemd[1]: Mounting /sysroot/nix/.ro-store...577machine # [ 3.566434] systemd[1]: Mounting /sysroot/nix/.rw-store...578machine # [ 3.569421] systemd[1]: sysroot-run.mount: Directory /sysroot/run to mount over is not empty, mounting anyway.579machine # [ 3.593572] systemd[1]: Mounting /sysroot/run...580machine # [ 3.606012] systemd[1]: Mounting /sysroot/tmp/shared...581machine # [ 3.622458] systemd[1]: Mounting /sysroot/tmp/xchg...582machine # [ 3.629429] systemd[1]: Mounted /sysroot/nix/.rw-store.583machine # [ 3.638387] systemd[1]: Mounted /sysroot/nix/.ro-store.584machine # [ 3.658815] systemd[1]: Mounted /sysroot/run.585machine # [ 3.684873] systemd[1]: Starting rw-sysroot-nix-store.service...586machine # [ 3.698129] systemd[1]: Mounted /sysroot/tmp/shared.587machine # [ 3.704888] systemd[1]: Mounted /sysroot/tmp/xchg.588machine # [ 3.714578] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.589machine # [ 3.715973] systemd[1]: Finished rw-sysroot-nix-store.service.590machine # [ 4.178003] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)591machine # [ 4.292956] systemd[1]: Found device /dev/tpm0.592machine # [ 4.300493] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.593machine # [ 4.303575] systemd[1]: Stopped Virtual Console Setup.594machine # [ 4.307639] systemd[1]: Stopping Virtual Console Setup...595machine # [ 4.319360] systemd[1]: Starting Virtual Console Setup...596machine # [ 4.342972] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.597machine # [ 4.344519] systemd[1]: Stopped Virtual Console Setup.598machine # [ 4.347400] systemd[1]: Found device /dev/tpmrm0.599machine # [ 4.352134] systemd[1]: Reached target Trusted Platform Module.600machine # [ 4.354129] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os601machine # [ 4.359278] systemd[1]: Starting Virtual Console Setup...602machine # [ 4.385713] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.603machine # [ 4.388966] systemd[1]: Finished Virtual Console Setup.604machine # [ 4.390288] systemd[1]: Reached target System Initialization.605machine # [ 4.391157] systemd[1]: Reached target Basic System.606machine # [ 4.552337] systemd[1]: sysroot-nix-store.mount: Directory /sysroot/nix/store to mount over is not empty, mounting anyway.607machine # [ 4.564471] systemd[1]: Mounting /sysroot/nix/store...608machine # [ 4.621740] systemd[1]: Mounted /sysroot/nix/store.609machine # [ 4.624793] systemd[1]: Reached target Initrd File Systems.610machine # [ 4.628947] systemd[1]: Starting Find NixOS closure...611machine # [ 4.640730] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...612machine # [ 4.683852] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.613machine # [ 4.686424] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.614machine # [ 4.704165] systemd[1]: Finished Find NixOS closure.615machine # [ 4.705433] systemd[1]: Reached target Initrd Default Target.616machine # [ 4.707496] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...617machine # [ 4.739041] systemd[1]: Stopped target Initrd Default Target.618machine # [ 4.744602] systemd[1]: Stopped target Basic System.619machine # [ 4.745607] systemd[1]: Stopped target Initrd Root Device.620machine # [ 4.746660] systemd[1]: Stopped target Path Units.621machine # [ 4.747615] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.622machine # [ 4.752098] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.623machine # [ 4.756180] systemd[1]: Stopped target Slice Units.624machine # [ 4.757133] systemd[1]: Stopped target Socket Units.625machine # [ 4.758011] systemd[1]: Stopped target System Initialization.626machine # [ 4.760138] systemd[1]: Stopped target Swaps.627machine # [ 4.761454] systemd[1]: Stopped target Timer Units.628machine # [ 4.764173] systemd[1]: Stopped target Trusted Platform Module.629machine # [ 4.765508] systemd[1]: dbus.socket: Deactivated successfully.630machine # [ 4.768163] systemd[1]: Closed D-Bus System Message Bus Socket.631machine # [ 4.770372] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.632machine # [ 4.772600] systemd[1]: Stopped Find NixOS closure.633machine # [ 4.774555] systemd[1]: Starting Load Kernel Module 9pnet_virtio...634machine # [ 4.787982] systemd[1]: Starting rw-sysroot-nix-store.service...635machine # [ 4.790057] systemd[1]: systemd-sysctl.service: Deactivated successfully.636machine # [ 4.792919] systemd[1]: Stopped Apply Kernel Variables.637machine # [ 4.797844] systemd[1]: systemd-modules-load.service: Deactivated successfully.638machine # [ 4.801418] systemd[1]: Stopped Load Kernel Modules.639machine # [ 4.804765] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.640machine # [ 4.811614] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.641machine # [ 4.813159] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.642machine # [ 4.815700] systemd[1]: Stopped Create System Files and Directories.643machine # [ 4.819118] systemd[1]: Stopped target Local File Systems.644machine # [ 4.820429] systemd[1]: Stopped target Preparation for Local File Systems.645machine # [ 4.822633] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.646machine # [ 4.825238] systemd[1]: Stopped Coldplug All udev Devices.647machine # [ 4.826889] systemd[1]: Stopping Rule-based Manager for Device Events and Files...648machine # [ 4.831691] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.649machine # [ 4.833216] systemd[1]: Stopped Virtual Console Setup.650machine # [ 4.833946] systemd[1]: initrd-cleanup.service: Deactivated successfully.651machine # [ 4.834867] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.652machine # [ 4.835771] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.653machine # [ 4.837082] systemd[1]: Finished Load Kernel Module 9pnet_virtio.654machine # [ 4.837964] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.655machine # [ 4.838956] systemd[1]: Finished rw-sysroot-nix-store.service.656machine # [ 4.839783] systemd[1]: systemd-udevd.service: Deactivated successfully.657machine # [ 4.840842] systemd[1]: Stopped Rule-based Manager for Device Events and Files.658machine # [ 4.841850] systemd[1]: systemd-udevd.service: Consumed 1.514s CPU time over 3.137s wall clock time, 23.1M memory peak.659machine # [ 4.843266] systemd[1]: Starting Cleanup udev Database...660machine # [ 4.848137] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.661machine # [ 4.852184] systemd[1]: Stopped Create Static Device Nodes in /dev.662machine # [ 4.853286] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.663machine # [ 4.854583] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.664machine # [ 4.860132] systemd[1]: kmod-static-nodes.service: Deactivated successfully.665machine # [ 4.861175] systemd[1]: Stopped Create List of Static Device Nodes.666machine # [ 4.893282] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.667machine # [ 4.895941] systemd[1]: Finished Cleanup udev Database.668machine # [ 4.897250] systemd[1]: Reached target Switch Root.669machine # [ 4.900353] systemd[1]: Starting NixOS Activation...670machine # [ 5.067762] initrd-nixos-activation-start[179]: booting system configuration /nix/store/lvrpyayslq959672dwh1pslar35nvlq1-nixos-system-machine-test671machine # [ 5.137405] initrd-nixos-activation-start[179]: running activation script...672machine # [ 5.566387] initrd-nixos-activation-start[202]: setting up /etc...673machine # [ 5.903064] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.674machine # [ 5.905920] systemd[1]: Finished NixOS Activation.675machine # [ 5.908114] systemd[1]: Starting Switch Root...676machine # [ 5.927940] systemd[1]: Switching root.677machine # [ 6.134076] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).678machine # [ 6.320273] NET: Registered PF_VSOCK protocol family679machine # [ 6.715409] systemd[1]: systemd 262-d2a5296 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.727995] systemd[1]: Detected virtualization kvm.681machine # [ 6.731602] systemd[1]: Detected architecture arm64.682machine # [ 6.733634] systemd[1]: Detected first boot.683machine # [ 6.739988] systemd[1]: Initializing machine ID from random generator.684machine # [ 6.911614] systemd[1]: bpf-restrict-fs: LSM BPF program attached685machine # [ 7.072166] systemd[1]: Applying preset policy.686machine # [ 7.570513] systemd[1]: Populated /etc with preset unit settings.687machine # [ 8.106419] systemd[1]: initrd-switch-root.service: Deactivated successfully.688machine # [ 8.108021] systemd[1]: Stopped initrd-switch-root.service.689machine # [ 8.109827] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.690machine # [ 8.113674] systemd[1]: Created slice Slice /system/getty.691machine # [ 8.116743] systemd[1]: Created slice Slice /system/systemd-fsck.692machine # [ 8.119706] systemd[1]: Created slice User and Session Slice.693machine # [ 8.120947] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.694machine # [ 8.123673] systemd[1]: Started Forward Password Requests to Wall Directory Watch.695machine # [ 8.125813] systemd[1]: Expecting device /dev/disk/by-label/ESP...696machine # [ 8.127859] systemd[1]: Expecting device /dev/hvc0...697machine # [ 8.129649] systemd[1]: Expecting device /dev/ttyAMA0...698machine # [ 8.131573] systemd[1]: Reached target Local Encrypted Volumes.699machine # [ 8.133483] systemd[1]: Stopped target initrd-fs.target.700machine # [ 8.135414] systemd[1]: Stopped target initrd-root-fs.target.701machine # [ 8.137264] systemd[1]: Stopped target initrd-switch-root.target.702machine # [ 8.139232] systemd[1]: Reached target Virtual Machines and Containers.703machine # [ 8.141211] systemd[1]: Reached target Path Units.704machine # [ 8.143005] systemd[1]: Reached target Remote File Systems.705machine # [ 8.144849] systemd[1]: Reached target Slice Units.706machine # [ 8.146638] systemd[1]: Reached target Swaps.707machine # [ 8.150519] systemd[1]: Listening on Query the User Interactively for a Password.708machine # [ 8.155440] systemd[1]: Listening on Process Core Dump Socket.709machine # [ 8.159362] systemd[1]: Listening on Credential Encryption/Decryption.710machine # [ 8.163156] systemd[1]: Listening on Factory Reset Management.711machine # [ 8.165182] systemd[1]: Listening on Hostname Service Socket.712machine # [ 8.170649] systemd[1]: Starting Journal Log Access Socket...713machine # [ 8.173521] systemd[1]: Listening on Journal Audit Socket.714machine # [ 8.177870] systemd[1]: Listening on Console Output Muting Service Socket.715machine # [ 8.180409] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.716machine # [ 8.183158] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os717machine # [ 8.185601] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki718machine # [ 8.196874] systemd[1]: Listening on Disk Repartitioning Service Socket.719machine # [ 8.199200] systemd[1]: Listening on udev Varlink Socket.720machine # [ 8.204001] systemd[1]: Mounting Huge Pages File System...721machine # [ 8.209332] systemd[1]: Mounting POSIX Message Queue File System...722machine # [ 8.219817] systemd[1]: Mounting Kernel Debug File System...723machine # [ 8.229317] systemd[1]: Mounting Kernel Trace File System...724machine # [ 8.241474] systemd[1]: Starting Create List of Static Device Nodes...725machine # [ 8.254200] systemd[1]: Starting Load Kernel Module 9pnet_virtio...726machine # [ 8.256555] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs727machine # [ 8.269060] systemd[1]: Mounting Kernel Configuration File System...728machine # [ 8.270527] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm729machine # [ 8.275930] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore730machine # [ 8.284023] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 8.337875] systemd[1]: Mounting FUSE Control File System...732machine # [ 8.348917] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67733machine # [ 8.389495] systemd[1]: Starting Journal Service...734machine # [ 8.411793] systemd[1]: Starting Load Kernel Modules...735machine # [ 8.428940] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...736machine # [ 8.447281] systemd[1]: Starting Remount Root and Kernel File Systems...737machine # [ 8.451110] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os738machine # [ 8.479191] systemd[1]: Starting Coldplug All udev Devices...739machine # [ 8.482085] systemd[1]: Listening on Journal Log Access Socket.740machine # [ 8.482506] systemd[1]: Mounted Huge Pages File System.741machine # [ 8.489208] systemd[1]: Mounted POSIX Message Queue File System.742machine # [ 8.514862] systemd-journald[274]: Collecting audit messages is enabled.743machine # [ 8.524337] systemd[1]: Mounted Kernel Debug File System.744machine # [ 8.532348] systemd[1]: Mounted Kernel Trace File System.745machine # [ 8.514566] systemd[1]: Queued start job for default target Multi-User System.746machine # [ 8.522859] systemd[1]: systemd-journald.service: Deactivated successfully.747machine # [ 8.554893] systemd[1]: Started Journal Service.748machine # [ 8.534740] systemd[1]: Finished Create List of Static Device Nodes.749machine # [ 8.535797] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.750machine # [ 8.538542] systemd[1]: Finished Load Kernel Module 9pnet_virtio.751machine # [ 8.552170] systemd[1]: Mounted Kernel Configuration File System.752machine # [ 8.553371] systemd[1]: Mounted FUSE Control File System.753machine # [ 8.558432] systemd-modules-load[275]: Module 'atkbd' is built in754machine # [ 8.586016] EXT4-fs (vda2): re-mounted f222513b-ded1-49fa-b591-20ce86a2fe7f.755machine # [ 8.568534] systemd-modules-load[275]: Module 'loop' is built in756machine # [ 8.571075] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...757machine # [ 8.576263] systemd[1]: Finished Load Kernel Modules.758machine # [ 8.580252] systemd[1]: Finished Remount Root and Kernel File Systems.759machine # [ 8.616369] systemd-oomd[276]: No swap; memory pressure usage will be degraded760machine # [ 8.623488] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.761machine # [ 8.630145] systemd[1]: Listening on Disk Image Download Service Socket.762machine # [ 8.634359] systemd[1]: Starting Firewall...763machine # [ 8.637425] systemd[1]: Starting Flush Journal to Persistent Storage...764machine # [ 8.639662] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore765machine # [ 8.663281] systemd[1]: Starting Load/Save OS Random Seed...766machine # [ 8.677842] systemd[1]: Starting Apply Kernel Variables...767machine # [ 8.680905] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os768machine # [ 8.720863] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.769machine # [ 8.758319] systemd-journald[274]: Received client request to flush runtime journal.770machine # [ 8.794321] systemd[1]: Starting Create Static Device Nodes in /dev...771machine # [ 8.802591] systemd[1]: Finished Load/Save OS Random Seed.772machine # [ 8.808734] systemd[1]: Reached target First Boot Complete.773machine # [ 8.812976] systemd[1]: Finished Flush Journal to Persistent Storage.774machine # [ 8.834162] systemd[1]: Finished Apply Kernel Variables.775machine # [ 8.879804] systemd[1]: Finished Create Static Device Nodes in /dev.776machine # [ 8.886564] systemd[1]: Reached target Preparation for Local File Systems.777machine # [ 8.889327] systemd[1]: Starting Rule-based Manager for Device Events and Files...778machine # [ 8.999089] systemd-udevd[308]: Using default interface naming scheme 'v261'.779machine # [ 9.088298] systemd[1]: Mounting /run/wrappers...780machine # [ 9.159190] systemd[1]: Mounted /run/wrappers.781machine # [ 9.165461] systemd[1]: Starting Create SUID/SGID Wrappers...782machine # [ 9.209290] systemd[1]: Started Rule-based Manager for Device Events and Files.783machine # [ 9.913070] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.784machine # [ 9.917080] systemd[1]: Finished Create SUID/SGID Wrappers.785machine # [ 10.321629] systemd[1]: Finished Coldplug All udev Devices.786machine # [ 10.379104] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs787machine # [ 10.408823] systemd[1]: Finished Firewall.788machine # [ 10.411883] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse789machine # [ 10.510669] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.790machine # [ 10.532214] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.791machine # [ 10.564966] systemd[1]: Found device /dev/tpmrm0.792machine # [ 10.565888] systemd[1]: Expecting device /dev/tpm0...793machine # [ 10.575302] (udev-worker)[337]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.794machine # [ 10.580166] (udev-worker)[337]: Network interface NamePolicy= disabled on kernel command line.795machine # [ 10.583331] (udev-worker)[339]: Network interface NamePolicy= disabled on kernel command line.796machine # [ 10.703675] systemd[1]: Condition check resulted in Virtio network device being skipped.797machine # [ 10.706171] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore798machine # [ 10.710800] systemd[1]: Starting Create SUID/SGID Wrappers...799machine # [ 10.712512] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67800machine # [ 10.721177] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore801machine # [ 10.816135] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.802machine # [ 10.825880] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...803machine # [ 10.933989] systemd-fsck[494]: fsck.fat 4.2 (2021-01-31)804machine # [ 10.937410] systemd-fsck[494]: /dev/vda1: 20 files, 28704/63671 clusters805machine # [ 10.945942] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.806machine # [ 10.954025] systemd[1]: Mounting /boot...807machine # [ 11.064516] systemd[1]: Mounted /boot.808machine # [ 11.067150] systemd[1]: Reached target Local File Systems.809machine # [ 11.073683] systemd[1]: Listening on Boot Loader Control Service Socket.810machine # [ 11.080957] systemd[1]: Starting register-nix-paths.service...811machine # [ 11.094598] systemd[1]: Starting Update Boot Loader Random Seed...812machine # [ 11.104446] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 11.124116] systemd[1]: Starting Create System Files and Directories...814machine # [ 11.178900] mousedev: PS/2 mouse device common for all mice815machine # [ 11.206348] bootctl[518]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 816machine # [ 11.215273] bootctl[518]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!817machine # [ 11.231885] bootctl[518]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).818machine # [ 11.249366] bootctl[518]: Successfully initialized system token in EFI variable with 32 bytes.819machine # [ 11.257315] systemd[1]: Finished register-nix-paths.service.820machine # [ 11.264098] systemd[1]: Finished Update Boot Loader Random Seed.821machine # [ 11.265055] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.822machine # [ 11.274075] systemd[1]: Finished Save Transient machine-id to Disk.823machine # [ 11.340472] systemd[1]: Finished Create System Files and Directories.824machine # [ 11.348437] systemd[1]: Starting Rebuild Journal Catalog...825machine # [ 11.356577] systemd[1]: Starting Record System Boot/Shutdown in UTMP...826machine # [ 11.425418] systemd[1]: Finished Record System Boot/Shutdown in UTMP.827machine # [ 11.482016] systemd[1]: Finished Rebuild Journal Catalog.828machine # [ 11.488614] systemd[1]: Starting Update is Completed...829machine # [ 11.502479] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.830machine # [ 11.508916] systemd[1]: Finished Create SUID/SGID Wrappers.831machine # [ 11.541727] systemd[1]: Finished Update is Completed.832machine # [ 12.348348] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input3833machine # [ 12.387473] systemd[1]: Found device /dev/tpm0.834machine # [ 12.390052] systemd[1]: Reached target Trusted Platform Module.835machine # [ 12.393530] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os836machine # [ 12.396046] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os837machine # [ 12.401059] systemd[1]: Reached target System Initialization.838machine # [ 12.404841] systemd[1]: Started Discard unused filesystem blocks once a week.839machine # [ 12.408363] systemd[1]: Started Daily Cleanup of Temporary Directories.840machine # [ 12.410327] systemd[1]: Reached target Timer Units.841machine # [ 12.412933] systemd[1]: Listening on D-Bus System Message Bus Socket.842machine # [ 12.417065] systemd[1]: Listening on Nix Daemon Socket.843machine # [ 12.418719] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.844machine # [ 12.422317] systemd[1]: Reached target Socket Units.845machine # [ 12.424434] systemd[1]: Reached target Basic System.846machine # [ 12.428168] systemd[1]: Started backdoor.service.847machine # [ 12.429697] systemd[1]: Starting Import lastlog data into lastlog2 database...848machine # [ 12.433233] systemd[1]: Starting Name Service Cache Daemon (nsncd)...849machine # [ 12.451208] systemd[1]: Starting Post-Boot Actions...850machine # [ 12.480333] systemd[1]: Started Reset console on configuration changes.851machine # [ 12.499249] systemd[1]: Starting resolvconf update...852machine # [ 12.547930] systemd[1]: Starting D-Bus System Message Bus...853machine # connecting to host...854machine # [ 12.616939] systemd[1]: Finished Post-Boot Actions.855machine: Guest shell says: b'Spawning backdoor root shell...\n'856machine # [ 12.624807] nsncd[574]: Sep 02 02:39:14.464 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"857machine # [ 12.635776] systemd[1]: Started Name Service Cache Daemon (nsncd).858machine # [ 12.642872] systemd[1]: Reached target Host and Network Name Lookups.859machine # [ 12.650288] systemd[1]: Reached target User and Group Name Lookups.860machine: connected to guest root shell861machine # [ 12.664532] systemd[1]: Starting User Login Management...862machine: (connecting took 27.77 seconds)863machine: (finished: waiting for the VM to finish booting, in 28.04 seconds)864machine # [ 12.708968] systemd[1]: Finished Import lastlog data into lastlog2 database.865machine # [ 12.843834] dbus-broker-launch[581]: Looking up NSS user entry for 'systemd-timesync'...866machine # [ 12.865188] systemd-logind[600]: New seat seat0.867machine # [ 12.877266] systemd-logind[600]: Watching system buttons on /dev/input/event0 (Power Button)868machine # [ 12.880913] systemd-logind[600]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)869machine # [ 12.903936] systemd[1]: Started User Login Management.870machine # [ 12.918453] dbus-broker-launch[581]: NSS returned no entry for 'systemd-timesync'871machine # [ 12.919492] dbus-broker-launch[581]: Invalid user-name in /nix/store/zwh89yakr3bibysbla21ypwbsxzvb81r-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"872machine # [ 12.930313] systemd[1]: Starting linger-users.service...873machine # [ 12.948798] systemd[1]: Stopped target Host and Network Name Lookups.874machine # [ 12.949769] systemd[1]: Stopping Host and Network Name Lookups...875machine # [ 12.950597] systemd[1]: Stopped target User and Group Name Lookups.876machine # [ 12.951438] systemd[1]: Stopping User and Group Name Lookups...877machine # [ 12.958975] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...878machine # [ 12.966215] systemd[1]: Starting Virtual Console Setup...879machine # [ 12.991734] systemd[1]: Started D-Bus System Message Bus.880machine # [ 13.000482] systemd[1]: nscd.service: Deactivated successfully.881machine # [ 13.003620] systemd[1]: Stopped Name Service Cache Daemon (nsncd).882machine # [ 13.045027] dbus-broker-launch[581]: Ready883machine # [ 13.067055] systemd[1]: linger-users.service: Deactivated successfully.884machine # [ 13.072743] systemd[1]: Finished linger-users.service.885machine # [ 13.076597] systemd-logind[600]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)886machine # [ 13.113734] systemd[1]: Starting Name Service Cache Daemon (nsncd)...887machine # [ 13.168338] systemd[1]: Started Name Service Cache Daemon (nsncd).888machine # [ 13.171011] systemd[1]: Finished resolvconf update.889machine # [ 13.175379] nsncd[670]: Sep 02 02:39:15.009 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"890machine # [ 13.179854] systemd[1]: Reached target Preparation for Network.891machine # [ 13.181270] systemd[1]: Reached target Host and Network Name Lookups.892machine # [ 13.184356] systemd[1]: Reached target User and Group Name Lookups.893machine # [ 13.185575] systemd[1]: Starting DHCP Client...894machine # [ 13.188279] systemd[1]: Starting Address configuration of eth1...895machine # [ 13.197730] systemd[1]: Starting Extra networking commands....896machine # [ 13.335311] network-addresses-eth1-start[688]: adding address 192.168.1.1/24... done897machine # [ 13.352888] network-addresses-eth1-start[688]: adding address 2001:db8:1::1/64... done898machine # [ 13.382337] systemd[1]: Finished Address configuration of eth1.899machine # [ 13.422037] dhcpcd[696]: dhcpcd-10.3.2 starting900machine # [ 13.434799] dhcpcd[742]: dev: loaded udev901machine # [ 13.474600] systemd[1]: Finished Extra networking commands..902machine # [ 13.478927] systemd[1]: Reached target Network.903machine # [ 13.482355] systemd[1]: Starting Permit User Sessions...904machine # [ 13.512815] 8021q: 802.1Q VLAN Support v1.8905machine # [ 13.513205] 8021q: adding VLAN 0 to HW filter on device eth1906machine # [ 13.533388] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.907machine # [ 13.543732] systemd[1]: Finished Permit User Sessions.908machine # [ 13.553177] systemd[1]: Started Getty on tty1.909machine # [ 13.554607] systemd[1]: Reached target Login Prompts.910machine # [ 13.609244] cfg80211: Loading compiled-in X.509 certificates for regulatory database911machine # [ 13.641448] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'912machine # [ 13.641912] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'913machine # [ 13.646409] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2914machine # [ 13.646780] cfg80211: failed to load regulatory.db915machine # [ 13.708747] 8021q: adding VLAN 0 to HW filter on device eth0916machine # [ 13.683606] dhcpcd[742]: eth0: waiting for carrier917machine # [ 13.685539] dhcpcd[742]: eth0: carrier acquired918machine # [ 13.697332] dhcpcd[742]: DUID 00:01:00:01:32:2a:48:d3:52:54:00:12:34:56919machine # [ 13.698533] dhcpcd[742]: eth0: IAID 00:12:34:56920machine # [ 13.699302] dhcpcd[742]: eth0: adding address fe80::5054:ff:fe12:3456921machine # [ 13.726244] systemd-vconsole-setup[651]: Configuration of first virtual console was skipped, ignoring remaining ones.922machine # [ 13.729942] systemd[1]: Finished Virtual Console Setup.923machine # [ 15.320916] dhcpcd[742]: eth0: soliciting a DHCP lease924machine # [ 15.324699] dhcpcd[742]: eth0: offered 10.0.2.15 from 10.0.2.2925machine # [ 15.332288] dhcpcd[742]: eth0: probing address 10.0.2.15/24926machine # [ 15.697433] dhcpcd[742]: eth0: soliciting an IPv6 router927machine # [ 15.701084] dhcpcd[742]: eth0: Router Advertisement from fe80::2928machine # [ 15.703617] dhcpcd[742]: eth0: adding address fec0::5054:ff:fe12:3456/64929machine # [ 15.706512] dhcpcd[742]: eth0: adding route to fec0::/64930machine # [ 15.708926] dhcpcd[742]: eth0: adding default route via fe80::2931machine # [ 20.001112] dhcpcd[742]: eth0: leased 10.0.2.15 for 86400 seconds932machine # [ 20.006088] dhcpcd[742]: eth0: adding route to 10.0.2.0/24933machine # [ 20.010248] dhcpcd[742]: eth0: adding default route via 10.0.2.2934machine # [ 20.162976] systemd[1]: Started DHCP Client.935machine # [ 20.164451] systemd[1]: Reached target Multi-User System.936machine # [ 20.165659] systemd[1]: Startup finished in 8.154s (firmware) + 6.285s (loader) + 883ms (kernel) + 5.353s (initrd) + 13.929s (userspace) = 34.605s.937machine: (finished: waiting for unit multi-user.target, in 36.30 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.53 seconds)940machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot941machine # [ 24.072239] Key type trusted registered942machine # [ 24.076106] Key type encrypted registered943machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.64 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.10 seconds)947machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat948machine # [ 24.253957] cat[923]: Successfully called mlockall().949machine # [ 24.254935] cat[923]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory950machine # [ 24.259910] cat[923]: Loaded shared library 'libcryptsetup.so.12' via dlopen().951machine # [ 24.261935] cat[923]: Allocating context for crypt device /dev/vdb.952machine # [ 24.263720] cat[923]: Trying to open device /dev/vdb with direct-io.953machine # [ 24.265158] cat[923]: Initialising device-mapper backend library.954machine # [ 24.267421] cat[923]: Trying to load LUKS2 crypt type from device /dev/vdb.955machine # [ 24.268660] 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.270632] cat[923]: Detected kernel Linux 6.18.48 aarch64.957machine # [ 24.271588] cat[923]: Loading LUKS2 header (repair disabled).958machine # [ 24.272725] cat[923]: Acquiring read lock for device /dev/vdb.959machine # [ 24.274205] cat[923]: Opening lock resource file /run/cryptsetup/L_254:16960machine # [ 24.275141] cat[923]: Verifying lock handle for /dev/vdb.961machine # [ 24.275893] cat[923]: Device /dev/vdb READ lock taken.962machine # [ 24.280111] cat[923]: Trying to read primary LUKS2 header at offset 0x0.963machine # [ 24.281087] cat[923]: Opening locked device /dev/vdb964machine # [ 24.281790] cat[923]: Verifying locked device handle (bdev)965machine # [ 24.282556] cat[923]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.966machine # [ 24.283651] cat[923]: Checksum:d7184cf6b847ed6fa2c7ea01f1d7069d3e4d807a52ae154b566c7a7aefd88122 (on-disk)967machine # [ 24.292082] cat[923]: Checksum:d7184cf6b847ed6fa2c7ea01f1d7069d3e4d807a52ae154b566c7a7aefd88122 (in-memory)968machine # [ 24.293366] cat[923]: Trying to read secondary LUKS2 header at offset 0x4000.969machine # [ 24.294327] cat[923]: Reusing open ro fd on device /dev/vdb970machine # [ 24.295085] cat[923]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.971machine # [ 24.300085] cat[923]: Checksum:8a02c5637d82ee1c61f6a86abd2e60037dc60e8ca15c128e9d4cf933dca99394 (on-disk)972machine # [ 24.301357] cat[923]: Checksum:8a02c5637d82ee1c61f6a86abd2e60037dc60e8ca15c128e9d4cf933dca99394 (in-memory)973machine # [ 24.302624] cat[923]: Device size 536870912, offset 16777216.974machine # [ 24.303413] cat[923]: Device /dev/vdb READ lock released.975machine # [ 24.308197] cat[923]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1.976machine # [ 24.310347] cat[923]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 363076kB.977machine # [ 24.311645] cat[923]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 363076, parallel_threads 1.978machine # [ 24.316093] cat[923]: Requesting JSON for token 0.979machine # [ 24.316776] cat[923]: Requesting JSON for token 1.980machine # [ 24.317437] cat[923]: Requesting JSON for token 2.981machine # [ 24.318097] cat[923]: Requesting JSON for token 3.982machine # [ 24.318773] cat[923]: Requesting JSON for token 4.983machine # [ 24.319435] cat[923]: Requesting JSON for token 5.984machine # [ 24.324133] cat[923]: Requesting JSON for token 6.985machine # [ 24.324820] cat[923]: Requesting JSON for token 7.986machine # [ 24.325482] cat[923]: Requesting JSON for token 8.987machine # [ 24.326159] cat[923]: Requesting JSON for token 9.988machine # [ 24.326834] cat[923]: Requesting JSON for token 10.989machine # [ 24.327506] cat[923]: Requesting JSON for token 11.990machine # [ 24.332072] cat[923]: Requesting JSON for token 12.991machine # [ 24.332771] cat[923]: Requesting JSON for token 13.992machine # [ 24.333444] cat[923]: Requesting JSON for token 14.993machine # [ 24.334112] cat[923]: Requesting JSON for token 15.994machine # [ 24.334783] cat[923]: Requesting JSON for token 16.995machine # [ 24.335451] cat[923]: Requesting JSON for token 17.996machine # [ 24.340087] cat[923]: Requesting JSON for token 18.997machine # [ 24.340795] cat[923]: Requesting JSON for token 19.998machine # [ 24.341464] cat[923]: Requesting JSON for token 20.999machine # [ 24.342141] cat[923]: Requesting JSON for token 21.1000machine # [ 24.342827] cat[923]: Requesting JSON for token 22.1001machine # [ 24.343503] cat[923]: Requesting JSON for token 23.1002machine # [ 24.348126] cat[923]: Requesting JSON for token 24.1003machine # [ 24.348865] cat[923]: Requesting JSON for token 25.1004machine # [ 24.349542] cat[923]: Requesting JSON for token 26.1005machine # [ 24.350211] cat[923]: Requesting JSON for token 27.1006machine # [ 24.350890] cat[923]: Requesting JSON for token 28.1007machine # [ 24.351567] cat[923]: Requesting JSON for token 29.1008machine # [ 24.360096] cat[923]: Requesting JSON for token 30.1009machine # [ 24.360853] cat[923]: Requesting JSON for token 31.1010machine # [ 24.361510] cat[923]: Keyslot 0 priority 1 != 2 (required), skipped.1011machine # [ 24.362334] cat[923]: Trying to open LUKS2 keyslot 0.1012machine # [ 24.363009] cat[923]: Running keyslot key derivation.1013machine # [ 24.623864] cat[923]: Reading keyslot area [0x8000].1014machine # [ 24.625926] cat[923]: Acquiring read lock for device /dev/vdb.1015machine # [ 24.627192] cat[923]: Opening lock resource file /run/cryptsetup/L_254:161016machine # [ 24.632108] cat[923]: Verifying lock handle for /dev/vdb.1017machine # [ 24.632887] cat[923]: Device /dev/vdb READ lock taken.1018machine # [ 24.633609] cat[923]: Reusing open ro fd on device /dev/vdb1019machine # [ 24.634437] cat[923]: Device /dev/vdb READ lock released.1020machine # [ 24.636215] cat[923]: Verifying key from keyslot 0, digest 0.1021machine # [ 24.700691] cat[923]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory1022machine # [ 24.702179] cat[923]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory1023machine # [ 24.706569] cat[923]: Loaded shared library 'libtss2-esys.so.0' via dlopen().1024machine # [ 24.708541] cat[923]: Loaded shared library 'libtss2-rc.so.0' via dlopen().1025machine # [ 24.709603] cat[923]: Loaded shared library 'libtss2-mu.so.0' via dlopen().1026machine # [ 24.711383] cat[923]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen().1027machine # [ 24.712803] cat[923]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'.1028machine # [ 24.714216] cat[923]: Loaded 'libtss2-tcti-device.so.0' via dlopen()1029machine # [ 24.715094] cat[923]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2]1030machine # [ 24.718141] cat[923]: TPM successfully started up.1031machine # [ 24.718838] cat[923]: Getting TPM2 capability 0x0000 property 0x0001 count 127.1032machine # [ 24.721109] cat[923]: Getting TPM2 capability 0x0002 property 0x011f count 256.1033machine # [ 24.732063] cat[923]: Getting TPM2 capability 0x0008 property 0x0000 count 508.1034machine # [ 24.734495] cat[923]: Getting TPM2 capability 0x0005 property 0x0000 count 1.1035machine # [ 24.736945] cat[923]: Getting TPM2 capability 0x0006 property 0x012c count 1.1036machine # [ 24.742155] cat[923]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.450ms.1037machine # [ 24.743564] cat[923]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1038machine # [ 24.745091] cat[923]: TPM handle 0x81000001 not populated.1039machine # [ 24.746195] cat[923]: Creating primary key on TPM.1040machine # [ 24.756391] cat[923]: Successfully created primary key on TPM in 10ms.1041machine # [ 24.766808] cat[923]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1042machine # [ 24.803404] cat[923]: Starting HMAC encryption session.1043machine # [ 24.820806] cat[923]: Generating secret key data.1044machine # [ 24.824055] cat[923]: Creating HMAC key on TPM for shard 0.1045machine # [ 24.825013] cat[923]: Creating object on TPM.1046machine # [ 24.840623] cat[923]: Successfully created object on TPM in 18ms.1047machine # [ 24.843814] cat[923]: Marshalling private and public part of HMAC key for shard 0.1048machine # [ 24.845148] cat[923]: Completed TPM2 key sealing in 101.165ms.1049machine # [ 24.849377] cat[923]: Requesting JSON for token 0.1050machine # [ 24.850163] cat[923]: Requesting JSON for token 1.1051machine # [ 24.850908] cat[923]: Requesting JSON for token 2.1052machine # [ 24.851655] cat[923]: Requesting JSON for token 3.1053machine # [ 24.852668] cat[923]: Requesting JSON for token 4.1054machine # [ 24.853514] cat[923]: Requesting JSON for token 5.1055machine # [ 24.854342] cat[923]: Requesting JSON for token 6.1056machine # [ 24.855168] cat[923]: Requesting JSON for token 7.1057machine # [ 24.856000] cat[923]: Requesting JSON for token 8.1058machine # [ 24.858202] cat[923]: Requesting JSON for token 9.1059machine # [ 24.859402] cat[923]: Requesting JSON for token 10.1060machine # [ 24.860202] cat[923]: Requesting JSON for token 11.1061machine # [ 24.860944] cat[923]: Requesting JSON for token 12.1062machine # [ 24.863903] cat[923]: Requesting JSON for token 13.1063machine # [ 24.864749] cat[923]: Requesting JSON for token 14.1064machine # [ 24.865482] cat[923]: Requesting JSON for token 15.1065machine # [ 24.866235] cat[923]: Requesting JSON for token 16.1066machine # [ 24.866981] cat[923]: Requesting JSON for token 17.1067machine # [ 24.867747] cat[923]: Requesting JSON for token 18.1068machine # [ 24.873796] cat[923]: Requesting JSON for token 19.1069machine # [ 24.874584] cat[923]: Requesting JSON for token 20.1070machine # [ 24.876058] cat[923]: Requesting JSON for token 21.1071machine # [ 24.876749] cat[923]: Requesting JSON for token 22.1072machine # [ 24.877496] cat[923]: Requesting JSON for token 23.1073machine # [ 24.878211] cat[923]: Requesting JSON for token 24.1074machine # [ 24.879292] cat[923]: Requesting JSON for token 25.1075machine # [ 24.879990] cat[923]: Requesting JSON for token 26.1076machine # [ 24.880718] cat[923]: Requesting JSON for token 27.1077machine # [ 24.883466] cat[923]: Requesting JSON for token 28.1078machine # [ 24.884192] cat[923]: Requesting JSON for token 29.1079machine # [ 24.884905] cat[923]: Requesting JSON for token 30.1080machine # [ 24.885581] cat[923]: Requesting JSON for token 31.1081machine # [ 24.886329] cat[923]: PCR policy hash not yet enrolled, enrolling now.1082machine # [ 24.887208] cat[923]: Unsealing for verification...1083machine # [ 24.887881] cat[923]: Loading HMAC key into TPM for shard 0.1084machine # [ 24.888888] cat[923]: Loading object into TPM.1085machine # [ 24.889508] cat[923]: Starting HMAC encryption session.1086machine # [ 24.896104] cat[923]: Starting policy session.1087machine # [ 24.919866] cat[923]: Building sealing policy.1088machine # [ 24.920812] cat[923]: Acquiring policy digest.1089machine # [ 24.944055] cat[923]: Session policy digest: 00000000000000000000000000000000000000000000000000000000000000001090machine # [ 24.945423] cat[923]: Unsealing HMAC key for shard 0.1091machine # [ 25.016057] cat[923]: Completed TPM2 key unsealing in 158.812ms.1092machine # [ 25.017150] cat[923]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000).1093machine # [ 25.018228] cat[923]: Adding new keyslot -1 by passphrase, volume key provided by key (-1).1094machine # [ 25.019530] cat[923]: Selected keyslot 1.1095machine # [ 25.082222] cat[923]: Keyslot 1 assigned to digest 0.1096machine # [ 25.083009] cat[923]: Trying to allocate LUKS2 keyslot 1.1097machine # [ 25.083846] cat[923]: Found area 290816 -> 5488641098machine # [ 25.084656] cat[923]: Reusing PBKDF values (no benchmark flag is set).1099machine # [ 25.085641] cat[923]: Calculating attributes for LUKS2 keyslot 1.1100machine # [ 25.086786] cat[923]: Acquiring write lock for device /dev/vdb.1101machine # [ 25.092066] cat[923]: Opening lock resource file /run/cryptsetup/L_254:161102machine # [ 25.092973] cat[923]: Verifying lock handle for /dev/vdb.1103machine # [ 25.093689] cat[923]: Device /dev/vdb WRITE lock taken.1104machine # [ 25.094383] cat[923]: Checking context sequence id matches value stored on disk.1105machine # [ 25.095328] cat[923]: Reusing open ro fd on device /dev/vdb1106machine # [ 25.096121] cat[923]: Running keyslot key derivation.1107machine # [ 25.098405] cat[923]: Updating keyslot area [0x47000].1108machine # [ 25.099569] cat[923]: Opening locked device /dev/vdb1109machine # [ 25.100807] cat[923]: Verifying locked device handle (bdev)1110machine # [ 25.101702] cat[923]: Device size 536870912, offset 16777216.1111machine # [ 25.102660] cat[923]: Device /dev/vdb WRITE lock already held.1112machine # [ 25.103455] cat[923]: Trying to write LUKS2 header (1039 bytes) at offset 0.1113machine # [ 25.104521] cat[923]: Reusing open rw fd on device /dev/vdb1114machine # [ 25.105423] cat[923]: Checksum:a749f209261dfd741a77d022ee4e3f85edd838b8c55e3368995a82b138368c22 (in-memory)1115machine # [ 25.106870] cat[923]: Trying to write LUKS2 header (1039 bytes) at offset 16384.1116machine # [ 25.107950] cat[923]: Reusing open rw fd on device /dev/vdb1117machine # [ 25.109203] cat[923]: Checksum:a315ae92caec3944944246fb2bc202d7ead1d369b7873a325805629b977f025c (in-memory)1118machine # [ 25.111356] cat[923]: Device /dev/vdb WRITE lock released.1119machine # [ 25.112396] cat[923]: Unknown hash algorithm id 0x01120machine # [ 25.113148] cat[923]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AIKC9mxgdmU++fPEnIz0Bb9ZYnmR7mMvk0zmX1gjADJXsABAEs5tJBosS6/jQQhjJ9xxZDj/y6R+NTmeTWv8+uK9fIC0DM5Cb22zYgrPASH/4ejMdQK6+xTS85rEKn9qLEUxTxtvfUNmA8rHIwk2jP8ilWXWtmyEKvK3Jy5Fhor4v8VLEnoWT6h0ibMyRYrGt10kMipoF6S/ZZSdxVQBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAIMxrgMJNs9PLubhku40uIr0lfSmH80T99KLQ2g03PhR6","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAs0341j4A4wsnT/xIoLcstPOi1L9eSXYnZ715c8eq0+eQAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAIAb1GgYrkqTsNBVFXvhwsKVGd+ngaNf5wvw7CAhvqguaACC5bWReiL/2q9qD0YpYn5m0VLdOD+EO2+gCepb9ZFv2eA=="}>1121machine # [ 25.136140] cat[923]: Updating JSON for token -1.1122machine # [ 25.136857] cat[923]: Trying to load libcryptsetup-token-systemd-tpm2.so.1123machine # [ 25.137828] cat[923]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0.1124machine # [ 25.138787] cat[923]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0.1125machine # [ 25.139817] cat[923]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0.1126machine # [ 25.145720] cat[923]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0.1127machine # [ 25.147481] [923]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0.1128machine # [ 25.152462] [923]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0.1129machine # [ 25.156336] [923]: Token handler systemd-tpm2-1.0 systemd-v262~rc1 (262-d2a5296) loaded successfully.1130machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 0.96 seconds)1131machine # [ 25.157458] [923]: Device size 536870912, offset 16777216.1132machine: must succeed: /nix/store/d26y3yw9dqhzaq82y7imfda5lr92rv98-nixos-system-machine-test/bin/switch-to-configuration boot1133machine # [ 25.158156] [923]: Acquiring write lock for device /dev/vdb.1134machine # [ 25.158859] [923]: Opening lock resource file /run/cryptsetup/L_254:161135machine # [ 25.159646] [923]: Verifying lock handle for /dev/vdb.1136machine # [ 25.164148] [923]: Device /dev/vdb WRITE lock taken.1137machine # [ 25.164806] [923]: Checking context sequence id matches value stored on disk.1138machine # [ 25.165687] [923]: Reusing open ro fd on device /dev/vdb1139machine # [ 25.169309] [923]: Trying to write LUKS2 header (1742 bytes) at offset 0.1140machine # [ 25.172704] [923]: Reusing open rw fd on device /dev/vdb1141machine # [ 25.173649] [923]: Checksum:699cc1d440bb3fe7945690a91d12d8d27cc4cf177c45ca0252f1b83344955986 (in-memory)1142machine # [ 25.175063] [923]: Trying to write LUKS2 header (1742 bytes) at offset 16384.1143machine # [ 25.176441] [923]: Reusing open rw fd on device /dev/vdb1144machine # [ 25.177451] [923]: Checksum:4de0c6841e8283f1eee97500591222e5fa138ac26329473854d31c6c0afbeed2 (in-memory)1145machine # [ 25.178745] [923]: Device /dev/vdb WRITE lock released.1146machine # [ 25.180468] [923]: New TPM2 token enrolled as key slot 1.1147machine # [ 25.181315] [923]: Releasing crypt device /dev/vdb context.1148machine # [ 25.182165] [923]: Releasing device-mapper backend.1149machine # [ 25.183152] [923]: Closing read only fd for /dev/vdb.1150machine # [ 25.183950] [923]: Closing read write fd for /dev/vdb.1151machine # [ 25.185140] [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/d26y3yw9dqhzaq82y7imfda5lr92rv98-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.93 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.17 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.48 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Aug 28 06:22:54 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\26nkjxvzn97myq3rxi657sn9j9ag6f06-initrd-linux-6.18.48-initrd.efi init=/nix/store/d26y3yw9dqhzaq82y7imfda5lr92rv98-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.000033] arm-pv: using stolen time PV1295machine # [ 0.000388] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1296machine # [ 0.000482] Console: colour dummy device 80x251297machine # [ 0.000486] printk: legacy console [tty0] enabled1298machine # [ 0.000717] ACPI: Core revision 202508071299machine # [ 0.000810] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1300machine # [ 0.000817] pid_max: default: 32768 minimum: 3011301machine # [ 0.000873] LSM: initializing lsm=capability,landlock,yama,bpf,ima1302machine # [ 0.000995] landlock: Up and running.1303machine # [ 0.000998] Yama: becoming mindful.1304machine # [ 0.001431] LSM support for eBPF active1305machine # [ 0.001512] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1306machine # [ 0.001520] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1307machine # [ 0.002588] rcu: Hierarchical SRCU implementation.1308machine # [ 0.002593] rcu: Max phase no-delay instances is 1000.1309machine # [ 0.003252] fsl-mc MSI: ITS@0x8080000 domain created1310machine # [ 0.003272] Remapping and enabling EFI services.1311machine # [ 0.003380] smp: Bringing up secondary CPUs ...1312machine # [ 0.003389] smp: Brought up 1 node, 1 CPU1313machine # [ 0.003392] SMP: Total of 1 processors activated.1314machine # [ 0.003394] CPU: All CPU(s) started at EL11315machine # [ 0.003404] CPU features: detected: Branch Target Identification1316machine # [ 0.003409] CPU features: detected: ARMv8.4 Translation Table Level1317machine # [ 0.003412] CPU features: detected: Instruction cache invalidation not required for I/D coherence1318machine # [ 0.003416] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1319machine # [ 0.003419] CPU features: detected: Common not Private translations1320machine # [ 0.003423] CPU features: detected: CRC32 instructions1321machine # [ 0.003425] CPU features: detected: Data cache clean to Point of Deep Persistence1322machine # [ 0.003428] CPU features: detected: Data cache clean to Point of Persistence1323machine # [ 0.003432] CPU features: detected: Data independent timing control (DIT)1324machine # [ 0.003435] CPU features: detected: E0PD1325machine # [ 0.003437] CPU features: detected: Enhanced Counter Virtualization1326machine # [ 0.003440] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1327machine # [ 0.003444] CPU features: detected: Enhanced Virtualization Traps1328machine # [ 0.003447] CPU features: detected: Fine Grained Traps1329machine # [ 0.003450] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1330machine # [ 0.003454] CPU features: detected: RCpc load-acquire (LDAPR)1331machine # [ 0.003457] CPU features: detected: LSE atomic instructions1332machine # [ 0.003460] CPU features: detected: Privileged Access Never1333machine # [ 0.003463] CPU features: detected: PMUv31334machine # [ 0.003465] CPU features: detected: RAS Extension Support1335machine # [ 0.003468] CPU features: detected: RASv1p1 Extension Support1336machine # [ 0.003471] CPU features: detected: Random Number Generator1337machine # [ 0.003473] CPU features: detected: Speculation barrier (SB)1338machine # [ 0.003476] CPU features: detected: Stage-2 Force Write-Back1339machine # [ 0.003479] CPU features: detected: TLB range maintenance instructions1340machine # [ 0.003484] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1341machine # [ 0.003523] alternatives: applying system-wide alternatives1342machine # [ 0.006284] CPU features: detected: BBM Level 2 without TLB conflict abort1343machine # [ 0.006400] Memory: 887000K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120052K reserved, 32768K cma-reserved)1344machine # [ 0.006664] devtmpfs: initialized1345machine # [ 0.007529] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1346machine # [ 0.007538] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1347machine # [ 0.007710] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1348machine # [ 0.007714] 0 pages in range for non-PLT usage1349machine # [ 0.007716] 508288 pages in range for PLT usage1350machine # [ 0.007793] pinctrl core: initialized pinctrl subsystem1351machine # [ 0.008316] SMBIOS 3.0.0 present.1352machine # [ 0.008322] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/20221353machine # [ 0.008330] DMI: Memory slots populated: 1/11354machine # [ 0.009599] NET: Registered PF_NETLINK/PF_ROUTE protocol family1355machine # [ 0.010216] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1356machine # [ 0.010381] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1357machine # [ 0.010543] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1358machine # [ 0.010562] audit: initializing netlink subsys (disabled)1359machine # [ 0.010965] thermal_sys: Registered thermal governor 'fair_share'1360machine # [ 0.010967] thermal_sys: Registered thermal governor 'bang_bang'1361machine # [ 0.010971] thermal_sys: Registered thermal governor 'step_wise'1362machine # [ 0.010973] thermal_sys: Registered thermal governor 'user_space'1363machine # [ 0.010976] thermal_sys: Registered thermal governor 'power_allocator'1364machine # [ 0.011002] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=11365machine # [ 0.011013] cpuidle: using governor ladder1366machine # [ 0.011021] cpuidle: using governor menu1367machine # [ 0.011174] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1368machine # [ 0.011193] ASID allocator initialised with 65536 entries1369machine # [ 0.011924] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51370machine # [ 0.012116] Serial: AMBA PL011 UART driver1371machine # [ 0.018535] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1372machine # [ 0.018540] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1373machine # [ 0.018544] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1374machine # [ 0.018546] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1375machine # [ 0.018549] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1376machine # [ 0.018552] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1377machine # [ 0.018555] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1378machine # [ 0.018557] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1379machine # [ 0.019325] fbcon: Taking over console1380machine # [ 0.019364] ACPI: Added _OSI(Module Device)1381machine # [ 0.019368] ACPI: Added _OSI(Processor Device)1382machine # [ 0.019371] ACPI: Added _OSI(Processor Aggregator Device)1383machine # [ 0.020395] ACPI: 1 ACPI AML tables successfully acquired and loaded1384machine # [ 0.026426] ACPI: Interpreter enabled1385machine # [ 0.026430] ACPI: Using GIC for interrupt routing1386machine # [ 0.026450] ACPI: MCFG table detected, 1 entries1387machine # [ 0.030280] ACPI: CPU0 has been hot-added1388machine # [ 0.030688] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA1389machine # [ 0.030758] printk: console [ttyAMA0] enabled1390machine # [ 0.098221] ACPI: PCI: Interrupt link L000 configured for IRQ 351391machine # [ 0.098237] ACPI: PCI: Interrupt link L001 configured for IRQ 361392machine # [ 0.098249] ACPI: PCI: Interrupt link L002 configured for IRQ 371393machine # [ 0.098260] ACPI: PCI: Interrupt link L003 configured for IRQ 381394machine # [ 0.098277] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1395machine # [ 0.098316] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1396machine # [ 0.098413] acpi PNP0A08:00: _OSC: platform does not support [LTR]1397machine # [ 0.098508] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]1398machine # [ 0.098747] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:001399machine # [ 0.098766] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1400machine # [ 0.098788] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]1401machine # [ 0.099117] PCI host bridge to bus 0000:001402machine # [ 0.099164] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]1403machine # [ 0.099170] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]1404machine # [ 0.099173] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]1405machine # [ 0.099178] pci_bus 0000:00: root bus resource [bus 00-ff]1406machine # [ 0.099181] PCI: OF: of_root node is NULL, cannot create PCI host bridge node1407machine # [ 0.099237] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1408machine # [ 0.099703] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1409machine # [ 0.099880] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]1410machine # [ 0.099891] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]1411machine # [ 0.099916] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]1412machine # [ 0.099927] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]1413machine # [ 0.100397] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1414machine # [ 0.102323] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]1415machine # [ 0.102337] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]1416machine # [ 0.102362] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]1417machine # [ 0.102865] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1418machine # [ 0.103053] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]1419machine # [ 0.103064] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]1420machine # [ 0.103089] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]1421machine # [ 0.209595] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1422machine # [ 0.209789] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]1423machine # [ 0.209806] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]1424machine # [ 0.209836] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]1425machine # [ 0.210321] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1426machine # [ 0.210499] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]1427machine # [ 0.210515] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]1428machine # [ 0.210544] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]1429machine # [ 0.211026] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1430machine # [ 0.219831] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]1431machine # [ 0.219857] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]1432machine # [ 0.219887] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]1433machine # [ 0.220389] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1434machine # [ 0.220569] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]1435machine # [ 0.220585] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]1436machine # [ 0.220615] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]1437machine # [ 0.226310] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1438machine # [ 0.226495] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]1439machine # [ 0.226511] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]1440machine # [ 0.226541] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]1441machine # [ 0.226558] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]1442machine # [ 0.227035] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1443machine # [ 0.228228] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]1444machine # [ 0.228264] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]1445machine # [ 0.228779] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1446machine # [ 0.228965] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]1447machine # [ 0.228995] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]1448machine # [ 0.238518] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1449machine # [ 0.239746] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]1450machine # [ 0.240127] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1451machine # [ 0.240862] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]1452machine # [ 0.240882] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]1453machine # [ 0.240913] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]1454machine # [ 0.241403] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1455machine # [ 0.242106] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]1456machine # [ 0.242125] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]1457machine # [ 0.242155] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]1458machine # [ 0.250366] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1459machine # [ 0.250383] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1460machine # [ 0.250391] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1461machine # [ 0.250438] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1462machine # [ 0.250485] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1463machine # [ 0.250532] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1464machine # [ 0.250578] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1465machine # [ 0.250625] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1466machine # [ 0.250671] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1467machine # [ 0.250718] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1468machine # [ 0.260274] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1469machine # [ 0.261343] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1470machine # [ 0.261398] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1471machine # [ 0.261445] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1472machine # [ 0.261490] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1473machine # [ 0.261512] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1474machine # [ 0.261533] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1475machine # [ 0.261555] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1476machine # [ 0.261577] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1477machine # [ 0.261599] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1478machine # [ 0.261622] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1479machine # [ 0.261644] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1480machine # [ 0.261666] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1481machine # [ 0.262162] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1482machine # [ 0.262188] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned1483machine # [ 0.262674] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1484machine # [ 0.262701] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1485machine # [ 0.262723] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1486machine # [ 0.263219] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned1487machine # [ 0.263244] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned1488machine # [ 0.263266] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned1489machine # [ 0.263937] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned1490machine # [ 0.263962] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned1491machine # [ 0.283924] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned1492machine # [ 0.283955] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned1493machine # [ 0.283979] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned1494machine # [ 0.284002] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned1495machine # [ 0.284568] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]1496machine # [ 0.284582] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]1497machine # [ 0.284589] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]1498machine # [ 0.292896] iommu: Default domain type: Translated1499machine # [ 0.292910] iommu: DMA domain TLB invalidation policy: strict mode1500machine # [ 0.294386] SCSI subsystem initialized1501machine # [ 0.295039] ACPI: bus type USB registered1502machine # [ 0.295081] usbcore: registered new interface driver usbfs1503machine # [ 0.295102] usbcore: registered new interface driver hub1504machine # [ 0.295118] usbcore: registered new device driver usb1505machine # [ 0.295327] pps_core: LinuxPPS API ver. 1 registered1506machine # [ 0.295334] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1507machine # [ 0.295345] PTP clock support registered1508machine # [ 0.295381] EDAC MC: Ver: 3.0.01509machine # [ 0.300501] scmi_core: SCMI protocol bus registered1510machine # [ 0.301225] efivars: Registered efivars operations1511machine # [ 0.302186] FPGA manager framework1512machine # [ 0.303039] vgaarb: loaded1513machine # [ 0.303651] clocksource: Switched to clocksource arch_sys_counter1514machine # [ 0.303965] VFS: Disk quotas dquot_6.6.01515machine # [ 0.303993] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1516machine # [ 0.307516] netfs: FS-Cache loaded1517machine # [ 0.307628] pnp: PnP ACPI init1518machine # [ 0.308646] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved1519machine # [ 0.308701] pnp: PnP ACPI: found 1 devices1520machine # [ 0.313027] NET: Registered PF_INET protocol family1521machine # [ 0.313090] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1522machine # [ 0.332944] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1523machine # [ 0.332989] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1524machine # [ 0.333014] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1525machine # [ 0.333062] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1526machine # [ 0.333138] TCP: Hash tables configured (established 8192 bind 8192)1527machine # [ 0.333217] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1528machine # [ 0.333248] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1529machine # [ 0.333273] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1530machine # [ 0.333353] NET: Registered PF_UNIX/PF_LOCAL protocol family1531machine # [ 0.333380] NET: Registered PF_XDP protocol family1532machine # [ 0.334103] PCI: CLS 0 bytes, default 641533machine # [ 0.334345] Trying to unpack rootfs image as initramfs...1534machine # [ 0.348860] kvm [1]: HYP mode not available1535machine # [ 0.443770] Initialise system trusted keyrings1536machine # [ 0.444514] workingset: timestamp_bits=42 max_order=18 bucket_order=01537machine # [ 0.445717] squashfs: version 4.0 (2009/01/31) Phillip Lougher1538machine # [ 0.446465] 9p: Installing v9fs 9p2000 file system support1539machine # [ 0.470485] Key type asymmetric registered1540machine # [ 0.470513] Asymmetric key parser 'x509' registered1541machine # [ 0.470586] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1542machine # [ 0.475714] io scheduler mq-deadline registered1543machine # [ 0.475732] io scheduler kyber registered1544machine # [ 0.483680] ledtrig-cpu: registered to indicate activity on CPUs1545machine # [ 0.485617] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input01546machine # [ 0.485675] ACPI: button: Power Button [PWRB]1547machine # [ 0.510085] ACPI: \_SB_.L001: Enabled at IRQ 361548machine # [ 0.510138] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1549machine # [ 0.520521] ACPI: \_SB_.L002: Enabled at IRQ 371550machine # [ 0.520565] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)1551machine # [ 0.522904] ACPI: \_SB_.L003: Enabled at IRQ 381552machine # [ 0.522940] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1553machine # [ 0.528153] ACPI: \_SB_.L000: Enabled at IRQ 351554machine # [ 0.528188] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1555machine # [ 0.530307] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1556machine # [ 0.540324] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)1557machine # [ 0.541971] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1558machine # [ 0.551988] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)1559machine # [ 0.556834] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1560machine # [ 0.558814] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)1561machine # [ 0.568619] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)1562machine # [ 0.584255] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1563machine # [ 0.585847] msm_serial: driver initialized1564machine # [ 0.585980] SuperH (H)SCI(F) driver initialized1565machine # [ 0.586018] STM32 USART driver initialized1566machine # [ 0.605121] ACPI: bus type drm_connector registered1567machine # [ 0.613158] loop: module loaded1568machine # [ 0.613342] virtio_blk virtio5: 1/0/0 default/read/poll queues1569machine # [ 0.613921] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)1570machine # [ 0.655709] vda: vda1 vda21571machine # [ 0.656119] virtio_blk virtio6: 1/0/0 default/read/poll queues1572machine # [ 0.656863] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1573machine # [ 0.664315] megasas: 07.734.00.00-rc11574machine # [ 0.666590] tun: Universal TUN/TAP device driver, 1.61575machine # [ 0.670525] thunder_xcv, ver 1.01576machine # [ 0.670579] thunder_bgx, ver 1.01577machine # [ 0.670602] nicpf, ver 1.01578machine # [ 0.671141] e1000: Intel(R) PRO/1000 Network Driver1579machine # [ 0.671148] e1000: Copyright (c) 1999-2006 Intel Corporation.1580machine # [ 0.671176] e1000e: Intel(R) PRO/1000 Network Driver1581machine # [ 0.671183] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1582machine # [ 0.671216] igb: Intel(R) Gigabit Ethernet Network Driver1583machine # [ 0.671223] igb: Copyright (c) 2007-2014 Intel Corporation.1584machine # [ 0.671247] igbvf: Intel(R) Gigabit Virtual Function Network Driver1585machine # [ 0.671254] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1586machine # [ 0.671380] sky2: driver version 1.301587machine # [ 0.680569] ehci-pci 0000:00:0b.0: EHCI Host Controller1588machine # [ 0.680602] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 11589machine # [ 0.680834] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a0001590machine # [ 0.683159] usbcore: registered new interface driver usb-storage1591machine # [ 0.683219] usbcore: registered new interface driver usbserial_generic1592machine # [ 0.683235] usbserial: USB Serial support registered for generic1593machine # [ 0.685980] hv_vmbus: registering driver hyperv_keyboard1594machine # [ 0.687294] rtc-efi rtc-efi.0: registered as rtc01595machine # [ 0.687915] rtc-efi rtc-efi.0: setting system clock to 2026-09-02T02:39:42 UTC (1788316782)1596machine # [ 0.688241] i2c_dev: i2c /dev entries driver1597machine # [ 0.692190] sdhci: Secure Digital Host Controller Interface driver1598machine # [ 0.692203] sdhci: Copyright(c) Pierre Ossman1599machine # [ 0.692430] Synopsys Designware Multimedia Card Interface Driver1600machine # [ 0.692769] sdhci-pltfm: SDHCI platform and OF driver helper1601machine # [ 0.693800] pstore: Using crash dump compression: deflate1602machine # [ 0.693810] pstore: Registered efi_pstore as persistent store backend1603machine # [ 0.697928] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.001604machine # [ 0.698929] hub 1-0:1.0: USB hub found1605machine # [ 0.699404] hub 1-0:1.0: 6 ports detected1606machine # [ 0.704559] hid: raw HID events driver (C) Jiri Kosina1607machine # [ 0.704849] usbcore: registered new interface driver usbhid1608machine # [ 0.704857] usbhid: USB HID core driver1609machine # [ 0.711798] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available1610machine # [ 0.713228] drop_monitor: Initializing network drop monitor service1611machine # [ 0.713395] NET: Registered PF_INET6 protocol family1612machine # [ 0.716447] Segment Routing with IPv61613machine # [ 0.716469] In-situ OAM (IOAM) with IPv61614machine # [ 0.716509] NET: Registered PF_PACKET protocol family1615machine # [ 0.718107] 9pnet: Installing 9P2000 support1616machine # [ 0.724711] Key type dns_resolver registered1617machine # [ 0.740187] registered taskstats version 11618machine # [ 0.740374] Loading compiled-in X.509 certificates1619machine # [ 0.763726] Demotion targets for Node 0: null1620machine # [ 0.764555] Key type .fscrypt registered1621machine # [ 0.764569] Key type fscrypt-provisioning registered1622machine # [ 0.764681] ima: No TPM chip found, activating TPM-bypass!1623machine # [ 0.764703] ima: Allocated hash algorithm: sha11624machine # [ 0.764726] ima: No architecture policies found1625machine # [ 0.797684] clk: Disabling unused clocks1626machine # [ 0.797717] PM: genpd: Disabling unused power domains1627machine # [ 0.923435] Freeing initrd memory: 26056K1628machine # [ 0.926911] Freeing unused kernel memory: 4736K1629machine # [ 0.927131] Run /init as init process1630machine # [ 0.944360] fuse: init (API version 7.45)1631machine # [ 0.947764] usb 1-1: new high-speed USB device number 2 using ehci-pci1632machine # [ 0.955383] systemd[1]: Successfully made /usr/ read-only.1633machine # [ 1.100016] 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.172105] 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.290471] systemd[1]: systemd 262-d2a5296 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.302169] usb 1-2: new high-speed USB device number 3 using ehci-pci1637machine # [ 1.305151] systemd[1]: Detected virtualization kvm.1638machine # [ 1.307083] systemd[1]: Detected architecture arm64.1639machine # [ 1.309092] systemd[1]: Running in initrd.1640machine # [ 1.311646] systemd[1]: Initializing machine ID from random generator.1641machine # [ 1.315018] systemd[1]: Hostname set to <machine>.1642machine # [ 1.454168] systemd[1]: bpf-restrict-fs: LSM BPF program attached1643machine # [ 1.461640] 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.463237] 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.518332] systemd[1]: Queued start job for default target Initrd Default Target.1646machine # [ 1.525465] systemd[1]: Created slice Slice /system/modprobe.1647machine # [ 1.526819] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1648machine # [ 1.527781] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1649machine # [ 1.528749] systemd[1]: Expecting device /dev/mapper/cryptroot...1650machine # [ 1.529503] systemd[1]: Expecting device /dev/tpm0...1651machine # [ 1.530132] systemd[1]: Expecting device /dev/tpmrm0...1652machine # [ 1.530775] systemd[1]: Expecting device /dev/vdb...1653machine # [ 1.531408] systemd[1]: Reached target Path Units.1654machine # [ 1.532061] systemd[1]: Reached target Slice Units.1655machine # [ 1.532684] systemd[1]: Reached target Swaps.1656machine # [ 1.533235] systemd[1]: Reached target Timer Units.1657machine # [ 1.533994] systemd[1]: Listening on D-Bus System Message Bus Socket.1658machine # [ 1.534918] systemd[1]: Listening on Journal Socket (/dev/log).1659machine # [ 1.535854] systemd[1]: Listening on Journal Sockets.1660machine # [ 1.536551] systemd[1]: Listening on udev Kernel Socket.1661machine # [ 1.537211] systemd[1]: Reached target Socket Units.1662machine # [ 1.539003] systemd[1]: Starting Create List of Static Device Nodes...1663machine # [ 1.551807] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1664machine # [ 1.551879] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1665machine # [ 1.555121] systemd[1]: Mounting Kernel Configuration File System...1666machine # [ 1.573825] systemd[1]: Starting Journal Service...1667machine # [ 1.582913] systemd[1]: Starting Load Kernel Modules...1668machine # [ 1.588877] systemd[1]: Starting Coldplug All udev Devices...1669machine # [ 1.599872] systemd[1]: Finished Create List of Static Device Nodes.1670machine # [ 1.601031] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1671machine # [ 1.601299] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1672machine # [ 1.601522] systemd[1]: Mounted Kernel Configuration File System.1673machine # [ 1.623190] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1674machine # [ 1.635852] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1675machine # [ 1.639835] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1676machine # [ 1.644130] [drm] pci: virtio-gpu-pci detected at 0000:00:09.01677machine # [ 1.644353] [drm] features: -virgl +edid -resource_blob -host_visible1678machine # [ 1.644361] [drm] features: -context_init1679machine # [ 1.645055] [drm] number of scanouts: 11680machine # [ 1.645073] [drm] number of cap sets: 01681machine # [ 1.655095] systemd-journald[74]: Collecting audit messages is disabled.1682machine # [ 1.664255] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1683machine # [ 1.665644] systemd[1]: Starting Create Static Device Nodes in /dev...1684machine # [ 1.669696] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic1685machine # [ 1.669717] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 01686machine # [ 1.688199] Console: switching to colour frame buffer device 160x501687machine # [ 1.694670] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device1688machine # [ 1.716225] systemd[1]: Finished Create Static Device Nodes in /dev.1689machine # [ 1.716421] systemd[1]: Reached target Preparation for Local File Systems.1690machine # [ 1.716457] systemd[1]: Reached target Local File Systems.1691machine # [ 1.724666] systemd[1]: Starting Rule-based Manager for Device Events and Files...1692machine # [ 1.727941] systemd[1]: Finished Load Kernel Modules.1693machine # [ 1.763905] systemd[1]: Starting Apply Kernel Variables...1694machine # [ 1.784211] systemd[1]: Finished Apply Kernel Variables.1695machine # [ 1.814199] systemd[1]: Started Journal Service.1696machine # [ 1.800261] systemd-modules-load[75]: Inserted module 'dm_mod'1697machine # [ 1.801277] systemd-modules-load[75]: Module 'virtio_balloon' is built in1698machine # [ 1.802342] systemd-modules-load[75]: Module 'virtio_console' is built in1699machine # [ 1.803420] systemd-modules-load[75]: Inserted module 'virtio_gpu'1700machine # [ 1.816606] systemd-modules-load[75]: Module 'virtio_rng' is built in1701machine # [ 1.817907] systemd-udevd[80]: Using default interface naming scheme 'v261'.1702machine # [ 1.819011] systemd[1]: Starting Create System Files and Directories...1703machine # [ 1.834605] systemd[1]: Finished Create System Files and Directories.1704machine # [ 1.857601] systemd[1]: Started Rule-based Manager for Device Events and Files.1705machine # [ 1.916141] systemd[1]: Starting Virtual Console Setup...1706machine # [ 1.964482] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.1707machine # [ 1.967733] systemd[1]: Finished Virtual Console Setup.1708machine # [ 2.644498] systemd[1]: Finished Coldplug All udev Devices.1709machine # [ 2.782553] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.1710machine # [ 2.812108] systemd[1]: Found device /dev/vdb.1711machine # [ 2.813837] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1712machine # [ 2.820217] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.1713machine # [ 3.817839] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)1714machine # [ 3.937564] systemd[1]: Found device /dev/tpm0.1715machine # [ 3.939681] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1716machine # [ 3.942599] systemd[1]: Stopped Virtual Console Setup.1717machine # [ 3.945705] systemd[1]: Stopping Virtual Console Setup...1718machine # [ 3.947659] systemd[1]: Starting Virtual Console Setup...1719machine # [ 3.965802] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1720machine # [ 3.968802] systemd[1]: Stopped Virtual Console Setup.1721machine # [ 3.970619] systemd[1]: Found device /dev/tpmrm0.1722machine # [ 3.972166] systemd[1]: Reached target Trusted Platform Module.1723machine # [ 3.976257] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1724machine # [ 3.977589] systemd[1]: Starting Cryptography Setup for cryptroot...1725machine # [ 3.979166] systemd[1]: Starting Virtual Console Setup...1726machine # [ 4.020083] systemd-vconsole-setup[116]: Configuration of first virtual console was skipped, ignoring remaining ones.1727machine # [ 4.025043] systemd[1]: Finished Virtual Console Setup.1728machine # [ 4.373334] Key type trusted registered1729machine # [ 4.376918] Key type encrypted registered1730machine # [ 4.385848] systemd[1]: Finished Cryptography Setup for cryptroot.1731machine # [ 4.389921] systemd[1]: Found device /dev/mapper/cryptroot.1732machine # [ 4.390876] systemd[1]: Reached target Local Encrypted Volumes.1733machine # [ 4.393154] systemd[1]: Reached target Initrd Root Device.1734machine # [ 4.394571] systemd[1]: Reached target System Initialization.1735machine # [ 4.399467] systemd[1]: Reached target Basic System.1736machine # [ 4.400335] systemd[1]: Starting File System Check on /dev/mapper/cryptroot...1737machine # [ 4.426429] systemd-fsck[130]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks1738machine # [ 4.433089] systemd[1]: Finished File System Check on /dev/mapper/cryptroot.1739machine # [ 4.436365] systemd[1]: Mounting /sysroot...1740machine # [ 4.533877] EXT4-fs (dm-0): mounted filesystem 3d0f91bd-1132-45e1-99f6-e38cbbc5f921 r/w with ordered data mode. Quota mode: none.1741machine # [ 4.510721] systemd[1]: Mounted /sysroot.1742machine # [ 4.512359] systemd[1]: Reached target Initrd Root File System.1743machine # [ 4.514586] systemd[1]: Starting Mountpoints Configured in the Real Root...1744machine # [ 4.531967] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.1745machine # [ 4.535285] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...1746machine # [ 4.539086] systemd[1]: Reloading...1747machine # [ 4.661769] systemd[1]: Reloading finished in 124 ms.1748machine # [ 4.686267] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...1749machine # [ 4.688799] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...1750machine # [ 4.692725] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1751machine # [ 4.694525] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1752machine # [ 4.699541] systemd[1]: Finished Mountpoints Configured in the Real Root.1753machine # [ 4.700814] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1754machine # [ 4.712126] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1755machine # [ 4.713815] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1756machine # [ 4.998426] systemd[1]: Mounting /sysroot/nix/.ro-store...1757machine # [ 5.012472] systemd[1]: Mounting /sysroot/nix/.rw-store...1758machine # [ 5.031831] systemd[1]: Mounting /sysroot/run...1759machine # [ 5.060372] systemd[1]: Mounting /sysroot/tmp/shared...1760machine # [ 5.076494] systemd[1]: Mounting /sysroot/tmp/xchg...1761machine # [ 5.095026] systemd[1]: Mounted /sysroot/nix/.rw-store.1762machine # [ 5.107730] systemd[1]: Mounted /sysroot/nix/.ro-store.1763machine # [ 5.128357] systemd[1]: Starting rw-sysroot-nix-store.service...1764machine # [ 5.132265] systemd[1]: Mounted /sysroot/run.1765machine # [ 5.139178] systemd[1]: Mounted /sysroot/tmp/shared.1766machine # [ 5.145282] systemd[1]: Mounted /sysroot/tmp/xchg.1767machine # [ 5.153080] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1768machine # [ 5.154526] systemd[1]: Finished rw-sysroot-nix-store.service.1769machine # [ 5.997304] systemd[1]: Mounting /sysroot/nix/store...1770machine # [ 6.059663] systemd[1]: Mounted /sysroot/nix/store.1771machine # [ 6.062886] systemd[1]: Reached target Initrd File Systems.1772machine # [ 6.068349] systemd[1]: Starting Find NixOS closure...1773machine # [ 6.080427] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1774machine # [ 6.126898] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1775machine # [ 6.130289] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1776machine # [ 6.143014] systemd[1]: Finished Find NixOS closure.1777machine # [ 6.144165] systemd[1]: Reached target Initrd Default Target.1778machine # [ 6.148522] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1779machine # [ 6.182339] systemd[1]: initrd-cleanup.service: Deactivated successfully.1780machine # [ 6.187134] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1781machine # [ 6.188574] systemd[1]: Stopped target Initrd Default Target.1782machine # [ 6.190079] systemd[1]: Stopped target Basic System.1783machine # [ 6.192190] systemd[1]: Stopped target Initrd Root Device.1784machine # [ 6.194911] systemd[1]: Stopped target Path Units.1785machine # [ 6.197382] systemd[1]: Stopped target Slice Units.1786machine # [ 6.198307] systemd[1]: Stopped target Socket Units.1787machine # [ 6.200199] systemd[1]: Stopped target System Initialization.1788machine # [ 6.204200] systemd[1]: Stopped target Local Encrypted Volumes.1789machine # [ 6.205259] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1790machine # [ 6.208146] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1791machine # [ 6.212429] systemd[1]: Stopped target Swaps.1792machine # [ 6.216911] systemd[1]: Stopped target Timer Units.1793machine # [ 6.218824] systemd[1]: Stopped target Trusted Platform Module.1794machine # [ 6.221159] systemd[1]: dbus.socket: Deactivated successfully.1795machine # [ 6.223454] systemd[1]: Closed D-Bus System Message Bus Socket.1796machine # [ 6.231855] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1797machine # [ 6.234935] systemd[1]: Stopped Find NixOS closure.1798machine # [ 6.238204] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1799machine # [ 6.242708] systemd[1]: Starting rw-sysroot-nix-store.service...1800machine # [ 6.247791] systemd[1]: systemd-sysctl.service: Deactivated successfully.1801machine # [ 6.249147] systemd[1]: Stopped Apply Kernel Variables.1802machine # [ 6.249879] systemd[1]: systemd-modules-load.service: Deactivated successfully.1803machine # [ 6.250837] systemd[1]: Stopped Load Kernel Modules.1804machine # [ 6.251523] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1805machine # [ 6.255081] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1806machine # [ 6.257117] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1807machine # [ 6.258140] systemd[1]: Stopped Create System Files and Directories.1808machine # [ 6.259003] systemd[1]: Stopped target Local File Systems.1809machine # [ 6.259761] systemd[1]: Stopped target Preparation for Local File Systems.1810machine # [ 6.260772] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1811machine # [ 6.261758] systemd[1]: Stopped Coldplug All udev Devices.1812machine # [ 6.262524] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1813machine # [ 6.263535] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1814machine # [ 6.268313] systemd[1]: Stopped Virtual Console Setup.1815machine # [ 6.269335] systemd[1]: systemd-udevd.service: Deactivated successfully.1816machine # [ 6.272290] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1817machine # [ 6.276178] systemd[1]: systemd-udevd.service: Consumed 1.533s CPU time over 4.539s wall clock time, 23.9M memory peak.1818machine # [ 6.277626] systemd[1]: Starting Cleanup udev Database...1819machine # [ 6.278383] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1820machine # [ 6.284194] systemd[1]: Stopped Create Static Device Nodes in /dev.1821machine # [ 6.285089] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1822machine # [ 6.286194] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1823machine # [ 6.287153] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1824machine # [ 6.292419] systemd[1]: Stopped Create List of Static Device Nodes.1825machine # [ 6.293288] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1826machine # [ 6.294260] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1827machine # [ 6.295083] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1828machine # [ 6.300080] systemd[1]: Finished rw-sysroot-nix-store.service.1829machine # [ 6.319376] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1830machine # [ 6.321539] systemd[1]: Finished Cleanup udev Database.1831machine # [ 6.323924] systemd[1]: Reached target Switch Root.1832machine # [ 6.328310] systemd[1]: Starting NixOS Activation...1833machine # [ 6.493102] initrd-nixos-activation-start[195]: booting system configuration /nix/store/d26y3yw9dqhzaq82y7imfda5lr92rv98-nixos-system-machine-test1834machine # [ 6.558592] initrd-nixos-activation-start[195]: running activation script...1835machine # [ 6.983620] initrd-nixos-activation-start[218]: setting up /etc...1836machine # [ 7.260052] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1837machine # [ 7.262866] systemd[1]: Finished NixOS Activation.1838machine # [ 7.263981] systemd[1]: Starting Switch Root...1839machine # [ 7.288743] systemd[1]: Switching root.1840machine # [ 7.489605] systemd-journald[74]: Received SIGTERM from PID 1 (systemd).1841machine # [ 7.683366] NET: Registered PF_VSOCK protocol family1842machine # [ 8.076772] systemd[1]: systemd 262-d2a5296 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)1843machine # [ 8.089183] systemd[1]: Detected virtualization kvm.1844machine # [ 8.092957] systemd[1]: Detected architecture arm64.1845machine # [ 8.095009] systemd[1]: Detected first boot.1846machine # [ 8.103188] systemd[1]: Initializing machine ID from random generator.1847machine # [ 8.283597] systemd[1]: bpf-restrict-fs: LSM BPF program attached1848machine # [ 8.440548] systemd[1]: Applying preset policy.1849machine # [ 8.957836] systemd[1]: Populated /etc with preset unit settings.1850machine # [ 9.503426] systemd[1]: initrd-switch-root.service: Deactivated successfully.1851machine # [ 9.505309] systemd[1]: Stopped initrd-switch-root.service.1852machine # [ 9.508368] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1853machine # [ 9.511000] systemd[1]: Created slice Slice /system/getty.1854machine # [ 9.513871] systemd[1]: Created slice Slice /system/systemd-fsck.1855machine # [ 9.516763] systemd[1]: Created slice User and Session Slice.1856machine # [ 9.518790] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1857machine # [ 9.521168] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1858machine # [ 9.522462] systemd[1]: Expecting device /dev/disk/by-label/ESP...1859machine # [ 9.524886] systemd[1]: Expecting device /dev/hvc0...1860machine # [ 9.525847] systemd[1]: Expecting device /dev/ttyAMA0...1861machine # [ 9.527333] systemd[1]: Reached target Local Encrypted Volumes.1862machine # [ 9.528977] systemd[1]: Stopped target initrd-fs.target.1863machine # [ 9.531201] systemd[1]: Stopped target initrd-root-fs.target.1864machine # [ 9.532313] systemd[1]: Stopped target initrd-switch-root.target.1865machine # [ 9.533893] systemd[1]: Reached target Virtual Machines and Containers.1866machine # [ 9.535518] systemd[1]: Reached target Path Units.1867machine # [ 9.537704] systemd[1]: Reached target Remote File Systems.1868machine # [ 9.538724] systemd[1]: Reached target Slice Units.1869machine # [ 9.540251] systemd[1]: Reached target Swaps.1870machine # [ 9.544400] systemd[1]: Listening on Query the User Interactively for a Password.1871machine # [ 9.549037] systemd[1]: Listening on Process Core Dump Socket.1872machine # [ 9.552736] systemd[1]: Listening on Credential Encryption/Decryption.1873machine # [ 9.556326] systemd[1]: Listening on Factory Reset Management.1874machine # [ 9.557520] systemd[1]: Listening on Hostname Service Socket.1875machine # [ 9.562982] systemd[1]: Starting Journal Log Access Socket...1876machine # [ 9.565048] systemd[1]: Listening on Journal Audit Socket.1877machine # [ 9.569048] systemd[1]: Listening on Console Output Muting Service Socket.1878machine # [ 9.571318] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1879machine # [ 9.573783] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1880machine # [ 9.576245] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1881machine # [ 9.587131] systemd[1]: Listening on Disk Repartitioning Service Socket.1882machine # [ 9.589419] systemd[1]: Listening on udev Varlink Socket.1883machine # [ 9.594024] systemd[1]: Mounting Huge Pages File System...1884machine # [ 9.599064] systemd[1]: Mounting POSIX Message Queue File System...1885machine # [ 9.606660] systemd[1]: Mounting Kernel Debug File System...1886machine # [ 9.620341] systemd[1]: Mounting Kernel Trace File System...1887machine # [ 9.631632] systemd[1]: Starting Create List of Static Device Nodes...1888machine # [ 9.643355] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1889machine # [ 9.646602] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1890machine # [ 9.662381] systemd[1]: Mounting Kernel Configuration File System...1891machine # [ 9.665058] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1892machine # [ 9.668105] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1893machine # [ 9.673143] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1894machine # [ 9.723753] systemd[1]: Mounting FUSE Control File System...1895machine # [ 9.724174] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully.1896machine # [ 9.724483] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service.1897machine # [ 9.738927] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671898machine # [ 9.769453] systemd[1]: Starting Journal Service...1899machine # [ 9.780670] systemd[1]: Starting Load Kernel Modules...1900machine # [ 9.805273] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1901machine # [ 9.840729] systemd[1]: Starting Remount Root and Kernel File Systems...1902machine # [ 9.841083] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1903machine # [ 9.855230] systemd[1]: Starting Coldplug All udev Devices...1904machine # [ 9.866932] systemd-journald[290]: Collecting audit messages is enabled.1905machine # [ 9.847697] systemd[1]: Queued start job for default target Multi-User System.1906machine # [ 9.854936] systemd[1]: systemd-journald.service: Deactivated successfully.1907machine # [ 9.864495] systemd-modules-load[291]: Module 'atkbd' is built in1908machine # [ 9.871861] systemd-modules-load[291]: Module 'loop' is built in1909machine # [ 9.902300] systemd[1]: Started Journal Service.1910machine # [ 9.884258] systemd[1]: Listening on Journal Log Access Socket.1911machine # [ 9.888220] systemd[1]: Mounted Huge Pages File System.1912machine # [ 9.896422] systemd[1]: Mounted POSIX Message Queue File System.1913machine # [ 9.897297] systemd[1]: Mounted Kernel Debug File System.1914machine # [ 9.898062] systemd[1]: Mounted Kernel Trace File System.1915machine # [ 9.898821] systemd[1]: Finished Create List of Static Device Nodes.1916machine # [ 9.899680] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1917machine # [ 9.913844] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1918machine # [ 9.914722] systemd[1]: Mounted Kernel Configuration File System.1919machine # [ 9.915553] systemd[1]: Mounted FUSE Control File System.1920machine # [ 9.919983] systemd[1]: Finished Load Kernel Modules.1921machine # [ 9.938409] systemd[1]: Starting Firewall...1922machine # [ 9.948137] systemd[1]: Starting Apply Kernel Variables...1923machine # [ 9.980140] EXT4-fs (dm-0): re-mounted 3d0f91bd-1132-45e1-99f6-e38cbbc5f921.1924machine # [ 9.957416] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1925machine # [ 9.981780] systemd[1]: Finished Remount Root and Kernel File Systems.1926machine # [ 9.982818] systemd[1]: Listening on Disk Image Download Service Socket.1927machine # [ 9.986475] systemd-oomd[293]: No swap; memory pressure usage will be degraded1928machine # [ 10.005507] systemd[1]: Starting Flush Journal to Persistent Storage...1929machine # [ 10.008798] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1930machine # [ 10.024221] systemd[1]: Starting Load/Save OS Random Seed...1931machine # [ 10.029436] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1932machine # [ 10.038042] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1933machine # [ 10.134611] systemd-journald[290]: Received client request to flush runtime journal.1934machine # [ 10.159779] systemd[1]: Finished Load/Save OS Random Seed.1935machine # [ 10.165657] systemd[1]: Reached target First Boot Complete.1936machine # [ 10.169135] systemd[1]: Finished Apply Kernel Variables.1937machine # [ 10.173291] systemd[1]: Finished Flush Journal to Persistent Storage.1938machine # [ 10.176932] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1939machine # [ 10.181086] systemd[1]: Starting Create Static Device Nodes in /dev...1940machine # [ 10.285982] systemd[1]: Finished Create Static Device Nodes in /dev.1941machine # [ 10.288779] systemd[1]: Reached target Preparation for Local File Systems.1942machine # [ 10.296858] systemd[1]: Starting Rule-based Manager for Device Events and Files...1943machine # [ 10.415663] systemd-udevd[330]: Using default interface naming scheme 'v261'.1944machine # [ 10.482436] systemd[1]: Mounting /run/wrappers...1945machine # [ 10.542608] systemd[1]: Mounted /run/wrappers.1946machine # [ 10.551832] systemd[1]: Starting Create SUID/SGID Wrappers...1947machine # [ 10.627906] systemd[1]: Started Rule-based Manager for Device Events and Files.1948machine # [ 11.333541] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1949machine # [ 11.337519] systemd[1]: Finished Create SUID/SGID Wrappers.1950machine # [ 11.735012] systemd[1]: Finished Coldplug All udev Devices.1951machine # [ 11.759140] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1952machine # [ 11.767763] systemd[1]: Finished Firewall.1953machine # [ 11.786920] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1954machine # [ 11.892096] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1955machine # [ 11.924101] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1956machine # [ 11.946307] (udev-worker)[360]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1957machine # [ 11.953437] (udev-worker)[372]: Network interface NamePolicy= disabled on kernel command line.1958machine # [ 11.957216] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line.1959machine # [ 11.960780] systemd[1]: Found device /dev/tpmrm0.1960machine # [ 11.962020] systemd[1]: Expecting device /dev/tpm0...1961machine # [ 12.068158] systemd[1]: Condition check resulted in Virtio network device being skipped.1962machine # [ 12.072087] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1963machine # [ 12.076105] systemd[1]: Starting Create SUID/SGID Wrappers...1964machine # [ 12.078489] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671965machine # [ 12.087646] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1966machine # [ 12.175200] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.1967machine # [ 12.196825] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...1968machine # [ 12.300151] systemd-fsck[510]: fsck.fat 4.2 (2021-01-31)1969machine # [ 12.305391] systemd-fsck[510]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.1970machine # [ 12.311483] systemd-fsck[510]: Automatically removing dirty bit.1971machine # [ 12.316197] systemd-fsck[510]: *** Filesystem was changed ***1972machine # [ 12.318769] systemd-fsck[510]: Writing changes.1973machine # [ 12.321604] systemd-fsck[510]: /dev/vda1: 20 files, 28704/63671 clusters1974machine # [ 12.329034] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.1975machine # [ 12.332204] systemd[1]: Mounting /boot...1976machine # [ 12.418885] systemd[1]: Mounted /boot.1977machine # [ 12.421878] systemd[1]: Reached target Local File Systems.1978machine # [ 12.428575] systemd[1]: Listening on Boot Loader Control Service Socket.1979machine # [ 12.434789] systemd[1]: Starting register-nix-paths.service...1980machine # [ 12.438231] systemd[1]: Starting Update Boot Loader Random Seed...1981machine # [ 12.467839] systemd[1]: Starting Save Transient machine-id to Disk...1982machine # [ 12.494763] systemd[1]: Starting Create System Files and Directories...1983machine # [ 12.539970] bootctl[533]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 1984machine # [ 12.553782] bootctl[533]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!1985machine # [ 12.563001] systemd[1]: Finished register-nix-paths.service.1986machine # [ 12.581786] bootctl[533]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).1987machine # [ 12.588373] systemd[1]: Finished Update Boot Loader Random Seed.1988machine # [ 12.593777] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1989machine # [ 12.602297] systemd[1]: Finished Save Transient machine-id to Disk.1990machine # [ 12.676023] mousedev: PS/2 mouse device common for all mice1991machine # [ 12.665091] systemd[1]: Finished Create System Files and Directories.1992machine # [ 12.671411] systemd[1]: Starting Rebuild Journal Catalog...1993machine # [ 12.680072] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1994machine # [ 12.756097] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1995machine # [ 12.807485] systemd[1]: Finished Rebuild Journal Catalog.1996machine # [ 12.813887] systemd[1]: Starting Update is Completed...1997machine # [ 12.837662] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1998machine # [ 12.841243] systemd[1]: Finished Create SUID/SGID Wrappers.1999machine # [ 12.866238] systemd[1]: Finished Update is Completed.2000machine # [ 13.677677] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input32001machine # [ 13.710586] systemd[1]: Found device /dev/tpm0.2002machine # [ 13.714892] systemd[1]: Reached target Trusted Platform Module.2003machine # [ 13.715761] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2004machine # [ 13.719168] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2005machine # [ 13.724273] systemd[1]: Reached target System Initialization.2006machine # [ 13.725117] systemd[1]: Started Discard unused filesystem blocks once a week.2007machine # [ 13.726087] systemd[1]: Started Daily Cleanup of Temporary Directories.2008machine # [ 13.727022] systemd[1]: Reached target Timer Units.2009machine # [ 13.727734] systemd[1]: Listening on D-Bus System Message Bus Socket.2010machine # [ 13.737499] systemd[1]: Listening on Nix Daemon Socket.2011machine # [ 13.741065] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2012machine # [ 13.743239] systemd[1]: Reached target Socket Units.2013machine # [ 13.745912] systemd[1]: Reached target Basic System.2014machine # [ 13.748336] systemd[1]: Started backdoor.service.2015machine # [ 13.752174] systemd[1]: Starting Import lastlog data into lastlog2 database...2016machine # [ 13.756157] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2017machine # [ 13.767659] systemd[1]: Starting Post-Boot Actions...2018machine # [ 13.787496] systemd[1]: Started Reset console on configuration changes.2019machine # [ 13.818964] systemd[1]: Starting resolvconf update...2020machine # [ 13.866320] systemd[1]: Starting D-Bus System Message Bus...2021machine # [ 13.914602] systemd[1]: Started Name Service Cache Daemon (nsncd).2022machine # [ 13.919797] nsncd[590]: Sep 02 02:39:55.753 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2023machine # connecting to host...2024machine # [ 13.936570] systemd[1]: Finished Post-Boot Actions.2025machine # [ 13.951388] systemd[1]: Reached target Host and Network Name Lookups.2026machine # [ 13.962827] systemd[1]: Reached target User and Group Name Lookups.2027machine # [ 13.984930] systemd[1]: Starting User Login Management...2028machine: Guest shell says: b'Spawning backdoor root shell...\n'2029machine: connected to guest root shell2030machine # [ 14.033235] systemd[1]: Finished Import lastlog data into lastlog2 database.2031machine: (connecting took 27.03 seconds)2032machine: (finished: waiting for the VM to finish booting, in 27.23 seconds)2033machine # [ 14.099017] dbus-broker-launch[598]: Looking up NSS user entry for 'systemd-timesync'...2034machine # [ 14.111344] dbus-broker-launch[598]: NSS returned no entry for 'systemd-timesync'2035machine # [ 14.118874] dbus-broker-launch[598]: Invalid user-name in /nix/store/q7ql3wsfq04j1s4b5c4a5lqmh6dfqpxw-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2036machine # [ 14.201595] systemd-logind[616]: New seat seat0.2037machine # [ 14.211451] systemd-logind[616]: Watching system buttons on /dev/input/event0 (Power Button)2038machine # [ 14.218009] systemd-logind[616]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2039machine # [ 14.225519] dbus-broker-launch[598]: Ready2040machine # [ 14.276773] systemd[1]: Started D-Bus System Message Bus.2041machine # [ 14.280178] systemd[1]: Started User Login Management.2042machine # [ 14.313619] systemd-logind[616]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2043machine # [ 14.318922] systemd[1]: Stopped target Host and Network Name Lookups.2044machine # [ 14.321714] systemd[1]: Stopping Host and Network Name Lookups...2045machine # [ 14.325793] systemd[1]: Stopped target User and Group Name Lookups.2046machine # [ 14.333091] systemd[1]: Stopping User and Group Name Lookups...2047machine # [ 14.336481] systemd[1]: Starting linger-users.service...2048machine # [ 14.341313] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2049machine # [ 14.357886] systemd[1]: Starting Virtual Console Setup...2050machine # [ 14.372644] systemd[1]: nscd.service: Deactivated successfully.2051machine # [ 14.383047] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2052machine # [ 14.427073] systemd[1]: linger-users.service: Deactivated successfully.2053machine # [ 14.431206] systemd[1]: Finished linger-users.service.2054machine # [ 14.469250] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2055machine # [ 14.478661] systemd[1]: Finished resolvconf update.2056machine # [ 14.482917] systemd[1]: Reached target Preparation for Network.2057machine # [ 14.490602] systemd[1]: Starting DHCP Client...2058machine # [ 14.504534] systemd[1]: Starting Address configuration of eth1...2059machine # [ 14.519463] systemd[1]: Starting Extra networking commands....2060machine # [ 14.554132] nsncd[690]: Sep 02 02:39:56.392 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2061machine # [ 14.559668] systemd[1]: Started Name Service Cache Daemon (nsncd).2062machine # [ 14.562042] systemd[1]: Reached target Host and Network Name Lookups.2063machine # [ 14.565125] systemd[1]: Reached target User and Group Name Lookups.2064machine # [ 14.668449] network-addresses-eth1-start[694]: adding address 192.168.1.1/24... done2065machine # [ 14.693655] network-addresses-eth1-start[694]: adding address 2001:db8:1::1/64... done2066machine # [ 14.721505] systemd[1]: Finished Address configuration of eth1.2067machine # [ 14.743854] dhcpcd[709]: dhcpcd-10.3.2 starting2068machine # [ 14.757066] dhcpcd[751]: dev: loaded udev2069machine # [ 14.825634] 8021q: 802.1Q VLAN Support v1.82070machine # [ 14.826024] 8021q: adding VLAN 0 to HW filter on device eth12071machine # [ 14.812855] systemd[1]: Finished Extra networking commands..2072machine # [ 14.815566] systemd[1]: Reached target Network.2073machine # [ 14.820403] systemd[1]: Starting Permit User Sessions...2074machine # [ 14.847490] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2075machine # [ 14.872682] systemd[1]: Finished Permit User Sessions.2076machine # [ 14.881755] systemd[1]: Started Getty on tty1.2077machine # [ 14.884894] systemd[1]: Reached target Login Prompts.2078machine # [ 14.930733] cfg80211: Loading compiled-in X.509 certificates for regulatory database2079machine # [ 14.962818] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2080machine # [ 14.963281] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2081machine # [ 14.968432] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22082machine # [ 14.968772] cfg80211: failed to load regulatory.db2083machine # [ 15.031023] 8021q: adding VLAN 0 to HW filter on device eth02084machine # [ 15.005509] dhcpcd[751]: eth0: waiting for carrier2085machine # [ 15.007148] dhcpcd[751]: eth0: carrier acquired2086machine # [ 15.018802] dhcpcd[751]: DUID 00:01:00:01:32:2a:48:fc:52:54:00:12:34:562087machine # [ 15.019923] dhcpcd[751]: eth0: IAID 00:12:34:562088machine # [ 15.020762] dhcpcd[751]: eth0: adding address fe80::5054:ff:fe12:34562089machine # [ 15.069589] systemd-vconsole-setup[671]: Configuration of first virtual console was skipped, ignoring remaining ones.2090machine # [ 15.073548] systemd[1]: Finished Virtual Console Setup.2091machine # [ 15.545694] dhcpcd[751]: eth0: soliciting a DHCP lease2092machine # [ 15.553937] dhcpcd[751]: eth0: offered 10.0.2.15 from 10.0.2.22093machine # [ 15.560392] dhcpcd[751]: eth0: probing address 10.0.2.15/242094machine # [ 16.713306] dhcpcd[751]: eth0: soliciting an IPv6 router2095machine # [ 16.715688] dhcpcd[751]: eth0: Router Advertisement from fe80::22096machine # [ 16.717894] dhcpcd[751]: eth0: adding address fec0::5054:ff:fe12:3456/642097machine # [ 16.719450] dhcpcd[751]: eth0: adding route to fec0::/642098machine # [ 16.721196] dhcpcd[751]: eth0: adding default route via fe80::22099machine # [ 19.959996] dhcpcd[751]: eth0: leased 10.0.2.15 for 86400 seconds2100machine # [ 19.962689] dhcpcd[751]: eth0: adding route to 10.0.2.0/242101machine # [ 19.965339] dhcpcd[751]: eth0: adding default route via 10.0.2.22102machine # [ 20.178082] systemd[1]: Started DHCP Client.2103machine # [ 20.180242] systemd[1]: Reached target Multi-User System.2104machine # [ 20.181642] systemd[1]: Startup finished in 6.063s (firmware) + 6.271s (loader) + 904ms (kernel) + 6.689s (initrd) + 12.587s (userspace) = 32.516s.2105machine: (finished: waiting for unit multi-user.target, in 34.40 seconds)2106machine: must succeed: mount2107machine: (finished: must succeed: mount, in 0.04 seconds)2108(finished: run the VM test script, in 76.12 seconds)2109test script finished in 76.17s2110cleanup2111kill QemuMachine (pid 92)2112machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2113(finished: cleanup, in 0.01 seconds)