vm-test-run-systemd-initrd-luks-tpm2
checks.aarch64-linux.systemd-initrd-luks-tpm2
· build #19
· 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 # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)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/k72ydf4zv20fybn39rgknfnq9jnb0jp8-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[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS \x1b[021;063'22machine: Guest shell says: b'H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m NixOS (boot-luks) \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 NixOS (boot-luks) Reboot Into Firmware Interface Boot in 5s. ------------------------------------------ Boot in 4s. ------------------------------------------ Boot in 3s. ------------------------------------------ Boot in 2s. ------------------------------------------ Boot in 1s. ------------------------------------------[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]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\xs25hhpkl6nywpm8pwk0yk7k4krxmq7d-initrd-linux-6.18.48-initrd.efi init=/nix/store/2y2x2bhcwh4132lw2ccsi6qj7955mci8-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 @408e0000 (indirect, esz 8, psz 64K, shr 1)130machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @408f0000 (flat, esz 8, psz 64K, shr 1)131machine # [ 0.000000] GICv3: using LPI property table @0x0000000040900000132machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000040910000133machine # [ 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.000030] arm-pv: using stolen time PV139machine # [ 0.000384] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)140machine # [ 0.000467] Console: colour dummy device 80x25141machine # [ 0.000472] printk: legacy console [tty0] enabled142machine # [ 0.000677] ACPI: Core revision 20250807143machine # [ 0.000762] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)144machine # [ 0.000769] pid_max: default: 32768 minimum: 301145machine # [ 0.000830] LSM: initializing lsm=capability,landlock,yama,bpf,ima146machine # [ 0.000953] landlock: Up and running.147machine # [ 0.000956] Yama: becoming mindful.148machine # [ 0.001373] LSM support for eBPF active149machine # [ 0.001458] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)150machine # [ 0.001465] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151machine # [ 0.002422] rcu: Hierarchical SRCU implementation.152machine # [ 0.002427] rcu: Max phase no-delay instances is 1000.153machine # [ 0.003040] fsl-mc MSI: ITS@0x8080000 domain created154machine # [ 0.003059] Remapping and enabling EFI services.155machine # [ 0.003167] smp: Bringing up secondary CPUs ...156machine # [ 0.003177] smp: Brought up 1 node, 1 CPU157machine # [ 0.003180] SMP: Total of 1 processors activated.158machine # [ 0.003182] CPU: All CPU(s) started at EL1159machine # [ 0.003193] CPU features: detected: Branch Target Identification160machine # [ 0.003198] CPU features: detected: ARMv8.4 Translation Table Level161machine # [ 0.003201] CPU features: detected: Instruction cache invalidation not required for I/D coherence162machine # [ 0.003205] CPU features: detected: Data cache clean to the PoU not required for I/D coherence163machine # [ 0.003209] CPU features: detected: Common not Private translations164machine # [ 0.003212] CPU features: detected: CRC32 instructions165machine # [ 0.003215] CPU features: detected: Data cache clean to Point of Deep Persistence166machine # [ 0.003218] CPU features: detected: Data cache clean to Point of Persistence167machine # [ 0.003221] CPU features: detected: Data independent timing control (DIT)168machine # [ 0.003224] CPU features: detected: E0PD169machine # [ 0.003226] CPU features: detected: Enhanced Counter Virtualization170machine # [ 0.003229] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)171machine # [ 0.003233] CPU features: detected: Enhanced Virtualization Traps172machine # [ 0.003236] CPU features: detected: Fine Grained Traps173machine # [ 0.003239] CPU features: detected: Generic authentication (architected QARMA5 algorithm)174machine # [ 0.003244] CPU features: detected: RCpc load-acquire (LDAPR)175machine # [ 0.003246] CPU features: detected: LSE atomic instructions176machine # [ 0.003249] CPU features: detected: Privileged Access Never177machine # [ 0.003252] CPU features: detected: PMUv3178machine # [ 0.003255] CPU features: detected: RAS Extension Support179machine # [ 0.003258] CPU features: detected: RASv1p1 Extension Support180machine # [ 0.003260] CPU features: detected: Random Number Generator181machine # [ 0.003263] CPU features: detected: Speculation barrier (SB)182machine # [ 0.003265] CPU features: detected: Stage-2 Force Write-Back183machine # [ 0.003268] CPU features: detected: TLB range maintenance instructions184machine # [ 0.003273] CPU features: detected: Speculative Store Bypassing Safe (SSBS)185machine # [ 0.003312] alternatives: applying system-wide alternatives186machine # [ 0.005976] CPU features: detected: BBM Level 2 without TLB conflict abort187machine # [ 0.006091] Memory: 887820K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 119480K reserved, 32768K cma-reserved)188machine # [ 0.006333] devtmpfs: initialized189machine # [ 0.007177] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)190machine # [ 0.007187] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).191machine # [ 0.007342] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL192machine # [ 0.007347] 0 pages in range for non-PLT usage193machine # [ 0.007348] 508288 pages in range for PLT usage194machine # [ 0.007424] pinctrl core: initialized pinctrl subsystem195machine # [ 0.007950] SMBIOS 3.0.0 present.196machine # [ 0.007956] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022197machine # [ 0.007963] DMI: Memory slots populated: 1/1198machine # [ 0.009219] NET: Registered PF_NETLINK/PF_ROUTE protocol family199machine # [ 0.009826] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations200machine # [ 0.009956] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations201machine # [ 0.010134] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202machine # [ 0.010153] audit: initializing netlink subsys (disabled)203machine # [ 0.010520] thermal_sys: Registered thermal governor 'fair_share'204machine # [ 0.010523] thermal_sys: Registered thermal governor 'bang_bang'205machine # [ 0.010526] thermal_sys: Registered thermal governor 'step_wise'206machine # [ 0.010529] thermal_sys: Registered thermal governor 'user_space'207machine # [ 0.010532] thermal_sys: Registered thermal governor 'power_allocator'208machine # [ 0.010553] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1209machine # [ 0.010564] cpuidle: using governor ladder210machine # [ 0.010570] cpuidle: using governor menu211machine # [ 0.010727] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.212machine # [ 0.010744] ASID allocator initialised with 65536 entries213machine # [ 0.011402] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5214machine # [ 0.011583] Serial: AMBA PL011 UART driver215machine # [ 0.018247] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages216machine # [ 0.018253] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page217machine # [ 0.018256] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages218machine # [ 0.018259] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page219machine # [ 0.018262] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages220machine # [ 0.018265] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page221machine # [ 0.018268] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages222machine # [ 0.018270] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page223machine # [ 0.018976] fbcon: Taking over console224machine # [ 0.019010] ACPI: Added _OSI(Module Device)225machine # [ 0.019013] ACPI: Added _OSI(Processor Device)226machine # [ 0.019016] ACPI: Added _OSI(Processor Aggregator Device)227machine # [ 0.020030] ACPI: 1 ACPI AML tables successfully acquired and loaded228machine # [ 0.026127] ACPI: Interpreter enabled229machine # [ 0.026131] ACPI: Using GIC for interrupt routing230machine # [ 0.026156] ACPI: MCFG table detected, 1 entries231machine # [ 0.030046] ACPI: CPU0 has been hot-added232machine # [ 0.030369] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA233machine # [ 0.030432] printk: console [ttyAMA0] enabled234machine # [ 0.115039] ACPI: PCI: Interrupt link L000 configured for IRQ 35235machine # [ 0.115055] ACPI: PCI: Interrupt link L001 configured for IRQ 36236machine # [ 0.115067] ACPI: PCI: Interrupt link L002 configured for IRQ 37237machine # [ 0.115079] ACPI: PCI: Interrupt link L003 configured for IRQ 38238machine # [ 0.115095] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])239machine # [ 0.115130] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]240machine # [ 0.115217] acpi PNP0A08:00: _OSC: platform does not support [LTR]241machine # [ 0.115313] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]242machine # [ 0.115550] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00243machine # [ 0.115565] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]244machine # [ 0.115586] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]245machine # [ 0.115923] PCI host bridge to bus 0000:00246machine # [ 0.115950] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]247machine # [ 0.115955] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]248machine # [ 0.115958] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]249machine # [ 0.115962] pci_bus 0000:00: root bus resource [bus 00-ff]250machine # [ 0.115965] PCI: OF: of_root node is NULL, cannot create PCI host bridge node251machine # [ 0.116028] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint252machine # [ 0.116494] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint253machine # [ 0.116672] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]254machine # [ 0.116684] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]255machine # [ 0.116708] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]256machine # [ 0.116720] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]257machine # [ 0.117197] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint258machine # [ 0.118730] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]259machine # [ 0.118743] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]260machine # [ 0.118768] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]261machine # [ 0.119277] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint262machine # [ 0.119466] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]263machine # [ 0.119477] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]264machine # [ 0.119504] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]265machine # [ 0.205533] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint266machine # [ 0.205724] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]267machine # [ 0.205741] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]268machine # [ 0.205771] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]269machine # [ 0.206264] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint270machine # [ 0.206442] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]271machine # [ 0.206458] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]272machine # [ 0.206488] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]273machine # [ 0.206973] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.207784] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]275machine # [ 0.207804] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]276machine # [ 0.207834] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]277machine # [ 0.217696] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint278machine # [ 0.217880] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]279machine # [ 0.217897] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]280machine # [ 0.217927] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]281machine # [ 0.218416] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint282machine # [ 0.218595] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]283machine # [ 0.218612] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]284machine # [ 0.218642] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]285machine # [ 0.218659] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]286machine # [ 0.219139] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint287machine # [ 0.228047] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]288machine # [ 0.228085] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]289machine # [ 0.228595] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint290machine # [ 0.228781] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]291machine # [ 0.228811] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]292machine # [ 0.233641] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint293machine # [ 0.234495] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]294machine # [ 0.234800] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.235589] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]296machine # [ 0.235608] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]297machine # [ 0.235637] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]298machine # [ 0.236141] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.236861] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]300machine # [ 0.236880] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]301machine # [ 0.236909] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]302machine # [ 0.245285] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.245301] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.245308] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.245353] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.245399] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.245445] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.245491] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.245537] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.245897] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.245945] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.245993] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.257150] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.257207] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.257254] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned316machine # [ 0.257298] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.257321] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.257343] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.257365] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.257387] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.257409] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.257431] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.257453] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.257476] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.257985] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.258009] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.258526] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.258551] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned329machine # [ 0.258574] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.259136] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned331machine # [ 0.259161] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned332machine # [ 0.259184] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned333machine # [ 0.276262] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned334machine # [ 0.276290] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned335machine # [ 0.278318] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned336machine # [ 0.278345] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned337machine # [ 0.278368] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned338machine # [ 0.278390] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned339machine # [ 0.278890] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]340machine # [ 0.278904] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]341machine # [ 0.278909] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]342machine # [ 0.286833] iommu: Default domain type: Translated343machine # [ 0.286845] iommu: DMA domain TLB invalidation policy: strict mode344machine # [ 0.288516] SCSI subsystem initialized345machine # [ 0.289092] ACPI: bus type USB registered346machine # [ 0.289137] usbcore: registered new interface driver usbfs347machine # [ 0.289157] usbcore: registered new interface driver hub348machine # [ 0.289173] usbcore: registered new device driver usb349machine # [ 0.291679] pps_core: LinuxPPS API ver. 1 registered350machine # [ 0.291690] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>351machine # [ 0.291701] PTP clock support registered352machine # [ 0.291742] EDAC MC: Ver: 3.0.0353machine # [ 0.294547] scmi_core: SCMI protocol bus registered354machine # [ 0.295233] efivars: Registered efivars operations355machine # [ 0.296174] FPGA manager framework356machine # [ 0.296965] vgaarb: loaded357machine # [ 0.297518] clocksource: Switched to clocksource arch_sys_counter358machine # [ 0.299794] VFS: Disk quotas dquot_6.6.0359machine # [ 0.299826] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360machine # [ 0.301228] netfs: FS-Cache loaded361machine # [ 0.301323] pnp: PnP ACPI init362machine # [ 0.301485] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved363machine # [ 0.303176] pnp: PnP ACPI: found 1 devices364machine # [ 0.306295] NET: Registered PF_INET protocol family365machine # [ 0.306350] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)366machine # [ 0.326215] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)367machine # [ 0.326251] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)368machine # [ 0.326272] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)369machine # [ 0.326315] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370machine # [ 0.326392] TCP: Hash tables configured (established 8192 bind 8192)371machine # [ 0.326456] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)372machine # [ 0.326484] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)373machine # [ 0.326508] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)374machine # [ 0.326592] NET: Registered PF_UNIX/PF_LOCAL protocol family375machine # [ 0.326616] NET: Registered PF_XDP protocol family376machine # [ 0.327280] PCI: CLS 0 bytes, default 64377machine # [ 0.327474] Trying to unpack rootfs image as initramfs...378machine # [ 0.342706] kvm [1]: HYP mode not available379machine # [ 0.435991] Initialise system trusted keyrings380machine # [ 0.436653] workingset: timestamp_bits=42 max_order=18 bucket_order=0381machine # [ 0.437840] squashfs: version 4.0 (2009/01/31) Phillip Lougher382machine # [ 0.438585] 9p: Installing v9fs 9p2000 file system support383machine # [ 0.466545] Key type asymmetric registered384machine # [ 0.466563] Asymmetric key parser 'x509' registered385machine # [ 0.466619] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)386machine # [ 0.468616] io scheduler mq-deadline registered387machine # [ 0.468629] io scheduler kyber registered388machine # [ 0.477550] ledtrig-cpu: registered to indicate activity on CPUs389machine # [ 0.479289] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0390machine # [ 0.479353] ACPI: button: Power Button [PWRB]391machine # [ 0.502937] ACPI: \_SB_.L001: Enabled at IRQ 36392machine # [ 0.502985] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)393machine # [ 0.505333] ACPI: \_SB_.L002: Enabled at IRQ 37394machine # [ 0.505366] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)395machine # [ 0.514952] ACPI: \_SB_.L003: Enabled at IRQ 38396machine # [ 0.514995] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)397machine # [ 0.525561] ACPI: \_SB_.L000: Enabled at IRQ 35398machine # [ 0.525605] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)399machine # [ 0.529646] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)400machine # [ 0.531927] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)401machine # [ 0.533472] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)402machine # [ 0.544142] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)403machine # [ 0.551953] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)404machine # [ 0.565823] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)405machine # [ 0.567577] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)406machine # [ 0.572754] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled407machine # [ 0.574938] msm_serial: driver initialized408machine # [ 0.575066] SuperH (H)SCI(F) driver initialized409machine # [ 0.575104] STM32 USART driver initialized410machine # [ 0.598923] ACPI: bus type drm_connector registered411machine # [ 0.606406] loop: module loaded412machine # [ 0.606562] virtio_blk virtio5: 1/0/0 default/read/poll queues413machine # [ 0.607185] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)414machine # [ 0.649571] vda: vda1 vda2415machine # [ 0.649878] virtio_blk virtio6: 1/0/0 default/read/poll queues416machine # [ 0.650510] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)417machine # [ 0.653958] megasas: 07.734.00.00-rc1418machine # [ 0.656068] tun: Universal TUN/TAP device driver, 1.6419machine # [ 0.659759] thunder_xcv, ver 1.0420machine # [ 0.659804] thunder_bgx, ver 1.0421machine # [ 0.659827] nicpf, ver 1.0422machine # [ 0.660361] e1000: Intel(R) PRO/1000 Network Driver423machine # [ 0.660369] e1000: Copyright (c) 1999-2006 Intel Corporation.424machine # [ 0.660395] e1000e: Intel(R) PRO/1000 Network Driver425machine # [ 0.660401] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.426machine # [ 0.660440] igb: Intel(R) Gigabit Ethernet Network Driver427machine # [ 0.660447] igb: Copyright (c) 2007-2014 Intel Corporation.428machine # [ 0.660471] igbvf: Intel(R) Gigabit Virtual Function Network Driver429machine # [ 0.660478] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.430machine # [ 0.660605] sky2: driver version 1.30431machine # [ 0.668772] usbcore: registered new interface driver usb-storage432machine # [ 0.668820] usbcore: registered new interface driver usbserial_generic433machine # [ 0.668835] usbserial: USB Serial support registered for generic434machine # [ 0.669350] hv_vmbus: registering driver hyperv_keyboard435machine # [ 0.670168] ehci-pci 0000:00:0b.0: EHCI Host Controller436machine # [ 0.670193] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 1437machine # [ 0.670478] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a000438machine # [ 0.681589] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.00439machine # [ 0.681897] hub 1-0:1.0: USB hub found440machine # [ 0.681930] hub 1-0:1.0: 6 ports detected441machine # [ 0.684410] rtc-efi rtc-efi.0: registered as rtc0442machine # [ 0.684985] rtc-efi rtc-efi.0: setting system clock to 2026-09-03T02:47:20 UTC (1788403640)443machine # [ 0.685286] i2c_dev: i2c /dev entries driver444machine # [ 0.689094] sdhci: Secure Digital Host Controller Interface driver445machine # [ 0.689105] sdhci: Copyright(c) Pierre Ossman446machine # [ 0.689331] Synopsys Designware Multimedia Card Interface Driver447machine # [ 0.691574] sdhci-pltfm: SDHCI platform and OF driver helper448machine # [ 0.692596] pstore: Using crash dump compression: deflate449machine # [ 0.692604] pstore: Registered efi_pstore as persistent store backend450machine # [ 0.702335] hid: raw HID events driver (C) Jiri Kosina451machine # [ 0.702605] usbcore: registered new interface driver usbhid452machine # [ 0.702613] usbhid: USB HID core driver453machine # [ 0.703522] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available454machine # [ 0.704852] drop_monitor: Initializing network drop monitor service455machine # [ 0.704964] NET: Registered PF_INET6 protocol family456machine # [ 0.709747] Segment Routing with IPv6457machine # [ 0.709772] In-situ OAM (IOAM) with IPv6458machine # [ 0.709800] NET: Registered PF_PACKET protocol family459machine # [ 0.711356] 9pnet: Installing 9P2000 support460machine # [ 0.713322] Key type dns_resolver registered461machine # [ 0.727195] registered taskstats version 1462machine # [ 0.727353] Loading compiled-in X.509 certificates463machine # [ 0.749558] Demotion targets for Node 0: null464machine # [ 0.750282] Key type .fscrypt registered465machine # [ 0.750293] Key type fscrypt-provisioning registered466machine # [ 0.750375] ima: No TPM chip found, activating TPM-bypass!467machine # [ 0.750394] ima: Allocated hash algorithm: sha1468machine # [ 0.750414] ima: No architecture policies found469machine # [ 0.785259] clk: Disabling unused clocks470machine # [ 0.785286] PM: genpd: Disabling unused power domains471machine # [ 0.873685] Freeing initrd memory: 25552K472machine # [ 0.877140] Freeing unused kernel memory: 4736K473machine # [ 0.877322] Run /init as init process474machine # [ 0.894210] fuse: init (API version 7.45)475machine # [ 0.904813] systemd[1]: Successfully made /usr/ read-only.476machine # [ 0.933549] usb 1-1: new high-speed USB device number 2 using ehci-pci477machine # [ 1.083706] 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.153923] 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.239614] systemd[1]: systemd 262-2451b1a 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.251275] systemd[1]: Detected virtualization kvm.481machine # [ 1.253164] systemd[1]: Detected architecture arm64.482machine # [ 1.255075] systemd[1]: Running in initrd.483machine # [ 1.257590] systemd[1]: Initializing machine ID from random generator.484machine # [ 1.260267] systemd[1]: Hostname set to <machine>.485machine # [ 1.277609] usb 1-2: new high-speed USB device number 3 using ehci-pci486machine # [ 1.407113] systemd[1]: bpf-restrict-fs: LSM BPF program attached487machine # [ 1.439272] 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.440717] 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.463794] systemd[1]: Queued start job for default target Initrd Default Target.490machine # [ 1.471270] systemd[1]: Created slice Slice /system/modprobe.491machine # [ 1.472157] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492machine # [ 1.473284] systemd[1]: Expecting device /dev/disk/by-label/nixos...493machine # [ 1.473303] systemd[1]: Expecting device /dev/tpm0...494machine # [ 1.473315] systemd[1]: Expecting device /dev/tpmrm0...495machine # [ 1.473339] systemd[1]: Reached target Path Units.496machine # [ 1.473355] systemd[1]: Reached target Slice Units.497machine # [ 1.473372] systemd[1]: Reached target Swaps.498machine # [ 1.473389] systemd[1]: Reached target Timer Units.499machine # [ 1.473573] systemd[1]: Listening on D-Bus System Message Bus Socket.500machine # [ 1.473697] systemd[1]: Listening on Journal Socket (/dev/log).501machine # [ 1.473807] systemd[1]: Listening on Journal Sockets.502machine # [ 1.473875] systemd[1]: Listening on udev Kernel Socket.503machine # [ 1.473893] systemd[1]: Reached target Socket Units.504machine # [ 1.482668] systemd[1]: Starting Create List of Static Device Nodes...505machine # [ 1.486275] systemd[1]: Starting Load Kernel Module 9pnet_virtio...506machine # [ 1.487105] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs507machine # [ 1.502170] systemd[1]: Mounting Kernel Configuration File System...508machine # [ 1.505649] systemd[1]: Starting Journal Service...509machine # [ 1.524467] systemd[1]: Starting Load Kernel Modules...510machine # [ 1.537671] systemd[1]: Starting Coldplug All udev Devices...511machine # [ 1.548198] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.512machine # [ 1.557739] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev513machine # [ 1.562043] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0514machine # [ 1.562275] [drm] features: -virgl +edid -resource_blob -host_visible515machine # [ 1.562284] [drm] features: -context_init516machine # [ 1.562961] [drm] number of scanouts: 1517machine # [ 1.562979] [drm] number of cap sets: 0518machine # [ 1.567113] systemd[1]: Finished Create List of Static Device Nodes.519machine # [ 1.568076] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.520machine # [ 1.574061] systemd[1]: Finished Load Kernel Module 9pnet_virtio.521machine # [ 1.574398] systemd[1]: Mounted Kernel Configuration File System.522machine # [ 1.581044] systemd-journald[72]: Collecting audit messages is disabled.523machine # [ 1.585944] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...524machine # [ 1.589300] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic525machine # [ 1.589321] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0526machine # [ 1.609772] Console: switching to colour frame buffer device 160x50527machine # [ 1.616157] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device528machine # [ 1.630092] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.529machine # [ 1.633129] systemd[1]: Starting Create Static Device Nodes in /dev...530machine # [ 1.650227] systemd[1]: Finished Load Kernel Modules.531machine # [ 1.656350] systemd[1]: Starting Apply Kernel Variables...532machine # [ 1.669670] systemd[1]: Finished Create Static Device Nodes in /dev.533machine # [ 1.671650] systemd[1]: Reached target Preparation for Local File Systems.534machine # [ 1.671692] systemd[1]: Reached target Local File Systems.535machine # [ 1.685878] systemd[1]: Starting Rule-based Manager for Device Events and Files...536machine # [ 1.703959] systemd[1]: Finished Apply Kernel Variables.537machine # [ 1.753007] systemd[1]: Started Journal Service.538machine # [ 1.731439] systemd-modules-load[73]: Inserted module 'dm_mod'539machine # [ 1.736207] systemd-modules-load[73]: Module 'virtio_balloon' is built in540machine # [ 1.737280] systemd-modules-load[73]: Module 'virtio_console' is built in541machine # [ 1.738340] systemd-modules-load[73]: Inserted module 'virtio_gpu'542machine # [ 1.739318] systemd-modules-load[73]: Module 'virtio_rng' is built in543machine # [ 1.745570] systemd[1]: Starting Create System Files and Directories...544machine # [ 1.757028] systemd-udevd[80]: Using default interface naming scheme 'v261'.545machine # [ 1.775110] systemd[1]: Finished Create System Files and Directories.546machine # [ 1.793140] systemd[1]: Started Rule-based Manager for Device Events and Files.547machine # [ 1.846538] systemd[1]: Starting Virtual Console Setup...548machine # [ 1.893760] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 1.896150] systemd[1]: Finished Virtual Console Setup.550machine # [ 2.556684] systemd[1]: Finished Coldplug All udev Devices.551machine # [ 2.691966] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.552machine # [ 2.730423] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.553machine # [ 2.737653] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.554machine # [ 2.892336] systemd[1]: Found device /dev/disk/by-label/nixos.555machine # [ 2.909005] systemd[1]: Reached target Initrd Root Device.556machine # [ 2.913621] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...557machine # [ 2.955400] systemd-fsck[110]: nixos: clean, 67477/137632 files, 417031/549888 blocks558machine # [ 2.966917] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.559machine # [ 2.972347] systemd[1]: Mounting /sysroot...560machine # [ 3.046401] EXT4-fs (vda2): mounted filesystem f222513b-ded1-49fa-b591-20ce86a2fe7f r/w with ordered data mode. Quota mode: none.561machine # [ 3.023311] systemd[1]: Mounted /sysroot.562machine # [ 3.025486] systemd[1]: Reached target Initrd Root File System.563machine # [ 3.032136] systemd[1]: Starting Mountpoints Configured in the Real Root...564machine # [ 3.055263] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.565machine # [ 3.060189] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...566machine # [ 3.064820] systemd[1]: Reloading...567machine # [ 3.286025] systemd[1]: Reloading finished in 223 ms.568machine # [ 3.318416] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...569machine # [ 3.323611] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...570machine # [ 3.326425] systemd[1]: Starting Load Kernel Module 9pnet_virtio...571machine # [ 3.334999] systemd[1]: initrd-parse-etc.service: Deactivated successfully.572machine # [ 3.337529] systemd[1]: Finished Mountpoints Configured in the Real Root.573machine # [ 3.339252] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.574machine # [ 3.363150] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 3.364684] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 3.525069] systemd[1]: Mounting /sysroot/nix/.ro-store...577machine # [ 3.535687] systemd[1]: Mounting /sysroot/nix/.rw-store...578machine # [ 3.542468] systemd[1]: sysroot-run.mount: Directory /sysroot/run to mount over is not empty, mounting anyway.579machine # [ 3.547888] systemd[1]: Mounting /sysroot/run...580machine # [ 3.569773] systemd[1]: Mounting /sysroot/tmp/shared...581machine # [ 3.581640] systemd[1]: Mounting /sysroot/tmp/xchg...582machine # [ 3.615191] systemd[1]: Mounted /sysroot/run.583machine # [ 3.626459] systemd[1]: Mounted /sysroot/nix/.ro-store.584machine # [ 3.637012] systemd[1]: Mounted /sysroot/nix/.rw-store.585machine # [ 3.649844] systemd[1]: Starting rw-sysroot-nix-store.service...586machine # [ 3.652204] systemd[1]: Mounted /sysroot/tmp/shared.587machine # [ 3.666374] systemd[1]: Mounted /sysroot/tmp/xchg.588machine # [ 3.680280] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.589machine # [ 3.681767] systemd[1]: Finished rw-sysroot-nix-store.service.590machine # [ 4.078654] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)591machine # [ 4.207257] systemd[1]: Found device /dev/tpm0.592machine # [ 4.213017] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.593machine # [ 4.214549] systemd[1]: Stopped Virtual Console Setup.594machine # [ 4.217449] systemd[1]: Stopping Virtual Console Setup...595machine # [ 4.224201] systemd[1]: Starting Virtual Console Setup...596machine # [ 4.244834] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.597machine # [ 4.248136] systemd[1]: Stopped Virtual Console Setup.598machine # [ 4.253497] systemd[1]: Found device /dev/tpmrm0.599machine # [ 4.255456] systemd[1]: Reached target Trusted Platform Module.600machine # [ 4.256853] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os601machine # [ 4.260143] systemd[1]: Starting Virtual Console Setup...602machine # [ 4.285516] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.603machine # [ 4.289151] systemd[1]: Finished Virtual Console Setup.604machine # [ 4.290014] systemd[1]: Reached target System Initialization.605machine # [ 4.290851] systemd[1]: Reached target Basic System.606machine # [ 4.527486] systemd[1]: sysroot-nix-store.mount: Directory /sysroot/nix/store to mount over is not empty, mounting anyway.607machine # [ 4.536452] systemd[1]: Mounting /sysroot/nix/store...608machine # [ 4.592498] systemd[1]: Mounted /sysroot/nix/store.609machine # [ 4.595359] systemd[1]: Reached target Initrd File Systems.610machine # [ 4.600159] systemd[1]: Starting Find NixOS closure...611machine # [ 4.612296] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...612machine # [ 4.653347] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.613machine # [ 4.660953] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.614machine # [ 4.673293] systemd[1]: Finished Find NixOS closure.615machine # [ 4.675244] systemd[1]: Reached target Initrd Default Target.616machine # [ 4.678894] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...617machine # [ 4.710941] systemd[1]: Stopped target Initrd Default Target.618machine # [ 4.713051] systemd[1]: Stopped target Basic System.619machine # [ 4.716443] systemd[1]: Stopped target Initrd Root Device.620machine # [ 4.717649] systemd[1]: Stopped target Path Units.621machine # [ 4.720360] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.622machine # [ 4.722887] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.623machine # [ 4.726222] systemd[1]: Stopped target Slice Units.624machine # [ 4.732170] systemd[1]: Stopped target Socket Units.625machine # [ 4.733135] systemd[1]: Stopped target System Initialization.626machine # [ 4.734133] systemd[1]: Stopped target Swaps.627machine # [ 4.734953] systemd[1]: Stopped target Timer Units.628machine # [ 4.735804] systemd[1]: Stopped target Trusted Platform Module.629machine # [ 4.739837] systemd[1]: dbus.socket: Deactivated successfully.630machine # [ 4.741195] systemd[1]: Closed D-Bus System Message Bus Socket.631machine # [ 4.742402] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.632machine # [ 4.745002] systemd[1]: Stopped Find NixOS closure.633machine # [ 4.747043] systemd[1]: Starting Load Kernel Module 9pnet_virtio...634machine # [ 4.757558] systemd[1]: Starting rw-sysroot-nix-store.service...635machine # [ 4.759324] systemd[1]: systemd-sysctl.service: Deactivated successfully.636machine # [ 4.762077] systemd[1]: Stopped Apply Kernel Variables.637machine # [ 4.762878] systemd[1]: systemd-modules-load.service: Deactivated successfully.638machine # [ 4.763854] systemd[1]: Stopped Load Kernel Modules.639machine # [ 4.772283] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.640machine # [ 4.773462] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.641machine # [ 4.775520] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.642machine # [ 4.784736] systemd[1]: Stopped Create System Files and Directories.643machine # [ 4.785759] systemd[1]: Stopped target Local File Systems.644machine # [ 4.786555] systemd[1]: Stopped target Preparation for Local File Systems.645machine # [ 4.787483] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.646machine # [ 4.793123] systemd[1]: Stopped Coldplug All udev Devices.647machine # [ 4.795275] systemd[1]: Stopping Rule-based Manager for Device Events and Files...648machine # [ 4.797771] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.649machine # [ 4.799559] systemd[1]: Stopped Virtual Console Setup.650machine # [ 4.803831] systemd[1]: initrd-cleanup.service: Deactivated successfully.651machine # [ 4.805210] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.652machine # [ 4.806108] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.653machine # [ 4.807110] systemd[1]: Finished Load Kernel Module 9pnet_virtio.654machine # [ 4.807924] systemd[1]: systemd-udevd.service: Deactivated successfully.655machine # [ 4.809027] systemd[1]: Stopped Rule-based Manager for Device Events and Files.656machine # [ 4.810003] systemd[1]: systemd-udevd.service: Consumed 1.512s CPU time over 3.135s wall clock time, 23M memory peak.657machine # [ 4.811359] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.658machine # [ 4.812415] systemd[1]: Finished rw-sysroot-nix-store.service.659machine # [ 4.813210] systemd[1]: Starting Cleanup udev Database...660machine # [ 4.813952] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.661machine # [ 4.814985] systemd[1]: Stopped Create Static Device Nodes in /dev.662machine # [ 4.815831] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.663machine # [ 4.824219] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.664machine # [ 4.825432] systemd[1]: kmod-static-nodes.service: Deactivated successfully.665machine # [ 4.828186] systemd[1]: Stopped Create List of Static Device Nodes.666machine # [ 4.862451] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.667machine # [ 4.863581] systemd[1]: Finished Cleanup udev Database.668machine # [ 4.867993] systemd[1]: Reached target Switch Root.669machine # [ 4.868755] systemd[1]: Starting NixOS Activation...670machine # [ 5.030224] initrd-nixos-activation-start[178]: booting system configuration /nix/store/2y2x2bhcwh4132lw2ccsi6qj7955mci8-nixos-system-machine-test671machine # [ 5.099374] initrd-nixos-activation-start[178]: running activation script...672machine # [ 5.524793] initrd-nixos-activation-start[201]: setting up /etc...673machine # [ 5.863968] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.674machine # [ 5.866709] systemd[1]: Finished NixOS Activation.675machine # [ 5.868538] systemd[1]: Starting Switch Root...676machine # [ 5.891623] systemd[1]: Switching root.677machine # [ 6.092363] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).678machine # [ 6.274395] NET: Registered PF_VSOCK protocol family679machine # [ 6.665169] systemd[1]: systemd 262-2451b1a 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.677865] systemd[1]: Detected virtualization kvm.681machine # [ 6.681796] systemd[1]: Detected architecture arm64.682machine # [ 6.683817] systemd[1]: Detected first boot.683machine # [ 6.690906] systemd[1]: Initializing machine ID from random generator.684machine # [ 6.862701] systemd[1]: bpf-restrict-fs: LSM BPF program attached685machine # [ 7.010034] systemd[1]: Applying preset policy.686machine # [ 7.501610] systemd[1]: Populated /etc with preset unit settings.687machine # [ 8.020043] systemd[1]: initrd-switch-root.service: Deactivated successfully.688machine # [ 8.021847] systemd[1]: Stopped initrd-switch-root.service.689machine # [ 8.024563] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.690machine # [ 8.027354] systemd[1]: Created slice Slice /system/getty.691machine # [ 8.029241] systemd[1]: Created slice Slice /system/systemd-fsck.692machine # [ 8.031256] systemd[1]: Created slice User and Session Slice.693machine # [ 8.032451] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.694machine # [ 8.034246] systemd[1]: Started Forward Password Requests to Wall Directory Watch.695machine # [ 8.036556] systemd[1]: Expecting device /dev/disk/by-label/ESP...696machine # [ 8.037709] systemd[1]: Expecting device /dev/hvc0...697machine # [ 8.039070] systemd[1]: Expecting device /dev/ttyAMA0...698machine # [ 8.040510] systemd[1]: Reached target Local Encrypted Volumes.699machine # [ 8.042224] systemd[1]: Stopped target initrd-fs.target.700machine # [ 8.044332] systemd[1]: Stopped target initrd-root-fs.target.701machine # [ 8.045378] systemd[1]: Stopped target initrd-switch-root.target.702machine # [ 8.046914] systemd[1]: Reached target Virtual Machines and Containers.703machine # [ 8.049194] systemd[1]: Reached target Path Units.704machine # [ 8.050217] systemd[1]: Reached target Remote File Systems.705machine # [ 8.052324] systemd[1]: Reached target Slice Units.706machine # [ 8.053265] systemd[1]: Reached target Swaps.707machine # [ 8.057225] systemd[1]: Listening on Query the User Interactively for a Password.708machine # [ 8.061757] systemd[1]: Listening on Process Core Dump Socket.709machine # [ 8.065400] systemd[1]: Listening on Credential Encryption/Decryption.710machine # [ 8.068920] systemd[1]: Listening on Factory Reset Management.711machine # [ 8.070135] systemd[1]: Listening on Hostname Service Socket.712machine # [ 8.075301] systemd[1]: Starting Journal Log Access Socket...713machine # [ 8.077219] systemd[1]: Listening on Journal Audit Socket.714machine # [ 8.081061] systemd[1]: Listening on Console Output Muting Service Socket.715machine # [ 8.083325] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.716machine # [ 8.085848] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os717machine # [ 8.088127] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki718machine # [ 8.098675] systemd[1]: Listening on Disk Repartitioning Service Socket.719machine # [ 8.100025] systemd[1]: Listening on udev Varlink Socket.720machine # [ 8.104078] systemd[1]: Mounting Huge Pages File System...721machine # [ 8.108019] systemd[1]: Mounting POSIX Message Queue File System...722machine # [ 8.117964] systemd[1]: Mounting Kernel Debug File System...723machine # [ 8.127773] systemd[1]: Mounting Kernel Trace File System...724machine # [ 8.140140] systemd[1]: Starting Create List of Static Device Nodes...725machine # [ 8.149645] systemd[1]: Starting Load Kernel Module 9pnet_virtio...726machine # [ 8.153670] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs727machine # [ 8.168510] systemd[1]: Mounting Kernel Configuration File System...728machine # [ 8.170439] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm729machine # [ 8.174570] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore730machine # [ 8.176885] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 8.187406] systemd[1]: Mounting FUSE Control File System...732machine # [ 8.189715] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67733machine # [ 8.211989] systemd[1]: Starting Journal Service...734machine # [ 8.247850] systemd[1]: Starting Load Kernel Modules...735machine # [ 8.267641] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...736machine # [ 8.285107] systemd[1]: Starting Remount Root and Kernel File Systems...737machine # [ 8.288429] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os738machine # [ 8.359813] systemd[1]: Starting Coldplug All udev Devices...739machine # [ 8.380812] systemd-journald[273]: Collecting audit messages is enabled.740machine # [ 8.373963] systemd[1]: Queued start job for default target Multi-User System.741machine # [ 8.406577] systemd[1]: Listening on Journal Log Access Socket.742machine # [ 8.412199] systemd[1]: Started Journal Service.743machine # [ 8.386921] systemd[1]: systemd-journald.service: Deactivated successfully.744machine # [ 8.394590] systemd-modules-load[274]: Module 'atkbd' is built in745machine # [ 8.398734] systemd-modules-load[274]: Module 'loop' is built in746machine # [ 8.429700] EXT4-fs (vda2): re-mounted f222513b-ded1-49fa-b591-20ce86a2fe7f.747machine # [ 8.406524] systemd[1]: Mounted Huge Pages File System.748machine # [ 8.410240] systemd[1]: Mounted POSIX Message Queue File System.749machine # [ 8.414064] systemd[1]: Mounted Kernel Debug File System.750machine # [ 8.419932] systemd[1]: Mounted Kernel Trace File System.751machine # [ 8.424519] systemd[1]: Finished Create List of Static Device Nodes.752machine # [ 8.425559] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.753machine # [ 8.426702] systemd[1]: Finished Load Kernel Module 9pnet_virtio.754machine # [ 8.427650] systemd[1]: Mounted Kernel Configuration File System.755machine # [ 8.437651] systemd[1]: Finished Load Kernel Modules.756machine # [ 8.441764] systemd[1]: Mounted FUSE Control File System.757machine # [ 8.449229] systemd[1]: Finished Remount Root and Kernel File Systems.758machine # [ 8.462206] systemd[1]: Listening on Disk Image Download Service Socket.759machine # [ 8.464753] systemd-oomd[275]: No swap; memory pressure usage will be degraded760machine # [ 8.472778] systemd[1]: Starting Firewall...761machine # [ 8.475982] systemd[1]: Starting Flush Journal to Persistent Storage...762machine # [ 8.480233] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore763machine # [ 8.485376] systemd[1]: Starting Load/Save OS Random Seed...764machine # [ 8.506445] systemd[1]: Starting Apply Kernel Variables...765machine # [ 8.519467] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...766machine # [ 8.522886] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os767machine # [ 8.531513] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.768machine # [ 8.612812] systemd-journald[273]: Received client request to flush runtime journal.769machine # [ 8.646562] systemd[1]: Finished Load/Save OS Random Seed.770machine # [ 8.653116] systemd[1]: Reached target First Boot Complete.771machine # [ 8.661364] systemd[1]: Finished Flush Journal to Persistent Storage.772machine # [ 8.670935] systemd[1]: Finished Apply Kernel Variables.773machine # [ 8.697842] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.774machine # [ 8.702201] systemd[1]: Starting Create Static Device Nodes in /dev...775machine # [ 8.814314] systemd[1]: Finished Create Static Device Nodes in /dev.776machine # [ 8.816591] systemd[1]: Reached target Preparation for Local File Systems.777machine # [ 8.824519] systemd[1]: Starting Rule-based Manager for Device Events and Files...778machine # [ 8.964542] systemd-udevd[312]: Using default interface naming scheme 'v261'.779machine # [ 8.999819] systemd[1]: Mounting /run/wrappers...780machine # [ 9.069001] systemd[1]: Mounted /run/wrappers.781machine # [ 9.079981] systemd[1]: Starting Create SUID/SGID Wrappers...782machine # [ 9.209958] systemd[1]: Started Rule-based Manager for Device Events and Files.783machine # [ 9.913952] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.784machine # [ 9.917643] systemd[1]: Finished Create SUID/SGID Wrappers.785machine # [ 10.496346] systemd[1]: Finished Firewall.786machine # [ 10.524910] systemd[1]: Finished Coldplug All udev Devices.787machine # [ 10.565781] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs788machine # [ 10.583266] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse789machine # [ 10.729304] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.790machine # [ 10.739114] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.791machine # [ 10.763288] systemd[1]: Found device /dev/tpmrm0.792machine # [ 10.765329] systemd[1]: Expecting device /dev/tpm0...793machine # [ 10.794173] (udev-worker)[348]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.794machine # [ 10.799841] (udev-worker)[355]: Network interface NamePolicy= disabled on kernel command line.795machine # [ 10.803292] (udev-worker)[348]: Network interface NamePolicy= disabled on kernel command line.796machine # [ 10.949173] systemd[1]: Condition check resulted in Virtio network device being skipped.797machine # [ 10.954860] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore798machine # [ 10.961039] systemd[1]: Starting Create SUID/SGID Wrappers...799machine # [ 10.962724] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67800machine # [ 10.974878] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore801machine # [ 11.096402] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.802machine # [ 11.108808] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...803machine # [ 11.238476] systemd-fsck[493]: fsck.fat 4.2 (2021-01-31)804machine # [ 11.242648] systemd-fsck[493]: /dev/vda1: 20 files, 28697/63671 clusters805machine # [ 11.252155] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.806machine # [ 11.262100] systemd[1]: Mounting /boot...807machine # [ 11.392110] systemd[1]: Mounted /boot.808machine # [ 11.392897] systemd[1]: Reached target Local File Systems.809machine # [ 11.397369] systemd[1]: Listening on Boot Loader Control Service Socket.810machine # [ 11.404563] systemd[1]: Starting register-nix-paths.service...811machine # [ 11.412127] systemd[1]: Starting Update Boot Loader Random Seed...812machine # [ 11.431021] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 11.470345] systemd[1]: Starting Create System Files and Directories...814machine # [ 11.556998] systemd[1]: Finished register-nix-paths.service.815machine # [ 11.566183] bootctl[518]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 816machine # [ 11.571880] bootctl[518]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!817machine # [ 11.585113] bootctl[518]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).818machine # [ 11.595454] bootctl[518]: Successfully initialized system token in EFI variable with 32 bytes.819machine # [ 11.605836] systemd[1]: Finished Update Boot Loader Random Seed.820machine # [ 11.609417] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.821machine # [ 11.615366] systemd[1]: Finished Save Transient machine-id to Disk.822machine # [ 11.692168] mousedev: PS/2 mouse device common for all mice823machine # [ 11.670861] systemd[1]: Finished Create System Files and Directories.824machine # [ 11.681372] systemd[1]: Starting Rebuild Journal Catalog...825machine # [ 11.685871] systemd[1]: Starting Record System Boot/Shutdown in UTMP...826machine # [ 11.762663] systemd[1]: Finished Record System Boot/Shutdown in UTMP.827machine # [ 11.795898] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.828machine # [ 11.799922] systemd[1]: Finished Create SUID/SGID Wrappers.829machine # [ 11.815008] systemd[1]: Finished Rebuild Journal Catalog.830machine # [ 11.818913] systemd[1]: Starting Update is Completed...831machine # [ 11.867304] systemd[1]: Finished Update is Completed.832machine # [ 12.656023] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input3833machine # [ 12.690791] systemd[1]: Found device /dev/tpm0.834machine # [ 12.693404] systemd[1]: Reached target Trusted Platform Module.835machine # [ 12.695951] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os836machine # [ 12.700397] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os837machine # [ 12.704630] systemd[1]: Reached target System Initialization.838machine # [ 12.708866] systemd[1]: Started Discard unused filesystem blocks once a week.839machine # [ 12.710497] systemd[1]: Started Daily Cleanup of Temporary Directories.840machine # [ 12.716184] systemd[1]: Reached target Timer Units.841machine # [ 12.718055] systemd[1]: Listening on D-Bus System Message Bus Socket.842machine # [ 12.719762] systemd[1]: Listening on Nix Daemon Socket.843machine # [ 12.723212] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.844machine # [ 12.727250] systemd[1]: Reached target Socket Units.845machine # [ 12.731048] systemd[1]: Reached target Basic System.846machine # [ 12.735124] systemd[1]: Started backdoor.service.847machine # [ 12.740864] systemd[1]: Starting Import lastlog data into lastlog2 database...848machine # [ 12.744256] systemd[1]: Starting Name Service Cache Daemon (nsncd)...849machine # [ 12.756088] systemd[1]: Starting Post-Boot Actions...850machine # [ 12.778487] systemd[1]: Started Reset console on configuration changes.851machine # [ 12.809828] systemd[1]: Starting resolvconf update...852machine # connecting to host...853machine # [ 12.877722] systemd[1]: Starting D-Bus System Message Bus...854machine: Guest shell says: b'Spawning backdoor root shell...\n'855machine # [ 12.905149] systemd[1]: Finished Post-Boot Actions.856machine # [ 12.931949] nsncd[572]: Sep 03 02:47:32.775 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"857machine # [ 12.941835] systemd[1]: Started Name Service Cache Daemon (nsncd).858machine: connected to guest root shell859machine: (connecting took 27.08 seconds)860machine: (finished: waiting for the VM to finish booting, in 27.43 seconds)861machine # [ 12.950769] systemd[1]: Reached target Host and Network Name Lookups.862machine # [ 12.957129] systemd[1]: Reached target User and Group Name Lookups.863machine # [ 12.973929] systemd[1]: Starting User Login Management...864machine # [ 13.016590] systemd[1]: Finished Import lastlog data into lastlog2 database.865machine # [ 13.112212] dbus-broker-launch[581]: Looking up NSS user entry for 'systemd-timesync'...866machine # [ 13.171877] systemd-logind[601]: New seat seat0.867machine # [ 13.178589] systemd-logind[601]: Watching system buttons on /dev/input/event0 (Power Button)868machine # [ 13.184689] systemd-logind[601]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)869machine # [ 13.185920] systemd[1]: Started User Login Management.870machine # [ 13.202353] dbus-broker-launch[581]: NSS returned no entry for 'systemd-timesync'871machine # [ 13.205836] dbus-broker-launch[581]: Invalid user-name in /nix/store/2gnn03r6ndb5sk6k9z362cz6qgbzfiyb-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"872machine # [ 13.218057] systemd[1]: Starting linger-users.service...873machine # [ 13.255099] systemd[1]: Started D-Bus System Message Bus.874machine # [ 13.280250] systemd[1]: Stopped target Host and Network Name Lookups.875machine # [ 13.290052] systemd[1]: Stopping Host and Network Name Lookups...876machine # [ 13.293561] systemd[1]: Stopped target User and Group Name Lookups.877machine # [ 13.294496] systemd[1]: Stopping User and Group Name Lookups...878machine # [ 13.295301] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...879machine # [ 13.307535] systemd[1]: Starting Virtual Console Setup...880machine # [ 13.324374] dbus-broker-launch[581]: Ready881machine # [ 13.326885] systemd[1]: nscd.service: Deactivated successfully.882machine # [ 13.330536] systemd[1]: Stopped Name Service Cache Daemon (nsncd).883machine # [ 13.341636] systemd[1]: linger-users.service: Deactivated successfully.884machine # [ 13.349072] systemd[1]: Finished linger-users.service.885machine # [ 13.383501] systemd[1]: Starting Name Service Cache Daemon (nsncd)...886machine # [ 13.428534] systemd-logind[601]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)887machine # [ 13.434193] systemd[1]: Finished resolvconf update.888machine # [ 13.446952] systemd[1]: Reached target Preparation for Network.889machine # [ 13.453120] nsncd[668]: Sep 03 02:47:33.295 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"890machine # [ 13.458028] systemd[1]: Starting DHCP Client...891machine # [ 13.465606] systemd[1]: Starting Address configuration of eth1...892machine # [ 13.476369] systemd[1]: Starting Extra networking commands....893machine # [ 13.479368] systemd[1]: Started Name Service Cache Daemon (nsncd).894machine # [ 13.484905] systemd[1]: Reached target Host and Network Name Lookups.895machine # [ 13.488334] systemd[1]: Reached target User and Group Name Lookups.896machine # [ 13.595343] network-addresses-eth1-start[686]: adding address 192.168.1.1/24... done897machine # [ 13.616916] network-addresses-eth1-start[686]: adding address 2001:db8:1::1/64... done898machine # [ 13.642763] systemd[1]: Finished Address configuration of eth1.899machine # [ 13.695740] dhcpcd[695]: dhcpcd-10.3.2 starting900machine # [ 13.709285] dhcpcd[740]: dev: loaded udev901machine # [ 13.745575] systemd[1]: Finished Extra networking commands..902machine # [ 13.749223] systemd[1]: Reached target Network.903machine # [ 13.753215] systemd[1]: Starting Permit User Sessions...904machine # [ 13.785182] 8021q: 802.1Q VLAN Support v1.8905machine # [ 13.787620] 8021q: adding VLAN 0 to HW filter on device eth1906machine # [ 13.809446] systemd[1]: Finished Permit User Sessions.907machine # [ 13.815068] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.908machine # [ 13.821376] systemd[1]: Started Getty on tty1.909machine # [ 13.823842] systemd[1]: Reached target Login Prompts.910machine # [ 13.882746] cfg80211: Loading compiled-in X.509 certificates for regulatory database911machine # [ 13.912896] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'912machine # [ 13.913344] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'913machine # [ 13.917924] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2914machine # [ 13.918239] cfg80211: failed to load regulatory.db915machine # [ 13.980743] 8021q: adding VLAN 0 to HW filter on device eth0916machine # [ 13.952948] dhcpcd[740]: eth0: waiting for carrier917machine # [ 13.954558] dhcpcd[740]: eth0: carrier acquired918machine # [ 13.966382] dhcpcd[740]: DUID 00:01:00:01:32:2b:9c:45:52:54:00:12:34:56919machine # [ 13.967496] dhcpcd[740]: eth0: IAID 00:12:34:56920machine # [ 13.968470] dhcpcd[740]: eth0: adding address fe80::5054:ff:fe12:3456921machine # [ 14.013244] systemd-vconsole-setup[655]: Configuration of first virtual console was skipped, ignoring remaining ones.922machine # [ 14.017021] systemd[1]: Finished Virtual Console Setup.923machine # [ 14.453528] dhcpcd[740]: eth0: soliciting a DHCP lease924machine # [ 14.461362] dhcpcd[740]: eth0: offered 10.0.2.15 from 10.0.2.2925machine # [ 14.468394] dhcpcd[740]: eth0: probing address 10.0.2.15/24926machine # [ 15.864409] dhcpcd[740]: eth0: soliciting an IPv6 router927machine # [ 15.869132] dhcpcd[740]: eth0: Router Advertisement from fe80::2928machine # [ 15.871740] dhcpcd[740]: eth0: adding address fec0::5054:ff:fe12:3456/64929machine # [ 15.874628] dhcpcd[740]: eth0: adding route to fec0::/64930machine # [ 15.877021] dhcpcd[740]: eth0: adding default route via fe80::2931machine # [ 19.667796] dhcpcd[740]: eth0: leased 10.0.2.15 for 86400 seconds932machine # [ 19.671675] dhcpcd[740]: eth0: adding route to 10.0.2.0/24933machine # [ 19.674613] dhcpcd[740]: eth0: adding default route via 10.0.2.2934machine # [ 19.828373] systemd[1]: Started DHCP Client.935machine # [ 19.830265] systemd[1]: Reached target Multi-User System.936machine # [ 19.831453] systemd[1]: Startup finished in 7.166s (firmware) + 6.329s (loader) + 852ms (kernel) + 5.335s (initrd) + 13.642s (userspace) = 33.327s.937machine: (finished: waiting for unit multi-user.target, in 34.55 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.57 seconds)940machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot941machine # [ 23.203661] Key type trusted registered942machine # [ 23.208353] Key type encrypted registered943machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.66 seconds)944machine: must succeed: mkfs.ext4 /dev/mapper/cryptroot945machine # mke2fs 1.47.4 (6-Mar-2025)946machine: (finished: must succeed: mkfs.ext4 /dev/mapper/cryptroot, in 0.11 seconds)947machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat948machine # [ 23.453964] cat[915]: Successfully called mlockall().949machine # [ 23.454815] cat[915]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory950machine # [ 23.463539] cat[915]: Loaded shared library 'libcryptsetup.so.12' via dlopen().951machine # [ 23.465411] cat[915]: Allocating context for crypt device /dev/vdb.952machine # [ 23.467138] cat[915]: Trying to open device /dev/vdb with direct-io.953machine # [ 23.468261] cat[915]: Initialising device-mapper backend library.954machine # [ 23.469638] cat[915]: Trying to load LUKS2 crypt type from device /dev/vdb.955machine # [ 23.472103] cat[915]: Crypto backend (OpenSSL 3.6.3 9 Jun 2026 [default][legacy][threads][argon2]) initialized in cryptsetup library version 2.8.7.956machine # [ 23.473780] cat[915]: Detected kernel Linux 6.18.48 aarch64.957machine # [ 23.474579] cat[915]: Loading LUKS2 header (repair disabled).958machine # [ 23.475337] cat[915]: Acquiring read lock for device /dev/vdb.959machine # [ 23.476158] cat[915]: Opening lock resource file /run/cryptsetup/L_254:16960machine # [ 23.477440] cat[915]: Verifying lock handle for /dev/vdb.961machine # [ 23.478733] cat[915]: Device /dev/vdb READ lock taken.962machine # [ 23.484756] cat[915]: Trying to read primary LUKS2 header at offset 0x0.963machine # [ 23.485653] cat[915]: Opening locked device /dev/vdb964machine # [ 23.486354] cat[915]: Verifying locked device handle (bdev)965machine # [ 23.487105] cat[915]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.966machine # [ 23.492154] cat[915]: Checksum:3ce1d2590cf4ba40363ee34b365d20bb2e7c14c1a7fb1573370905e946915bbc (on-disk)967machine # [ 23.493399] cat[915]: Checksum:3ce1d2590cf4ba40363ee34b365d20bb2e7c14c1a7fb1573370905e946915bbc (in-memory)968machine # [ 23.494669] cat[915]: Trying to read secondary LUKS2 header at offset 0x4000.969machine # [ 23.495603] cat[915]: Reusing open ro fd on device /dev/vdb970machine # [ 23.500076] cat[915]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.971machine # [ 23.501082] cat[915]: Checksum:0dbb8d888f05829f6dfd584963a1e75316d60c2d627660ae815893bd46d63fe8 (on-disk)972machine # [ 23.502310] cat[915]: Checksum:0dbb8d888f05829f6dfd584963a1e75316d60c2d627660ae815893bd46d63fe8 (in-memory)973machine # [ 23.503552] cat[915]: Device size 536870912, offset 16777216.974machine # [ 23.508106] cat[915]: Device /dev/vdb READ lock released.975machine # [ 23.508854] cat[915]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1.976machine # [ 23.509870] cat[915]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 364006kB.977machine # [ 23.511156] cat[915]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 364006, parallel_threads 1.978machine # [ 23.520093] cat[915]: Requesting JSON for token 0.979machine # [ 23.520783] cat[915]: Requesting JSON for token 1.980machine # [ 23.521463] cat[915]: Requesting JSON for token 2.981machine # [ 23.522123] cat[915]: Requesting JSON for token 3.982machine # [ 23.522805] cat[915]: Requesting JSON for token 4.983machine # [ 23.523468] cat[915]: Requesting JSON for token 5.984machine # [ 23.528076] cat[915]: Requesting JSON for token 6.985machine # [ 23.528777] cat[915]: Requesting JSON for token 7.986machine # [ 23.529445] cat[915]: Requesting JSON for token 8.987machine # [ 23.530114] cat[915]: Requesting JSON for token 9.988machine # [ 23.530776] cat[915]: Requesting JSON for token 10.989machine # [ 23.531456] cat[915]: Requesting JSON for token 11.990machine # [ 23.536106] cat[915]: Requesting JSON for token 12.991machine # [ 23.536803] cat[915]: Requesting JSON for token 13.992machine # [ 23.537477] cat[915]: Requesting JSON for token 14.993machine # [ 23.538153] cat[915]: Requesting JSON for token 15.994machine # [ 23.538827] cat[915]: Requesting JSON for token 16.995machine # [ 23.539494] cat[915]: Requesting JSON for token 17.996machine # [ 23.544075] cat[915]: Requesting JSON for token 18.997machine # [ 23.544786] cat[915]: Requesting JSON for token 19.998machine # [ 23.545469] cat[915]: Requesting JSON for token 20.999machine # [ 23.546134] cat[915]: Requesting JSON for token 21.1000machine # [ 23.546822] cat[915]: Requesting JSON for token 22.1001machine # [ 23.547497] cat[915]: Requesting JSON for token 23.1002machine # [ 23.552149] cat[915]: Requesting JSON for token 24.1003machine # [ 23.552929] cat[915]: Requesting JSON for token 25.1004machine # [ 23.553596] cat[915]: Requesting JSON for token 26.1005machine # [ 23.554283] cat[915]: Requesting JSON for token 27.1006machine # [ 23.554958] cat[915]: Requesting JSON for token 28.1007machine # [ 23.555626] cat[915]: Requesting JSON for token 29.1008machine # [ 23.560158] cat[915]: Requesting JSON for token 30.1009machine # [ 23.560976] cat[915]: Requesting JSON for token 31.1010machine # [ 23.561649] cat[915]: Keyslot 0 priority 1 != 2 (required), skipped.1011machine # [ 23.562519] cat[915]: Trying to open LUKS2 keyslot 0.1012machine # [ 23.563218] cat[915]: Running keyslot key derivation.1013machine # [ 23.835365] cat[915]: Reading keyslot area [0x8000].1014machine # [ 23.837557] cat[915]: Acquiring read lock for device /dev/vdb.1015machine # [ 23.840158] cat[915]: Opening lock resource file /run/cryptsetup/L_254:161016machine # [ 23.841102] cat[915]: Verifying lock handle for /dev/vdb.1017machine # [ 23.841830] cat[915]: Device /dev/vdb READ lock taken.1018machine # [ 23.842539] cat[915]: Reusing open ro fd on device /dev/vdb1019machine # [ 23.843329] cat[915]: Device /dev/vdb READ lock released.1020machine # [ 23.847726] cat[915]: Verifying key from keyslot 0, digest 0.1021machine # [ 23.912939] cat[915]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory1022machine # [ 23.914370] cat[915]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory1023machine # [ 23.919257] cat[915]: Loaded shared library 'libtss2-esys.so.0' via dlopen().1024machine # [ 23.921317] cat[915]: Loaded shared library 'libtss2-rc.so.0' via dlopen().1025machine # [ 23.922401] cat[915]: Loaded shared library 'libtss2-mu.so.0' via dlopen().1026machine # [ 23.924461] cat[915]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen().1027machine # [ 23.925944] cat[915]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'.1028machine # [ 23.927493] cat[915]: Loaded 'libtss2-tcti-device.so.0' via dlopen()1029machine # [ 23.928870] cat[915]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2]1030machine # [ 23.931692] cat[915]: TPM successfully started up.1031machine # [ 23.932469] cat[915]: Getting TPM2 capability 0x0000 property 0x0001 count 127.1032machine # [ 23.933456] cat[915]: Getting TPM2 capability 0x0002 property 0x011f count 256.1033machine # [ 23.942600] cat[915]: Getting TPM2 capability 0x0008 property 0x0000 count 508.1034machine # [ 23.945050] cat[915]: Getting TPM2 capability 0x0005 property 0x0000 count 1.1035machine # [ 23.947511] cat[915]: Getting TPM2 capability 0x0006 property 0x012c count 1.1036machine # [ 23.952767] cat[915]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.452ms.1037machine # [ 23.953869] cat[915]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1038machine # [ 23.956263] cat[915]: TPM handle 0x81000001 not populated.1039machine # [ 23.958457] cat[915]: Creating primary key on TPM.1040machine # [ 23.969248] cat[915]: Successfully created primary key on TPM in 10ms.1041machine # [ 23.980005] cat[915]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1042machine # [ 24.016696] cat[915]: Starting HMAC encryption session.1043machine # [ 24.036736] cat[915]: Generating secret key data.1044machine # [ 24.040062] cat[915]: Creating HMAC key on TPM for shard 0.1045machine # [ 24.041054] cat[915]: Creating object on TPM.1046machine # [ 24.056509] cat[915]: Successfully created object on TPM in 18ms.1047machine # [ 24.059694] cat[915]: Marshalling private and public part of HMAC key for shard 0.1048machine # [ 24.060960] cat[915]: Completed TPM2 key sealing in 106.448ms.1049machine # [ 24.065197] cat[915]: Requesting JSON for token 0.1050machine # [ 24.066000] cat[915]: Requesting JSON for token 1.1051machine # [ 24.066761] cat[915]: Requesting JSON for token 2.1052machine # [ 24.067514] cat[915]: Requesting JSON for token 3.1053machine # [ 24.068514] cat[915]: Requesting JSON for token 4.1054machine # [ 24.069389] cat[915]: Requesting JSON for token 5.1055machine # [ 24.070229] cat[915]: Requesting JSON for token 6.1056machine # [ 24.071080] cat[915]: Requesting JSON for token 7.1057machine # [ 24.071926] cat[915]: Requesting JSON for token 8.1058machine # [ 24.074171] cat[915]: Requesting JSON for token 9.1059machine # [ 24.074953] cat[915]: Requesting JSON for token 10.1060machine # [ 24.076224] cat[915]: Requesting JSON for token 11.1061machine # [ 24.076991] cat[915]: Requesting JSON for token 12.1062machine # [ 24.079959] cat[915]: Requesting JSON for token 13.1063machine # [ 24.080795] cat[915]: Requesting JSON for token 14.1064machine # [ 24.081533] cat[915]: Requesting JSON for token 15.1065machine # [ 24.082276] cat[915]: Requesting JSON for token 16.1066machine # [ 24.083045] cat[915]: Requesting JSON for token 17.1067machine # [ 24.083779] cat[915]: Requesting JSON for token 18.1068machine # [ 24.089872] cat[915]: Requesting JSON for token 19.1069machine # [ 24.090643] cat[915]: Requesting JSON for token 20.1070machine # [ 24.092176] cat[915]: Requesting JSON for token 21.1071machine # [ 24.092878] cat[915]: Requesting JSON for token 22.1072machine # [ 24.093626] cat[915]: Requesting JSON for token 23.1073machine # [ 24.094352] cat[915]: Requesting JSON for token 24.1074machine # [ 24.095428] cat[915]: Requesting JSON for token 25.1075machine # [ 24.096162] cat[915]: Requesting JSON for token 26.1076machine # [ 24.098946] cat[915]: Requesting JSON for token 27.1077machine # [ 24.099668] cat[915]: Requesting JSON for token 28.1078machine # [ 24.100609] cat[915]: Requesting JSON for token 29.1079machine # [ 24.101330] cat[915]: Requesting JSON for token 30.1080machine # [ 24.103751] cat[915]: Requesting JSON for token 31.1081machine # [ 24.108091] cat[915]: PCR policy hash not yet enrolled, enrolling now.1082machine # [ 24.109098] cat[915]: Unsealing for verification...1083machine # [ 24.109777] cat[915]: Loading HMAC key into TPM for shard 0.1084machine # [ 24.110546] cat[915]: Loading object into TPM.1085machine # [ 24.111151] cat[915]: Starting HMAC encryption session.1086machine # [ 24.111844] cat[915]: Starting policy session.1087machine # [ 24.135458] cat[915]: Building sealing policy.1088machine # [ 24.136359] cat[915]: Acquiring policy digest.1089machine # [ 24.156825] cat[915]: Session policy digest: 00000000000000000000000000000000000000000000000000000000000000001090machine # [ 24.160049] cat[915]: Unsealing HMAC key for shard 0.1091machine # [ 24.228082] cat[915]: Completed TPM2 key unsealing in 158.231ms.1092machine # [ 24.229303] cat[915]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000).1093machine # [ 24.230480] cat[915]: Adding new keyslot -1 by passphrase, volume key provided by key (-1).1094machine # [ 24.231865] cat[915]: Selected keyslot 1.1095machine # [ 24.299357] cat[915]: Keyslot 1 assigned to digest 0.1096machine # [ 24.300694] cat[915]: Trying to allocate LUKS2 keyslot 1.1097machine # [ 24.304091] cat[915]: Found area 290816 -> 5488641098machine # [ 24.304827] cat[915]: Reusing PBKDF values (no benchmark flag is set).1099machine # [ 24.305705] cat[915]: Calculating attributes for LUKS2 keyslot 1.1100machine # [ 24.306532] cat[915]: Acquiring write lock for device /dev/vdb.1101machine # [ 24.307328] cat[915]: Opening lock resource file /run/cryptsetup/L_254:161102machine # [ 24.311762] cat[915]: Verifying lock handle for /dev/vdb.1103machine # [ 24.312574] cat[915]: Device /dev/vdb WRITE lock taken.1104machine # [ 24.313293] cat[915]: Checking context sequence id matches value stored on disk.1105machine # [ 24.314284] cat[915]: Reusing open ro fd on device /dev/vdb1106machine # [ 24.315083] cat[915]: Running keyslot key derivation.1107machine # [ 24.316261] cat[915]: Updating keyslot area [0x47000].1108machine # [ 24.317408] cat[915]: Opening locked device /dev/vdb1109machine # [ 24.318415] cat[915]: Verifying locked device handle (bdev)1110machine # [ 24.319317] cat[915]: Device size 536870912, offset 16777216.1111machine # [ 24.320321] cat[915]: Device /dev/vdb WRITE lock already held.1112machine # [ 24.321334] cat[915]: Trying to write LUKS2 header (1039 bytes) at offset 0.1113machine # [ 24.322377] cat[915]: Reusing open rw fd on device /dev/vdb1114machine # [ 24.323252] cat[915]: Checksum:d8939748e14b532df08857b6179a8d6199915d861cb8406b71d593b6632fd2f5 (in-memory)1115machine # [ 24.324869] cat[915]: Trying to write LUKS2 header (1039 bytes) at offset 16384.1116machine # [ 24.326466] cat[915]: Reusing open rw fd on device /dev/vdb1117machine # [ 24.327401] cat[915]: Checksum:14ad700990cc90941d7afa4544a43c00d46ed875cfd5bc9efbe7107436b9def5 (in-memory)1118machine # [ 24.328919] cat[915]: Device /dev/vdb WRITE lock released.1119machine # [ 24.329758] cat[915]: Unknown hash algorithm id 0x01120machine # [ 24.330718] cat[915]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AINBOaEK4R43TfbEBDVV7tc7qiMFALCGq7vXvLLdDxMBxABDKAzm4ZtxT2uHOKLTxJixFeTOkt9Wa4bZEzKveEopZo61XxX+M9Fp1XSIbxxAP57imsat/MH669Kk7g1qcwxw1fbQYaeI0dxpxgpXbNvD3VEaba1Z3fVrWaI9P1coW1I0P5NfIMg4a4vdr3MZLpqu/qonFJ5LdStyylgBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAICegPNTdYdFl4louH/u3BCeTvSqPIN9CEsBRDKstO+jE","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAvjNe37umCy4r4AxmXnOdMhKBsg+YjWa3CAxlbkiYFWwgAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAINTDv9KPp7XfmF9rTojGoLbw0OjwbtsNR+2iIgTD/Gx8ACAsK978AhEQ1bGCpTr1AhI8oGHn73P2YDpj/70FOqvrjg=="}>1121machine # [ 24.354027] cat[915]: Updating JSON for token -1.1122machine # [ 24.354776] cat[915]: Trying to load libcryptsetup-token-systemd-tpm2.so.1123machine # [ 24.355776] cat[915]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0.1124machine # [ 24.358738] [915]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0.1125machine # [ 24.362312] [915]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0.1126machine # [ 24.364645] [915]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0.1127machine # [ 24.365601] [915]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0.1128machine # [ 24.366580] [915]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0.1129machine # [ 24.367544] [915]: Token handler systemd-tpm2-1.0 systemd-v262~rc1 (262-2451b1a) loaded successfully.1130machine # [ 24.374040] [915]: Device size 536870912, offset 16777216.1131machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 0.97 seconds)1132machine # [ 24.374811] [915]: Acquiring write lock for device /dev/vdb.1133machine: must succeed: /nix/store/qv8jnzk5i2z4yaa39sx5yhcb6vrmhzfj-nixos-system-machine-test/bin/switch-to-configuration boot1134machine # [ 24.375513] [915]: Opening lock resource file /run/cryptsetup/L_254:161135machine # [ 24.376414] [915]: Verifying lock handle for /dev/vdb.1136machine # [ 24.377069] [915]: Device /dev/vdb WRITE lock taken.1137machine # [ 24.377690] [915]: Checking context sequence id matches value stored on disk.1138machine # [ 24.378590] [915]: Reusing open ro fd on device /dev/vdb1139machine # [ 24.379251] [915]: Trying to write LUKS2 header (1742 bytes) at offset 0.1140machine # [ 24.380165] [915]: Reusing open rw fd on device /dev/vdb1141machine # [ 24.380829] [915]: Checksum:8b82877549037d6e195b9fb35e9b3dd1098398f58dc145b8a21defed796bdf35 (in-memory)1142machine # [ 24.381950] [915]: Trying to write LUKS2 header (1742 bytes) at offset 16384.1143machine # [ 24.382818] [915]: Reusing open rw fd on device /dev/vdb1144machine # [ 24.383477] [915]: Checksum:4b60f629d338d2efa6244491e6813ba997edd4d6e61847de8cecc4babfd52eeb (in-memory)1145machine # [ 24.384664] [915]: Device /dev/vdb WRITE lock released.1146machine # [ 24.385308] [915]: New TPM2 token enrolled as key slot 1.1147machine # [ 24.387180] [915]: Releasing crypt device /dev/vdb context.1148machine # [ 24.388086] [915]: Releasing device-mapper backend.1149machine # [ 24.388800] [915]: Closing read only fd for /dev/vdb.1150machine # [ 24.389607] [915]: Closing read write fd for /dev/vdb.1151machine # [ 24.390360] [915]: 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/qv8jnzk5i2z4yaa39sx5yhcb6vrmhzfj-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.95 seconds)1156machine: must succeed: sync1157machine: (finished: must succeed: sync, in 0.03 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 98)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\vl7vzvj7k3gnz41jbngb1q3aqq28lmid-initrd-linux-6.18.48-initrd.efi init=/nix/store/qv8jnzk5i2z4yaa39sx5yhcb6vrmhzfj-nixos-system-machine-test/init console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf1252machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1253machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1254machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1255machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1256machine # [ 0.000000] software IO TLB: area num 1.1257machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1258machine # [ 0.000000] Fallback order for Node 0: 01259machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441260machine # [ 0.000000] Policy zone: DMA1261machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1262machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11263machine # [ 0.000000] allocated 2097152 bytes of page_ext1264machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages1265machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1266machine # [ 0.000000] rcu: Hierarchical RCU implementation.1267machine # [ 0.000000] rcu: RCU event tracing is enabled.1268machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1269machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1270machine # [ 0.000000] Rude variant of Tasks RCU enabled.1271machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1272machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1273machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11274machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1275machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1276machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1277machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01278machine # [ 0.000000] GICv3: 256 SPIs implemented1279machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1280machine # [ 0.000000] Root IRQ handler: gic_handle_irq1281machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1282machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01283machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001284machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1285machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)1286machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)1287machine # [ 0.000000] GICv3: using LPI property table @0x00000000409100001288machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000409200001289machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1290machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1291machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1292machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1293machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1294machine # [ 0.000034] arm-pv: using stolen time PV1295machine # [ 0.000408] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1296machine # [ 0.000500] Console: colour dummy device 80x251297machine # [ 0.000505] printk: legacy console [tty0] enabled1298machine # [ 0.000717] ACPI: Core revision 202508071299machine # [ 0.000789] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1300machine # [ 0.000796] pid_max: default: 32768 minimum: 3011301machine # [ 0.000855] LSM: initializing lsm=capability,landlock,yama,bpf,ima1302machine # [ 0.000987] landlock: Up and running.1303machine # [ 0.000990] Yama: becoming mindful.1304machine # [ 0.001422] LSM support for eBPF active1305machine # [ 0.001516] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1306machine # [ 0.001524] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1307machine # [ 0.002601] rcu: Hierarchical SRCU implementation.1308machine # [ 0.002606] rcu: Max phase no-delay instances is 1000.1309machine # [ 0.003253] fsl-mc MSI: ITS@0x8080000 domain created1310machine # [ 0.003273] Remapping and enabling EFI services.1311machine # [ 0.003388] smp: Bringing up secondary CPUs ...1312machine # [ 0.003397] smp: Brought up 1 node, 1 CPU1313machine # [ 0.003401] SMP: Total of 1 processors activated.1314machine # [ 0.003403] CPU: All CPU(s) started at EL11315machine # [ 0.003414] CPU features: detected: Branch Target Identification1316machine # [ 0.003418] CPU features: detected: ARMv8.4 Translation Table Level1317machine # [ 0.003421] CPU features: detected: Instruction cache invalidation not required for I/D coherence1318machine # [ 0.003425] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1319machine # [ 0.003429] CPU features: detected: Common not Private translations1320machine # [ 0.003432] CPU features: detected: CRC32 instructions1321machine # [ 0.003434] CPU features: detected: Data cache clean to Point of Deep Persistence1322machine # [ 0.003438] CPU features: detected: Data cache clean to Point of Persistence1323machine # [ 0.003441] CPU features: detected: Data independent timing control (DIT)1324machine # [ 0.003444] CPU features: detected: E0PD1325machine # [ 0.003447] CPU features: detected: Enhanced Counter Virtualization1326machine # [ 0.003450] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1327machine # [ 0.003454] CPU features: detected: Enhanced Virtualization Traps1328machine # [ 0.003457] CPU features: detected: Fine Grained Traps1329machine # [ 0.003460] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1330machine # [ 0.003465] CPU features: detected: RCpc load-acquire (LDAPR)1331machine # [ 0.003468] CPU features: detected: LSE atomic instructions1332machine # [ 0.003471] CPU features: detected: Privileged Access Never1333machine # [ 0.003474] CPU features: detected: PMUv31334machine # [ 0.003477] CPU features: detected: RAS Extension Support1335machine # [ 0.003480] CPU features: detected: RASv1p1 Extension Support1336machine # [ 0.003483] CPU features: detected: Random Number Generator1337machine # [ 0.003485] CPU features: detected: Speculation barrier (SB)1338machine # [ 0.003488] CPU features: detected: Stage-2 Force Write-Back1339machine # [ 0.003491] CPU features: detected: TLB range maintenance instructions1340machine # [ 0.003496] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1341machine # [ 0.003534] alternatives: applying system-wide alternatives1342machine # [ 0.006261] CPU features: detected: BBM Level 2 without TLB conflict abort1343machine # [ 0.006369] Memory: 887256K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120044K reserved, 32768K cma-reserved)1344machine # [ 0.006626] devtmpfs: initialized1345machine # [ 0.007506] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1346machine # [ 0.007516] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1347machine # [ 0.007688] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1348machine # [ 0.007692] 0 pages in range for non-PLT usage1349machine # [ 0.007693] 508288 pages in range for PLT usage1350machine # [ 0.007774] pinctrl core: initialized pinctrl subsystem1351machine # [ 0.008348] SMBIOS 3.0.0 present.1352machine # [ 0.008354] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/20221353machine # [ 0.008362] DMI: Memory slots populated: 1/11354machine # [ 0.009664] NET: Registered PF_NETLINK/PF_ROUTE protocol family1355machine # [ 0.010289] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1356machine # [ 0.010426] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1357machine # [ 0.010581] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1358machine # [ 0.010599] audit: initializing netlink subsys (disabled)1359machine # [ 0.010991] thermal_sys: Registered thermal governor 'fair_share'1360machine # [ 0.010993] thermal_sys: Registered thermal governor 'bang_bang'1361machine # [ 0.010997] thermal_sys: Registered thermal governor 'step_wise'1362machine # [ 0.011000] thermal_sys: Registered thermal governor 'user_space'1363machine # [ 0.011003] thermal_sys: Registered thermal governor 'power_allocator'1364machine # [ 0.011027] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=11365machine # [ 0.011039] cpuidle: using governor ladder1366machine # [ 0.011047] cpuidle: using governor menu1367machine # [ 0.011206] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1368machine # [ 0.011227] ASID allocator initialised with 65536 entries1369machine # [ 0.011967] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51370machine # [ 0.012161] Serial: AMBA PL011 UART driver1371machine # [ 0.018542] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1372machine # [ 0.018548] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1373machine # [ 0.018552] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1374machine # [ 0.018554] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1375machine # [ 0.018557] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1376machine # [ 0.018560] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1377machine # [ 0.018563] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1378machine # [ 0.018565] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1379machine # [ 0.019355] fbcon: Taking over console1380machine # [ 0.019389] ACPI: Added _OSI(Module Device)1381machine # [ 0.019393] ACPI: Added _OSI(Processor Device)1382machine # [ 0.019395] ACPI: Added _OSI(Processor Aggregator Device)1383machine # [ 0.020413] ACPI: 1 ACPI AML tables successfully acquired and loaded1384machine # [ 0.026420] ACPI: Interpreter enabled1385machine # [ 0.026425] ACPI: Using GIC for interrupt routing1386machine # [ 0.026449] ACPI: MCFG table detected, 1 entries1387machine # [ 0.030312] ACPI: CPU0 has been hot-added1388machine # [ 0.030727] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA1389machine # [ 0.030800] printk: console [ttyAMA0] enabled1390machine # [ 0.098261] ACPI: PCI: Interrupt link L000 configured for IRQ 351391machine # [ 0.098277] ACPI: PCI: Interrupt link L001 configured for IRQ 361392machine # [ 0.098290] ACPI: PCI: Interrupt link L002 configured for IRQ 371393machine # [ 0.098302] ACPI: PCI: Interrupt link L003 configured for IRQ 381394machine # [ 0.098320] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1395machine # [ 0.098360] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1396machine # [ 0.098459] acpi PNP0A08:00: _OSC: platform does not support [LTR]1397machine # [ 0.098556] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]1398machine # [ 0.098784] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:001399machine # [ 0.098803] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1400machine # [ 0.098826] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]1401machine # [ 0.099174] PCI host bridge to bus 0000:001402machine # [ 0.099202] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]1403machine # [ 0.099207] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]1404machine # [ 0.099210] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]1405machine # [ 0.099215] pci_bus 0000:00: root bus resource [bus 00-ff]1406machine # [ 0.099219] PCI: OF: of_root node is NULL, cannot create PCI host bridge node1407machine # [ 0.099275] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1408machine # [ 0.099751] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1409machine # [ 0.099929] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]1410machine # [ 0.099941] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]1411machine # [ 0.099966] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]1412machine # [ 0.099978] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]1413machine # [ 0.100467] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1414machine # [ 0.101391] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]1415machine # [ 0.101404] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]1416machine # [ 0.101429] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]1417machine # [ 0.102040] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1418machine # [ 0.102217] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]1419machine # [ 0.102228] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]1420machine # [ 0.102253] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]1421machine # [ 0.102759] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1422machine # [ 0.102938] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]1423machine # [ 0.102949] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]1424machine # [ 0.102974] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]1425machine # [ 0.213248] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1426machine # [ 0.213440] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]1427machine # [ 0.213457] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]1428machine # [ 0.213488] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]1429machine # [ 0.213976] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1430machine # [ 0.214761] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]1431machine # [ 0.214781] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]1432machine # [ 0.214812] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]1433machine # [ 0.215414] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1434machine # [ 0.215599] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]1435machine # [ 0.215618] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]1436machine # [ 0.215651] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]1437machine # [ 0.216156] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1438machine # [ 0.216347] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]1439machine # [ 0.216364] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]1440machine # [ 0.216395] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]1441machine # [ 0.216413] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]1442machine # [ 0.230061] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1443machine # [ 0.231469] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]1444machine # [ 0.231506] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]1445machine # [ 0.232021] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1446machine # [ 0.232208] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]1447machine # [ 0.232239] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]1448machine # [ 0.232695] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1449machine # [ 0.233376] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]1450machine # [ 0.233675] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1451machine # [ 0.243160] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]1452machine # [ 0.243184] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]1453machine # [ 0.243215] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]1454machine # [ 0.243730] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1455machine # [ 0.244592] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]1456machine # [ 0.244612] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]1457machine # [ 0.244642] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]1458machine # [ 0.245267] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1459machine # [ 0.245279] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1460machine # [ 0.245287] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1461machine # [ 0.245331] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1462machine # [ 0.245377] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1463machine # [ 0.245423] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1464machine # [ 0.245474] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1465machine # [ 0.245522] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1466machine # [ 0.245570] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1467machine # [ 0.245617] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1468machine # [ 0.245664] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1469machine # [ 0.262034] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1470machine # [ 0.262091] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1471machine # [ 0.262137] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1472machine # [ 0.262182] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1473machine # [ 0.262205] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1474machine # [ 0.262227] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1475machine # [ 0.262249] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1476machine # [ 0.262272] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1477machine # [ 0.262294] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1478machine # [ 0.262317] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1479machine # [ 0.262339] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1480machine # [ 0.262362] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1481machine # [ 0.262852] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1482machine # [ 0.262877] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned1483machine # [ 0.263373] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1484machine # [ 0.263398] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1485machine # [ 0.263419] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1486machine # [ 0.278402] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned1487machine # [ 0.278430] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned1488machine # [ 0.278452] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned1489machine # [ 0.279042] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned1490machine # [ 0.279067] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned1491machine # [ 0.279607] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned1492machine # [ 0.279632] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned1493machine # [ 0.279655] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned1494machine # [ 0.279677] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned1495machine # [ 0.280213] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]1496machine # [ 0.280226] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]1497machine # [ 0.280232] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]1498machine # [ 0.292978] iommu: Default domain type: Translated1499machine # [ 0.292998] iommu: DMA domain TLB invalidation policy: strict mode1500machine # [ 0.294530] SCSI subsystem initialized1501machine # [ 0.295155] ACPI: bus type USB registered1502machine # [ 0.295199] usbcore: registered new interface driver usbfs1503machine # [ 0.295220] usbcore: registered new interface driver hub1504machine # [ 0.295237] usbcore: registered new device driver usb1505machine # [ 0.295450] pps_core: LinuxPPS API ver. 1 registered1506machine # [ 0.295458] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1507machine # [ 0.295469] PTP clock support registered1508machine # [ 0.295511] EDAC MC: Ver: 3.0.01509machine # [ 0.300683] scmi_core: SCMI protocol bus registered1510machine # [ 0.301382] efivars: Registered efivars operations1511machine # [ 0.302340] FPGA manager framework1512machine # [ 0.303206] vgaarb: loaded1513machine # [ 0.303775] clocksource: Switched to clocksource arch_sys_counter1514machine # [ 0.304076] VFS: Disk quotas dquot_6.6.01515machine # [ 0.304104] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1516machine # [ 0.307655] netfs: FS-Cache loaded1517machine # [ 0.307763] pnp: PnP ACPI init1518machine # [ 0.308728] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved1519machine # [ 0.308782] pnp: PnP ACPI: found 1 devices1520machine # [ 0.313137] NET: Registered PF_INET protocol family1521machine # [ 0.313194] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1522machine # [ 0.332404] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1523machine # [ 0.332443] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1524machine # [ 0.332467] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1525machine # [ 0.332508] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1526machine # [ 0.332584] TCP: Hash tables configured (established 8192 bind 8192)1527machine # [ 0.332650] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1528machine # [ 0.332681] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1529machine # [ 0.332706] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1530machine # [ 0.332781] NET: Registered PF_UNIX/PF_LOCAL protocol family1531machine # [ 0.332807] NET: Registered PF_XDP protocol family1532machine # [ 0.333476] PCI: CLS 0 bytes, default 641533machine # [ 0.333673] Trying to unpack rootfs image as initramfs...1534machine # [ 0.349261] kvm [1]: HYP mode not available1535machine # [ 0.440860] Initialise system trusted keyrings1536machine # [ 0.441582] workingset: timestamp_bits=42 max_order=18 bucket_order=01537machine # [ 0.442802] squashfs: version 4.0 (2009/01/31) Phillip Lougher1538machine # [ 0.443564] 9p: Installing v9fs 9p2000 file system support1539machine # [ 0.472262] Key type asymmetric registered1540machine # [ 0.472288] Asymmetric key parser 'x509' registered1541machine # [ 0.472356] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1542machine # [ 0.474426] io scheduler mq-deadline registered1543machine # [ 0.474439] io scheduler kyber registered1544machine # [ 0.483853] ledtrig-cpu: registered to indicate activity on CPUs1545machine # [ 0.485806] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input01546machine # [ 0.485873] ACPI: button: Power Button [PWRB]1547machine # [ 0.513885] ACPI: \_SB_.L001: Enabled at IRQ 361548machine # [ 0.513937] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1549machine # [ 0.516176] ACPI: \_SB_.L002: Enabled at IRQ 371550machine # [ 0.516213] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)1551machine # [ 0.517755] ACPI: \_SB_.L003: Enabled at IRQ 381552machine # [ 0.517787] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1553machine # [ 0.528012] ACPI: \_SB_.L000: Enabled at IRQ 351554machine # [ 0.528071] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1555machine # [ 0.530426] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1556machine # [ 0.540496] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)1557machine # [ 0.542770] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1558machine # [ 0.544990] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)1559machine # [ 0.556113] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1560machine # [ 0.558342] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)1561machine # [ 0.568152] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)1562machine # [ 0.576516] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1563machine # [ 0.578871] msm_serial: driver initialized1564machine # [ 0.578997] SuperH (H)SCI(F) driver initialized1565machine # [ 0.579036] STM32 USART driver initialized1566machine # [ 0.605878] ACPI: bus type drm_connector registered1567machine # [ 0.613063] loop: module loaded1568machine # [ 0.613241] virtio_blk virtio5: 1/0/0 default/read/poll queues1569machine # [ 0.613896] virtio_blk virtio5: [vda] 4927488 512-byte logical blocks (2.52 GB/2.35 GiB)1570machine # [ 0.655835] vda: vda1 vda21571machine # [ 0.656207] virtio_blk virtio6: 1/0/0 default/read/poll queues1572machine # [ 0.656893] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1573machine # [ 0.660548] megasas: 07.734.00.00-rc11574machine # [ 0.662890] tun: Universal TUN/TAP device driver, 1.61575machine # [ 0.665584] thunder_xcv, ver 1.01576machine # [ 0.665631] thunder_bgx, ver 1.01577machine # [ 0.665656] nicpf, ver 1.01578machine # [ 0.666203] e1000: Intel(R) PRO/1000 Network Driver1579machine # [ 0.666211] e1000: Copyright (c) 1999-2006 Intel Corporation.1580machine # [ 0.666239] e1000e: Intel(R) PRO/1000 Network Driver1581machine # [ 0.666246] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1582machine # [ 0.666281] igb: Intel(R) Gigabit Ethernet Network Driver1583machine # [ 0.666289] igb: Copyright (c) 2007-2014 Intel Corporation.1584machine # [ 0.666313] igbvf: Intel(R) Gigabit Virtual Function Network Driver1585machine # [ 0.666321] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1586machine # [ 0.666453] sky2: driver version 1.301587machine # [ 0.668678] ehci-pci 0000:00:0b.0: EHCI Host Controller1588machine # [ 0.668722] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 11589machine # [ 0.668995] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a0001590machine # [ 0.679415] usbcore: registered new interface driver usb-storage1591machine # [ 0.679546] usbcore: registered new interface driver usbserial_generic1592machine # [ 0.679562] usbserial: USB Serial support registered for generic1593machine # [ 0.682204] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.001594machine # [ 0.682559] hub 1-0:1.0: USB hub found1595machine # [ 0.682584] hub 1-0:1.0: 6 ports detected1596machine # [ 0.683345] hv_vmbus: registering driver hyperv_keyboard1597machine # [ 0.686205] rtc-efi rtc-efi.0: registered as rtc01598machine # [ 0.686243] rtc-efi rtc-efi.0: setting system clock to 2026-09-03T02:47:59 UTC (1788403679)1599machine # [ 0.686558] i2c_dev: i2c /dev entries driver1600machine # [ 0.691084] sdhci: Secure Digital Host Controller Interface driver1601machine # [ 0.691098] sdhci: Copyright(c) Pierre Ossman1602machine # [ 0.691338] Synopsys Designware Multimedia Card Interface Driver1603machine # [ 0.691667] sdhci-pltfm: SDHCI platform and OF driver helper1604machine # [ 0.700838] pstore: Using crash dump compression: deflate1605machine # [ 0.700855] pstore: Registered efi_pstore as persistent store backend1606machine # [ 0.701754] hid: raw HID events driver (C) Jiri Kosina1607machine # [ 0.702043] usbcore: registered new interface driver usbhid1608machine # [ 0.702051] usbhid: USB HID core driver1609machine # [ 0.706340] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available1610machine # [ 0.707714] drop_monitor: Initializing network drop monitor service1611machine # [ 0.707897] NET: Registered PF_INET6 protocol family1612machine # [ 0.720079] Segment Routing with IPv61613machine # [ 0.720112] In-situ OAM (IOAM) with IPv61614machine # [ 0.720145] NET: Registered PF_PACKET protocol family1615machine # [ 0.721816] 9pnet: Installing 9P2000 support1616machine # [ 0.723959] Key type dns_resolver registered1617machine # [ 0.738394] registered taskstats version 11618machine # [ 0.738549] Loading compiled-in X.509 certificates1619machine # [ 0.756930] Demotion targets for Node 0: null1620machine # [ 0.757648] Key type .fscrypt registered1621machine # [ 0.757661] Key type fscrypt-provisioning registered1622machine # [ 0.757758] ima: No TPM chip found, activating TPM-bypass!1623machine # [ 0.757780] ima: Allocated hash algorithm: sha11624machine # [ 0.757801] ima: No architecture policies found1625machine # [ 0.792831] clk: Disabling unused clocks1626machine # [ 0.792853] PM: genpd: Disabling unused power domains1627machine # [ 0.877541] Freeing initrd memory: 26048K1628machine # [ 0.880950] Freeing unused kernel memory: 4736K1629machine # [ 0.881155] Run /init as init process1630machine # [ 0.898252] fuse: init (API version 7.45)1631machine # [ 0.911536] systemd[1]: Successfully made /usr/ read-only.1632machine # [ 0.927816] usb 1-1: new high-speed USB device number 2 using ehci-pci1633machine # [ 1.080033] 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.152196] 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.246452] systemd[1]: systemd 262-2451b1a 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.257999] systemd[1]: Detected virtualization kvm.1637machine # [ 1.259985] systemd[1]: Detected architecture arm64.1638machine # [ 1.261837] systemd[1]: Running in initrd.1639machine # [ 1.264525] systemd[1]: Initializing machine ID from random generator.1640machine # [ 1.267231] systemd[1]: Hostname set to <machine>.1641machine # [ 1.275897] usb 1-2: new high-speed USB device number 3 using ehci-pci1642machine # [ 1.412390] systemd[1]: bpf-restrict-fs: LSM BPF program attached1643machine # [ 1.434658] 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.436337] 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.475202] systemd[1]: Queued start job for default target Initrd Default Target.1646machine # [ 1.485599] systemd[1]: Created slice Slice /system/modprobe.1647machine # [ 1.486883] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1648machine # [ 1.487811] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1649machine # [ 1.488861] systemd[1]: Expecting device /dev/mapper/cryptroot...1650machine # [ 1.489622] systemd[1]: Expecting device /dev/tpm0...1651machine # [ 1.490255] systemd[1]: Expecting device /dev/tpmrm0...1652machine # [ 1.490905] systemd[1]: Expecting device /dev/vdb...1653machine # [ 1.491539] systemd[1]: Reached target Path Units.1654machine # [ 1.492199] systemd[1]: Reached target Slice Units.1655machine # [ 1.492824] systemd[1]: Reached target Swaps.1656machine # [ 1.493376] systemd[1]: Reached target Timer Units.1657machine # [ 1.494126] systemd[1]: Listening on D-Bus System Message Bus Socket.1658machine # [ 1.495126] systemd[1]: Listening on Journal Socket (/dev/log).1659machine # [ 1.495999] systemd[1]: Listening on Journal Sockets.1660machine # [ 1.496716] systemd[1]: Listening on udev Kernel Socket.1661machine # [ 1.497393] systemd[1]: Reached target Socket Units.1662machine # [ 1.499223] systemd[1]: Starting Create List of Static Device Nodes...1663machine # [ 1.506958] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1664machine # [ 1.507938] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1665machine # [ 1.520115] systemd[1]: Mounting Kernel Configuration File System...1666machine # [ 1.531932] systemd[1]: Starting Journal Service...1667machine # [ 1.538997] systemd[1]: Starting Load Kernel Modules...1668machine # [ 1.556085] systemd[1]: Starting Coldplug All udev Devices...1669machine # [ 1.562983] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1670machine # [ 1.569833] systemd[1]: Finished Create List of Static Device Nodes.1671machine # [ 1.570694] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1672machine # [ 1.575951] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1673machine # [ 1.576437] systemd[1]: Mounted Kernel Configuration File System.1674machine # [ 1.578833] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1675machine # [ 1.587482] [drm] pci: virtio-gpu-pci detected at 0000:00:09.01676machine # [ 1.587711] [drm] features: -virgl +edid -resource_blob -host_visible1677machine # [ 1.587719] [drm] features: -context_init1678machine # [ 1.588192] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1679machine # [ 1.608802] [drm] number of scanouts: 11680machine # [ 1.608830] [drm] number of cap sets: 01681machine # [ 1.610552] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic1682machine # [ 1.610570] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 01683machine # [ 1.622677] systemd-journald[72]: Collecting audit messages is disabled.1684machine # [ 1.628603] Console: switching to colour frame buffer device 160x501685machine # [ 1.640351] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1686machine # [ 1.644079] systemd[1]: Starting Create Static Device Nodes in /dev...1687machine # [ 1.656421] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device1688machine # [ 1.672027] systemd[1]: Finished Load Kernel Modules.1689machine # [ 1.674991] systemd[1]: Starting Apply Kernel Variables...1690machine # [ 1.700170] systemd[1]: Finished Create Static Device Nodes in /dev.1691machine # [ 1.700443] systemd[1]: Reached target Preparation for Local File Systems.1692machine # [ 1.700479] systemd[1]: Reached target Local File Systems.1693machine # [ 1.708268] systemd[1]: Starting Rule-based Manager for Device Events and Files...1694machine # [ 1.736101] systemd[1]: Finished Apply Kernel Variables.1695machine # [ 1.778940] systemd[1]: Started Journal Service.1696machine # [ 1.768242] systemd-modules-load[73]: Inserted module 'dm_mod'1697machine # [ 1.769290] systemd-modules-load[73]: Module 'virtio_balloon' is built in1698machine # [ 1.770336] systemd-modules-load[73]: Module 'virtio_console' is built in1699machine # [ 1.771350] systemd-modules-load[73]: Inserted module 'virtio_gpu'1700machine # [ 1.785063] systemd-modules-load[73]: Module 'virtio_rng' is built in1701machine # [ 1.786351] systemd-udevd[80]: Using default interface naming scheme 'v261'.1702machine # [ 1.787437] systemd[1]: Starting Create System Files and Directories...1703machine # [ 1.801696] systemd[1]: Finished Create System Files and Directories.1704machine # [ 1.820940] systemd[1]: Started Rule-based Manager for Device Events and Files.1705machine # [ 1.877853] systemd[1]: Starting Virtual Console Setup...1706machine # [ 1.920508] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.1707machine # [ 1.923756] systemd[1]: Finished Virtual Console Setup.1708machine # [ 2.592246] systemd[1]: Finished Coldplug All udev Devices.1709machine # [ 2.720691] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1710machine # [ 2.725309] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1711machine # [ 2.756240] systemd[1]: Found device /dev/vdb.1712machine # [ 2.758045] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.1713machine # [ 3.724845] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)1714machine # [ 3.831856] systemd[1]: Found device /dev/tpm0.1715machine # [ 3.842846] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1716machine # [ 3.849175] systemd[1]: Stopped Virtual Console Setup.1717machine # [ 3.851912] systemd[1]: Stopping Virtual Console Setup...1718machine # [ 3.854533] systemd[1]: Starting Virtual Console Setup...1719machine # [ 3.861494] systemd[1]: Found device /dev/tpmrm0.1720machine # [ 3.863206] systemd[1]: Reached target Trusted Platform Module.1721machine # [ 3.869487] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1722machine # [ 3.871576] systemd[1]: Starting Cryptography Setup for cryptroot...1723machine # [ 3.899249] systemd-vconsole-setup[114]: Configuration of first virtual console was skipped, ignoring remaining ones.1724machine # [ 3.902956] systemd[1]: Finished Virtual Console Setup.1725machine # [ 4.259552] Key type trusted registered1726machine # [ 4.262496] Key type encrypted registered1727machine # [ 4.275364] systemd[1]: Finished Cryptography Setup for cryptroot.1728machine # [ 4.279938] systemd[1]: Found device /dev/mapper/cryptroot.1729machine # [ 4.281506] systemd[1]: Reached target Local Encrypted Volumes.1730machine # [ 4.283577] systemd[1]: Reached target Initrd Root Device.1731machine # [ 4.288233] systemd[1]: Reached target System Initialization.1732machine # [ 4.289132] systemd[1]: Reached target Basic System.1733machine # [ 4.289838] systemd[1]: Starting File System Check on /dev/mapper/cryptroot...1734machine # [ 4.313844] systemd-fsck[129]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks1735machine # [ 4.320098] systemd[1]: Finished File System Check on /dev/mapper/cryptroot.1736machine # [ 4.323573] systemd[1]: Mounting /sysroot...1737machine # [ 4.422402] EXT4-fs (dm-0): mounted filesystem 800f0e09-ef08-418e-970d-d64c4cc1a4a3 r/w with ordered data mode. Quota mode: none.1738machine # [ 4.399069] systemd[1]: Mounted /sysroot.1739machine # [ 4.401528] systemd[1]: Reached target Initrd Root File System.1740machine # [ 4.402746] systemd[1]: Starting Mountpoints Configured in the Real Root...1741machine # [ 4.419581] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1742machine # [ 4.422928] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1743machine # [ 4.426609] systemd[1]: Reloading...1744machine # [ 4.548875] systemd[1]: Reloading finished in 123 ms.1745machine # [ 4.571774] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1746machine # [ 4.574405] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1747machine # [ 4.578342] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1748machine # [ 4.580132] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1749machine # [ 4.584296] systemd[1]: Finished Mountpoints Configured in the Real Root.1750machine # [ 4.585404] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1751machine # [ 4.603723] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1752machine # [ 4.605760] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1753machine # [ 4.877243] systemd[1]: Mounting /sysroot/nix/.ro-store...1754machine # [ 4.887645] systemd[1]: Mounting /sysroot/nix/.rw-store...1755machine # [ 4.910672] systemd[1]: Mounting /sysroot/run...1756machine # [ 4.936402] systemd[1]: Mounting /sysroot/tmp/shared...1757machine # [ 4.948324] systemd[1]: Mounting /sysroot/tmp/xchg...1758machine # [ 4.999090] systemd[1]: Mounted /sysroot/nix/.ro-store.1759machine # [ 5.000391] systemd[1]: Mounted /sysroot/nix/.rw-store.1760machine # [ 5.001489] systemd[1]: Mounted /sysroot/run.1761machine # [ 5.015315] systemd[1]: Starting rw-sysroot-nix-store.service...1762machine # [ 5.018426] systemd[1]: Mounted /sysroot/tmp/shared.1763machine # [ 5.019169] systemd[1]: Mounted /sysroot/tmp/xchg.1764machine # [ 5.036931] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1765machine # [ 5.039415] systemd[1]: Finished rw-sysroot-nix-store.service.1766machine # [ 5.044299] systemd[1]: Mounting /sysroot/nix/store...1767machine # [ 5.071527] systemd[1]: Mounted /sysroot/nix/store.1768machine # [ 5.073068] systemd[1]: Reached target Initrd File Systems.1769machine # [ 5.075377] systemd[1]: Starting Find NixOS closure...1770machine # [ 5.083394] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1771machine # [ 5.103716] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1772machine # [ 5.115085] systemd[1]: Finished Find NixOS closure.1773machine # [ 5.115880] systemd[1]: Reached target Initrd Default Target.1774machine # [ 5.117258] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1775machine # [ 5.143695] systemd[1]: initrd-cleanup.service: Deactivated successfully.1776machine # [ 5.147338] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1777machine # [ 5.148383] systemd[1]: Stopped target Initrd Default Target.1778machine # [ 5.149201] systemd[1]: Stopped target Basic System.1779machine # [ 5.149889] systemd[1]: Stopped target Initrd Root Device.1780machine # [ 5.150635] systemd[1]: Stopped target Path Units.1781machine # [ 5.151303] systemd[1]: Stopped target Slice Units.1782machine # [ 5.151988] systemd[1]: Stopped target Socket Units.1783machine # [ 5.156438] systemd[1]: Stopped target System Initialization.1784machine # [ 5.160124] systemd[1]: Stopped target Local Encrypted Volumes.1785machine # [ 5.161010] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1786machine # [ 5.162038] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1787machine # [ 5.164194] systemd[1]: Stopped target Swaps.1788machine # [ 5.167118] systemd[1]: Stopped target Timer Units.1789machine # [ 5.167978] systemd[1]: Stopped target Trusted Platform Module.1790machine # [ 5.171077] systemd[1]: dbus.socket: Deactivated successfully.1791machine # [ 5.181205] systemd[1]: Closed D-Bus System Message Bus Socket.1792machine # [ 5.182553] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1793machine # [ 5.183712] systemd[1]: Stopped Find NixOS closure.1794machine # [ 5.184789] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1795machine # [ 5.192574] systemd[1]: Starting rw-sysroot-nix-store.service...1796machine # [ 5.194668] systemd[1]: systemd-sysctl.service: Deactivated successfully.1797machine # [ 5.198892] systemd[1]: Stopped Apply Kernel Variables.1798machine # [ 5.200447] systemd[1]: systemd-modules-load.service: Deactivated successfully.1799machine # [ 5.203921] systemd[1]: Stopped Load Kernel Modules.1800machine # [ 5.205212] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1801machine # [ 5.208310] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1802machine # [ 5.210034] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1803machine # [ 5.212153] systemd[1]: Stopped Create System Files and Directories.1804machine # [ 5.214390] systemd[1]: Stopped target Local File Systems.1805machine # [ 5.215280] systemd[1]: Stopped target Preparation for Local File Systems.1806machine # [ 5.216344] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1807machine # [ 5.217346] systemd[1]: Stopped Coldplug All udev Devices.1808machine # [ 5.218107] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1809machine # [ 5.219102] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1810machine # [ 5.223930] systemd[1]: Stopped Virtual Console Setup.1811machine # [ 5.224864] systemd[1]: systemd-udevd.service: Deactivated successfully.1812machine # [ 5.228299] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1813machine # [ 5.229487] systemd[1]: systemd-udevd.service: Consumed 1.473s CPU time over 3.515s wall clock time, 24M memory peak.1814machine # [ 5.232212] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1815machine # [ 5.236157] systemd[1]: Finished rw-sysroot-nix-store.service.1816machine # [ 5.237002] systemd[1]: Starting Cleanup udev Database...1817machine # [ 5.237757] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1818machine # [ 5.240131] systemd[1]: Stopped Create Static Device Nodes in /dev.1819machine # [ 5.241015] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1820machine # [ 5.244440] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1821machine # [ 5.245440] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1822machine # [ 5.248177] systemd[1]: Stopped Create List of Static Device Nodes.1823machine # [ 5.252097] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1824machine # [ 5.253115] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1825machine # [ 5.275289] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1826machine # [ 5.278517] systemd[1]: Finished Cleanup udev Database.1827machine # [ 5.279266] systemd[1]: Reached target Switch Root.1828machine # [ 5.284087] systemd[1]: Starting NixOS Activation...1829machine # [ 5.452589] initrd-nixos-activation-start[193]: booting system configuration /nix/store/qv8jnzk5i2z4yaa39sx5yhcb6vrmhzfj-nixos-system-machine-test1830machine # [ 5.519868] initrd-nixos-activation-start[193]: running activation script...1831machine # [ 5.951328] initrd-nixos-activation-start[216]: setting up /etc...1832machine # [ 6.222404] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1833machine # [ 6.225227] systemd[1]: Finished NixOS Activation.1834machine # [ 6.226364] systemd[1]: Starting Switch Root...1835machine # [ 6.249702] systemd[1]: Switching root.1836machine # [ 6.465273] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1837machine # [ 6.669195] NET: Registered PF_VSOCK protocol family1838machine # [ 7.068125] systemd[1]: systemd 262-2451b1a 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)1839machine # [ 7.080849] systemd[1]: Detected virtualization kvm.1840machine # [ 7.084876] systemd[1]: Detected architecture arm64.1841machine # [ 7.087054] systemd[1]: Detected first boot.1842machine # [ 7.095430] systemd[1]: Initializing machine ID from random generator.1843machine # [ 7.279347] systemd[1]: bpf-restrict-fs: LSM BPF program attached1844machine # [ 7.442055] systemd[1]: Applying preset policy.1845machine # [ 7.988572] systemd[1]: Populated /etc with preset unit settings.1846machine # [ 8.634159] systemd[1]: initrd-switch-root.service: Deactivated successfully.1847machine # [ 8.635911] systemd[1]: Stopped initrd-switch-root.service.1848machine # [ 8.639082] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1849machine # [ 8.642820] systemd[1]: Created slice Slice /system/getty.1850machine # [ 8.646456] systemd[1]: Created slice Slice /system/systemd-fsck.1851machine # [ 8.649507] systemd[1]: Created slice User and Session Slice.1852machine # [ 8.651561] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1853machine # [ 8.653865] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1854machine # [ 8.656068] systemd[1]: Expecting device /dev/disk/by-label/ESP...1855machine # [ 8.657991] systemd[1]: Expecting device /dev/hvc0...1856machine # [ 8.659753] systemd[1]: Expecting device /dev/ttyAMA0...1857machine # [ 8.661619] systemd[1]: Reached target Local Encrypted Volumes.1858machine # [ 8.663492] systemd[1]: Stopped target initrd-fs.target.1859machine # [ 8.665332] systemd[1]: Stopped target initrd-root-fs.target.1860machine # [ 8.667180] systemd[1]: Stopped target initrd-switch-root.target.1861machine # [ 8.669594] systemd[1]: Reached target Virtual Machines and Containers.1862machine # [ 8.671651] systemd[1]: Reached target Path Units.1863machine # [ 8.673440] systemd[1]: Reached target Remote File Systems.1864machine # [ 8.675292] systemd[1]: Reached target Slice Units.1865machine # [ 8.677131] systemd[1]: Reached target Swaps.1866machine # [ 8.681169] systemd[1]: Listening on Query the User Interactively for a Password.1867machine # [ 8.686198] systemd[1]: Listening on Process Core Dump Socket.1868machine # [ 8.690535] systemd[1]: Listening on Credential Encryption/Decryption.1869machine # [ 8.694324] systemd[1]: Listening on Factory Reset Management.1870machine # [ 8.695538] systemd[1]: Listening on Hostname Service Socket.1871machine # [ 8.701519] systemd[1]: Starting Journal Log Access Socket...1872machine # [ 8.703670] systemd[1]: Listening on Journal Audit Socket.1873machine # [ 8.707924] systemd[1]: Listening on Console Output Muting Service Socket.1874machine # [ 8.710786] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1875machine # [ 8.713703] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1876machine # [ 8.716680] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1877machine # [ 8.728178] systemd[1]: Listening on Disk Repartitioning Service Socket.1878machine # [ 8.728744] systemd[1]: Listening on udev Varlink Socket.1879machine # [ 8.734493] systemd[1]: Mounting Huge Pages File System...1880machine # [ 8.739289] systemd[1]: Mounting POSIX Message Queue File System...1881machine # [ 8.750319] systemd[1]: Mounting Kernel Debug File System...1882machine # [ 8.760973] systemd[1]: Mounting Kernel Trace File System...1883machine # [ 8.772604] systemd[1]: Starting Create List of Static Device Nodes...1884machine # [ 8.786353] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1885machine # [ 8.790352] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1886machine # [ 8.809939] systemd[1]: Mounting Kernel Configuration File System...1887machine # [ 8.813006] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1888machine # [ 8.815767] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1889machine # [ 8.819457] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1890machine # [ 8.879207] systemd[1]: Mounting FUSE Control File System...1891machine # [ 8.881091] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully.1892machine # [ 8.894014] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service.1893machine # [ 8.897341] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671894machine # [ 8.936282] systemd[1]: Starting Journal Service...1895machine # [ 8.968105] systemd[1]: Starting Load Kernel Modules...1896machine # [ 8.979136] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1897machine # [ 9.008132] systemd[1]: Starting Remount Root and Kernel File Systems...1898machine # [ 9.008574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1899machine # [ 9.030768] systemd[1]: Starting Coldplug All udev Devices...1900machine # [ 9.055334] systemd-journald[288]: Collecting audit messages is enabled.1901machine # [ 9.062712] systemd[1]: Listening on Journal Log Access Socket.1902machine # [ 9.057034] systemd[1]: Queued start job for default target Multi-User System.1903machine # [ 9.061260] systemd[1]: systemd-journald.service: Deactivated successfully.1904machine # [ 9.095875] systemd[1]: Started Journal Service.1905machine # [ 9.078083] systemd[1]: Mounted Huge Pages File System.1906machine # [ 9.084893] systemd-modules-load[289]: Module 'atkbd' is built in1907machine # [ 9.092364] systemd-modules-load[289]: Module 'loop' is built in1908machine # [ 9.097058] systemd[1]: Mounted POSIX Message Queue File System.1909machine # [ 9.098059] systemd[1]: Mounted Kernel Debug File System.1910machine # [ 9.098842] systemd[1]: Mounted Kernel Trace File System.1911machine # [ 9.099603] systemd[1]: Finished Create List of Static Device Nodes.1912machine # [ 9.114145] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1913machine # [ 9.115226] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1914machine # [ 9.120187] systemd[1]: Mounted Kernel Configuration File System.1915machine # [ 9.151945] EXT4-fs (dm-0): re-mounted 800f0e09-ef08-418e-970d-d64c4cc1a4a3.1916machine # [ 9.128893] systemd[1]: Mounted FUSE Control File System.1917machine # [ 9.133187] systemd[1]: Finished Load Kernel Modules.1918machine # [ 9.139104] systemd[1]: Finished Remount Root and Kernel File Systems.1919machine # [ 9.142306] systemd[1]: Listening on Disk Image Download Service Socket.1920machine # [ 9.150480] systemd-oomd[291]: No swap; memory pressure usage will be degraded1921machine # [ 9.156786] systemd[1]: Starting Firewall...1922machine # [ 9.159643] systemd[1]: Starting Flush Journal to Persistent Storage...1923machine # [ 9.163172] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1924machine # [ 9.171141] systemd[1]: Starting Load/Save OS Random Seed...1925machine # [ 9.206302] systemd[1]: Starting Apply Kernel Variables...1926machine # [ 9.212288] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1927machine # [ 9.217811] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1928machine # [ 9.228424] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1929machine # [ 9.292958] systemd-journald[288]: Received client request to flush runtime journal.1930machine # [ 9.352537] systemd[1]: Finished Load/Save OS Random Seed.1931machine # [ 9.364322] systemd[1]: Reached target First Boot Complete.1932machine # [ 9.369457] systemd[1]: Finished Flush Journal to Persistent Storage.1933machine # [ 9.392598] systemd[1]: Finished Apply Kernel Variables.1934machine # [ 9.425225] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1935machine # [ 9.438997] systemd[1]: Starting Create Static Device Nodes in /dev...1936machine # [ 9.557779] systemd[1]: Finished Create Static Device Nodes in /dev.1937machine # [ 9.559969] systemd[1]: Reached target Preparation for Local File Systems.1938machine # [ 9.565690] systemd[1]: Starting Rule-based Manager for Device Events and Files...1939machine # [ 9.616787] systemd[1]: Mounting /run/wrappers...1940machine # [ 9.682448] systemd[1]: Mounted /run/wrappers.1941machine # [ 9.694858] systemd[1]: Starting Create SUID/SGID Wrappers...1942machine # [ 9.710118] systemd-udevd[329]: Using default interface naming scheme 'v261'.1943machine # [ 9.916169] systemd[1]: Started Rule-based Manager for Device Events and Files.1944machine # [ 10.477690] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1945machine # [ 10.480739] systemd[1]: Finished Create SUID/SGID Wrappers.1946machine # [ 10.922534] systemd[1]: Finished Coldplug All udev Devices.1947machine # [ 10.975222] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1948machine # [ 11.011719] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1949machine # [ 11.031396] systemd[1]: Finished Firewall.1950machine # [ 11.123342] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1951machine # [ 11.149569] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1952machine # [ 11.175552] systemd[1]: Found device /dev/tpmrm0.1953machine # [ 11.177408] systemd[1]: Expecting device /dev/tpm0...1954machine # [ 11.191342] (udev-worker)[379]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1955machine # [ 11.196791] (udev-worker)[370]: Network interface NamePolicy= disabled on kernel command line.1956machine # [ 11.200090] (udev-worker)[379]: Network interface NamePolicy= disabled on kernel command line.1957machine # [ 11.311473] systemd[1]: Condition check resulted in Virtio network device being skipped.1958machine # [ 11.314340] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1959machine # [ 11.318755] systemd[1]: Starting Create SUID/SGID Wrappers...1960machine # [ 11.321506] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671961machine # [ 11.330205] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1962machine # [ 11.464535] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.1963machine # [ 11.473715] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...1964machine # [ 11.587082] systemd-fsck[513]: fsck.fat 4.2 (2021-01-31)1965machine # [ 11.590635] systemd-fsck[513]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.1966machine # [ 11.598309] systemd-fsck[513]: Automatically removing dirty bit.1967machine # [ 11.604192] systemd-fsck[513]: *** Filesystem was changed ***1968machine # [ 11.606565] systemd-fsck[513]: Writing changes.1969machine # [ 11.607410] systemd-fsck[513]: /dev/vda1: 20 files, 28697/63671 clusters1970machine # [ 11.613074] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.1971machine # [ 11.620549] systemd[1]: Mounting /boot...1972machine # [ 11.716387] systemd[1]: Mounted /boot.1973machine # [ 11.719225] systemd[1]: Reached target Local File Systems.1974machine # [ 11.723476] systemd[1]: Listening on Boot Loader Control Service Socket.1975machine # [ 11.730969] systemd[1]: Starting register-nix-paths.service...1976machine # [ 11.734741] systemd[1]: Starting Update Boot Loader Random Seed...1977machine # [ 11.764106] mousedev: PS/2 mouse device common for all mice1978machine # [ 11.749364] systemd[1]: Starting Save Transient machine-id to Disk...1979machine # [ 11.782349] systemd[1]: Starting Create System Files and Directories...1980machine # [ 11.857815] bootctl[535]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 1981machine # [ 11.882878] bootctl[535]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!1982machine # [ 11.898723] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1983machine # [ 11.904500] bootctl[535]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).1984machine # [ 11.905820] systemd[1]: Finished register-nix-paths.service.1985machine # [ 11.906640] systemd[1]: Finished Save Transient machine-id to Disk.1986machine # [ 11.916878] systemd[1]: Finished Update Boot Loader Random Seed.1987machine # [ 11.974289] systemd[1]: Finished Create System Files and Directories.1988machine # [ 11.982137] systemd[1]: Starting Rebuild Journal Catalog...1989machine # [ 11.985791] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1990machine # [ 12.077243] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1991machine # [ 12.080848] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1992machine # [ 12.085049] systemd[1]: Finished Create SUID/SGID Wrappers.1993machine # [ 12.110178] systemd[1]: Finished Rebuild Journal Catalog.1994machine # [ 12.113087] systemd[1]: Starting Update is Completed...1995machine # [ 12.159350] systemd[1]: Finished Update is Completed.1996machine # [ 12.916639] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input31997machine # [ 12.951384] systemd[1]: Found device /dev/tpm0.1998machine # [ 12.956293] systemd[1]: Reached target Trusted Platform Module.1999machine # [ 12.957294] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2000machine # [ 12.958560] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2001machine # [ 12.959740] systemd[1]: Reached target System Initialization.2002machine # [ 12.966175] systemd[1]: Started Discard unused filesystem blocks once a week.2003machine # [ 12.970992] systemd[1]: Started Daily Cleanup of Temporary Directories.2004machine # [ 12.972700] systemd[1]: Reached target Timer Units.2005machine # [ 12.975420] systemd[1]: Listening on D-Bus System Message Bus Socket.2006machine # [ 12.981214] systemd[1]: Listening on Nix Daemon Socket.2007machine # [ 12.981993] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2008machine # [ 12.983170] systemd[1]: Reached target Socket Units.2009machine # [ 12.983884] systemd[1]: Reached target Basic System.2010machine # [ 12.990305] systemd[1]: Started backdoor.service.2011machine # [ 12.997017] systemd[1]: Starting Import lastlog data into lastlog2 database...2012machine # [ 12.998018] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2013machine # [ 13.009215] systemd[1]: Starting Post-Boot Actions...2014machine # [ 13.035052] systemd[1]: Started Reset console on configuration changes.2015machine # [ 13.072139] systemd[1]: Starting resolvconf update...2016machine # [ 13.131998] systemd[1]: Starting D-Bus System Message Bus...2017machine # [ 13.145077] nsncd[587]: Sep 03 02:48:11.985 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2018machine # connecting to host...2019machine # [ 13.158311] systemd[1]: Finished Post-Boot Actions.2020machine # [ 13.161045] systemd[1]: Started Name Service Cache Daemon (nsncd).2021machine # [ 13.202541] systemd[1]: Reached target Host and Network Name Lookups.2022machine # [ 13.208501] systemd[1]: Reached target User and Group Name Lookups.2023machine: Guest shell says: b'Spawning backdoor root shell...\n'2024machine # [ 13.226961] systemd[1]: Starting User Login Management...2025machine # [ 13.259884] systemd[1]: Finished Import lastlog data into lastlog2 database.2026machine: connected to guest root shell2027machine: (connecting took 26.26 seconds)2028machine: (finished: waiting for the VM to finish booting, in 26.46 seconds)2029machine # [ 13.397147] dbus-broker-launch[595]: Looking up NSS user entry for 'systemd-timesync'...2030machine # [ 13.425434] systemd-logind[613]: New seat seat0.2031machine # [ 13.433626] systemd-logind[613]: Watching system buttons on /dev/input/event0 (Power Button)2032machine # [ 13.438734] systemd-logind[613]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2033machine # [ 13.503680] systemd[1]: Started User Login Management.2034machine # [ 13.515372] systemd[1]: Stopped target Host and Network Name Lookups.2035machine # [ 13.517748] dbus-broker-launch[595]: NSS returned no entry for 'systemd-timesync'2036machine # [ 13.518722] dbus-broker-launch[595]: Invalid user-name in /nix/store/lzcrfdd38r63230k6nd0zpkcsd145gdg-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2037machine # [ 13.532672] systemd[1]: Stopping Host and Network Name Lookups...2038machine # [ 13.537920] systemd[1]: Stopped target User and Group Name Lookups.2039machine # [ 13.538947] systemd[1]: Stopping User and Group Name Lookups...2040machine # [ 13.539730] systemd[1]: Starting linger-users.service...2041machine # [ 13.549135] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2042machine # [ 13.555013] systemd[1]: Starting Virtual Console Setup...2043machine # [ 13.557964] systemd[1]: nscd.service: Deactivated successfully.2044machine # [ 13.562274] systemd-logind[613]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2045machine # [ 13.572265] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2046machine # [ 13.625237] systemd[1]: Started D-Bus System Message Bus.2047machine # [ 13.642424] dbus-broker-launch[595]: Ready2048machine # [ 13.643087] systemd[1]: linger-users.service: Deactivated successfully.2049machine # [ 13.648392] systemd[1]: Finished linger-users.service.2050machine # [ 13.693008] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2051machine # [ 13.747091] systemd[1]: Started Name Service Cache Daemon (nsncd).2052machine # [ 13.750169] nsncd[682]: Sep 03 02:48:12.587 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2053machine # [ 13.755915] systemd[1]: Finished resolvconf update.2054machine # [ 13.757245] systemd[1]: Reached target Preparation for Network.2055machine # [ 13.758431] systemd[1]: Reached target Host and Network Name Lookups.2056machine # [ 13.761952] systemd[1]: Reached target User and Group Name Lookups.2057machine # [ 13.763765] systemd[1]: Starting DHCP Client...2058machine # [ 13.766266] systemd[1]: Starting Address configuration of eth1...2059machine # [ 13.775683] systemd[1]: Starting Extra networking commands....2060machine # [ 13.908582] network-addresses-eth1-start[701]: adding address 192.168.1.1/24... done2061machine # [ 13.929510] network-addresses-eth1-start[701]: adding address 2001:db8:1::1/64... done2062machine # [ 13.955221] systemd[1]: Finished Address configuration of eth1.2063machine # [ 14.015537] dhcpcd[710]: dhcpcd-10.3.2 starting2064machine # [ 14.028630] dhcpcd[761]: dev: loaded udev2065machine # [ 14.046575] systemd[1]: Finished Extra networking commands..2066machine # [ 14.049085] systemd[1]: Reached target Network.2067machine # [ 14.053976] systemd[1]: Starting Permit User Sessions...2068machine # [ 14.103338] 8021q: 802.1Q VLAN Support v1.82069machine # [ 14.103725] 8021q: adding VLAN 0 to HW filter on device eth12070machine # [ 14.114557] systemd[1]: Finished Permit User Sessions.2071machine # [ 14.127837] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2072machine # [ 14.134679] systemd[1]: Started Getty on tty1.2073machine # [ 14.137681] systemd[1]: Reached target Login Prompts.2074machine # [ 14.195359] cfg80211: Loading compiled-in X.509 certificates for regulatory database2075machine # [ 14.227577] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2076machine # [ 14.229967] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2077machine # [ 14.234743] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22078machine # [ 14.235077] cfg80211: failed to load regulatory.db2079machine # [ 14.264323] systemd-vconsole-setup[664]: Configuration of first virtual console was skipped, ignoring remaining ones.2080machine # [ 14.268790] systemd[1]: Finished Virtual Console Setup.2081machine # [ 14.304531] 8021q: adding VLAN 0 to HW filter on device eth02082machine # [ 14.278231] dhcpcd[761]: eth0: waiting for carrier2083machine # [ 14.279715] dhcpcd[761]: eth0: carrier acquired2084machine # [ 14.290473] dhcpcd[761]: DUID 00:01:00:01:32:2b:9c:6d:52:54:00:12:34:562085machine # [ 14.291680] dhcpcd[761]: eth0: IAID 00:12:34:562086machine # [ 14.292461] dhcpcd[761]: eth0: adding address fe80::5054:ff:fe12:34562087machine # [ 15.351013] dhcpcd[761]: eth0: soliciting an IPv6 router2088machine # [ 15.354685] dhcpcd[761]: eth0: Router Advertisement from fe80::22089machine # [ 15.357382] dhcpcd[761]: eth0: adding address fec0::5054:ff:fe12:3456/642090machine # [ 15.360145] dhcpcd[761]: eth0: adding route to fec0::/642091machine # [ 15.362346] dhcpcd[761]: eth0: adding default route via fe80::22092machine # [ 16.007545] dhcpcd[761]: eth0: soliciting a DHCP lease2093machine # [ 16.012968] dhcpcd[761]: eth0: offered 10.0.2.15 from 10.0.2.22094machine # [ 16.016485] dhcpcd[761]: eth0: probing address 10.0.2.15/242095machine # [ 21.751789] dhcpcd[761]: eth0: leased 10.0.2.15 for 86400 seconds2096machine # [ 21.756620] dhcpcd[761]: eth0: adding route to 10.0.2.0/242097machine # [ 21.759586] dhcpcd[761]: eth0: adding default route via 10.0.2.22098machine # [ 21.915224] systemd[1]: Started DHCP Client.2099machine # [ 21.916969] systemd[1]: Reached target Multi-User System.2100machine # [ 21.918190] systemd[1]: Startup finished in 6.059s (firmware) + 6.276s (loader) + 857ms (kernel) + 5.721s (initrd) + 15.338s (userspace) = 34.254s.2101machine: (finished: waiting for unit multi-user.target, in 35.81 seconds)2102machine: must succeed: mount2103machine: (finished: must succeed: mount, in 0.04 seconds)2104(finished: run the VM test script, in 75.88 seconds)2105test script finished in 75.93s2106cleanup2107kill QemuMachine (pid 98)2108machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2109(finished: cleanup, in 0.01 seconds)