nixbot

builds

succeeded vm-test-run-systemd-initrd-luks-tpm2 checks.aarch64-linux.systemd-initrd-luks-tpm2 · build #23 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: waiting for unit multi-user.target8machine: waiting for the VM to finish booting9machine: starting vm10machine: QEMU running (pid 45)11machine # Disk image does not exist, creating the virtualisation disk image...12machine # Formatting '/build/vm-state-machine/machine.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=2523922432 backing_file=/nix/store/8690ia465wgv1yrml9jz14bnz0kxlkci-nixos-disk-image/nixos.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=1613machine # Virtualisation disk image created.14machine # Formatting 'empty0.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=536870912 lazy_refcounts=off refcount_bits=1615machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)16machine: Guest shell says: b'\x1b[2J\x1b[001;001H\x1b[=3h\x1b[2J\x1b[001;001H\x1b[2J\x1b[001;001H\x1b[8;042;160t\x1b[2J\x1b[001;001H'17machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)18machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'19machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)20machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'21machine: Guest shell says: b'\r \r\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H\x1b[020;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m NixOS (boot-luks) \x1b[021;063'22machine: Guest shell says: b'H\x1b[1m\x1b[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS \x1b[022;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Reboot Into Firmware I'23machine: Guest shell says: b'nterface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot '24machine: Guest shell says: b'in 5s. \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m----------'25machine: Guest shell says: b'--------------------------------'26machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. '27machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'28machine: Guest shell says: b'------------------------------------------'29machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. '30machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'31machine: Guest shell says: b'---------------------'32machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. '33machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'34machine: Guest shell says: b'------------------------------------------'35machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '36machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'37machine: Guest shell says: b'---------------------'38machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'39machine # NixOS (boot-luks) NixOS Reboot Into Firmware Interface Boot in 5s. ------------------------------------------ Boot in 4s. ------------------------------------------ Boot in 3s. ------------------------------------------ Boot in 2s. ------------------------------------------ Boot in 1s. ------------------------------------------[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]40machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 202641machine # [ 0.000000] KASLR enabled42machine # [ 0.000000] efi: EFI v2.7 by EDK II43machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fe0000 MEMATTR=0x45ad8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a6a018 INITRD=0x45ad0418 MEMRESERVE=0x45ad221844machine # [ 0.000000] random: crng init done45machine # [ 0.000000] ACPI: Early table checksum verification disabled46machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )47machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013)48machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)49machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001811 (v02 BOCHS BXPC 00000001 BXPC 00000001)50machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)51machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)52machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)53machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)54machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)55machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)56machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)57machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)58machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013)59machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,960060machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]61machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf2880-0x7fdf5fff]62machine # [ 0.000000] Zone ranges:63machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]64machine # [ 0.000000] DMA32 empty65machine # [ 0.000000] Normal empty66machine # [ 0.000000] Device empty67machine # [ 0.000000] Movable zone start for each node68machine # [ 0.000000] Early memory node ranges69machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045fcffff]70machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff]71machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff]72machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]73machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]74machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]75machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]76machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]77machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]78machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]79machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000080machine # [ 0.000000] psci: probing for conduit method from ACPI.81machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.82machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs83machine # [ 0.000000] psci: Trusted OS migration not required84machine # [ 0.000000] psci: SMC Calling Convention v1.185machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)86machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129687machine # [ 0.000000] Detected PIPT I-cache on CPU088machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)89machine # [ 0.000000] CPU features: detected: GICv3 CPU interface90machine # [ 0.000000] CPU features: detected: Spectre-v491machine # [ 0.000000] CPU features: detected: Spectre-BHB92machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3893machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2394machine # [ 0.000000] alternatives: applying boot alternatives95machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\qslb8f889n1a02qd20ig57yfxqjalbf1-initrd-linux-6.18.49-initrd.efi init=/nix/store/n0r7si3yim6yg9l95rgfp4znryb4y0hl-nixos-system-machine-test/init console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf96machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes97machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)98machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)99machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB100machine # [ 0.000000] software IO TLB: area num 1.101machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)102machine # [ 0.000000] Fallback order for Node 0: 0103machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144104machine # [ 0.000000] Policy zone: DMA105machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off106machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1107machine # [ 0.000000] allocated 2097152 bytes of page_ext108machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages109machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups110machine # [ 0.000000] rcu: Hierarchical RCU implementation.111machine # [ 0.000000] rcu: RCU event tracing is enabled.112machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.113machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.114machine # [ 0.000000] Rude variant of Tasks RCU enabled.115machine # [ 0.000000] Tracing variant of Tasks RCU enabled.116machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.117machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1118machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.119machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.120machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.121machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0122machine # [ 0.000000] GICv3: 256 SPIs implemented123machine # [ 0.000000] GICv3: 0 Extended SPIs implemented124machine # [ 0.000000] Root IRQ handler: gic_handle_irq125machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI126machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0127machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000128machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]129machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)130machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)131machine # [ 0.000000] GICv3: using LPI property table @0x0000000040910000132machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000040920000133machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.134machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns135machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).136machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns137machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns138machine # [ 0.000034] arm-pv: using stolen time PV139machine # [ 0.000461] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)140machine # [ 0.000552] Console: colour dummy device 80x25141machine # [ 0.000556] printk: legacy console [tty0] enabled142machine # [ 0.000766] ACPI: Core revision 20250807143machine # [ 0.000846] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)144machine # [ 0.000853] pid_max: default: 32768 minimum: 301145machine # [ 0.000911] LSM: initializing lsm=capability,landlock,yama,bpf,ima146machine # [ 0.001042] landlock: Up and running.147machine # [ 0.001046] Yama: becoming mindful.148machine # [ 0.001520] LSM support for eBPF active149machine # [ 0.001615] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)150machine # [ 0.001622] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)151machine # [ 0.002749] rcu: Hierarchical SRCU implementation.152machine # [ 0.002755] rcu: Max phase no-delay instances is 1000.153machine # [ 0.003439] fsl-mc MSI: ITS@0x8080000 domain created154machine # [ 0.003459] Remapping and enabling EFI services.155machine # [ 0.003579] smp: Bringing up secondary CPUs ...156machine # [ 0.003588] smp: Brought up 1 node, 1 CPU157machine # [ 0.003591] SMP: Total of 1 processors activated.158machine # [ 0.003594] CPU: All CPU(s) started at EL1159machine # [ 0.003605] CPU features: detected: Branch Target Identification160machine # [ 0.003609] CPU features: detected: ARMv8.4 Translation Table Level161machine # [ 0.003612] CPU features: detected: Instruction cache invalidation not required for I/D coherence162machine # [ 0.003616] CPU features: detected: Data cache clean to the PoU not required for I/D coherence163machine # [ 0.003619] CPU features: detected: Common not Private translations164machine # [ 0.003623] CPU features: detected: CRC32 instructions165machine # [ 0.003626] CPU features: detected: Data cache clean to Point of Deep Persistence166machine # [ 0.003629] CPU features: detected: Data cache clean to Point of Persistence167machine # [ 0.003633] CPU features: detected: Data independent timing control (DIT)168machine # [ 0.003636] CPU features: detected: E0PD169machine # [ 0.003638] CPU features: detected: Enhanced Counter Virtualization170machine # [ 0.003641] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)171machine # [ 0.003645] CPU features: detected: Enhanced Virtualization Traps172machine # [ 0.003648] CPU features: detected: Fine Grained Traps173machine # [ 0.003651] CPU features: detected: Generic authentication (architected QARMA5 algorithm)174machine # [ 0.003656] CPU features: detected: RCpc load-acquire (LDAPR)175machine # [ 0.003659] CPU features: detected: LSE atomic instructions176machine # [ 0.003662] CPU features: detected: Privileged Access Never177machine # [ 0.003664] CPU features: detected: PMUv3178machine # [ 0.003666] CPU features: detected: RAS Extension Support179machine # [ 0.003669] CPU features: detected: RASv1p1 Extension Support180machine # [ 0.003672] CPU features: detected: Random Number Generator181machine # [ 0.003674] CPU features: detected: Speculation barrier (SB)182machine # [ 0.003677] CPU features: detected: Stage-2 Force Write-Back183machine # [ 0.003680] CPU features: detected: TLB range maintenance instructions184machine # [ 0.003684] CPU features: detected: Speculative Store Bypassing Safe (SSBS)185machine # [ 0.003727] alternatives: applying system-wide alternatives186machine # [ 0.006461] CPU features: detected: BBM Level 2 without TLB conflict abort187machine # [ 0.006598] Memory: 887012K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120028K reserved, 32768K cma-reserved)188machine # [ 0.006855] devtmpfs: initialized189machine # [ 0.007773] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)190machine # [ 0.007783] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).191machine # [ 0.007961] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL192machine # [ 0.007966] 0 pages in range for non-PLT usage193machine # [ 0.007967] 508288 pages in range for PLT usage194machine # [ 0.008038] pinctrl core: initialized pinctrl subsystem195machine # [ 0.008592] SMBIOS 3.0.0 present.196machine # [ 0.008597] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022197machine # [ 0.008605] DMI: Memory slots populated: 1/1198machine # [ 0.009983] NET: Registered PF_NETLINK/PF_ROUTE protocol family199machine # [ 0.010663] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations200machine # [ 0.010800] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations201machine # [ 0.010958] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations202machine # [ 0.010977] audit: initializing netlink subsys (disabled)203machine # [ 0.011396] thermal_sys: Registered thermal governor 'fair_share'204machine # [ 0.011398] thermal_sys: Registered thermal governor 'bang_bang'205machine # [ 0.011401] thermal_sys: Registered thermal governor 'step_wise'206machine # [ 0.011404] thermal_sys: Registered thermal governor 'user_space'207machine # [ 0.011407] thermal_sys: Registered thermal governor 'power_allocator'208machine # [ 0.011433] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1209machine # [ 0.011446] cpuidle: using governor ladder210machine # [ 0.011454] cpuidle: using governor menu211machine # [ 0.011629] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.212machine # [ 0.011652] ASID allocator initialised with 65536 entries213machine # [ 0.012454] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5214machine # [ 0.012653] Serial: AMBA PL011 UART driver215machine # [ 0.018717] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages216machine # [ 0.018723] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page217machine # [ 0.018726] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages218machine # [ 0.018729] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page219machine # [ 0.018732] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages220machine # [ 0.018735] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page221machine # [ 0.018738] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages222machine # [ 0.018740] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page223machine # [ 0.019542] fbcon: Taking over console224machine # [ 0.019578] ACPI: Added _OSI(Module Device)225machine # [ 0.019582] ACPI: Added _OSI(Processor Device)226machine # [ 0.019585] ACPI: Added _OSI(Processor Aggregator Device)227machine # [ 0.020629] ACPI: 1 ACPI AML tables successfully acquired and loaded228machine # [ 0.026586] ACPI: Interpreter enabled229machine # [ 0.026590] ACPI: Using GIC for interrupt routing230machine # [ 0.026617] ACPI: MCFG table detected, 1 entries231machine # [ 0.030632] ACPI: CPU0 has been hot-added232machine # [ 0.030994] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA233machine # [ 0.031065] printk: console [ttyAMA0] enabled234machine # [ 0.080606] ACPI: PCI: Interrupt link L000 configured for IRQ 35235machine # [ 0.080623] ACPI: PCI: Interrupt link L001 configured for IRQ 36236machine # [ 0.080635] ACPI: PCI: Interrupt link L002 configured for IRQ 37237machine # [ 0.080647] ACPI: PCI: Interrupt link L003 configured for IRQ 38238machine # [ 0.080663] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])239machine # [ 0.080707] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]240machine # [ 0.080790] acpi PNP0A08:00: _OSC: platform does not support [LTR]241machine # [ 0.080886] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]242machine # [ 0.081131] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00243machine # [ 0.081153] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]244machine # [ 0.081176] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]245machine # [ 0.081546] PCI host bridge to bus 0000:00246machine # [ 0.081573] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]247machine # [ 0.081578] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]248machine # [ 0.081581] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]249machine # [ 0.081585] pci_bus 0000:00: root bus resource [bus 00-ff]250machine # [ 0.081588] PCI: OF: of_root node is NULL, cannot create PCI host bridge node251machine # [ 0.081639] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint252machine # [ 0.082159] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint253machine # [ 0.082352] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]254machine # [ 0.082364] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]255machine # [ 0.082390] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]256machine # [ 0.082403] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]257machine # [ 0.082910] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint258machine # [ 0.084715] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]259machine # [ 0.084729] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]260machine # [ 0.084757] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]261machine # [ 0.085294] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint262machine # [ 0.209136] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]263machine # [ 0.209169] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]264machine # [ 0.209200] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]265machine # [ 0.209758] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint266machine # [ 0.209946] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]267machine # [ 0.209963] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]268machine # [ 0.209994] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]269machine # [ 0.210502] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint270machine # [ 0.210687] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]271machine # [ 0.210705] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]272machine # [ 0.210736] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]273machine # [ 0.211236] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.212075] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]275machine # [ 0.212096] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]276machine # [ 0.212128] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]277machine # [ 0.224529] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint278machine # [ 0.224726] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]279machine # [ 0.224743] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]280machine # [ 0.224776] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]281machine # [ 0.225289] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint282machine # [ 0.225481] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]283machine # [ 0.225499] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]284machine # [ 0.225530] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]285machine # [ 0.225548] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]286machine # [ 0.233092] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint287machine # [ 0.235361] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]288machine # [ 0.235402] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]289machine # [ 0.235955] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint290machine # [ 0.236152] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]291machine # [ 0.236184] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]292machine # [ 0.236637] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint293machine # [ 0.237317] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]294machine # [ 0.237636] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.238343] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]296machine # [ 0.246443] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]297machine # [ 0.246489] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]298machine # [ 0.247031] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.247872] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]300machine # [ 0.247893] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]301machine # [ 0.247925] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]302machine # [ 0.248536] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.248550] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.248558] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.248607] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.248657] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.248707] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.248757] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.248807] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.248857] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.248908] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.248959] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.250338] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.250396] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.250447] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned316machine # [ 0.268655] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.268686] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.268710] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.268734] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.268758] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.268782] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.268806] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.268831] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.275298] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.275929] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.275958] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.276510] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.276539] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned329machine # [ 0.276562] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned330machine # [ 0.281853] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned331machine # [ 0.281884] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned332machine # [ 0.281907] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned333machine # [ 0.282480] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned334machine # [ 0.282506] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned335machine # [ 0.283009] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned336machine # [ 0.283036] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned337machine # [ 0.283060] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned338machine # [ 0.283086] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned339machine # [ 0.283599] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]340machine # [ 0.283613] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]341machine # [ 0.283620] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]342machine # [ 0.296520] iommu: Default domain type: Translated343machine # [ 0.296536] iommu: DMA domain TLB invalidation policy: strict mode344machine # [ 0.298034] SCSI subsystem initialized345machine # [ 0.298651] ACPI: bus type USB registered346machine # [ 0.298698] usbcore: registered new interface driver usbfs347machine # [ 0.298719] usbcore: registered new interface driver hub348machine # [ 0.300465] usbcore: registered new device driver usb349machine # [ 0.300691] pps_core: LinuxPPS API ver. 1 registered350machine # [ 0.300700] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>351machine # [ 0.300712] PTP clock support registered352machine # [ 0.300755] EDAC MC: Ver: 3.0.0353machine # [ 0.304234] scmi_core: SCMI protocol bus registered354machine # [ 0.304971] efivars: Registered efivars operations355machine # [ 0.305955] FPGA manager framework356machine # [ 0.306825] vgaarb: loaded357machine # [ 0.307430] clocksource: Switched to clocksource arch_sys_counter358machine # [ 0.307745] VFS: Disk quotas dquot_6.6.0359machine # [ 0.307774] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)360machine # [ 0.311557] netfs: FS-Cache loaded361machine # [ 0.311664] pnp: PnP ACPI init362machine # [ 0.311866] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved363machine # [ 0.311921] pnp: PnP ACPI: found 1 devices364machine # [ 0.317236] NET: Registered PF_INET protocol family365machine # [ 0.317306] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)366machine # [ 0.337625] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)367machine # [ 0.337673] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)368machine # [ 0.337701] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)369machine # [ 0.337748] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)370machine # [ 0.337826] TCP: Hash tables configured (established 8192 bind 8192)371machine # [ 0.337913] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)372machine # [ 0.337947] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)373machine # [ 0.337973] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)374machine # [ 0.338068] NET: Registered PF_UNIX/PF_LOCAL protocol family375machine # [ 0.338092] NET: Registered PF_XDP protocol family376machine # [ 0.338860] PCI: CLS 0 bytes, default 64377machine # [ 0.339093] Trying to unpack rootfs image as initramfs...378machine # [ 0.356987] kvm [1]: HYP mode not available379machine # [ 0.453491] Initialise system trusted keyrings380machine # [ 0.454265] workingset: timestamp_bits=42 max_order=18 bucket_order=0381machine # [ 0.455529] squashfs: version 4.0 (2009/01/31) Phillip Lougher382machine # [ 0.456301] 9p: Installing v9fs 9p2000 file system support383machine # [ 0.484266] Key type asymmetric registered384machine # [ 0.484295] Asymmetric key parser 'x509' registered385machine # [ 0.484371] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)386machine # [ 0.486474] io scheduler mq-deadline registered387machine # [ 0.486488] io scheduler kyber registered388machine # [ 0.495464] ledtrig-cpu: registered to indicate activity on CPUs389machine # [ 0.497495] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0390machine # [ 0.497559] ACPI: button: Power Button [PWRB]391machine # [ 0.522081] ACPI: \_SB_.L001: Enabled at IRQ 36392machine # [ 0.522164] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)393machine # [ 0.532758] ACPI: \_SB_.L002: Enabled at IRQ 37394machine # [ 0.532971] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)395machine # [ 0.534447] ACPI: \_SB_.L003: Enabled at IRQ 38396machine # [ 0.534480] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)397machine # [ 0.539293] ACPI: \_SB_.L000: Enabled at IRQ 35398machine # [ 0.539334] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)399machine # [ 0.545791] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)400machine # [ 0.557130] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)401machine # [ 0.559424] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)402machine # [ 0.569959] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)403machine # [ 0.574438] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)404machine # [ 0.582668] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)405machine # [ 0.588599] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)406machine # [ 0.604872] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled407machine # [ 0.607551] msm_serial: driver initialized408machine # [ 0.607694] SuperH (H)SCI(F) driver initialized409machine # [ 0.607735] STM32 USART driver initialized410machine # [ 0.625058] ACPI: bus type drm_connector registered411machine # [ 0.633323] loop: module loaded412machine # [ 0.633514] virtio_blk virtio5: 1/0/0 default/read/poll queues413machine # [ 0.634091] virtio_blk virtio5: [vda] 4929536 512-byte logical blocks (2.52 GB/2.35 GiB)414machine # [ 0.675495] vda: vda1 vda2415machine # [ 0.675912] virtio_blk virtio6: 1/0/0 default/read/poll queues416machine # [ 0.676652] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)417machine # [ 0.684129] megasas: 07.734.00.00-rc1418machine # [ 0.686509] tun: Universal TUN/TAP device driver, 1.6419machine # [ 0.689593] thunder_xcv, ver 1.0420machine # [ 0.689637] thunder_bgx, ver 1.0421machine # [ 0.689661] nicpf, ver 1.0422machine # [ 0.690227] e1000: Intel(R) PRO/1000 Network Driver423machine # [ 0.690236] e1000: Copyright (c) 1999-2006 Intel Corporation.424machine # [ 0.690263] e1000e: Intel(R) PRO/1000 Network Driver425machine # [ 0.690271] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.426machine # [ 0.690313] igb: Intel(R) Gigabit Ethernet Network Driver427machine # [ 0.690322] igb: Copyright (c) 2007-2014 Intel Corporation.428machine # [ 0.690355] igbvf: Intel(R) Gigabit Virtual Function Network Driver429machine # [ 0.690363] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.430machine # [ 0.690494] sky2: driver version 1.30431machine # [ 0.700158] usbcore: registered new interface driver usb-storage432machine # [ 0.700223] usbcore: registered new interface driver usbserial_generic433machine # [ 0.700249] usbserial: USB Serial support registered for generic434machine # [ 0.700799] hv_vmbus: registering driver hyperv_keyboard435machine # [ 0.701877] ehci-pci 0000:00:0b.0: EHCI Host Controller436machine # [ 0.701904] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 1437machine # [ 0.702146] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a000438machine # [ 0.708167] rtc-efi rtc-efi.0: registered as rtc0439machine # [ 0.708767] rtc-efi rtc-efi.0: setting system clock to 2026-09-06T02:38:30 UTC (1788662310)440machine # [ 0.709086] i2c_dev: i2c /dev entries driver441machine # [ 0.713147] sdhci: Secure Digital Host Controller Interface driver442machine # [ 0.713161] sdhci: Copyright(c) Pierre Ossman443machine # [ 0.713393] Synopsys Designware Multimedia Card Interface Driver444machine # [ 0.713715] sdhci-pltfm: SDHCI platform and OF driver helper445machine # [ 0.714776] pstore: Using crash dump compression: deflate446machine # [ 0.714787] pstore: Registered efi_pstore as persistent store backend447machine # [ 0.718943] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.00448machine # [ 0.719339] hub 1-0:1.0: USB hub found449machine # [ 0.719366] hub 1-0:1.0: 6 ports detected450machine # [ 0.728509] hid: raw HID events driver (C) Jiri Kosina451machine # [ 0.728796] usbcore: registered new interface driver usbhid452machine # [ 0.728805] usbhid: USB HID core driver453machine # [ 0.731616] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available454machine # [ 0.733027] drop_monitor: Initializing network drop monitor service455machine # [ 0.733209] NET: Registered PF_INET6 protocol family456machine # [ 0.739952] Segment Routing with IPv6457machine # [ 0.739990] In-situ OAM (IOAM) with IPv6458machine # [ 0.740021] NET: Registered PF_PACKET protocol family459machine # [ 0.741730] 9pnet: Installing 9P2000 support460machine # [ 0.748155] Key type dns_resolver registered461machine # [ 0.763935] registered taskstats version 1462machine # [ 0.764102] Loading compiled-in X.509 certificates463machine # [ 0.779463] Demotion targets for Node 0: null464machine # [ 0.787635] Key type .fscrypt registered465machine # [ 0.787659] Key type fscrypt-provisioning registered466machine # [ 0.787780] ima: No TPM chip found, activating TPM-bypass!467machine # [ 0.787802] ima: Allocated hash algorithm: sha1468machine # [ 0.787827] ima: No architecture policies found469machine # [ 0.821339] clk: Disabling unused clocks470machine # [ 0.821379] PM: genpd: Disabling unused power domains471machine # [ 0.953997] Freeing initrd memory: 26100K472machine # [ 0.957525] Freeing unused kernel memory: 4736K473machine # [ 0.957737] Run /init as init process474machine # [ 0.971477] usb 1-1: new high-speed USB device number 2 using ehci-pci475machine # [ 0.976325] fuse: init (API version 7.45)476machine # [ 0.991524] systemd[1]: Successfully made /usr/ read-only.477machine # [ 1.123800] 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.195854] 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.319507] usb 1-2: new high-speed USB device number 3 using ehci-pci480machine # [ 1.326468] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)481machine # [ 1.338626] systemd[1]: Detected virtualization kvm.482machine # [ 1.340677] systemd[1]: Detected architecture arm64.483machine # [ 1.342531] systemd[1]: Running in initrd.484machine # [ 1.345217] systemd[1]: Initializing machine ID from random generator.485machine # [ 1.348067] systemd[1]: Hostname set to <machine>.486machine # [ 1.477220] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:0b.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2487machine # [ 1.477406] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input0488machine # [ 1.498151] systemd[1]: bpf-restrict-fs: LSM BPF program attached489machine # [ 1.554500] systemd[1]: Queued start job for default target Initrd Default Target.490machine # [ 1.565368] systemd[1]: Created slice Slice /system/modprobe.491machine # [ 1.566306] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.492machine # [ 1.567300] systemd[1]: Expecting device /dev/disk/by-label/nixos...493machine # [ 1.568234] systemd[1]: Expecting device /dev/tpm0...494machine # [ 1.568871] systemd[1]: Expecting device /dev/tpmrm0...495machine # [ 1.569537] systemd[1]: Reached target Path Units.496machine # [ 1.570151] systemd[1]: Reached target Slice Units.497machine # [ 1.570771] systemd[1]: Reached target Swaps.498machine # [ 1.571336] systemd[1]: Reached target Timer Units.499machine # [ 1.572163] systemd[1]: Listening on D-Bus System Message Bus Socket.500machine # [ 1.573093] systemd[1]: Listening on Journal Socket (/dev/log).501machine # [ 1.573947] systemd[1]: Listening on Journal Sockets.502machine # [ 1.574623] systemd[1]: Listening on udev Kernel Socket.503machine # [ 1.575272] systemd[1]: Reached target Socket Units.504machine # [ 1.577277] systemd[1]: Starting Create List of Static Device Nodes...505machine # [ 1.591617] systemd[1]: Starting Load Kernel Module 9pnet_virtio...506machine # [ 1.591708] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs507machine # [ 1.595097] systemd[1]: Mounting Kernel Configuration File System...508machine # [ 1.603680] systemd[1]: Starting Journal Service...509machine # [ 1.627789] systemd[1]: Starting Load Kernel Modules...510machine # [ 1.652046] systemd[1]: Starting Coldplug All udev Devices...511machine # [ 1.659256] systemd-journald[73]: Collecting audit messages is disabled.512machine # [ 1.671634] systemd[1]: Finished Create List of Static Device Nodes.513machine # [ 1.673025] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.514machine # [ 1.673343] systemd[1]: Finished Load Kernel Module 9pnet_virtio.515machine # [ 1.673580] systemd[1]: Mounted Kernel Configuration File System.516machine # [ 1.687831] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...517machine # [ 1.699971] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.518machine # [ 1.711603] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev519machine # [ 1.723812] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0520machine # [ 1.724052] [drm] features: -virgl +edid -resource_blob -host_visible521machine # [ 1.724063] [drm] features: -context_init522machine # [ 1.724786] [drm] number of scanouts: 1523machine # [ 1.724805] [drm] number of cap sets: 0524machine # [ 1.743817] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic525machine # [ 1.743845] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0526machine # [ 1.756207] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.527machine # [ 1.760341] Console: switching to colour frame buffer device 160x50528machine # [ 1.771881] systemd[1]: Starting Create Static Device Nodes in /dev...529machine # [ 1.788204] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device530machine # [ 1.805267] systemd[1]: Finished Load Kernel Modules.531machine # [ 1.807616] systemd[1]: Starting Apply Kernel Variables...532machine # [ 1.839810] systemd[1]: Finished Create Static Device Nodes in /dev.533machine # [ 1.840091] systemd[1]: Reached target Preparation for Local File Systems.534machine # [ 1.840131] systemd[1]: Reached target Local File Systems.535machine # [ 1.845373] systemd[1]: Starting Rule-based Manager for Device Events and Files...536machine # [ 1.835063] systemd-modules-load[74]: Inserted module 'dm_mod'537machine # [ 1.863872] systemd[1]: Started Journal Service.538machine # [ 1.839983] systemd-modules-load[74]: Module 'virtio_balloon' is built in539machine # [ 1.841209] systemd-modules-load[74]: Module 'virtio_console' is built in540machine # [ 1.842317] systemd-modules-load[74]: Inserted module 'virtio_gpu'541machine # [ 1.843324] systemd-modules-load[74]: Module 'virtio_rng' is built in542machine # [ 1.858716] systemd[1]: Finished Apply Kernel Variables.543machine # [ 1.888127] systemd[1]: Starting Create System Files and Directories...544machine # [ 1.913616] systemd[1]: Finished Create System Files and Directories.545machine # [ 1.917519] systemd-udevd[80]: Using default interface naming scheme 'v261'.546machine # [ 1.950324] systemd[1]: Started Rule-based Manager for Device Events and Files.547machine # [ 2.020161] systemd[1]: Starting Virtual Console Setup...548machine # [ 2.068540] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.549machine # [ 2.076617] systemd[1]: Finished Virtual Console Setup.550machine # [ 2.723920] systemd[1]: Finished Coldplug All udev Devices.551machine # [ 2.859431] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.552machine # [ 2.883394] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.553machine # [ 2.890300] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line.554machine # [ 3.061051] systemd[1]: Found device /dev/disk/by-label/nixos.555machine # [ 3.080552] systemd[1]: Reached target Initrd Root Device.556machine # [ 3.083744] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...557machine # [ 3.131577] systemd-fsck[110]: nixos: clean, 67477/137632 files, 417266/550144 blocks558machine # [ 3.143357] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.559machine # [ 3.152320] systemd[1]: Mounting /sysroot...560machine # [ 3.221403] EXT4-fs (vda2): mounted filesystem f222513b-ded1-49fa-b591-20ce86a2fe7f r/w with ordered data mode. Quota mode: none.561machine # [ 3.199598] systemd[1]: Mounted /sysroot.562machine # [ 3.206174] systemd[1]: Reached target Initrd Root File System.563machine # [ 3.207758] systemd[1]: Starting Mountpoints Configured in the Real Root...564machine # [ 3.236179] systemd-sysroot-fstab-check[117]: /sysroot should be mounted in the initrd, will request daemon-reload.565machine # [ 3.242113] systemd[1]: Reload requested from client PID 117 ('systemd-sysroot') (unit initrd-parse-etc.service)...566machine # [ 3.247052] systemd[1]: Reloading...567machine # [ 3.488124] systemd[1]: Reloading finished in 242 ms.568machine # [ 3.520112] systemd-sysroot-fstab-check[117]: Requesting initrd-fs.target/start/replace...569machine # [ 3.524922] systemd-sysroot-fstab-check[117]: Requesting swap.target/start/replace...570machine # [ 3.531098] systemd[1]: Starting Load Kernel Module 9pnet_virtio...571machine # [ 3.533996] systemd[1]: initrd-parse-etc.service: Deactivated successfully.572machine # [ 3.543609] systemd[1]: Finished Mountpoints Configured in the Real Root.573machine # [ 3.545535] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.574machine # [ 3.560762] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.575machine # [ 3.564185] systemd[1]: Finished Load Kernel Module 9pnet_virtio.576machine # [ 3.629682] systemd[1]: Mounting /sysroot/nix/.ro-store...577machine # [ 3.640470] systemd[1]: Mounting /sysroot/nix/.rw-store...578machine # [ 3.643730] systemd[1]: sysroot-run.mount: Directory /sysroot/run to mount over is not empty, mounting anyway.579machine # [ 3.663028] systemd[1]: Mounting /sysroot/run...580machine # [ 3.692079] systemd[1]: Mounting /sysroot/tmp/shared...581machine # [ 3.710793] systemd[1]: Mounting /sysroot/tmp/xchg...582machine # [ 3.742269] systemd[1]: Mounted /sysroot/nix/.ro-store.583machine # [ 3.751480] systemd[1]: Mounted /sysroot/nix/.rw-store.584machine # [ 3.766617] systemd[1]: Mounted /sysroot/run.585machine # [ 3.787078] systemd[1]: Starting rw-sysroot-nix-store.service...586machine # [ 3.795762] systemd[1]: Mounted /sysroot/tmp/shared.587machine # [ 3.808159] systemd[1]: Mounted /sysroot/tmp/xchg.588machine # [ 3.822983] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.589machine # [ 3.824581] systemd[1]: Finished rw-sysroot-nix-store.service.590machine # [ 4.296900] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)591machine # [ 4.418926] systemd[1]: Found device /dev/tpm0.592machine # [ 4.429858] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.593machine # [ 4.435107] systemd[1]: Stopped Virtual Console Setup.594machine # [ 4.443150] systemd[1]: Stopping Virtual Console Setup...595machine # [ 4.448199] systemd[1]: Starting Virtual Console Setup...596machine # [ 4.473959] systemd[1]: Found device /dev/tpmrm0.597machine # [ 4.479168] systemd[1]: Reached target Trusted Platform Module.598machine # [ 4.485859] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os599machine # [ 4.489046] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.600machine # [ 4.490588] systemd[1]: Stopped Virtual Console Setup.601machine # [ 4.493273] systemd[1]: Starting Virtual Console Setup...602machine # [ 4.521718] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones.603machine # [ 4.525352] systemd[1]: Finished Virtual Console Setup.604machine # [ 4.526837] systemd[1]: Reached target System Initialization.605machine # [ 4.527689] systemd[1]: Reached target Basic System.606machine # [ 4.631060] systemd[1]: sysroot-nix-store.mount: Directory /sysroot/nix/store to mount over is not empty, mounting anyway.607machine # [ 4.640363] systemd[1]: Mounting /sysroot/nix/store...608machine # [ 4.694364] systemd[1]: Mounted /sysroot/nix/store.609machine # [ 4.697207] systemd[1]: Reached target Initrd File Systems.610machine # [ 4.701974] systemd[1]: Starting Find NixOS closure...611machine # [ 4.710323] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...612machine # [ 4.761258] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.613machine # [ 4.765995] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.614machine # [ 4.780443] systemd[1]: Finished Find NixOS closure.615machine # [ 4.783121] systemd[1]: Reached target Initrd Default Target.616machine # [ 4.784830] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...617machine # [ 4.815131] systemd[1]: Stopped target Initrd Default Target.618machine # [ 4.820898] systemd[1]: Stopped target Basic System.619machine # [ 4.821845] systemd[1]: Stopped target Initrd Root Device.620machine # [ 4.822825] systemd[1]: Stopped target Path Units.621machine # [ 4.823665] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.622machine # [ 4.826326] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.623machine # [ 4.832196] systemd[1]: Stopped target Slice Units.624machine # [ 4.833100] systemd[1]: Stopped target Socket Units.625machine # [ 4.833908] systemd[1]: Stopped target System Initialization.626machine # [ 4.834846] systemd[1]: Stopped target Swaps.627machine # [ 4.836105] systemd[1]: Stopped target Timer Units.628machine # [ 4.837775] systemd[1]: Stopped target Trusted Platform Module.629machine # [ 4.839988] systemd[1]: dbus.socket: Deactivated successfully.630machine # [ 4.842232] systemd[1]: Closed D-Bus System Message Bus Socket.631machine # [ 4.844242] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.632machine # [ 4.848900] systemd[1]: Stopped Find NixOS closure.633machine # [ 4.853087] systemd[1]: Starting Load Kernel Module 9pnet_virtio...634machine # [ 4.854808] systemd[1]: Starting rw-sysroot-nix-store.service...635machine # [ 4.857072] systemd[1]: systemd-sysctl.service: Deactivated successfully.636machine # [ 4.864210] systemd[1]: Stopped Apply Kernel Variables.637machine # [ 4.869999] systemd[1]: systemd-modules-load.service: Deactivated successfully.638machine # [ 4.871126] systemd[1]: Stopped Load Kernel Modules.639machine # [ 4.876376] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.640machine # [ 4.881618] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.641machine # [ 4.886650] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.642machine # [ 4.893521] systemd[1]: Stopped Create System Files and Directories.643machine # [ 4.896313] systemd[1]: Stopped target Local File Systems.644machine # [ 4.897495] systemd[1]: Stopped target Preparation for Local File Systems.645machine # [ 4.899734] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.646machine # [ 4.902001] systemd[1]: Stopped Coldplug All udev Devices.647machine # [ 4.903823] systemd[1]: Stopping Rule-based Manager for Device Events and Files...648machine # [ 4.907271] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.649machine # [ 4.909047] systemd[1]: Stopped Virtual Console Setup.650machine # [ 4.912407] systemd[1]: initrd-cleanup.service: Deactivated successfully.651machine # [ 4.913413] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.652machine # [ 4.915335] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.653machine # [ 4.918799] systemd[1]: Finished Load Kernel Module 9pnet_virtio.654machine # [ 4.919678] systemd[1]: systemd-udevd.service: Deactivated successfully.655machine # [ 4.920880] systemd[1]: Stopped Rule-based Manager for Device Events and Files.656machine # [ 4.921882] systemd[1]: systemd-udevd.service: Consumed 1.527s CPU time over 3.081s wall clock time, 22.9M memory peak.657machine # [ 4.923301] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.658machine # [ 4.924459] systemd[1]: Finished rw-sysroot-nix-store.service.659machine # [ 4.925271] systemd[1]: Starting Cleanup udev Database...660machine # [ 4.926030] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.661machine # [ 4.927275] systemd[1]: Stopped Create Static Device Nodes in /dev.662machine # [ 4.932253] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.663machine # [ 4.933461] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.664machine # [ 4.936474] systemd[1]: kmod-static-nodes.service: Deactivated successfully.665machine # [ 4.940241] systemd[1]: Stopped Create List of Static Device Nodes.666machine # [ 4.977286] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.667machine # [ 4.978995] systemd[1]: Finished Cleanup udev Database.668machine # [ 4.981743] systemd[1]: Reached target Switch Root.669machine # [ 4.983005] systemd[1]: Starting NixOS Activation...670machine # [ 5.163921] initrd-nixos-activation-start[180]: booting system configuration /nix/store/n0r7si3yim6yg9l95rgfp4znryb4y0hl-nixos-system-machine-test671machine # [ 5.236255] initrd-nixos-activation-start[180]: running activation script...672machine # [ 5.696539] initrd-nixos-activation-start[203]: setting up /etc...673machine # [ 6.054527] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.674machine # [ 6.057509] systemd[1]: Finished NixOS Activation.675machine # [ 6.058844] systemd[1]: Starting Switch Root...676machine # [ 6.081011] systemd[1]: Switching root.677machine # [ 6.291051] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).678machine # [ 6.482429] NET: Registered PF_VSOCK protocol family679machine # [ 6.876280] systemd[1]: systemd 262-9457f81 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.888564] systemd[1]: Detected virtualization kvm.681machine # [ 6.891590] systemd[1]: Detected architecture arm64.682machine # [ 6.894550] systemd[1]: Detected first boot.683machine # [ 6.902412] systemd[1]: Initializing machine ID from random generator.684machine # [ 7.076689] systemd[1]: bpf-restrict-fs: LSM BPF program attached685machine # [ 7.255247] systemd[1]: Applying preset policy.686machine # [ 7.761510] systemd[1]: Populated /etc with preset unit settings.687machine # [ 8.304094] systemd[1]: initrd-switch-root.service: Deactivated successfully.688machine # [ 8.306566] systemd[1]: Stopped initrd-switch-root.service.689machine # [ 8.309403] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.690machine # [ 8.312290] systemd[1]: Created slice Slice /system/getty.691machine # [ 8.314350] systemd[1]: Created slice Slice /system/systemd-fsck.692machine # [ 8.316524] systemd[1]: Created slice User and Session Slice.693machine # [ 8.318670] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.694machine # [ 8.320236] systemd[1]: Started Forward Password Requests to Wall Directory Watch.695machine # [ 8.321940] systemd[1]: Expecting device /dev/disk/by-label/ESP...696machine # [ 8.323604] systemd[1]: Expecting device /dev/hvc0...697machine # [ 8.325840] systemd[1]: Expecting device /dev/ttyAMA0...698machine # [ 8.326886] systemd[1]: Reached target Local Encrypted Volumes.699machine # [ 8.328583] systemd[1]: Stopped target initrd-fs.target.700machine # [ 8.330852] systemd[1]: Stopped target initrd-root-fs.target.701machine # [ 8.331999] systemd[1]: Stopped target initrd-switch-root.target.702machine # [ 8.333595] systemd[1]: Reached target Virtual Machines and Containers.703machine # [ 8.335291] systemd[1]: Reached target Path Units.704machine # [ 8.336729] systemd[1]: Reached target Remote File Systems.705machine # [ 8.338444] systemd[1]: Reached target Slice Units.706machine # [ 8.340011] systemd[1]: Reached target Swaps.707machine # [ 8.344246] systemd[1]: Listening on Query the User Interactively for a Password.708machine # [ 8.349186] systemd[1]: Listening on Process Core Dump Socket.709machine # [ 8.353201] systemd[1]: Listening on Credential Encryption/Decryption.710machine # [ 8.356935] systemd[1]: Listening on Factory Reset Management.711machine # [ 8.358208] systemd[1]: Listening on Hostname Service Socket.712machine # [ 8.364139] systemd[1]: Starting Journal Log Access Socket...713machine # [ 8.366284] systemd[1]: Listening on Journal Audit Socket.714machine # [ 8.370164] systemd[1]: Listening on Console Output Muting Service Socket.715machine # [ 8.371737] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.716machine # [ 8.373731] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os717machine # [ 8.376512] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki718machine # [ 8.387499] systemd[1]: Listening on Disk Repartitioning Service Socket.719machine # [ 8.389869] systemd[1]: Listening on udev Varlink Socket.720machine # [ 8.395104] systemd[1]: Mounting Huge Pages File System...721machine # [ 8.400763] systemd[1]: Mounting POSIX Message Queue File System...722machine # [ 8.409519] systemd[1]: Mounting Kernel Debug File System...723machine # [ 8.423638] systemd[1]: Mounting Kernel Trace File System...724machine # [ 8.435025] systemd[1]: Starting Create List of Static Device Nodes...725machine # [ 8.451855] systemd[1]: Starting Load Kernel Module 9pnet_virtio...726machine # [ 8.455373] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs727machine # [ 8.467046] systemd[1]: Mounting Kernel Configuration File System...728machine # [ 8.469566] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm729machine # [ 8.472151] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore730machine # [ 8.475012] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse731machine # [ 8.547828] systemd[1]: Mounting FUSE Control File System...732machine # [ 8.550724] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67733machine # [ 8.595056] systemd[1]: Starting Journal Service...734machine # [ 8.616381] systemd[1]: Starting Load Kernel Modules...735machine # [ 8.641753] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...736machine # [ 8.660420] systemd[1]: Starting Remount Root and Kernel File Systems...737machine # [ 8.664375] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os738machine # [ 8.705379] systemd[1]: Starting Coldplug All udev Devices...739machine # [ 8.712117] systemd-journald[275]: Collecting audit messages is enabled.740machine # [ 8.691975] systemd[1]: Queued start job for default target Multi-User System.741machine # [ 8.704718] systemd[1]: systemd-journald.service: Deactivated successfully.742machine # [ 8.710829] systemd-modules-load[276]: Module 'atkbd' is built in743machine # [ 8.739404] systemd[1]: Started Journal Service.744machine # [ 8.720753] systemd-modules-load[276]: Module 'loop' is built in745machine # [ 8.721771] systemd[1]: Listening on Journal Log Access Socket.746machine # [ 8.722777] systemd[1]: Mounted Huge Pages File System.747machine # [ 8.723661] systemd[1]: Mounted POSIX Message Queue File System.748machine # [ 8.730666] systemd[1]: Mounted Kernel Debug File System.749machine # [ 8.739601] systemd[1]: Mounted Kernel Trace File System.750machine # [ 8.741127] systemd[1]: Finished Create List of Static Device Nodes.751machine # [ 8.748665] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.752machine # [ 8.753164] systemd[1]: Finished Load Kernel Module 9pnet_virtio.753machine # [ 8.758743] systemd[1]: Mounted Kernel Configuration File System.754machine # [ 8.765641] systemd[1]: Mounted FUSE Control File System.755machine # [ 8.773170] systemd[1]: Finished Load Kernel Modules.756machine # [ 8.779915] systemd[1]: Starting Firewall...757machine # [ 8.785229] systemd[1]: Starting Apply Kernel Variables...758machine # [ 8.797622] systemd-oomd[278]: No swap; memory pressure usage will be degraded759machine # [ 8.831785] EXT4-fs (vda2): re-mounted f222513b-ded1-49fa-b591-20ce86a2fe7f.760machine # [ 8.812496] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...761machine # [ 8.829796] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.762machine # [ 8.832416] systemd[1]: Finished Remount Root and Kernel File Systems.763machine # [ 8.854607] systemd[1]: Listening on Disk Image Download Service Socket.764machine # [ 8.866109] systemd[1]: Starting Flush Journal to Persistent Storage...765machine # [ 8.872243] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore766machine # [ 8.881072] systemd[1]: Starting Load/Save OS Random Seed...767machine # [ 8.892184] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os768machine # [ 8.977250] systemd[1]: Finished Apply Kernel Variables.769machine # [ 8.996670] systemd[1]: Finished Load/Save OS Random Seed.770machine # [ 8.998449] systemd[1]: Reached target First Boot Complete.771machine # [ 9.031428] systemd-journald[275]: Received client request to flush runtime journal.772machine # [ 9.058763] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.773machine # [ 9.067034] systemd[1]: Starting Create Static Device Nodes in /dev...774machine # [ 9.068762] systemd[1]: Finished Flush Journal to Persistent Storage.775machine # [ 9.183471] systemd[1]: Finished Create Static Device Nodes in /dev.776machine # [ 9.184914] systemd[1]: Reached target Preparation for Local File Systems.777machine # [ 9.194075] systemd[1]: Starting Rule-based Manager for Device Events and Files...778machine # [ 9.291398] systemd[1]: Mounting /run/wrappers...779machine # [ 9.337743] systemd-udevd[317]: Using default interface naming scheme 'v261'.780machine # [ 9.352245] systemd[1]: Mounted /run/wrappers.781machine # [ 9.364326] systemd[1]: Starting Create SUID/SGID Wrappers...782machine # [ 9.562805] systemd[1]: Started Rule-based Manager for Device Events and Files.783machine # [ 10.190415] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.784machine # [ 10.193478] systemd[1]: Finished Create SUID/SGID Wrappers.785machine # [ 10.625716] systemd[1]: Finished Coldplug All udev Devices.786machine # [ 10.669392] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs787machine # [ 10.695583] systemd[1]: Finished Firewall.788machine # [ 10.698332] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse789machine # [ 10.791490] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.790machine # [ 10.815752] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.791machine # [ 10.857246] systemd[1]: Found device /dev/tpmrm0.792machine # [ 10.860479] systemd[1]: Expecting device /dev/tpm0...793machine # [ 10.866546] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line.794machine # [ 10.873907] (udev-worker)[364]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.795machine # [ 10.878970] (udev-worker)[364]: Network interface NamePolicy= disabled on kernel command line.796machine # [ 11.001382] systemd[1]: Condition check resulted in Virtio network device being skipped.797machine # [ 11.008200] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore798machine # [ 11.011457] systemd[1]: Starting Create SUID/SGID Wrappers...799machine # [ 11.012787] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67800machine # [ 11.017040] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore801machine # [ 11.088565] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.802machine # [ 11.096808] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...803machine # [ 11.202845] systemd-fsck[490]: fsck.fat 4.2 (2021-01-31)804machine # [ 11.205579] systemd-fsck[490]: /dev/vda1: 20 files, 28914/63671 clusters805machine # [ 11.216351] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.806machine # [ 11.225301] systemd[1]: Mounting /boot...807machine # [ 11.341798] systemd[1]: Mounted /boot.808machine # [ 11.343110] systemd[1]: Reached target Local File Systems.809machine # [ 11.347424] systemd[1]: Listening on Boot Loader Control Service Socket.810machine # [ 11.355253] systemd[1]: Starting register-nix-paths.service...811machine # [ 11.367394] systemd[1]: Starting Update Boot Loader Random Seed...812machine # [ 11.379416] systemd[1]: Starting Save Transient machine-id to Disk...813machine # [ 11.409388] systemd[1]: Starting Create System Files and Directories...814machine # [ 11.492177] systemd[1]: Finished register-nix-paths.service.815machine # [ 11.507592] bootctl[514]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 816machine # [ 11.530399] bootctl[514]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!817machine # [ 11.532383] bootctl[514]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).818machine # [ 11.561742] mousedev: PS/2 mouse device common for all mice819machine # [ 11.542366] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.820machine # [ 11.547438] bootctl[514]: Successfully initialized system token in EFI variable with 32 bytes.821machine # [ 11.553948] systemd[1]: Finished Save Transient machine-id to Disk.822machine # [ 11.558164] systemd[1]: Finished Update Boot Loader Random Seed.823machine # [ 11.629337] systemd[1]: Finished Create System Files and Directories.824machine # [ 11.638633] systemd[1]: Starting Rebuild Journal Catalog...825machine # [ 11.643773] systemd[1]: Starting Record System Boot/Shutdown in UTMP...826machine # [ 11.730048] systemd[1]: Finished Record System Boot/Shutdown in UTMP.827machine # [ 11.786862] systemd[1]: Finished Rebuild Journal Catalog.828machine # [ 11.795626] systemd[1]: Starting Update is Completed...829machine # [ 11.812991] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.830machine # [ 11.817464] systemd[1]: Finished Create SUID/SGID Wrappers.831machine # [ 11.858005] systemd[1]: Finished Update is Completed.832machine # [ 12.653153] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input3833machine # [ 12.680275] systemd[1]: Found device /dev/tpm0.834machine # [ 12.681870] systemd[1]: Reached target Trusted Platform Module.835machine # [ 12.683883] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os836machine # [ 12.689185] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os837machine # [ 12.692091] systemd[1]: Reached target System Initialization.838machine # [ 12.696300] systemd[1]: Started Discard unused filesystem blocks once a week.839machine # [ 12.699752] systemd[1]: Started Daily Cleanup of Temporary Directories.840machine # [ 12.704221] systemd[1]: Reached target Timer Units.841machine # [ 12.705677] systemd[1]: Listening on D-Bus System Message Bus Socket.842machine # [ 12.708915] systemd[1]: Listening on Nix Daemon Socket.843machine # [ 12.710678] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.844machine # [ 12.717354] systemd[1]: Reached target Socket Units.845machine # [ 12.719489] systemd[1]: Reached target Basic System.846machine # [ 12.720334] systemd[1]: Started backdoor.service.847machine # [ 12.723827] systemd[1]: Starting Import lastlog data into lastlog2 database...848machine # [ 12.732918] systemd[1]: Starting Name Service Cache Daemon (nsncd)...849machine # [ 12.746628] systemd[1]: Starting Post-Boot Actions...850machine # [ 12.788653] systemd[1]: Started Reset console on configuration changes.851machine # [ 12.814094] systemd[1]: Starting resolvconf update...852machine # connecting to host...853machine # [ 12.898150] systemd[1]: Starting D-Bus System Message Bus...854machine: Guest shell says: b'Spawning backdoor root shell...\n'855machine # [ 12.921276] systemd[1]: Finished Post-Boot Actions.856machine # [ 12.940516] systemd[1]: Finished Import lastlog data into lastlog2 database.857machine # [ 12.947322] nsncd[574]: Sep 06 02:38:42.765 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"858machine # [ 12.960324] systemd[1]: Started Name Service Cache Daemon (nsncd).859machine: connected to guest root shell860machine # [ 12.961169] systemd[1]: Reached target Host and Network Name Lookups.861machine: (connecting took 26.21 seconds)862machine # [ 12.961974] systemd[1]: Reached target User and Group Name Lookups.863machine: (finished: waiting for the VM to finish booting, in 27.46 seconds)864machine # [ 12.972935] systemd[1]: Starting User Login Management...865machine # [ 13.124166] dbus-broker-launch[585]: Looking up NSS user entry for 'systemd-timesync'...866machine # [ 13.171240] systemd-logind[600]: New seat seat0.867machine # [ 13.183198] systemd-logind[600]: Watching system buttons on /dev/input/event0 (Power Button)868machine # [ 13.191237] systemd-logind[600]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)869machine # [ 13.194178] systemd[1]: Started User Login Management.870machine # [ 13.199983] dbus-broker-launch[585]: NSS returned no entry for 'systemd-timesync'871machine # [ 13.206123] dbus-broker-launch[585]: Invalid user-name in /nix/store/7g7ddl8k6a8nlp26ghg0g8xgvjqlri9h-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"872machine # [ 13.218892] systemd[1]: Starting linger-users.service...873machine # [ 13.254017] systemd[1]: Started D-Bus System Message Bus.874machine # [ 13.273578] systemd[1]: Starting Virtual Console Setup...875machine # [ 13.321608] dbus-broker-launch[585]: Ready876machine # [ 13.329284] systemd[1]: linger-users.service: Deactivated successfully.877machine # [ 13.331981] systemd[1]: Finished linger-users.service.878machine # [ 13.365002] systemd[1]: Stopped target Host and Network Name Lookups.879machine # [ 13.371188] systemd[1]: Stopping Host and Network Name Lookups...880machine # [ 13.374717] systemd[1]: Stopped target User and Group Name Lookups.881machine # [ 13.375634] systemd[1]: Stopping User and Group Name Lookups...882machine # [ 13.381242] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...883machine # [ 13.383604] systemd[1]: nscd.service: Deactivated successfully.884machine # [ 13.388974] systemd[1]: Stopped Name Service Cache Daemon (nsncd).885machine # [ 13.398451] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.886machine # [ 13.404625] systemd[1]: Stopped Virtual Console Setup.887machine # [ 13.426047] systemd[1]: Starting Name Service Cache Daemon (nsncd)...888machine # [ 13.430172] systemd[1]: Starting Virtual Console Setup...889machine # [ 13.467939] systemd-logind[600]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)890machine # [ 13.511547] systemd[1]: Finished resolvconf update.891machine # [ 13.515289] systemd[1]: Reached target Preparation for Network.892machine # [ 13.523078] systemd[1]: Starting DHCP Client...893machine # [ 13.527636] nsncd[669]: Sep 06 02:38:43.344 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"894machine # [ 13.534424] systemd[1]: Starting Address configuration of eth1...895machine # [ 13.542702] systemd[1]: Starting Extra networking commands....896machine # [ 13.545132] systemd[1]: Started Name Service Cache Daemon (nsncd).897machine # [ 13.548362] systemd[1]: Reached target Host and Network Name Lookups.898machine # [ 13.553174] systemd[1]: Reached target User and Group Name Lookups.899machine # [ 13.684397] network-addresses-eth1-start[690]: adding address 192.168.1.1/24... done900machine # [ 13.707236] network-addresses-eth1-start[690]: adding address 2001:db8:1::1/64... done901machine # [ 13.739385] systemd[1]: Finished Address configuration of eth1.902machine # [ 13.786610] dhcpcd[699]: dhcpcd-10.3.2 starting903machine # [ 13.802498] dhcpcd[744]: dev: loaded udev904machine # [ 13.842025] systemd[1]: Finished Extra networking commands..905machine # [ 13.873841] 8021q: 802.1Q VLAN Support v1.8906machine # [ 13.874265] 8021q: adding VLAN 0 to HW filter on device eth1907machine # [ 13.851939] systemd[1]: Reached target Network.908machine # [ 13.857100] systemd[1]: Starting Permit User Sessions...909machine # [ 13.902712] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.910machine # [ 13.919517] systemd[1]: Finished Permit User Sessions.911machine # [ 13.932285] systemd[1]: Started Getty on tty1.912machine # [ 13.933081] systemd[1]: Reached target Login Prompts.913machine # [ 13.985344] cfg80211: Loading compiled-in X.509 certificates for regulatory database914machine # [ 14.019265] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'915machine # [ 14.020688] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'916machine # [ 14.025520] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2917machine # [ 14.025857] cfg80211: failed to load regulatory.db918machine # [ 14.092950] 8021q: adding VLAN 0 to HW filter on device eth0919machine # [ 14.068273] dhcpcd[744]: eth0: waiting for carrier920machine # [ 14.069193] dhcpcd[744]: eth0: carrier acquired921machine # [ 14.080478] dhcpcd[744]: DUID 00:01:00:01:32:2f:8e:b3:52:54:00:12:34:56922machine # [ 14.081816] dhcpcd[744]: eth0: IAID 00:12:34:56923machine # [ 14.082600] dhcpcd[744]: eth0: adding address fe80::5054:ff:fe12:3456924machine # [ 14.139174] systemd-vconsole-setup[670]: Configuration of first virtual console was skipped, ignoring remaining ones.925machine # [ 14.143053] systemd[1]: Finished Virtual Console Setup.926machine # [ 14.552916] dhcpcd[744]: eth0: soliciting a DHCP lease927machine # [ 14.557049] dhcpcd[744]: eth0: offered 10.0.2.15 from 10.0.2.2928machine # [ 14.560544] dhcpcd[744]: eth0: probing address 10.0.2.15/24929machine # [ 16.813259] dhcpcd[744]: eth0: soliciting an IPv6 router930machine # [ 16.817741] dhcpcd[744]: eth0: Router Advertisement from fe80::2931machine # [ 16.820557] dhcpcd[744]: eth0: adding address fec0::5054:ff:fe12:3456/64932machine # [ 16.823135] dhcpcd[744]: eth0: adding route to fec0::/64933machine # [ 16.825519] dhcpcd[744]: eth0: adding default route via fe80::2934machine # [ 19.334109] dhcpcd[744]: eth0: leased 10.0.2.15 for 86400 seconds935machine # [ 19.340358] dhcpcd[744]: eth0: adding route to 10.0.2.0/24936machine # [ 19.344004] dhcpcd[744]: eth0: adding default route via 10.0.2.2937machine # [ 19.529875] systemd[1]: Started DHCP Client.938machine # [ 19.532950] systemd[1]: Reached target Multi-User System.939machine # [ 19.534376] systemd[1]: Startup finished in 6.182s (firmware) + 6.403s (loader) + 934ms (kernel) + 5.459s (initrd) + 13.139s (userspace) = 32.119s.940machine: (finished: waiting for unit multi-user.target, in 34.70 seconds)941machine: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -942machine: (finished: must succeed: echo -n supersecret | cryptsetup luksFormat -q --iter-time=1 /dev/vdb -, in 2.74 seconds)943machine: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot944machine # [ 23.520350] Key type trusted registered945machine # [ 23.525335] Key type encrypted registered946machine: (finished: must succeed: echo -n supersecret | cryptsetup luksOpen -q /dev/vdb cryptroot, in 0.61 seconds)947machine: must succeed: mkfs.ext4 /dev/mapper/cryptroot948machine # mke2fs 1.47.4 (6-Mar-2025)949machine: (finished: must succeed: mkfs.ext4 /dev/mapper/cryptroot, in 0.11 seconds)950machine: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat951machine # [ 23.711601] cat[914]: Successfully called mlockall().952machine # [ 23.712749] cat[914]: Failed to find TPM2 pcrlock policy file 'pcrlock.json': No such file or directory953machine # [ 23.718488] cat[914]: Loaded shared library 'libcryptsetup.so.12' via dlopen().954machine # [ 23.720438] cat[914]: Allocating context for crypt device /dev/vdb.955machine # [ 23.721456] cat[914]: Trying to open device /dev/vdb with direct-io.956machine # [ 23.723047] cat[914]: Initialising device-mapper backend library.957machine # [ 23.724397] cat[914]: Trying to load LUKS2 crypt type from device /dev/vdb.958machine # [ 23.725512] cat[914]: Crypto backend (OpenSSL 3.6.3 9 Jun 2026 [default][legacy][threads][argon2]) initialized in cryptsetup library version 2.8.7.959machine # [ 23.728729] cat[914]: Detected kernel Linux 6.18.49 aarch64.960machine # [ 23.729843] cat[914]: Loading LUKS2 header (repair disabled).961machine # [ 23.730825] cat[914]: Acquiring read lock for device /dev/vdb.962machine # [ 23.731643] cat[914]: Opening lock resource file /run/cryptsetup/L_254:16963machine # [ 23.732934] cat[914]: Verifying lock handle for /dev/vdb.964machine # [ 23.736102] cat[914]: Device /dev/vdb READ lock taken.965machine # [ 23.736870] cat[914]: Trying to read primary LUKS2 header at offset 0x0.966machine # [ 23.737811] cat[914]: Opening locked device /dev/vdb967machine # [ 23.738526] cat[914]: Verifying locked device handle (bdev)968machine # [ 23.739301] cat[914]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.969machine # [ 23.748181] cat[914]: Checksum:34f3825325f7386384e5f1b1154574ccd929f51bdc2f82a229c49e65d4f067e3 (on-disk)970machine # [ 23.749466] cat[914]: Checksum:34f3825325f7386384e5f1b1154574ccd929f51bdc2f82a229c49e65d4f067e3 (in-memory)971machine # [ 23.750732] cat[914]: Trying to read secondary LUKS2 header at offset 0x4000.972machine # [ 23.751691] cat[914]: Reusing open ro fd on device /dev/vdb973machine # [ 23.756095] cat[914]: LUKS2 header version 2 of size 16384 bytes, checksum sha256.974machine # [ 23.757114] cat[914]: Checksum:aae05ce5046cec499e21090330f903deed3b1abde63b7eefcbf33f054cfc10e0 (on-disk)975machine # [ 23.758338] cat[914]: Checksum:aae05ce5046cec499e21090330f903deed3b1abde63b7eefcbf33f054cfc10e0 (in-memory)976machine # [ 23.759619] cat[914]: Device size 536870912, offset 16777216.977machine # [ 23.764087] cat[914]: Device /dev/vdb READ lock released.978machine # [ 23.764876] cat[914]: Only 1 active CPUs detected, PBKDF threads decreased from 4 to 1.979machine # [ 23.765968] cat[914]: Not enough physical memory detected, PBKDF max memory decreased from 1048576kB to 357912kB.980machine # [ 23.767309] cat[914]: PBKDF argon2id, time_ms 2000 (iterations 0), max_memory_kb 357912, parallel_threads 1.981machine # [ 23.772196] cat[914]: Requesting JSON for token 0.982machine # [ 23.776118] cat[914]: Requesting JSON for token 1.983machine # [ 23.776847] cat[914]: Requesting JSON for token 2.984machine # [ 23.777533] cat[914]: Requesting JSON for token 3.985machine # [ 23.778215] cat[914]: Requesting JSON for token 4.986machine # [ 23.778909] cat[914]: Requesting JSON for token 5.987machine # [ 23.779596] cat[914]: Requesting JSON for token 6.988machine # [ 23.784110] cat[914]: Requesting JSON for token 7.989machine # [ 23.784807] cat[914]: Requesting JSON for token 8.990machine # [ 23.785495] cat[914]: Requesting JSON for token 9.991machine # [ 23.786178] cat[914]: Requesting JSON for token 10.992machine # [ 23.786877] cat[914]: Requesting JSON for token 11.993machine # [ 23.787555] cat[914]: Requesting JSON for token 12.994machine # [ 23.796162] cat[914]: Requesting JSON for token 13.995machine # [ 23.796975] cat[914]: Requesting JSON for token 14.996machine # [ 23.797693] cat[914]: Requesting JSON for token 15.997machine # [ 23.798394] cat[914]: Requesting JSON for token 16.998machine # [ 23.799125] cat[914]: Requesting JSON for token 17.999machine # [ 23.799828] cat[914]: Requesting JSON for token 18.1000machine # [ 23.804127] cat[914]: Requesting JSON for token 19.1001machine # [ 23.804924] cat[914]: Requesting JSON for token 20.1002machine # [ 23.805626] cat[914]: Requesting JSON for token 21.1003machine # [ 23.806326] cat[914]: Requesting JSON for token 22.1004machine # [ 23.807054] cat[914]: Requesting JSON for token 23.1005machine # [ 23.807781] cat[914]: Requesting JSON for token 24.1006machine # [ 23.812142] cat[914]: Requesting JSON for token 25.1007machine # [ 23.812956] cat[914]: Requesting JSON for token 26.1008machine # [ 23.813659] cat[914]: Requesting JSON for token 27.1009machine # [ 23.814349] cat[914]: Requesting JSON for token 28.1010machine # [ 23.815073] cat[914]: Requesting JSON for token 29.1011machine # [ 23.815771] cat[914]: Requesting JSON for token 30.1012machine # [ 23.820118] cat[914]: Requesting JSON for token 31.1013machine # [ 23.820882] cat[914]: Keyslot 0 priority 1 != 2 (required), skipped.1014machine # [ 23.821769] cat[914]: Trying to open LUKS2 keyslot 0.1015machine # [ 23.822497] cat[914]: Running keyslot key derivation.1016machine # [ 24.127005] cat[914]: Reading keyslot area [0x8000].1017machine # [ 24.129575] cat[914]: Acquiring read lock for device /dev/vdb.1018machine # [ 24.131070] cat[914]: Opening lock resource file /run/cryptsetup/L_254:161019machine # [ 24.133096] cat[914]: Verifying lock handle for /dev/vdb.1020machine # [ 24.135106] cat[914]: Device /dev/vdb READ lock taken.1021machine # [ 24.137840] cat[914]: Reusing open ro fd on device /dev/vdb1022machine # [ 24.140331] cat[914]: Device /dev/vdb READ lock released.1023machine # [ 24.144402] cat[914]: Verifying key from keyslot 0, digest 0.1024machine # [ 24.213930] cat[914]: Failed to find TPM PCR public key file 'tpm2-pcr-public-key.pem': No such file or directory1025machine # [ 24.215563] cat[914]: Failed to read TPM2 PCR public key, proceeding without: No such file or directory1026machine # [ 24.220169] cat[914]: Loaded shared library 'libtss2-esys.so.0' via dlopen().1027machine # [ 24.222198] cat[914]: Loaded shared library 'libtss2-rc.so.0' via dlopen().1028machine # [ 24.223365] cat[914]: Loaded shared library 'libtss2-mu.so.0' via dlopen().1029machine # [ 24.225319] cat[914]: Loaded shared library 'libtss2-tcti-device.so.0' via dlopen().1030machine # [ 24.226786] cat[914]: Using TPM2 TCTI driver 'device' with device '/dev/tpmrm0'.1031machine # [ 24.228369] cat[914]: Loaded 'libtss2-tcti-device.so.0' via dlopen()1032machine # [ 24.229298] cat[914]: Loaded TCTI module 'tcti-device' (TCTI module for communication with Linux kernel interface.) [Version 2]1033machine # [ 24.232554] cat[914]: TPM successfully started up.1034machine # [ 24.233266] cat[914]: Getting TPM2 capability 0x0000 property 0x0001 count 127.1035machine # [ 24.234352] cat[914]: Getting TPM2 capability 0x0002 property 0x011f count 256.1036machine # [ 24.242486] cat[914]: Getting TPM2 capability 0x0008 property 0x0000 count 508.1037machine # [ 24.244989] cat[914]: Getting TPM2 capability 0x0005 property 0x0000 count 1.1038machine # [ 24.247506] cat[914]: Getting TPM2 capability 0x0006 property 0x012c count 1.1039machine # [ 24.252912] cat[914]: Added 32 bytes of TPM2 entropy to the kernel random pool in 1.463ms.1040machine # [ 24.254081] cat[914]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1041machine # [ 24.256269] cat[914]: TPM handle 0x81000001 not populated.1042machine # [ 24.258477] cat[914]: Creating primary key on TPM.1043machine # [ 24.267934] cat[914]: Successfully created primary key on TPM in 9ms.1044machine # [ 24.277659] cat[914]: Getting TPM2 capability 0x0001 property 0x81000001 count 1.1045machine # [ 24.314011] cat[914]: Starting HMAC encryption session.1046machine # [ 24.331871] cat[914]: Generating secret key data.1047machine # [ 24.336156] cat[914]: Creating HMAC key on TPM for shard 0.1048machine # [ 24.337114] cat[914]: Creating object on TPM.1049machine # [ 24.351390] cat[914]: Successfully created object on TPM in 18ms.1050machine # [ 24.354578] cat[914]: Marshalling private and public part of HMAC key for shard 0.1051machine # [ 24.355797] cat[914]: Completed TPM2 key sealing in 101.192ms.1052machine # [ 24.359559] cat[914]: Requesting JSON for token 0.1053machine # [ 24.361220] cat[914]: Requesting JSON for token 1.1054machine # [ 24.362039] cat[914]: Requesting JSON for token 2.1055machine # [ 24.362832] cat[914]: Requesting JSON for token 3.1056machine # [ 24.363606] cat[914]: Requesting JSON for token 4.1057machine # [ 24.364514] cat[914]: Requesting JSON for token 5.1058machine # [ 24.365378] cat[914]: Requesting JSON for token 6.1059machine # [ 24.366234] cat[914]: Requesting JSON for token 7.1060machine # [ 24.367152] cat[914]: Requesting JSON for token 8.1061machine # [ 24.369437] cat[914]: Requesting JSON for token 9.1062machine # [ 24.370239] cat[914]: Requesting JSON for token 10.1063machine # [ 24.371500] cat[914]: Requesting JSON for token 11.1064machine # [ 24.374514] cat[914]: Requesting JSON for token 12.1065machine # [ 24.375297] cat[914]: Requesting JSON for token 13.1066machine # [ 24.376113] cat[914]: Requesting JSON for token 14.1067machine # [ 24.376867] cat[914]: Requesting JSON for token 15.1068machine # [ 24.377619] cat[914]: Requesting JSON for token 16.1069machine # [ 24.378411] cat[914]: Requesting JSON for token 17.1070machine # [ 24.379170] cat[914]: Requesting JSON for token 18.1071machine # [ 24.379919] cat[914]: Requesting JSON for token 19.1072machine # [ 24.386118] cat[914]: Requesting JSON for token 20.1073machine # [ 24.388850] cat[914]: Requesting JSON for token 21.1074machine # [ 24.389568] cat[914]: Requesting JSON for token 22.1075machine # [ 24.390342] cat[914]: Requesting JSON for token 23.1076machine # [ 24.391055] cat[914]: Requesting JSON for token 24.1077machine # [ 24.392144] cat[914]: Requesting JSON for token 25.1078machine # [ 24.392836] cat[914]: Requesting JSON for token 26.1079machine # [ 24.395544] cat[914]: Requesting JSON for token 27.1080machine # [ 24.396494] cat[914]: Requesting JSON for token 28.1081machine # [ 24.397224] cat[914]: Requesting JSON for token 29.1082machine # [ 24.400416] cat[914]: Requesting JSON for token 30.1083machine # [ 24.401155] cat[914]: Requesting JSON for token 31.1084machine # [ 24.401862] cat[914]: PCR policy hash not yet enrolled, enrolling now.1085machine # [ 24.402782] cat[914]: Unsealing for verification...1086machine # [ 24.403479] cat[914]: Loading HMAC key into TPM for shard 0.1087machine # [ 24.408133] cat[914]: Loading object into TPM.1088machine # [ 24.408912] cat[914]: Starting HMAC encryption session.1089machine # [ 24.409658] cat[914]: Starting policy session.1090machine # [ 24.432586] cat[914]: Building sealing policy.1091machine # [ 24.433459] cat[914]: Acquiring policy digest.1092machine # [ 24.454812] cat[914]: Session policy digest: 00000000000000000000000000000000000000000000000000000000000000001093machine # [ 24.459790] cat[914]: Unsealing HMAC key for shard 0.1094machine # [ 24.524081] cat[914]: Completed TPM2 key unsealing in 161.556ms.1095machine # [ 24.525162] cat[914]: PBKDF pbkdf2-sha512, time_ms 0 (iterations 1000).1096machine # [ 24.526203] cat[914]: Adding new keyslot -1 by passphrase, volume key provided by key (-1).1097machine # [ 24.527498] cat[914]: Selected keyslot 1.1098machine # [ 24.591022] cat[914]: Keyslot 1 assigned to digest 0.1099machine # [ 24.592055] cat[914]: Trying to allocate LUKS2 keyslot 1.1100machine # [ 24.592850] cat[914]: Found area 290816 -> 5488641101machine # [ 24.593567] cat[914]: Reusing PBKDF values (no benchmark flag is set).1102machine # [ 24.594832] cat[914]: Calculating attributes for LUKS2 keyslot 1.1103machine # [ 24.600077] cat[914]: Acquiring write lock for device /dev/vdb.1104machine # [ 24.600957] cat[914]: Opening lock resource file /run/cryptsetup/L_254:161105machine # [ 24.601909] cat[914]: Verifying lock handle for /dev/vdb.1106machine # [ 24.602687] cat[914]: Device /dev/vdb WRITE lock taken.1107machine # [ 24.603432] cat[914]: Checking context sequence id matches value stored on disk.1108machine # [ 24.606697] cat[914]: Reusing open ro fd on device /dev/vdb1109machine # [ 24.607817] cat[914]: Running keyslot key derivation.1110machine # [ 24.609158] cat[914]: Updating keyslot area [0x47000].1111machine # [ 24.610008] cat[914]: Opening locked device /dev/vdb1112machine # [ 24.610842] cat[914]: Verifying locked device handle (bdev)1113machine # [ 24.611838] cat[914]: Device size 536870912, offset 16777216.1114machine # [ 24.612858] cat[914]: Device /dev/vdb WRITE lock already held.1115machine # [ 24.613783] cat[914]: Trying to write LUKS2 header (1039 bytes) at offset 0.1116machine # [ 24.614758] cat[914]: Reusing open rw fd on device /dev/vdb1117machine # [ 24.615541] cat[914]: Checksum:9e67c55329ff53f88aa88f1578d3adcdbc768e151a92ce63c20c5241d05a0732 (in-memory)1118machine # [ 24.617025] cat[914]: Trying to write LUKS2 header (1039 bytes) at offset 16384.1119machine # [ 24.618157] cat[914]: Reusing open rw fd on device /dev/vdb1120machine # [ 24.619357] cat[914]: Checksum:f99daa3e7863a6ce530fa6979cf783eb246af9cbc87dbb79163a736a5d7026eb (in-memory)1121machine # [ 24.621353] cat[914]: Device /dev/vdb WRITE lock released.1122machine # [ 24.622549] cat[914]: Unknown hash algorithm id 0x01123machine # [ 24.623417] cat[914]: Adding token text <{"type":"systemd-tpm2","keyslots":["1"],"tpm2-blob":"AJ4AIMp6SOcbjNdB+keI33RKodW+I2Y6NC5oVON2jSswRBvgABD2mApO6zRHCK+yxHlRzn3rw/wQnDeTw8R9wt+9JF9k2rEXqzl3wkuapZk/IstiWLciw/hdQrYbOiQ9PqLTTVkmJYZNg2rXs6jrR81AbBx+iICOmqkvpqLm9b+ltMVkhtkBDWV8uPVx7RcRiPQIVrEbNN+pDnTb5jpW/gBOAAgACwAABBIAIAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAABAAIHCMZQ7RKMeDtp7uZaGAzsbvnhdrNoLLtfMMjUlB2gcc","tpm2-pcrs":[],"tpm2-primary-alg":"ecc","tpm2-policy-hash":"0000000000000000000000000000000000000000000000000000000000000000","tpm2_srk":"gQAAAQAiAAv66P4bjHvkv2udzig4rGUG3W9dcgJCnNpM4y8IyUdz+QAAAAEAWgAjAAsAAwRyAAAABgCAAEMAEAADABAAIEVj2FbyR8UREFiQU6qgxfcLaxNDUoVbW9kJ+Gk9JgyuACDsFsDcl4JLeYlA6XwzJzM3AuTASTxelE2ff46BE5xz3g=="}>1124machine # [ 24.643642] cat[914]: Updating JSON for token -1.1125machine # [ 24.644518] cat[914]: Trying to load libcryptsetup-token-systemd-tpm2.so.1126machine # [ 24.645534] cat[914]: Loading symbol cryptsetup_token_open@CRYPTSETUP_TOKEN_1.0.1127machine # [ 24.646599] cat[914]: Loading symbol cryptsetup_token_buffer_free@CRYPTSETUP_TOKEN_1.0.1128machine # [ 24.647694] cat[914]: Loading symbol cryptsetup_token_validate@CRYPTSETUP_TOKEN_1.0.1129machine # [ 24.655087] cat[914]: Loading symbol cryptsetup_token_dump@CRYPTSETUP_TOKEN_1.0.1130machine # [ 24.656436] cat[914]: Loading symbol cryptsetup_token_open_pin@CRYPTSETUP_TOKEN_1.0.1131machine # [ 24.657578] cat[914]: Loading symbol cryptsetup_token_version@CRYPTSETUP_TOKEN_1.0.1132machine # [ 24.658845] [914]: Token handler systemd-tpm2-1.0 systemd-v262~rc1 (262-9457f81) loaded successfully.1133machine # [ 24.660356] [914]: Device size 536870912, offset 16777216.1134machine # [ 24.661212] [914]: Acquiring write lock for device /dev/vdb.1135machine # [ 24.662018] [914]: Opening lock resource file /run/cryptsetup/L_254:161136machine # [ 24.662963] [914]: Verifying lock handle for /dev/vdb.1137machine # [ 24.663797] [914]: Device /dev/vdb WRITE lock taken.1138machine # [ 24.664730] [914]: Checking context sequence id matches value stored on disk.1139machine # [ 24.665657] [914]: Reusing open ro fd on device /dev/vdb1140machine # [ 24.666360] [914]: Trying to write LUKS2 header (1742 bytes) at offset 0.1141machine # [ 24.667251] [914]: Reusing open rw fd on device /dev/vdb1142machine # [ 24.667965] [914]: Checksum:5b6ccf0f6f60c8dd46ee9b953d1d172c41505b261df39b50ad964e099f6076a1 (in-memory)1143machine # [ 24.670303] [914]: Trying to write LUKS2 header (1742 bytes) at offset 16384.1144machine # [ 24.671470] [914]: Reusing open rw fd on device /dev/vdb1145machine # [ 24.672533] [914]: Checksum:7dc79a32a5ff5384fc45cad4754d6f24ad54bf503d65b29b6d1bdd6cc80e1692 (in-memory)1146machine # [ 24.673995] [914]: Device /dev/vdb WRITE lock released.1147machine # [ 24.674852] [914]: New TPM2 token enrolled as key slot 1.1148machine # [ 24.675569] [914]: Releasing crypt device /dev/vdb context.1149machine # [ 24.677059] [914]: Releasing device-mapper backend.1150machine: (finished: must succeed: PASSWORD=supersecret SYSTEMD_LOG_LEVEL=debug systemd-cryptenroll --tpm2-pcrs= --tpm2-device=auto /dev/vdb |& systemd-cat, in 1.02 seconds)1151machine # [ 24.677711] [914]: Closing read only fd for /dev/vdb.1152machine: must succeed: /nix/store/1zwymc3mwgv7nc9bwvf3w3327n4xfrr2-nixos-system-machine-test/bin/switch-to-configuration boot1153machine # [ 24.678348] [914]: Closing read write fd for /dev/vdb.1154machine # [ 24.679009] [914]: Unloading systemd-tpm2 token handler.1155machine # Not checking switch inhibitors (action = boot)1156machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.1157machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.1158machine: (finished: must succeed: /nix/store/1zwymc3mwgv7nc9bwvf3w3327n4xfrr2-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.99 seconds)1159machine: must succeed: sync1160machine: (finished: must succeed: sync, in 0.04 seconds)1161machine: forced crash1162machine: waiting for the VM to power off1163additionally exposed symbols:1164 machine,1165 vlan1,1166 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_ssh1167machine: (finished: waiting for the VM to power off, in 0.00 seconds)1168machine: waiting for unit multi-user.target1169machine: waiting for the VM to finish booting1170machine: starting vm1171machine: QEMU running (pid 93)1172machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)1173machine: 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'1174machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1175machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1176machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)1177machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x6,0x0)\r\n'1178machine: Guest shell says: b'\r \r\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H\x1b[020;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m NixOS \x1b[021;063'1179machine: Guest shell says: b'H\x1b[1m\x1b[30m\x1b[47m\x1b[0m\x1b[30m\x1b[47m NixOS (boot-luks) \x1b[022;063H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Reboot Into Firmware I'1180machine: Guest shell says: b'nterface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot '1181machine: Guest shell says: b'in 5s. \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 4s. '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 3s. '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 2s. '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[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '1193machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'1194machine: Guest shell says: b'---------------------'1195machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'1196machine # 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]1197machine # [ 0.000000] Linux version 6.18.49 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Wed Sep 2 12:31:51 UTC 20261198machine # [ 0.000000] KASLR enabled1199machine # [ 0.000000] efi: EFI v2.7 by EDK II1200machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 TPMFinalLog=0x47fc0000 MEMATTR=0x45ae8018 ACPI 2.0=0x47ff3018 RNG=0x47ff3798 TPMEventLog=0x45a7a018 INITRD=0x45ae0418 MEMRESERVE=0x45ae22981201machine # [ 0.000000] random: crng init done1202machine # [ 0.000000] ACPI: Early table checksum verification disabled1203machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )1204machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 000074 (v01 BOCHS BXPC 00000001 01000013)1205machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)1206machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 001811 (v02 BOCHS BXPC 00000001 BXPC 00000001)1207machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)1208machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)1209machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)1210machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)1211machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)1212machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)1213machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)1214machine # [ 0.000000] ACPI: TPM2 0x0000000047FF3998 00004C (v04 BOCHS BXPC 00000001 BXPC 00000001)1215machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3A18 000038 (v01 INTEL EDK2 00000002 01000013)1216machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,96001217machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1218machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf1880-0x7fdf4fff]1219machine # [ 0.000000] Zone ranges:1220machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1221machine # [ 0.000000] DMA32 empty1222machine # [ 0.000000] Normal empty1223machine # [ 0.000000] Device empty1224machine # [ 0.000000] Movable zone start for each node1225machine # [ 0.000000] Early memory node ranges1226machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045b0ffff]1227machine # [ 0.000000] node 0: [mem 0x0000000045b10000-0x0000000045b1ffff]1228machine # [ 0.000000] node 0: [mem 0x0000000045b20000-0x0000000045fcffff]1229machine # [ 0.000000] node 0: [mem 0x0000000045fd0000-0x000000004604ffff]1230machine # [ 0.000000] node 0: [mem 0x0000000046050000-0x000000004609ffff]1231machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]1232machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]1233machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]1234machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]1235machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]1236machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]1237machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1238machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001239machine # [ 0.000000] psci: probing for conduit method from ACPI.1240machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1241machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1242machine # [ 0.000000] psci: Trusted OS migration not required1243machine # [ 0.000000] psci: SMC Calling Convention v1.11244machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1245machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961246machine # [ 0.000000] Detected PIPT I-cache on CPU01247machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1248machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1249machine # [ 0.000000] CPU features: detected: Spectre-v41250machine # [ 0.000000] CPU features: detected: Spectre-BHB1251machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381252machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231253machine # [ 0.000000] alternatives: applying boot alternatives1254machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\yk42b10ha8lh9rng6b3lngrp2blrf5lf-initrd-linux-6.18.49-initrd.efi init=/nix/store/1zwymc3mwgv7nc9bwvf3w3327n4xfrr2-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,bpf1255machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1256machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1257machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1258machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1259machine # [ 0.000000] software IO TLB: area num 1.1260machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1261machine # [ 0.000000] Fallback order for Node 0: 01262machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441263machine # [ 0.000000] Policy zone: DMA1264machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1265machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11266machine # [ 0.000000] allocated 2097152 bytes of page_ext1267machine # [ 0.000000] ftrace: allocating 74886 entries in 294 pages1268machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1269machine # [ 0.000000] rcu: Hierarchical RCU implementation.1270machine # [ 0.000000] rcu: RCU event tracing is enabled.1271machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1272machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1273machine # [ 0.000000] Rude variant of Tasks RCU enabled.1274machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1275machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1276machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11277machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1278machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1279machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1280machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01281machine # [ 0.000000] GICv3: 256 SPIs implemented1282machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1283machine # [ 0.000000] Root IRQ handler: gic_handle_irq1284machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1285machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01286machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001287machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1288machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)1289machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)1290machine # [ 0.000000] GICv3: using LPI property table @0x00000000409100001291machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x00000000409200001292machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1293machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1294machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1295machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1296machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1297machine # [ 0.000032] arm-pv: using stolen time PV1298machine # [ 0.000391] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1299machine # [ 0.000475] Console: colour dummy device 80x251300machine # [ 0.000480] printk: legacy console [tty0] enabled1301machine # [ 0.000689] ACPI: Core revision 202508071302machine # [ 0.000768] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1303machine # [ 0.000775] pid_max: default: 32768 minimum: 3011304machine # [ 0.000831] LSM: initializing lsm=capability,landlock,yama,bpf,ima1305machine # [ 0.000947] landlock: Up and running.1306machine # [ 0.000949] Yama: becoming mindful.1307machine # [ 0.001387] LSM support for eBPF active1308machine # [ 0.001475] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1309machine # [ 0.001483] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1310machine # [ 0.002458] rcu: Hierarchical SRCU implementation.1311machine # [ 0.002462] rcu: Max phase no-delay instances is 1000.1312machine # [ 0.003082] fsl-mc MSI: ITS@0x8080000 domain created1313machine # [ 0.003101] Remapping and enabling EFI services.1314machine # [ 0.003204] smp: Bringing up secondary CPUs ...1315machine # [ 0.003213] smp: Brought up 1 node, 1 CPU1316machine # [ 0.003216] SMP: Total of 1 processors activated.1317machine # [ 0.003219] CPU: All CPU(s) started at EL11318machine # [ 0.003230] CPU features: detected: Branch Target Identification1319machine # [ 0.003235] CPU features: detected: ARMv8.4 Translation Table Level1320machine # [ 0.003238] CPU features: detected: Instruction cache invalidation not required for I/D coherence1321machine # [ 0.003242] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1322machine # [ 0.003245] CPU features: detected: Common not Private translations1323machine # [ 0.003249] CPU features: detected: CRC32 instructions1324machine # [ 0.003251] CPU features: detected: Data cache clean to Point of Deep Persistence1325machine # [ 0.003255] CPU features: detected: Data cache clean to Point of Persistence1326machine # [ 0.003258] CPU features: detected: Data independent timing control (DIT)1327machine # [ 0.003261] CPU features: detected: E0PD1328machine # [ 0.003264] CPU features: detected: Enhanced Counter Virtualization1329machine # [ 0.003267] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1330machine # [ 0.003271] CPU features: detected: Enhanced Virtualization Traps1331machine # [ 0.003273] CPU features: detected: Fine Grained Traps1332machine # [ 0.003277] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1333machine # [ 0.003282] CPU features: detected: RCpc load-acquire (LDAPR)1334machine # [ 0.003285] CPU features: detected: LSE atomic instructions1335machine # [ 0.003288] CPU features: detected: Privileged Access Never1336machine # [ 0.003291] CPU features: detected: PMUv31337machine # [ 0.003294] CPU features: detected: RAS Extension Support1338machine # [ 0.003296] CPU features: detected: RASv1p1 Extension Support1339machine # [ 0.003299] CPU features: detected: Random Number Generator1340machine # [ 0.003301] CPU features: detected: Speculation barrier (SB)1341machine # [ 0.003304] CPU features: detected: Stage-2 Force Write-Back1342machine # [ 0.003307] CPU features: detected: TLB range maintenance instructions1343machine # [ 0.003312] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1344machine # [ 0.003351] alternatives: applying system-wide alternatives1345machine # [ 0.006011] CPU features: detected: BBM Level 2 without TLB conflict abort1346machine # [ 0.006127] Memory: 886912K/1048576K available (24448K kernel code, 7090K rwdata, 26344K rodata, 4736K init, 1107K bss, 120364K reserved, 32768K cma-reserved)1347machine # [ 0.006364] devtmpfs: initialized1348machine # [ 0.007232] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1349machine # [ 0.007242] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1350machine # [ 0.007406] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1351machine # [ 0.007411] 0 pages in range for non-PLT usage1352machine # [ 0.007412] 508288 pages in range for PLT usage1353machine # [ 0.007489] pinctrl core: initialized pinctrl subsystem1354machine # [ 0.008029] SMBIOS 3.0.0 present.1355machine # [ 0.008035] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/20221356machine # [ 0.008044] DMI: Memory slots populated: 1/11357machine # [ 0.009297] NET: Registered PF_NETLINK/PF_ROUTE protocol family1358machine # [ 0.009897] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1359machine # [ 0.010050] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1360machine # [ 0.010207] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1361machine # [ 0.010227] audit: initializing netlink subsys (disabled)1362machine # [ 0.010605] thermal_sys: Registered thermal governor 'fair_share'1363machine # [ 0.010608] thermal_sys: Registered thermal governor 'bang_bang'1364machine # [ 0.010611] thermal_sys: Registered thermal governor 'step_wise'1365machine # [ 0.010614] thermal_sys: Registered thermal governor 'user_space'1366machine # [ 0.010617] thermal_sys: Registered thermal governor 'power_allocator'1367machine # [ 0.010641] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=11368machine # [ 0.010652] cpuidle: using governor ladder1369machine # [ 0.010658] cpuidle: using governor menu1370machine # [ 0.010810] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1371machine # [ 0.010827] ASID allocator initialised with 65536 entries1372machine # [ 0.011566] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.51373machine # [ 0.011748] Serial: AMBA PL011 UART driver1374machine # [ 0.018268] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1375machine # [ 0.018273] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1376machine # [ 0.018276] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1377machine # [ 0.018279] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1378machine # [ 0.018282] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1379machine # [ 0.018284] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1380machine # [ 0.018287] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1381machine # [ 0.018290] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1382machine # [ 0.019024] fbcon: Taking over console1383machine # [ 0.019058] ACPI: Added _OSI(Module Device)1384machine # [ 0.019061] ACPI: Added _OSI(Processor Device)1385machine # [ 0.019064] ACPI: Added _OSI(Processor Aggregator Device)1386machine # [ 0.020087] ACPI: 1 ACPI AML tables successfully acquired and loaded1387machine # [ 0.026150] ACPI: Interpreter enabled1388machine # [ 0.026155] ACPI: Using GIC for interrupt routing1389machine # [ 0.026173] ACPI: MCFG table detected, 1 entries1390machine # [ 0.030009] ACPI: CPU0 has been hot-added1391machine # [ 0.030376] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA1392machine # [ 0.030441] printk: console [ttyAMA0] enabled1393machine # [ 0.106254] ACPI: PCI: Interrupt link L000 configured for IRQ 351394machine # [ 0.106270] ACPI: PCI: Interrupt link L001 configured for IRQ 361395machine # [ 0.106281] ACPI: PCI: Interrupt link L002 configured for IRQ 371396machine # [ 0.106293] ACPI: PCI: Interrupt link L003 configured for IRQ 381397machine # [ 0.106310] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])1398machine # [ 0.106348] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]1399machine # [ 0.106431] acpi PNP0A08:00: _OSC: platform does not support [LTR]1400machine # [ 0.106527] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]1401machine # [ 0.106758] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:001402machine # [ 0.106778] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1403machine # [ 0.106800] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]1404machine # [ 0.107135] PCI host bridge to bus 0000:001405machine # [ 0.107163] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]1406machine # [ 0.107167] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]1407machine # [ 0.107170] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]1408machine # [ 0.107175] pci_bus 0000:00: root bus resource [bus 00-ff]1409machine # [ 0.107178] PCI: OF: of_root node is NULL, cannot create PCI host bridge node1410machine # [ 0.107250] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1411machine # [ 0.107729] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1412machine # [ 0.107910] pci 0000:00:01.0: BAR 0 [io 0x0220-0x023f]1413machine # [ 0.107922] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]1414machine # [ 0.107947] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]1415machine # [ 0.107959] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]1416machine # [ 0.108446] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1417machine # [ 0.109388] pci 0000:00:02.0: BAR 0 [io 0x0200-0x021f]1418machine # [ 0.109402] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]1419machine # [ 0.109427] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]1420machine # [ 0.109937] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1421machine # [ 0.110208] pci 0000:00:03.0: BAR 0 [io 0x0140-0x017f]1422machine # [ 0.110219] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]1423machine # [ 0.110245] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]1424machine # [ 0.110741] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1425machine # [ 0.110928] pci 0000:00:04.0: BAR 0 [io 0x01e0-0x01ff]1426machine # [ 0.110940] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]1427machine # [ 0.110965] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]1428machine # [ 0.211418] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1429machine # [ 0.211622] pci 0000:00:05.0: BAR 0 [io 0x01c0-0x01df]1430machine # [ 0.211641] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]1431machine # [ 0.211672] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]1432machine # [ 0.212177] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1433machine # [ 0.213083] pci 0000:00:06.0: BAR 0 [io 0x0080-0x00ff]1434machine # [ 0.213108] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]1435machine # [ 0.213139] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]1436machine # [ 0.219973] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1437machine # [ 0.220162] pci 0000:00:07.0: BAR 0 [io 0x0000-0x007f]1438machine # [ 0.220179] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]1439machine # [ 0.220209] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]1440machine # [ 0.220714] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1441machine # [ 0.220897] pci 0000:00:08.0: BAR 0 [io 0x01a0-0x01bf]1442machine # [ 0.220914] pci 0000:00:08.0: BAR 1 [mem 0x10045000-0x10045fff]1443machine # [ 0.220944] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]1444machine # [ 0.220962] pci 0000:00:08.0: ROM [mem 0xfffc0000-0xffffffff pref]1445machine # [ 0.221456] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1446machine # [ 0.230523] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]1447machine # [ 0.230562] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]1448machine # [ 0.231091] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1449machine # [ 0.231279] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]1450machine # [ 0.231309] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]1451machine # [ 0.231742] pci 0000:00:0b.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1452machine # [ 0.232763] pci 0000:00:0b.0: BAR 0 [mem 0x10042000-0x10042fff]1453machine # [ 0.233083] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1454machine # [ 0.241209] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]1455machine # [ 0.241233] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]1456machine # [ 0.241264] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]1457machine # [ 0.241780] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1458machine # [ 0.242466] pci 0000:00:0d.0: BAR 0 [io 0x0180-0x019f]1459machine # [ 0.242488] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]1460machine # [ 0.242518] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]1461machine # [ 0.243075] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1462machine # [ 0.243087] pci 0000:00:08.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1463machine # [ 0.243094] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1464machine # [ 0.243142] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1465machine # [ 0.243188] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1466machine # [ 0.243235] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1467machine # [ 0.243282] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1468machine # [ 0.243329] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1469machine # [ 0.243376] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1470machine # [ 0.243423] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1471machine # [ 0.243471] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1472machine # [ 0.260306] pci 0000:00:0a.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1473machine # [ 0.260371] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1474machine # [ 0.260418] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1475machine # [ 0.260464] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1476machine # [ 0.260486] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1477machine # [ 0.260509] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1478machine # [ 0.260533] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1479machine # [ 0.260556] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1480machine # [ 0.260579] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1481machine # [ 0.260602] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1482machine # [ 0.260625] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1483machine # [ 0.260648] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1484machine # [ 0.271531] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1485machine # [ 0.271563] pci 0000:00:0b.0: BAR 0 [mem 0x1008a000-0x1008afff]: assigned1486machine # [ 0.272266] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1487machine # [ 0.272300] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1488machine # [ 0.272324] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1489machine # [ 0.272837] pci 0000:00:07.0: BAR 0 [io 0x1080-0x10ff]: assigned1490machine # [ 0.272865] pci 0000:00:03.0: BAR 0 [io 0x1100-0x113f]: assigned1491machine # [ 0.272888] pci 0000:00:0c.0: BAR 0 [io 0x1140-0x117f]: assigned1492machine # [ 0.273418] pci 0000:00:01.0: BAR 0 [io 0x1180-0x119f]: assigned1493machine # [ 0.273444] pci 0000:00:02.0: BAR 0 [io 0x11a0-0x11bf]: assigned1494machine # [ 0.273952] pci 0000:00:04.0: BAR 0 [io 0x11c0-0x11df]: assigned1495machine # [ 0.273979] pci 0000:00:05.0: BAR 0 [io 0x11e0-0x11ff]: assigned1496machine # [ 0.274002] pci 0000:00:08.0: BAR 0 [io 0x1200-0x121f]: assigned1497machine # [ 0.274026] pci 0000:00:0d.0: BAR 0 [io 0x1220-0x123f]: assigned1498machine # [ 0.274523] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]1499machine # [ 0.274537] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]1500machine # [ 0.274543] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]1501machine # [ 0.291154] iommu: Default domain type: Translated1502machine # [ 0.291171] iommu: DMA domain TLB invalidation policy: strict mode1503machine # [ 0.292700] SCSI subsystem initialized1504machine # [ 0.293295] ACPI: bus type USB registered1505machine # [ 0.293341] usbcore: registered new interface driver usbfs1506machine # [ 0.293361] usbcore: registered new interface driver hub1507machine # [ 0.293376] usbcore: registered new device driver usb1508machine # [ 0.293592] pps_core: LinuxPPS API ver. 1 registered1509machine # [ 0.293600] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1510machine # [ 0.293611] PTP clock support registered1511machine # [ 0.293648] EDAC MC: Ver: 3.0.01512machine # [ 0.298709] scmi_core: SCMI protocol bus registered1513machine # [ 0.299395] efivars: Registered efivars operations1514machine # [ 0.300337] FPGA manager framework1515machine # [ 0.301229] vgaarb: loaded1516machine # [ 0.301790] clocksource: Switched to clocksource arch_sys_counter1517machine # [ 0.302087] VFS: Disk quotas dquot_6.6.01518machine # [ 0.302115] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1519machine # [ 0.305701] netfs: FS-Cache loaded1520machine # [ 0.306241] pnp: PnP ACPI init1521machine # [ 0.306446] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved1522machine # [ 0.306502] pnp: PnP ACPI: found 1 devices1523machine # [ 0.310972] NET: Registered PF_INET protocol family1524machine # [ 0.311034] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1525machine # [ 0.330631] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1526machine # [ 0.330676] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1527machine # [ 0.330701] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1528machine # [ 0.330742] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1529machine # [ 0.330818] TCP: Hash tables configured (established 8192 bind 8192)1530machine # [ 0.330891] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1531machine # [ 0.330919] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1532machine # [ 0.330943] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1533machine # [ 0.331021] NET: Registered PF_UNIX/PF_LOCAL protocol family1534machine # [ 0.331047] NET: Registered PF_XDP protocol family1535machine # [ 0.331777] PCI: CLS 0 bytes, default 641536machine # [ 0.332017] Trying to unpack rootfs image as initramfs...1537machine # [ 0.347025] kvm [1]: HYP mode not available1538machine # [ 0.438371] Initialise system trusted keyrings1539machine # [ 0.439102] workingset: timestamp_bits=42 max_order=18 bucket_order=01540machine # [ 0.440306] squashfs: version 4.0 (2009/01/31) Phillip Lougher1541machine # [ 0.441082] 9p: Installing v9fs 9p2000 file system support1542machine # [ 0.469852] Key type asymmetric registered1543machine # [ 0.469888] Asymmetric key parser 'x509' registered1544machine # [ 0.469958] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1545machine # [ 0.472028] io scheduler mq-deadline registered1546machine # [ 0.472041] io scheduler kyber registered1547machine # [ 0.481828] ledtrig-cpu: registered to indicate activity on CPUs1548machine # [ 0.483769] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input01549machine # [ 0.483824] ACPI: button: Power Button [PWRB]1550machine # [ 0.511608] ACPI: \_SB_.L001: Enabled at IRQ 361551machine # [ 0.511665] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1552machine # [ 0.514041] ACPI: \_SB_.L002: Enabled at IRQ 371553machine # [ 0.514088] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)1554machine # [ 0.515665] ACPI: \_SB_.L003: Enabled at IRQ 381555machine # [ 0.515702] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1556machine # [ 0.525896] ACPI: \_SB_.L000: Enabled at IRQ 351557machine # [ 0.525963] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1558machine # [ 0.528276] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1559machine # [ 0.538559] virtio-pci 0000:00:06.0: enabling device (0005 -> 0007)1560machine # [ 0.541172] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1561machine # [ 0.545334] virtio-pci 0000:00:08.0: enabling device (0000 -> 0003)1562machine # [ 0.553502] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1563machine # [ 0.563588] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)1564machine # [ 0.565785] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)1565machine # [ 0.578452] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1566machine # [ 0.586752] msm_serial: driver initialized1567machine # [ 0.586900] SuperH (H)SCI(F) driver initialized1568machine # [ 0.586940] STM32 USART driver initialized1569machine # [ 0.607519] ACPI: bus type drm_connector registered1570machine # [ 0.614340] loop: module loaded1571machine # [ 0.614526] virtio_blk virtio5: 1/0/0 default/read/poll queues1572machine # [ 0.615223] virtio_blk virtio5: [vda] 4929536 512-byte logical blocks (2.52 GB/2.35 GiB)1573machine # [ 0.657863] vda: vda1 vda21574machine # [ 0.658334] virtio_blk virtio6: 1/0/0 default/read/poll queues1575machine # [ 0.659158] virtio_blk virtio6: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1576machine # [ 0.666484] megasas: 07.734.00.00-rc11577machine # [ 0.668944] tun: Universal TUN/TAP device driver, 1.61578machine # [ 0.673330] thunder_xcv, ver 1.01579machine # [ 0.673385] thunder_bgx, ver 1.01580machine # [ 0.673409] nicpf, ver 1.01581machine # [ 0.675119] e1000: Intel(R) PRO/1000 Network Driver1582machine # [ 0.675133] e1000: Copyright (c) 1999-2006 Intel Corporation.1583machine # [ 0.675160] e1000e: Intel(R) PRO/1000 Network Driver1584machine # [ 0.675166] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1585machine # [ 0.675206] igb: Intel(R) Gigabit Ethernet Network Driver1586machine # [ 0.675213] igb: Copyright (c) 2007-2014 Intel Corporation.1587machine # [ 0.675238] igbvf: Intel(R) Gigabit Virtual Function Network Driver1588machine # [ 0.675245] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1589machine # [ 0.675379] sky2: driver version 1.301590machine # [ 0.676846] usbcore: registered new interface driver usb-storage1591machine # [ 0.676927] usbcore: registered new interface driver usbserial_generic1592machine # [ 0.676960] usbserial: USB Serial support registered for generic1593machine # [ 0.677582] hv_vmbus: registering driver hyperv_keyboard1594machine # [ 0.678601] ehci-pci 0000:00:0b.0: EHCI Host Controller1595machine # [ 0.678629] ehci-pci 0000:00:0b.0: new USB bus registered, assigned bus number 11596machine # [ 0.678940] ehci-pci 0000:00:0b.0: irq 47, io mem 0x1008a0001597machine # [ 0.690075] ehci-pci 0000:00:0b.0: USB 2.0 started, EHCI 1.001598machine # [ 0.690422] hub 1-0:1.0: USB hub found1599machine # [ 0.690446] hub 1-0:1.0: 6 ports detected1600machine # [ 0.698059] rtc-efi rtc-efi.0: registered as rtc01601machine # [ 0.698115] rtc-efi rtc-efi.0: setting system clock to 2026-09-06T02:39:09 UTC (1788662349)1602machine # [ 0.698532] i2c_dev: i2c /dev entries driver1603machine # [ 0.701303] sdhci: Secure Digital Host Controller Interface driver1604machine # [ 0.701318] sdhci: Copyright(c) Pierre Ossman1605machine # [ 0.701596] Synopsys Designware Multimedia Card Interface Driver1606machine # [ 0.701987] sdhci-pltfm: SDHCI platform and OF driver helper1607machine # [ 0.703231] pstore: Using crash dump compression: deflate1608machine # [ 0.703240] pstore: Registered efi_pstore as persistent store backend1609machine # [ 0.719013] hid: raw HID events driver (C) Jiri Kosina1610machine # [ 0.719289] usbcore: registered new interface driver usbhid1611machine # [ 0.719297] usbhid: USB HID core driver1612machine # [ 0.720277] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available1613machine # [ 0.721700] drop_monitor: Initializing network drop monitor service1614machine # [ 0.721897] NET: Registered PF_INET6 protocol family1615machine # [ 0.726657] Segment Routing with IPv61616machine # [ 0.726683] In-situ OAM (IOAM) with IPv61617machine # [ 0.726713] NET: Registered PF_PACKET protocol family1618machine # [ 0.728284] 9pnet: Installing 9P2000 support1619machine # [ 0.731036] Key type dns_resolver registered1620machine # [ 0.745528] registered taskstats version 11621machine # [ 0.745716] Loading compiled-in X.509 certificates1622machine # [ 0.769824] Demotion targets for Node 0: null1623machine # [ 0.770634] Key type .fscrypt registered1624machine # [ 0.770647] Key type fscrypt-provisioning registered1625machine # [ 0.770761] ima: No TPM chip found, activating TPM-bypass!1626machine # [ 0.770781] ima: Allocated hash algorithm: sha11627machine # [ 0.770802] ima: No architecture policies found1628machine # [ 0.803138] clk: Disabling unused clocks1629machine # [ 0.803174] PM: genpd: Disabling unused power domains1630machine # [ 0.925432] Freeing initrd memory: 26368K1631machine # [ 0.928881] Freeing unused kernel memory: 4736K1632machine # [ 0.929104] Run /init as init process1633machine # [ 0.945847] usb 1-1: new high-speed USB device number 2 using ehci-pci1634machine # [ 0.947590] fuse: init (API version 7.45)1635machine # [ 0.961382] systemd[1]: Successfully made /usr/ read-only.1636machine # [ 1.098114] 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/input11637machine # [ 1.170307] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0b.0-1/input01638machine # [ 1.293870] usb 1-2: new high-speed USB device number 3 using ehci-pci1639machine # [ 1.297220] systemd[1]: systemd 262-9457f81 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)1640machine # [ 1.297290] systemd[1]: Detected virtualization kvm.1641machine # [ 1.297402] systemd[1]: Detected architecture arm64.1642machine # [ 1.297434] systemd[1]: Running in initrd.1643machine # [ 1.315914] systemd[1]: Initializing machine ID from random generator.1644machine # [ 1.318721] systemd[1]: Hostname set to <machine>.1645machine # [ 1.455327] systemd[1]: bpf-restrict-fs: LSM BPF program attached1646machine # [ 1.481636] 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/input21647machine # [ 1.483307] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0b.0-2/input01648machine # [ 1.518674] systemd[1]: Queued start job for default target Initrd Default Target.1649machine # [ 1.527709] systemd[1]: Created slice Slice /system/modprobe.1650machine # [ 1.529070] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1651machine # [ 1.530030] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1652machine # [ 1.530988] systemd[1]: Expecting device /dev/mapper/cryptroot...1653machine # [ 1.531803] systemd[1]: Expecting device /dev/tpm0...1654machine # [ 1.532424] systemd[1]: Expecting device /dev/tpmrm0...1655machine # [ 1.533081] systemd[1]: Expecting device /dev/vdb...1656machine # [ 1.533712] systemd[1]: Reached target Path Units.1657machine # [ 1.534382] systemd[1]: Reached target Slice Units.1658machine # [ 1.534999] systemd[1]: Reached target Swaps.1659machine # [ 1.535553] systemd[1]: Reached target Timer Units.1660machine # [ 1.536317] systemd[1]: Listening on D-Bus System Message Bus Socket.1661machine # [ 1.537238] systemd[1]: Listening on Journal Socket (/dev/log).1662machine # [ 1.538113] systemd[1]: Listening on Journal Sockets.1663machine # [ 1.538876] systemd[1]: Listening on udev Kernel Socket.1664machine # [ 1.539539] systemd[1]: Reached target Socket Units.1665machine # [ 1.541505] systemd[1]: Starting Create List of Static Device Nodes...1666machine # [ 1.549332] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1667machine # [ 1.550352] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1668machine # [ 1.566402] systemd[1]: Mounting Kernel Configuration File System...1669machine # [ 1.578023] systemd[1]: Starting Journal Service...1670machine # [ 1.590161] systemd[1]: Starting Load Kernel Modules...1671machine # [ 1.606069] systemd[1]: Starting Coldplug All udev Devices...1672machine # [ 1.612014] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1673machine # [ 1.613727] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1674machine # [ 1.617924] systemd[1]: Finished Create List of Static Device Nodes.1675machine # [ 1.618978] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1676machine # [ 1.619258] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1677machine # [ 1.619479] systemd[1]: Mounted Kernel Configuration File System.1678machine # [ 1.634206] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1679machine # [ 1.641695] [drm] pci: virtio-gpu-pci detected at 0000:00:09.01680machine # [ 1.650748] [drm] features: -virgl +edid -resource_blob -host_visible1681machine # [ 1.650767] [drm] features: -context_init1682machine # [ 1.651488] [drm] number of scanouts: 11683machine # [ 1.651505] [drm] number of cap sets: 01684machine # [ 1.655704] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic1685machine # [ 1.655721] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 01686machine # [ 1.672839] systemd-journald[72]: Collecting audit messages is disabled.1687machine # [ 1.694463] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1688machine # [ 1.697031] systemd[1]: Starting Create Static Device Nodes in /dev...1689machine # [ 1.713868] Console: switching to colour frame buffer device 160x501690machine # [ 1.714544] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device1691machine # [ 1.731166] systemd[1]: Finished Load Kernel Modules.1692machine # [ 1.734230] systemd[1]: Starting Apply Kernel Variables...1693machine # [ 1.754850] systemd[1]: Finished Create Static Device Nodes in /dev.1694machine # [ 1.755039] systemd[1]: Reached target Preparation for Local File Systems.1695machine # [ 1.755075] systemd[1]: Reached target Local File Systems.1696machine # [ 1.760086] systemd[1]: Starting Rule-based Manager for Device Events and Files...1697machine # [ 1.782121] systemd[1]: Finished Apply Kernel Variables.1698machine # [ 1.832983] systemd[1]: Started Journal Service.1699machine # [ 1.811787] systemd-modules-load[73]: Inserted module 'dm_mod'1700machine # [ 1.820371] systemd-modules-load[73]: Module 'virtio_balloon' is built in1701machine # [ 1.821454] systemd-modules-load[73]: Module 'virtio_console' is built in1702machine # [ 1.822485] systemd-modules-load[73]: Inserted module 'virtio_gpu'1703machine # [ 1.823499] systemd-modules-load[73]: Module 'virtio_rng' is built in1704machine # [ 1.836832] systemd[1]: Starting Create System Files and Directories...1705machine # [ 1.838172] systemd-udevd[80]: Using default interface naming scheme 'v261'.1706machine # [ 1.855455] systemd[1]: Finished Create System Files and Directories.1707machine # [ 1.873383] systemd[1]: Started Rule-based Manager for Device Events and Files.1708machine # [ 1.928127] systemd[1]: Starting Virtual Console Setup...1709machine # [ 1.976469] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.1710machine # [ 1.979833] systemd[1]: Finished Virtual Console Setup.1711machine # [ 2.666256] systemd[1]: Finished Coldplug All udev Devices.1712machine # [ 2.814763] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1713machine # [ 2.826425] systemd[1]: Found device /dev/vdb.1714machine # [ 2.827461] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1715machine # [ 2.831189] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.1716machine # [ 3.812599] tpm_tis MSFT0101:00: 2.0 TPM (device-id 0x1, rev-id 1)1717machine # [ 3.927072] systemd[1]: Found device /dev/tpm0.1718machine # [ 3.938915] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1719machine # [ 3.941166] systemd[1]: Stopped Virtual Console Setup.1720machine # [ 3.945279] systemd[1]: Stopping Virtual Console Setup...1721machine # [ 3.947532] systemd[1]: Starting Virtual Console Setup...1722machine # [ 3.954705] systemd[1]: Found device /dev/tpmrm0.1723machine # [ 3.956100] systemd[1]: Reached target Trusted Platform Module.1724machine # [ 3.960965] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1725machine # [ 3.964120] systemd[1]: Starting Cryptography Setup for cryptroot...1726machine # [ 3.992145] systemd-vconsole-setup[113]: Configuration of first virtual console was skipped, ignoring remaining ones.1727machine # [ 3.995613] systemd[1]: Finished Virtual Console Setup.1728machine # [ 4.354482] Key type trusted registered1729machine # [ 4.358126] Key type encrypted registered1730machine # [ 4.372542] systemd[1]: Found device /dev/mapper/cryptroot.1731machine # [ 4.374096] systemd[1]: Finished Cryptography Setup for cryptroot.1732machine # [ 4.375367] systemd[1]: Reached target Local Encrypted Volumes.1733machine # [ 4.377673] systemd[1]: Reached target Initrd Root Device.1734machine # [ 4.378709] systemd[1]: Reached target System Initialization.1735machine # [ 4.383555] systemd[1]: Reached target Basic System.1736machine # [ 4.384547] systemd[1]: Starting File System Check on /dev/mapper/cryptroot...1737machine # [ 4.409927] systemd-fsck[129]: /dev/mapper/cryptroot: clean, 12/126976 files, 42920/507904 blocks1738machine # [ 4.417520] systemd[1]: Finished File System Check on /dev/mapper/cryptroot.1739machine # [ 4.419402] systemd[1]: Mounting /sysroot...1740machine # [ 4.517515] EXT4-fs (dm-0): mounted filesystem feea331b-7040-42f8-846c-425c509b51d6 r/w with ordered data mode. Quota mode: none.1741machine # [ 4.492260] systemd[1]: Mounted /sysroot.1742machine # [ 4.493650] systemd[1]: Reached target Initrd Root File System.1743machine # [ 4.496175] systemd[1]: Starting Mountpoints Configured in the Real Root...1744machine # [ 4.515688] systemd-sysroot-fstab-check[136]: /sysroot should be mounted in the initrd, will request daemon-reload.1745machine # [ 4.520113] systemd[1]: Reload requested from client PID 136 ('systemd-sysroot') (unit initrd-parse-etc.service)...1746machine # [ 4.522752] systemd[1]: Reloading...1747machine # [ 4.645035] systemd[1]: Reloading finished in 125 ms.1748machine # [ 4.670656] systemd-sysroot-fstab-check[136]: Requesting initrd-fs.target/start/replace...1749machine # [ 4.673164] systemd-sysroot-fstab-check[136]: Requesting swap.target/start/replace...1750machine # [ 4.676872] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1751machine # [ 4.678655] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1752machine # [ 4.683851] systemd[1]: Finished Mountpoints Configured in the Real Root.1753machine # [ 4.685269] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1754machine # [ 4.695686] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1755machine # [ 4.697207] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1756machine # [ 4.969222] systemd[1]: Mounting /sysroot/nix/.ro-store...1757machine # [ 4.979700] systemd[1]: Mounting /sysroot/nix/.rw-store...1758machine # [ 4.994392] systemd[1]: Mounting /sysroot/run...1759machine # [ 5.029204] systemd[1]: Mounting /sysroot/tmp/shared...1760machine # [ 5.056867] systemd[1]: Mounting /sysroot/tmp/xchg...1761machine # [ 5.065918] systemd[1]: Mounted /sysroot/nix/.rw-store.1762machine # [ 5.078226] systemd[1]: Mounted /sysroot/nix/.ro-store.1763machine # [ 5.090531] systemd[1]: Mounted /sysroot/run.1764machine # [ 5.107893] systemd[1]: Mounted /sysroot/tmp/shared.1765machine # [ 5.116386] systemd[1]: Starting rw-sysroot-nix-store.service...1766machine # [ 5.122921] systemd[1]: Mounted /sysroot/tmp/xchg.1767machine # [ 5.147836] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1768machine # [ 5.149468] systemd[1]: Finished rw-sysroot-nix-store.service.1769machine # [ 5.967995] systemd[1]: Mounting /sysroot/nix/store...1770machine # [ 6.032920] systemd[1]: Mounted /sysroot/nix/store.1771machine # [ 6.036269] systemd[1]: Reached target Initrd File Systems.1772machine # [ 6.040827] systemd[1]: Starting Find NixOS closure...1773machine # [ 6.052367] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1774machine # [ 6.096541] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1775machine # [ 6.100449] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1776machine # [ 6.117221] systemd[1]: Finished Find NixOS closure.1777machine # [ 6.120244] systemd[1]: Reached target Initrd Default Target.1778machine # [ 6.122129] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1779machine # [ 6.153554] systemd[1]: Stopped target Initrd Default Target.1780machine # [ 6.155789] systemd[1]: Stopped target Basic System.1781machine # [ 6.160222] systemd[1]: Stopped target Initrd Root Device.1782machine # [ 6.161283] systemd[1]: Stopped target Path Units.1783machine # [ 6.162200] systemd[1]: Stopped target Slice Units.1784machine # [ 6.163128] systemd[1]: Stopped target Socket Units.1785machine # [ 6.166093] systemd[1]: Stopped target System Initialization.1786machine # [ 6.171934] systemd[1]: Stopped target Local Encrypted Volumes.1787machine # [ 6.173110] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1788machine # [ 6.174348] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1789machine # [ 6.175617] systemd[1]: Stopped target Swaps.1790machine # [ 6.176653] systemd[1]: Stopped target Timer Units.1791machine # [ 6.177470] systemd[1]: Stopped target Trusted Platform Module.1792machine # [ 6.178413] systemd[1]: dbus.socket: Deactivated successfully.1793machine # [ 6.179357] systemd[1]: Closed D-Bus System Message Bus Socket.1794machine # [ 6.195186] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1795machine # [ 6.200255] systemd[1]: Stopped Find NixOS closure.1796machine # [ 6.201079] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1797machine # [ 6.201975] systemd[1]: Starting rw-sysroot-nix-store.service...1798machine # [ 6.202790] systemd[1]: systemd-sysctl.service: Deactivated successfully.1799machine # [ 6.203702] systemd[1]: Stopped Apply Kernel Variables.1800machine # [ 6.212986] systemd[1]: systemd-modules-load.service: Deactivated successfully.1801machine # [ 6.218939] systemd[1]: Stopped Load Kernel Modules.1802machine # [ 6.219896] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1803machine # [ 6.224288] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1804machine # [ 6.225369] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1805machine # [ 6.227447] systemd[1]: Stopped Create System Files and Directories.1806machine # [ 6.229739] systemd[1]: Stopped target Local File Systems.1807machine # [ 6.232425] systemd[1]: Stopped target Preparation for Local File Systems.1808machine # [ 6.233388] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1809machine # [ 6.235530] systemd[1]: Stopped Coldplug All udev Devices.1810machine # [ 6.240290] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1811machine # [ 6.241320] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1812machine # [ 6.242306] systemd[1]: Stopped Virtual Console Setup.1813machine # [ 6.243021] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1814machine # [ 6.243998] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1815machine # [ 6.245411] systemd[1]: systemd-udevd.service: Deactivated successfully.1816machine # [ 6.246325] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1817machine # [ 6.247304] systemd[1]: systemd-udevd.service: Consumed 1.504s CPU time over 4.492s wall clock time, 24M memory peak.1818machine # [ 6.249231] systemd[1]: initrd-cleanup.service: Deactivated successfully.1819machine # [ 6.250262] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1820machine # [ 6.251164] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1821machine # [ 6.255959] systemd[1]: Finished rw-sysroot-nix-store.service.1822machine # [ 6.256938] systemd[1]: Starting Cleanup udev Database...1823machine # [ 6.260272] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1824machine # [ 6.261483] systemd[1]: Stopped Create Static Device Nodes in /dev.1825machine # [ 6.264192] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1826machine # [ 6.265326] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1827machine # [ 6.268112] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1828machine # [ 6.269066] systemd[1]: Stopped Create List of Static Device Nodes.1829machine # [ 6.301924] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1830machine # [ 6.304820] systemd[1]: Finished Cleanup udev Database.1831machine # [ 6.308640] systemd[1]: Reached target Switch Root.1832machine # [ 6.309360] systemd[1]: Starting NixOS Activation...1833machine # [ 6.474303] initrd-nixos-activation-start[193]: booting system configuration /nix/store/1zwymc3mwgv7nc9bwvf3w3327n4xfrr2-nixos-system-machine-test1834machine # [ 6.539720] initrd-nixos-activation-start[193]: running activation script...1835machine # [ 6.960372] initrd-nixos-activation-start[216]: setting up /etc...1836machine # [ 7.226872] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1837machine # [ 7.229676] systemd[1]: Finished NixOS Activation.1838machine # [ 7.230768] systemd[1]: Starting Switch Root...1839machine # [ 7.252288] systemd[1]: Switching root.1840machine # [ 7.462966] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1841machine # [ 7.654081] NET: Registered PF_VSOCK protocol family1842machine # [ 8.050544] systemd[1]: systemd 262-9457f81 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1843machine # [ 8.062898] systemd[1]: Detected virtualization kvm.1844machine # [ 8.066716] systemd[1]: Detected architecture arm64.1845machine # [ 8.068727] systemd[1]: Detected first boot.1846machine # [ 8.076203] systemd[1]: Initializing machine ID from random generator.1847machine # [ 8.255535] systemd[1]: bpf-restrict-fs: LSM BPF program attached1848machine # [ 8.408323] systemd[1]: Applying preset policy.1849machine # [ 8.907474] systemd[1]: Populated /etc with preset unit settings.1850machine # [ 9.437491] systemd[1]: initrd-switch-root.service: Deactivated successfully.1851machine # [ 9.439323] systemd[1]: Stopped initrd-switch-root.service.1852machine # [ 9.442505] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1853machine # [ 9.445016] systemd[1]: Created slice Slice /system/getty.1854machine # [ 9.446953] systemd[1]: Created slice Slice /system/systemd-fsck.1855machine # [ 9.448793] systemd[1]: Created slice User and Session Slice.1856machine # [ 9.450203] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1857machine # [ 9.450588] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1858machine # [ 9.450867] systemd[1]: Expecting device /dev/disk/by-label/ESP...1859machine # [ 9.451104] systemd[1]: Expecting device /dev/hvc0...1860machine # [ 9.451332] systemd[1]: Expecting device /dev/ttyAMA0...1861machine # [ 9.451562] systemd[1]: Reached target Local Encrypted Volumes.1862machine # [ 9.451797] systemd[1]: Stopped target initrd-fs.target.1863machine # [ 9.452022] systemd[1]: Stopped target initrd-root-fs.target.1864machine # [ 9.452242] systemd[1]: Stopped target initrd-switch-root.target.1865machine # [ 9.452467] systemd[1]: Reached target Virtual Machines and Containers.1866machine # [ 9.452700] systemd[1]: Reached target Path Units.1867machine # [ 9.452925] systemd[1]: Reached target Remote File Systems.1868machine # [ 9.453158] systemd[1]: Reached target Slice Units.1869machine # [ 9.453380] systemd[1]: Reached target Swaps.1870machine # [ 9.465978] systemd[1]: Listening on Query the User Interactively for a Password.1871machine # [ 9.470723] systemd[1]: Listening on Process Core Dump Socket.1872machine # [ 9.474611] systemd[1]: Listening on Credential Encryption/Decryption.1873machine # [ 9.478331] systemd[1]: Listening on Factory Reset Management.1874machine # [ 9.480290] systemd[1]: Listening on Hostname Service Socket.1875machine # [ 9.485541] systemd[1]: Starting Journal Log Access Socket...1876machine # [ 9.488326] systemd[1]: Listening on Journal Audit Socket.1877machine # [ 9.492250] systemd[1]: Listening on Console Output Muting Service Socket.1878machine # [ 9.494639] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1879machine # [ 9.497164] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1880machine # [ 9.499669] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1881machine # [ 9.511067] systemd[1]: Listening on Disk Repartitioning Service Socket.1882machine # [ 9.513387] systemd[1]: Listening on udev Varlink Socket.1883machine # [ 9.518100] systemd[1]: Mounting Huge Pages File System...1884machine # [ 9.523121] systemd[1]: Mounting POSIX Message Queue File System...1885machine # [ 9.533623] systemd[1]: Mounting Kernel Debug File System...1886machine # [ 9.542042] systemd[1]: Mounting Kernel Trace File System...1887machine # [ 9.553777] systemd[1]: Starting Create List of Static Device Nodes...1888machine # [ 9.565357] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1889machine # [ 9.569965] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1890machine # [ 9.583748] systemd[1]: Mounting Kernel Configuration File System...1891machine # [ 9.588255] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1892machine # [ 9.595199] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1893machine # [ 9.599136] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1894machine # [ 9.662460] systemd[1]: Mounting FUSE Control File System...1895machine # [ 9.669494] systemd[1]: systemd-cryptsetup@cryptroot.service: Deactivated successfully.1896machine # [ 9.682145] systemd[1]: Stopped systemd-cryptsetup@cryptroot.service.1897machine # [ 9.693205] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671898machine # [ 9.723620] systemd[1]: Starting Journal Service...1899machine # [ 9.738312] systemd[1]: Starting Load Kernel Modules...1900machine # [ 9.757277] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1901machine # [ 9.772681] systemd[1]: Starting Remount Root and Kernel File Systems...1902machine # [ 9.776382] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1903machine # [ 9.804767] systemd[1]: Starting Coldplug All udev Devices...1904machine # [ 9.836753] systemd-journald[288]: Collecting audit messages is enabled.1905machine # [ 9.844425] systemd[1]: Listening on Journal Log Access Socket.1906machine # [ 9.848166] systemd[1]: Mounted Huge Pages File System.1907machine # [ 9.856423] systemd[1]: Mounted POSIX Message Queue File System.1908machine # [ 9.829074] systemd[1]: Queued start job for default target Multi-User System.1909machine # [ 9.860124] systemd[1]: Started Journal Service.1910machine # [ 9.837138] systemd[1]: systemd-journald.service: Deactivated successfully.1911machine # [ 9.869953] EXT4-fs (dm-0): re-mounted feea331b-7040-42f8-846c-425c509b51d6.1912machine # [ 9.846227] systemd-modules-load[289]: Module 'atkbd' is built in1913machine # [ 9.854670] systemd-modules-load[289]: Module 'loop' is built in1914machine # [ 9.857407] systemd[1]: Mounted Kernel Debug File System.1915machine # [ 9.860275] systemd[1]: Mounted Kernel Trace File System.1916machine # [ 9.866087] systemd[1]: Finished Create List of Static Device Nodes.1917machine # [ 9.867098] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1918machine # [ 9.873328] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1919machine # [ 9.875689] systemd[1]: Mounted Kernel Configuration File System.1920machine # [ 9.881639] systemd[1]: Mounted FUSE Control File System.1921machine # [ 9.886438] systemd[1]: Finished Load Kernel Modules.1922machine # [ 9.890938] systemd[1]: Finished Remount Root and Kernel File Systems.1923machine # [ 9.897038] systemd[1]: Listening on Disk Image Download Service Socket.1924machine # [ 9.899954] systemd[1]: Starting Firewall...1925machine # [ 9.921512] systemd[1]: Starting Flush Journal to Persistent Storage...1926machine # [ 9.922671] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1927machine # [ 9.929075] systemd[1]: Starting Load/Save OS Random Seed...1928machine # [ 9.942275] systemd-oomd[290]: No swap; memory pressure usage will be degraded1929machine # [ 9.947287] systemd[1]: Starting Apply Kernel Variables...1930machine # [ 9.971394] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1931machine # [ 9.976065] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1932machine # [ 9.984281] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1933machine # [ 10.077429] systemd-journald[288]: Received client request to flush runtime journal.1934machine # [ 10.104135] systemd[1]: Finished Load/Save OS Random Seed.1935machine # [ 10.108371] systemd[1]: Reached target First Boot Complete.1936machine # [ 10.112928] systemd[1]: Finished Flush Journal to Persistent Storage.1937machine # [ 10.117840] systemd[1]: Finished Apply Kernel Variables.1938machine # [ 10.157481] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1939machine # [ 10.165149] systemd[1]: Starting Create Static Device Nodes in /dev...1940machine # [ 10.263423] systemd[1]: Finished Create Static Device Nodes in /dev.1941machine # [ 10.268341] systemd[1]: Reached target Preparation for Local File Systems.1942machine # [ 10.271155] systemd[1]: Starting Rule-based Manager for Device Events and Files...1943machine # [ 10.384283] systemd-udevd[330]: Using default interface naming scheme 'v261'.1944machine # [ 10.419667] systemd[1]: Mounting /run/wrappers...1945machine # [ 10.483657] systemd[1]: Mounted /run/wrappers.1946machine # [ 10.486826] systemd[1]: Starting Create SUID/SGID Wrappers...1947machine # [ 10.588997] systemd[1]: Started Rule-based Manager for Device Events and Files.1948machine # [ 11.231142] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1949machine # [ 11.235934] systemd[1]: Finished Create SUID/SGID Wrappers.1950machine # [ 11.658091] systemd[1]: Finished Coldplug All udev Devices.1951machine # [ 11.664759] systemd[1]: Finished Firewall.1952machine # [ 11.698757] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1953machine # [ 11.717130] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1954machine # [ 11.837920] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1955machine # [ 11.863017] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1956machine # [ 11.867425] systemd[1]: Found device /dev/tpmrm0.1957machine # [ 11.869719] systemd[1]: Expecting device /dev/tpm0...1958machine # [ 11.886069] (udev-worker)[360]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1959machine # [ 11.892236] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line.1960machine # [ 11.893658] (udev-worker)[369]: Network interface NamePolicy= disabled on kernel command line.1961machine # [ 12.010275] systemd[1]: Condition check resulted in Virtio network device being skipped.1962machine # [ 12.014573] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1963machine # [ 12.018844] systemd[1]: Starting Create SUID/SGID Wrappers...1964machine # [ 12.020936] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671965machine # [ 12.028363] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1966machine # [ 12.114272] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.1967machine # [ 12.123737] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...1968machine # [ 12.233975] systemd-fsck[506]: fsck.fat 4.2 (2021-01-31)1969machine # [ 12.236670] systemd-fsck[506]: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt.1970machine # [ 12.242094] systemd-fsck[506]: Automatically removing dirty bit.1971machine # [ 12.245459] systemd-fsck[506]: *** Filesystem was changed ***1972machine # [ 12.250253] systemd-fsck[506]: Writing changes.1973machine # [ 12.250926] systemd-fsck[506]: /dev/vda1: 20 files, 28914/63671 clusters1974machine # [ 12.256434] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.1975machine # [ 12.259632] systemd[1]: Mounting /boot...1976machine # [ 12.368443] systemd[1]: Mounted /boot.1977machine # [ 12.370875] systemd[1]: Reached target Local File Systems.1978machine # [ 12.375589] systemd[1]: Listening on Boot Loader Control Service Socket.1979machine # [ 12.382668] systemd[1]: Starting register-nix-paths.service...1980machine # [ 12.388129] systemd[1]: Starting Update Boot Loader Random Seed...1981machine # [ 12.419255] systemd[1]: Starting Save Transient machine-id to Disk...1982machine # [ 12.442222] systemd[1]: Starting Create System Files and Directories...1983machine # [ 12.496914] systemd[1]: Finished register-nix-paths.service.1984machine # [ 12.512481] bootctl[530]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 1985machine # [ 12.522411] bootctl[530]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!1986machine # [ 12.557358] bootctl[530]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).1987machine # [ 12.564922] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1988machine # [ 12.569488] systemd[1]: Finished Save Transient machine-id to Disk.1989machine # [ 12.574879] systemd[1]: Finished Update Boot Loader Random Seed.1990machine # [ 12.635976] mousedev: PS/2 mouse device common for all mice1991machine # [ 12.612102] systemd[1]: Finished Create System Files and Directories.1992machine # [ 12.618249] systemd[1]: Starting Rebuild Journal Catalog...1993machine # [ 12.624891] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1994machine # [ 12.705497] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1995machine # [ 12.758819] systemd[1]: Finished Rebuild Journal Catalog.1996machine # [ 12.765910] systemd[1]: Starting Update is Completed...1997machine # [ 12.784333] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1998machine # [ 12.787582] systemd[1]: Finished Create SUID/SGID Wrappers.1999machine # [ 12.818193] systemd[1]: Finished Update is Completed.2000machine # [ 13.651282] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio9/input/input32001machine # [ 13.678230] systemd[1]: Found device /dev/tpm0.2002machine # [ 13.680274] systemd[1]: Reached target Trusted Platform Module.2003machine # [ 13.684204] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2004machine # [ 13.686990] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os2005machine # [ 13.689650] systemd[1]: Reached target System Initialization.2006machine # [ 13.694705] systemd[1]: Started Discard unused filesystem blocks once a week.2007machine # [ 13.700438] systemd[1]: Started Daily Cleanup of Temporary Directories.2008machine # [ 13.701860] systemd[1]: Reached target Timer Units.2009machine # [ 13.704966] systemd[1]: Listening on D-Bus System Message Bus Socket.2010machine # [ 13.705875] systemd[1]: Listening on Nix Daemon Socket.2011machine # [ 13.706632] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.2012machine # [ 13.707789] systemd[1]: Reached target Socket Units.2013machine # [ 13.714955] systemd[1]: Reached target Basic System.2014machine # [ 13.720756] systemd[1]: Started backdoor.service.2015machine # [ 13.721711] systemd[1]: Starting Import lastlog data into lastlog2 database...2016machine # [ 13.724086] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2017machine # [ 13.755939] systemd[1]: Starting Post-Boot Actions...2018machine # [ 13.763589] systemd[1]: Started Reset console on configuration changes.2019machine # [ 13.795204] systemd[1]: Starting resolvconf update...2020machine # connecting to host...2021machine # [ 13.853743] systemd[1]: Starting D-Bus System Message Bus...2022machine: Guest shell says: b'Spawning backdoor root shell...\n'2023machine # [ 13.938457] systemd[1]: Finished Post-Boot Actions.2024machine: connected to guest root shell2025machine: (connecting took 26.97 seconds)2026machine: (finished: waiting for the VM to finish booting, in 27.18 seconds)2027machine # [ 13.947546] nsncd[587]: Sep 06 02:39:22.777 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2028machine # [ 13.964387] systemd[1]: Started Name Service Cache Daemon (nsncd).2029machine # [ 13.965323] systemd[1]: Reached target Host and Network Name Lookups.2030machine # [ 13.966193] systemd[1]: Reached target User and Group Name Lookups.2031machine # [ 13.978359] systemd[1]: Starting User Login Management...2032machine # [ 14.014030] systemd[1]: Finished Import lastlog data into lastlog2 database.2033machine # [ 14.116301] dbus-broker-launch[594]: Looking up NSS user entry for 'systemd-timesync'...2034machine # [ 14.179680] dbus-broker-launch[594]: NSS returned no entry for 'systemd-timesync'2035machine # [ 14.188279] dbus-broker-launch[594]: Invalid user-name in /nix/store/69p558cfwx3dz2rr2yyp0alz6bd89g9x-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"2036machine # [ 14.201766] systemd-logind[616]: New seat seat0.2037machine # [ 14.205949] systemd-logind[616]: Watching system buttons on /dev/input/event0 (Power Button)2038machine # [ 14.213167] systemd-logind[616]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)2039machine # [ 14.219531] systemd[1]: Started User Login Management.2040machine # [ 14.223542] systemd[1]: Stopped target Host and Network Name Lookups.2041machine # [ 14.229619] systemd[1]: Stopping Host and Network Name Lookups...2042machine # [ 14.230440] systemd[1]: Stopped target User and Group Name Lookups.2043machine # [ 14.231278] systemd[1]: Stopping User and Group Name Lookups...2044machine # [ 14.238768] systemd[1]: Starting linger-users.service...2045machine # [ 14.243315] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...2046machine # [ 14.262585] systemd[1]: nscd.service: Deactivated successfully.2047machine # [ 14.266393] systemd[1]: Stopped Name Service Cache Daemon (nsncd).2048machine # [ 14.285984] systemd[1]: Started D-Bus System Message Bus.2049machine # [ 14.325982] dbus-broker-launch[594]: Ready2050machine # [ 14.354613] systemd[1]: linger-users.service: Deactivated successfully.2051machine # [ 14.355580] systemd[1]: Finished linger-users.service.2052machine # [ 14.366490] systemd[1]: Starting Name Service Cache Daemon (nsncd)...2053machine # [ 14.370459] systemd[1]: Starting Virtual Console Setup...2054machine # [ 14.418182] systemd[1]: Finished resolvconf update.2055machine # [ 14.438118] systemd[1]: Reached target Preparation for Network.2056machine # [ 14.455018] systemd[1]: Starting DHCP Client...2057machine # [ 14.466373] nsncd[682]: Sep 06 02:39:23.295 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"2058machine # [ 14.479422] systemd[1]: Starting Address configuration of eth1...2059machine # [ 14.490851] systemd[1]: Starting Extra networking commands....2060machine # [ 14.492694] systemd[1]: Started Name Service Cache Daemon (nsncd).2061machine # [ 14.506526] systemd-logind[616]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)2062machine # [ 14.524843] systemd[1]: Reached target Host and Network Name Lookups.2063machine # [ 14.529234] systemd[1]: Reached target User and Group Name Lookups.2064machine # [ 14.636434] network-addresses-eth1-start[691]: adding address 192.168.1.1/24... done2065machine # [ 14.659905] network-addresses-eth1-start[691]: adding address 2001:db8:1::1/64... done2066machine # [ 14.686983] systemd[1]: Finished Address configuration of eth1.2067machine # [ 14.745068] dhcpcd[710]: dhcpcd-10.3.2 starting2068machine # [ 14.758615] dhcpcd[762]: dev: loaded udev2069machine # [ 14.770482] systemd[1]: Finished Extra networking commands..2070machine # [ 14.773480] systemd[1]: Reached target Network.2071machine # [ 14.778014] systemd[1]: Starting Permit User Sessions...2072machine # [ 14.835163] 8021q: 802.1Q VLAN Support v1.82073machine # [ 14.835561] 8021q: adding VLAN 0 to HW filter on device eth12074machine # [ 14.828341] systemd[1]: Finished Permit User Sessions.2075machine # [ 14.838443] systemd[1]: Started Getty on tty1.2076machine # [ 14.839963] systemd[1]: Reached target Login Prompts.2077machine # [ 14.864461] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.2078machine # [ 14.924845] cfg80211: Loading compiled-in X.509 certificates for regulatory database2079machine # [ 14.957888] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'2080machine # [ 14.958356] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'2081machine # [ 14.963318] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -22082machine # [ 14.963645] cfg80211: failed to load regulatory.db2083machine # [ 15.024856] 8021q: adding VLAN 0 to HW filter on device eth02084machine # [ 14.996931] dhcpcd[762]: eth0: waiting for carrier2085machine # [ 14.998699] dhcpcd[762]: eth0: carrier acquired2086machine # [ 15.009932] dhcpcd[762]: DUID 00:01:00:01:32:2f:8e:db:52:54:00:12:34:562087machine # [ 15.011146] dhcpcd[762]: eth0: IAID 00:12:34:562088machine # [ 15.011912] dhcpcd[762]: eth0: adding address fe80::5054:ff:fe12:34562089machine # [ 15.064755] systemd-vconsole-setup[683]: Configuration of first virtual console was skipped, ignoring remaining ones.2090machine # [ 15.068839] systemd[1]: Finished Virtual Console Setup.2091machine # [ 15.722264] dhcpcd[762]: eth0: soliciting a DHCP lease2092machine # [ 15.729004] dhcpcd[762]: eth0: offered 10.0.2.15 from 10.0.2.22093machine # [ 15.732465] dhcpcd[762]: eth0: probing address 10.0.2.15/242094machine # [ 17.485214] dhcpcd[762]: eth0: soliciting an IPv6 router2095machine # [ 17.489842] dhcpcd[762]: eth0: Router Advertisement from fe80::22096machine # [ 17.492667] dhcpcd[762]: eth0: adding address fec0::5054:ff:fe12:3456/642097machine # [ 17.495644] dhcpcd[762]: eth0: adding route to fec0::/642098machine # [ 17.498188] dhcpcd[762]: eth0: adding default route via fe80::22099machine # [ 21.083123] dhcpcd[762]: eth0: leased 10.0.2.15 for 86400 seconds2100machine # [ 21.093012] dhcpcd[762]: eth0: adding route to 10.0.2.0/242101machine # [ 21.100751] dhcpcd[762]: eth0: adding default route via 10.0.2.22102machine # [ 21.291446] systemd[1]: Started DHCP Client.2103machine # [ 21.294019] systemd[1]: Reached target Multi-User System.2104machine # [ 21.295493] systemd[1]: Startup finished in 6.067s (firmware) + 6.300s (loader) + 903ms (kernel) + 6.657s (initrd) + 13.733s (userspace) = 33.663s.2105machine: (finished: waiting for unit multi-user.target, in 35.55 seconds)2106machine: must succeed: mount2107machine: (finished: must succeed: mount, in 0.03 seconds)2108(finished: run the VM test script, in 75.82 seconds)2109test script finished in 75.87s2110cleanup2111kill QemuMachine (pid 93)2112machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)2113(finished: cleanup, in 0.02 seconds)