vm-test-run-systemd-boot-switch-test
checks.aarch64-linux.systemd-boot-switch-test
· build #42
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: must succeed: test -e /boot/efi/fruits/tomato.efi8machine: waiting for the VM to finish booting9machine: starting vm10machine # Disk image does not exist, creating the virtualisation disk image...11machine: QEMU running (pid 45)12machine # Formatting '/build/vm-state-machine/tmp.bNuKkO9em5', fmt=raw size=107374182413machine # mke2fs 1.47.4 (6-Mar-2025)14machine # Discarding device blocks: 0/262144 done15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: c8c5a89f-ff25-47bc-a2aa-f1276713e29717machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Formatting '/build/vm-state-machine/machine-esp.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=273695232 backing_file=/nix/store/4d7pr555hznb6vjhy87gqr2l22q6ni6h-machine-esp-image/esp.qcow2 backing_fmt=qcow2 lazy_refcounts=off refcount_bits=1627machine # Starting virtiofs daemons...28machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-09-23T03:00:02Z INFO virtiofsd] Waiting for vhost-user socket connection...31machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-09-23T03:00:02Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35machine # [2026-09-23T03:00:02Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36machine # [2026-09-23T03:00:02Z INFO virtiofsd] Waiting for vhost-user socket connection...37machine # [2026-09-23T03:00:03Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-23T03:00:03Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-09-23T03:00:03Z INFO virtiofsd] Client connected, servicing requests40machine # UEFI firmware (version built at 00:00:00 on Jan 1 1980)41machine: 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'42machine # BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x4,0x0)43machine: Guest shell says: b'BdsDxe: loading Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x4,0x0)\r\n'44machine # BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x4,0x0)45machine: Guest shell says: b'BdsDxe: starting Boot0002 "UEFI Misc Device" from PciRoot(0x0)/Pci(0x4,0x0)\r\n\r \r\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'46machine: Guest shell says: b'\x1b[2J\x1b[001;001H\x1b[021;063H\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 '47machine: Guest shell says: b' Reboot Into Firmware Interface \x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m '48machine: Guest shell says: b' Boot in 5s. \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b'49machine: Guest shell says: b'[0m\x1b[37m\x1b[40m------------------------------------------'50machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 4s. '51machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'52machine: Guest shell says: b'------------------------------------------'53machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 3s. '54machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'55machine: Guest shell says: b'---------------------'56machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 2s. '57machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m---------------------'58machine: Guest shell says: b'---------------------'59machine: Guest shell says: b'\x1b[024;001H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m Boot in 1s. '60machine: Guest shell says: b' \x1b[023;060H\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m'61machine: Guest shell says: b'------------------------------------------'62machine: Guest shell says: b'\x1b[1m\x1b[37m\x1b[40m\x1b[0m\x1b[37m\x1b[40m\x1b[2J\x1b[001;001H'63machine # 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]64machine # [ 0.000000] Linux version 6.18.53 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 21 13:06:06 UTC 202665machine # [ 0.000000] KASLR enabled66machine # [ 0.000000] efi: EFI v2.7 by EDK II67machine # [ 0.000000] efi: SMBIOS 3.0=0x47d60000 MEMATTR=0x45b14018 ACPI 2.0=0x47ff3018 RNG=0x47ff3198 INITRD=0x45b0cb18 MEMRESERVE=0x45b15e9868machine # [ 0.000000] random: crng init done69machine # [ 0.000000] ACPI: Early table checksum verification disabled70machine # [ 0.000000] ACPI: RSDP 0x0000000047FF3018 000024 (v02 BOCHS )71machine # [ 0.000000] ACPI: XSDT 0x0000000047FF3F18 00006C (v01 BOCHS BXPC 00000001 01000013)72machine # [ 0.000000] ACPI: FACP 0x0000000047FF3B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)73machine # [ 0.000000] ACPI: DSDT 0x0000000047FF1018 0015A5 (v02 BOCHS BXPC 00000001 BXPC 00000001)74machine # [ 0.000000] ACPI: APIC 0x0000000047FF3C98 0000B8 (v04 BOCHS BXPC 00000001 BXPC 00000001)75machine # [ 0.000000] ACPI: PPTT 0x0000000047FF3D98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)76machine # [ 0.000000] ACPI: GTDT 0x0000000047FF3098 000068 (v03 BOCHS BXPC 00000001 BXPC 00000001)77machine # [ 0.000000] ACPI: MCFG 0x0000000047FF3A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)78machine # [ 0.000000] ACPI: SPCR 0x0000000047FF3E98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)79machine # [ 0.000000] ACPI: DBG2 0x0000000047FF3818 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)80machine # [ 0.000000] ACPI: IORT 0x0000000047FF3898 000080 (v05 BOCHS BXPC 00000001 BXPC 00000001)81machine # [ 0.000000] ACPI: BGRT 0x0000000047FF3998 000038 (v01 INTEL EDK2 00000002 01000013)82machine # [ 0.000000] ACPI: SPCR: console: pl011,mmio32,0x9000000,960083machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]84machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fdf2880-0x7fdf5fff]85machine # [ 0.000000] Zone ranges:86machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]87machine # [ 0.000000] DMA32 empty88machine # [ 0.000000] Normal empty89machine # [ 0.000000] Device empty90machine # [ 0.000000] Movable zone start for each node91machine # [ 0.000000] Early memory node ranges92machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x0000000045fdffff]93machine # [ 0.000000] node 0: [mem 0x0000000045fe0000-0x000000004605ffff]94machine # [ 0.000000] node 0: [mem 0x0000000046060000-0x000000004609ffff]95machine # [ 0.000000] node 0: [mem 0x00000000460a0000-0x00000000462affff]96machine # [ 0.000000] node 0: [mem 0x00000000462b0000-0x00000000462bffff]97machine # [ 0.000000] node 0: [mem 0x00000000462c0000-0x00000000463dffff]98machine # [ 0.000000] node 0: [mem 0x00000000463e0000-0x0000000047bbffff]99machine # [ 0.000000] node 0: [mem 0x0000000047bc0000-0x0000000047feffff]100machine # [ 0.000000] node 0: [mem 0x0000000047ff0000-0x000000007fffffff]101machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]102machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000103machine # [ 0.000000] psci: probing for conduit method from ACPI.104machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.105machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs106machine # [ 0.000000] psci: Trusted OS migration not required107machine # [ 0.000000] psci: SMC Calling Convention v1.1108machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)109machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186776 r8192 d116328 u311296110machine # [ 0.000000] Detected PIPT I-cache on CPU0111machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)112machine # [ 0.000000] CPU features: detected: GICv3 CPU interface113machine # [ 0.000000] CPU features: detected: Spectre-v4114machine # [ 0.000000] CPU features: detected: Spectre-BHB115machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38116machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23117machine # [ 0.000000] alternatives: applying boot alternatives118machine # [ 0.000000] Kernel command line: initrd=\EFI\nixos\ym09nd5md4j4qbj0fdfdw5rdyvqsw0jl-initrd-linux-6.18.53-initrd.efi init=/nix/store/424wkrw28hlxpmkzqzzi644jdsrndkm2-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,bpf119machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes120machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)121machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)122machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB123machine # [ 0.000000] software IO TLB: area num 1.124machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)125machine # [ 0.000000] Fallback order for Node 0: 0126machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144127machine # [ 0.000000] Policy zone: DMA128machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off129machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1130machine # [ 0.000000] allocated 2097152 bytes of page_ext131machine # [ 0.000000] ftrace: allocating 74963 entries in 294 pages132machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups133machine # [ 0.000000] rcu: Hierarchical RCU implementation.134machine # [ 0.000000] rcu: RCU event tracing is enabled.135machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.136machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.137machine # [ 0.000000] Rude variant of Tasks RCU enabled.138machine # [ 0.000000] Tracing variant of Tasks RCU enabled.139machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.140machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1141machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.142machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.143machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.144machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0145machine # [ 0.000000] GICv3: 256 SPIs implemented146machine # [ 0.000000] GICv3: 0 Extended SPIs implemented147machine # [ 0.000000] Root IRQ handler: gic_handle_irq148machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI149machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0150machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000151machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]152machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @408f0000 (indirect, esz 8, psz 64K, shr 1)153machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @40900000 (flat, esz 8, psz 64K, shr 1)154machine # [ 0.000000] GICv3: using LPI property table @0x0000000040910000155machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000040920000156machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.157machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns158machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).159machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns160machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns161machine # [ 0.000033] arm-pv: using stolen time PV162machine # [ 0.000538] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)163machine # [ 0.000661] Console: colour dummy device 80x25164machine # [ 0.000665] printk: legacy console [tty0] enabled165machine # [ 0.000886] ACPI: Core revision 20250807166machine # [ 0.000989] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)167machine # [ 0.000997] pid_max: default: 32768 minimum: 301168machine # [ 0.001063] LSM: initializing lsm=capability,landlock,yama,bpf,ima169machine # [ 0.001223] landlock: Up and running.170machine # [ 0.001225] Yama: becoming mindful.171machine # [ 0.001756] LSM support for eBPF active172machine # [ 0.001865] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)173machine # [ 0.001874] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)174machine # [ 0.002945] rcu: Hierarchical SRCU implementation.175machine # [ 0.002952] rcu: Max phase no-delay instances is 1000.176machine # [ 0.003673] fsl-mc MSI: ITS@0x8080000 domain created177machine # [ 0.003700] Remapping and enabling EFI services.178machine # [ 0.003986] smp: Bringing up secondary CPUs ...179machine # [ 0.003998] smp: Brought up 1 node, 1 CPU180machine # [ 0.004032] SMP: Total of 1 processors activated.181machine # [ 0.004036] CPU: All CPU(s) started at EL1182machine # [ 0.004047] CPU features: detected: Branch Target Identification183machine # [ 0.004053] CPU features: detected: ARMv8.4 Translation Table Level184machine # [ 0.004056] CPU features: detected: Instruction cache invalidation not required for I/D coherence185machine # [ 0.004060] CPU features: detected: Data cache clean to the PoU not required for I/D coherence186machine # [ 0.004063] CPU features: detected: Common not Private translations187machine # [ 0.004066] CPU features: detected: CRC32 instructions188machine # [ 0.004069] CPU features: detected: Data cache clean to Point of Deep Persistence189machine # [ 0.004073] CPU features: detected: Data cache clean to Point of Persistence190machine # [ 0.004076] CPU features: detected: Data independent timing control (DIT)191machine # [ 0.004079] CPU features: detected: E0PD192machine # [ 0.004082] CPU features: detected: Enhanced Counter Virtualization193machine # [ 0.004085] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)194machine # [ 0.004088] CPU features: detected: Enhanced Virtualization Traps195machine # [ 0.004091] CPU features: detected: Fine Grained Traps196machine # [ 0.004094] CPU features: detected: Generic authentication (architected QARMA5 algorithm)197machine # [ 0.004099] CPU features: detected: RCpc load-acquire (LDAPR)198machine # [ 0.004102] CPU features: detected: LSE atomic instructions199machine # [ 0.004105] CPU features: detected: Privileged Access Never200machine # [ 0.004108] CPU features: detected: PMUv3201machine # [ 0.004111] CPU features: detected: RAS Extension Support202machine # [ 0.004113] CPU features: detected: RASv1p1 Extension Support203machine # [ 0.004116] CPU features: detected: Random Number Generator204machine # [ 0.004118] CPU features: detected: Speculation barrier (SB)205machine # [ 0.004121] CPU features: detected: Stage-2 Force Write-Back206machine # [ 0.004124] CPU features: detected: TLB range maintenance instructions207machine # [ 0.004128] CPU features: detected: Speculative Store Bypassing Safe (SSBS)208machine # [ 0.004166] alternatives: applying system-wide alternatives209machine # [ 0.007035] CPU features: detected: BBM Level 2 without TLB conflict abort210machine # [ 0.007191] Memory: 886684K/1048576K available (24448K kernel code, 7094K rwdata, 26592K rodata, 4736K init, 1107K bss, 120552K reserved, 32768K cma-reserved)211machine # [ 0.007511] devtmpfs: initialized212machine # [ 0.008555] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)213machine # [ 0.008566] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).214machine # [ 0.008741] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL215machine # [ 0.008747] 0 pages in range for non-PLT usage216machine # [ 0.008748] 508224 pages in range for PLT usage217machine # [ 0.008833] pinctrl core: initialized pinctrl subsystem218machine # [ 0.009480] SMBIOS 3.0.0 present.219machine # [ 0.009486] DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022220machine # [ 0.009497] DMI: Memory slots populated: 1/1221machine # [ 0.010959] NET: Registered PF_NETLINK/PF_ROUTE protocol family222machine # [ 0.011644] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations223machine # [ 0.011782] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations224machine # [ 0.011942] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations225machine # [ 0.011961] audit: initializing netlink subsys (disabled)226machine # [ 0.012085] audit: type=2000 audit(0.008:1): state=initialized audit_enabled=0 res=1227machine # [ 0.012492] thermal_sys: Registered thermal governor 'fair_share'228machine # [ 0.012495] thermal_sys: Registered thermal governor 'bang_bang'229machine # [ 0.012498] thermal_sys: Registered thermal governor 'step_wise'230machine # [ 0.012501] thermal_sys: Registered thermal governor 'user_space'231machine # [ 0.012504] thermal_sys: Registered thermal governor 'power_allocator'232machine # [ 0.012537] cpuidle: using governor ladder233machine # [ 0.012546] cpuidle: using governor menu234machine # [ 0.012737] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.235machine # [ 0.012755] ASID allocator initialised with 65536 entries236machine # [ 0.013585] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5237machine # [ 0.013785] Serial: AMBA PL011 UART driver238machine # [ 0.020365] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages239machine # [ 0.020373] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page240machine # [ 0.020376] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages241machine # [ 0.020379] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page242machine # [ 0.020382] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages243machine # [ 0.020384] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page244machine # [ 0.020387] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages245machine # [ 0.020390] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page246machine # [ 0.021259] fbcon: Taking over console247machine # [ 0.021301] ACPI: Added _OSI(Module Device)248machine # [ 0.021304] ACPI: Added _OSI(Processor Device)249machine # [ 0.021307] ACPI: Added _OSI(Processor Aggregator Device)250machine # [ 0.022288] ACPI: 1 ACPI AML tables successfully acquired and loaded251machine # [ 0.028249] ACPI: Interpreter enabled252machine # [ 0.028255] ACPI: Using GIC for interrupt routing253machine # [ 0.028293] ACPI: MCFG table detected, 1 entries254machine # [ 0.032495] ACPI: CPU0 has been hot-added255machine # [ 0.032961] ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA256machine # [ 0.033045] printk: console [ttyAMA0] enabled257machine # [ 0.091023] ACPI: PCI: Interrupt link L000 configured for IRQ 35258machine # [ 0.091047] ACPI: PCI: Interrupt link L001 configured for IRQ 36259machine # [ 0.091061] ACPI: PCI: Interrupt link L002 configured for IRQ 37260machine # [ 0.091073] ACPI: PCI: Interrupt link L003 configured for IRQ 38261machine # [ 0.091093] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])262machine # [ 0.091138] acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]263machine # [ 0.091222] acpi PNP0A08:00: _OSC: platform does not support [LTR]264machine # [ 0.091318] acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]265machine # [ 0.091601] acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00266machine # [ 0.091625] acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]267machine # [ 0.091647] ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]268machine # [ 0.092020] PCI host bridge to bus 0000:00269machine # [ 0.092048] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]270machine # [ 0.092053] pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]271machine # [ 0.092056] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]272machine # [ 0.092060] pci_bus 0000:00: root bus resource [bus 00-ff]273machine # [ 0.092064] PCI: OF: of_root node is NULL, cannot create PCI host bridge node274machine # [ 0.092123] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint275machine # [ 0.092657] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint276machine # [ 0.092839] pci 0000:00:01.0: BAR 0 [io 0x01a0-0x01bf]277machine # [ 0.092851] pci 0000:00:01.0: BAR 1 [mem 0x1004c000-0x1004cfff]278machine # [ 0.092876] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]279machine # [ 0.092888] pci 0000:00:01.0: ROM [mem 0xfffc0000-0xffffffff pref]280machine # [ 0.093397] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint281machine # [ 0.094331] pci 0000:00:02.0: BAR 0 [io 0x0180-0x019f]282machine # [ 0.094345] pci 0000:00:02.0: BAR 1 [mem 0x1004b000-0x1004bfff]283machine # [ 0.094371] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]284machine # [ 0.095005] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint285machine # [ 0.217193] pci 0000:00:03.0: BAR 0 [io 0x0080-0x00ff]286machine # [ 0.217213] pci 0000:00:03.0: BAR 1 [mem 0x1004a000-0x1004afff]287machine # [ 0.217239] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]288machine # [ 0.217879] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint289machine # [ 0.218843] pci 0000:00:04.0: BAR 0 [io 0x0000-0x007f]290machine # [ 0.218857] pci 0000:00:04.0: BAR 1 [mem 0x10049000-0x10049fff]291machine # [ 0.218884] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]292machine # [ 0.219495] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint293machine # [ 0.219686] pci 0000:00:05.0: BAR 0 [io 0x0160-0x017f]294machine # [ 0.219697] pci 0000:00:05.0: BAR 1 [mem 0x10048000-0x10048fff]295machine # [ 0.219723] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]296machine # [ 0.219736] pci 0000:00:05.0: ROM [mem 0xfffc0000-0xffffffff pref]297machine # [ 0.220269] pci 0000:00:06.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint298machine # [ 0.232631] pci 0000:00:06.0: BAR 1 [mem 0x10047000-0x10047fff]299machine # [ 0.232664] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]300machine # [ 0.233287] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint301machine # [ 0.233481] pci 0000:00:07.0: BAR 1 [mem 0x10046000-0x10046fff]302machine # [ 0.233507] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]303machine # [ 0.233994] pci 0000:00:08.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint304machine # [ 0.240434] pci 0000:00:08.0: BAR 0 [mem 0x10045000-0x10045fff]305machine # [ 0.240796] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint306machine # [ 0.240997] pci 0000:00:09.0: BAR 1 [mem 0x10044000-0x10044fff]307machine # [ 0.241025] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]308machine # [ 0.241576] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint309machine # [ 0.241771] pci 0000:00:0a.0: BAR 1 [mem 0x10043000-0x10043fff]310machine # [ 0.241798] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]311machine # [ 0.242334] pci 0000:00:0b.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint312machine # [ 0.242525] pci 0000:00:0b.0: BAR 1 [mem 0x10042000-0x10042fff]313machine # [ 0.242551] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]314machine # [ 0.251964] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint315machine # [ 0.252790] pci 0000:00:0c.0: BAR 0 [io 0x0100-0x013f]316machine # [ 0.252805] pci 0000:00:0c.0: BAR 1 [mem 0x10041000-0x10041fff]317machine # [ 0.252832] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]318machine # [ 0.253482] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint319machine # [ 0.254261] pci 0000:00:0d.0: BAR 0 [io 0x0140-0x015f]320machine # [ 0.254273] pci 0000:00:0d.0: BAR 1 [mem 0x10040000-0x10040fff]321machine # [ 0.254300] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]322machine # [ 0.254980] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned323machine # [ 0.254986] pci 0000:00:05.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned324machine # [ 0.254990] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned325machine # [ 0.255036] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned326machine # [ 0.255081] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned327machine # [ 0.255131] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned328machine # [ 0.255177] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned329machine # [ 0.255226] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned330machine # [ 0.270926] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned331machine # [ 0.270980] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned332machine # [ 0.271025] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned333machine # [ 0.271070] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned334machine # [ 0.271114] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned335machine # [ 0.271158] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned336machine # [ 0.271202] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned337machine # [ 0.271221] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned338machine # [ 0.271239] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned339machine # [ 0.271258] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned340machine # [ 0.271276] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned341machine # [ 0.271294] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned342machine # [ 0.271789] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned343machine # [ 0.271809] pci 0000:00:08.0: BAR 0 [mem 0x10087000-0x10087fff]: assigned344machine # [ 0.272310] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned345machine # [ 0.272329] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned346machine # [ 0.272348] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned347machine # [ 0.272367] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned348machine # [ 0.272386] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned349machine # [ 0.272446] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned350machine # [ 0.291525] pci 0000:00:04.0: BAR 0 [io 0x1080-0x10ff]: assigned351machine # [ 0.292283] pci 0000:00:0c.0: BAR 0 [io 0x1100-0x113f]: assigned352machine # [ 0.292873] pci 0000:00:01.0: BAR 0 [io 0x1140-0x115f]: assigned353machine # [ 0.292897] pci 0000:00:02.0: BAR 0 [io 0x1160-0x117f]: assigned354machine # [ 0.293452] pci 0000:00:05.0: BAR 0 [io 0x1180-0x119f]: assigned355machine # [ 0.293475] pci 0000:00:0d.0: BAR 0 [io 0x11a0-0x11bf]: assigned356machine # [ 0.294030] pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]357machine # [ 0.294039] pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]358machine # [ 0.294042] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]359machine # [ 0.305424] iommu: Default domain type: Translated360machine # [ 0.305441] iommu: DMA domain TLB invalidation policy: strict mode361machine # [ 0.305671] SCSI subsystem initialized362machine # [ 0.305830] ACPI: bus type USB registered363machine # [ 0.305884] usbcore: registered new interface driver usbfs364machine # [ 0.305908] usbcore: registered new interface driver hub365machine # [ 0.305925] usbcore: registered new device driver usb366machine # [ 0.306157] pps_core: LinuxPPS API ver. 1 registered367machine # [ 0.306161] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>368machine # [ 0.306174] PTP clock support registered369machine # [ 0.306212] EDAC MC: Ver: 3.0.0370machine # [ 0.306596] scmi_core: SCMI protocol bus registered371machine # [ 0.306726] efivars: Registered efivars operations372machine # [ 0.307118] FPGA manager framework373machine # [ 0.316107] vgaarb: loaded374machine # [ 0.316396] clocksource: Switched to clocksource arch_sys_counter375machine # [ 0.316748] VFS: Disk quotas dquot_6.6.0376machine # [ 0.316771] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)377machine # [ 0.318783] netfs: FS-Cache loaded378machine # [ 0.318909] pnp: PnP ACPI init379machine # [ 0.319142] system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved380machine # [ 0.319193] pnp: PnP ACPI: found 1 devices381machine # [ 0.327269] NET: Registered PF_INET protocol family382machine # [ 0.327333] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)383machine # [ 0.350498] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)384machine # [ 0.350548] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)385machine # [ 0.350575] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)386machine # [ 0.350629] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)387machine # [ 0.350702] TCP: Hash tables configured (established 8192 bind 8192)388machine # [ 0.350795] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)389machine # [ 0.350826] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)390machine # [ 0.350847] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)391machine # [ 0.350933] NET: Registered PF_UNIX/PF_LOCAL protocol family392machine # [ 0.350957] NET: Registered PF_XDP protocol family393machine # [ 0.351779] PCI: CLS 0 bytes, default 64394machine # [ 0.352028] Trying to unpack rootfs image as initramfs...395machine # [ 0.370481] kvm [1]: HYP mode not available396machine # [ 0.517176] Initialise system trusted keyrings397machine # [ 0.517333] workingset: timestamp_bits=42 max_order=18 bucket_order=0398machine # [ 0.517684] squashfs: version 4.0 (2009/01/31) Phillip Lougher399machine # [ 0.517783] 9p: Installing v9fs 9p2000 file system support400machine # [ 0.545917] Key type asymmetric registered401machine # [ 0.545936] Asymmetric key parser 'x509' registered402machine # [ 0.546011] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)403machine # [ 0.546149] io scheduler mq-deadline registered404machine # [ 0.546154] io scheduler kyber registered405machine # [ 0.557840] ledtrig-cpu: registered to indicate activity on CPUs406machine # [ 0.559020] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0407machine # [ 0.559073] ACPI: button: Power Button [PWRB]408machine # [ 0.589188] ACPI: \_SB_.L001: Enabled at IRQ 36409machine # [ 0.589241] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)410machine # [ 0.591806] ACPI: \_SB_.L002: Enabled at IRQ 37411machine # [ 0.591843] virtio-pci 0000:00:02.0: enabling device (0005 -> 0007)412machine # [ 0.596583] ACPI: \_SB_.L003: Enabled at IRQ 38413machine # [ 0.596615] virtio-pci 0000:00:03.0: enabling device (0005 -> 0007)414machine # [ 0.598273] ACPI: \_SB_.L000: Enabled at IRQ 35415machine # [ 0.598297] virtio-pci 0000:00:04.0: enabling device (0005 -> 0007)416machine # [ 0.608476] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)417machine # [ 0.620790] virtio-pci 0000:00:07.0: enabling device (0000 -> 0002)418machine # [ 0.623020] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)419machine # [ 0.633398] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)420machine # [ 0.635711] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0002)421machine # [ 0.639684] virtio-pci 0000:00:0c.0: enabling device (0005 -> 0007)422machine # [ 0.649940] virtio-pci 0000:00:0d.0: enabling device (0005 -> 0007)423machine # [ 0.655361] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled424machine # [ 0.658473] msm_serial: driver initialized425machine # [ 0.658586] SuperH (H)SCI(F) driver initialized426machine # [ 0.658628] STM32 USART driver initialized427machine # [ 0.686704] ACPI: bus type drm_connector registered428machine # [ 0.697355] loop: module loaded429machine # [ 0.697564] virtio_blk virtio2: 1/0/0 default/read/poll queues430machine # [ 0.698337] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)431machine # [ 0.702881] virtio_blk virtio3: 1/0/0 default/read/poll queues432machine # [ 0.703635] virtio_blk virtio3: [vdb] 534561 512-byte logical blocks (274 MB/261 MiB)433machine # [ 0.744515] vdb: vdb1434machine # [ 0.745421] megasas: 07.734.00.00-rc1435machine # [ 0.747970] tun: Universal TUN/TAP device driver, 1.6436machine # [ 0.751333] thunder_xcv, ver 1.0437machine # [ 0.751372] thunder_bgx, ver 1.0438machine # [ 0.751393] nicpf, ver 1.0439machine # [ 0.752006] e1000: Intel(R) PRO/1000 Network Driver440machine # [ 0.752011] e1000: Copyright (c) 1999-2006 Intel Corporation.441machine # [ 0.752035] e1000e: Intel(R) PRO/1000 Network Driver442machine # [ 0.752038] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.443machine # [ 0.752075] igb: Intel(R) Gigabit Ethernet Network Driver444machine # [ 0.752078] igb: Copyright (c) 2007-2014 Intel Corporation.445machine # [ 0.752101] igbvf: Intel(R) Gigabit Virtual Function Network Driver446machine # [ 0.752107] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.447machine # [ 0.752242] sky2: driver version 1.30448machine # [ 0.762349] usbcore: registered new interface driver usb-storage449machine # [ 0.762416] usbcore: registered new interface driver usbserial_generic450machine # [ 0.762428] usbserial: USB Serial support registered for generic451machine # [ 0.763029] hv_vmbus: registering driver hyperv_keyboard452machine # [ 0.764112] ehci-pci 0000:00:08.0: EHCI Host Controller453machine # [ 0.764137] ehci-pci 0000:00:08.0: new USB bus registered, assigned bus number 1454machine # [ 0.764586] ehci-pci 0000:00:08.0: irq 48, io mem 0x10087000455machine # [ 0.770776] rtc-efi rtc-efi.0: registered as rtc0456machine # [ 0.770810] rtc-efi rtc-efi.0: setting system clock to 2026-09-23T03:00:15 UTC (1790132415)457machine # [ 0.771141] i2c_dev: i2c /dev entries driver458machine # [ 0.776608] sdhci: Secure Digital Host Controller Interface driver459machine # [ 0.776615] sdhci: Copyright(c) Pierre Ossman460machine # [ 0.776898] Synopsys Designware Multimedia Card Interface Driver461machine # [ 0.777230] sdhci-pltfm: SDHCI platform and OF driver helper462machine # [ 0.778348] pstore: Using crash dump compression: deflate463machine # [ 0.778354] pstore: Registered efi_pstore as persistent store backend464machine # [ 0.778475] ehci-pci 0000:00:08.0: USB 2.0 started, EHCI 1.00465machine # [ 0.778810] hub 1-0:1.0: USB hub found466machine # [ 0.778829] hub 1-0:1.0: 6 ports detected467machine # [ 0.793595] hid: raw HID events driver (C) Jiri Kosina468machine # [ 0.793922] usbcore: registered new interface driver usbhid469machine # [ 0.793927] usbhid: USB HID core driver470machine # [ 0.795006] hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 11 (0,800003ff) counters available471machine # [ 0.804963] drop_monitor: Initializing network drop monitor service472machine # [ 0.805157] NET: Registered PF_INET6 protocol family473machine # [ 0.805731] Segment Routing with IPv6474machine # [ 0.805745] In-situ OAM (IOAM) with IPv6475machine # [ 0.805781] NET: Registered PF_PACKET protocol family476machine # [ 0.805887] 9pnet: Installing 9P2000 support477machine # [ 0.805938] Key type dns_resolver registered478machine # [ 0.825076] registered taskstats version 1479machine # [ 0.825258] Loading compiled-in X.509 certificates480machine # [ 0.848457] Demotion targets for Node 0: null481machine # [ 0.848776] Key type .fscrypt registered482machine # [ 0.848781] Key type fscrypt-provisioning registered483machine # [ 0.848904] ima: No TPM chip found, activating TPM-bypass!484machine # [ 0.848923] ima: Allocated hash algorithm: sha1485machine # [ 0.848945] ima: No architecture policies found486machine # [ 0.897077] clk: Disabling unused clocks487machine # [ 0.897103] PM: genpd: Disabling unused power domains488machine # [ 1.032520] usb 1-1: new high-speed USB device number 2 using ehci-pci489machine # [ 1.068319] Freeing initrd memory: 26380K490machine # [ 1.071916] Freeing unused kernel memory: 4736K491machine # [ 1.072158] Run /init as init process492machine # [ 1.093746] fuse: init (API version 7.45)493machine # [ 1.097435] virtiofs virtio7: discovered new tag: nix-store494machine # [ 1.098221] virtiofs virtio7: virtio_fs_setup_dax: No cache capability495machine # [ 1.114233] virtiofs virtio8: discovered new tag: shared496machine # [ 1.114977] virtiofs virtio8: virtio_fs_setup_dax: No cache capability497machine # [ 1.116321] virtiofs virtio9: discovered new tag: xchg498machine # [ 1.119320] virtiofs virtio9: virtio_fs_setup_dax: No cache capability499machine # [ 1.133866] systemd[1]: Successfully made /usr/ read-only.500machine # [ 1.186752] input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:08.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1501machine # [ 1.256898] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:08.0-1/input0502machine # [ 1.376584] usb 1-2: new high-speed USB device number 3 using ehci-pci503machine # [ 1.468322] systemd[1]: systemd 263-ef3e0ff 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)504machine # [ 1.468381] systemd[1]: Detected virtualization kvm.505machine # [ 1.468578] systemd[1]: Detected architecture arm64.506machine # [ 1.468600] systemd[1]: Running in initrd.507machine # [ 1.470019] systemd[1]: Initializing machine ID from random generator.508machine # [ 1.470384] systemd[1]: Hostname set to <machine>.509machine # [ 1.565096] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:08.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2510machine # [ 1.565499] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:08.0-2/input0511machine # [ 1.681237] systemd[1]: bpf-restrict-fs: LSM BPF program attached512machine # [ 1.744972] systemd[1]: Queued start job for default target Initrd Default Target.513machine # [ 1.754997] systemd[1]: Created slice Slice /system/modprobe.514machine # [ 1.755235] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.515machine # [ 1.755268] systemd[1]: Expecting device /dev/disk/by-label/nixos...516machine # [ 1.755293] systemd[1]: Reached target Path Units.517machine # [ 1.755309] systemd[1]: Reached target Slice Units.518machine # [ 1.755323] systemd[1]: Reached target Swaps.519machine # [ 1.755338] systemd[1]: Reached target Timer Units.520machine # [ 1.755491] systemd[1]: Listening on D-Bus System Message Bus Socket.521machine # [ 1.755641] systemd[1]: Listening on Journal Socket (/dev/log).522machine # [ 1.755766] systemd[1]: Listening on Journal Sockets.523machine # [ 1.755877] systemd[1]: Listening on udev Kernel Socket.524machine # [ 1.755890] systemd[1]: Reached target Socket Units.525machine # [ 1.765983] systemd[1]: Starting Create List of Static Device Nodes...526machine # [ 1.766062] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs527machine # [ 1.772640] systemd[1]: Mounting Kernel Configuration File System...528machine # [ 1.783048] systemd[1]: Starting Journal Service...529machine # [ 1.793212] systemd[1]: Starting Load Kernel Modules...530machine # [ 1.793458] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os531machine # [ 1.808307] systemd[1]: Starting Coldplug All udev Devices...532machine # [ 1.833236] systemd[1]: Finished Create List of Static Device Nodes.533machine # [ 1.863560] systemd-journald[70]: Collecting audit messages is disabled.534machine # [ 1.876679] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...535machine # [ 1.881801] systemd[1]: Mounted Kernel Configuration File System.536machine # [ 1.899483] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.537machine # [ 1.920740] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev538machine # [ 1.937816] [drm] pci: virtio-gpu-pci detected at 0000:00:06.0539machine # [ 1.938043] [drm] features: -virgl +edid -resource_blob -host_visible540machine # [ 1.938046] [drm] features: -context_init541machine # [ 1.938807] [drm] number of scanouts: 1542machine # [ 1.938829] [drm] number of cap sets: 0543machine # [ 1.944139] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.544machine # [ 1.947130] systemd[1]: Starting Create Static Device Nodes in /dev...545machine # [ 1.960925] virtio-pci 0000:00:06.0: [drm] Registered 1 planes with drm panic546machine # [ 1.960940] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:06.0 on minor 0547machine # [ 1.985095] Console: switching to colour frame buffer device 160x50548machine # [ 2.013101] virtio-pci 0000:00:06.0: [drm] fb0: virtio_gpudrmfb frame buffer device549machine # [ 2.015020] systemd[1]: Finished Create Static Device Nodes in /dev.550machine # [ 2.015472] systemd[1]: Reached target Preparation for Local File Systems.551machine # [ 2.015512] systemd[1]: Reached target Local File Systems.552machine # [ 2.024741] systemd[1]: Starting Rule-based Manager for Device Events and Files...553machine # [ 2.040609] systemd[1]: Finished Load Kernel Modules.554machine # [ 2.042626] systemd[1]: Starting Apply Kernel Variables...555machine # [ 2.056444] systemd-modules-load[71]: Inserted module 'dm_mod'556machine # [ 2.057594] systemd-modules-load[71]: Module 'virtio_balloon' is built in557machine # [ 2.058857] systemd-modules-load[71]: Module 'virtio_console' is built in558machine # [ 2.059957] systemd-modules-load[71]: Inserted module 'virtio_gpu'559machine # [ 2.089689] systemd[1]: Started Journal Service.560machine # [ 2.076617] systemd-modules-load[71]: Module 'virtio_rng' is built in561machine # [ 2.088139] systemd[1]: Starting Create System Files and Directories...562machine # [ 2.101479] systemd[1]: Finished Apply Kernel Variables.563machine # [ 2.137571] systemd-udevd[76]: Using default interface naming scheme 'v261'.564machine # [ 2.148127] systemd[1]: Finished Create System Files and Directories.565machine # [ 2.173653] systemd[1]: Started Rule-based Manager for Device Events and Files.566machine # [ 2.242665] systemd[1]: Starting Virtual Console Setup...567machine # [ 2.308590] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.568machine # [ 2.312770] systemd[1]: Finished Virtual Console Setup.569machine # [ 2.967411] systemd[1]: Finished Coldplug All udev Devices.570machine # [ 2.969282] systemd[1]: Reached target System Initialization.571machine # [ 2.972167] systemd[1]: Reached target Basic System.572machine # [ 3.151660] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.573machine # [ 3.174032] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.574machine # [ 3.235728] systemd[1]: Found device /dev/disk/by-label/nixos.575machine # [ 3.242557] systemd[1]: Reached target Initrd Root Device.576machine # [ 3.247782] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...577machine # [ 3.297960] systemd-fsck[106]: nixos: clean, 12/65536 files, 13019/262144 blocks578machine # [ 3.306789] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.579machine # [ 3.309677] systemd[1]: Mounting /sysroot...580machine # [ 3.367701] systemd[1]: Mounted /sysroot.[ 3.392985] EXT4-fs (vda): mounted filesystem c8c5a89f-ff25-47bc-a2aa-f1276713e297 r/w with ordered data mode. Quota mode: none.581machine # 582machine # [ 3.375102] systemd[1]: Reached target Initrd Root File System.583machine # [ 3.381205] systemd[1]: Starting Mountpoints Configured in the Real Root...584machine # [ 3.415536] systemd-sysroot-fstab-check[114]: /sysroot should be mounted in the initrd, will request daemon-reload.585machine # [ 3.423840] systemd[1]: Reload requested from client PID 114 ('systemd-sysroot') (unit initrd-parse-etc.service)...586machine # [ 3.432297] systemd[1]: Reloading...587machine # [ 3.664456] systemd[1]: Reloading finished in 244 ms.588machine # [ 3.698003] systemd-sysroot-fstab-check[114]: Requesting initrd-fs.target/start/replace...589machine # [ 3.714613] systemd-sysroot-fstab-check[114]: Requesting swap.target/start/replace...590machine # [ 3.724191] systemd[1]: initrd-parse-etc.service: Deactivated successfully.591machine # [ 3.727897] systemd[1]: Finished Mountpoints Configured in the Real Root.592machine # [ 3.730602] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.593machine # [ 3.802310] systemd[1]: Mounting /sysroot/nix/.ro-store...594machine # [ 3.820168] systemd[1]: Mounting /sysroot/nix/.rw-store...595machine # [ 3.830293] systemd[1]: Mounting /sysroot/run...596machine # [ 3.855378] systemd[1]: Mounting /sysroot/tmp/shared...597machine # [ 3.889945] systemd[1]: Mounting /sysroot/tmp/xchg...598machine # [ 3.942084] systemd[1]: Mounted /sysroot/nix/.ro-store.599machine # [ 3.948390] systemd[1]: Mounted /sysroot/nix/.rw-store.600machine # [ 3.955085] systemd[1]: Mounted /sysroot/run.601machine # [ 3.975616] systemd[1]: Mounted /sysroot/tmp/shared.602machine # [ 3.986275] systemd[1]: Mounted /sysroot/tmp/xchg.603machine # [ 4.000838] systemd[1]: Starting rw-sysroot-nix-store.service...604machine # [ 4.025228] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.605machine # [ 4.026819] systemd[1]: Finished rw-sysroot-nix-store.service.606machine # [ 4.800722] systemd[1]: Mounting /sysroot/nix/store...607machine # [ 4.813794] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.608machine # [ 4.818152] systemd[1]: Stopped Virtual Console Setup.609machine # [ 4.819027] systemd[1]: Stopping Virtual Console Setup...610machine # [ 4.826443] systemd[1]: Starting Virtual Console Setup...611machine # [ 4.852862] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.612machine # [ 4.858577] systemd[1]: Stopped Virtual Console Setup.613machine # [ 4.863810] systemd[1]: Starting Virtual Console Setup...614machine # [ 4.869357] systemd[1]: Mounted /sysroot/nix/store.615machine # [ 4.872235] systemd[1]: Reached target Initrd File Systems.616machine # [ 4.877002] systemd[1]: Starting Find NixOS closure...617machine # [ 4.884924] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...618machine # [ 4.931502] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.619machine # [ 4.940329] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.620machine # [ 4.949744] systemd[1]: Finished Find NixOS closure.621machine # [ 4.950650] systemd[1]: Reached target Initrd Default Target.622machine # [ 4.952396] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...623machine # [ 4.962256] systemd-vconsole-setup[151]: Configuration of first virtual console was skipped, ignoring remaining ones.624machine # [ 4.977834] systemd[1]: Finished Virtual Console Setup.625machine # [ 4.989178] systemd[1]: Stopped target Initrd Default Target.626machine # [ 4.990981] systemd[1]: Stopped target Basic System.627machine # [ 4.995342] systemd[1]: Stopped target Initrd Root Device.628machine # [ 4.996762] systemd[1]: Stopped target Path Units.629machine # [ 4.997503] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.630machine # [ 4.998579] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.631machine # [ 5.000831] systemd[1]: Stopped target Slice Units.632machine # [ 5.002480] systemd[1]: Stopped target Socket Units.633machine # [ 5.004389] systemd[1]: Stopped target System Initialization.634machine # [ 5.010328] systemd[1]: Stopped target Swaps.635machine # [ 5.011882] systemd[1]: Stopped target Timer Units.636machine # [ 5.013590] systemd[1]: dbus.socket: Deactivated successfully.637machine # [ 5.017683] systemd[1]: Closed D-Bus System Message Bus Socket.638machine # [ 5.020291] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.639machine # [ 5.024236] systemd[1]: Stopped Find NixOS closure.640machine # [ 5.028386] systemd[1]: Starting rw-sysroot-nix-store.service...641machine # [ 5.030250] systemd[1]: systemd-sysctl.service: Deactivated successfully.642machine # [ 5.033689] systemd[1]: Stopped Apply Kernel Variables.643machine # [ 5.036197] systemd[1]: systemd-modules-load.service: Deactivated successfully.644machine # [ 5.039232] systemd[1]: Stopped Load Kernel Modules.645machine # [ 5.040160] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.646machine # [ 5.042812] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.647machine # [ 5.045686] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.648machine # [ 5.047157] systemd[1]: Stopped Create System Files and Directories.649machine # [ 5.048417] systemd[1]: Stopped target Local File Systems.650machine # [ 5.049219] systemd[1]: Stopped target Preparation for Local File Systems.651machine # [ 5.050187] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.652machine # [ 5.051281] systemd[1]: Stopped Coldplug All udev Devices.653machine # [ 5.061400] systemd[1]: Stopping Rule-based Manager for Device Events and Files...654machine # [ 5.062568] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.655machine # [ 5.063772] systemd[1]: Stopped Virtual Console Setup.656machine # [ 5.070721] systemd[1]: initrd-cleanup.service: Deactivated successfully.657machine # [ 5.073908] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.658machine # [ 5.075057] systemd[1]: systemd-udevd.service: Deactivated successfully.659machine # [ 5.076608] systemd[1]: Stopped Rule-based Manager for Device Events and Files.660machine # [ 5.077696] systemd[1]: systemd-udevd.service: Consumed 1.662s CPU time over 3.042s wall clock time, 22.8M memory peak.661machine # [ 5.079147] systemd[1]: Starting Cleanup udev Database...662machine # [ 5.079945] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.663machine # [ 5.084289] systemd[1]: Stopped Create Static Device Nodes in /dev.664machine # [ 5.087601] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.665machine # [ 5.092539] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.666machine # [ 5.093884] systemd[1]: kmod-static-nodes.service: Deactivated successfully.667machine # [ 5.094912] systemd[1]: Stopped Create List of Static Device Nodes.668machine # [ 5.100196] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.669machine # [ 5.101332] systemd[1]: Finished rw-sysroot-nix-store.service.670machine # [ 5.137942] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.671machine # [ 5.140556] systemd[1]: Finished Cleanup udev Database.672machine # [ 5.142743] systemd[1]: Reached target Switch Root.673machine # [ 5.144593] systemd[1]: Starting NixOS Activation...674machine # [ 5.247698] initrd-nixos-activation-start[174]: booting system configuration /nix/store/424wkrw28hlxpmkzqzzi644jdsrndkm2-nixos-system-machine-test675machine # [ 5.291102] initrd-nixos-activation-start[174]: running activation script...676machine # [ 5.575632] initrd-nixos-activation-start[197]: setting up /etc...677machine # [ 5.718441] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.678machine # [ 5.721653] systemd[1]: Finished NixOS Activation.679machine # [ 5.722994] systemd[1]: Starting Switch Root...680machine # [ 5.749692] systemd[1]: Switching root.681machine # [ 5.947577] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).682machine # [ 6.072189] NET: Registered PF_VSOCK protocol family683machine # [ 6.446443] systemd[1]: systemd 263-ef3e0ff 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)684machine # [ 6.446504] systemd[1]: Detected virtualization kvm.685machine # [ 6.446568] systemd[1]: Detected architecture arm64.686machine # [ 6.566611] systemd[1]: bpf-restrict-fs: LSM BPF program attached687machine # [ 7.091843] systemd[1]: initrd-switch-root.service: Deactivated successfully.688machine # [ 7.092309] systemd[1]: Stopped initrd-switch-root.service.689machine # [ 7.098337] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.690machine # [ 7.100329] systemd[1]: Created slice Slice /system/getty.691machine # [ 7.104757] systemd[1]: Created slice Slice /system/systemd-fsck.692machine # [ 7.105584] systemd[1]: Created slice User and Session Slice.693machine # [ 7.105729] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.694machine # [ 7.105824] systemd[1]: Started Forward Password Requests to Wall Directory Watch.695machine # [ 7.106239] systemd[1]: Expecting device /dev/disk/by-label/ESP...696machine # [ 7.106563] systemd[1]: Expecting device /dev/hvc0...697machine # [ 7.106850] systemd[1]: Expecting device /dev/ttyAMA0...698machine # [ 7.107144] systemd[1]: Reached target Local Encrypted Volumes.699machine # [ 7.107431] systemd[1]: Stopped target initrd-fs.target.700machine # [ 7.107705] systemd[1]: Stopped target initrd-root-fs.target.701machine # [ 7.107960] systemd[1]: Stopped target initrd-switch-root.target.702machine # [ 7.108232] systemd[1]: Reached target Virtual Machines and Containers.703machine # [ 7.119076] systemd[1]: Reached target Path Units.704machine # [ 7.119551] systemd[1]: Reached target Remote File Systems.705machine # [ 7.122965] systemd[1]: Reached target Slice Units.706machine # [ 7.123413] systemd[1]: Reached target Swaps.707machine # [ 7.128197] systemd[1]: Listening on Query the User Interactively for a Password.708machine # [ 7.132754] systemd[1]: Listening on Process Core Dump Socket.709machine # [ 7.134405] systemd[1]: Listening on Credential Encryption/Decryption.710machine # [ 7.135803] systemd[1]: Listening on Factory Reset Management.711machine # [ 7.136395] systemd[1]: Listening on Hostname Service Socket.712machine # [ 7.144242] systemd[1]: Starting Journal Log Access Socket...713machine # [ 7.147852] systemd[1]: Listening on Journal Audit Socket.714machine # [ 7.152134] systemd[1]: Listening on Console Output Muting Service Socket.715machine # [ 7.154464] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.716machine # [ 7.155937] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os717machine # [ 7.160282] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki718machine # [ 7.166785] systemd[1]: Listening on Disk Repartitioning Service Socket.719machine # [ 7.167458] systemd[1]: Listening on udev Varlink Socket.720machine # [ 7.173588] systemd[1]: Mounting Huge Pages File System...721machine # [ 7.178148] systemd[1]: Mounting POSIX Message Queue File System...722machine # [ 7.196559] systemd[1]: Mounting Kernel Debug File System...723machine # [ 7.202366] systemd[1]: Mounting Kernel Trace File System...724machine # [ 7.220114] systemd[1]: Starting Create List of Static Device Nodes...725machine # [ 7.222865] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs726machine # [ 7.244983] systemd[1]: Mounting Kernel Configuration File System...727machine # [ 7.245450] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm728machine # [ 7.245757] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore729machine # [ 7.246066] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse730machine # [ 7.282220] systemd[1]: Mounting FUSE Control File System...731machine # [ 7.308204] systemd[1]: Starting seed-system-profile.service...732machine # [ 7.314397] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67733machine # [ 7.336882] systemd[1]: Starting Journal Service...734machine # [ 7.352228] systemd[1]: Starting Load Kernel Modules...735machine # [ 7.373844] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...736machine # [ 7.410438] systemd[1]: Starting Remount Root and Kernel File Systems...737machine # [ 7.410875] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os738machine # [ 7.430362] systemd[1]: Starting Coldplug All udev Devices...739machine # [ 7.458437] systemd[1]: Listening on Journal Log Access Socket.740machine # [ 7.459000] systemd[1]: Mounted Huge Pages File System.741machine # [ 7.459449] systemd[1]: Mounted POSIX Message Queue File System.742machine # [ 7.459852] systemd[1]: Mounted Kernel Debug File System.743machine # [ 7.460246] systemd[1]: Mounted Kernel Trace File System.744machine # [ 7.472882] systemd-journald[269]: Collecting audit messages is enabled.745machine # [ 7.458521] systemd[1]: Queued start job for default target Multi-User System.746machine # [ 7.459857] systemd[1]: systemd-journald.service: Deactivated successfully.747machine # [ 7.492637] systemd[1]: Finished Create List of Static Device Nodes.748machine # [ 7.501171] systemd[1]: Started Journal Service.749machine # [ 7.477013] systemd[1]: Finished seed-system-profile.service.750machine # [ 7.486833] systemd-modules-load[270]: Module 'atkbd' is built in751machine # [ 7.487874] systemd-modules-load[270]: Module 'loop' is built in752machine # [ 7.502480] systemd[1]: Finished Load Kernel Modules.753machine # [ 7.507291] systemd[1]: Mounted Kernel Configuration File System.754machine # [ 7.536468] systemd[1]: Starting Firewall...755machine # [ 7.541765] systemd-oomd[271]: No swap; memory pressure usage will be degraded756machine # [ 7.547344] systemd[1]: Starting Apply Kernel Variables...757machine # [ 7.555039] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...758machine # [ 7.585213] EXT4-fs (vda): re-mounted c8c5a89f-ff25-47bc-a2aa-f1276713e297.759machine # [ 7.561353] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.760machine # [ 7.562547] systemd[1]: Mounted FUSE Control File System.761machine # [ 7.580126] systemd[1]: Finished Remount Root and Kernel File Systems.762machine # [ 7.581186] systemd[1]: Listening on Disk Image Download Service Socket.763machine # [ 7.606255] systemd[1]: Starting Flush Journal to Persistent Storage...764machine # [ 7.607345] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore765machine # [ 7.616529] systemd[1]: Starting Load/Save OS Random Seed...766machine # [ 7.617395] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os767machine # [ 7.725012] systemd-journald[269]: Received client request to flush runtime journal.768machine # [ 7.956911] systemd[1]: Finished Apply Kernel Variables.769machine # [ 7.960332] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.770machine # [ 7.961597] systemd[1]: Starting Create Static Device Nodes in /dev...771machine # [ 7.962550] systemd[1]: Finished Load/Save OS Random Seed.772machine # [ 7.963347] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes773machine # [ 7.972360] systemd[1]: Finished Flush Journal to Persistent Storage.774machine # [ 8.229023] systemd[1]: Finished Create Static Device Nodes in /dev.775machine # [ 8.231331] systemd[1]: Reached target Preparation for Local File Systems.776machine # [ 8.246182] systemd[1]: Mounting /run/wrappers...777machine # [ 8.248217] systemd[1]: Starting Rule-based Manager for Device Events and Files...778machine # [ 8.355119] systemd[1]: Mounted /run/wrappers.779machine # [ 8.360544] systemd[1]: Starting Create SUID/SGID Wrappers...780machine # [ 8.430864] systemd-udevd[314]: Using default interface naming scheme 'v261'.781machine # [ 8.568923] systemd[1]: Started Rule-based Manager for Device Events and Files.782machine # [ 8.806604] systemd[1]: Finished Coldplug All udev Devices.783machine # [ 9.018019] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs784machine # [ 9.075537] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse785machine # [ 9.302878] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.786machine # [ 9.307038] systemd[1]: Finished Create SUID/SGID Wrappers.787machine # [ 9.365256] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.788machine # [ 9.376172] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.789machine # [ 9.473535] (udev-worker)[371]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.790machine # [ 9.475868] (udev-worker)[371]: Network interface NamePolicy= disabled on kernel command line.791machine # [ 9.728661] systemd[1]: Condition check resulted in Virtio network device being skipped.792machine # [ 9.734094] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore793machine # [ 9.744229] systemd[1]: Starting Create SUID/SGID Wrappers...794machine # [ 9.748741] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67795machine # [ 9.755981] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore796machine # [ 9.757774] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os797machine # [ 9.759049] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os798machine # [ 9.824722] systemd[1]: Condition check resulted in /dev/disk/by-label/ESP being skipped.799machine # [ 9.841739] systemd[1]: Starting File System Check on /dev/disk/by-label/ESP...800machine # [ 9.994917] systemd-fsck[483]: fsck.fat 4.2 (2021-01-31)801machine # [ 9.995839] systemd-fsck[483]: /dev/vdb1: 23 files, 22731/66398 clusters802machine # [ 10.007139] systemd[1]: Finished File System Check on /dev/disk/by-label/ESP.803machine # [ 10.025541] systemd[1]: Mounting /boot...804machine # [ 10.046056] systemd[1]: Finished Firewall.805machine # [ 10.158811] systemd[1]: Mounted /boot.806machine # [ 10.160728] systemd[1]: Reached target Local File Systems.807machine # [ 10.166907] systemd[1]: Listening on Boot Loader Control Service Socket.808machine # [ 10.176122] systemd[1]: Starting register-nix-paths.service...809machine # [ 10.180457] systemd[1]: Starting Update Boot Loader Random Seed...810machine # [ 10.186037] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id811machine # [ 10.210340] systemd[1]: Starting Create System Files and Directories...812machine # [ 10.277420] bootctl[511]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 813machine # [ 10.289863] bootctl[511]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!814machine # [ 10.324801] mousedev: PS/2 mouse device common for all mice815machine # [ 10.357019] bootctl[511]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).816machine # [ 10.370610] bootctl[511]: Successfully initialized system token in EFI variable with 32 bytes.817machine # [ 10.378869] systemd[1]: Finished Update Boot Loader Random Seed.818machine # [ 10.429376] systemd[1]: Finished Create System Files and Directories.819machine # [ 10.444243] systemd[1]: Starting Rebuild Journal Catalog...820machine # [ 10.451691] systemd[1]: Starting Record System Boot/Shutdown in UTMP...821machine # [ 10.576091] systemd[1]: Finished Record System Boot/Shutdown in UTMP.822machine # [ 10.618844] systemd[1]: Finished Rebuild Journal Catalog.823machine # [ 10.628421] systemd[1]: Starting Update is Completed...824machine # [ 10.701178] systemd[1]: Finished Update is Completed.825machine # [ 10.727209] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.826machine # [ 10.736336] systemd[1]: Finished Create SUID/SGID Wrappers.827machine # [ 11.574847] systemd[1]: Finished register-nix-paths.service.828machine # [ 11.578317] systemd[1]: Reached target System Initialization.829machine # [ 11.582275] systemd[1]: Started Discard unused filesystem blocks once a week.830machine # [ 11.585957] systemd[1]: Started Daily Cleanup of Temporary Directories.831machine # [ 11.586980] systemd[1]: Reached target Timer Units.832machine # [ 11.587703] systemd[1]: Listening on D-Bus System Message Bus Socket.833machine # [ 11.593247] systemd[1]: Listening on Nix Daemon Socket.834machine # [ 11.596528] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.835machine # [ 11.600190] systemd[1]: Reached target Socket Units.836machine # [ 11.603699] systemd[1]: Reached target Basic System.837machine # [ 11.606103] systemd[1]: Started backdoor.service.838machine # [ 11.609581] systemd[1]: Starting install-boot-loader.service...839machine # [ 11.626424] systemd[1]: Starting Import lastlog data into lastlog2 database...840machine # [ 11.650004] systemd[1]: Starting Name Service Cache Daemon (nsncd)...841machine # [ 11.659453] systemd[1]: Starting Post-Boot Actions...842machine # [ 11.675994] systemd[1]: Started Reset console on configuration changes.843machine # [ 11.736665] systemd[1]: Starting resolvconf update...844machine # connecting to host...845machine # [ 11.811376] bootctl[578]: Created directory "/boot/EFI".846machine # [ 11.820785] bootctl[578]: Created directory "/boot/EFI/systemd".847machine # [ 11.821748] bootctl[578]: Created directory "/boot/EFI/BOOT".848machine # [ 11.822593] bootctl[578]: Created directory "/boot/loader".849machine # [ 11.823383] bootctl[578]: Created directory "/boot/loader/keys".850machine # [ 11.839204] bootctl[578]: Created directory "/boot/loader".851machine # [ 11.842519] bootctl[578]: Created directory "/boot/loader/entries".852machine # [ 11.843489] bootctl[578]: Created directory "/boot/EFI".853machine # [ 11.856612] bootctl[578]: Created directory "/boot/EFI/Linux".854machine # [ 11.863071] systemd[1]: Starting D-Bus System Message Bus...855machine # [ 11.873391] bootctl[578]: Copied "/nix/store/2lckkskw40in5vmpcihl3b4rygx8df89-systemd-263-ef3e0ff/lib/systemd/boot/efi/systemd-bootaa64.efi" to "/boot/EFI/systemd/systemd-bootaa64.efi".856machine: Guest shell says: b'Spawning backdoor root shell...\n'857machine # [ 11.907766] systemd[1]: Finished Post-Boot Actions.858machine # [ 11.918008] nsncd[572]: Sep 23 03:00:26.674 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"859machine: connected to guest root shell860machine # [ 11.934315] systemd[1]: Started Name Service Cache Daemon (nsncd).861machine: (connecting took 23.93 seconds)862machine # [ 11.935302] systemd[1]: Reached target Host and Network Name Lookups.863machine: (finished: waiting for the VM to finish booting, in 24.34 seconds)864machine # [ 11.945603] systemd[1]: Reached target User and Group Name Lookups.865machine # [ 11.946573] systemd[1]: Starting User Login Management...866machine # [ 11.995755] systemd[1]: Finished Import lastlog data into lastlog2 database.867machine: (finished: must succeed: test -e /boot/efi/fruits/tomato.efi, in 24.42 seconds)868machine: must succeed: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi869machine # [ 12.031865] bootctl[578]: Copied "/nix/store/2lckkskw40in5vmpcihl3b4rygx8df89-systemd-263-ef3e0ff/lib/systemd/boot/efi/systemd-bootaa64.efi" to "/boot/EFI/BOOT/BOOTAA64.EFI".870machine # [ 12.049589] bootctl[578]: Mount point '/boot' which backs the random seed file is world accessible, which is a security hole! 871machine # [ 12.051352] bootctl[578]: Random seed file '/boot/loader/random-seed' is world accessible, which is a security hole!872machine: (finished: must succeed: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi, in 0.08 seconds)873subtest: remove files when no longer needed874machine: must succeed: /nix/store/pcbsdg68k1s4rprxfh0p5n2fx35m0rjv-nixos-system-common-test/bin/switch-to-configuration boot875machine # [ 12.164322] dbus-broker-launch[582]: Looking up NSS user entry for 'systemd-timesync'...876machine # [ 12.166484] bootctl[578]: Random seed file /boot/loader/random-seed successfully refreshed (32 bytes).877machine # [ 12.182189] dbus-broker-launch[582]: NSS returned no entry for 'systemd-timesync'878machine # [ 12.183389] dbus-broker-launch[582]: Invalid user-name in /nix/store/sa6lwfjl4h38s8x4n9mkxq4b2h1y5vb1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"879machine # [ 12.208198] bootctl[578]: Created EFI boot entry "Linux Boot Manager".880machine # [ 12.266014] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:07.0/virtio6/input/input3881machine # [ 12.252833] systemd-logind[600]: New seat seat0.882machine # [ 12.259269] systemd-logind[600]: Watching system buttons on /dev/input/event0 (Power Button)883machine # [ 12.276421] bootctl[578]: Created EFI boot entry "Fallback Linux Boot Manager".884machine # [ 12.284247] systemd-logind[600]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)885machine # [ 12.297933] systemd[1]: Started User Login Management.886machine # [ 12.298806] systemd[1]: Starting linger-users.service...887machine # [ 12.332196] systemd[1]: Started D-Bus System Message Bus.888machine # [ 12.361798] systemd[1]: Finished install-boot-loader.service.889machine # Not checking switch inhibitors (action = boot)890machine # [ 12.386502] systemd[1]: Stopped target Host and Network Name Lookups.891machine # [ 12.389611] systemd[1]: Stopping Host and Network Name Lookups...892machine # [ 12.390540] systemd[1]: Stopped target User and Group Name Lookups.893machine # [ 12.391402] systemd[1]: Stopping User and Group Name Lookups...894machine # [ 12.403884] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...895machine # [ 12.413026] systemd[1]: nscd.service: Deactivated successfully.896machine # [ 12.414004] systemd[1]: Stopped Name Service Cache Daemon (nsncd).897machine # [ 12.425816] dbus-broker-launch[582]: Ready898machine # [ 12.434283] systemd[1]: linger-users.service: Deactivated successfully.899machine # [ 12.441832] systemd[1]: Finished linger-users.service.900machine # [ 12.467832] systemd[1]: Starting Name Service Cache Daemon (nsncd)...901machine # [ 12.579580] systemd[1]: Started Name Service Cache Daemon (nsncd).902machine # [ 12.587010] nsncd[669]: Sep 23 03:00:27.337 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"903machine # [ 12.598029] systemd[1]: Reached target Host and Network Name Lookups.904machine # [ 12.599035] systemd[1]: Reached target User and Group Name Lookups.905machine # [ 12.599891] systemd[1]: Finished resolvconf update.906machine # [ 12.608721] systemd[1]: Reached target Preparation for Network.907machine # [ 12.615705] systemd[1]: Starting DHCP Client...908machine # [ 12.620138] systemd[1]: Starting Address configuration of eth1...909machine # [ 12.646328] systemd[1]: Starting Extra networking commands....910machine # [ 12.879227] network-addresses-eth1-start[690]: adding address 192.168.1.2/24... done911machine # [ 12.913247] network-addresses-eth1-start[690]: adding address 2001:db8:1::2/64... done912machine # [ 12.967323] systemd[1]: Finished Address configuration of eth1.913machine # [ 13.045302] dhcpcd[699]: dhcpcd-10.3.2 starting914machine # [ 13.063375] dhcpcd[741]: dev: loaded udev915machine # [ 13.152180] 8021q: 802.1Q VLAN Support v1.8916machine # [ 13.157816] 8021q: adding VLAN 0 to HW filter on device eth1917machine # [ 13.181968] systemd[1]: Finished Extra networking commands..918machine # [ 13.187346] systemd[1]: Reached target Network.919machine # [ 13.202264] systemd[1]: Starting Permit User Sessions...920machine # [ 13.233840] systemd[1]: Starting Virtual Console Setup...921machine # [ 13.371857] cfg80211: Loading compiled-in X.509 certificates for regulatory database922machine # [ 13.352856] systemd[1]: Finished Permit User Sessions.923machine # [ 13.369675] systemd[1]: Started Getty on tty1.924machine # [ 13.376587] systemd[1]: Reached target Login Prompts.925machine # [ 13.460178] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'926machine # [ 13.464678] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'927machine # [ 13.466465] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2928machine # [ 13.466790] cfg80211: failed to load regulatory.db929machine # [ 13.461480] systemd-logind[600]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)930machine # [ 13.476493] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.931machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.932machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.933machine # [ 13.551215] dhcpcd[741]: eth0: waiting for carrier[ 13.578606] 8021q: adding VLAN 0 to HW filter on device eth0934machine # 935machine # [ 13.556914] dhcpcd[741]: libudev: received NULL device936machine # [ 13.557818] dhcpcd[741]: libudev: received NULL device937machine # [ 13.558610] dhcpcd[741]: eth0: carrier acquired938machine # [ 13.569001] dhcpcd[741]: DUID 00:01:00:01:32:45:fd:4c:52:54:00:12:34:56939machine # [ 13.570060] dhcpcd[741]: eth0: IAID 00:12:34:56940machine # [ 13.570695] dhcpcd[741]: eth0: adding address fe80::5054:ff:fe12:3456941machine: (finished: must succeed: /nix/store/pcbsdg68k1s4rprxfh0p5n2fx35m0rjv-nixos-system-common-test/bin/switch-to-configuration boot, in 1.62 seconds)942machine: must fail: test -e /boot/efi/fruits/tomato.efi943machine # [ 13.723521] systemd-vconsole-setup[762]: Configuration of first virtual console was skipped, ignoring remaining ones.944machine # [ 13.728990] systemd[1]: Finished Virtual Console Setup.945machine: (finished: must fail: test -e /boot/efi/fruits/tomato.efi, in 0.02 seconds)946machine: must fail: test -d /boot/efi/fruits947machine: (finished: must fail: test -d /boot/efi/fruits, in 0.01 seconds)948machine: must succeed: test -d /boot/efi/nixos/.extra-files949machine: (finished: must succeed: test -d /boot/efi/nixos/.extra-files, in 0.01 seconds)950machine: must fail: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi951machine: (finished: must fail: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi, in 0.01 seconds)952machine: must fail: test -d /boot/efi/nixos/.extra-files/efi/fruits953machine: (finished: must fail: test -d /boot/efi/nixos/.extra-files/efi/fruits, in 0.01 seconds)954(finished: subtest: remove files when no longer needed, in 1.70 seconds)955subtest: files are added back when needed again956machine: must succeed: /nix/store/424wkrw28hlxpmkzqzzi644jdsrndkm2-nixos-system-machine-test/bin/switch-to-configuration boot957machine # Not checking switch inhibitors (action = boot)958machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.959machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.960machine: (finished: must succeed: /nix/store/424wkrw28hlxpmkzqzzi644jdsrndkm2-nixos-system-machine-test/bin/switch-to-configuration boot, in 0.28 seconds)961machine: must succeed: test -e /boot/efi/fruits/tomato.efi962machine: (finished: must succeed: test -e /boot/efi/fruits/tomato.efi, in 0.01 seconds)963machine: must succeed: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi964machine: (finished: must succeed: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi, in 0.01 seconds)965(finished: subtest: files are added back when needed again, in 0.30 seconds)966subtest: simultaneously removing and adding files works967machine: must succeed: /nix/store/mdhy81ss58hqg5jdk4m2vbm6w9mfmm7z-nixos-system-with_netbootxyz-test/bin/switch-to-configuration boot968machine # Not checking switch inhibitors (action = boot)969machine # Skipping "/boot/EFI/systemd/systemd-bootaa64.efi", same boot loader version in place already.970machine # Skipping "/boot/EFI/BOOT/BOOTAA64.EFI", same boot loader version in place already.971machine: (finished: must succeed: /nix/store/mdhy81ss58hqg5jdk4m2vbm6w9mfmm7z-nixos-system-with_netbootxyz-test/bin/switch-to-configuration boot, in 0.28 seconds)972machine: must fail: test -e /boot/efi/fruits/tomato.efi973machine: (finished: must fail: test -e /boot/efi/fruits/tomato.efi, in 0.01 seconds)974machine: must fail: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi975machine: (finished: must fail: test -e /boot/efi/nixos/.extra-files/efi/fruits/tomato.efi, in 0.01 seconds)976machine: must succeed: test -e /boot/loader/entries/netbootxyz.conf977machine: (finished: must succeed: test -e /boot/loader/entries/netbootxyz.conf, in 0.01 seconds)978machine: must succeed: test -e /boot/efi/netbootxyz/netboot.xyz.efi979machine: (finished: must succeed: test -e /boot/efi/netbootxyz/netboot.xyz.efi, in 0.01 seconds)980machine: must succeed: test -e /boot/efi/nixos/.extra-files/loader/entries/netbootxyz.conf981machine: (finished: must succeed: test -e /boot/efi/nixos/.extra-files/loader/entries/netbootxyz.conf, in 0.01 seconds)982machine: must succeed: test -e /boot/efi/nixos/.extra-files/efi/netbootxyz/netboot.xyz.efi983machine: (finished: must succeed: test -e /boot/efi/nixos/.extra-files/efi/netbootxyz/netboot.xyz.efi, in 0.01 seconds)984(finished: subtest: simultaneously removing and adding files works, in 0.36 seconds)985(finished: run the VM test script, in 26.86 seconds)986machine # [ 14.819444] dhcpcd[741]: eth0: soliciting a DHCP lease987machine # [ 14.825358] dhcpcd[741]: eth0: offered 10.0.2.15 from 10.0.2.2988machine # [ 14.828456] dhcpcd[741]: eth0: probing address 10.0.2.15/24989test script finished in 27.42s990cleanup991kill QemuMachine (pid 45)992machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)993machine # [2026-09-23T03:00:30Z INFO virtiofsd] Client disconnected, shutting down994machine # [2026-09-23T03:00:30Z INFO virtiofsd] Client disconnected, shutting down995machine # [2026-09-23T03:00:30Z INFO virtiofsd] Client disconnected, shutting down996(finished: cleanup, in 0.19 seconds)997additionally exposed symbols:998 common, machine, with_netbootxyz,999 vlan1,1000 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_ssh