vm-test-run-systemd-cryptenroll
checks.aarch64-linux.systemd-cryptenroll
· build #37
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600.0 seconds6run the VM test script7machine: starting vm8machine # Disk image does not exist, creating the virtualisation disk image...9machine: QEMU running (pid 45)10machine # Formatting '/build/vm-state-machine/tmp.2TdmoLF6rG', fmt=raw size=107374182411machine # mke2fs 1.47.4 (6-Mar-2025)12machine: must succeed: test -e /dev/tpm013machine # Discarding device blocks: 0/262144 done14machine: waiting for the VM to finish booting15machine # Creating filesystem with 262144 4k blocks and 65536 inodes16machine # Filesystem UUID: 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d017machine # Superblock backups stored on blocks:18machine # 32768, 98304, 163840, 22937619machine # 20machine # Allocating group tables: 0/8 done21machine # Writing inode tables: 0/8 done22machine # Creating journal (8192 blocks): done23machine # Writing superblocks and filesystem accounting information: 0/8 done24machine # 25machine # Virtualisation disk image created.26machine # Formatting 'empty0.qcow2', fmt=qcow2 cluster_size=65536 extended_l2=off compression_type=zlib size=536870912 lazy_refcounts=off refcount_bits=1627machine # Starting virtiofs daemons...28machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33machine # [2026-09-15T21:17:55Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34machine # [2026-09-15T21:17:55Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-09-15T21:17:55Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-15T21:17:55Z INFO virtiofsd] Waiting for vhost-user socket connection...37machine # [2026-09-15T21:17:55Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-15T21:17:55Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-09-15T21:17:55Z INFO virtiofsd] Client connected, servicing requests40machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]41machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 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 0x7fded4c0-0x7fdf0c3f]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 s186648 r8192 d116456 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/2pw2gj2rhiqgwryjc5qyfwffmfa9w3q1-nixos-system-machine-test/init regInfo=/nix/store/37b8k4br8ji3vw1az7xxp6jf8066qpy7-closure-info/registration console=ttyAMA0,115200n8 console=tty075machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/37b8k4br8ji3vw1az7xxp6jf8066qpy7-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 74894 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 @44cf0000 (indirect, esz 8, psz 64K, shr 1)110machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (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.000032] arm-pv: using stolen time PV119machine # [ 0.000409] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)120machine # [ 0.000619] Console: colour dummy device 80x25121machine # [ 0.000628] printk: legacy console [tty0] enabled122machine # [ 0.000860] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)123machine # [ 0.000868] pid_max: default: 32768 minimum: 301124machine # [ 0.000947] LSM: initializing lsm=capability,landlock,yama,bpf,ima125machine # [ 0.001080] landlock: Up and running.126machine # [ 0.001084] Yama: becoming mindful.127machine # [ 0.001537] LSM support for eBPF active128machine # [ 0.001671] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.001690] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)130machine # [ 0.002879] cacheinfo: Unable to detect cache hierarchy for CPU 0131machine # [ 0.003622] rcu: Hierarchical SRCU implementation.132machine # [ 0.003626] rcu: Max phase no-delay instances is 1000.133machine # [ 0.004879] fsl-mc MSI: its@8080000 domain created134machine # [ 0.004973] EFI services will not be available.135machine # [ 0.005091] smp: Bringing up secondary CPUs ...136machine # [ 0.005100] smp: Brought up 1 node, 1 CPU137machine # [ 0.005103] SMP: Total of 1 processors activated.138machine # [ 0.005106] CPU: All CPU(s) started at EL1139machine # [ 0.005119] CPU features: detected: Branch Target Identification140machine # [ 0.005124] CPU features: detected: ARMv8.4 Translation Table Level141machine # [ 0.005127] CPU features: detected: Instruction cache invalidation not required for I/D coherence142machine # [ 0.005131] CPU features: detected: Data cache clean to the PoU not required for I/D coherence143machine # [ 0.005134] CPU features: detected: Common not Private translations144machine # [ 0.005138] CPU features: detected: CRC32 instructions145machine # [ 0.005140] CPU features: detected: Data cache clean to Point of Deep Persistence146machine # [ 0.005144] CPU features: detected: Data cache clean to Point of Persistence147machine # [ 0.005147] CPU features: detected: Data independent timing control (DIT)148machine # [ 0.005150] CPU features: detected: E0PD149machine # [ 0.005152] CPU features: detected: Enhanced Counter Virtualization150machine # [ 0.005155] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)151machine # [ 0.005158] CPU features: detected: Enhanced Virtualization Traps152machine # [ 0.005161] CPU features: detected: Fine Grained Traps153machine # [ 0.005165] CPU features: detected: Generic authentication (architected QARMA5 algorithm)154machine # [ 0.005171] CPU features: detected: RCpc load-acquire (LDAPR)155machine # [ 0.005174] CPU features: detected: LSE atomic instructions156machine # [ 0.005177] CPU features: detected: Privileged Access Never157machine # [ 0.005179] CPU features: detected: PMUv3158machine # [ 0.005182] CPU features: detected: RAS Extension Support159machine # [ 0.005185] CPU features: detected: RASv1p1 Extension Support160machine # [ 0.005187] CPU features: detected: Random Number Generator161machine # [ 0.005190] CPU features: detected: Speculation barrier (SB)162machine # [ 0.005193] CPU features: detected: Stage-2 Force Write-Back163machine # [ 0.005196] CPU features: detected: TLB range maintenance instructions164machine # [ 0.005201] CPU features: detected: Speculative Store Bypassing Safe (SSBS)165machine # [ 0.005238] alternatives: applying system-wide alternatives166machine # [ 0.008321] CPU features: detected: BBM Level 2 without TLB conflict abort167machine # [ 0.008549] Memory: 893788K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113244K reserved, 32768K cma-reserved)168machine # [ 0.008910] devtmpfs: initialized169machine # [ 0.010730] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)170machine # [ 0.010754] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).171machine # [ 0.010941] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL172machine # [ 0.010945] 0 pages in range for non-PLT usage173machine # [ 0.010946] 508288 pages in range for PLT usage174machine # [ 0.011040] pinctrl core: initialized pinctrl subsystem175machine # [ 0.011792] DMI not present or invalid.176machine # [ 0.014966] NET: Registered PF_NETLINK/PF_ROUTE protocol family177machine # [ 0.017481] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations178machine # [ 0.017630] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations179machine # [ 0.017792] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations180machine # [ 0.017815] audit: initializing netlink subsys (disabled)181machine # [ 0.018401] thermal_sys: Registered thermal governor 'fair_share'182machine # [ 0.018403] thermal_sys: Registered thermal governor 'bang_bang'183machine # [ 0.018407] thermal_sys: Registered thermal governor 'step_wise'184machine # [ 0.018410] thermal_sys: Registered thermal governor 'user_space'185machine # [ 0.018415] thermal_sys: Registered thermal governor 'power_allocator'186machine # [ 0.018440] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1187machine # [ 0.018449] cpuidle: using governor ladder188machine # [ 0.018454] cpuidle: using governor menu189machine # [ 0.018677] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.190machine # [ 0.018694] ASID allocator initialised with 65536 entries191machine # [ 0.019874] Serial: AMBA PL011 UART driver192machine # [ 0.025141] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1193machine # [ 0.025298] printk: console [ttyAMA0] enabled194machine # [ 0.152118] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages195machine # [ 0.152142] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page196machine # [ 0.152148] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages197machine # [ 0.152152] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page198machine # [ 0.152157] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages199machine # [ 0.152167] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page200machine # [ 0.152172] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages201machine # [ 0.152176] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page202machine # [ 0.159877] fbcon: Taking over console203machine # [ 0.159895] ACPI: Interpreter disabled.204machine # [ 0.161789] iommu: Default domain type: Translated205machine # [ 0.161800] iommu: DMA domain TLB invalidation policy: strict mode206machine # [ 0.163613] SCSI subsystem initialized207machine # [ 0.170731] usbcore: registered new interface driver usbfs208machine # [ 0.170756] usbcore: registered new interface driver hub209machine # [ 0.170784] usbcore: registered new device driver usb210machine # [ 0.171084] pps_core: LinuxPPS API ver. 1 registered211machine # [ 0.171091] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>212machine # [ 0.171101] PTP clock support registered213machine # [ 0.171152] EDAC MC: Ver: 3.0.0214machine # [ 0.176045] scmi_core: SCMI protocol bus registered215machine # [ 0.177103] FPGA manager framework216machine # [ 0.178194] vgaarb: loaded217machine # [ 0.178874] clocksource: Switched to clocksource arch_sys_counter218machine # [ 0.180904] VFS: Disk quotas dquot_6.6.0219machine # [ 0.180935] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)220machine # [ 0.184887] netfs: FS-Cache loaded221machine # [ 0.185006] pnp: PnP ACPI: disabled222machine # [ 0.188964] NET: Registered PF_INET protocol family223machine # [ 0.189127] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)224machine # [ 0.220005] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)225machine # [ 0.220065] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)226machine # [ 0.220093] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)227machine # [ 0.220144] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)228machine # [ 0.220220] TCP: Hash tables configured (established 8192 bind 8192)229machine # [ 0.220334] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)230machine # [ 0.220391] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)231machine # [ 0.220418] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)232machine # [ 0.220520] NET: Registered PF_UNIX/PF_LOCAL protocol family233machine # [ 0.220560] NET: Registered PF_XDP protocol family234machine # [ 0.220583] PCI: CLS 0 bytes, default 64235machine # [ 0.220855] Trying to unpack rootfs image as initramfs...236machine # [ 0.236833] kvm [1]: HYP mode not available237machine # [ 0.355451] Initialise system trusted keyrings238machine # [ 0.356242] workingset: timestamp_bits=42 max_order=18 bucket_order=0239machine # [ 0.357573] squashfs: version 4.0 (2009/01/31) Phillip Lougher240machine # [ 0.358421] 9p: Installing v9fs 9p2000 file system support241machine # [ 0.387226] Key type asymmetric registered242machine # [ 0.387257] Asymmetric key parser 'x509' registered243machine # [ 0.387329] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)244machine # [ 0.389571] io scheduler mq-deadline registered245machine # [ 0.389585] io scheduler kyber registered246machine # [ 0.399123] pl061_gpio 9030000.pl061: PL061 GPIO chip registered247machine # [ 0.400578] ledtrig-cpu: registered to indicate activity on CPUs248machine # [ 0.400947] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:249machine # [ 0.400965] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000250machine # [ 0.400977] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000251machine # [ 0.400986] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000252machine # [ 0.401010] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits253machine # [ 0.401035] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]254machine # [ 0.401112] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00255machine # [ 0.401122] pci_bus 0000:00: root bus resource [bus 00-ff]256machine # [ 0.401128] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]257machine # [ 0.401133] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]258machine # [ 0.401138] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]259machine # [ 0.401211] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint260machine # [ 0.401671] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint261machine # [ 0.401860] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]262machine # [ 0.401877] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]263machine # [ 0.401907] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]264machine # [ 0.401924] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]265machine # [ 0.402412] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint266machine # [ 0.402606] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]267machine # [ 0.402622] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]268machine # [ 0.402652] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]269machine # [ 0.423106] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint270machine # [ 0.423299] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]271machine # [ 0.423316] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]272machine # [ 0.423346] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]273machine # [ 0.423801] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint274machine # [ 0.423983] pci 0000:00:04.0: BAR 0 [io 0x0000-0x007f]275machine # [ 0.423999] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]276machine # [ 0.424029] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277machine # [ 0.424484] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint278machine # [ 0.424674] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]279machine # [ 0.424690] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]280machine # [ 0.424721] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]281machine # [ 0.424739] pci 0000:00:05.0: ROM [mem 0x00000000-0x0003ffff pref]282machine # [ 0.425204] pci 0000:00:06.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint283machine # [ 0.425394] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]284machine # [ 0.425425] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]285machine # [ 0.425880] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint286machine # [ 0.426123] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]287machine # [ 0.426154] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]288machine # [ 0.426558] pci 0000:00:08.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint289machine # [ 0.426741] pci 0000:00:08.0: BAR 0 [mem 0x00000000-0x00000fff]290machine # [ 0.451229] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint291machine # [ 0.451456] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.451489] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.451994] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint294machine # [ 0.452185] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]295machine # [ 0.452215] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]296machine # [ 0.452678] pci 0000:00:0b.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint297machine # [ 0.452865] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]298machine # [ 0.452895] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]299machine # [ 0.453349] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint300machine # [ 0.453658] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x003f]301machine # [ 0.453677] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]302machine # [ 0.453711] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]303machine # [ 0.454197] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint304machine # [ 0.454384] pci 0000:00:0d.0: BAR 0 [io 0x0000-0x001f]305machine # [ 0.454400] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]306machine # [ 0.454430] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]307machine # [ 0.455051] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned308machine # [ 0.455063] pci 0000:00:05.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned309machine # [ 0.455069] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned310machine # [ 0.455115] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned311machine # [ 0.455164] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned312machine # [ 0.455213] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned313machine # [ 0.455261] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned314machine # [ 0.455315] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned315machine # [ 0.455364] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned316machine # [ 0.455413] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned317machine # [ 0.455463] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned318machine # [ 0.455510] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned319machine # [ 0.455560] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned320machine # [ 0.455668] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned321machine # [ 0.455726] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned322machine # [ 0.455748] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned323machine # [ 0.455771] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned324machine # [ 0.455797] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned325machine # [ 0.455819] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned326machine # [ 0.455840] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned327machine # [ 0.455863] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned328machine # [ 0.455885] pci 0000:00:08.0: BAR 0 [mem 0x10087000-0x10087fff]: assigned329machine # [ 0.455908] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned330machine # [ 0.455931] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned331machine # [ 0.455956] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned332machine # [ 0.455979] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned333machine # [ 0.456005] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned334machine # [ 0.456036] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned335machine # [ 0.456058] pci 0000:00:04.0: BAR 0 [io 0x1080-0x10ff]: assigned336machine # [ 0.456079] pci 0000:00:0c.0: BAR 0 [io 0x1100-0x113f]: assigned337machine # [ 0.456102] pci 0000:00:01.0: BAR 0 [io 0x1140-0x115f]: assigned338machine # [ 0.456123] pci 0000:00:02.0: BAR 0 [io 0x1160-0x117f]: assigned339machine # [ 0.456148] pci 0000:00:05.0: BAR 0 [io 0x1180-0x119f]: assigned340machine # [ 0.456170] pci 0000:00:0d.0: BAR 0 [io 0x11a0-0x11bf]: assigned341machine # [ 0.456198] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]342machine # [ 0.456208] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]343machine # [ 0.456213] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]344machine # [ 0.457162] pci 0000:00:08.0: enabling device (0000 -> 0002)345machine # [ 0.533706] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)346machine # [ 0.540307] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)347machine # [ 0.542591] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)348machine # [ 0.552488] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)349machine # [ 0.554630] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)350machine # [ 0.566046] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)351machine # [ 0.572731] virtio-pci 0000:00:07.0: enabling device (0000 -> 0002)352machine # [ 0.574745] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)353machine # [ 0.584557] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)354machine # [ 0.586708] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0002)355machine # [ 0.597597] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)356machine # [ 0.604374] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0003)357machine # [ 0.617550] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled358machine # [ 0.620233] msm_serial: driver initialized359machine # [ 0.620394] SuperH (H)SCI(F) driver initialized360machine # [ 0.620446] STM32 USART driver initialized361machine # [ 0.657108] loop: module loaded362machine # [ 0.657334] virtio_blk virtio2: 1/0/0 default/read/poll queues363machine # [ 0.658234] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)364machine # [ 0.663105] virtio_blk virtio3: 1/0/0 default/read/poll queues365machine # [ 0.663816] virtio_blk virtio3: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)366machine # [ 0.679650] megasas: 07.734.00.00-rc1367machine # [ 0.680409] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]368machine # [ 0.682583] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000369machine # [ 0.682614] Intel/Sharp Extended Query Table at 0x0031370machine # [ 0.684578] Using buffer write method371machine # [ 0.684638] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]372machine # [ 0.686708] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000373machine # [ 0.686735] Intel/Sharp Extended Query Table at 0x0031374machine # [ 0.696482] Using buffer write method375machine # [ 0.696520] Concatenating MTD devices:376machine # [ 0.696525] (0): "0.flash"377machine # [ 0.696529] (1): "0.flash"378machine # [ 0.696532] into device "0.flash"379machine # [ 0.989720] Freeing initrd memory: 26388K380machine # [ 0.996030] tun: Universal TUN/TAP device driver, 1.6381machine # [ 1.000200] thunder_xcv, ver 1.0382machine # [ 1.000250] thunder_bgx, ver 1.0383machine # [ 1.000273] nicpf, ver 1.0384machine # [ 1.000849] e1000: Intel(R) PRO/1000 Network Driver385machine # [ 1.000857] e1000: Copyright (c) 1999-2006 Intel Corporation.386machine # [ 1.000885] e1000e: Intel(R) PRO/1000 Network Driver387machine # [ 1.000894] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.388machine # [ 1.000926] igb: Intel(R) Gigabit Ethernet Network Driver389machine # [ 1.000932] igb: Copyright (c) 2007-2014 Intel Corporation.390machine # [ 1.000954] igbvf: Intel(R) Gigabit Virtual Function Network Driver391machine # [ 1.000960] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.392machine # [ 1.001094] sky2: driver version 1.30393machine # [ 1.002691] usbcore: registered new interface driver usb-storage394machine # [ 1.002783] usbcore: registered new interface driver usbserial_generic395machine # [ 1.002798] usbserial: USB Serial support registered for generic396machine # [ 1.013308] hv_vmbus: registering driver hyperv_keyboard397machine # [ 1.014776] ehci-pci 0000:00:08.0: EHCI Host Controller398machine # [ 1.014814] ehci-pci 0000:00:08.0: new USB bus registered, assigned bus number 1399machine # [ 1.015171] ehci-pci 0000:00:08.0: irq 17, io mem 0x10087000400machine # [ 1.018601] rtc-pl031 9010000.pl031: registered as rtc0401machine # [ 1.018639] rtc-pl031 9010000.pl031: setting system clock to 2026-09-15T21:17:57 UTC (1789507077)402machine # [ 1.020823] i2c_dev: i2c /dev entries driver403machine # [ 1.024550] sdhci: Secure Digital Host Controller Interface driver404machine # [ 1.024565] sdhci: Copyright(c) Pierre Ossman405machine # [ 1.024828] Synopsys Designware Multimedia Card Interface Driver406machine # [ 1.025207] sdhci-pltfm: SDHCI platform and OF driver helper407machine # [ 1.026780] hid: raw HID events driver (C) Jiri Kosina408machine # [ 1.026935] ehci-pci 0000:00:08.0: USB 2.0 started, EHCI 1.00409machine # [ 1.027251] hub 1-0:1.0: USB hub found410machine # [ 1.027272] hub 1-0:1.0: 6 ports detected411machine # [ 1.032994] usbcore: registered new interface driver usbhid412machine # [ 1.033004] usbhid: USB HID core driver413machine # [ 1.035447] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available414machine # [ 1.036989] drop_monitor: Initializing network drop monitor service415machine # [ 1.037205] NET: Registered PF_INET6 protocol family416machine # [ 1.040332] Segment Routing with IPv6417machine # [ 1.040355] In-situ OAM (IOAM) with IPv6418machine # [ 1.040396] NET: Registered PF_PACKET protocol family419machine # [ 1.042110] 9pnet: Installing 9P2000 support420machine # [ 1.042163] Key type dns_resolver registered421machine # [ 1.049132] registered taskstats version 1422machine # [ 1.049304] Loading compiled-in X.509 certificates423machine # [ 1.058348] Demotion targets for Node 0: null424machine # [ 1.058484] Key type .fscrypt registered425machine # [ 1.058492] Key type fscrypt-provisioning registered426machine # [ 1.058610] ima: No TPM chip found, activating TPM-bypass!427machine # [ 1.058631] ima: Allocated hash algorithm: sha1428machine # [ 1.058660] ima: No architecture policies found429machine # [ 1.063084] input: gpio-keys as /devices/platform/gpio-keys/input/input0430machine # [ 1.082602] clk: Disabling unused clocks431machine # [ 1.082635] PM: genpd: Disabling unused power domains432machine # [ 1.086926] Freeing unused kernel memory: 4736K433machine # [ 1.087131] Run /init as init process434machine # [ 1.105485] systemd[1]: Successfully made /usr/ read-only.435machine # [ 1.278975] usb 1-1: new high-speed USB device number 2 using ehci-pci436machine # [ 1.435906] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1437machine # [ 1.443255] systemd[1]: systemd 262-e2c8482 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)438machine # [ 1.443332] systemd[1]: Detected virtualization qemu.439machine # [ 1.443514] systemd[1]: Detected architecture arm64.440machine # [ 1.443548] systemd[1]: Running in initrd.441machine # [ 1.444820] systemd[1]: Initializing machine ID from random generator.442machine # [ 1.445195] systemd[1]: Hostname set to <machine>.443machine # [ 1.527213] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:08.0-1/input0444machine # [ 1.636134] systemd[1]: bpf-restrict-fs: LSM BPF program attached445machine # [ 1.651010] usb 1-2: new high-speed USB device number 3 using ehci-pci446machine # [ 1.693998] systemd[1]: Queued start job for default target Initrd Default Target.447machine # [ 1.700861] systemd[1]: Created slice Slice /system/modprobe.448machine # [ 1.701863] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.449machine # [ 1.703140] systemd[1]: Expecting device /dev/disk/by-label/nixos...450machine # [ 1.704007] systemd[1]: Reached target Path Units.451machine # [ 1.704672] systemd[1]: Reached target Slice Units.452machine # [ 1.705347] systemd[1]: Reached target Swaps.453machine # [ 1.705966] systemd[1]: Reached target Timer Units.454machine # [ 1.706810] systemd[1]: Listening on D-Bus System Message Bus Socket.455machine # [ 1.707926] systemd[1]: Listening on Journal Socket (/dev/log).456machine # [ 1.708864] systemd[1]: Listening on Journal Sockets.457machine # [ 1.709643] systemd[1]: Listening on udev Kernel Socket.458machine # [ 1.710392] systemd[1]: Reached target Socket Units.459machine # [ 1.712724] systemd[1]: Starting Create List of Static Device Nodes...460machine # [ 1.712799] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs461machine # [ 1.722842] systemd[1]: Mounting Kernel Configuration File System...462machine # [ 1.731327] systemd[1]: Starting Journal Service...463machine # [ 1.747078] systemd[1]: Starting Load Kernel Modules...464machine # [ 1.747220] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os465machine # [ 1.759067] systemd[1]: Starting Coldplug All udev Devices...466machine # [ 1.775472] systemd[1]: Finished Create List of Static Device Nodes.467machine # [ 1.776282] systemd[1]: Mounted Kernel Configuration File System.468machine # [ 1.787464] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...469machine # [ 1.805068] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2470machine # [ 1.807233] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:08.0-2/input0471machine # [ 1.832805] systemd-journald[72]: Collecting audit messages is disabled.472machine # [ 1.841015] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.473machine # [ 1.851451] systemd[1]: Starting Create Static Device Nodes in /dev...474machine # [ 1.859269] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.475machine # [ 1.871628] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev476machine # [ 1.877907] [drm] pci: virtio-gpu-pci detected at 0000:00:06.0477machine # [ 1.878197] [drm] features: -virgl +edid -resource_blob -host_visible478machine # [ 1.878208] [drm] features: -context_init479machine # [ 1.903137] [drm] number of scanouts: 1480machine # [ 1.903176] [drm] number of cap sets: 0481machine # [ 1.906169] virtio-pci 0000:00:06.0: [drm] Registered 1 planes with drm panic482machine # [ 1.906194] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:06.0 on minor 0483machine # [ 1.927884] systemd[1]: Finished Create Static Device Nodes in /dev.484machine # [ 1.928303] systemd[1]: Reached target Preparation for Local File Systems.485machine # [ 1.928337] systemd[1]: Reached target Local File Systems.486machine # [ 1.935353] systemd[1]: Starting Rule-based Manager for Device Events and Files...487machine # [ 1.943246] Console: switching to colour frame buffer device 160x50488machine # [ 1.950343] virtio-pci 0000:00:06.0: [drm] fb0: virtio_gpudrmfb frame buffer device489machine # [ 1.981712] systemd[1]: Finished Load Kernel Modules.490machine # [ 1.995445] systemd[1]: Starting Apply Kernel Variables...491machine # [ 2.012521] systemd-modules-load[73]: Inserted module 'dm_mod'492machine # [ 2.032715] systemd[1]: Started Journal Service.493machine # [ 2.017674] systemd-modules-load[73]: Module 'virtio_balloon' is built in494machine # [ 2.027786] systemd-modules-load[73]: Module 'virtio_console' is built in495machine # [ 2.032525] systemd-modules-load[73]: Inserted module 'virtio_gpu'496machine # [ 2.037309] systemd-modules-load[73]: Module 'virtio_rng' is built in497machine # [ 2.048396] systemd[1]: Starting Create System Files and Directories...498machine # [ 2.052644] systemd-udevd[79]: Using default interface naming scheme 'v261'.499machine # [ 2.057510] systemd[1]: Finished Apply Kernel Variables.500machine # [ 2.095953] systemd[1]: Started Rule-based Manager for Device Events and Files.501machine # [ 2.097750] systemd[1]: Finished Create System Files and Directories.502machine # [ 2.160968] systemd[1]: Starting Virtual Console Setup...503machine # [ 2.244573] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.504machine # [ 2.252194] systemd[1]: Finished Virtual Console Setup.505machine # [ 2.875441] systemd[1]: Finished Coldplug All udev Devices.506machine # [ 2.876911] systemd[1]: Reached target System Initialization.507machine # [ 2.880173] systemd[1]: Reached target Basic System.508machine # [ 3.012178] (udev-worker)[91]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.509machine # [ 3.051422] (udev-worker)[91]: Network interface NamePolicy= disabled on kernel command line.510machine # [ 3.116469] systemd[1]: Found device /dev/disk/by-label/nixos.511machine # [ 3.120500] systemd[1]: Reached target Initrd Root Device.512machine # [ 3.124598] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...513machine # [ 3.176577] systemd-fsck[110]: nixos: clean, 12/65536 files, 13019/262144 blocks514machine # [ 3.185377] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.515machine # [ 3.193064] systemd[1]: Mounting /sysroot...516machine # [ 3.255981] EXT4-fs (vda): mounted filesystem 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0 r/w with ordered data mode. Quota mode: none.517machine # [ 3.244798] systemd[1]: Mounted /sysroot.518machine # [ 3.247329] systemd[1]: Reached target Initrd Root File System.519machine # [ 3.253277] systemd[1]: Starting Mountpoints Configured in the Real Root...520machine # [ 3.283041] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.521machine # [ 3.291733] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...522machine # [ 3.295167] systemd[1]: Reloading...523machine # [ 3.502362] systemd[1]: Reloading finished in 212 ms.524machine # [ 3.533627] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...525machine # [ 3.539500] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...526machine # [ 3.546265] systemd[1]: initrd-parse-etc.service: Deactivated successfully.527machine # [ 3.549167] systemd[1]: Finished Mountpoints Configured in the Real Root.528machine # [ 3.551535] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.529machine # [ 3.757754] systemd[1]: Mounting /sysroot/nix/.ro-store...530machine # [ 3.770930] systemd[1]: Mounting /sysroot/nix/.rw-store...531machine # [ 3.786027] systemd[1]: Mounting /sysroot/run...532machine # [ 3.811318] systemd[1]: Mounting /sysroot/tmp/shared...533machine # [ 3.842163] systemd[1]: Mounting /sysroot/tmp/xchg...534machine # [ 3.878429] systemd[1]: Mounted /sysroot/nix/.rw-store.535machine # [ 3.909146] fuse: init (API version 7.45)536machine # [ 3.916350] virtiofs virtio7: discovered new tag: nix-store537machine # [ 3.917248] virtiofs virtio7: virtio_fs_setup_dax: No cache capability538machine # [ 3.902750] systemd[1]: Mounted /sysroot/run.539machine # [ 3.932751] virtiofs virtio8: discovered new tag: shared540machine # [ 3.933546] virtiofs virtio8: virtio_fs_setup_dax: No cache capability541machine # [ 3.941473] virtiofs virtio9: discovered new tag: xchg542machine # [ 3.942358] virtiofs virtio9: virtio_fs_setup_dax: No cache capability543machine # [ 3.943523] systemd[1]: Starting rw-sysroot-nix-store.service...544machine # [ 3.946534] systemd[1]: Mounted /sysroot/nix/.ro-store.545machine # [ 3.966031] systemd[1]: Mounted /sysroot/tmp/shared.546machine # [ 3.968588] systemd[1]: Mounted /sysroot/tmp/xchg.547machine # [ 3.990362] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.548machine # [ 3.991941] systemd[1]: Finished rw-sysroot-nix-store.service.549machine # [ 4.488740] tpm_tis c000000.tpm_tis: 2.0 TPM (device-id 0x1, rev-id 1)550machine # [ 4.477168] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/yf6qr0y28a50mnhgyrfdk0hmnvgr6c9d-systemd-262-e2c8482/lib/udev/mtd_probe": No such file or directory551machine # [ 4.498596] tpm tpm0: A TPM error (256) occurred attempting the self test552machine # [ 4.498660] tpm tpm0: starting up the TPM manually553machine # [ 4.484372] (udev-worker)[95]: 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 directory554machine # [ 4.519276] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.555machine # [ 4.522424] systemd[1]: Stopped Virtual Console Setup.556machine # [ 4.528229] systemd[1]: Stopping Virtual Console Setup...557machine # [ 4.529897] systemd[1]: Starting Virtual Console Setup...558machine # [ 4.550731] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.559machine # [ 4.552528] systemd[1]: Stopped Virtual Console Setup.560machine # [ 4.556216] systemd[1]: Starting Virtual Console Setup...561machine # [ 4.590911] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.562machine # [ 4.596312] systemd[1]: Finished Virtual Console Setup.563machine # [ 4.627699] systemd[1]: Reached target Trusted Platform Module.564machine # [ 4.759235] systemd[1]: Mounting /sysroot/nix/store...565machine # [ 4.827308] systemd[1]: Mounted /sysroot/nix/store.566machine # [ 4.830117] systemd[1]: Reached target Initrd File Systems.567machine # [ 4.835988] systemd[1]: Starting Find NixOS closure...568machine # [ 4.844786] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...569machine # [ 4.887029] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.570machine # [ 4.890242] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.571machine # [ 4.903920] systemd[1]: Finished Find NixOS closure.572machine # [ 4.907112] systemd[1]: Reached target Initrd Default Target.573machine # [ 4.909111] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...574machine # [ 4.942695] systemd[1]: Stopped target Initrd Default Target.575machine # [ 4.948723] systemd[1]: Stopped target Basic System.576machine # [ 4.949803] systemd[1]: Stopped target Initrd Root Device.577machine # [ 4.950934] systemd[1]: Stopped target Path Units.578machine # [ 4.951975] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.579machine # [ 4.960302] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.580machine # [ 4.961932] systemd[1]: Stopped target Slice Units.581machine # [ 4.962898] systemd[1]: Stopped target Socket Units.582machine # [ 4.964428] systemd[1]: Stopped target System Initialization.583machine # [ 4.966458] systemd[1]: Stopped target Swaps.584machine # [ 4.972562] systemd[1]: Stopped target Timer Units.585machine # [ 4.974617] systemd[1]: Stopped target Trusted Platform Module.586machine # [ 4.976629] systemd[1]: dbus.socket: Deactivated successfully.587machine # [ 4.981074] systemd[1]: Closed D-Bus System Message Bus Socket.588machine # [ 4.985179] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.589machine # [ 4.994566] systemd[1]: Stopped Find NixOS closure.590machine # [ 4.995460] systemd[1]: Starting rw-sysroot-nix-store.service...591machine # [ 5.001980] systemd[1]: systemd-sysctl.service: Deactivated successfully.592machine # [ 5.004901] systemd[1]: Stopped Apply Kernel Variables.593machine # [ 5.008472] systemd[1]: systemd-modules-load.service: Deactivated successfully.594machine # [ 5.012864] systemd[1]: Stopped Load Kernel Modules.595machine # [ 5.016641] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.596machine # [ 5.020354] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.597machine # [ 5.021557] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.598machine # [ 5.023560] systemd[1]: Stopped Create System Files and Directories.599machine # [ 5.025576] systemd[1]: Stopped target Local File Systems.600machine # [ 5.028297] systemd[1]: Stopped target Preparation for Local File Systems.601machine # [ 5.030300] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.602machine # [ 5.031469] systemd[1]: Stopped Coldplug All udev Devices.603machine # [ 5.032441] systemd[1]: Stopping Rule-based Manager for Device Events and Files...604machine # [ 5.033506] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.605machine # [ 5.034542] systemd[1]: Stopped Virtual Console Setup.606machine # [ 5.035310] systemd[1]: initrd-cleanup.service: Deactivated successfully.607machine # [ 5.040320] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.608machine # [ 5.041346] systemd[1]: systemd-udevd.service: Deactivated successfully.609machine # [ 5.043369] systemd[1]: Stopped Rule-based Manager for Device Events and Files.610machine # [ 5.048323] systemd[1]: systemd-udevd.service: Consumed 1.506s CPU time over 3.090s wall clock time, 22.3M memory peak.611machine # [ 5.049804] systemd[1]: Starting Cleanup udev Database...612machine # [ 5.050587] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.613machine # [ 5.051676] systemd[1]: Stopped Create Static Device Nodes in /dev.614machine # [ 5.056235] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.615machine # [ 5.060124] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.616machine # [ 5.061182] systemd[1]: kmod-static-nodes.service: Deactivated successfully.617machine # [ 5.062182] systemd[1]: Stopped Create List of Static Device Nodes.618machine # [ 5.064374] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.619machine # [ 5.068365] systemd[1]: Finished rw-sysroot-nix-store.service.620machine # [ 5.090188] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.621machine # [ 5.091940] systemd[1]: Finished Cleanup udev Database.622machine # [ 5.095478] systemd[1]: Reached target Switch Root.623machine # [ 5.100538] systemd[1]: Starting NixOS Activation...624machine # [ 5.186035] initrd-nixos-activation-start[177]: booting system configuration /nix/store/2pw2gj2rhiqgwryjc5qyfwffmfa9w3q1-nixos-system-machine-test625machine # [ 5.221673] initrd-nixos-activation-start[177]: running activation script...626machine # [ 5.484867] initrd-nixos-activation-start[200]: setting up /etc...627machine # [ 5.613799] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.628machine # [ 5.616141] systemd[1]: Finished NixOS Activation.629machine # [ 5.617816] systemd[1]: Starting Switch Root...630machine # [ 5.640992] systemd[1]: Switching root.631machine # [ 5.835060] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).632machine # [ 6.361975] systemd[1]: systemd 262-e2c8482 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)633machine # [ 6.375419] systemd[1]: Detected virtualization qemu.634machine # [ 6.379878] systemd[1]: Detected architecture arm64.635machine # [ 6.382203] systemd[1]: Detected first boot.636machine # [ 6.387314] systemd[1]: Initializing machine ID from random generator.637machine # [ 6.557685] systemd[1]: bpf-restrict-fs: LSM BPF program attached638machine # [ 6.767877] systemd[1]: Applying preset policy.639machine # [ 7.043317] systemd[1]: Populated /etc with preset unit settings.640machine # [ 7.269329] systemd[1]: initrd-switch-root.service: Deactivated successfully.641machine # [ 7.271228] systemd[1]: Stopped initrd-switch-root.service.642machine # [ 7.275789] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.643machine # [ 7.278720] systemd[1]: Created slice Slice /system/getty.644machine # [ 7.281777] systemd[1]: Created slice User and Session Slice.645machine # [ 7.284345] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.646machine # [ 7.286872] systemd[1]: Started Forward Password Requests to Wall Directory Watch.647machine # [ 7.289241] systemd[1]: Expecting device /dev/hvc0...648machine # [ 7.291280] systemd[1]: Expecting device /dev/ttyAMA0...649machine # [ 7.293221] systemd[1]: Reached target Local Encrypted Volumes.650machine # [ 7.295391] systemd[1]: Stopped target initrd-fs.target.651machine # [ 7.296441] systemd[1]: Stopped target initrd-root-fs.target.652machine # [ 7.298190] systemd[1]: Stopped target initrd-switch-root.target.653machine # [ 7.300065] systemd[1]: Reached target Virtual Machines and Containers.654machine # [ 7.302704] systemd[1]: Reached target Path Units.655machine # [ 7.303782] systemd[1]: Reached target Remote File Systems.656machine # [ 7.305430] systemd[1]: Reached target Slice Units.657machine # [ 7.307098] systemd[1]: Reached target Swaps.658machine # [ 7.311084] systemd[1]: Listening on Query the User Interactively for a Password.659machine # [ 7.314051] systemd[1]: Listening on Process Core Dump Socket.660machine # [ 7.316255] systemd[1]: Listening on Credential Encryption/Decryption.661machine # [ 7.318568] systemd[1]: Listening on Factory Reset Management.662machine # [ 7.319902] systemd[1]: Listening on Hostname Service Socket.663machine # [ 7.324257] systemd[1]: Starting Journal Log Access Socket...664machine # [ 7.326606] systemd[1]: Listening on Journal Audit Socket.665machine # [ 7.330529] systemd[1]: Listening on Console Output Muting Service Socket.666machine # [ 7.332264] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.667machine # [ 7.334550] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os668machine # [ 7.336624] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki669machine # [ 7.343724] systemd[1]: Listening on Disk Repartitioning Service Socket.670machine # [ 7.345198] systemd[1]: Listening on udev Varlink Socket.671machine # [ 7.349149] systemd[1]: Mounting Huge Pages File System...672machine # [ 7.355248] systemd[1]: Mounting POSIX Message Queue File System...673machine # [ 7.367707] systemd[1]: Mounting Kernel Debug File System...674machine # [ 7.377765] systemd[1]: Mounting Kernel Trace File System...675machine # [ 7.394411] systemd[1]: Starting Create List of Static Device Nodes...676machine # [ 7.397507] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs677machine # [ 7.411752] systemd[1]: Mounting Kernel Configuration File System...678machine # [ 7.419183] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm679machine # [ 7.426800] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore680machine # [ 7.429859] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse681machine # [ 7.456962] systemd[1]: Mounting FUSE Control File System...682machine # [ 7.458634] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67683machine # [ 7.487672] systemd[1]: Starting Journal Service...684machine # [ 7.506830] systemd[1]: Starting Load Kernel Modules...685machine # [ 7.526266] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...686machine # [ 7.547175] systemd[1]: Starting Remount Root and Kernel File Systems...687machine # [ 7.550248] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os688machine # [ 7.575867] systemd[1]: Starting Coldplug All udev Devices...689machine # [ 7.586736] systemd-journald[271]: Collecting audit messages is enabled.690machine # [ 7.592933] systemd[1]: Listening on Journal Log Access Socket.691machine # [ 7.585886] systemd[1]: Queued start job for default target Multi-User System.692machine # [ 7.592837] systemd[1]: systemd-journald.service: Deactivated successfully.693machine # [ 7.617424] systemd[1]: Started Journal Service.694machine # [ 7.606741] systemd[1]: Mounted Huge Pages File System.695machine # [ 7.611982] systemd[1]: Mounted POSIX Message Queue File System.696machine # [ 7.613157] systemd[1]: Mounted Kernel Debug File System.697machine # [ 7.613931] systemd[1]: Mounted Kernel Trace File System.698machine # [ 7.622015] systemd[1]: Finished Create List of Static Device Nodes.699machine # [ 7.648274] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...700machine # [ 7.657615] systemd-modules-load[272]: Module 'atkbd' is built in701machine # [ 7.661381] systemd-modules-load[272]: Module 'loop' is built in702machine # [ 7.683087] EXT4-fs (vda): re-mounted 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0.703machine # [ 7.675076] systemd[1]: Finished Load Kernel Modules.704machine # [ 7.678103] systemd[1]: Finished Remount Root and Kernel File Systems.705machine # [ 7.680387] systemd[1]: Mounted Kernel Configuration File System.706machine # [ 7.700130] systemd-oomd[273]: No swap; memory pressure usage will be degraded707machine # [ 7.708113] systemd[1]: Listening on Disk Image Download Service Socket.708machine # [ 7.714899] systemd[1]: Starting Firewall...709machine # [ 7.722366] systemd[1]: Starting Flush Journal to Persistent Storage...710machine # [ 7.723485] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore711machine # [ 7.729116] systemd[1]: Starting Load/Save OS Random Seed...712machine # [ 7.744307] systemd[1]: Starting Apply Kernel Variables...713machine # [ 7.745292] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os714machine # [ 7.746730] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.715machine # [ 7.747663] systemd[1]: Mounted FUSE Control File System.716machine # [ 7.855288] systemd-journald[271]: Received client request to flush runtime journal.717machine # [ 7.912630] systemd[1]: Finished Load/Save OS Random Seed.718machine # [ 7.913707] systemd[1]: Reached target First Boot Complete.719machine # [ 7.920824] systemd[1]: Finished Flush Journal to Persistent Storage.720machine # [ 7.939809] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.721machine # [ 7.953315] systemd[1]: Starting Create Static Device Nodes in /dev...722machine # [ 7.955496] systemd[1]: Finished Apply Kernel Variables.723machine # [ 8.277081] systemd[1]: Finished Create Static Device Nodes in /dev.724machine # [ 8.279395] systemd[1]: Reached target Preparation for Local File Systems.725machine # [ 8.286414] systemd[1]: Mounting /run/wrappers...726machine # [ 8.294481] systemd[1]: Starting Rule-based Manager for Device Events and Files...727machine # [ 8.393377] systemd[1]: Mounted /run/wrappers.728machine # [ 8.394246] systemd[1]: Reached target Local File Systems.729machine # [ 8.398996] systemd[1]: Listening on Boot Loader Control Service Socket.730machine # [ 8.406180] systemd[1]: Starting Create SUID/SGID Wrappers...731machine # [ 8.407171] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.732machine # [ 8.416793] systemd[1]: Starting Save Transient machine-id to Disk...733machine # [ 8.424165] systemd[1]: Starting Create System Files and Directories...734machine # [ 8.491927] systemd-udevd[308]: Using default interface naming scheme 'v261'.735machine # [ 8.636445] systemd[1]: Finished Create System Files and Directories.736machine # [ 8.647527] systemd[1]: Starting Rebuild Journal Catalog...737machine # [ 8.660167] systemd[1]: Starting Record System Boot/Shutdown in UTMP...738machine # [ 8.661301] systemd[1]: Started Rule-based Manager for Device Events and Files.739machine # [ 8.704992] systemd[1]: Finished Save Transient machine-id to Disk.740machine # [ 8.828945] systemd[1]: Finished Record System Boot/Shutdown in UTMP.741machine # [ 8.863850] systemd[1]: Finished Rebuild Journal Catalog.742machine # [ 8.873716] systemd[1]: Starting Update is Completed...743machine # [ 9.005792] systemd[1]: Finished Update is Completed.744machine # [ 9.091196] systemd[1]: Finished Coldplug All udev Devices.745machine # [ 9.202954] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs746machine # [ 9.245113] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse747machine # [ 9.251246] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.748machine # [ 9.420241] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.749machine # [ 9.424095] systemd[1]: Finished Create SUID/SGID Wrappers.750machine # [ 9.427231] systemd[1]: Reached target System Initialization.751machine # [ 9.431271] systemd[1]: Started Discard unused filesystem blocks once a week.752machine # [ 9.434067] systemd[1]: Started Daily Cleanup of Temporary Directories.753machine # [ 9.435067] systemd[1]: Reached target Timer Units.754machine # [ 9.435783] systemd[1]: Listening on D-Bus System Message Bus Socket.755machine # [ 9.442593] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.756machine # [ 9.443845] systemd[1]: Reached target Socket Units.757machine # [ 9.451634] systemd[1]: Reached target Basic System.758machine # [ 9.456390] systemd[1]: Starting Import lastlog data into lastlog2 database...759machine # [ 9.457443] systemd[1]: Starting Name Service Cache Daemon (nsncd)...760machine # [ 9.458331] systemd[1]: Starting Post-Boot Actions...761machine # [ 9.478956] systemd[1]: Started Reset console on configuration changes.762machine # [ 9.503281] systemd[1]: Starting resolvconf update...763machine # [ 9.592695] systemd[1]: Starting D-Bus System Message Bus...764machine # [ 9.600990] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.765machine # [ 9.624941] systemd[1]: Finished Post-Boot Actions.766machine # [ 9.688944] nsncd[435]: Sep 15 21:18:06.187 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"767machine # [ 9.707002] systemd[1]: Started Name Service Cache Daemon (nsncd).768machine # [ 9.717127] systemd[1]: Reached target Host and Network Name Lookups.769machine # [ 9.718162] systemd[1]: Reached target User and Group Name Lookups.770machine # [ 9.728244] systemd[1]: Starting User Login Management...771machine # [ 9.729223] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.772machine # [ 9.739663] systemd[1]: Started backdoor.service.773machine # [ 9.779046] systemd[1]: Finished Import lastlog data into lastlog2 database.774machine # [ 9.866054] dbus-broker-launch[445]: Looking up NSS user entry for 'systemd-timesync'...775machine # [ 9.869781] dbus-broker-launch[445]: NSS returned no entry for 'systemd-timesync'776machine # [ 9.870887] dbus-broker-launch[445]: Invalid user-name in /nix/store/kiv06p8mj99a1w7zd9q0gnbf2v7w2mnn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"777machine # [ 9.937627] systemd[1]: Started D-Bus System Message Bus.778machine # connecting to host...779machine # [ 9.977126] systemd-logind[465]: New seat seat0.780machine # [ 9.992092] systemd[1]: Started User Login Management.781machine # [ 10.004944] dbus-broker-launch[445]: Ready782machine # [ 10.005708] systemd[1]: Starting linger-users.service...783machine: Guest shell says: b'Spawning backdoor root shell...\n'784machine: connected to guest root shell785machine: (connecting took 10.38 seconds)786machine # [ 10.042840] (udev-worker)[374]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.787machine: (finished: waiting for the VM to finish booting, in 10.38 seconds)788machine # [ 10.058022] (udev-worker)[374]: Network interface NamePolicy= disabled on kernel command line.789machine # [ 10.093203] systemd[1]: Condition check resulted in /dev/tpmrm0 being skipped.790machine # [ 10.101632] systemd[1]: Expecting device /dev/tpm0...791machine # [ 10.109123] systemd[1]: Stopped target Host and Network Name Lookups.792machine # [ 10.110148] systemd[1]: Stopping Host and Network Name Lookups...793machine # [ 10.110980] systemd[1]: Stopped target User and Group Name Lookups.794machine # [ 10.111864] systemd[1]: Stopping User and Group Name Lookups...795machine # [ 10.127094] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...796machine # [ 10.135412] systemd[1]: nscd.service: Deactivated successfully.797machine # [ 10.143983] systemd[1]: Stopped Name Service Cache Daemon (nsncd).798machine: (finished: must succeed: test -e /dev/tpm0, in 10.48 seconds)799machine: must succeed: test -e /dev/tpmrm0800machine # [ 10.172182] systemd[1]: linger-users.service: Deactivated successfully.801machine # [ 10.178718] systemd[1]: Finished linger-users.service.802machine # [ 10.200400] systemd[1]: Starting Name Service Cache Daemon (nsncd)...803machine: (finished: must succeed: test -e /dev/tpmrm0, in 0.07 seconds)804machine: must succeed: systemd-cryptenroll --tpm2-device=list805machine # [ 10.286743] systemd[1]: Finished resolvconf update.806machine # [ 10.300602] systemd[1]: Starting DHCP Client...807machine # [ 10.320714] nsncd[546]: Sep 15 21:18:06.819 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"808machine # [ 10.331877] systemd[1]: Started Name Service Cache Daemon (nsncd).809machine # [ 10.338258] systemd[1]: Reached target Host and Network Name Lookups.810machine # [ 10.339227] systemd[1]: Reached target User and Group Name Lookups.811machine: (finished: must succeed: systemd-cryptenroll --tpm2-device=list, in 0.13 seconds)812machine: must succeed: echo -n lukspass | cryptsetup luksFormat -q /dev/vdb -813machine # [ 10.620369] dhcpcd[591]: dhcpcd-10.3.2 starting814machine # [ 10.645662] dhcpcd[603]: dev: loaded udev815machine # [ 10.654560] systemd[1]: Condition check resulted in Virtio network device being skipped.816machine # [ 10.763747] 8021q: 802.1Q VLAN Support v1.8817machine # [ 10.776566] systemd[1]: Finished Firewall.818machine # [ 10.782234] systemd[1]: Reached target Preparation for Network.819machine # [ 10.786570] systemd[1]: Starting Address configuration of eth1...820machine # [ 10.796962] systemd[1]: Starting Extra networking commands....821machine # [ 10.882128] systemd-logind[465]: Watching system buttons on /dev/input/event0 (gpio-keys)822machine # [ 11.013849] cfg80211: Loading compiled-in X.509 certificates for regulatory database823machine # [ 11.096667] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'824machine # [ 11.097192] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'825machine # [ 11.104312] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2826machine # [ 11.104657] cfg80211: failed to load regulatory.db827machine # [ 11.110799] 8021q: adding VLAN 0 to HW filter on device eth1828machine # [ 11.149398] network-addresses-eth1-start[609]: adding address 192.168.1.1/24... done829machine # [ 11.195142] mousedev: PS/2 mouse device common for all mice830machine # [ 11.207033] network-addresses-eth1-start[609]: adding address 2001:db8:1::1/64... done831machine # [ 11.252797] dhcpcd[637]: /nix/store/1ki7bgdr0niilkg9jbkpcdaggbv0kb8a-openresolv-3.17.4/sbin/.resolvconf-wrapped: line 1250: kill: (614) - Operation not permitted832machine # [ 11.254755] dhcpcd[637]: .resolvconf-wrapped: clearing stale lock pid 614833machine # [ 11.271621] systemd[1]: Finished Address configuration of eth1.834machine # [ 11.403338] 8021q: adding VLAN 0 to HW filter on device eth0835machine # [ 11.386014] dhcpcd[603]: eth0: waiting for carrier836machine # [ 11.388804] dhcpcd[603]: libudev: received NULL device837machine # [ 11.389726] dhcpcd[603]: libudev: received NULL device838machine # [ 11.390443] dhcpcd[603]: eth0: carrier acquired839machine # [ 11.426623] dhcpcd[603]: DUID 00:01:00:01:32:3c:72:8f:52:54:00:12:34:56840machine # [ 11.427656] dhcpcd[603]: eth0: IAID 00:12:34:56841machine # [ 11.433403] dhcpcd[603]: eth0: adding address fe80::5054:ff:fe12:3456842machine # [ 11.453186] systemd-logind[465]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)843machine # [ 11.480243] systemd[1]: Finished Extra networking commands..844machine # [ 11.491657] systemd[1]: Reached target Network.845machine # [ 11.495267] systemd[1]: Starting Permit User Sessions...846machine # [ 11.632828] systemd[1]: Finished Permit User Sessions.847machine # [ 11.641861] systemd[1]: Started Getty on tty1.848machine # [ 11.644453] systemd[1]: Reached target Login Prompts.849machine # [ 12.769004] dhcpcd[603]: eth0: soliciting an IPv6 router850machine # [ 12.771337] dhcpcd[603]: eth0: Router Advertisement from fe80::2851machine # [ 12.776200] dhcpcd[603]: eth0: adding address fec0::5054:ff:fe12:3456/64852machine # [ 12.777186] dhcpcd[603]: eth0: adding route to fec0::/64853machine # [ 12.777917] dhcpcd[603]: eth0: adding default route via fe80::2854machine # [ 13.042263] dhcpcd[603]: eth0: soliciting a DHCP lease855machine # [ 13.048162] dhcpcd[603]: eth0: offered 10.0.2.15 from 10.0.2.2856machine # [ 13.049088] dhcpcd[603]: eth0: probing address 10.0.2.15/24857machine # [ 13.252992] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/virtio6/input/input3858machine # [ 13.668571] systemd[1]: Condition check resulted in /dev/tpm0 being skipped.859machine # [ 13.670290] systemd[1]: Reached target Trusted Platform Module.860machine # [ 13.999270] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.861machine # [ 14.002083] systemd[1]: Starting Virtual Console Setup...862machine # [ 14.044914] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.863machine # [ 14.051868] systemd[1]: Stopped Virtual Console Setup.864machine # [ 14.062301] systemd[1]: Starting Virtual Console Setup...865machine # [ 14.122819] systemd-logind[465]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)866machine # [ 18.205292] systemd-vconsole-setup[701]: Configuration of first virtual console was skipped, ignoring remaining ones.867machine # [ 18.218863] systemd[1]: Finished Virtual Console Setup.868machine # [ 18.706973] dhcpcd[603]: eth0: leased 10.0.2.15 for 86400 seconds869machine # [ 18.707973] dhcpcd[603]: eth0: adding route to 10.0.2.0/24870machine # [ 18.712343] dhcpcd[603]: eth0: adding default route via 10.0.2.2871machine # [ 19.310599] systemd[1]: Started DHCP Client.872machine # [ 19.316927] systemd[1]: Reached target Multi-User System.873machine # [ 19.317829] systemd[1]: Startup finished in 1.073s (kernel) + 4.846s (initrd) + 13.396s (userspace) = 19.316s.874machine: (finished: must succeed: echo -n lukspass | cryptsetup luksFormat -q /dev/vdb -, in 14.76 seconds)875machine: must succeed: PASSWORD=lukspass systemd-cryptenroll --tpm2-device=auto --tpm2-pcrs=7 /dev/vdb876machine # TPM2 device supports the sha256 PCR bank but none of the selected PCRs are initialized! Firmware apparently did not measure into any of them. Proceeding anyway, but the PCR policy is effectively unenforced!877machine # New TPM2 token enrolled as key slot 1.878machine: (finished: must succeed: PASSWORD=lukspass systemd-cryptenroll --tpm2-device=auto --tpm2-pcrs=7 /dev/vdb, in 2.69 seconds)879machine: must succeed: echo 'luks /dev/vdb - tpm2-device=auto' >> /etc/crypttab880machine: (finished: must succeed: echo 'luks /dev/vdb - tpm2-device=auto' >> /etc/crypttab, in 0.03 seconds)881machine: waiting for the VM to power off882additionally exposed symbols:883 machine,884 vlan1,885 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_ssh886machine # [ 27.840185] systemd-logind[465]: poweroff requested from client PID 776 ('poweroff') (unit backdoor.service)...887machine # [ 27.843837] systemd-logind[465]: System is powering down.888machine # [ 27.853571] systemd-logind[465]: The system will power off now!889machine # [ 27.868407] systemd[1]: Removed slice Slice /system/modprobe.890machine # [ 27.872887] systemd[1]: Stopped target Multi-User System.891machine # [ 27.873922] systemd[1]: Stopped target Login Prompts.892machine # [ 27.874677] systemd[1]: Stopped target Virtual Machines and Containers.893machine # [ 27.875666] systemd[1]: Stopped target Host and Network Name Lookups.894machine # [ 27.882600] systemd[1]: Stopped target Timer Units.895machine # [ 27.883878] dhcpcd[603]: received SIGTERM, stopping896machine # [ 27.887669] systemd[1]: fstrim.timer: Deactivated successfully.897machine # [ 27.890995] dhcpcd[603]: eth0: removing interface898machine # [ 27.891837] systemd[1]: Stopped Discard unused filesystem blocks once a week.899machine # [ 27.895941] dhcpcd[603]: eth0: deleting address fec0::5054:ff:fe12:3456/64900machine # [ 27.902028] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.901machine # [ 27.903335] dhcpcd[603]: eth0: deleting route to fec0::/64902machine # [ 27.908300] systemd[1]: Stopped Daily Cleanup of Temporary Directories.903machine # [ 27.909357] dhcpcd[603]: eth0: deleting default route via fe80::2904machine # [ 27.910327] systemd[1]: Stopped target Trusted Platform Module.905machine # [ 27.911265] dhcpcd[603]: script_status: /nix/store/nc3yxdc9q2dqigfkdhx4x0fx5g9h8y94-dhcpcd-10.3.2/libexec/dhcpcd-run-hooks: Terminated906machine # [ 27.924963] systemd[1]: systemd-rfkill.socket: Deactivated successfully.907machine # [ 27.926090] dhcpcd[603]: eth0: deleting address fe80::5054:ff:fe12:3456908machine # [ 27.927080] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.909machine # [ 27.929302] dhcpcd[603]: eth0: deleting route to 10.0.2.0/24910machine # [ 27.930196] systemd[1]: Mounting /run/initramfs...911machine # [ 27.930998] dhcpcd[603]: eth0: deleting default route via 10.0.2.2912machine # [ 27.931911] systemd[1]: Stopping backdoor.service...913machine # [ 27.940419] systemd[1]: Stopping DHCP Client...914machine # [ 27.941259] systemd[1]: Stopping Getty on tty1...915machine # [ 27.942008] systemd[1]: lastlog2-import.service: Deactivated successfully.916machine # [ 27.943034] systemd[1]: Stopped Import lastlog data into lastlog2 database.917machine # [ 27.952741] systemd[1]: Stopping Address configuration of eth1...918machine # [ 27.953862] systemd[1]: Stopping Post-Boot Actions...919machine # [ 27.954678] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.920machine # [ 27.955862] systemd[1]: Stopped Reset console on configuration changes.921machine # [ 27.964216] systemd[1]: Stopping User Login Management...922machine # [ 27.965169] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.923machine # [ 27.966271] systemd[1]: Stopped Save Transient machine-id to Disk.924machine # [ 27.967195] systemd[1]: Stopped target First Boot Complete.925machine # [ 27.968002] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...926machine # [ 27.977531] systemd[1]: Stopping Load/Save OS Random Seed...927machine # [ 27.978485] systemd[1]: systemd-oomd.service: Deactivated successfully.928machine # [ 27.986207] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.929machine # [ 27.993874] dhcpcd[603]: dhcpcd exited930machine # [ 27.994718] systemd[1]: systemd-logind.service: Deactivated successfully.931machine # [ 28.002003] systemd[1]: Stopped User Login Management.932machine # [ 28.044295] systemd[1]: backdoor.service: Deactivated successfully.933machine # [ 28.052250] systemd[1]: Stopped backdoor.service.934machine # [ 28.055760] systemd[1]: backdoor.service: Consumed 14.512s CPU time over 18.309s wall clock time, 358.9M memory peak, 939K read from disk, 32.5M written to disk.935machine # [ 28.066678] systemd[1]: dhcpcd.service: Deactivated successfully.936machine # [ 28.067745] systemd[1]: Stopped DHCP Client.937machine # [ 28.074428] systemd[1]: dhcpcd.service: Consumed 237ms CPU time over 17.754s wall clock time, 5.7M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.938machine # [ 28.083719] systemd[1]: getty@tty1.service: Deactivated successfully.939machine # [ 28.086453] network-addresses-eth1-pre-stop[783]: deleting address 192.168.1.1/24... done940machine # [ 28.090277] systemd[1]: Stopped Getty on tty1.941machine # [ 28.103517] systemd[1]: post-boot.service: Deactivated successfully.942machine # [ 28.106714] network-addresses-eth1-pre-stop[783]: deleting address 2001:db8:1::1/64... done943machine # [ 28.109675] systemd[1]: Stopped Post-Boot Actions.944machine # [ 28.113870] systemd[1]: systemd-random-seed.service: Deactivated successfully.945machine # [ 28.117936] systemd[1]: Stopped Load/Save OS Random Seed.946machine # [ 28.126963] systemd[1]: Mounted /run/initramfs.947machine # [ 28.129986] systemd[1]: network-addresses-eth1.service: Deactivated successfully.948machine # [ 28.132515] systemd[1]: Stopped Address configuration of eth1.949machine # [ 28.143089] systemd[1]: Removed slice Slice /system/getty.950machine # [ 28.148236] systemd[1]: Starting Generate shutdown ramfs...951machine # [ 28.153842] systemd[1]: Stopping Permit User Sessions...952machine # [ 28.212462] systemd[1]: systemd-user-sessions.service: Deactivated successfully.953machine # [ 28.213772] systemd[1]: Stopped Permit User Sessions.954machine # [ 28.217016] systemd[1]: Stopped target Network.955machine # [ 28.217938] systemd[1]: Stopped target User and Group Name Lookups.956machine # [ 28.224634] systemd[1]: Stopped target Remote File Systems.957machine # [ 28.225546] systemd[1]: network-local-commands.service: Deactivated successfully.958machine # [ 28.226617] systemd[1]: Stopped Extra networking commands..959machine # [ 28.227441] systemd[1]: Stopped target Preparation for Network.960machine # [ 28.234469] systemd[1]: Stopping Firewall...961machine # [ 28.235301] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...962machine # [ 28.239114] systemd[1]: resolvconf.service: Deactivated successfully.963machine # [ 28.241739] systemd[1]: Stopped resolvconf update.964machine # [ 28.242542] systemd[1]: nscd.service: Deactivated successfully.965machine # [ 28.243471] systemd[1]: Stopped Name Service Cache Daemon (nsncd).966machine # [ 28.250104] systemd[1]: Stopped target Basic System.967machine # [ 28.251713] systemd[1]: Stopped target Path Units.968machine # [ 28.256822] systemd[1]: Stopped target Slice Units.969machine # [ 28.257815] systemd[1]: Removed slice User and Session Slice.970machine # [ 28.259920] systemd[1]: Stopped target Socket Units.971machine # [ 28.266959] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.972machine # [ 28.273785] systemd[1]: Closed Hostname Service Socket.973machine # [ 28.275129] make-initrd-ng[807]: /etc/initrd-release -> /nix/store/s0k038sacp3qi1ldk2936dfbm8s8sk55-etc-os-release974machine # [ 28.278126] make-initrd-ng[807]: /etc/os-release -> /nix/store/s0k038sacp3qi1ldk2936dfbm8s8sk55-etc-os-release975machine # [ 28.279674] make-initrd-ng[807]: /shutdown -> /nix/store/yf6qr0y28a50mnhgyrfdk0hmnvgr6c9d-systemd-262-e2c8482/lib/systemd/systemd-shutdown976machine # [ 28.288835] systemd[1]: systemd-importd.socket: Deactivated successfully.977machine # [ 28.289990] systemd[1]: Closed Disk Image Download Service Socket.978machine # [ 28.291048] systemd[1]: systemd-machined.socket: Deactivated successfully.979machine # [ 28.299771] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.980machine # [ 28.304142] systemd[1]: systemd-mute-console.socket: Deactivated successfully.981machine # [ 28.305252] systemd[1]: Closed Console Output Muting Service Socket.982machine # [ 28.306222] systemd[1]: systemd-oomd.socket: Deactivated successfully.983machine # [ 28.307192] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.984machine # [ 28.313549] systemd[1]: systemd-repart.socket: Deactivated successfully.985machine # [ 28.314605] systemd[1]: Closed Disk Repartitioning Service Socket.986machine # [ 28.315667] dbus-broker[502]: Dispatched 1077 messages @ 3(±6)μs / message.987machine # [ 28.324477] systemd[1]: Stopping D-Bus System Message Bus...988machine # [ 28.325378] systemd[1]: dbus-broker.service: Deactivated successfully.989machine # [ 28.326303] systemd[1]: Stopped D-Bus System Message Bus.990machine # [ 28.327114] systemd[1]: dbus.socket: Deactivated successfully.991machine # [ 28.327946] systemd[1]: Closed D-Bus System Message Bus Socket.992machine # [ 28.339042] systemd[1]: Stopped target System Initialization.993machine # [ 28.339930] systemd[1]: Stopped target Local Encrypted Volumes.994machine # [ 28.341129] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.995machine # [ 28.342216] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.996machine # [ 28.343348] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.997machine # [ 28.353309] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.998machine # [ 28.354494] systemd[1]: systemd-sysctl.service: Deactivated successfully.999machine # [ 28.365397] systemd[1]: Stopped Apply Kernel Variables.1000machine # [ 28.366352] systemd[1]: systemd-coredump.socket: Deactivated successfully.1001machine # [ 28.367342] systemd[1]: Closed Process Core Dump Socket.1002machine # [ 28.376616] systemd[1]: systemd-update-done.service: Deactivated successfully.1003machine # [ 28.377774] systemd[1]: Stopped Update is Completed.1004machine # [ 28.378542] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1005machine # [ 28.379678] systemd[1]: Stopped Rebuild Journal Catalog.1006machine # [ 28.388463] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1007machine # [ 28.399834] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1008machine # [ 28.404508] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1009machine # [ 28.405548] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1010machine # [ 28.406619] systemd[1]: Stopped Create System Files and Directories.1011machine # [ 28.407591] systemd[1]: Stopped target Local File Systems.1012machine # [ 28.414603] systemd[1]: Unmounting /run/keys...1013machine # [ 28.420260] systemd[1]: Unmounting /run/wrappers...1014machine # [ 28.511621] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1015machine # [ 28.517818] systemd[1]: Finished Generate shutdown ramfs.1016machine # [ 28.521377] systemd[1]: run-keys.mount: Deactivated successfully.1017machine # [ 28.524468] systemd[1]: Unmounted /run/keys.1018machine # [ 28.525355] systemd[1]: firewall.service: Deactivated successfully.1019machine # [ 28.527768] systemd[1]: Stopped Firewall.1020machine # [ 28.531887] systemd[1]: run-wrappers.mount: Deactivated successfully.1021machine # [ 28.533717] systemd[1]: Unmounted /run/wrappers.1022machine # [ 28.540208] systemd[1]: Stopped target Preparation for Local File Systems.1023machine # [ 28.541494] systemd[1]: Stopped target Swaps.1024machine # [ 28.542225] systemd[1]: Reached target Unmount All Filesystems.1025machine # [ 28.543126] systemd[1]: systemd-modules-load.service: Deactivated successfully.1026machine # [ 28.545852] systemd[1]: Stopped Load Kernel Modules.1027machine # [ 28.547633] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1028machine # [ 28.550981] systemd[1]: Stopped Remount Root and Kernel File Systems.1029machine # [ 28.551992] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1030machine # [ 28.556816] systemd[1]: Stopped File System Check on Root Device.1031machine # [ 28.557941] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1032machine # [ 28.560556] systemd[1]: Stopped Create Static Device Nodes in /dev.1033machine # [ 28.563258] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1034machine # [ 28.564796] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1035machine # [ 28.565877] systemd[1]: Reached target System Shutdown.1036machine # [ 28.566737] systemd[1]: Reached target Late Shutdown Services.1037machine # [ 28.567668] systemd[1]: systemd-poweroff.service: Deactivated successfully.1038machine # [ 28.568879] systemd[1]: Finished System Power Off.1039machine # [ 28.569626] systemd[1]: Reached target System Power Off.1040machine # [ 28.570446] systemd[1]: Shutting down.1041machine # [ 28.758510] systemd-shutdown[1]: Syncing filesystems and block devices.1042machine # [ 28.815404] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1043machine # [ 28.847592] systemd-journald[271]: Received SIGTERM from PID 1 (systemd-shutdow).1044machine # [ 28.913145] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1045machine # [ 28.931312] systemd-shutdown[1]: Unmounting file systems.1046machine # [ 28.941344] (sd-umount)[838]: Unmounting '/run/credentials/systemd-journald.service'.1047machine # [ 28.948749] (sd-remount)[839]: 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'.1048machine # [ 28.974693] (sd-umount)[840]: Unmounting '/nix/store'.1049machine # [ 28.977586] (sd-umount)[840]: Failed to unmount /nix/store: Device or resource busy1050machine # [ 28.981662] systemd-shutdown[1]: Moving mount /nix/store to /run/shutdown/mounts/777d817632a534f0.1051machine # [ 28.986503] (sd-remount)[841]: 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'.1052machine # [ 28.993629] (sd-umount)[842]: Unmounting '/nix/store'.1053machine # [ 28.997775] (sd-remount)[843]: Remounting '/tmp/xchg' read-only with options ''.1054machine # [ 29.002874] (sd-umount)[844]: Unmounting '/tmp/xchg'.1055machine # [ 29.008100] (sd-remount)[845]: Remounting '/tmp/shared' read-only with options ''.1056machine # [ 29.011931] (sd-umount)[846]: Unmounting '/tmp/shared'.1057machine # [ 29.017776] (sd-umount)[847]: Unmounting '/nix/.ro-store'.1058machine # [ 29.021401] (sd-umount)[848]: Unmounting '/nix/.rw-store'.1059machine # [ 29.025145] (sd-remount)[849]: Remounting '/' read-only with options ''.1060machine # [ 29.035940] EXT4-fs (vda): re-mounted 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0 ro.1061machine # [ 29.041888] (sd-umount)[850]: Unmounting '/run/shutdown/mounts/777d817632a534f0'.1062machine # [ 29.043996] (sd-umount)[850]: Failed to unmount /run/shutdown/mounts/777d817632a534f0: Device or resource busy1063machine # [ 29.049349] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1064machine # [ 29.051089] systemd-shutdown[1]: Deactivating swaps.1065machine # [ 29.054403] systemd-shutdown[1]: All swaps deactivated.1066machine # [ 29.055772] systemd-shutdown[1]: Detaching loop devices.1067machine # [ 29.068064] systemd-shutdown[1]: All loop devices detached.1068machine # [ 29.070404] systemd-shutdown[1]: Stopping MD devices.1069machine # [ 29.073011] systemd-shutdown[1]: All MD devices stopped.1070machine # [ 29.075384] systemd-shutdown[1]: Detaching DM devices.1071machine # [ 29.077942] systemd-shutdown[1]: All DM devices detached.1072machine # [ 29.080577] systemd-shutdown[1]: Unmounting file systems.1073machine # [ 29.084663] (sd-umount)[851]: Unmounting '/run/shutdown/mounts/777d817632a534f0'.1074machine # [ 29.087708] (sd-umount)[851]: Failed to unmount /run/shutdown/mounts/777d817632a534f0: Device or resource busy1075machine # [ 29.091702] systemd-shutdown[1]: Not all file systems unmounted, 1 left.1076machine # [ 29.094434] systemd-shutdown[1]: Cannot finalize remaining file systems, continuing.1077machine # [ 29.436170] systemd-shutdown[1]: Successfully changed into root pivot.1078machine # [ 29.439349] systemd-shutdown[1]: Entering exitrd...1079machine # [ 29.461876] shutdown[1]: Syncing filesystems and block devices.1080machine # [ 29.466523] shutdown[1]: Sending SIGTERM to remaining processes...1081machine # [ 29.479841] shutdown[1]: Sending SIGKILL to remaining processes...1082machine # [ 29.492133] shutdown[1]: Unmounting file systems.1083machine # [ 29.499035] (sd-umoun[853]: Unmounting '/run/credentials'.1084machine # [ 29.505993] (sd-umoun[854]: Unmounting '/oldroot/sys/fs/fuse/connections'.1085machine # [ 29.512593] (sd-umoun[855]: Unmounting '/oldroot/sys/kernel/config'.1086machine # [ 29.519188] (sd-umoun[856]: Unmounting '/oldroot/sys/kernel/tracing'.1087machine # [ 29.525698] (sd-umoun[857]: Unmounting '/oldroot/dev/hugepages'.1088machine # [ 29.532153] (sd-umoun[858]: Unmounting '/oldroot/dev/mqueue'.1089machine # [ 29.539893] (sd-umoun[859]: Unmounting '/oldroot/sys/kernel/debug'.1090machine # [ 29.547222] (sd-umoun[860]: Unmounting '/oldroot/sys/fs/bpf'.1091machine # [ 29.553769] (sd-umoun[861]: Unmounting '/oldroot/sys/fs/pstore'.1092machine # [ 29.560958] (sd-umoun[862]: Unmounting '/oldroot/sys/fs/cgroup'.1093machine # [ 29.567867] (sd-umoun[863]: Unmounting '/oldroot/sys/kernel/security'.1094machine # [ 29.574539] (sd-umoun[864]: Unmounting '/oldroot/run/shutdown/mounts/777d817632a534f0'.1095machine # [ 29.633991] (sd-umoun[865]: Unmounting '/oldroot/sys'.1096machine # [ 29.638219] (sd-umoun[866]: Unmounting '/oldroot/proc'.1097machine # [ 29.644172] (sd-umoun[867]: Unmounting '/oldroot/dev/shm'.1098machine # [ 29.649006] (sd-umoun[868]: Unmounting '/oldroot/dev/pts'.1099machine # [ 29.653716] (sd-umoun[869]: Unmounting '/oldroot/dev'.1100machine # [ 29.658396] (sd-umoun[870]: Unmounting '/oldroot/run'.1101machine # [ 29.662990] (sd-umoun[871]: Unmounting '/oldroot'.1102machine # [ 29.669775] EXT4-fs (vda): unmounting filesystem 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0.1103machine # [ 29.675821] shutdown[1]: All filesystems unmounted.1104machine # [ 29.678768] shutdown[1]: Deactivating swaps.1105machine # [ 29.681903] shutdown[1]: All swaps deactivated.1106machine # [ 29.684785] shutdown[1]: Detaching loop devices.1107machine # [ 29.693734] shutdown[1]: All loop devices detached.1108machine # [ 29.696910] shutdown[1]: Stopping MD devices.1109machine # [ 29.700112] shutdown[1]: All MD devices stopped.1110machine # [ 29.702992] shutdown[1]: Detaching DM devices.1111machine # [ 29.705983] shutdown[1]: All DM devices detached.1112machine # [ 29.708802] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1113machine # [ 29.713923] shutdown[1]: Syncing filesystems and block devices.1114machine # [ 29.718264] shutdown[1]: Powering off.1115machine # [ 29.755419] Console: switching to colour dummy device 80x251116machine # [ 29.766154] Flash device refused suspend due to active operation (state 20)1117machine # [ 29.766212] Flash device refused suspend due to active operation (state 20)1118machine # [ 29.770427] reboot: Power down1119machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client disconnected, shutting down1120machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client disconnected, shutting down1121machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client disconnected, shutting down1122machine: (finished: waiting for the VM to power off, in 2.21 seconds)1123machine: starting vm1124machine # Starting virtiofs daemons...1125machine: QEMU running (pid 103)1126machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1127machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1128machine: waiting for unit systemd-cryptsetup@luks.service1129machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1130machine: waiting for the VM to finish booting1131machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1132machine # [2026-09-15T21:18:26Z INFO virtiofsd] Waiting for vhost-user socket connection...1133machine # [2026-09-15T21:18:26Z INFO virtiofsd] Waiting for vhost-user socket connection...1134machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1135machine # [2026-09-15T21:18:26Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1136machine # [2026-09-15T21:18:26Z INFO virtiofsd] Waiting for vhost-user socket connection...1137machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client connected, servicing requests1138machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client connected, servicing requests1139machine # [2026-09-15T21:18:26Z INFO virtiofsd] Client connected, servicing requests1140machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]1141machine # [ 0.000000] Linux version 6.18.51 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri Sep 11 09:49:46 UTC 20261142machine # [ 0.000000] KASLR enabled1143machine # [ 0.000000] random: crng init done1144machine # [ 0.000000] Machine model: linux,dummy-virt1145machine # [ 0.000000] efi: UEFI not found.1146machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT1147machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1148machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded4c0-0x7fdf0c3f]1149machine # [ 0.000000] Zone ranges:1150machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1151machine # [ 0.000000] DMA32 empty1152machine # [ 0.000000] Normal empty1153machine # [ 0.000000] Device empty1154machine # [ 0.000000] Movable zone start for each node1155machine # [ 0.000000] Early memory node ranges1156machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]1157machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1158machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001159machine # [ 0.000000] psci: probing for conduit method from DT.1160machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1161machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1162machine # [ 0.000000] psci: Trusted OS migration not required1163machine # [ 0.000000] psci: SMC Calling Convention v1.11164machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1165machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961166machine # [ 0.000000] Detected PIPT I-cache on CPU01167machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1168machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1169machine # [ 0.000000] CPU features: detected: Spectre-v41170machine # [ 0.000000] CPU features: detected: Spectre-BHB1171machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381172machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231173machine # [ 0.000000] alternatives: applying boot alternatives1174machine # [ 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/2pw2gj2rhiqgwryjc5qyfwffmfa9w3q1-nixos-system-machine-test/init regInfo=/nix/store/37b8k4br8ji3vw1az7xxp6jf8066qpy7-closure-info/registration console=ttyAMA0,115200n8 console=tty01175machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/37b8k4br8ji3vw1az7xxp6jf8066qpy7-closure-info/registration", will be passed to user space.1176machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1177machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1178machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1179machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1180machine # [ 0.000000] software IO TLB: area num 1.1181machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1182machine # [ 0.000000] Fallback order for Node 0: 01183machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441184machine # [ 0.000000] Policy zone: DMA1185machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1186machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11187machine # [ 0.000000] allocated 2097152 bytes of page_ext1188machine # [ 0.000000] ftrace: allocating 74894 entries in 294 pages1189machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1190machine # [ 0.000000] rcu: Hierarchical RCU implementation.1191machine # [ 0.000000] rcu: RCU event tracing is enabled.1192machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1193machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1194machine # [ 0.000000] Rude variant of Tasks RCU enabled.1195machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1196machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1197machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11198machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1199machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1200machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1201machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01202machine # [ 0.000000] GICv3: 256 SPIs implemented1203machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1204machine # [ 0.000000] Root IRQ handler: gic_handle_irq1205machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1206machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01207machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001208machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1209machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)1210machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)1211machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d100001212machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d200001213machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1214machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1215machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1216machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1217machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1218machine # [ 0.000042] arm-pv: using stolen time PV1219machine # [ 0.000610] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1220machine # [ 0.000763] Console: colour dummy device 80x251221machine # [ 0.000771] printk: legacy console [tty0] enabled1222machine # [ 0.000958] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1223machine # [ 0.000965] pid_max: default: 32768 minimum: 3011224machine # [ 0.001043] LSM: initializing lsm=capability,landlock,yama,bpf,ima1225machine # [ 0.001208] landlock: Up and running.1226machine # [ 0.001212] Yama: becoming mindful.1227machine # [ 0.001795] LSM support for eBPF active1228machine # [ 0.001942] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1229machine # [ 0.001962] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1230machine # [ 0.003066] cacheinfo: Unable to detect cache hierarchy for CPU 01231machine # [ 0.003884] rcu: Hierarchical SRCU implementation.1232machine # [ 0.003889] rcu: Max phase no-delay instances is 1000.1233machine # [ 0.005189] fsl-mc MSI: its@8080000 domain created1234machine # [ 0.005280] EFI services will not be available.1235machine # [ 0.005360] smp: Bringing up secondary CPUs ...1236machine # [ 0.005369] smp: Brought up 1 node, 1 CPU1237machine # [ 0.005372] SMP: Total of 1 processors activated.1238machine # [ 0.005375] CPU: All CPU(s) started at EL11239machine # [ 0.005388] CPU features: detected: Branch Target Identification1240machine # [ 0.005393] CPU features: detected: ARMv8.4 Translation Table Level1241machine # [ 0.005395] CPU features: detected: Instruction cache invalidation not required for I/D coherence1242machine # [ 0.005399] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1243machine # [ 0.005403] CPU features: detected: Common not Private translations1244machine # [ 0.005406] CPU features: detected: CRC32 instructions1245machine # [ 0.005408] CPU features: detected: Data cache clean to Point of Deep Persistence1246machine # [ 0.005412] CPU features: detected: Data cache clean to Point of Persistence1247machine # [ 0.005415] CPU features: detected: Data independent timing control (DIT)1248machine # [ 0.005418] CPU features: detected: E0PD1249machine # [ 0.005421] CPU features: detected: Enhanced Counter Virtualization1250machine # [ 0.005424] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1251machine # [ 0.005427] CPU features: detected: Enhanced Virtualization Traps1252machine # [ 0.005430] CPU features: detected: Fine Grained Traps1253machine # [ 0.005434] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1254machine # [ 0.005438] CPU features: detected: RCpc load-acquire (LDAPR)1255machine # [ 0.005441] CPU features: detected: LSE atomic instructions1256machine # [ 0.005444] CPU features: detected: Privileged Access Never1257machine # [ 0.005446] CPU features: detected: PMUv31258machine # [ 0.005449] CPU features: detected: RAS Extension Support1259machine # [ 0.005452] CPU features: detected: RASv1p1 Extension Support1260machine # [ 0.005454] CPU features: detected: Random Number Generator1261machine # [ 0.005457] CPU features: detected: Speculation barrier (SB)1262machine # [ 0.005459] CPU features: detected: Stage-2 Force Write-Back1263machine # [ 0.005462] CPU features: detected: TLB range maintenance instructions1264machine # [ 0.005466] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1265machine # [ 0.005507] alternatives: applying system-wide alternatives1266machine # [ 0.008508] CPU features: detected: BBM Level 2 without TLB conflict abort1267machine # [ 0.008739] Memory: 894060K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113244K reserved, 32768K cma-reserved)1268machine # [ 0.009126] devtmpfs: initialized1269machine # [ 0.010980] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1270machine # [ 0.011005] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1271machine # [ 0.011211] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1272machine # [ 0.011216] 0 pages in range for non-PLT usage1273machine # [ 0.011217] 508288 pages in range for PLT usage1274machine # [ 0.011336] pinctrl core: initialized pinctrl subsystem1275machine # [ 0.012114] DMI not present or invalid.1276machine # [ 0.015652] NET: Registered PF_NETLINK/PF_ROUTE protocol family1277machine # [ 0.018146] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1278machine # [ 0.018311] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1279machine # [ 0.018475] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1280machine # [ 0.018509] audit: initializing netlink subsys (disabled)1281machine # [ 0.019201] thermal_sys: Registered thermal governor 'fair_share'1282machine # [ 0.019204] thermal_sys: Registered thermal governor 'bang_bang'1283machine # [ 0.019207] thermal_sys: Registered thermal governor 'step_wise'1284machine # [ 0.019210] thermal_sys: Registered thermal governor 'user_space'1285machine # [ 0.019215] thermal_sys: Registered thermal governor 'power_allocator'1286machine # [ 0.019244] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=11287machine # [ 0.019253] cpuidle: using governor ladder1288machine # [ 0.019258] cpuidle: using governor menu1289machine # [ 0.019479] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1290machine # [ 0.019498] ASID allocator initialised with 65536 entries1291machine # [ 0.020779] Serial: AMBA PL011 UART driver1292machine # [ 0.026556] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev11293machine # [ 0.026706] printk: console [ttyAMA0] enabled1294machine # [ 0.152314] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1295machine # [ 0.152334] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1296machine # [ 0.152341] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1297machine # [ 0.152346] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1298machine # [ 0.152350] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1299machine # [ 0.152354] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1300machine # [ 0.152359] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1301machine # [ 0.152363] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1302machine # [ 0.160338] fbcon: Taking over console1303machine # [ 0.160358] ACPI: Interpreter disabled.1304machine # [ 0.169498] iommu: Default domain type: Translated1305machine # [ 0.169515] iommu: DMA domain TLB invalidation policy: strict mode1306machine # [ 0.169906] SCSI subsystem initialized1307machine # [ 0.171963] usbcore: registered new interface driver usbfs1308machine # [ 0.171988] usbcore: registered new interface driver hub1309machine # [ 0.172014] usbcore: registered new device driver usb1310machine # [ 0.172293] pps_core: LinuxPPS API ver. 1 registered1311machine # [ 0.172299] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1312machine # [ 0.172309] PTP clock support registered1313machine # [ 0.172355] EDAC MC: Ver: 3.0.01314machine # [ 0.177223] scmi_core: SCMI protocol bus registered1315machine # [ 0.178242] FPGA manager framework1316machine # [ 0.179196] vgaarb: loaded1317machine # [ 0.179863] clocksource: Switched to clocksource arch_sys_counter1318machine # [ 0.183619] VFS: Disk quotas dquot_6.6.01319machine # [ 0.183659] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1320machine # [ 0.187611] netfs: FS-Cache loaded1321machine # [ 0.187749] pnp: PnP ACPI: disabled1322machine # [ 0.191932] NET: Registered PF_INET protocol family1323machine # [ 0.192098] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1324machine # [ 0.221775] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1325machine # [ 0.221829] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1326machine # [ 0.221857] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1327machine # [ 0.221907] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1328machine # [ 0.221981] TCP: Hash tables configured (established 8192 bind 8192)1329machine # [ 0.222099] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1330machine # [ 0.222156] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1331machine # [ 0.222208] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1332machine # [ 0.222334] NET: Registered PF_UNIX/PF_LOCAL protocol family1333machine # [ 0.222355] NET: Registered PF_XDP protocol family1334machine # [ 0.222378] PCI: CLS 0 bytes, default 641335machine # [ 0.222646] Trying to unpack rootfs image as initramfs...1336machine # [ 0.243912] kvm [1]: HYP mode not available1337machine # [ 0.352429] Initialise system trusted keyrings1338machine # [ 0.353214] workingset: timestamp_bits=42 max_order=18 bucket_order=01339machine # [ 0.354576] squashfs: version 4.0 (2009/01/31) Phillip Lougher1340machine # [ 0.355371] 9p: Installing v9fs 9p2000 file system support1341machine # [ 0.384185] Key type asymmetric registered1342machine # [ 0.384214] Asymmetric key parser 'x509' registered1343machine # [ 0.384289] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1344machine # [ 0.386540] io scheduler mq-deadline registered1345machine # [ 0.386554] io scheduler kyber registered1346machine # [ 0.396040] pl061_gpio 9030000.pl061: PL061 GPIO chip registered1347machine # [ 0.397532] ledtrig-cpu: registered to indicate activity on CPUs1348machine # [ 0.397932] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:1349machine # [ 0.397949] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x00000000001350machine # [ 0.397963] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x00100000001351machine # [ 0.397971] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x80000000001352machine # [ 0.397999] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits1353machine # [ 0.398024] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1354machine # [ 0.398104] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:001355machine # [ 0.398116] pci_bus 0000:00: root bus resource [bus 00-ff]1356machine # [ 0.398122] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]1357machine # [ 0.398127] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]1358machine # [ 0.398133] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]1359machine # [ 0.398194] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1360machine # [ 0.398664] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1361machine # [ 0.398854] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]1362machine # [ 0.398871] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]1363machine # [ 0.398907] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1364machine # [ 0.398924] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]1365machine # [ 0.399377] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1366machine # [ 0.399563] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]1367machine # [ 0.399579] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]1368machine # [ 0.399609] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1369machine # [ 0.400120] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1370machine # [ 0.400334] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]1371machine # [ 0.400351] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]1372machine # [ 0.400384] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1373machine # [ 0.400846] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1374machine # [ 0.401037] pci 0000:00:04.0: BAR 0 [io 0x0000-0x007f]1375machine # [ 0.401053] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]1376machine # [ 0.401083] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1377machine # [ 0.401546] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1378machine # [ 0.401744] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]1379machine # [ 0.401761] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]1380machine # [ 0.401792] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1381machine # [ 0.401809] pci 0000:00:05.0: ROM [mem 0x00000000-0x0003ffff pref]1382machine # [ 0.402270] pci 0000:00:06.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1383machine # [ 0.402460] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]1384machine # [ 0.402490] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1385machine # [ 0.403017] pci 0000:00:07.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1386machine # [ 0.403207] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]1387machine # [ 0.403236] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1388machine # [ 0.403625] pci 0000:00:08.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1389machine # [ 0.403812] pci 0000:00:08.0: BAR 0 [mem 0x00000000-0x00000fff]1390machine # [ 0.448192] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1391machine # [ 0.448414] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]1392machine # [ 0.448449] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1393machine # [ 0.448922] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1394machine # [ 0.449115] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]1395machine # [ 0.449145] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1396machine # [ 0.449658] pci 0000:00:0b.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1397machine # [ 0.449852] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]1398machine # [ 0.449883] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1399machine # [ 0.450355] pci 0000:00:0c.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1400machine # [ 0.450659] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x003f]1401machine # [ 0.450678] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]1402machine # [ 0.450709] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1403machine # [ 0.451195] pci 0000:00:0d.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1404machine # [ 0.451387] pci 0000:00:0d.0: BAR 0 [io 0x0000-0x001f]1405machine # [ 0.451404] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]1406machine # [ 0.451437] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1407machine # [ 0.452062] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1408machine # [ 0.452074] pci 0000:00:05.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1409machine # [ 0.452080] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1410machine # [ 0.452132] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1411machine # [ 0.452182] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1412machine # [ 0.452234] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1413machine # [ 0.452284] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1414machine # [ 0.452335] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1415machine # [ 0.452386] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1416machine # [ 0.452438] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1417machine # [ 0.452488] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1418machine # [ 0.452537] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1419machine # [ 0.452586] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1420machine # [ 0.452654] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned1421machine # [ 0.452771] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1422machine # [ 0.452795] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1423machine # [ 0.452819] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1424machine # [ 0.452846] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1425machine # [ 0.452870] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1426machine # [ 0.452902] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1427machine # [ 0.452927] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1428machine # [ 0.452950] pci 0000:00:08.0: BAR 0 [mem 0x10087000-0x10087fff]: assigned1429machine # [ 0.452974] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1430machine # [ 0.452997] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1431machine # [ 0.453021] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned1432machine # [ 0.453045] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1433machine # [ 0.453072] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned1434machine # [ 0.453095] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned1435machine # [ 0.453117] pci 0000:00:04.0: BAR 0 [io 0x1080-0x10ff]: assigned1436machine # [ 0.453140] pci 0000:00:0c.0: BAR 0 [io 0x1100-0x113f]: assigned1437machine # [ 0.453162] pci 0000:00:01.0: BAR 0 [io 0x1140-0x115f]: assigned1438machine # [ 0.453186] pci 0000:00:02.0: BAR 0 [io 0x1160-0x117f]: assigned1439machine # [ 0.453209] pci 0000:00:05.0: BAR 0 [io 0x1180-0x119f]: assigned1440machine # [ 0.453232] pci 0000:00:0d.0: BAR 0 [io 0x11a0-0x11bf]: assigned1441machine # [ 0.453261] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]1442machine # [ 0.453272] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]1443machine # [ 0.453277] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]1444machine # [ 0.454253] pci 0000:00:08.0: enabling device (0000 -> 0002)1445machine # [ 0.531710] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1446machine # [ 0.541419] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)1447machine # [ 0.552598] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1448machine # [ 0.554852] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1449machine # [ 0.557200] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1450machine # [ 0.559775] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)1451machine # [ 0.577985] virtio-pci 0000:00:07.0: enabling device (0000 -> 0002)1452machine # [ 0.580949] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)1453machine # [ 0.583165] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1454machine # [ 0.593571] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0002)1455machine # [ 0.596761] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1456machine # [ 0.599401] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0003)1457machine # [ 0.617225] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1458machine # [ 0.620171] msm_serial: driver initialized1459machine # [ 0.620340] SuperH (H)SCI(F) driver initialized1460machine # [ 0.620398] STM32 USART driver initialized1461machine # [ 0.656534] loop: module loaded1462machine # [ 0.656765] virtio_blk virtio2: 1/0/0 default/read/poll queues1463machine # [ 0.657727] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)1464machine # [ 0.664155] virtio_blk virtio3: 1/0/0 default/read/poll queues1465machine # [ 0.664983] virtio_blk virtio3: [vdb] 1048576 512-byte logical blocks (537 MB/512 MiB)1466machine # [ 0.680796] megasas: 07.734.00.00-rc11467machine # [ 0.681719] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1468machine # [ 0.684031] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001469machine # [ 0.684074] Intel/Sharp Extended Query Table at 0x00311470machine # [ 0.686003] Using buffer write method1471machine # [ 0.686088] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1472machine # [ 0.694326] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001473machine # [ 0.694357] Intel/Sharp Extended Query Table at 0x00311474machine # [ 0.696120] Using buffer write method1475machine # [ 0.696157] Concatenating MTD devices:1476machine # [ 0.696161] (0): "0.flash"1477machine # [ 0.696165] (1): "0.flash"1478machine # [ 0.696168] into device "0.flash"1479machine # [ 1.011666] Freeing initrd memory: 26388K1480machine # [ 1.018626] tun: Universal TUN/TAP device driver, 1.61481machine # [ 1.023051] thunder_xcv, ver 1.01482machine # [ 1.023135] thunder_bgx, ver 1.01483machine # [ 1.023190] nicpf, ver 1.01484machine # [ 1.023820] e1000: Intel(R) PRO/1000 Network Driver1485machine # [ 1.023832] e1000: Copyright (c) 1999-2006 Intel Corporation.1486machine # [ 1.023862] e1000e: Intel(R) PRO/1000 Network Driver1487machine # [ 1.027279] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1488machine # [ 1.027340] igb: Intel(R) Gigabit Ethernet Network Driver1489machine # [ 1.027347] igb: Copyright (c) 2007-2014 Intel Corporation.1490machine # [ 1.027371] igbvf: Intel(R) Gigabit Virtual Function Network Driver1491machine # [ 1.027377] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1492machine # [ 1.027533] sky2: driver version 1.301493machine # [ 1.033403] usbcore: registered new interface driver usb-storage1494machine # [ 1.033516] usbcore: registered new interface driver usbserial_generic1495machine # [ 1.033531] usbserial: USB Serial support registered for generic1496machine # [ 1.034190] hv_vmbus: registering driver hyperv_keyboard1497machine # [ 1.035675] ehci-pci 0000:00:08.0: EHCI Host Controller1498machine # [ 1.035715] ehci-pci 0000:00:08.0: new USB bus registered, assigned bus number 11499machine # [ 1.036072] ehci-pci 0000:00:08.0: irq 17, io mem 0x100870001500machine # [ 1.041938] rtc-pl031 9010000.pl031: registered as rtc01501machine # [ 1.041975] rtc-pl031 9010000.pl031: setting system clock to 2026-09-15T21:18:28 UTC (1789507108)1502machine # [ 1.042389] i2c_dev: i2c /dev entries driver1503machine # [ 1.048154] sdhci: Secure Digital Host Controller Interface driver1504machine # [ 1.048166] sdhci: Copyright(c) Pierre Ossman1505machine # [ 1.048454] Synopsys Designware Multimedia Card Interface Driver1506machine # [ 1.048840] sdhci-pltfm: SDHCI platform and OF driver helper1507machine # [ 1.050471] hid: raw HID events driver (C) Jiri Kosina1508machine # [ 1.050754] usbcore: registered new interface driver usbhid1509machine # [ 1.050765] usbhid: USB HID core driver1510machine # [ 1.056696] ehci-pci 0000:00:08.0: USB 2.0 started, EHCI 1.001511machine # [ 1.057792] hub 1-0:1.0: USB hub found1512machine # [ 1.058316] hub 1-0:1.0: 6 ports detected1513machine # [ 1.059327] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available1514machine # [ 1.062222] drop_monitor: Initializing network drop monitor service1515machine # [ 1.062437] NET: Registered PF_INET6 protocol family1516machine # [ 1.064480] Segment Routing with IPv61517machine # [ 1.064505] In-situ OAM (IOAM) with IPv61518machine # [ 1.064538] NET: Registered PF_PACKET protocol family1519machine # [ 1.066267] 9pnet: Installing 9P2000 support1520machine # [ 1.066322] Key type dns_resolver registered1521machine # [ 1.073229] registered taskstats version 11522machine # [ 1.073383] Loading compiled-in X.509 certificates1523machine # [ 1.082660] Demotion targets for Node 0: null1524machine # [ 1.082797] Key type .fscrypt registered1525machine # [ 1.082804] Key type fscrypt-provisioning registered1526machine # [ 1.082928] ima: No TPM chip found, activating TPM-bypass!1527machine # [ 1.082948] ima: Allocated hash algorithm: sha11528machine # [ 1.082972] ima: No architecture policies found1529machine # [ 1.087422] input: gpio-keys as /devices/platform/gpio-keys/input/input01530machine # [ 1.106978] clk: Disabling unused clocks1531machine # [ 1.107022] PM: genpd: Disabling unused power domains1532machine # [ 1.111457] Freeing unused kernel memory: 4736K1533machine # [ 1.111682] Run /init as init process1534machine # [ 1.131014] systemd[1]: Successfully made /usr/ read-only.1535machine # [ 1.303993] usb 1-1: new high-speed USB device number 2 using ehci-pci1536machine # [ 1.458805] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11537machine # [ 1.466138] systemd[1]: systemd 262-e2c8482 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)1538machine # [ 1.479630] systemd[1]: Detected virtualization qemu.1539machine # [ 1.482179] systemd[1]: Detected architecture arm64.1540machine # [ 1.484308] systemd[1]: Running in initrd.1541machine # [ 1.487411] systemd[1]: Initializing machine ID from random generator.1542machine # [ 1.490810] systemd[1]: Hostname set to <machine>.1543machine # [ 1.552243] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:08.0-1/input01544machine # [ 1.654221] systemd[1]: bpf-restrict-fs: LSM BPF program attached1545machine # [ 1.671995] usb 1-2: new high-speed USB device number 3 using ehci-pci1546machine # [ 1.717611] systemd[1]: Queued start job for default target Initrd Default Target.1547machine # [ 1.726143] systemd[1]: Created slice Slice /system/modprobe.1548machine # [ 1.727261] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1549machine # [ 1.728463] systemd[1]: Expecting device /dev/disk/by-label/nixos...1550machine # [ 1.729339] systemd[1]: Reached target Path Units.1551machine # [ 1.730024] systemd[1]: Reached target Slice Units.1552machine # [ 1.730682] systemd[1]: Reached target Swaps.1553machine # [ 1.731272] systemd[1]: Reached target Timer Units.1554machine # [ 1.732247] systemd[1]: Listening on D-Bus System Message Bus Socket.1555machine # [ 1.733319] systemd[1]: Listening on Journal Socket (/dev/log).1556machine # [ 1.734264] systemd[1]: Listening on Journal Sockets.1557machine # [ 1.735052] systemd[1]: Listening on udev Kernel Socket.1558machine # [ 1.735761] systemd[1]: Reached target Socket Units.1559machine # [ 1.738387] systemd[1]: Starting Create List of Static Device Nodes...1560machine # [ 1.738480] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1561machine # [ 1.748119] systemd[1]: Mounting Kernel Configuration File System...1562machine # [ 1.756214] systemd[1]: Starting Journal Service...1563machine # [ 1.788328] systemd[1]: Starting Load Kernel Modules...1564machine # [ 1.789258] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1565machine # [ 1.809710] systemd[1]: Starting Coldplug All udev Devices...1566machine # [ 1.815044] systemd-journald[72]: Collecting audit messages is disabled.1567machine # [ 1.831086] systemd[1]: Finished Create List of Static Device Nodes.1568machine # [ 1.834918] systemd[1]: Mounted Kernel Configuration File System.1569machine # [ 1.844480] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21570machine # [ 1.844648] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:08.0-2/input01571machine # [ 1.848319] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1572machine # [ 1.864102] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1573machine # [ 1.866071] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1574machine # [ 1.890117] [drm] pci: virtio-gpu-pci detected at 0000:00:06.01575machine # [ 1.890411] [drm] features: -virgl +edid -resource_blob -host_visible1576machine # [ 1.890424] [drm] features: -context_init1577machine # [ 1.891227] [drm] number of scanouts: 11578machine # [ 1.891250] [drm] number of cap sets: 01579machine # [ 1.908106] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1580machine # [ 1.911127] systemd[1]: Starting Create Static Device Nodes in /dev...1581machine # [ 1.924248] virtio-pci 0000:00:06.0: [drm] Registered 1 planes with drm panic1582machine # [ 1.924277] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:06.0 on minor 01583machine # [ 1.952757] Console: switching to colour frame buffer device 160x501584machine # [ 1.980127] virtio-pci 0000:00:06.0: [drm] fb0: virtio_gpudrmfb frame buffer device1585machine # [ 1.985826] systemd[1]: Finished Load Kernel Modules.1586machine # [ 1.989461] systemd[1]: Starting Apply Kernel Variables...1587machine # [ 2.016293] systemd[1]: Finished Create Static Device Nodes in /dev.1588machine # [ 2.016783] systemd[1]: Reached target Preparation for Local File Systems.1589machine # [ 2.016828] systemd[1]: Reached target Local File Systems.1590machine # [ 2.022753] systemd[1]: Starting Rule-based Manager for Device Events and Files...1591machine # [ 2.024116] systemd-modules-load[73]: Inserted module 'dm_mod'1592machine # [ 2.025349] systemd-modules-load[73]: Module 'virtio_balloon' is built in1593machine # [ 2.026573] systemd-modules-load[73]: Module 'virtio_console' is built in1594machine # [ 2.027683] systemd-modules-load[73]: Inserted module 'virtio_gpu'1595machine # [ 2.052248] systemd[1]: Started Journal Service.1596machine # [ 2.035421] systemd-modules-load[73]: Module 'virtio_rng' is built in1597machine # [ 2.050385] systemd[1]: Finished Apply Kernel Variables.1598machine # [ 2.069020] systemd[1]: Starting Create System Files and Directories...1599machine # [ 2.101173] systemd-udevd[80]: Using default interface naming scheme 'v261'.1600machine # [ 2.115497] systemd[1]: Finished Create System Files and Directories.1601machine # [ 2.138361] systemd[1]: Started Rule-based Manager for Device Events and Files.1602machine # [ 2.220775] systemd[1]: Starting Virtual Console Setup...1603machine # [ 2.304615] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1604machine # [ 2.308729] systemd[1]: Finished Virtual Console Setup.1605machine # [ 2.974902] systemd[1]: Finished Coldplug All udev Devices.1606machine # [ 2.976905] systemd[1]: Reached target System Initialization.1607machine # [ 2.980906] systemd[1]: Reached target Basic System.1608machine # [ 3.120097] (udev-worker)[96]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1609machine # [ 3.159251] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line.1610machine # [ 3.233007] systemd[1]: Found device /dev/disk/by-label/nixos.1611machine # [ 3.236753] systemd[1]: Reached target Initrd Root Device.1612machine # [ 3.239451] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1613machine # [ 3.300235] systemd-fsck[110]: nixos: clean, 225/65536 files, 15236/262144 blocks1614machine # [ 3.308083] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1615machine # [ 3.318324] systemd[1]: Mounting /sysroot...1616machine # [ 3.376405] EXT4-fs (vda): mounted filesystem 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0 r/w with ordered data mode. Quota mode: none.1617machine # [ 3.362574] systemd[1]: Mounted /sysroot.1618machine # [ 3.365001] systemd[1]: Reached target Initrd Root File System.1619machine # [ 3.370729] systemd[1]: Starting Mountpoints Configured in the Real Root...1620machine # [ 3.404219] systemd-sysroot-fstab-check[118]: /sysroot should be mounted in the initrd, will request daemon-reload.1621machine # [ 3.410696] systemd[1]: Reload requested from client PID 118 ('systemd-sysroot') (unit initrd-parse-etc.service)...1622machine # [ 3.413906] systemd[1]: Reloading...1623machine # [ 3.632174] systemd[1]: Reloading finished in 217 ms.1624machine # [ 3.662361] systemd-sysroot-fstab-check[118]: Requesting initrd-fs.target/start/replace...1625machine # [ 3.665283] systemd-sysroot-fstab-check[118]: Requesting swap.target/start/replace...1626machine # [ 3.670991] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1627machine # [ 3.675662] systemd[1]: Finished Mountpoints Configured in the Real Root.1628machine # [ 3.677482] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1629machine # [ 3.795733] systemd[1]: Mounting /sysroot/nix/.ro-store...1630machine # [ 3.816261] systemd[1]: Mounting /sysroot/nix/.rw-store...1631machine # [ 3.821274] systemd[1]: Mounting /sysroot/run...1632machine # [ 3.853417] systemd[1]: Mounting /sysroot/tmp/shared...1633machine # [ 3.901548] systemd[1]: Mounting /sysroot/tmp/xchg...1634machine # [ 3.925720] fuse: init (API version 7.45)1635machine # [ 3.936333] virtiofs virtio7: discovered new tag: nix-store1636machine # [ 3.937155] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1637machine # [ 3.953821] virtiofs virtio8: discovered new tag: shared1638machine # [ 3.954681] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1639machine # [ 3.967464] virtiofs virtio9: discovered new tag: xchg1640machine # [ 3.974724] virtiofs virtio9: virtio_fs_setup_dax: No cache capability1641machine # [ 3.961865] systemd[1]: Mounted /sysroot/nix/.rw-store.1642machine # [ 3.964770] systemd[1]: Mounted /sysroot/run.1643machine # [ 3.982450] systemd[1]: Mounted /sysroot/nix/.ro-store.1644machine # [ 4.011717] systemd[1]: Starting rw-sysroot-nix-store.service...1645machine # [ 4.016196] systemd[1]: Mounted /sysroot/tmp/shared.1646machine # [ 4.030820] systemd[1]: Mounted /sysroot/tmp/xchg.1647machine # [ 4.058873] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1648machine # [ 4.060702] systemd[1]: Finished rw-sysroot-nix-store.service.1649machine # [ 4.761228] (udev-worker)[91]: mtd0ro: Failed to find and pin callout binary "/nix/store/yf6qr0y28a50mnhgyrfdk0hmnvgr6c9d-systemd-262-e2c8482/lib/udev/mtd_probe": No such file or directory1650machine # [ 4.765348] (udev-worker)[91]: 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 directory1651machine # [ 4.809444] tpm_tis c000000.tpm_tis: 2.0 TPM (device-id 0x1, rev-id 1)1652machine # [ 4.797774] systemd[1]: Mounting /sysroot/nix/store...1653machine # [ 4.829607] tpm tpm0: A TPM error (256) occurred attempting the self test1654machine # [ 4.829676] tpm tpm0: starting up the TPM manually1655machine # [ 4.842171] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1656machine # [ 4.843417] systemd[1]: Stopped Virtual Console Setup.1657machine # [ 4.844284] systemd[1]: Stopping Virtual Console Setup...1658machine # [ 4.848651] systemd[1]: Starting Virtual Console Setup...1659machine # [ 4.868603] systemd[1]: Mounted /sysroot/nix/store.1660machine # [ 4.883826] systemd[1]: Reached target Initrd File Systems.1661machine # [ 4.890269] systemd[1]: Starting Find NixOS closure...1662machine # [ 4.902480] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1663machine # [ 4.925460] systemd-vconsole-setup[153]: Configuration of first virtual console was skipped, ignoring remaining ones.1664machine # [ 4.936129] systemd[1]: Finished Virtual Console Setup.1665machine # [ 4.937917] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.1666machine # [ 4.968903] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1667machine # [ 4.972323] systemd[1]: Finished Find NixOS closure.1668machine # [ 4.974631] systemd[1]: Reached target Initrd Default Target.1669machine # [ 4.977794] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1670machine # [ 4.986717] systemd[1]: Reached target Trusted Platform Module.1671machine # [ 5.010969] systemd[1]: Stopped target Initrd Default Target.1672machine # [ 5.016602] systemd[1]: Stopped target Basic System.1673machine # [ 5.017539] systemd[1]: Stopped target Initrd Root Device.1674machine # [ 5.018431] systemd[1]: Stopped target Path Units.1675machine # [ 5.019197] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1676machine # [ 5.021409] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1677machine # [ 5.024356] systemd[1]: Stopped target Slice Units.1678machine # [ 5.028305] systemd[1]: Stopped target Socket Units.1679machine # [ 5.029274] systemd[1]: Stopped target System Initialization.1680machine # [ 5.030240] systemd[1]: Stopped target Swaps.1681machine # [ 5.031441] systemd[1]: Stopped target Timer Units.1682machine # [ 5.033453] systemd[1]: Stopped target Trusted Platform Module.1683machine # [ 5.039964] systemd[1]: dbus.socket: Deactivated successfully.1684machine # [ 5.042030] systemd[1]: Closed D-Bus System Message Bus Socket.1685machine # [ 5.045286] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1686machine # [ 5.048274] systemd[1]: Stopped Find NixOS closure.1687machine # [ 5.052925] systemd[1]: Starting rw-sysroot-nix-store.service...1688machine # [ 5.058125] systemd[1]: systemd-sysctl.service: Deactivated successfully.1689machine # [ 5.059348] systemd[1]: Stopped Apply Kernel Variables.1690machine # [ 5.068692] systemd[1]: systemd-modules-load.service: Deactivated successfully.1691machine # [ 5.069975] systemd[1]: Stopped Load Kernel Modules.1692machine # [ 5.070973] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1693machine # [ 5.081588] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1694machine # [ 5.082941] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1695machine # [ 5.087324] systemd[1]: Stopped Create System Files and Directories.1696machine # [ 5.090911] systemd[1]: Stopped target Local File Systems.1697machine # [ 5.091840] systemd[1]: Stopped target Preparation for Local File Systems.1698machine # [ 5.094160] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1699machine # [ 5.096559] systemd[1]: Stopped Coldplug All udev Devices.1700machine # [ 5.100356] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1701machine # [ 5.101608] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1702machine # [ 5.104317] systemd[1]: Stopped Virtual Console Setup.1703machine # [ 5.105193] systemd[1]: initrd-cleanup.service: Deactivated successfully.1704machine # [ 5.106604] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1705machine # [ 5.107744] systemd[1]: systemd-udevd.service: Deactivated successfully.1706machine # [ 5.109123] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1707machine # [ 5.110207] systemd[1]: systemd-udevd.service: Consumed 1.688s CPU time over 3.078s wall clock time, 22.2M memory peak.1708machine # [ 5.111708] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1709machine # [ 5.116479] systemd[1]: Finished rw-sysroot-nix-store.service.1710machine # [ 5.119930] systemd[1]: Starting Cleanup udev Database...1711machine # [ 5.121805] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1712machine # [ 5.128253] systemd[1]: Stopped Create Static Device Nodes in /dev.1713machine # [ 5.129364] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1714machine # [ 5.130590] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1715machine # [ 5.131641] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1716machine # [ 5.136200] systemd[1]: Stopped Create List of Static Device Nodes.1717machine # [ 5.168680] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1718machine # [ 5.170647] systemd[1]: Finished Cleanup udev Database.1719machine # [ 5.174021] systemd[1]: Reached target Switch Root.1720machine # [ 5.175424] systemd[1]: Starting NixOS Activation...1721machine # [ 5.278266] initrd-nixos-activation-start[174]: booting system configuration /nix/store/2pw2gj2rhiqgwryjc5qyfwffmfa9w3q1-nixos-system-machine-test1722machine # [ 5.314849] initrd-nixos-activation-start[174]: running activation script...1723machine # [ 5.590992] initrd-nixos-activation-start[197]: setting up /etc...1724machine # [ 5.795094] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1725machine # [ 5.805893] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1726machine # [ 5.808483] systemd[1]: Finished NixOS Activation.1727machine # [ 5.816389] systemd[1]: Starting Switch Root...1728machine # [ 5.836590] systemd[1]: Switching root.1729machine # [ 6.030068] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1730machine # [ 6.559147] systemd[1]: systemd 262-e2c8482 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)1731machine # [ 6.572576] systemd[1]: Detected virtualization qemu.1732machine # [ 6.575922] systemd[1]: Detected architecture arm64.1733machine # [ 6.748179] systemd[1]: bpf-restrict-fs: LSM BPF program attached1734machine # [ 7.182772] systemd[1]: initrd-switch-root.service: Deactivated successfully.1735machine # [ 7.184723] systemd[1]: Stopped initrd-switch-root.service.1736machine # [ 7.188325] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1737machine # [ 7.191262] systemd[1]: Created slice Slice /system/getty.1738machine # [ 7.193541] systemd[1]: Created slice Slice /system/systemd-cryptsetup.1739machine # [ 7.195641] systemd[1]: Created slice User and Session Slice.1740machine # [ 7.197182] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1741machine # [ 7.199019] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1742machine # [ 7.200967] systemd[1]: Expecting device /dev/hvc0...1743machine # [ 7.203365] systemd[1]: Expecting device /dev/ttyAMA0...1744machine # [ 7.204531] systemd[1]: Expecting device /dev/vdb...1745machine # [ 7.207027] systemd[1]: Stopped target initrd-fs.target.1746machine # [ 7.208184] systemd[1]: Stopped target initrd-root-fs.target.1747machine # [ 7.209873] systemd[1]: Stopped target initrd-switch-root.target.1748machine # [ 7.211513] systemd[1]: Reached target Virtual Machines and Containers.1749machine # [ 7.213265] systemd[1]: Reached target Path Units.1750machine # [ 7.215658] systemd[1]: Reached target Remote File Systems.1751machine # [ 7.216816] systemd[1]: Reached target Slice Units.1752machine # [ 7.218207] systemd[1]: Reached target Swaps.1753machine # [ 7.221083] systemd[1]: Listening on Query the User Interactively for a Password.1754machine # [ 7.224111] systemd[1]: Listening on Process Core Dump Socket.1755machine # [ 7.226346] systemd[1]: Listening on Credential Encryption/Decryption.1756machine # [ 7.228532] systemd[1]: Listening on Factory Reset Management.1757machine # [ 7.229819] systemd[1]: Listening on Hostname Service Socket.1758machine # [ 7.234216] systemd[1]: Starting Journal Log Access Socket...1759machine # [ 7.236568] systemd[1]: Listening on Journal Audit Socket.1760machine # [ 7.240423] systemd[1]: Listening on Console Output Muting Service Socket.1761machine # [ 7.242082] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1762machine # [ 7.243770] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1763machine # [ 7.246925] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1764machine # [ 7.254682] systemd[1]: Listening on Disk Repartitioning Service Socket.1765machine # [ 7.256264] systemd[1]: Listening on udev Varlink Socket.1766machine # [ 7.260381] systemd[1]: Mounting Huge Pages File System...1767machine # [ 7.268845] systemd[1]: Mounting POSIX Message Queue File System...1768machine # [ 7.272681] systemd[1]: Mounting Kernel Debug File System...1769machine # [ 7.290285] systemd[1]: Mounting Kernel Trace File System...1770machine # [ 7.300836] systemd[1]: Starting Create List of Static Device Nodes...1771machine # [ 7.308176] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1772machine # [ 7.324872] systemd[1]: Mounting Kernel Configuration File System...1773machine # [ 7.331093] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1774machine # [ 7.339441] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1775machine # [ 7.341749] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1776machine # [ 7.371805] systemd[1]: Mounting FUSE Control File System...1777machine # [ 7.380603] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671778machine # [ 7.411748] systemd[1]: Starting Journal Service...1779machine # [ 7.433273] systemd[1]: Starting Load Kernel Modules...1780machine # [ 7.458530] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1781machine # [ 7.488934] systemd[1]: Starting Remount Root and Kernel File Systems...1782machine # [ 7.489389] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1783machine # [ 7.513692] systemd[1]: Starting Coldplug All udev Devices...1784machine # [ 7.522361] systemd-journald[268]: Collecting audit messages is enabled.1785machine # [ 7.530420] systemd[1]: Listening on Journal Log Access Socket.1786machine # [ 7.535864] systemd[1]: Mounted Huge Pages File System.1787machine # [ 7.539261] systemd[1]: Mounted POSIX Message Queue File System.1788machine # [ 7.523257] systemd[1]: Queued start job for default target Multi-User System.1789machine # [ 7.545023] systemd[1]: Started Journal Service.1790machine # [ 7.531717] systemd[1]: systemd-journald.service: Deactivated successfully.1791machine # [ 7.536624] systemd[1]: Mounted Kernel Debug File System.1792machine # [ 7.537620] systemd[1]: Mounted Kernel Trace File System.1793machine # [ 7.544205] systemd[1]: Finished Create List of Static Device Nodes.1794machine # [ 7.545240] systemd[1]: Mounted Kernel Configuration File System.1795machine # [ 7.562085] systemd-modules-load[269]: Module 'atkbd' is built in1796machine # [ 7.572294] systemd-modules-load[269]: Module 'loop' is built in1797machine # [ 7.584188] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1798machine # [ 7.587980] systemd[1]: Finished Load Kernel Modules.1799machine # [ 7.620198] EXT4-fs (vda): re-mounted 328bcb36-d74d-4bc9-8a4d-ea7dc360a8d0.1800machine # [ 7.604378] systemd[1]: Starting Firewall...1801machine # [ 7.616543] systemd-oomd[271]: No swap; memory pressure usage will be degraded1802machine # [ 7.620843] systemd[1]: Starting Apply Kernel Variables...1803machine # [ 7.623337] systemd[1]: Mounted FUSE Control File System.1804machine # [ 7.629437] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1805machine # [ 7.636925] systemd[1]: Finished Remount Root and Kernel File Systems.1806machine # [ 7.660775] systemd[1]: Listening on Disk Image Download Service Socket.1807machine # [ 7.680690] systemd[1]: Starting Flush Journal to Persistent Storage...1808machine # [ 7.681978] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1809machine # [ 7.696192] systemd[1]: Starting Load/Save OS Random Seed...1810machine # [ 7.697185] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1811machine # [ 7.794585] systemd-journald[268]: Received client request to flush runtime journal.1812machine # [ 7.844869] systemd[1]: Finished Load/Save OS Random Seed.1813machine # [ 7.845886] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes1814machine # [ 7.856360] systemd[1]: Finished Flush Journal to Persistent Storage.1815machine # [ 7.864948] systemd[1]: Finished Apply Kernel Variables.1816machine # [ 7.870545] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1817machine # [ 7.876679] systemd[1]: Starting Create Static Device Nodes in /dev...1818machine # [ 8.162642] systemd[1]: Finished Create Static Device Nodes in /dev.1819machine # [ 8.163762] systemd[1]: Reached target Preparation for Local File Systems.1820machine # [ 8.174030] systemd[1]: Starting Rule-based Manager for Device Events and Files...1821machine # [ 8.184204] systemd[1]: Mounting /run/wrappers...1822machine # [ 8.269391] systemd[1]: Mounted /run/wrappers.1823machine # [ 8.273283] systemd[1]: Reached target Local File Systems.1824machine # [ 8.284232] systemd[1]: Listening on Boot Loader Control Service Socket.1825machine # [ 8.287962] systemd[1]: Starting Create SUID/SGID Wrappers...1826machine # [ 8.289459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1827machine # [ 8.290805] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id1828machine # [ 8.304528] systemd[1]: Starting Create System Files and Directories...1829machine # [ 8.370716] systemd-udevd[307]: Using default interface naming scheme 'v261'.1830machine # [ 8.495472] systemd[1]: Finished Create System Files and Directories.1831machine # [ 8.501799] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var1832machine # [ 8.503178] systemd[1]: Update is Completed skipped, no trigger condition checks were met.1833machine # [ 8.509946] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1834machine # [ 8.540316] systemd[1]: Started Rule-based Manager for Device Events and Files.1835machine # [ 8.614787] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1836machine # [ 9.029572] systemd[1]: Finished Coldplug All udev Devices.1837machine # [ 9.078994] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1838machine # [ 9.122039] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1839machine # [ 9.365447] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1840machine # [ 9.370398] systemd[1]: Finished Create SUID/SGID Wrappers.1841machine # [ 9.378094] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1842machine # [ 9.421603] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1843machine # [ 9.542189] systemd[1]: Condition check resulted in /dev/tpmrm0 being skipped.1844machine # [ 9.543342] systemd[1]: Expecting device /dev/tpm0...1845machine # [ 9.554238] (udev-worker)[358]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1846machine # [ 9.558565] (udev-worker)[358]: Network interface NamePolicy= disabled on kernel command line.1847machine # [ 9.571944] systemd[1]: Condition check resulted in /dev/vdb being skipped.1848machine # [ 9.581038] systemd[1]: Starting Cryptography Setup for luks...1849machine # [ 9.936947] systemd[1]: Condition check resulted in Virtio network device being skipped.1850machine # [ 9.948117] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1851machine # [ 9.953691] systemd[1]: Starting Create SUID/SGID Wrappers...1852machine # [ 9.954663] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1853machine # [ 9.955895] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671854machine # [ 9.972415] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var1855machine # [ 9.973793] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id1856machine # [ 9.975352] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1857machine # [ 9.990963] systemd[1]: Update is Completed skipped, no trigger condition checks were met.1858machine # [ 10.338441] mousedev: PS/2 mouse device common for all mice1859machine # [ 10.452180] systemd[1]: Finished Firewall.1860machine # [ 10.502695] Key type trusted registered1861machine # [ 10.506829] Key type encrypted registered1862machine # [ 10.816423] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1863machine # [ 10.819882] systemd[1]: Finished Create SUID/SGID Wrappers.1864machine # [ 11.306856] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/virtio6/input/input31865machine # [ 11.548156] systemd[1]: Condition check resulted in /dev/tpm0 being skipped.1866machine # [ 11.552374] systemd[1]: Reached target Trusted Platform Module.1867machine # [ 11.553485] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1868machine # [ 11.554825] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1869machine # [ 11.721319] systemd[1]: Starting Virtual Console Setup...1870machine # [ 11.746212] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1871machine # [ 11.749854] systemd[1]: Stopped Virtual Console Setup.1872machine # [ 11.759815] systemd[1]: Starting Virtual Console Setup...1873machine # [ 11.853165] systemd[1]: Finished Cryptography Setup for luks.1874machine # [ 11.854722] systemd[1]: Reached target Local Encrypted Volumes.1875machine # [ 11.946584] systemd-vconsole-setup[558]: Configuration of first virtual console was skipped, ignoring remaining ones.1876machine # [ 11.951987] systemd[1]: Finished Virtual Console Setup.1877machine # [ 11.953470] systemd[1]: Reached target System Initialization.1878machine # [ 11.956539] systemd[1]: Started Discard unused filesystem blocks once a week.1879machine # [ 11.958639] systemd[1]: Started Daily Cleanup of Temporary Directories.1880machine # [ 11.961547] systemd[1]: Reached target Timer Units.1881machine # [ 11.964808] systemd[1]: Listening on D-Bus System Message Bus Socket.1882machine # [ 11.965823] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1883machine # [ 11.967031] systemd[1]: Reached target Socket Units.1884machine # [ 11.967778] systemd[1]: Reached target Basic System.1885machine # [ 11.971851] systemd[1]: Started backdoor.service.1886machine # [ 11.974294] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db1887machine # [ 11.980462] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1888machine # [ 11.982486] systemd[1]: Starting Post-Boot Actions...1889machine # [ 12.009032] systemd[1]: Started Reset console on configuration changes.1890machine # [ 12.029885] systemd[1]: Starting resolvconf update...1891machine # [ 12.071999] systemd[1]: Starting D-Bus System Message Bus...1892machine # [ 12.090776] nsncd[565]: Sep 15 21:18:39.566 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1893machine # [ 12.099543] systemd[1]: Finished Post-Boot Actions.1894machine # [ 12.103267] systemd[1]: Started Name Service Cache Daemon (nsncd).1895machine # [ 12.110387] systemd[1]: Reached target Host and Network Name Lookups.1896machine # [ 12.111600] systemd[1]: Reached target User and Group Name Lookups.1897machine # connecting to host...1898machine # [ 12.143403] systemd[1]: Starting User Login Management...1899machine: Guest shell says: b'Spawning backdoor root shell...\n'1900machine: connected to guest root shell1901machine: (connecting took 12.54 seconds)1902machine: (finished: waiting for the VM to finish booting, in 12.54 seconds)1903machine # [ 12.324281] dbus-broker-launch[570]: Looking up NSS user entry for 'systemd-timesync'...1904machine # [ 12.339877] dbus-broker-launch[570]: NSS returned no entry for 'systemd-timesync'1905machine # [ 12.343437] dbus-broker-launch[570]: Invalid user-name in /nix/store/kiv06p8mj99a1w7zd9q0gnbf2v7w2mnn-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1906machine: (finished: waiting for unit systemd-cryptsetup@luks.service, in 12.73 seconds)1907machine: must succeed: systemd-cryptenroll --wipe-slot=tpm2 /dev/vdb1908machine # [ 12.387314] systemd-logind[585]: New seat seat0.1909machine # [ 12.395579] systemd[1]: Started D-Bus System Message Bus.1910machine # [ 12.406739] systemd-logind[585]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1911machine # [ 12.416696] systemd-logind[585]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1912machine # [ 12.418087] systemd-logind[585]: Watching system buttons on /dev/input/event0 (gpio-keys)1913machine # [ 12.419196] systemd[1]: Started User Login Management.1914machine # [ 12.439887] systemd[1]: Starting linger-users.service...1915machine # [ 12.454285] dbus-broker-launch[570]: Ready1916machine # [ 12.527720] systemd[1]: linger-users.service: Deactivated successfully.1917machine # [ 12.530694] systemd[1]: Finished linger-users.service.1918machine # [ 12.541273] systemd[1]: Stopped target Host and Network Name Lookups.1919machine # [ 12.549274] systemd[1]: Stopping Host and Network Name Lookups...1920machine # [ 12.550366] systemd[1]: Stopped target User and Group Name Lookups.1921machine # [ 12.551272] systemd[1]: Stopping User and Group Name Lookups...1922machine # [ 12.560375] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1923machine # [ 12.561405] systemd[1]: nscd.service: Deactivated successfully.1924machine # [ 12.562275] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1925machine # Wiped slot 1.1926machine # [ 12.582838] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1927machine: (finished: must succeed: systemd-cryptenroll --wipe-slot=tpm2 /dev/vdb, in 0.22 seconds)1928(finished: run the VM test script, in 44.41 seconds)1929machine # [ 12.663534] systemd[1]: Started Name Service Cache Daemon (nsncd).1930machine # [ 12.668946] systemd[1]: Reached target Host and Network Name Lookups.1931machine # [ 12.672584] nsncd[647]: Sep 15 21:18:40.142 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1932machine # [ 12.674894] systemd[1]: Reached target User and Group Name Lookups.1933machine # [ 12.681063] systemd[1]: Finished resolvconf update.1934machine # [ 12.681949] systemd[1]: Reached target Preparation for Network.1935machine # [ 12.684898] systemd[1]: Starting DHCP Client...1936machine # [ 12.691481] systemd[1]: Starting Address configuration of eth1...1937machine # [ 12.701362] systemd[1]: Starting Extra networking commands....1938machine # [ 12.825177] network-addresses-eth1-start[674]: adding address 192.168.1.1/24... done1939test script finished in 44.65s1940cleanup1941kill QemuMachine (pid 103)1942machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)1943machine # [2026-09-15T21:18:40Z INFO virtiofsd] Client disconnected, shutting down1944machine # [2026-09-15T21:18:40Z INFO virtiofsd] Client disconnected, shutting down1945machine # [2026-09-15T21:18:40Z INFO virtiofsd] Client disconnected, shutting down1946(finished: cleanup, in 0.07 seconds)