vm-test-run-systemd-initrd-simple
checks.aarch64-linux.systemd-initrd-simple
· build #57
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 1.20 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7subtest: testing initrd backdoor8machine: waiting for unit initrd.target9machine: waiting for the VM to finish booting10machine: starting vm11machine # Disk image does not exist, creating the virtualisation disk image...12machine: QEMU running (pid 45)13machine # Formatting '/build/vm-state-machine/tmp.RajmmNqOAv', fmt=raw size=107374182414machine # mke2fs 1.47.4 (6-Mar-2025)15machine # Discarding device blocks: 0/262144 done16machine # Creating filesystem with 262144 4k blocks and 65536 inodes17machine # Filesystem UUID: ee1e8b72-05e1-4d58-a37b-7c6e2ff342b418machine # Superblock backups stored on blocks:19machine # 32768, 98304, 163840, 22937620machine # 21machine # Allocating group tables: 0/8 done22machine # Writing inode tables: 0/8 done23machine # Creating journal (8192 blocks): done24machine # Writing superblocks and filesystem accounting information: 0/8 done25machine # 26machine # Virtualisation disk image created.27machine # Starting virtiofs daemons...28machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-10-15T02:55:32Z INFO virtiofsd] Waiting for vhost-user socket connection...31machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)32machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether33machine # [2026-10-15T02:55:32Z INFO virtiofsd] Waiting for vhost-user socket connection...34machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35machine # [2026-10-15T02:55:32Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36machine # [2026-10-15T02:55:32Z INFO virtiofsd] Waiting for vhost-user socket connection...37machine # [2026-10-15T02:55:32Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-10-15T02:55:32Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-10-15T02:55:32Z INFO virtiofsd] Client connected, servicing requests40machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]41machine # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 202642machine # [ 0.000000] KASLR enabled43machine # [ 0.000000] random: crng init done44machine # [ 0.000000] Machine model: linux,dummy-virt45machine # [ 0.000000] efi: UEFI not found.46machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT47machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]48machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]49machine # [ 0.000000] Zone ranges:50machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]51machine # [ 0.000000] DMA32 empty52machine # [ 0.000000] Normal empty53machine # [ 0.000000] Device empty54machine # [ 0.000000] Movable zone start for each node55machine # [ 0.000000] Early memory node ranges56machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]58machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000059machine # [ 0.000000] psci: probing for conduit method from DT.60machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.61machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs62machine # [ 0.000000] psci: Trusted OS migration not required63machine # [ 0.000000] psci: SMC Calling Convention v1.164machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)65machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u31129666machine # [ 0.000000] Detected PIPT I-cache on CPU067machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)68machine # [ 0.000000] CPU features: detected: GICv3 CPU interface69machine # [ 0.000000] CPU features: detected: Spectre-v470machine # [ 0.000000] CPU features: detected: Spectre-BHB71machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3872machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2373machine # [ 0.000000] alternatives: applying boot alternatives74machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/gxlljyaid42bg28sszbxn94mnbx7s8xj-nixos-system-machine-test/init regInfo=/nix/.ro-store/jma8qm8xky5kbn1gihrazxrc56qw0l0y-closure-info/registration console=ttyAMA0,115200n8 console=tty075machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jma8qm8xky5kbn1gihrazxrc56qw0l0y-closure-info/registration", will be passed to user space.76machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes77machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)78machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)79machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB80machine # [ 0.000000] software IO TLB: area num 1.81machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)82machine # [ 0.000000] Fallback order for Node 0: 083machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214484machine # [ 0.000000] Policy zone: DMA85machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off86machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=187machine # [ 0.000000] allocated 2097152 bytes of page_ext88machine # [ 0.000000] ftrace: allocating 75039 entries in 294 pages89machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups90machine # [ 0.000000] rcu: Hierarchical RCU implementation.91machine # [ 0.000000] rcu: RCU event tracing is enabled.92machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.93machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.94machine # [ 0.000000] Rude variant of Tasks RCU enabled.95machine # [ 0.000000] Tracing variant of Tasks RCU enabled.96machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.97machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=198machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.99machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.101machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0102machine # [ 0.000000] GICv3: 256 SPIs implemented103machine # [ 0.000000] GICv3: 0 Extended SPIs implemented104machine # [ 0.000000] Root IRQ handler: gic_handle_irq105machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI106machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0107machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000108machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]109machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)110machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)111machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000112machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000113machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.114machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns115machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).116machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns117machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns118machine # [ 0.000036] arm-pv: using stolen time PV119machine # [ 0.000400] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)120machine # [ 0.000588] Console: colour dummy device 80x25121machine # [ 0.000596] printk: legacy console [tty0] enabled122machine # [ 0.000795] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)123machine # [ 0.000802] pid_max: default: 32768 minimum: 301124machine # [ 0.000911] LSM: initializing lsm=capability,landlock,yama,bpf,ima125machine # [ 0.001140] landlock: Up and running.126machine # [ 0.001146] Yama: becoming mindful.127machine # [ 0.001806] LSM support for eBPF active128machine # [ 0.001982] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.002006] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)130machine # [ 0.005018] rcu: Hierarchical SRCU implementation.131machine # [ 0.005026] rcu: Max phase no-delay instances is 1000.132machine # [ 0.006488] fsl-mc MSI: its@8080000 domain created133machine # [ 0.006621] EFI services will not be available.134machine # [ 0.006724] smp: Bringing up secondary CPUs ...135machine # [ 0.006736] smp: Brought up 1 node, 1 CPU136machine # [ 0.006739] SMP: Total of 1 processors activated.137machine # [ 0.006742] CPU: All CPU(s) started at EL1138machine # [ 0.006754] CPU features: detected: Branch Target Identification139machine # [ 0.006764] CPU features: detected: ARMv8.4 Translation Table Level140machine # [ 0.006767] CPU features: detected: Instruction cache invalidation not required for I/D coherence141machine # [ 0.006771] CPU features: detected: Data cache clean to the PoU not required for I/D coherence142machine # [ 0.006775] CPU features: detected: Common not Private translations143machine # [ 0.006778] CPU features: detected: CRC32 instructions144machine # [ 0.006781] CPU features: detected: Data cache clean to Point of Deep Persistence145machine # [ 0.006784] CPU features: detected: Data cache clean to Point of Persistence146machine # [ 0.006787] CPU features: detected: Data independent timing control (DIT)147machine # [ 0.006790] CPU features: detected: E0PD148machine # [ 0.006792] CPU features: detected: Enhanced Counter Virtualization149machine # [ 0.006796] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)150machine # [ 0.006799] CPU features: detected: Enhanced Virtualization Traps151machine # [ 0.006802] CPU features: detected: Fine Grained Traps152machine # [ 0.006806] CPU features: detected: Generic authentication (architected QARMA5 algorithm)153machine # [ 0.006810] CPU features: detected: RCpc load-acquire (LDAPR)154machine # [ 0.006813] CPU features: detected: LSE atomic instructions155machine # [ 0.006816] CPU features: detected: Privileged Access Never156machine # [ 0.006819] CPU features: detected: PMUv3157machine # [ 0.006822] CPU features: detected: RAS Extension Support158machine # [ 0.006824] CPU features: detected: RASv1p1 Extension Support159machine # [ 0.006827] CPU features: detected: Random Number Generator160machine # [ 0.006829] CPU features: detected: Speculation barrier (SB)161machine # [ 0.006832] CPU features: detected: Stage-2 Force Write-Back162machine # [ 0.006835] CPU features: detected: TLB range maintenance instructions163machine # [ 0.006838] CPU features: detected: Speculative Store Bypassing Safe (SSBS)164machine # [ 0.006887] alternatives: applying system-wide alternatives165machine # [ 0.010203] CPU features: detected: BBM Level 2 without TLB conflict abort166machine # [ 0.010479] Memory: 892876K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 114392K reserved, 32768K cma-reserved)167machine # [ 0.011037] devtmpfs: initialized168machine # [ 0.021480] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)169machine # [ 0.021534] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).170machine # [ 0.021765] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL171machine # [ 0.021787] 0 pages in range for non-PLT usage172machine # [ 0.021788] 508192 pages in range for PLT usage173machine # [ 0.022028] pinctrl core: initialized pinctrl subsystem174machine # [ 0.023140] DMI not present or invalid.175machine # [ 0.028037] NET: Registered PF_NETLINK/PF_ROUTE protocol family176machine # [ 0.030927] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations177machine # [ 0.031107] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations178machine # [ 0.031299] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations179machine # [ 0.031344] audit: initializing netlink subsys (disabled)180machine # [ 0.032255] thermal_sys: Registered thermal governor 'fair_share'181machine # [ 0.032262] thermal_sys: Registered thermal governor 'bang_bang'182machine # [ 0.032268] thermal_sys: Registered thermal governor 'step_wise'183machine # [ 0.032271] thermal_sys: Registered thermal governor 'user_space'184machine # [ 0.032274] thermal_sys: Registered thermal governor 'power_allocator'185machine # [ 0.032319] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1186machine # [ 0.032330] cpuidle: using governor ladder187machine # [ 0.032337] cpuidle: using governor menu188machine # [ 0.032574] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.189machine # [ 0.032602] ASID allocator initialised with 65536 entries190machine # [ 0.034126] Serial: AMBA PL011 UART driver191machine # [ 0.040219] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1192machine # [ 0.040435] printk: console [ttyAMA0] enabled193machine # [ 0.170465] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages194machine # [ 0.170480] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page195machine # [ 0.170484] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages196machine # [ 0.170487] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page197machine # [ 0.170489] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages198machine # [ 0.170492] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page199machine # [ 0.170495] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages200machine # [ 0.170498] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page201machine # [ 0.172264] fbcon: Taking over console202machine # [ 0.172277] ACPI: Interpreter disabled.203machine # [ 0.190964] iommu: Default domain type: Translated204machine # [ 0.190980] iommu: DMA domain TLB invalidation policy: strict mode205machine # [ 0.191528] SCSI subsystem initialized206machine # [ 0.191820] usbcore: registered new interface driver usbfs207machine # [ 0.191850] usbcore: registered new interface driver hub208machine # [ 0.191866] usbcore: registered new device driver usb209machine # [ 0.192271] pps_core: LinuxPPS API ver. 1 registered210machine # [ 0.192277] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>211machine # [ 0.192286] PTP clock support registered212machine # [ 0.192335] EDAC MC: Ver: 3.0.0213machine # [ 0.192543] scmi_core: SCMI protocol bus registered214machine # [ 0.192983] FPGA manager framework215machine # [ 0.193721] vgaarb: loaded216machine # [ 0.194080] clocksource: Switched to clocksource arch_sys_counter217machine # [ 0.207291] VFS: Disk quotas dquot_6.6.0218machine # [ 0.207336] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)219machine # [ 0.210043] netfs: FS-Cache loaded220machine # [ 0.212155] pnp: PnP ACPI: disabled221machine # [ 0.217114] NET: Registered PF_INET protocol family222machine # [ 0.217314] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)223machine # [ 0.249990] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)224machine # [ 0.250040] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)225machine # [ 0.250067] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)226machine # [ 0.253481] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)227machine # [ 0.253565] TCP: Hash tables configured (established 8192 bind 8192)228machine # [ 0.253655] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)229machine # [ 0.253720] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)230machine # [ 0.253766] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)231machine # [ 0.253858] NET: Registered PF_UNIX/PF_LOCAL protocol family232machine # [ 0.253940] NET: Registered PF_XDP protocol family233machine # [ 0.253959] PCI: CLS 0 bytes, default 64234machine # [ 0.260481] Trying to unpack rootfs image as initramfs...235machine # [ 0.262893] kvm [1]: HYP mode not available236machine # [ 0.398784] Initialise system trusted keyrings237machine # [ 0.398949] workingset: timestamp_bits=42 max_order=18 bucket_order=0238machine # [ 0.399393] squashfs: version 4.0 (2009/01/31) Phillip Lougher239machine # [ 0.399464] 9p: Installing v9fs 9p2000 file system support240machine # [ 0.427876] Key type asymmetric registered241machine # [ 0.427901] Asymmetric key parser 'x509' registered242machine # [ 0.428247] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)243machine # [ 0.428425] io scheduler mq-deadline registered244machine # [ 0.428429] io scheduler kyber registered245machine # [ 0.454320] pl061_gpio 9030000.pl061: PL061 GPIO chip registered246machine # [ 0.458962] ledtrig-cpu: registered to indicate activity on CPUs247machine # [ 0.459551] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:248machine # [ 0.459570] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000249machine # [ 0.459582] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000250machine # [ 0.459588] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000251machine # [ 0.459609] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits252machine # [ 0.459638] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]253machine # [ 0.459730] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00254machine # [ 0.459738] pci_bus 0000:00: root bus resource [bus 00-ff]255machine # [ 0.459743] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]256machine # [ 0.459746] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]257machine # [ 0.459749] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]258machine # [ 0.459816] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint259machine # [ 0.460304] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint260machine # [ 0.460498] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]261machine # [ 0.460512] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]262machine # [ 0.460541] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]263machine # [ 0.460555] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]264machine # [ 0.461671] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint265machine # [ 0.461870] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]266machine # [ 0.461883] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]267machine # [ 0.461911] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]268machine # [ 0.490630] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint269machine # [ 0.490847] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]270machine # [ 0.490876] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]271machine # [ 0.490918] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]272machine # [ 0.491505] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint273machine # [ 0.491724] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]274machine # [ 0.491738] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]275machine # [ 0.491768] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]276machine # [ 0.491785] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]277machine # [ 0.492946] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint278machine # [ 0.493328] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]279machine # [ 0.493370] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]280machine # [ 0.495124] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint281machine # [ 0.495346] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]282machine # [ 0.495381] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283machine # [ 0.495974] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint284machine # [ 0.496177] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]285machine # [ 0.496498] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint286machine # [ 0.496704] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.496733] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.497261] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint289machine # [ 0.497471] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]290machine # [ 0.497518] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]291machine # [ 0.498022] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint292machine # [ 0.498285] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]293machine # [ 0.498313] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]294machine # [ 0.498848] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint295machine # [ 0.501433] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]296machine # [ 0.501459] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]297machine # [ 0.501490] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]298machine # [ 0.558343] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint299machine # [ 0.558573] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]300machine # [ 0.558589] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]301machine # [ 0.558619] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]302machine # [ 0.559492] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned303machine # [ 0.559500] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned304machine # [ 0.559504] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned305machine # [ 0.559553] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned306machine # [ 0.559601] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned307machine # [ 0.559648] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned308machine # [ 0.559696] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned309machine # [ 0.559744] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned310machine # [ 0.559792] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned311machine # [ 0.559840] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned312machine # [ 0.559888] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned313machine # [ 0.559935] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned314machine # [ 0.560104] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned315machine # [ 0.560150] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned316machine # [ 0.560169] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned317machine # [ 0.560189] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned318machine # [ 0.560209] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned319machine # [ 0.560228] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned320machine # [ 0.560248] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned321machine # [ 0.560267] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned322machine # [ 0.560288] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned323machine # [ 0.560308] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned324machine # [ 0.560333] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned325machine # [ 0.560354] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned326machine # [ 0.560375] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned327machine # [ 0.560395] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned328machine # [ 0.560415] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned329machine # [ 0.560434] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned330machine # [ 0.560458] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned331machine # [ 0.560478] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned332machine # [ 0.560498] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned333machine # [ 0.560525] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]334machine # [ 0.560531] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]335machine # [ 0.560534] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]336machine # [ 0.561504] pci 0000:00:07.0: enabling device (0000 -> 0002)337machine # [ 0.668835] pci 0000:00:07.0: quirk_usb_early_handoff+0x0/0xa60 took 104818 usecs338machine # [ 0.692654] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)339machine # [ 1.727874] Freeing initrd memory: 27148K340machine # [ 1.728547] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)341machine # [ 1.733096] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)342machine # [ 1.845530] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)343machine # [ 1.848697] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)344machine # [ 1.852078] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)345machine # [ 1.865665] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)346machine # [ 1.868563] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)347machine # [ 1.871412] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)348machine # [ 1.873629] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)349machine # [ 1.881594] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)350machine # [ 1.888581] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled351machine # [ 1.891529] msm_serial: driver initialized352machine # [ 1.891686] SuperH (H)SCI(F) driver initialized353machine # [ 1.891749] STM32 USART driver initialized354machine # [ 1.912243] loop: module loaded355machine # [ 1.912459] virtio_blk virtio2: 1/0/0 default/read/poll queues356machine # [ 1.913783] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)357machine # [ 1.919610] megasas: 07.734.00.00-rc1358machine # [ 1.920609] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]359machine # [ 1.924402] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000360machine # [ 1.924443] Intel/Sharp Extended Query Table at 0x0031361machine # [ 2.429451] Using buffer write method362machine # [ 2.429561] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]363machine # [ 2.433881] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000364machine # [ 2.433911] Intel/Sharp Extended Query Table at 0x0031365machine # [ 2.437632] Using buffer write method366machine # [ 2.437654] Concatenating MTD devices:367machine # [ 2.437656] (0): "0.flash"368machine # [ 2.437659] (1): "0.flash"369machine # [ 2.437670] into device "0.flash"370machine # [ 2.449403] tun: Universal TUN/TAP device driver, 1.6371machine # [ 2.456109] thunder_xcv, ver 1.0372machine # [ 2.456138] thunder_bgx, ver 1.0373machine # [ 2.456163] nicpf, ver 1.0374machine # [ 2.456765] e1000: Intel(R) PRO/1000 Network Driver375machine # [ 2.456769] e1000: Copyright (c) 1999-2006 Intel Corporation.376machine # [ 2.456796] e1000e: Intel(R) PRO/1000 Network Driver377machine # [ 2.456803] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.378machine # [ 2.456827] igb: Intel(R) Gigabit Ethernet Network Driver379machine # [ 2.456831] igb: Copyright (c) 2007-2014 Intel Corporation.380machine # [ 2.456851] igbvf: Intel(R) Gigabit Virtual Function Network Driver381machine # [ 2.456855] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.382machine # [ 2.456998] sky2: driver version 1.30383machine # [ 2.466662] usbcore: registered new interface driver usb-storage384machine # [ 2.466846] usbcore: registered new interface driver usbserial_generic385machine # [ 2.466858] usbserial: USB Serial support registered for generic386machine # [ 2.467522] hv_vmbus: registering driver hyperv_keyboard387machine # [ 2.468929] ehci-pci 0000:00:07.0: EHCI Host Controller388machine # [ 2.468963] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1389machine # [ 2.469378] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000390machine # [ 2.469780] rtc-pl031 9010000.pl031: registered as rtc0391machine # [ 2.469817] rtc-pl031 9010000.pl031: setting system clock to 2026-10-15T02:55:39 UTC (1792032939)392machine # [ 2.477681] i2c_dev: i2c /dev entries driver393machine # [ 2.478118] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00394machine # [ 2.478514] hub 1-0:1.0: USB hub found395machine # [ 2.478532] hub 1-0:1.0: 6 ports detected396machine # [ 2.485473] sdhci: Secure Digital Host Controller Interface driver397machine # [ 2.485482] sdhci: Copyright(c) Pierre Ossman398machine # [ 2.485796] Synopsys Designware Multimedia Card Interface Driver399machine # [ 2.488434] sdhci-pltfm: SDHCI platform and OF driver helper400machine # [ 2.490953] hid: raw HID events driver (C) Jiri Kosina401machine # [ 2.491356] usbcore: registered new interface driver usbhid402machine # [ 2.491363] usbhid: USB HID core driver403machine # [ 2.492815] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available404machine # [ 2.497861] drop_monitor: Initializing network drop monitor service405machine # [ 2.498966] NET: Registered PF_INET6 protocol family406machine # [ 2.499649] Segment Routing with IPv6407machine # [ 2.499661] In-situ OAM (IOAM) with IPv6408machine # [ 2.499692] NET: Registered PF_PACKET protocol family409machine # [ 2.499748] 9pnet: Installing 9P2000 support410machine # [ 2.499802] Key type dns_resolver registered411machine # [ 2.510324] registered taskstats version 1412machine # [ 2.510561] Loading compiled-in X.509 certificates413machine # [ 2.520373] Demotion targets for Node 0: null414machine # [ 2.520510] Key type .fscrypt registered415machine # [ 2.520516] Key type fscrypt-provisioning registered416machine # [ 2.520637] ima: No TPM chip found, activating TPM-bypass!417machine # [ 2.520672] ima: Allocated hash algorithm: sha1418machine # [ 2.520713] ima: No architecture policies found419machine # [ 2.521502] input: gpio-keys as /devices/platform/gpio-keys/input/input0420machine # [ 2.548369] clk: Disabling unused clocks421machine # [ 2.548393] PM: genpd: Disabling unused power domains422machine # [ 2.554979] Freeing unused kernel memory: 4736K423machine # [ 2.555184] Run /init as init process424machine # [ 2.573662] systemd[1]: Successfully made /usr/ read-only.425machine # [ 2.575037] systemd[1]: systemd 263-7f073ff 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 +EXPERIMENTAL-ENVVAR)426machine # [ 2.575053] systemd[1]: Detected virtualization qemu.427machine # [ 2.575077] systemd[1]: Detected architecture arm64.428machine # [ 2.575083] systemd[1]: Running in initrd.429machine # [ 2.575419] systemd[1]: Initializing machine ID from random generator.430machine # [ 2.575543] systemd[1]: Hostname set to <machine>.431machine # [ 2.684860] systemd[1]: bpf-restrict-fs: LSM BPF program attached432machine # [ 2.730281] usb 1-1: new high-speed USB device number 2 using ehci-pci433machine # [ 2.749596] systemd[1]: Queued start job for default target Initrd Default Target.434machine # [ 2.760766] systemd[1]: Created slice Slice /system/modprobe.435machine # [ 2.760986] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.436machine # [ 2.761011] systemd[1]: Expecting device /dev/disk/by-label/nixos...437machine # [ 2.761020] systemd[1]: Expecting device /dev/hvc0...438machine # [ 2.761030] systemd[1]: Expecting device /dev/ttyAMA0...439machine # [ 2.761051] systemd[1]: Reached target Path Units.440machine # [ 2.761063] systemd[1]: Reached target Slice Units.441machine # [ 2.761077] systemd[1]: Reached target Swaps.442machine # [ 2.761090] systemd[1]: Reached target Timer Units.443machine # [ 2.761394] systemd[1]: Listening on D-Bus System Message Bus Socket.444machine # [ 2.761529] systemd[1]: Listening on Journal Socket (/dev/log).445machine # [ 2.761643] systemd[1]: Listening on Journal Sockets.446machine # [ 2.761715] systemd[1]: Listening on udev Kernel Socket.447machine # [ 2.761728] systemd[1]: Reached target Socket Units.448machine # [ 2.773577] systemd[1]: Starting Create List of Static Device Nodes...449machine # [ 2.773647] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs450machine # [ 2.779717] systemd[1]: Mounting Kernel Configuration File System...451machine # [ 2.793697] systemd[1]: Starting Journal Service...452machine # [ 2.806357] systemd[1]: Starting Load Kernel Modules...453machine # [ 2.806492] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os454machine # [ 2.823456] systemd[1]: Starting Coldplug All udev Devices...455machine # [ 2.854506] systemd[1]: Finished Create List of Static Device Nodes.456machine # [ 2.865973] systemd-journald[70]: Collecting audit messages is disabled.457machine # [ 2.872355] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.458machine # [ 2.878445] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...459machine # [ 2.887111] systemd[1]: Mounted Kernel Configuration File System.460machine # [ 2.887311] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev461machine # [ 2.889851] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1462machine # [ 2.908336] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0463machine # [ 2.908610] [drm] features: -virgl +edid -resource_blob -host_visible464machine # [ 2.908613] [drm] features: -context_init465machine # [ 2.909559] [drm] number of scanouts: 1466machine # [ 2.909570] [drm] number of cap sets: 0467machine # [ 2.930558] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic468machine # [ 2.930577] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0469machine # [ 2.958897] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.470machine # [ 2.966535] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0471machine # [ 2.967199] systemd[1]: Starting Create Static Device Nodes in /dev...472machine # [ 2.974548] Console: switching to colour frame buffer device 160x50473machine # [ 2.994751] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device474machine # [ 3.006779] systemd[1]: Finished Load Kernel Modules.475machine # [ 3.015116] systemd[1]: Starting Apply Kernel Variables...476machine # [ 3.054932] systemd[1]: Finished Create Static Device Nodes in /dev.477machine # [ 3.055198] systemd[1]: Reached target Preparation for Local File Systems.478machine # [ 3.055230] systemd[1]: Reached target Local File Systems.479machine # [ 3.057238] systemd[1]: Starting Rule-based Manager for Device Events and Files...480machine # [ 3.050576] systemd-modules-load[71]: Inserted module 'dm_mod'481machine # [ 3.056206] systemd-modules-load[71]: Module 'virtio_balloon' is built in482machine # [ 3.061605] systemd-modules-load[71]: Module 'virtio_console' is built in483machine # [ 3.082637] systemd[1]: Started Journal Service.484machine # [ 3.087166] usb 1-2: new high-speed USB device number 3 using ehci-pci485machine # [ 3.068454] systemd-modules-load[71]: Inserted module 'virtio_gpu'486machine # [ 3.077951] systemd-modules-load[71]: Module 'virtio_rng' is built in487machine # [ 3.082126] systemd[1]: Finished Apply Kernel Variables.488machine # [ 3.100134] systemd[1]: Starting Create System Files and Directories...489machine # [ 3.142594] systemd-udevd[79]: Using default interface naming scheme 'v261'.490machine # [ 3.166450] systemd[1]: Finished Create System Files and Directories.491machine # [ 3.190501] systemd[1]: Started Rule-based Manager for Device Events and Files.492machine # [ 3.248149] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2493machine # [ 3.248440] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0494machine # [ 3.312172] systemd[1]: Starting Virtual Console Setup...495machine # [ 3.401548] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.496machine # [ 3.405408] systemd[1]: Finished Virtual Console Setup.497machine # [ 4.214144] systemd[1]: Found device /dev/hvc0.498machine # [ 4.284502] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.499machine # [ 4.315203] systemd[1]: Finished Coldplug All udev Devices.500machine # [ 4.316311] systemd[1]: Reached target System Initialization.501machine # [ 4.317215] systemd[1]: Reached target Basic System.502machine # [ 4.321522] systemd[1]: Found device /dev/ttyAMA0.503machine # [ 4.325923] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.504machine # [ 4.332269] systemd[1]: Started backdoor.service.505machine # [ 4.361281] backdoor-start[110]: /nix/store/13csj3ip6wj2nbam4hrzfp742n5g4yal-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found506machine # connecting to host...507machine: Guest shell says: b'Spawning backdoor root shell...\n'508machine: connected to guest root shell509machine: (connecting took 4.58 seconds)510machine: (finished: waiting for the VM to finish booting, in 9.59 seconds)511machine # [ 4.394219] systemd[1]: Found device /dev/disk/by-label/nixos.512machine # [ 4.399912] systemd[1]: Reached target Initrd Root Device.513machine # [ 4.415571] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...514machine # [ 4.499881] systemd-fsck[124]: nixos: clean, 12/65536 files, 13019/262144 blocks515machine # [ 4.508237] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.516machine # [ 4.516349] systemd[1]: Mounting /sysroot...517machine # [ 4.597917] EXT4-fs (vda): mounted filesystem ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4 r/w with ordered data mode. Quota mode: none.518machine # [ 4.581396] systemd[1]: Mounted /sysroot.519machine # [ 4.585134] systemd[1]: Reached target Initrd Root File System.520machine # [ 4.592180] systemd[1]: Mounting /sysroot/nix/.ro-store...521machine # [ 4.603115] systemd[1]: Mounting /sysroot/nix/.rw-store...522machine # [ 4.620293] systemd[1]: Mounting /sysroot/run...523machine # [ 4.638582] systemd[1]: Mounting /sysroot/tmp/shared...524machine # [ 4.677674] systemd[1]: Mounting /sysroot/tmp/xchg...525machine # [ 4.692144] systemd[1]: Starting Mountpoints Configured in the Real Root...526machine # [ 4.725908] systemd[1]: Mounted /sysroot/run.527machine # [ 4.781503] fuse: init (API version 7.45)528machine # [ 4.800055] virtiofs virtio6: discovered new tag: nix-store529machine # [ 4.800911] virtiofs virtio6: virtio_fs_setup_dax: No cache capability530machine # [ 4.792212] systemd[1]: Mounted /sysroot/nix/.rw-store.531machine # [ 4.825129] virtiofs virtio7: discovered new tag: shared532machine # [ 4.817140] systemd-sysroot-fstab-check[137]: /sysroot should be mounted in the initrd, will request daemon-reload.533machine # [ 4.838683] virtiofs virtio7: virtio_fs_setup_dax: No cache capability534machine # [ 4.845785] virtiofs virtio8: discovered new tag: xchg535machine # [ 4.829095] systemd[1]: Starting rw-sysroot-nix-store.service...536machine # [ 4.850878] virtiofs virtio8: virtio_fs_setup_dax: No cache capability537machine # [ 4.860284] systemd[1]: Mounted /sysroot/nix/.ro-store.538machine # [ 4.861339] systemd[1]: Mounted /sysroot/tmp/shared.539machine # [ 4.862063] systemd[1]: Mounted /sysroot/tmp/xchg.540machine # [ 4.862760] systemd[1]: Reload requested from client PID 137 ('systemd-sysroot') (unit initrd-parse-etc.service)...541machine # [ 4.871786] systemd[1]: Reloading...542machine # [ 5.132210] systemd[1]: Reloading finished in 271 ms.543machine # [ 5.174240] systemd-sysroot-fstab-check[137]: Requesting initrd-fs.target/start/replace...544machine # [ 5.187824] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.545machine # [ 5.189151] systemd[1]: Finished rw-sysroot-nix-store.service.546machine # [ 5.190003] systemd-sysroot-fstab-check[137]: Requesting swap.target/start/replace...547machine # [ 5.198004] systemd[1]: initrd-parse-etc.service: Deactivated successfully.548machine # [ 5.223392] systemd[1]: Finished Mountpoints Configured in the Real Root.549machine # [ 5.249088] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.550machine # [ 5.298769] systemd[1]: Starting rw-sysroot-nix-store.service...551machine # [ 5.361678] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.552machine # [ 5.368443] systemd[1]: Finished rw-sysroot-nix-store.service.553machine # [ 5.379893] systemd[1]: Mounting /sysroot/nix/store...554machine # [ 5.442527] systemd[1]: Mounted /sysroot/nix/store.555machine # [ 5.443513] systemd[1]: Reached target Initrd File Systems.556machine # [ 5.446656] systemd[1]: Starting Find NixOS closure...557machine # [ 5.464336] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...558machine # [ 5.521480] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.559machine # [ 5.544141] systemd[1]: Finished Find NixOS closure.560machine # [ 5.548996] systemd[1]: Reached target Initrd Default Target.561machine # [ 5.564261] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...562machine # [ 5.603110] systemd[1]: initrd-cleanup.service: Deactivated successfully.563machine # [ 5.606306] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.564machine # [ 5.609282] systemd[1]: Startup finished in 2.539s (kernel) + 0 (initrd) + 3.069s (userspace) = 5.608s.565machine # [ 6.335320] (udev-worker)[200]: mtd0ro: Failed to find and pin callout binary "/nix/store/zb1l01zaw0xw40lqcnwmap98xi9szh56-systemd-263-7f073ff/lib/udev/mtd_probe": No such file or directory566machine # [ 6.339074] (udev-worker)[200]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory567machine # [ 6.379894] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.568machine # [ 6.381921] systemd[1]: Stopped Virtual Console Setup.569machine # [ 6.382696] systemd[1]: Stopping Virtual Console Setup...570machine # [ 6.388147] systemd[1]: Starting Virtual Console Setup...571machine # [ 6.405002] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.572machine # [ 6.407993] systemd[1]: Stopped Virtual Console Setup.573machine # [ 6.409357] systemd[1]: Starting Virtual Console Setup...574machine # [ 6.436820] systemd-vconsole-setup[207]: Configuration of first virtual console was skipped, ignoring remaining ones.575machine # [ 6.442127] systemd[1]: Finished Virtual Console Setup.576machine # [ 6.442994] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.577machine: (finished: waiting for unit initrd.target, in 11.83 seconds)578machine: must succeed: systemctl status initrd-fs.target579machine: (finished: must succeed: systemctl status initrd-fs.target, in 0.02 seconds)580machine: waiting for unit initrd.target581machine: (finished: waiting for unit initrd.target, in 0.02 seconds)582machine: waiting for the VM to finish booting583machine # [ 6.684974] systemd[1]: Stopped target Initrd Default Target.584machine # [ 6.688378] systemd[1]: Stopped target Basic System.585machine # [ 6.689384] systemd[1]: Stopped target Initrd Root Device.586machine # [ 6.690366] systemd[1]: Stopped target Path Units.587machine # [ 6.691249] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.588machine # [ 6.698206] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.589machine # [ 6.701585] systemd[1]: Stopped target Slice Units.590machine # [ 6.704229] systemd[1]: Stopped target Socket Units.591machine # [ 6.705159] systemd[1]: Stopped target System Initialization.592machine # [ 6.708277] systemd[1]: Stopped target Swaps.593machine # [ 6.709092] systemd[1]: Stopped target Timer Units.594machine # [ 6.710864] systemd[1]: dbus.socket: Deactivated successfully.595machine # [ 6.716188] systemd[1]: Closed D-Bus System Message Bus Socket.596machine # [ 6.717940] systemd[1]: Stopping backdoor.service...597machine # [ 6.719935] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...598machine # [ 6.724217] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.599machine # [ 6.728716] systemd[1]: Stopped Find NixOS closure.600machine # [ 6.730220] systemd[1]: Starting rw-sysroot-nix-store.service...601machine # [ 6.735243] systemd[1]: systemd-sysctl.service: Deactivated successfully.602machine # [ 6.736630] systemd[1]: Stopped Apply Kernel Variables.603machine # [ 6.737447] systemd[1]: systemd-modules-load.service: Deactivated successfully.604machine # [ 6.741721] systemd[1]: Stopped Load Kernel Modules.605machine # [ 6.743595] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.606machine # [ 6.753658] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.607machine # [ 6.755035] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.608machine # [ 6.761812] systemd[1]: Stopped Create System Files and Directories.609machine # [ 6.762822] systemd[1]: Stopped target Local File Systems.610machine # [ 6.763713] systemd[1]: Stopped target Preparation for Local File Systems.611machine # [ 6.773781] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.612machine # [ 6.776408] systemd[1]: Stopped Coldplug All udev Devices.613machine # [ 6.777391] systemd[1]: Stopping Rule-based Manager for Device Events and Files...614machine # [ 6.779626] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.615machine # [ 6.782709] systemd[1]: Stopped Virtual Console Setup.616machine # [ 6.784459] systemd[1]: backdoor.service: Deactivated successfully.617machine # [ 6.785638] systemd[1]: Stopped backdoor.service.618machine # [ 6.786488] systemd[1]: systemd-udevd.service: Deactivated successfully.619machine # [ 6.787518] systemd[1]: Stopped Rule-based Manager for Device Events and Files.620machine # [ 6.788802] systemd[1]: systemd-udevd.service: Consumed 1.703s CPU time over 3.717s wall clock time, 30.4M memory peak.621machine # [ 6.790275] systemd[1]: Starting Cleanup udev Database...622machine # [ 6.791094] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.623machine # [ 6.796374] systemd[1]: Stopped Create Static Device Nodes in /dev.624machine # [ 6.797393] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.625machine # [ 6.804501] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.626machine # [ 6.805706] systemd[1]: kmod-static-nodes.service: Deactivated successfully.627machine # [ 6.806739] systemd[1]: Stopped Create List of Static Device Nodes.628machine # [ 6.807674] systemd[1]: initrd-cleanup.service: Deactivated successfully.629machine # [ 6.812220] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.630machine # [ 6.813202] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.631machine # [ 6.814242] systemd[1]: Finished rw-sysroot-nix-store.service.632machine # [ 6.845534] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.633machine # [ 6.848585] systemd[1]: Finished Cleanup udev Database.634machine # [ 6.850357] systemd[1]: Reached target Switch Root.635machine # [ 6.851826] systemd[1]: Starting NixOS Activation...636machine # [ 6.945452] initrd-nixos-activation-start[235]: booting system configuration /nix/store/gxlljyaid42bg28sszbxn94mnbx7s8xj-nixos-system-machine-test637machine # [ 6.979720] initrd-nixos-activation-start[235]: running activation script...638machine # [ 7.231175] initrd-nixos-activation-start[258]: setting up /etc...639machine # [ 7.355741] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.640machine # [ 7.359197] systemd[1]: Finished NixOS Activation.641machine # [ 7.360580] systemd[1]: Starting Switch Root...642machine # [ 7.386414] systemd[1]: Switching root.643machine # [ 7.568298] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).644machine # [ 7.728677] systemd[1]: systemd 263-7f073ff 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 +EXPERIMENTAL-ENVVAR)645machine # [ 7.729668] systemd[1]: Detected virtualization qemu.646machine # [ 7.729725] systemd[1]: Detected architecture arm64.647machine # [ 7.739523] systemd[1]: Detected first boot.648machine # [ 7.743227] systemd[1]: Initializing machine ID from random generator.649machine # [ 7.870835] systemd[1]: bpf-restrict-fs: LSM BPF program attached650machine # [ 8.024288] systemd[1]: Applying preset policy.651machine # [ 8.235646] systemd[1]: Populated /etc with preset unit settings.652machine # [ 8.436466] systemd[1]: initrd-switch-root.service: Deactivated successfully.653machine # [ 8.437336] systemd[1]: Stopped initrd-switch-root.service.654machine # [ 8.442928] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.655machine # [ 8.444528] systemd[1]: Created slice Slice /system/getty.656machine # [ 8.445726] systemd[1]: Created slice User and Session Slice.657machine # [ 8.449873] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.658machine # [ 8.452498] systemd[1]: Started Forward Password Requests to Wall Directory Watch.659machine # [ 8.452948] systemd[1]: Expecting device /dev/hvc0...660machine # [ 8.453728] systemd[1]: Expecting device /dev/ttyAMA0...661machine # [ 8.457437] systemd[1]: Reached target Local Encrypted Volumes.662machine # [ 8.457905] systemd[1]: Stopped target initrd-fs.target.663machine # [ 8.460723] systemd[1]: Stopped target initrd-root-fs.target.664machine # [ 8.461161] systemd[1]: Stopped target initrd-switch-root.target.665machine # [ 8.461886] systemd[1]: Reached target Virtual Machines and Containers.666machine # [ 8.465581] systemd[1]: Reached target Path Units.667machine # [ 8.466010] systemd[1]: Reached target Remote File Systems.668machine # [ 8.468753] systemd[1]: Reached target Slice Units.669machine # [ 8.469260] systemd[1]: Reached target Swaps.670machine # [ 8.473034] systemd[1]: Listening on Query the User Interactively for a Password.671machine # [ 8.476082] systemd[1]: Listening on Process Core Dump Socket.672machine # [ 8.477457] systemd[1]: Listening on Credential Encryption/Decryption.673machine # [ 8.480885] systemd[1]: Listening on Factory Reset Management.674machine # [ 8.481445] systemd[1]: Listening on Hostname Service Socket.675machine # [ 8.486992] systemd[1]: Starting Journal Log Access Socket...676machine # [ 8.488716] systemd[1]: Listening on Journal Audit Socket.677machine # [ 8.492607] systemd[1]: Listening on Console Output Muting Service Socket.678machine # [ 8.493462] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.679machine # [ 8.493991] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os680machine # [ 8.497916] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki681machine # [ 8.505664] systemd[1]: Listening on Disk Repartitioning Service Socket.682machine # [ 8.508066] systemd[1]: Listening on udev Varlink Socket.683machine # [ 8.511754] systemd[1]: Mounting Huge Pages File System...684machine # [ 8.516398] systemd[1]: Mounting POSIX Message Queue File System...685machine # [ 8.530914] systemd[1]: Mounting Kernel Debug File System...686machine # [ 8.540129] systemd[1]: Mounting Kernel Trace File System...687machine # [ 8.560229] systemd[1]: Starting Create List of Static Device Nodes...688machine # [ 8.563347] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs689machine # [ 8.579777] systemd[1]: Mounting Kernel Configuration File System...690machine # [ 8.583607] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm691machine # [ 8.588764] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore692machine # [ 8.594354] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse693machine # [ 8.616701] systemd[1]: Mounting FUSE Control File System...694machine # [ 8.620698] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67695machine # [ 8.666814] systemd[1]: Starting Journal Service...696machine # [ 8.686592] systemd[1]: Starting Load Kernel Modules...697machine # [ 8.711091] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...698machine # [ 8.722463] systemd[1]: Starting Remount Root and Kernel File Systems...699machine # [ 8.726506] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os700machine # [ 8.749352] systemd-journald[329]: Collecting audit messages is enabled.701machine # [ 8.773240] systemd[1]: Starting Coldplug All udev Devices...702machine # [ 8.752616] systemd[1]: Queued start job for default target Multi-User System.703machine # [ 8.755858] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.704machine # [ 8.781875] systemd[1]: Started Journal Service.705machine # [ 8.762363] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.706machine # [ 8.772507] systemd[1]: systemd-journald.service: Deactivated successfully.707machine # [ 8.782009] systemd[1]: Listening on Journal Log Access Socket.708machine # [ 8.783130] systemd[1]: Mounted Huge Pages File System.709machine # [ 8.783946] systemd[1]: Mounted POSIX Message Queue File System.710machine # [ 8.792318] systemd[1]: Mounted Kernel Debug File System.711machine # [ 8.793179] systemd[1]: Mounted Kernel Trace File System.712machine # [ 8.793974] systemd[1]: Finished Create List of Static Device Nodes.713machine # [ 8.805402] systemd[1]: Mounted Kernel Configuration File System.714machine # [ 8.830197] systemd-modules-load[330]: Module 'atkbd' is built in715machine # [ 8.850316] EXT4-fs (vda): re-mounted ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4.716machine # [ 8.834602] systemd-modules-load[330]: Module 'loop' is built in717machine # [ 8.844212] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...718machine # [ 8.847780] systemd[1]: Finished Load Kernel Modules.719machine # [ 8.856259] systemd[1]: Finished Remount Root and Kernel File Systems.720machine # [ 8.857515] systemd[1]: Listening on Disk Image Download Service Socket.721machine # [ 8.876277] systemd-oomd[332]: No swap; memory pressure usage will be degraded722machine # [ 8.880516] systemd[1]: Starting Firewall...723machine # [ 8.898076] systemd[1]: Starting Grow Root File System...724machine # [ 8.907274] systemd[1]: Starting Flush Journal to Persistent Storage...725machine # [ 8.908580] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore726machine # [ 8.924564] systemd[1]: Starting Load/Save OS Random Seed...727machine # [ 8.954887] systemd[1]: Starting Apply Kernel Variables...728machine # [ 8.955916] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os729machine # [ 8.964433] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.730machine # [ 8.978845] systemd[1]: Mounted FUSE Control File System.731machine # [ 9.057474] EXT4-fs (vda): resizing filesystem from 262144 to 262144 blocks732machine # [ 9.060102] systemd-growfs[347]: Successfully resized "/" to 1G bytes.733machine # [ 9.071490] systemd[1]: Finished Grow Root File System.734machine # [ 9.107847] systemd-journald[329]: Received client request to flush runtime journal.735machine # [ 9.153888] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.736machine # [ 9.155107] systemd[1]: Starting Create Static Device Nodes in /dev...737machine # [ 9.168993] systemd[1]: Finished Load/Save OS Random Seed.738machine # [ 9.175578] systemd[1]: Reached target First Boot Complete.739machine # [ 9.181229] systemd[1]: Finished Flush Journal to Persistent Storage.740machine # [ 9.217030] systemd[1]: Finished Apply Kernel Variables.741machine # [ 9.310531] systemd[1]: Finished Create Static Device Nodes in /dev.742machine # [ 9.311753] systemd[1]: Reached target Preparation for Local File Systems.743machine # [ 9.317994] systemd[1]: Starting Rule-based Manager for Device Events and Files...744machine # [ 9.425402] systemd[1]: Mounting /run/wrappers...745machine # [ 9.481852] systemd-udevd[369]: Using default interface naming scheme 'v261'.746machine # [ 9.490254] systemd[1]: Mounted /run/wrappers.747machine # [ 9.491241] systemd[1]: Reached target Local File Systems.748machine # [ 9.502288] systemd[1]: Listening on Boot Loader Control Service Socket.749machine # [ 9.505808] systemd[1]: Starting Create SUID/SGID Wrappers...750machine # [ 9.506779] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.751machine # [ 9.518207] systemd[1]: Starting Save Transient machine-id to Disk...752machine # [ 9.519227] systemd[1]: Starting Create System Files and Directories...753machine # [ 9.677542] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.754machine # [ 9.693273] systemd[1]: Finished Save Transient machine-id to Disk.755machine # [ 9.701859] systemd[1]: Started Rule-based Manager for Device Events and Files.756machine # [ 9.752991] systemd[1]: Finished Create System Files and Directories.757machine # [ 9.773084] systemd[1]: Starting Rebuild Journal Catalog...758machine # [ 9.788298] systemd[1]: Starting Record System Boot/Shutdown in UTMP...759machine # [ 9.925315] systemd[1]: Finished Record System Boot/Shutdown in UTMP.760machine # [ 9.935821] systemd[1]: Finished Rebuild Journal Catalog.761machine # [ 9.945660] systemd[1]: Starting Update is Completed...762machine # [ 10.025627] systemd[1]: Finished Update is Completed.763machine # [ 10.386865] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs764machine # [ 10.441041] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse765machine # [ 10.532984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.766machine # [ 10.536077] systemd[1]: Finished Create SUID/SGID Wrappers.767machine # [ 10.719587] systemd[1]: Found device /dev/hvc0.768machine # [ 10.761219] systemd[1]: Finished Coldplug All udev Devices.769machine # [ 10.764904] systemd[1]: Reached target System Initialization.770machine # [ 10.765926] systemd[1]: Started Discard unused filesystem blocks once a week.771machine # [ 10.766987] systemd[1]: Started Daily Cleanup of Temporary Directories.772machine # [ 10.767992] systemd[1]: Reached target Timer Units.773machine # [ 10.777214] systemd[1]: Listening on D-Bus System Message Bus Socket.774machine # [ 10.778175] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.775machine # [ 10.779408] systemd[1]: Reached target Socket Units.776machine # [ 10.789438] systemd[1]: Reached target Basic System.777machine # [ 10.790274] systemd[1]: Starting Import lastlog data into lastlog2 database...778machine # [ 10.791341] systemd[1]: Starting Name Service Cache Daemon (nsncd)...779machine # [ 10.801197] systemd[1]: Starting Post-Boot Actions...780machine # [ 10.816982] systemd[1]: Started Reset console on configuration changes.781machine # [ 10.866121] systemd[1]: Starting resolvconf update...782machine # [ 10.867139] systemd[1]: Found device /dev/ttyAMA0.783machine # [ 10.913653] systemd[1]: Started backdoor.service.784machine # [ 10.955136] systemd[1]: Starting D-Bus System Message Bus...785machine # [ 11.015927] systemd[1]: Started Name Service Cache Daemon (nsncd).786machine # [ 11.027329] systemd[1]: Reached target Host and Network Name Lookups.787machine # [ 11.035500] nsncd[505]: Oct 15 02:55:48.071 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"788machine # [ 11.050117] systemd[1]: Reached target User and Group Name Lookups.789machine # [ 11.110090] systemd[1]: Starting User Login Management...790machine # [ 11.124920] systemd[1]: Finished Post-Boot Actions.791machine # [ 11.184731] (udev-worker)[476]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.792machine # connecting to host...793machine # [ 11.231957] (udev-worker)[476]: Network interface NamePolicy= disabled on kernel command line.794machine # [ 11.240612] systemd[1]: Finished Import lastlog data into lastlog2 database.795machine # [ 11.269413] dbus-broker-launch[514]: Looking up NSS user entry for 'systemd-timesync'...796machine # [ 11.281422] dbus-broker-launch[514]: NSS returned no entry for 'systemd-timesync'797machine # [ 11.282609] dbus-broker-launch[514]: Invalid user-name in /nix/store/10ndnr17zcaw1kn44jrabk4ak1sdx8cn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"798machine: Guest shell says: b'Spawning backdoor root shell...\n'799machine: connected to guest root shell800machine: (connecting took 4.64 seconds)801machine: (finished: waiting for the VM to finish booting, in 4.64 seconds)802(finished: subtest: testing initrd backdoor, in 16.51 seconds)803subtest: handover to stage-2 systemd works804machine: waiting for unit multi-user.target805machine # [ 11.324175] systemd[1]: Started D-Bus System Message Bus.806machine # [ 11.390869] dbus-broker-launch[514]: Ready807machine # [ 11.457759] systemd-logind[532]: New seat seat0.808machine # [ 11.553147] systemd[1]: Started User Login Management.809machine # [ 11.578813] systemd[1]: Stopped target Host and Network Name Lookups.810machine # [ 11.590936] systemd[1]: Stopping Host and Network Name Lookups...811machine # [ 11.594348] systemd[1]: Stopped target User and Group Name Lookups.812machine # [ 11.595346] systemd[1]: Stopping User and Group Name Lookups...813machine # [ 11.607365] systemd[1]: Starting linger-users.service...814machine # [ 11.613573] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...815machine # [ 11.637358] systemd[1]: nscd.service: Deactivated successfully.816machine # [ 11.654704] systemd[1]: Stopped Name Service Cache Daemon (nsncd).817machine # [ 11.734509] systemd[1]: Starting Name Service Cache Daemon (nsncd)...818machine # [ 11.738937] systemd[1]: linger-users.service: Deactivated successfully.819machine # [ 11.745448] systemd[1]: Finished linger-users.service.820machine # [ 11.780519] systemd[1]: Finished Firewall.821machine # [ 11.817695] systemd[1]: Condition check resulted in Virtio network device being skipped.822machine # [ 11.821752] systemd[1]: Condition check resulted in Virtio network device being skipped.823machine # [ 11.829374] systemd[1]: Finished resolvconf update.824machine # [ 11.830223] systemd[1]: Reached target Preparation for Network.825machine # [ 11.837921] systemd[1]: Starting DHCP Client...826machine # [ 11.847668] systemd[1]: Starting Address configuration of eth1...827machine # [ 11.850749] nsncd[631]: Oct 15 02:55:48.899 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"828machine # [ 11.869679] systemd-logind[532]: Watching system buttons on /dev/input/event0 (gpio-keys)829machine # [ 11.881946] systemd[1]: Starting Extra networking commands....830machine # [ 11.888446] systemd[1]: Started Name Service Cache Daemon (nsncd).831machine # [ 11.892137] systemd[1]: Reached target Host and Network Name Lookups.832machine # [ 11.896303] systemd[1]: Reached target User and Group Name Lookups.833machine # [ 12.041789] network-addresses-eth1-start[644]: adding address 192.168.1.1/24... done834machine # [ 12.093922] network-addresses-eth1-start[644]: adding address 2001:db8:1::1/64... done835machine # [ 12.156738] systemd[1]: Finished Address configuration of eth1.836machine # [ 12.171409] dhcpcd[662]: dhcpcd-10.3.2 starting837machine # [ 12.181743] dhcpcd[703]: dev: loaded udev838machine # [ 12.234414] mousedev: PS/2 mouse device common for all mice839machine # [ 12.264924] 8021q: 802.1Q VLAN Support v1.8840machine # [ 12.265316] 8021q: adding VLAN 0 to HW filter on device eth1841machine # [ 12.272493] systemd[1]: Finished Extra networking commands..842machine # [ 12.274249] systemd[1]: Reached target Network.843machine # [ 12.281616] systemd[1]: Starting Permit User Sessions...844machine # [ 12.415178] cfg80211: Loading compiled-in X.509 certificates for regulatory database845machine # [ 12.409660] systemd[1]: Finished Permit User Sessions.846machine # [ 12.418957] systemd[1]: Started Getty on tty1.847machine # [ 12.421998] systemd[1]: Reached target Login Prompts.848machine # [ 12.454473] systemd-logind[532]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)849machine # [ 12.487658] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'850machine # [ 12.488221] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'851machine # [ 12.489561] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2852machine # [ 12.489901] cfg80211: failed to load regulatory.db853machine # [ 12.550253] dhcpcd[703]: eth0: waiting for carrier854machine # [ 12.551433] dhcpcd[703]: libudev: received NULL device[ 12.570856] 8021q: adding VLAN 0 to HW filter on device eth0855machine # 856machine # [ 12.554796] dhcpcd[703]: libudev: received NULL device857machine # [ 12.555886] dhcpcd[703]: eth0: carrier acquired858machine # [ 12.574684] dhcpcd[703]: DUID 00:01:00:01:32:62:fd:35:52:54:00:12:34:56859machine # [ 12.575788] dhcpcd[703]: eth0: IAID 00:12:34:56860machine # [ 12.578278] dhcpcd[703]: eth0: adding address fe80::5054:ff:fe12:3456861machine # [ 13.719122] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3862machine # [ 14.103292] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.863machine # [ 14.123060] systemd[1]: Starting Virtual Console Setup...864machine # [ 14.149938] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.865machine # [ 14.151284] systemd[1]: Stopped Virtual Console Setup.866machine # [ 14.164001] systemd[1]: Starting Virtual Console Setup...867machine # [ 14.198567] systemd-logind[532]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)868machine # [ 14.255915] dhcpcd[703]: eth0: soliciting a DHCP lease869machine # [ 14.264802] dhcpcd[703]: eth0: offered 10.0.2.15 from 10.0.2.2870machine # [ 14.268779] dhcpcd[703]: eth0: probing address 10.0.2.15/24871machine # [ 14.334543] systemd-vconsole-setup[771]: Configuration of first virtual console was skipped, ignoring remaining ones.872machine # [ 14.338228] systemd[1]: Finished Virtual Console Setup.873machine # [ 14.966592] dhcpcd[703]: eth0: soliciting an IPv6 router874machine # [ 14.969047] dhcpcd[703]: eth0: Router Advertisement from fe80::2875machine # [ 14.970472] dhcpcd[703]: eth0: adding address fec0::5054:ff:fe12:3456/64876machine # [ 14.973150] dhcpcd[703]: eth0: adding route to fec0::/64877machine # [ 14.974812] dhcpcd[703]: eth0: adding default route via fe80::2878machine # [ 20.070102] dhcpcd[703]: eth0: leased 10.0.2.15 for 86400 seconds879machine # [ 20.072970] dhcpcd[703]: eth0: adding route to 10.0.2.0/24880machine # [ 20.073145] dhcpcd[703]: eth0: adding default route via 10.0.2.2881machine # [ 20.186274] systemd[1]: Started DHCP Client.882machine # [ 20.191909] systemd[1]: Reached target Multi-User System.883machine # [ 20.193216] systemd[1]: Startup finished in 2.539s (kernel) + 5.083s (initrd) + 12.568s (userspace) = 20.191s.884machine: (finished: waiting for unit multi-user.target, in 9.44 seconds)885machine: must succeed: systemd-analyze | grep -q '(initrd)'886machine: (finished: must succeed: systemd-analyze | grep -q '(initrd)', in 0.16 seconds)887machine: must succeed: touch /testfile888machine: (finished: must succeed: touch /testfile, in 0.03 seconds)889machine: must fail: touch /nix/store/testfile890machine # touch: cannot touch '/nix/store/testfile': Read-only file system891machine: (finished: must fail: touch /nix/store/testfile, in 0.03 seconds)892machine: must succeed: [ -e /run/booted-system ]893machine: (finished: must succeed: [ -e /run/booted-system ], in 0.02 seconds)894machine: must succeed: [ -e /sys/class ]895machine: (finished: must succeed: [ -e /sys/class ], in 0.02 seconds)896machine: must succeed: [ -e /dev/null ]897machine: (finished: must succeed: [ -e /dev/null ], in 0.01 seconds)898machine: must succeed: [ -e /proc/1 ]899machine: (finished: must succeed: [ -e /proc/1 ], in 0.01 seconds)900machine: must succeed: [ -e /dev/shm ]901machine: (finished: must succeed: [ -e /dev/shm ], in 0.01 seconds)902machine: must succeed: [ -e /dev/pts/ptmx ]903machine: (finished: must succeed: [ -e /dev/pts/ptmx ], in 0.01 seconds)904machine: must succeed: [ -e /run/keys ]905machine: (finished: must succeed: [ -e /run/keys ], in 0.01 seconds)906machine: must succeed: [ ! -e /nixos-closure ]907machine: (finished: must succeed: [ ! -e /nixos-closure ], in 0.01 seconds)908(finished: subtest: handover to stage-2 systemd works, in 9.78 seconds)909subtest: groups work910machine: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring'911machine: (finished: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring', in 0.03 seconds)912(finished: subtest: groups work, in 0.03 seconds)913subtest: growfs works914machine: must succeed: df --output=avail / | sed 1d915machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.02 seconds)916machine: waiting for the VM to power off917additionally exposed symbols:918 machine,919 vlan1,920 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_ssh921machine # [ 21.139652] systemd-logind[532]: poweroff requested from client PID 930 ('poweroff') (unit backdoor.service)...922machine # [ 21.143682] systemd-logind[532]: System is powering down.923machine # [ 21.154218] systemd-logind[532]: The system will power off now!924machine # [ 21.164891] systemd[1]: Removed slice Slice /system/modprobe.925machine # [ 21.169014] systemd[1]: Stopped target Multi-User System.926machine # [ 21.171851] systemd[1]: Stopped target Login Prompts.927machine # [ 21.177355] systemd[1]: Stopped target Virtual Machines and Containers.928machine # [ 21.178762] dhcpcd[703]: received SIGTERM, stopping929machine # [ 21.179670] systemd[1]: Stopped target Host and Network Name Lookups.930machine # [ 21.188539] dhcpcd[703]: eth0: removing interface931machine # [ 21.190421] systemd[1]: Stopped target Timer Units.932machine # [ 21.191278] dhcpcd[703]: eth0: deleting address fec0::5054:ff:fe12:3456/64933machine # [ 21.200387] systemd[1]: fstrim.timer: Deactivated successfully.934machine # [ 21.201420] dhcpcd[703]: eth0: deleting route to fec0::/64935machine # [ 21.202275] systemd[1]: Stopped Discard unused filesystem blocks once a week.936machine # [ 21.203343] dhcpcd[703]: eth0: deleting default route via fe80::2937machine # [ 21.208422] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.938machine # [ 21.209572] dhcpcd[703]: script_status: /nix/store/rdc07ai806ajismdlk5fg46r6x6x7034-dhcpcd-10.3.2/libexec/dhcpcd-run-hooks: Terminated939machine # [ 21.211442] systemd[1]: Stopped Daily Cleanup of Temporary Directories.940machine # [ 21.224625] dhcpcd[703]: eth0: deleting address fe80::5054:ff:fe12:3456941machine # [ 21.225769] systemd[1]: systemd-rfkill.socket: Deactivated successfully.942machine # [ 21.226849] dhcpcd[703]: eth0: deleting route to 10.0.2.0/24943machine # [ 21.227764] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.944machine # [ 21.235556] dhcpcd[703]: eth0: deleting default route via 10.0.2.2945machine # [ 21.239971] systemd[1]: Mounting /run/initramfs...946machine # [ 21.241375] systemd[1]: Stopping backdoor.service...947machine # [ 21.242207] systemd[1]: Stopping DHCP Client...948machine # [ 21.242980] systemd[1]: Stopping Getty on tty1...949machine # [ 21.243719] systemd[1]: lastlog2-import.service: Deactivated successfully.950machine # [ 21.253356] systemd[1]: Stopped Import lastlog data into lastlog2 database.951machine # [ 21.254554] systemd[1]: Stopping Address configuration of eth1...952machine # [ 21.255602] systemd[1]: Stopping Post-Boot Actions...953machine # [ 21.264541] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.954machine # [ 21.265783] dhcpcd[703]: dhcpcd exited955machine # [ 21.266461] systemd[1]: Stopped Reset console on configuration changes.956machine # [ 21.267630] systemd[1]: Stopping User Login Management...957machine # [ 21.274650] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.958machine # [ 21.279857] systemd[1]: Stopped Save Transient machine-id to Disk.959machine # [ 21.281899] systemd[1]: Stopped target First Boot Complete.960machine # [ 21.282821] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...961machine # [ 21.283860] systemd[1]: Stopping Load/Save OS Random Seed...962machine # [ 21.291405] systemd[1]: systemd-oomd.service: Deactivated successfully.963machine # [ 21.297014] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.964machine # [ 21.298250] systemd[1]: backdoor.service: Deactivated successfully.965machine # [ 21.299215] systemd[1]: Stopped backdoor.service.966machine # [ 21.299945] systemd[1]: systemd-logind.service: Deactivated successfully.967machine # [ 21.314624] systemd[1]: Stopped User Login Management.968machine # [ 21.325970] systemd[1]: dhcpcd.service: Deactivated successfully.969machine # [ 21.331246] systemd[1]: Stopped DHCP Client.970machine # [ 21.334494] systemd[1]: dhcpcd.service: Consumed 250ms CPU time over 9.489s wall clock time, 7.7M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.971machine # [ 21.353591] network-addresses-eth1-pre-stop[934]: deleting address 192.168.1.1/24... done972machine # [ 21.360375] systemd[1]: getty@tty1.service: Deactivated successfully.973machine # [ 21.367472] systemd[1]: Stopped Getty on tty1.974machine # [ 21.379256] network-addresses-eth1-pre-stop[934]: deleting address 2001:db8:1::1/64... done975machine # [ 21.387271] systemd[1]: post-boot.service: Deactivated successfully.976machine # [ 21.394624] systemd[1]: Stopped Post-Boot Actions.977machine # [ 21.398410] systemd[1]: systemd-random-seed.service: Deactivated successfully.978machine # [ 21.401598] systemd[1]: Stopped Load/Save OS Random Seed.979machine # [ 21.407213] systemd[1]: network-addresses-eth1.service: Deactivated successfully.980machine # [ 21.410309] systemd[1]: Stopped Address configuration of eth1.981machine # [ 21.418228] systemd[1]: Mounted /run/initramfs.982machine # [ 21.424239] systemd[1]: Removed slice Slice /system/getty.983machine # [ 21.428598] systemd[1]: Starting Generate shutdown ramfs...984machine # [ 21.440802] systemd[1]: Stopping Permit User Sessions...985machine # [ 21.490036] systemd[1]: systemd-user-sessions.service: Deactivated successfully.986machine # [ 21.491740] systemd[1]: Stopped Permit User Sessions.987machine # [ 21.499165] systemd[1]: Stopped target Network.988machine # [ 21.499945] systemd[1]: Stopped target User and Group Name Lookups.989machine # [ 21.501233] systemd[1]: Stopped target Remote File Systems.990machine # [ 21.504331] systemd[1]: network-local-commands.service: Deactivated successfully.991machine # [ 21.505466] systemd[1]: Stopped Extra networking commands..992machine # [ 21.506291] systemd[1]: Stopped target Preparation for Network.993machine # [ 21.516685] systemd[1]: Stopping Firewall...994machine # [ 21.517661] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...995machine # [ 21.518650] systemd[1]: resolvconf.service: Deactivated successfully.996machine # [ 21.519725] systemd[1]: Stopped resolvconf update.997machine # [ 21.527433] systemd[1]: nscd.service: Deactivated successfully.998machine # [ 21.531608] systemd[1]: Stopped Name Service Cache Daemon (nsncd).999machine # [ 21.540427] make-initrd-ng[958]: /etc/initrd-release -> /nix/store/pqw34vf15pgjdbln6agl61gmmp9xfjik-etc-os-release1000machine # [ 21.542006] make-initrd-ng[958]: /etc/os-release -> /nix/store/pqw34vf15pgjdbln6agl61gmmp9xfjik-etc-os-release1001machine # [ 21.543398] make-initrd-ng[958]: /shutdown -> /nix/store/zb1l01zaw0xw40lqcnwmap98xi9szh56-systemd-263-7f073ff/lib/systemd/systemd-shutdown1002machine # [ 21.557480] systemd[1]: Stopped target Basic System.1003machine # [ 21.558384] systemd[1]: Stopped target Path Units.1004machine # [ 21.559264] systemd[1]: Stopped target Slice Units.1005machine # [ 21.568527] systemd[1]: Removed slice User and Session Slice.1006machine # [ 21.569618] systemd[1]: Stopped target Socket Units.1007machine # [ 21.570414] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.1008machine # [ 21.571461] systemd[1]: Closed Hostname Service Socket.1009machine # [ 21.582533] systemd[1]: systemd-importd.socket: Deactivated successfully.1010machine # [ 21.583771] systemd[1]: Closed Disk Image Download Service Socket.1011machine # [ 21.590857] systemd[1]: systemd-machined.socket: Deactivated successfully.1012machine # [ 21.595234] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1013machine # [ 21.600301] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1014machine # [ 21.601418] systemd[1]: Closed Console Output Muting Service Socket.1015machine # [ 21.602367] systemd[1]: systemd-oomd.socket: Deactivated successfully.1016machine # [ 21.603335] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1017machine # [ 21.613112] systemd[1]: systemd-repart.socket: Deactivated successfully.1018machine # [ 21.614209] systemd[1]: Closed Disk Repartitioning Service Socket.1019machine # [ 21.615556] dbus-broker[568]: Dispatched 920 messages @ 4(±15)μs / message.1020machine # [ 21.628953] systemd[1]: Stopping D-Bus System Message Bus...1021machine # [ 21.636761] systemd[1]: dbus-broker.service: Deactivated successfully.1022machine # [ 21.637928] systemd[1]: Stopped D-Bus System Message Bus.1023machine # [ 21.638782] systemd[1]: dbus.socket: Deactivated successfully.1024machine # [ 21.639844] systemd[1]: Closed D-Bus System Message Bus Socket.1025machine # [ 21.649643] systemd[1]: Stopped target System Initialization.1026machine # [ 21.650637] systemd[1]: Stopped target Local Encrypted Volumes.1027machine # [ 21.651635] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1028machine # [ 21.657780] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1029machine # [ 21.659154] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1030machine # [ 21.665598] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1031machine # [ 21.666798] systemd[1]: systemd-sysctl.service: Deactivated successfully.1032machine # [ 21.679468] systemd[1]: Stopped Apply Kernel Variables.1033machine # [ 21.683659] systemd[1]: systemd-coredump.socket: Deactivated successfully.1034machine # [ 21.690088] systemd[1]: Closed Process Core Dump Socket.1035machine # [ 21.691019] systemd[1]: systemd-update-done.service: Deactivated successfully.1036machine # [ 21.697293] systemd[1]: Stopped Update is Completed.1037machine # [ 21.698167] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1038machine # [ 21.699447] systemd[1]: Stopped Rebuild Journal Catalog.1039machine # [ 21.703687] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1040machine # [ 21.732135] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1041machine # [ 21.733409] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1042machine # [ 21.734436] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1043machine # [ 21.735572] systemd[1]: Stopped Create System Files and Directories.1044machine # [ 21.749872] systemd[1]: Stopped target Local File Systems.1045machine # [ 21.750879] systemd[1]: Unmounting /run/keys...1046machine # [ 21.751667] systemd[1]: Unmounting /run/wrappers...1047machine # [ 21.757551] systemd[1]: systemd-growfs-root.service: Deactivated successfully.1048machine # [ 21.758767] systemd[1]: Stopped Grow Root File System.1049machine # [ 21.777287] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1050machine # [ 21.783039] systemd[1]: Finished Generate shutdown ramfs.1051machine # [ 21.791659] systemd[1]: firewall.service: Deactivated successfully.1052machine # [ 21.795748] systemd[1]: Stopped Firewall.1053machine # [ 21.796739] systemd[1]: systemd-modules-load.service: Deactivated successfully.1054machine # [ 21.799319] systemd[1]: Stopped Load Kernel Modules.1055machine # [ 21.925598] systemd[1]: run-keys.mount: Deactivated successfully.1056machine # [ 21.926787] systemd[1]: Unmounted /run/keys.1057machine # [ 21.927597] systemd[1]: run-wrappers.mount: Deactivated successfully.1058machine # [ 21.928727] systemd[1]: Unmounted /run/wrappers.1059machine # [ 21.929439] systemd[1]: Stopped target Preparation for Local File Systems.1060machine # [ 21.930442] systemd[1]: Stopped target Swaps.1061machine # [ 21.931165] systemd[1]: Reached target Unmount All Filesystems.1062machine # [ 21.933528] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1063machine # [ 21.934597] systemd[1]: Stopped Remount Root and Kernel File Systems.1064machine # [ 21.935560] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1065machine # [ 21.936895] systemd[1]: Stopped File System Check on Root Device.1066machine # [ 21.937829] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1067machine # [ 21.939102] systemd[1]: Stopped Create Static Device Nodes in /dev.1068machine # [ 21.940118] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1069machine # [ 21.941354] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1070machine # [ 21.942432] systemd[1]: Reached target System Shutdown.1071machine # [ 21.943263] systemd[1]: Reached target Late Shutdown Services.1072machine # [ 21.947166] systemd[1]: systemd-poweroff.service: Deactivated successfully.1073machine # [ 21.948405] systemd[1]: Finished System Power Off.1074machine # [ 21.949168] systemd[1]: Reached target System Power Off.1075machine # [ 21.950018] systemd[1]: Shutting down.1076machine # [ 22.131114] systemd-shutdown[1]: Syncing filesystems and block devices.1077machine # [ 22.210038] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1078machine # [ 22.218723] systemd-journald[329]: Received SIGTERM from PID 1 (systemd-shutdow).1079machine # [ 22.249964] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1080machine # [ 22.256114] systemd-shutdown[1]: Unmounting file systems.1081machine # [ 22.260660] (sd-umount)[989]: Unmounting '/run/credentials/systemd-journald.service'.1082machine # [ 22.261999] (sd-remount)[990]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'.1083machine # [ 22.277359] (sd-umount)[991]: Unmounting '/nix/store'.1084machine # [ 22.277627] (sd-umount)[991]: Failed to unmount /nix/store: Device or resource busy1085machine # [ 22.288224] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/da677ea01c86ce54.1086machine # [ 22.289407] (sd-remount)[992]: Remounting '/nix/store' read-only with options 'lowerdir=/sysroot/nix/.ro-store,upperdir=/sysroot/nix/.rw-store/upper,workdir=/sysroot/nix/.rw-store/work,uuid=on'.1087machine # [ 22.296609] (sd-umount)[993]: Unmounting '/nix/store'.1088machine # [ 22.298021] (sd-umount)[994]: Unmounting '/nix/.ro-store'.1089machine # [ 22.302270] (sd-remount)[995]: Remounting '/tmp/xchg' read-only with options ''.1090machine # [ 22.303395] (sd-umount)[996]: Unmounting '/tmp/xchg'.1091machine # [ 22.305404] (sd-remount)[997]: Remounting '/tmp/shared' read-only with options ''.1092machine # [ 22.310937] (sd-umount)[998]: Unmounting '/tmp/shared'.1093machine # [ 22.312422] (sd-umount)[999]: Unmounting '/nix/.rw-store'.1094machine # [ 22.313542] (sd-remount)[1000]: Remounting '/' read-only with options ''.1095machine # [ 22.321818] EXT4-fs (vda): re-mounted ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4 ro.1096machine # [ 22.326629] (sd-umount)[1001]: Unmounting '/run/shutdown/mounts/da677ea01c86ce54'.1097machine # [ 22.326908] (sd-umount)[1001]: Failed to unmount /run/shutdown/mounts/da677ea01c86ce54: Device or resource busy1098machine # [ 22.328200] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1099machine # [ 22.328518] systemd-shutdown[1]: Deactivating swaps.1100machine # [ 22.329424] systemd-shutdown[1]: All swaps deactivated.1101machine # [ 22.330053] systemd-shutdown[1]: Detaching loop devices.1102machine # [ 22.347447] systemd-shutdown[1]: All loop devices detached.1103machine # [ 22.347594] systemd-shutdown[1]: Stopping MD devices.1104machine # [ 22.348762] systemd-shutdown[1]: All MD devices stopped.1105machine # [ 22.348787] systemd-shutdown[1]: Detaching DM devices.1106machine # [ 22.348917] systemd-shutdown[1]: All DM devices detached.1107machine # [ 22.349064] systemd-shutdown[1]: Unmounting file systems.1108machine # [ 22.356163] (sd-umount)[1002]: Unmounting '/run/shutdown/mounts/da677ea01c86ce54'.1109machine # [ 22.356345] (sd-umount)[1002]: Failed to unmount /run/shutdown/mounts/da677ea01c86ce54: Device or resource busy1110machine # [ 22.357857] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1111machine # [ 22.357888] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing.1112machine # [ 22.367088] systemd-shutdown[1]: Successfully changed into root pivot.1113machine # [ 22.367931] systemd-shutdown[1]: Entering exitrd...1114machine # [ 22.381679] shutdown[1]: Syncing filesystems and block devices.1115machine # [ 22.384704] shutdown[1]: Sending SIGTERM to remaining processes...1116machine # [ 22.389089] shutdown[1]: Sending SIGKILL to remaining processes...1117machine # [ 22.393228] shutdown[1]: Unmounting file systems.1118machine # [ 22.396522] (sd-umoun[1004]: Unmounting '/run/credentials'.1119machine # [ 22.397825] (sd-umoun[1005]: Unmounting '/oldroot/sys/fs/fuse/connections'.1120machine # [ 22.401521] (sd-umoun[1006]: Unmounting '/oldroot/sys/kernel/config'.1121machine # [ 22.403819] (sd-umoun[1007]: Unmounting '/oldroot/dev/mqueue'.1122machine # [ 22.404936] (sd-umoun[1008]: Unmounting '/oldroot/sys/kernel/debug'.1123machine # [ 22.406020] (sd-umoun[1009]: Unmounting '/oldroot/sys/kernel/tracing'.1124machine # [ 22.411209] (sd-umoun[1010]: Unmounting '/oldroot/dev/hugepages'.1125machine # [ 22.412567] (sd-umoun[1011]: Unmounting '/oldroot/sys/fs/bpf'.1126machine # [ 22.413977] (sd-umoun[1012]: Unmounting '/oldroot/sys/fs/pstore'.1127machine # [ 22.419749] (sd-umoun[1013]: Unmounting '/oldroot/sys/fs/cgroup'.1128machine # [ 22.421384] (sd-umoun[1014]: Unmounting '/oldroot/sys/kernel/security'.1129machine # [ 22.425364] (sd-umoun[1015]: Unmounting '/oldroot/run/shutdown/mounts/da677ea01c86ce54'.1130machine # [ 22.454971] (sd-umoun[1016]: Unmounting '/oldroot/sys'.1131machine # [ 22.456363] (sd-umoun[1017]: Unmounting '/oldroot/proc'.1132machine # [ 22.457556] (sd-umoun[1018]: Unmounting '/oldroot/dev/shm'.1133machine # [ 22.461294] (sd-umoun[1019]: Unmounting '/oldroot/dev/pts'.1134machine # [ 22.463455] (sd-umoun[1020]: Unmounting '/oldroot/dev'.1135machine # [ 22.464673] (sd-umoun[1021]: Unmounting '/oldroot/run'.1136machine # [ 22.465979] (sd-umoun[1022]: Unmounting '/oldroot'.1137machine # [ 22.471704] EXT4-fs (vda): unmounting filesystem ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4.1138machine # [ 22.473379] shutdown[1]: All filesystems unmounted.1139machine # [ 22.473739] shutdown[1]: Deactivating swaps.1140machine # [ 22.477620] shutdown[1]: All swaps deactivated.1141machine # [ 22.477951] shutdown[1]: Detaching loop devices.1142machine # [ 22.483511] shutdown[1]: All loop devices detached.1143machine # [ 22.483867] shutdown[1]: Stopping MD devices.1144machine # [ 22.484788] shutdown[1]: All MD devices stopped.1145machine # [ 22.485382] shutdown[1]: Detaching DM devices.1146machine # [ 22.489312] shutdown[1]: All DM devices detached.1147machine # [ 22.489632] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1148machine # [ 22.493367] shutdown[1]: Syncing filesystems and block devices.1149machine # [ 22.495598] shutdown[1]: Powering off.1150machine # [ 22.526465] Console: switching to colour dummy device 80x251151machine # [ 22.535315] Flash device refused suspend due to active operation (state 20)1152machine # [ 22.535332] Flash device refused suspend due to active operation (state 20)1153machine # [ 22.537788] reboot: Power down1154machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client disconnected, shutting down1155machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client disconnected, shutting down1156machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client disconnected, shutting down1157machine: (finished: waiting for the VM to power off, in 1.67 seconds)1158Image resized.1159machine: starting vm1160machine # Starting virtiofs daemons...1161machine: QEMU running (pid 87)1162machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1163machine: waiting for unit initrd.target1164machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1165machine: waiting for the VM to finish booting1166machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1167machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1168machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1169machine # [2026-10-15T02:55:59Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1170machine # [2026-10-15T02:55:59Z INFO virtiofsd] Waiting for vhost-user socket connection...1171machine # [2026-10-15T02:55:59Z INFO virtiofsd] Waiting for vhost-user socket connection...1172machine # [2026-10-15T02:55:59Z INFO virtiofsd] Waiting for vhost-user socket connection...1173machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client connected, servicing requests1174machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client connected, servicing requests1175machine # [2026-10-15T02:55:59Z INFO virtiofsd] Client connected, servicing requests1176machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]1177machine # [ 0.000000] Linux version 6.18.55 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Oct 3 10:39:03 UTC 20261178machine # [ 0.000000] KASLR enabled1179machine # [ 0.000000] random: crng init done1180machine # [ 0.000000] Machine model: linux,dummy-virt1181machine # [ 0.000000] efi: UEFI not found.1182machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT1183machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1184machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]1185machine # [ 0.000000] Zone ranges:1186machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1187machine # [ 0.000000] DMA32 empty1188machine # [ 0.000000] Normal empty1189machine # [ 0.000000] Device empty1190machine # [ 0.000000] Movable zone start for each node1191machine # [ 0.000000] Early memory node ranges1192machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]1193machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1194machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001195machine # [ 0.000000] psci: probing for conduit method from DT.1196machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1197machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1198machine # [ 0.000000] psci: Trusted OS migration not required1199machine # [ 0.000000] psci: SMC Calling Convention v1.11200machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1201machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186840 r8192 d116264 u3112961202machine # [ 0.000000] Detected PIPT I-cache on CPU01203machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1204machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1205machine # [ 0.000000] CPU features: detected: Spectre-v41206machine # [ 0.000000] CPU features: detected: Spectre-BHB1207machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381208machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231209machine # [ 0.000000] alternatives: applying boot alternatives1210machine # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/gxlljyaid42bg28sszbxn94mnbx7s8xj-nixos-system-machine-test/init regInfo=/nix/.ro-store/jma8qm8xky5kbn1gihrazxrc56qw0l0y-closure-info/registration console=ttyAMA0,115200n8 console=tty01211machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/jma8qm8xky5kbn1gihrazxrc56qw0l0y-closure-info/registration", will be passed to user space.1212machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1213machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1214machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1215machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1216machine # [ 0.000000] software IO TLB: area num 1.1217machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1218machine # [ 0.000000] Fallback order for Node 0: 01219machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441220machine # [ 0.000000] Policy zone: DMA1221machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1222machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11223machine # [ 0.000000] allocated 2097152 bytes of page_ext1224machine # [ 0.000000] ftrace: allocating 75039 entries in 294 pages1225machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1226machine # [ 0.000000] rcu: Hierarchical RCU implementation.1227machine # [ 0.000000] rcu: RCU event tracing is enabled.1228machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1229machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1230machine # [ 0.000000] Rude variant of Tasks RCU enabled.1231machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1232machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1233machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11234machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1235machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1236machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1237machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01238machine # [ 0.000000] GICv3: 256 SPIs implemented1239machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1240machine # [ 0.000000] Root IRQ handler: gic_handle_irq1241machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1242machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01243machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001244machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1245machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)1246machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)1247machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d100001248machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d200001249machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1250machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1251machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1252machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1253machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1254machine # [ 0.000047] arm-pv: using stolen time PV1255machine # [ 0.000772] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1256machine # [ 0.001018] Console: colour dummy device 80x251257machine # [ 0.001027] printk: legacy console [tty0] enabled1258machine # [ 0.001252] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1259machine # [ 0.001259] pid_max: default: 32768 minimum: 3011260machine # [ 0.001377] LSM: initializing lsm=capability,landlock,yama,bpf,ima1261machine # [ 0.001557] landlock: Up and running.1262machine # [ 0.001560] Yama: becoming mindful.1263machine # [ 0.002108] LSM support for eBPF active1264machine # [ 0.002249] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1265machine # [ 0.002272] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1266machine # [ 0.004543] rcu: Hierarchical SRCU implementation.1267machine # [ 0.004550] rcu: Max phase no-delay instances is 1000.1268machine # [ 0.005993] fsl-mc MSI: its@8080000 domain created1269machine # [ 0.006121] EFI services will not be available.1270machine # [ 0.006220] smp: Bringing up secondary CPUs ...1271machine # [ 0.006235] smp: Brought up 1 node, 1 CPU1272machine # [ 0.006238] SMP: Total of 1 processors activated.1273machine # [ 0.006241] CPU: All CPU(s) started at EL11274machine # [ 0.006258] CPU features: detected: Branch Target Identification1275machine # [ 0.006268] CPU features: detected: ARMv8.4 Translation Table Level1276machine # [ 0.006271] CPU features: detected: Instruction cache invalidation not required for I/D coherence1277machine # [ 0.006275] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1278machine # [ 0.006278] CPU features: detected: Common not Private translations1279machine # [ 0.006282] CPU features: detected: CRC32 instructions1280machine # [ 0.006284] CPU features: detected: Data cache clean to Point of Deep Persistence1281machine # [ 0.006288] CPU features: detected: Data cache clean to Point of Persistence1282machine # [ 0.006291] CPU features: detected: Data independent timing control (DIT)1283machine # [ 0.006294] CPU features: detected: E0PD1284machine # [ 0.006296] CPU features: detected: Enhanced Counter Virtualization1285machine # [ 0.006300] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1286machine # [ 0.006303] CPU features: detected: Enhanced Virtualization Traps1287machine # [ 0.006306] CPU features: detected: Fine Grained Traps1288machine # [ 0.006310] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1289machine # [ 0.006315] CPU features: detected: RCpc load-acquire (LDAPR)1290machine # [ 0.006318] CPU features: detected: LSE atomic instructions1291machine # [ 0.006320] CPU features: detected: Privileged Access Never1292machine # [ 0.006323] CPU features: detected: PMUv31293machine # [ 0.006326] CPU features: detected: RAS Extension Support1294machine # [ 0.006329] CPU features: detected: RASv1p1 Extension Support1295machine # [ 0.006332] CPU features: detected: Random Number Generator1296machine # [ 0.006334] CPU features: detected: Speculation barrier (SB)1297machine # [ 0.006337] CPU features: detected: Stage-2 Force Write-Back1298machine # [ 0.006340] CPU features: detected: TLB range maintenance instructions1299machine # [ 0.006345] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1300machine # [ 0.006386] alternatives: applying system-wide alternatives1301machine # [ 0.010776] CPU features: detected: BBM Level 2 without TLB conflict abort1302machine # [ 0.010992] Memory: 892872K/1048576K available (24576K kernel code, 7094K rwdata, 26568K rodata, 4736K init, 1106K bss, 114392K reserved, 32768K cma-reserved)1303machine # [ 0.012616] devtmpfs: initialized1304machine # [ 0.016682] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1305machine # [ 0.016711] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1306machine # [ 0.017028] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1307machine # [ 0.017036] 0 pages in range for non-PLT usage1308machine # [ 0.017037] 508192 pages in range for PLT usage1309machine # [ 0.017160] pinctrl core: initialized pinctrl subsystem1310machine # [ 0.018039] DMI not present or invalid.1311machine # [ 0.022188] NET: Registered PF_NETLINK/PF_ROUTE protocol family1312machine # [ 0.024704] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1313machine # [ 0.024901] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1314machine # [ 0.025074] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1315machine # [ 0.025109] audit: initializing netlink subsys (disabled)1316machine # [ 0.025854] thermal_sys: Registered thermal governor 'fair_share'1317machine # [ 0.025857] thermal_sys: Registered thermal governor 'bang_bang'1318machine # [ 0.025861] thermal_sys: Registered thermal governor 'step_wise'1319machine # [ 0.025864] thermal_sys: Registered thermal governor 'user_space'1320machine # [ 0.025867] thermal_sys: Registered thermal governor 'power_allocator'1321machine # [ 0.025901] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=11322machine # [ 0.025913] cpuidle: using governor ladder1323machine # [ 0.025919] cpuidle: using governor menu1324machine # [ 0.026134] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1325machine # [ 0.026153] ASID allocator initialised with 65536 entries1326machine # [ 0.027565] Serial: AMBA PL011 UART driver1327machine # [ 0.035013] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev11328machine # [ 0.035157] printk: console [ttyAMA0] enabled1329machine # [ 0.172689] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1330machine # [ 0.172706] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1331machine # [ 0.172709] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1332machine # [ 0.172712] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1333machine # [ 0.172715] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1334machine # [ 0.172718] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1335machine # [ 0.172721] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1336machine # [ 0.172723] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1337machine # [ 0.174110] fbcon: Taking over console1338machine # [ 0.174124] ACPI: Interpreter disabled.1339machine # [ 0.191735] iommu: Default domain type: Translated1340machine # [ 0.191742] iommu: DMA domain TLB invalidation policy: strict mode1341machine # [ 0.192734] SCSI subsystem initialized1342machine # [ 0.194924] usbcore: registered new interface driver usbfs1343machine # [ 0.194955] usbcore: registered new interface driver hub1344machine # [ 0.194976] usbcore: registered new device driver usb1345machine # [ 0.200294] pps_core: LinuxPPS API ver. 1 registered1346machine # [ 0.200301] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1347machine # [ 0.200309] PTP clock support registered1348machine # [ 0.200370] EDAC MC: Ver: 3.0.01349machine # [ 0.200575] scmi_core: SCMI protocol bus registered1350machine # [ 0.201044] FPGA manager framework1351machine # [ 0.207163] vgaarb: loaded1352machine # [ 0.207491] clocksource: Switched to clocksource arch_sys_counter1353machine # [ 0.208269] VFS: Disk quotas dquot_6.6.01354machine # [ 0.208305] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1355machine # [ 0.212830] netfs: FS-Cache loaded1356machine # [ 0.212973] pnp: PnP ACPI: disabled1357machine # [ 0.219103] NET: Registered PF_INET protocol family1358machine # [ 0.219260] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1359machine # [ 0.251857] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1360machine # [ 0.251902] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1361machine # [ 0.251928] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1362machine # [ 0.251976] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1363machine # [ 0.252049] TCP: Hash tables configured (established 8192 bind 8192)1364machine # [ 0.252171] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1365machine # [ 0.252229] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1366machine # [ 0.252281] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1367machine # [ 0.252410] NET: Registered PF_UNIX/PF_LOCAL protocol family1368machine # [ 0.252429] NET: Registered PF_XDP protocol family1369machine # [ 0.252445] PCI: CLS 0 bytes, default 641370machine # [ 0.252951] Trying to unpack rootfs image as initramfs...1371machine # [ 0.265833] kvm [1]: HYP mode not available1372machine # [ 0.394046] Initialise system trusted keyrings1373machine # [ 0.394232] workingset: timestamp_bits=42 max_order=18 bucket_order=01374machine # [ 0.394688] squashfs: version 4.0 (2009/01/31) Phillip Lougher1375machine # [ 0.394756] 9p: Installing v9fs 9p2000 file system support1376machine # [ 0.423077] Key type asymmetric registered1377machine # [ 0.423111] Asymmetric key parser 'x509' registered1378machine # [ 0.424793] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1379machine # [ 0.425034] io scheduler mq-deadline registered1380machine # [ 0.425040] io scheduler kyber registered1381machine # [ 0.439697] pl061_gpio 9030000.pl061: PL061 GPIO chip registered1382machine # [ 0.440575] ledtrig-cpu: registered to indicate activity on CPUs1383machine # [ 0.441041] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:1384machine # [ 0.441059] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x00000000001385machine # [ 0.441072] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x00100000001386machine # [ 0.441078] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x80000000001387machine # [ 0.441103] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits1388machine # [ 0.441129] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1389machine # [ 0.441234] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:001390machine # [ 0.441246] pci_bus 0000:00: root bus resource [bus 00-ff]1391machine # [ 0.441251] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]1392machine # [ 0.441254] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]1393machine # [ 0.441257] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]1394machine # [ 0.442214] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1395machine # [ 0.442816] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1396machine # [ 0.443031] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]1397machine # [ 0.443046] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]1398machine # [ 0.443078] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1399machine # [ 0.443094] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]1400machine # [ 0.467728] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1401machine # [ 0.467945] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]1402machine # [ 0.467958] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]1403machine # [ 0.467986] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1404machine # [ 0.468816] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1405machine # [ 0.469013] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]1406machine # [ 0.469026] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]1407machine # [ 0.469057] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1408machine # [ 0.469932] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1409machine # [ 0.470134] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]1410machine # [ 0.470147] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]1411machine # [ 0.470175] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1412machine # [ 0.470189] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]1413machine # [ 0.470690] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1414machine # [ 0.470888] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]1415machine # [ 0.470915] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1416machine # [ 0.471413] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1417machine # [ 0.491689] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]1418machine # [ 0.491735] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1419machine # [ 0.492260] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1420machine # [ 0.492544] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]1421machine # [ 0.492859] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1422machine # [ 0.493062] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]1423machine # [ 0.493091] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1424machine # [ 0.493606] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1425machine # [ 0.493802] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]1426machine # [ 0.493829] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1427machine # [ 0.494825] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1428machine # [ 0.495025] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]1429machine # [ 0.495055] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1430machine # [ 0.515974] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1431machine # [ 0.516310] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]1432machine # [ 0.516327] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]1433machine # [ 0.516375] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1434machine # [ 0.516910] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1435machine # [ 0.517107] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]1436machine # [ 0.517121] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]1437machine # [ 0.517149] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1438machine # [ 0.517842] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1439machine # [ 0.517850] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1440machine # [ 0.517853] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1441machine # [ 0.517904] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1442machine # [ 0.517950] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1443machine # [ 0.517999] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1444machine # [ 0.518046] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1445machine # [ 0.518093] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1446machine # [ 0.518141] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1447machine # [ 0.518193] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1448machine # [ 0.518239] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1449machine # [ 0.518285] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1450machine # [ 0.518361] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1451machine # [ 0.518405] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1452machine # [ 0.518424] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1453machine # [ 0.518443] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1454machine # [ 0.518463] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1455machine # [ 0.518486] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1456machine # [ 0.518505] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1457machine # [ 0.518524] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned1458machine # [ 0.518545] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1459machine # [ 0.518564] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1460machine # [ 0.518589] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1461machine # [ 0.518610] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned1462machine # [ 0.518630] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1463machine # [ 0.518649] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned1464machine # [ 0.518667] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned1465machine # [ 0.518686] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned1466machine # [ 0.518705] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned1467machine # [ 0.518724] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned1468machine # [ 0.518743] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned1469machine # [ 0.518767] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]1470machine # [ 0.518773] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]1471machine # [ 0.518776] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]1472machine # [ 0.558609] pci 0000:00:07.0: enabling device (0000 -> 0002)1473machine # [ 0.592060] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1474machine # [ 0.977435] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)1475machine # [ 0.981227] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1476machine # [ 0.983306] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1477machine # [ 0.997044] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)1478machine # [ 0.999147] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)1479machine # [ 1.009484] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)1480machine # [ 1.011427] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)1481machine # [ 1.021597] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1482machine # [ 1.031734] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1483machine # [ 1.034754] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1484machine # [ 1.052557] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1485machine # [ 1.057998] msm_serial: driver initialized1486machine # [ 1.058155] SuperH (H)SCI(F) driver initialized1487machine # [ 1.058219] STM32 USART driver initialized1488machine # [ 1.099196] loop: module loaded1489machine # [ 1.099412] virtio_blk virtio2: 1/0/0 default/read/poll queues1490machine # [ 1.108581] virtio_blk virtio2: [vda] 4194304 512-byte logical blocks (2.15 GB/2.00 GiB)1491machine # [ 1.113444] megasas: 07.734.00.00-rc11492machine # [ 1.114238] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1493machine # [ 1.128744] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001494machine # [ 1.128770] Intel/Sharp Extended Query Table at 0x00311495machine # [ 1.130576] Using buffer write method1496machine # [ 1.130638] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1497machine # [ 1.145093] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001498machine # [ 1.145123] Intel/Sharp Extended Query Table at 0x00311499machine # [ 1.146818] Using buffer write method1500machine # [ 1.146836] Concatenating MTD devices:1501machine # [ 1.146839] (0): "0.flash"1502machine # [ 1.146841] (1): "0.flash"1503machine # [ 1.146843] into device "0.flash"1504machine # [ 1.406391] Freeing initrd memory: 27148K1505machine # [ 1.414879] tun: Universal TUN/TAP device driver, 1.61506machine # [ 1.419973] thunder_xcv, ver 1.01507machine # [ 1.420006] thunder_bgx, ver 1.01508machine # [ 1.420024] nicpf, ver 1.01509machine # [ 1.420803] e1000: Intel(R) PRO/1000 Network Driver1510machine # [ 1.420809] e1000: Copyright (c) 1999-2006 Intel Corporation.1511machine # [ 1.420850] e1000e: Intel(R) PRO/1000 Network Driver1512machine # [ 1.420857] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1513machine # [ 1.420884] igb: Intel(R) Gigabit Ethernet Network Driver1514machine # [ 1.420888] igb: Copyright (c) 2007-2014 Intel Corporation.1515machine # [ 1.420917] igbvf: Intel(R) Gigabit Virtual Function Network Driver1516machine # [ 1.420931] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1517machine # [ 1.421123] sky2: driver version 1.301518machine # [ 1.432719] usbcore: registered new interface driver usb-storage1519machine # [ 1.432800] usbcore: registered new interface driver usbserial_generic1520machine # [ 1.432814] usbserial: USB Serial support registered for generic1521machine # [ 1.433659] hv_vmbus: registering driver hyperv_keyboard1522machine # [ 1.435627] ehci-pci 0000:00:07.0: EHCI Host Controller1523machine # [ 1.435672] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11524machine # [ 1.435946] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001525machine # [ 1.442259] rtc-pl031 9010000.pl031: registered as rtc01526machine # [ 1.442301] rtc-pl031 9010000.pl031: setting system clock to 2026-10-15T02:56:04 UTC (1792032964)1527machine # [ 1.443077] i2c_dev: i2c /dev entries driver1528machine # [ 1.451142] sdhci: Secure Digital Host Controller Interface driver1529machine # [ 1.451157] sdhci: Copyright(c) Pierre Ossman1530machine # [ 1.451569] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001531machine # [ 1.454658] hub 1-0:1.0: USB hub found1532machine # [ 1.454690] hub 1-0:1.0: 6 ports detected1533machine # [ 1.456705] Synopsys Designware Multimedia Card Interface Driver1534machine # [ 1.457234] sdhci-pltfm: SDHCI platform and OF driver helper1535machine # [ 1.461473] hid: raw HID events driver (C) Jiri Kosina1536machine # [ 1.462032] usbcore: registered new interface driver usbhid1537machine # [ 1.462039] usbhid: USB HID core driver1538machine # [ 1.465999] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available1539machine # [ 1.469799] drop_monitor: Initializing network drop monitor service1540machine # [ 1.470061] NET: Registered PF_INET6 protocol family1541machine # [ 1.471124] Segment Routing with IPv61542machine # [ 1.471143] In-situ OAM (IOAM) with IPv61543machine # [ 1.471196] NET: Registered PF_PACKET protocol family1544machine # [ 1.471313] 9pnet: Installing 9P2000 support1545machine # [ 1.471379] Key type dns_resolver registered1546machine # [ 1.486865] registered taskstats version 11547machine # [ 1.487138] Loading compiled-in X.509 certificates1548machine # [ 1.498712] Demotion targets for Node 0: null1549machine # [ 1.498888] Key type .fscrypt registered1550machine # [ 1.498892] Key type fscrypt-provisioning registered1551machine # [ 1.499068] ima: No TPM chip found, activating TPM-bypass!1552machine # [ 1.499105] ima: Allocated hash algorithm: sha11553machine # [ 1.499152] ima: No architecture policies found1554machine # [ 1.504856] input: gpio-keys as /devices/platform/gpio-keys/input/input01555machine # [ 1.532305] clk: Disabling unused clocks1556machine # [ 1.532333] PM: genpd: Disabling unused power domains1557machine # [ 1.538590] Freeing unused kernel memory: 4736K1558machine # [ 1.538858] Run /init as init process1559machine # [ 1.564226] systemd[1]: Successfully made /usr/ read-only.1560machine # [ 1.564978] systemd[1]: systemd 263-7f073ff 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 +EXPERIMENTAL-ENVVAR)1561machine # [ 1.564994] systemd[1]: Detected virtualization qemu.1562machine # [ 1.565032] systemd[1]: Detected architecture arm64.1563machine # [ 1.565038] systemd[1]: Running in initrd.1564machine # [ 1.565430] systemd[1]: Initializing machine ID from random generator.1565machine # [ 1.565598] systemd[1]: Hostname set to <machine>.1566machine # [ 1.695354] systemd[1]: bpf-restrict-fs: LSM BPF program attached1567machine # [ 1.703609] usb 1-1: new high-speed USB device number 2 using ehci-pci1568machine # [ 1.773144] systemd[1]: Queued start job for default target Initrd Default Target.1569machine # [ 1.782674] systemd[1]: Created slice Slice /system/modprobe.1570machine # [ 1.782955] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1571machine # [ 1.782989] systemd[1]: Expecting device /dev/disk/by-label/nixos...1572machine # [ 1.783000] systemd[1]: Expecting device /dev/hvc0...1573machine # [ 1.783009] systemd[1]: Expecting device /dev/ttyAMA0...1574machine # [ 1.783032] systemd[1]: Reached target Path Units.1575machine # [ 1.783045] systemd[1]: Reached target Slice Units.1576machine # [ 1.783059] systemd[1]: Reached target Swaps.1577machine # [ 1.783072] systemd[1]: Reached target Timer Units.1578machine # [ 1.783269] systemd[1]: Listening on D-Bus System Message Bus Socket.1579machine # [ 1.783450] systemd[1]: Listening on Journal Socket (/dev/log).1580machine # [ 1.787816] systemd[1]: Listening on Journal Sockets.1581machine # [ 1.787935] systemd[1]: Listening on udev Kernel Socket.1582machine # [ 1.787949] systemd[1]: Reached target Socket Units.1583machine # [ 1.796228] systemd[1]: Starting Create List of Static Device Nodes...1584machine # [ 1.796325] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1585machine # [ 1.803721] systemd[1]: Mounting Kernel Configuration File System...1586machine # [ 1.817823] systemd[1]: Starting Journal Service...1587machine # [ 1.833714] systemd[1]: Starting Load Kernel Modules...1588machine # [ 1.833848] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1589machine # [ 1.860890] systemd[1]: Starting Coldplug All udev Devices...1590machine # [ 1.861500] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11591machine # [ 1.883962] systemd-journald[71]: Collecting audit messages is disabled.1592machine # [ 1.887773] systemd[1]: Finished Create List of Static Device Nodes.1593machine # [ 1.927759] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1594machine # [ 1.928608] systemd[1]: Mounted Kernel Configuration File System.1595machine # [ 1.955844] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01596machine # [ 1.980686] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1597machine # [ 1.985395] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1598machine # [ 2.004413] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1599machine # [ 2.007038] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01600machine # [ 2.007299] [drm] features: -virgl +edid -resource_blob -host_visible1601machine # [ 2.007303] [drm] features: -context_init1602machine # [ 2.012045] systemd[1]: Starting Create Static Device Nodes in /dev...1603machine # [ 2.020312] [drm] number of scanouts: 11604machine # [ 2.020333] [drm] number of cap sets: 01605machine # [ 2.025389] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1606machine # [ 2.025408] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01607machine # [ 2.047986] Console: switching to colour frame buffer device 160x501608machine # [ 2.068219] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1609machine # [ 2.074406] systemd[1]: Finished Load Kernel Modules.1610machine # [ 2.079672] usb 1-2: new high-speed USB device number 3 using ehci-pci1611machine # [ 2.081620] systemd[1]: Starting Apply Kernel Variables...1612machine # [ 2.080715] systemd-modules-load[72]: Inserted module 'dm_mod'1613machine # [ 2.082155] systemd-modules-load[72]: Module 'virtio_balloon' is built in1614machine # [ 2.083451] systemd-modules-load[72]: Module 'virtio_console' is built in1615machine # [ 2.108525] systemd[1]: Finished Create Static Device Nodes in /dev.1616machine # [ 2.109162] systemd[1]: Started Journal Service.1617machine # [ 2.098873] systemd-modules-load[72]: Inserted module 'virtio_gpu'1618machine # [ 2.104351] systemd-modules-load[72]: Module 'virtio_rng' is built in1619machine # [ 2.107827] systemd[1]: Reached target Preparation for Local File Systems.1620machine # [ 2.112559] systemd[1]: Reached target Local File Systems.1621machine # [ 2.120730] systemd[1]: Starting Create System Files and Directories...1622machine # [ 2.129436] systemd[1]: Starting Rule-based Manager for Device Events and Files...1623machine # [ 2.131667] systemd[1]: Finished Apply Kernel Variables.1624machine # [ 2.175891] systemd[1]: Finished Create System Files and Directories.1625machine # [ 2.212708] systemd-udevd[81]: Using default interface naming scheme 'v261'.1626machine # [ 2.242724] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21627machine # [ 2.243092] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01628machine # [ 2.253614] systemd[1]: Started Rule-based Manager for Device Events and Files.1629machine # [ 2.353060] systemd[1]: Starting Virtual Console Setup...1630machine # [ 2.441602] systemd-vconsole-setup[98]: Configuration of first virtual console was skipped, ignoring remaining ones.1631machine # [ 2.448586] systemd[1]: Finished Virtual Console Setup.1632machine # [ 3.104941] systemd[1]: Found device /dev/hvc0.1633machine # [ 3.135929] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1634machine # [ 3.173342] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.1635machine # [ 3.188934] systemd[1]: Finished Coldplug All udev Devices.1636machine # [ 3.191280] systemd[1]: Reached target System Initialization.1637machine # [ 3.195885] systemd[1]: Reached target Basic System.1638machine # [ 3.200234] systemd[1]: Found device /dev/ttyAMA0.1639machine # [ 3.202605] systemd[1]: Started backdoor.service.1640machine # [ 3.236412] backdoor-start[110]: /nix/store/13csj3ip6wj2nbam4hrzfp742n5g4yal-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found1641machine # connecting to host...1642machine: Guest shell says: b'Spawning backdoor root shell...\n'1643machine # [ 3.252641] systemd[1]: Found device /dev/disk/by-label/nixos.1644machine: connected to guest root shell1645machine: (connecting took 3.64 seconds)1646machine: (finished: waiting for the VM to finish booting, in 3.64 seconds)1647machine # [ 3.260136] systemd[1]: Reached target Initrd Root Device.1648machine # [ 3.264142] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1649machine # [ 3.337975] systemd-fsck[123]: nixos: clean, 225/65536 files, 15235/262144 blocks1650machine # [ 3.346363] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1651machine # [ 3.351180] systemd[1]: Mounting /sysroot...1652machine # [ 3.414621] EXT4-fs (vda): mounted filesystem ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4 r/w with ordered data mode. Quota mode: none.1653machine # [ 3.398257] systemd[1]: Mounted /sysroot.1654machine # [ 3.400493] systemd[1]: Reached target Initrd Root File System.1655machine # [ 3.404319] systemd[1]: Starting Mountpoints Configured in the Real Root...1656machine # [ 3.441791] systemd-sysroot-fstab-check[132]: /sysroot should be mounted in the initrd, will request daemon-reload.1657machine # [ 3.452278] systemd[1]: Reload requested from client PID 132 ('systemd-sysroot') (unit initrd-parse-etc.service)...1658machine # [ 3.457718] systemd[1]: Reloading...1659machine # [ 3.667843] systemd[1]: Reloading finished in 216 ms.1660machine # [ 3.699332] systemd-sysroot-fstab-check[132]: Requesting initrd-fs.target/start/replace...1661machine # [ 3.704507] systemd-sysroot-fstab-check[132]: Requesting swap.target/start/replace...1662machine # [ 3.711655] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1663machine # [ 3.714711] systemd[1]: Finished Mountpoints Configured in the Real Root.1664machine # [ 3.715724] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1665machine # [ 3.845505] systemd[1]: Mounting /sysroot/nix/.ro-store...1666machine # [ 3.864323] systemd[1]: Mounting /sysroot/nix/.rw-store...1667machine # [ 3.873340] systemd[1]: Mounting /sysroot/run...1668machine # [ 3.898881] systemd[1]: Mounting /sysroot/tmp/shared...1669machine # [ 3.928687] systemd[1]: Mounting /sysroot/tmp/xchg...1670machine # [ 4.001717] fuse: init (API version 7.45)1671machine # [ 3.983120] systemd[1]: Mounted /sysroot/nix/.rw-store.1672machine # [ 4.015776] virtiofs virtio6: discovered new tag: nix-store1673machine # [ 4.016691] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1674machine # [ 4.016252] systemd[1]: Starting rw-sysroot-nix-store.service...1675machine # [ 4.042337] virtiofs virtio7: discovered new tag: shared1676machine # [ 4.043262] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1677machine # [ 4.054287] virtiofs virtio8: discovered new tag: xchg1678machine # [ 4.055160] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1679machine # [ 4.044139] systemd[1]: Mounted /sysroot/run.1680machine # [ 4.070011] systemd[1]: Mounted /sysroot/nix/.ro-store.1681machine # [ 4.074062] systemd[1]: Mounted /sysroot/tmp/shared.1682machine # [ 4.075167] systemd[1]: Mounted /sysroot/tmp/xchg.1683machine # [ 4.077180] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1684machine # [ 4.082287] systemd[1]: Finished rw-sysroot-nix-store.service.1685machine # [ 4.094089] systemd[1]: Mounting /sysroot/nix/store...1686machine # [ 4.230543] systemd[1]: Mounted /sysroot/nix/store.1687machine # [ 4.234419] systemd[1]: Reached target Initrd File Systems.1688machine # [ 4.235925] systemd[1]: Starting Find NixOS closure...1689machine # [ 4.255266] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1690machine # [ 4.304995] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1691machine # [ 4.315488] systemd[1]: Finished Find NixOS closure.1692machine # [ 4.317980] systemd[1]: Reached target Initrd Default Target.1693machine # [ 4.323669] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1694machine # [ 4.352706] systemd[1]: initrd-cleanup.service: Deactivated successfully.1695machine # [ 4.354158] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1696machine # [ 4.368590] systemd[1]: Startup finished in 1.521s (kernel) + 0 (initrd) + 2.846s (userspace) = 4.368s.1697machine: (finished: waiting for unit initrd.target, in 4.78 seconds)1698machine: waiting for the VM to finish booting1699machine # [ 4.421099] systemd[1]: Stopped target Initrd Default Target.1700machine # [ 4.423247] systemd[1]: Stopped target Basic System.1701machine # [ 4.428595] systemd[1]: Stopped target Initrd Root Device.1702machine # [ 4.429506] systemd[1]: Stopped target Path Units.1703machine # [ 4.430210] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1704machine # [ 4.431298] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1705machine # [ 4.440333] systemd[1]: Stopped target Slice Units.1706machine # [ 4.445394] systemd[1]: Stopped target Socket Units.1707machine # [ 4.446277] systemd[1]: Stopped target System Initialization.1708machine # [ 4.449708] systemd[1]: Stopped target Swaps.1709machine # [ 4.451799] systemd[1]: Stopped target Timer Units.1710machine # [ 4.456104] systemd[1]: dbus.socket: Deactivated successfully.1711machine # [ 4.458131] systemd[1]: Closed D-Bus System Message Bus Socket.1712machine # [ 4.461276] systemd[1]: Stopping backdoor.service...1713machine # [ 4.465596] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1714machine # [ 4.467688] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1715machine # [ 4.473603] systemd[1]: Stopped Find NixOS closure.1716machine # [ 4.474394] systemd[1]: Starting rw-sysroot-nix-store.service...1717machine # [ 4.475297] systemd[1]: systemd-sysctl.service: Deactivated successfully.1718machine # [ 4.481296] systemd[1]: Stopped Apply Kernel Variables.1719machine # [ 4.483123] systemd[1]: systemd-modules-load.service: Deactivated successfully.1720machine # [ 4.488414] systemd[1]: Stopped Load Kernel Modules.1721machine # [ 4.489456] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1722machine # [ 4.500191] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1723machine # [ 4.504326] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1724machine # [ 4.508535] systemd[1]: Stopped Create System Files and Directories.1725machine # [ 4.514626] systemd[1]: Stopped target Local File Systems.1726machine # [ 4.517835] systemd[1]: Stopped target Preparation for Local File Systems.1727machine # [ 4.524369] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1728machine # [ 4.527896] systemd[1]: Stopped Coldplug All udev Devices.1729machine # [ 4.529002] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1730machine # [ 4.530930] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1731machine # [ 4.532134] systemd[1]: Stopped Virtual Console Setup.1732machine # [ 4.533142] systemd[1]: backdoor.service: Deactivated successfully.1733machine # [ 4.534080] systemd[1]: Stopped backdoor.service.1734machine # [ 4.534810] systemd[1]: initrd-cleanup.service: Deactivated successfully.1735machine # [ 4.535795] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1736machine # [ 4.542413] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1737machine # [ 4.544221] systemd[1]: Finished rw-sysroot-nix-store.service.1738machine # [ 4.548336] systemd[1]: systemd-udevd.service: Deactivated successfully.1739machine # [ 4.549489] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1740machine # [ 4.552453] systemd[1]: Starting Cleanup udev Database...1741machine # [ 4.553359] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1742machine # [ 4.555199] systemd[1]: Stopped Create Static Device Nodes in /dev.1743machine # [ 4.556466] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1744machine # [ 4.557686] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1745machine # [ 4.558748] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1746machine # [ 4.559793] systemd[1]: Stopped Create List of Static Device Nodes.1747machine # [ 4.594134] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1748machine # [ 4.596483] systemd[1]: Finished Cleanup udev Database.1749machine # [ 4.598902] systemd[1]: Reached target Switch Root.1750machine # [ 4.600787] systemd[1]: Starting NixOS Activation...1751machine # [ 4.684741] initrd-nixos-activation-start[194]: booting system configuration /nix/store/gxlljyaid42bg28sszbxn94mnbx7s8xj-nixos-system-machine-test1752machine # [ 4.723797] initrd-nixos-activation-start[194]: running activation script...1753machine # [ 5.022296] initrd-nixos-activation-start[217]: setting up /etc...1754machine # [ 5.233945] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1755machine # [ 5.238016] systemd[1]: Finished NixOS Activation.1756machine # [ 5.239507] systemd[1]: Starting Switch Root...1757machine # [ 5.268500] systemd[1]: Switching root.1758machine # [ 5.446177] systemd-journald[71]: Received SIGTERM from PID 1 (systemd).1759machine # [ 5.647852] systemd[1]: systemd 263-7f073ff 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 +EXPERIMENTAL-ENVVAR)1760machine # [ 5.648776] systemd[1]: Detected virtualization qemu.1761machine # [ 5.649581] systemd[1]: Detected architecture arm64.1762machine # [ 5.815243] systemd[1]: bpf-restrict-fs: LSM BPF program attached1763machine # [ 6.274928] systemd[1]: initrd-switch-root.service: Deactivated successfully.1764machine # [ 6.275387] systemd[1]: Stopped initrd-switch-root.service.1765machine # [ 6.282391] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1766machine # [ 6.286109] systemd[1]: Created slice Slice /system/getty.1767machine # [ 6.288725] systemd[1]: Created slice User and Session Slice.1768machine # [ 6.289320] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1769machine # [ 6.290002] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1770machine # [ 6.290569] systemd[1]: Expecting device /dev/hvc0...1771machine # [ 6.291134] systemd[1]: Expecting device /dev/ttyAMA0...1772machine # [ 6.296593] systemd[1]: Reached target Local Encrypted Volumes.1773machine # [ 6.297060] systemd[1]: Stopped target initrd-fs.target.1774machine # [ 6.297728] systemd[1]: Stopped target initrd-root-fs.target.1775machine # [ 6.298333] systemd[1]: Stopped target initrd-switch-root.target.1776machine # [ 6.298933] systemd[1]: Reached target Virtual Machines and Containers.1777machine # [ 6.304197] systemd[1]: Reached target Path Units.1778machine # [ 6.304755] systemd[1]: Reached target Remote File Systems.1779machine # [ 6.305475] systemd[1]: Reached target Slice Units.1780machine # [ 6.306142] systemd[1]: Reached target Swaps.1781machine # [ 6.311872] systemd[1]: Listening on Query the User Interactively for a Password.1782machine # [ 6.319919] systemd[1]: Listening on Process Core Dump Socket.1783machine # [ 6.321534] systemd[1]: Listening on Credential Encryption/Decryption.1784machine # [ 6.322882] systemd[1]: Listening on Factory Reset Management.1785machine # [ 6.327306] systemd[1]: Listening on Hostname Service Socket.1786machine # [ 6.332676] systemd[1]: Starting Journal Log Access Socket...1787machine # [ 6.334553] systemd[1]: Listening on Journal Audit Socket.1788machine # [ 6.338458] systemd[1]: Listening on Console Output Muting Service Socket.1789machine # [ 6.339399] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1790machine # [ 6.343204] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1791machine # [ 6.347267] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1792machine # [ 6.354512] systemd[1]: Listening on Disk Repartitioning Service Socket.1793machine # [ 6.355261] systemd[1]: Listening on udev Varlink Socket.1794machine # [ 6.360546] systemd[1]: Mounting Huge Pages File System...1795machine # [ 6.365667] systemd[1]: Mounting POSIX Message Queue File System...1796machine # [ 6.393306] systemd[1]: Mounting Kernel Debug File System...1797machine # [ 6.405663] systemd[1]: Mounting Kernel Trace File System...1798machine # [ 6.420089] systemd[1]: Starting Create List of Static Device Nodes...1799machine # [ 6.424677] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1800machine # [ 6.453735] systemd[1]: Mounting Kernel Configuration File System...1801machine # [ 6.454382] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1802machine # [ 6.458593] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1803machine # [ 6.462001] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1804machine # [ 6.492209] systemd[1]: Mounting FUSE Control File System...1805machine # [ 6.492796] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671806machine # [ 6.538884] systemd[1]: Starting Journal Service...1807machine # [ 6.563446] systemd[1]: Starting Load Kernel Modules...1808machine # [ 6.591198] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1809machine # [ 6.630681] systemd[1]: Starting Remount Root and Kernel File Systems...1810machine # [ 6.631165] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1811machine # [ 6.671224] systemd-journald[289]: Collecting audit messages is enabled.1812machine # [ 6.673013] systemd[1]: Starting Coldplug All udev Devices...1813machine # [ 6.686255] systemd[1]: Listening on Journal Log Access Socket.1814machine # [ 6.686833] systemd[1]: Mounted Huge Pages File System.1815machine # [ 6.687306] systemd[1]: Mounted POSIX Message Queue File System.1816machine # [ 6.673533] systemd[1]: Queued start job for default target Multi-User System.1817machine # [ 6.679840] systemd[1]: Unnecessary job was removed for /sys/devices/virtual/tty/hvc0.[ 6.700414] systemd[1]: Started Journal Service.1818machine # 1819machine # [ 6.689156] systemd[1]: Unnecessary job was removed for /sys/devices/platform/9000000.pl011/9000000.pl011:0/9000000.pl011:0.0/tty/ttyAMA0.1820machine # [ 6.691173] systemd[1]: systemd-journald.service: Deactivated successfully.1821machine # [ 6.701024] systemd-modules-load[290]: Module 'atkbd' is built in1822machine # [ 6.702254] systemd-modules-load[290]: Module 'loop' is built in1823machine # [ 6.703365] systemd[1]: Mounted Kernel Debug File System.1824machine # [ 6.718617] systemd[1]: Mounted Kernel Trace File System.1825machine # [ 6.719764] systemd[1]: Finished Create List of Static Device Nodes.1826machine # [ 6.725104] systemd[1]: Finished Load Kernel Modules.1827machine # [ 6.752274] systemd[1]: Starting Firewall...1828machine # [ 6.770025] systemd[1]: Starting Apply Kernel Variables...1829machine # [ 6.799664] EXT4-fs (vda): re-mounted ee1e8b72-05e1-4d58-a37b-7c6e2ff342b4.1830machine # [ 6.789457] systemd-oomd[291]: No swap; memory pressure usage will be degraded1831machine # [ 6.814490] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1832machine # [ 6.817326] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1833machine # [ 6.827407] systemd[1]: Finished Remount Root and Kernel File Systems.1834machine # [ 6.828758] systemd[1]: Mounted Kernel Configuration File System.1835machine # [ 6.829777] systemd[1]: Mounted FUSE Control File System.1836machine # [ 6.843902] systemd[1]: Listening on Disk Image Download Service Socket.1837machine # [ 6.880436] systemd[1]: Starting Grow Root File System...1838machine # [ 6.899474] systemd[1]: Starting Flush Journal to Persistent Storage...1839machine # [ 6.905650] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1840machine # [ 6.927424] systemd[1]: Starting Load/Save OS Random Seed...1841machine # [ 6.944345] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1842machine # [ 7.141041] EXT4-fs (vda): resizing filesystem from 262144 to 524288 blocks1843machine # [ 7.140515] systemd[1]: Finished Apply Kernel Variables.1844machine # [ 7.175560] systemd-journald[289]: Received client request to flush runtime journal.1845machine # [ 7.211724] EXT4-fs (vda): resized filesystem to 5242881846machine # [ 7.309123] systemd-growfs[310]: Successfully resized "/" to 2G bytes.1847machine # [ 7.312262] systemd[1]: Finished Grow Root File System.1848machine # [ 7.313390] systemd[1]: Finished Load/Save OS Random Seed.1849machine # [ 7.314267] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes1850machine # [ 7.315570] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1851machine # [ 7.330004] systemd[1]: Starting Create Static Device Nodes in /dev...1852machine # [ 7.331134] systemd[1]: Finished Flush Journal to Persistent Storage.1853machine # [ 7.465376] systemd[1]: Finished Create Static Device Nodes in /dev.1854machine # [ 7.468003] systemd[1]: Reached target Preparation for Local File Systems.1855machine # [ 7.482751] systemd[1]: Mounting /run/wrappers...1856machine # [ 7.492252] systemd[1]: Starting Rule-based Manager for Device Events and Files...1857machine # [ 7.585314] systemd[1]: Mounted /run/wrappers.1858machine # [ 7.586173] systemd[1]: Reached target Local File Systems.1859machine # [ 7.592951] systemd[1]: Listening on Boot Loader Control Service Socket.1860machine # [ 7.600131] systemd[1]: Starting Create SUID/SGID Wrappers...1861machine # [ 7.608326] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1862machine # [ 7.609882] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id1863machine # [ 7.624319] systemd[1]: Starting Create System Files and Directories...1864machine # [ 7.751488] systemd-udevd[333]: Using default interface naming scheme 'v261'.1865machine # [ 7.907642] systemd[1]: Finished Create System Files and Directories.1866machine # [ 7.925280] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var1867machine # [ 7.935230] systemd[1]: Update is Completed skipped, no trigger condition checks were met.1868machine # [ 7.950136] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1869machine # [ 8.028937] systemd[1]: Started Rule-based Manager for Device Events and Files.1870machine # [ 8.085002] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1871machine # [ 8.958869] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1872machine # [ 8.968368] systemd[1]: Finished Create SUID/SGID Wrappers.1873machine # [ 9.276769] systemd[1]: Finished Coldplug All udev Devices.1874machine # [ 9.278251] systemd[1]: Reached target System Initialization.1875machine # [ 9.281633] systemd[1]: Started Discard unused filesystem blocks once a week.1876machine # [ 9.282840] systemd[1]: Started Daily Cleanup of Temporary Directories.1877machine # [ 9.283801] systemd[1]: Reached target Timer Units.1878machine # [ 9.291124] systemd[1]: Listening on D-Bus System Message Bus Socket.1879machine # [ 9.294547] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1880machine # [ 9.295905] systemd[1]: Reached target Socket Units.1881machine # [ 9.305328] systemd[1]: Reached target Basic System.1882machine # [ 9.306241] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db1883machine # [ 9.317050] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1884machine # [ 9.321270] systemd[1]: Starting Post-Boot Actions...1885machine # [ 9.325583] systemd[1]: Started Reset console on configuration changes.1886machine # [ 9.333338] systemd[1]: Starting resolvconf update...1887machine # [ 9.395534] systemd[1]: Starting D-Bus System Message Bus...1888machine # [ 9.507110] systemd[1]: Finished Post-Boot Actions.1889machine # [ 9.536605] systemd[1]: Started Name Service Cache Daemon (nsncd).1890machine # [ 9.537771] systemd[1]: Reached target Host and Network Name Lookups.1891machine # [ 9.538766] systemd[1]: Reached target User and Group Name Lookups.1892machine # [ 9.570315] systemd[1]: Starting User Login Management...1893machine # [ 9.596154] nsncd[456]: Oct 15 02:56:12.610 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1894machine # [ 9.774694] dbus-broker-launch[462]: Looking up NSS user entry for 'systemd-timesync'...1895machine # [ 9.813458] dbus-broker-launch[462]: NSS returned no entry for 'systemd-timesync'1896machine # [ 9.815137] dbus-broker-launch[462]: Invalid user-name in /nix/store/10ndnr17zcaw1kn44jrabk4ak1sdx8cn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1897machine # [ 9.917173] systemd[1]: Started D-Bus System Message Bus.1898machine # [ 9.942289] systemd-logind[478]: New seat seat0.1899machine # [ 9.952449] systemd[1]: Started User Login Management.1900machine # [ 9.961892] systemd[1]: Starting linger-users.service...1901machine # [ 9.990353] dbus-broker-launch[462]: Ready1902machine # [ 10.070065] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input31903machine # [ 10.064764] systemd[1]: Stopped target Host and Network Name Lookups.1904machine # [ 10.070646] systemd[1]: Stopping Host and Network Name Lookups...1905machine # [ 10.071790] systemd[1]: Stopped target User and Group Name Lookups.1906machine # [ 10.082918] systemd[1]: Stopping User and Group Name Lookups...1907machine # [ 10.083908] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1908machine # [ 10.092567] systemd[1]: nscd.service: Deactivated successfully.1909machine # [ 10.093550] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1910machine # [ 10.105185] systemd[1]: linger-users.service: Deactivated successfully.1911machine # [ 10.108540] systemd[1]: Finished linger-users.service.1912machine # [ 10.132319] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1913machine # [ 10.243645] systemd[1]: Started Name Service Cache Daemon (nsncd).1914machine # [ 10.249659] nsncd[540]: Oct 15 02:56:13.322 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1915machine # [ 10.263189] systemd[1]: Reached target Host and Network Name Lookups.1916machine # [ 10.268153] systemd[1]: Reached target User and Group Name Lookups.1917machine # [ 10.320426] systemd[1]: Finished resolvconf update.1918machine # [ 10.325841] systemd[1]: Starting DHCP Client...1919machine # [ 10.603390] dhcpcd[584]: dhcpcd-10.3.2 starting1920machine # [ 10.622108] dhcpcd[593]: dev: loaded udev1921machine # [ 10.627241] dhcpcd[593]: DUID 00:01:00:01:32:62:fd:35:52:54:00:12:34:561922machine # [ 10.629405] dhcpcd[593]: no valid interfaces found1923machine # [ 10.630192] dhcpcd[593]: no valid interfaces found1924machine # [ 10.633173] dhcpcd[593]: libudev: received NULL device1925machine # [ 10.634047] dhcpcd[593]: libudev: received NULL device1926machine # [ 10.676155] systemd[1]: Finished Firewall.1927machine # [ 10.681187] systemd[1]: Reached target Preparation for Network.1928machine # [ 10.686048] systemd[1]: Starting Extra networking commands....1929machine # [ 11.006393] systemd[1]: Starting Virtual Console Setup...1930machine # [ 11.069833] systemd[1]: Finished Extra networking commands..1931machine # [ 11.074756] systemd[1]: Reached target Network.1932machine # [ 11.086524] systemd[1]: Starting Permit User Sessions...1933machine # [ 11.107676] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1934machine # [ 11.115355] systemd[1]: Stopped Virtual Console Setup.1935machine # [ 11.143212] systemd[1]: Starting Virtual Console Setup...1936machine # [ 11.169576] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1937machine # [ 11.194716] systemd[1]: Finished Permit User Sessions.1938machine # [ 11.206377] systemd[1]: Started Getty on tty1.1939machine # [ 11.213040] systemd[1]: Reached target Login Prompts.1940machine # [ 11.413498] systemd[1]: Found device /dev/hvc0.1941machine # [ 11.434925] systemd[1]: Found device /dev/ttyAMA0.1942machine # [ 11.441993] systemd[1]: Started backdoor.service.1943machine # connecting to host...1944machine: Guest shell says: b'Spawning backdoor root shell...\n'1945machine: connected to guest root shell1946machine: (connecting took 7.20 seconds)1947machine: (finished: waiting for the VM to finish booting, in 7.20 seconds)1948machine: must succeed: df --output=avail / | sed 1d1949machine # [ 11.644719] 8021q: 802.1Q VLAN Support v1.81950machine # [ 11.683534] (udev-worker)[634]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1951machine # [ 11.713253] (udev-worker)[634]: Network interface NamePolicy= disabled on kernel command line.1952machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.13 seconds)1953(finished: subtest: growfs works, in 17.04 seconds)1954subtest: no warnings from systemd about write permissions1955machine: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges'1956machine # [ 11.838818] cfg80211: Loading compiled-in X.509 certificates for regulatory database1957machine: (finished: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges', in 0.10 seconds)1958(finished: subtest: no warnings from systemd about write permissions, in 0.10 seconds)1959(finished: run the VM test script, in 43.46 seconds)1960machine # [ 11.880807] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1961machine # [ 11.881388] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1962machine # [ 11.887583] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21963machine # [ 11.887932] cfg80211: failed to load regulatory.db1964test script finished in 43.58s1965cleanup1966kill QemuMachine (pid 87)1967machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)1968machine # [2026-10-15T02:56:15Z INFO virtiofsd] Client disconnected, shutting down1969machine # [2026-10-15T02:56:15Z INFO virtiofsd] Client disconnected, shutting down1970machine # [2026-10-15T02:56:15Z INFO virtiofsd] Client disconnected, shutting down1971(finished: cleanup, in 0.16 seconds)