nixbot

builds

succeeded vm-test-run-systemd-initrd-simple checks.aarch64-linux.systemd-initrd-simple · build #35 · 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 script7subtest: testing initrd backdoor8machine: waiting for unit initrd.target9machine: waiting for the VM to finish booting10machine: starting vm11machine # Disk image does not exist, creating the virtualisation disk image...12machine: QEMU running (pid 45)13machine # Formatting '/build/vm-state-machine/tmp.oCbPqQ1MDS', fmt=raw size=107374182414machine # mke2fs 1.47.4 (6-Mar-2025)15machine # Discarding device blocks: 0/262144 done16machine # Creating filesystem with 262144 4k blocks and 65536 inodes17machine # Filesystem UUID: e0472b85-873b-4ccf-b92c-741e50f7a11118machine # Superblock backups stored on blocks:19machine # 32768, 98304, 163840, 22937620machine # 21machine # Allocating group tables: 0/8 done22machine # Writing inode tables: 0/8 done23machine # Creating journal (8192 blocks): done24machine # Writing superblocks and filesystem accounting information: 0/8 done25machine # 26machine # Virtualisation disk image created.27machine # Starting virtiofs daemons...28machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)29machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether30machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)31machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether32machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33machine # [2026-09-14T03:00:29Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34machine # [2026-09-14T03:00:29Z INFO virtiofsd] Waiting for vhost-user socket connection...35machine # [2026-09-14T03:00:29Z INFO virtiofsd] Waiting for vhost-user socket connection...36machine # [2026-09-14T03:00:29Z INFO virtiofsd] Waiting for vhost-user socket connection...37machine # [2026-09-14T03:00:29Z INFO virtiofsd] Client connected, servicing requests38machine # [2026-09-14T03:00:29Z INFO virtiofsd] Client connected, servicing requests39machine # [2026-09-14T03:00:29Z 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 0x7fded700-0x7fdf0e7f]49machine # [ 0.000000] Zone ranges:50machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]51machine # [ 0.000000] DMA32 empty52machine # [ 0.000000] Normal empty53machine # [ 0.000000] Device empty54machine # [ 0.000000] Movable zone start for each node55machine # [ 0.000000] Early memory node ranges56machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]57machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]58machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000059machine # [ 0.000000] psci: probing for conduit method from DT.60machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.61machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs62machine # [ 0.000000] psci: Trusted OS migration not required63machine # [ 0.000000] psci: SMC Calling Convention v1.164machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)65machine # [ 0.000000] percpu: Embedded 76 pages/cpu 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/sgbymhnd6pd3bgq1lrpzlcjkwz6qna4r-nixos-system-machine-test/init regInfo=/nix/store/vh860w6m3xng9sz3w7v0lil7k7icn892-closure-info/registration console=ttyAMA0,115200n8 console=tty075machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vh860w6m3xng9sz3w7v0lil7k7icn892-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.000031] arm-pv: using stolen time PV119machine # [ 0.000438] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)120machine # [ 0.000632] Console: colour dummy device 80x25121machine # [ 0.000639] printk: legacy console [tty0] enabled122machine # [ 0.000833] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)123machine # [ 0.000840] pid_max: default: 32768 minimum: 301124machine # [ 0.000919] LSM: initializing lsm=capability,landlock,yama,bpf,ima125machine # [ 0.001096] landlock: Up and running.126machine # [ 0.001099] Yama: becoming mindful.127machine # [ 0.001595] LSM support for eBPF active128machine # [ 0.001710] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)129machine # [ 0.001735] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)130machine # [ 0.002850] cacheinfo: Unable to detect cache hierarchy for CPU 0131machine # [ 0.003589] rcu: Hierarchical SRCU implementation.132machine # [ 0.003593] rcu: Max phase no-delay instances is 1000.133machine # [ 0.004865] fsl-mc MSI: its@8080000 domain created134machine # [ 0.004958] EFI services will not be available.135machine # [ 0.005026] smp: Bringing up secondary CPUs ...136machine # [ 0.005035] smp: Brought up 1 node, 1 CPU137machine # [ 0.005038] SMP: Total of 1 processors activated.138machine # [ 0.005041] CPU: All CPU(s) started at EL1139machine # [ 0.005055] CPU features: detected: Branch Target Identification140machine # [ 0.005060] CPU features: detected: ARMv8.4 Translation Table Level141machine # [ 0.005063] CPU features: detected: Instruction cache invalidation not required for I/D coherence142machine # [ 0.005067] CPU features: detected: Data cache clean to the PoU not required for I/D coherence143machine # [ 0.005070] CPU features: detected: Common not Private translations144machine # [ 0.005073] CPU features: detected: CRC32 instructions145machine # [ 0.005076] CPU features: detected: Data cache clean to Point of Deep Persistence146machine # [ 0.005080] CPU features: detected: Data cache clean to Point of Persistence147machine # [ 0.005083] CPU features: detected: Data independent timing control (DIT)148machine # [ 0.005086] CPU features: detected: E0PD149machine # [ 0.005089] CPU features: detected: Enhanced Counter Virtualization150machine # [ 0.005092] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)151machine # [ 0.005095] CPU features: detected: Enhanced Virtualization Traps152machine # [ 0.005098] CPU features: detected: Fine Grained Traps153machine # [ 0.005102] CPU features: detected: Generic authentication (architected QARMA5 algorithm)154machine # [ 0.005107] CPU features: detected: RCpc load-acquire (LDAPR)155machine # [ 0.005110] CPU features: detected: LSE atomic instructions156machine # [ 0.005113] CPU features: detected: Privileged Access Never157machine # [ 0.005116] CPU features: detected: PMUv3158machine # [ 0.005118] CPU features: detected: RAS Extension Support159machine # [ 0.005121] CPU features: detected: RASv1p1 Extension Support160machine # [ 0.005124] CPU features: detected: Random Number Generator161machine # [ 0.005126] CPU features: detected: Speculation barrier (SB)162machine # [ 0.005129] CPU features: detected: Stage-2 Force Write-Back163machine # [ 0.005132] CPU features: detected: TLB range maintenance instructions164machine # [ 0.005137] CPU features: detected: Speculative Store Bypassing Safe (SSBS)165machine # [ 0.005175] alternatives: applying system-wide alternatives166machine # [ 0.008268] CPU features: detected: BBM Level 2 without TLB conflict abort167machine # [ 0.008458] Memory: 894000K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113232K reserved, 32768K cma-reserved)168machine # [ 0.008814] devtmpfs: initialized169machine # [ 0.010584] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)170machine # [ 0.010607] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).171machine # [ 0.010810] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL172machine # [ 0.010814] 0 pages in range for non-PLT usage173machine # [ 0.010815] 508288 pages in range for PLT usage174machine # [ 0.010934] pinctrl core: initialized pinctrl subsystem175machine # [ 0.011708] DMI not present or invalid.176machine # [ 0.014793] NET: Registered PF_NETLINK/PF_ROUTE protocol family177machine # [ 0.017094] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations178machine # [ 0.017281] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations179machine # [ 0.017442] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations180machine # [ 0.017464] audit: initializing netlink subsys (disabled)181machine # [ 0.018049] thermal_sys: Registered thermal governor 'fair_share'182machine # [ 0.018051] thermal_sys: Registered thermal governor 'bang_bang'183machine # [ 0.018055] thermal_sys: Registered thermal governor 'step_wise'184machine # [ 0.018058] thermal_sys: Registered thermal governor 'user_space'185machine # [ 0.018063] thermal_sys: Registered thermal governor 'power_allocator'186machine # [ 0.018095] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1187machine # [ 0.018104] cpuidle: using governor ladder188machine # [ 0.018111] cpuidle: using governor menu189machine # [ 0.018311] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.190machine # [ 0.018328] ASID allocator initialised with 65536 entries191machine # [ 0.019457] Serial: AMBA PL011 UART driver192machine # [ 0.024709] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1193machine # [ 0.024867] printk: console [ttyAMA0] enabled194machine # [ 0.152755] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages195machine # [ 0.152775] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page196machine # [ 0.152781] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages197machine # [ 0.152786] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page198machine # [ 0.152790] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages199machine # [ 0.152795] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page200machine # [ 0.152799] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages201machine # [ 0.152803] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page202machine # [ 0.160486] fbcon: Taking over console203machine # [ 0.160504] ACPI: Interpreter disabled.204machine # [ 0.162463] iommu: Default domain type: Translated205machine # [ 0.162474] iommu: DMA domain TLB invalidation policy: strict mode206machine # [ 0.164198] SCSI subsystem initialized207machine # [ 0.169263] usbcore: registered new interface driver usbfs208machine # [ 0.169296] usbcore: registered new interface driver hub209machine # [ 0.169315] usbcore: registered new device driver usb210machine # [ 0.169581] pps_core: LinuxPPS API ver. 1 registered211machine # [ 0.169588] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>212machine # [ 0.169598] PTP clock support registered213machine # [ 0.169654] EDAC MC: Ver: 3.0.0214machine # [ 0.174490] scmi_core: SCMI protocol bus registered215machine # [ 0.175478] FPGA manager framework216machine # [ 0.176469] vgaarb: loaded217machine # [ 0.177115] clocksource: Switched to clocksource arch_sys_counter218machine # [ 0.183563] VFS: Disk quotas dquot_6.6.0219machine # [ 0.183611] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)220machine # [ 0.185404] netfs: FS-Cache loaded221machine # [ 0.185559] pnp: PnP ACPI: disabled222machine # [ 0.189512] NET: Registered PF_INET protocol family223machine # [ 0.189671] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)224machine # [ 0.220169] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)225machine # [ 0.220225] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)226machine # [ 0.220257] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)227machine # [ 0.220310] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)228machine # [ 0.220386] TCP: Hash tables configured (established 8192 bind 8192)229machine # [ 0.220509] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)230machine # [ 0.220568] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)231machine # [ 0.220618] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)232machine # [ 0.220737] NET: Registered PF_UNIX/PF_LOCAL protocol family233machine # [ 0.220802] NET: Registered PF_XDP protocol family234machine # [ 0.220825] PCI: CLS 0 bytes, default 64235machine # [ 0.221082] Trying to unpack rootfs image as initramfs...236machine # [ 0.239150] kvm [1]: HYP mode not available237machine # [ 0.352878] Initialise system trusted keyrings238machine # [ 0.353747] workingset: timestamp_bits=42 max_order=18 bucket_order=0239machine # [ 0.355112] squashfs: version 4.0 (2009/01/31) Phillip Lougher240machine # [ 0.355909] 9p: Installing v9fs 9p2000 file system support241machine # [ 0.379989] Key type asymmetric registered242machine # [ 0.380021] Asymmetric key parser 'x509' registered243machine # [ 0.380105] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)244machine # [ 0.389173] io scheduler mq-deadline registered245machine # [ 0.389198] io scheduler kyber registered246machine # [ 0.394345] pl061_gpio 9030000.pl061: PL061 GPIO chip registered247machine # [ 0.395646] ledtrig-cpu: registered to indicate activity on CPUs248machine # [ 0.396017] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:249machine # [ 0.396034] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000250machine # [ 0.396045] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000251machine # [ 0.396054] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000252machine # [ 0.396075] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits253machine # [ 0.396097] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]254machine # [ 0.396174] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00255machine # [ 0.396184] pci_bus 0000:00: root bus resource [bus 00-ff]256machine # [ 0.396190] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]257machine # [ 0.396195] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]258machine # [ 0.396201] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]259machine # [ 0.396265] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint260machine # [ 0.396718] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint261machine # [ 0.396909] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]262machine # [ 0.396926] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]263machine # [ 0.396957] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]264machine # [ 0.396974] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]265machine # [ 0.397482] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint266machine # [ 0.397673] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]267machine # [ 0.397691] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]268machine # [ 0.397721] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]269machine # [ 0.398204] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint270machine # [ 0.398400] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]271machine # [ 0.398417] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]272machine # [ 0.398447] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]273machine # [ 0.398925] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274machine # [ 0.399113] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]275machine # [ 0.399129] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]276machine # [ 0.399160] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277machine # [ 0.399179] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]278machine # [ 0.399662] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint279machine # [ 0.399856] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]280machine # [ 0.399887] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]281machine # [ 0.400380] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint282machine # [ 0.400569] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]283machine # [ 0.400599] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]284machine # [ 0.401002] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint285machine # [ 0.441267] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]286machine # [ 0.441662] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint287machine # [ 0.441861] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]288machine # [ 0.441891] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]289machine # [ 0.442366] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint290machine # [ 0.442560] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]291machine # [ 0.442594] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292machine # [ 0.443077] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint293machine # [ 0.443269] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]294machine # [ 0.443300] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]295machine # [ 0.443778] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint296machine # [ 0.444077] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]297machine # [ 0.444094] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]298machine # [ 0.444125] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]299machine # [ 0.444607] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint300machine # [ 0.444797] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]301machine # [ 0.444815] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]302machine # [ 0.444846] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]303machine # [ 0.465591] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned304machine # [ 0.465620] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned305machine # [ 0.465626] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned306machine # [ 0.465680] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned307machine # [ 0.465735] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned308machine # [ 0.465787] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned309machine # [ 0.465839] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned310machine # [ 0.465891] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned311machine # [ 0.465942] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned312machine # [ 0.465991] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned313machine # [ 0.466040] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned314machine # [ 0.466089] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned315machine # [ 0.466216] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned316machine # [ 0.466266] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned317machine # [ 0.466293] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned318machine # [ 0.466315] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned319machine # [ 0.466338] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned320machine # [ 0.466361] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned321machine # [ 0.466384] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned322machine # [ 0.466406] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned323machine # [ 0.466431] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned324machine # [ 0.466458] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned325machine # [ 0.466483] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned326machine # [ 0.466508] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned327machine # [ 0.466532] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned328machine # [ 0.466554] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned329machine # [ 0.466576] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned330machine # [ 0.466598] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned331machine # [ 0.466621] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned332machine # [ 0.466645] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned333machine # [ 0.466667] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned334machine # [ 0.466694] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]335machine # [ 0.466704] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]336machine # [ 0.466709] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]337machine # [ 0.467542] pci 0000:00:07.0: enabling device (0000 -> 0002)338machine # [ 0.524212] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)339machine # [ 0.534731] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)340machine # [ 0.539291] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)341machine # [ 0.545390] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)342machine # [ 0.547717] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)343machine # [ 0.558154] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)344machine # [ 0.559977] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)345machine # [ 0.570452] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)346machine # [ 0.572501] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)347machine # [ 0.576053] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)348machine # [ 0.584747] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)349machine # [ 0.601935] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled350machine # [ 0.604568] msm_serial: driver initialized351machine # [ 0.604712] SuperH (H)SCI(F) driver initialized352machine # [ 0.604766] STM32 USART driver initialized353machine # [ 0.639740] loop: module loaded354machine # [ 0.639973] virtio_blk virtio2: 1/0/0 default/read/poll queues355machine # [ 0.640835] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)356machine # [ 0.645892] megasas: 07.734.00.00-rc1357machine # [ 0.646588] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]358machine # [ 0.658798] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000359machine # [ 0.658865] Intel/Sharp Extended Query Table at 0x0031360machine # [ 0.660596] Using buffer write method361machine # [ 0.660677] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]362machine # [ 0.671393] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000363machine # [ 0.671434] Intel/Sharp Extended Query Table at 0x0031364machine # [ 0.681812] Using buffer write method365machine # [ 0.681857] Concatenating MTD devices:366machine # [ 0.681861] (0): "0.flash"367machine # [ 0.681865] (1): "0.flash"368machine # [ 0.681869] into device "0.flash"369machine # [ 0.956564] Freeing initrd memory: 26372K370machine # [ 0.962745] tun: Universal TUN/TAP device driver, 1.6371machine # [ 0.966781] thunder_xcv, ver 1.0372machine # [ 0.966819] thunder_bgx, ver 1.0373machine # [ 0.966840] nicpf, ver 1.0374machine # [ 0.967372] e1000: Intel(R) PRO/1000 Network Driver375machine # [ 0.967380] e1000: Copyright (c) 1999-2006 Intel Corporation.376machine # [ 0.967409] e1000e: Intel(R) PRO/1000 Network Driver377machine # [ 0.967418] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.378machine # [ 0.967452] igb: Intel(R) Gigabit Ethernet Network Driver379machine # [ 0.967458] igb: Copyright (c) 2007-2014 Intel Corporation.380machine # [ 0.967484] igbvf: Intel(R) Gigabit Virtual Function Network Driver381machine # [ 0.967490] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.382machine # [ 0.967621] sky2: driver version 1.30383machine # [ 0.969899] ehci-pci 0000:00:07.0: EHCI Host Controller384machine # [ 0.969930] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1385machine # [ 0.970137] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000386machine # [ 0.979943] usbcore: registered new interface driver usb-storage387machine # [ 0.980030] usbcore: registered new interface driver usbserial_generic388machine # [ 0.980045] usbserial: USB Serial support registered for generic389machine # [ 0.980656] hv_vmbus: registering driver hyperv_keyboard390machine # [ 0.981174] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00391machine # [ 0.981604] hub 1-0:1.0: USB hub found392machine # [ 0.981626] hub 1-0:1.0: 6 ports detected393machine # [ 0.987169] rtc-pl031 9010000.pl031: registered as rtc0394machine # [ 0.987201] rtc-pl031 9010000.pl031: setting system clock to 2026-09-14T03:00:31 UTC (1789354831)395machine # [ 0.987549] i2c_dev: i2c /dev entries driver396machine # [ 0.993030] sdhci: Secure Digital Host Controller Interface driver397machine # [ 0.993043] sdhci: Copyright(c) Pierre Ossman398machine # [ 0.994673] Synopsys Designware Multimedia Card Interface Driver399machine # [ 0.995046] sdhci-pltfm: SDHCI platform and OF driver helper400machine # [ 0.996565] hid: raw HID events driver (C) Jiri Kosina401machine # [ 0.996811] usbcore: registered new interface driver usbhid402machine # [ 0.996819] usbhid: USB HID core driver403machine # [ 1.001301] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available404machine # [ 1.002786] drop_monitor: Initializing network drop monitor service405machine # [ 1.002987] NET: Registered PF_INET6 protocol family406machine # [ 1.006480] Segment Routing with IPv6407machine # [ 1.006500] In-situ OAM (IOAM) with IPv6408machine # [ 1.006546] NET: Registered PF_PACKET protocol family409machine # [ 1.008233] 9pnet: Installing 9P2000 support410machine # [ 1.008291] Key type dns_resolver registered411machine # [ 1.015152] registered taskstats version 1412machine # [ 1.015309] Loading compiled-in X.509 certificates413machine # [ 1.023952] Demotion targets for Node 0: null414machine # [ 1.024072] Key type .fscrypt registered415machine # [ 1.024083] Key type fscrypt-provisioning registered416machine # [ 1.024184] ima: No TPM chip found, activating TPM-bypass!417machine # [ 1.024204] ima: Allocated hash algorithm: sha1418machine # [ 1.024225] ima: No architecture policies found419machine # [ 1.028562] input: gpio-keys as /devices/platform/gpio-keys/input/input0420machine # [ 1.047362] clk: Disabling unused clocks421machine # [ 1.047396] PM: genpd: Disabling unused power domains422machine # [ 1.051675] Freeing unused kernel memory: 4736K423machine # [ 1.051915] Run /init as init process424machine # [ 1.067497] systemd[1]: Successfully made /usr/ read-only.425machine # [ 1.229217] usb 1-1: new high-speed USB device number 2 using ehci-pci426machine # [ 1.381959] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1427machine # [ 1.402569] systemd[1]: systemd 262-5698092 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)428machine # [ 1.415612] systemd[1]: Detected virtualization qemu.429machine # [ 1.417957] systemd[1]: Detected architecture arm64.430machine # [ 1.420356] systemd[1]: Running in initrd.431machine # [ 1.423579] systemd[1]: Initializing machine ID from random generator.432machine # [ 1.426798] systemd[1]: Hostname set to <machine>.433machine # [ 1.473512] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0434machine # [ 1.584578] systemd[1]: bpf-restrict-fs: LSM BPF program attached435machine # [ 1.597264] usb 1-2: new high-speed USB device number 3 using ehci-pci436machine # [ 1.647860] systemd[1]: Queued start job for default target Initrd Default Target.437machine # [ 1.659400] systemd[1]: Created slice Slice /system/modprobe.438machine # [ 1.660489] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.439machine # [ 1.661899] systemd[1]: Expecting device /dev/disk/by-label/nixos...440machine # [ 1.661924] systemd[1]: Expecting device /dev/hvc0...441machine # [ 1.661936] systemd[1]: Expecting device /dev/ttyAMA0...442machine # [ 1.661969] systemd[1]: Reached target Path Units.443machine # [ 1.661987] systemd[1]: Reached target Slice Units.444machine # [ 1.662005] systemd[1]: Reached target Swaps.445machine # [ 1.662023] systemd[1]: Reached target Timer Units.446machine # [ 1.662228] systemd[1]: Listening on D-Bus System Message Bus Socket.447machine # [ 1.662372] systemd[1]: Listening on Journal Socket (/dev/log).448machine # [ 1.662502] systemd[1]: Listening on Journal Sockets.449machine # [ 1.662586] systemd[1]: Listening on udev Kernel Socket.450machine # [ 1.662603] systemd[1]: Reached target Socket Units.451machine # [ 1.672572] systemd[1]: Starting Create List of Static Device Nodes...452machine # [ 1.673629] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs453machine # [ 1.684609] systemd[1]: Mounting Kernel Configuration File System...454machine # [ 1.713577] systemd[1]: Starting Journal Service...455machine # [ 1.716180] systemd[1]: Starting Load Kernel Modules...456machine # [ 1.717059] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os457machine # [ 1.725413] systemd[1]: Starting Coldplug All udev Devices...458machine # [ 1.733565] systemd[1]: Finished Create List of Static Device Nodes.459machine # [ 1.735794] systemd[1]: Mounted Kernel Configuration File System.460machine # [ 1.748707] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...461machine # [ 1.767650] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2462machine # [ 1.767844] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0463machine # [ 1.807421] systemd-journald[72]: Collecting audit messages is disabled.464machine # [ 1.823548] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.465machine # [ 1.833959] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.466machine # [ 1.836924] systemd[1]: Starting Create Static Device Nodes in /dev...467machine # [ 1.849202] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev468machine # [ 1.855804] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0469machine # [ 1.856070] [drm] features: -virgl +edid -resource_blob -host_visible470machine # [ 1.856083] [drm] features: -context_init471machine # [ 1.856946] [drm] number of scanouts: 1472machine # [ 1.856973] [drm] number of cap sets: 0473machine # [ 1.877508] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic474machine # [ 1.877536] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0475machine # [ 1.909945] Console: switching to colour frame buffer device 160x50476machine # [ 1.916869] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device477machine # [ 1.925883] systemd[1]: Finished Create Static Device Nodes in /dev.478machine # [ 1.926150] systemd[1]: Reached target Preparation for Local File Systems.479machine # [ 1.926187] systemd[1]: Reached target Local File Systems.480machine # [ 1.933645] systemd[1]: Starting Rule-based Manager for Device Events and Files...481machine # [ 1.957861] systemd[1]: Finished Load Kernel Modules.482machine # [ 1.981340] systemd[1]: Starting Apply Kernel Variables...483machine # [ 1.988403] systemd-modules-load[73]: Inserted module 'dm_mod'484machine # [ 1.989615] systemd-modules-load[73]: Module 'virtio_balloon' is built in485machine # [ 1.990901] systemd-modules-load[73]: Module 'virtio_console' is built in486machine # [ 2.009532] systemd[1]: Started Journal Service.487machine # [ 2.000351] systemd-modules-load[73]: Inserted module 'virtio_gpu'488machine # [ 2.008606] systemd-modules-load[73]: Module 'virtio_rng' is built in489machine # [ 2.017542] systemd[1]: Starting Create System Files and Directories...490machine # [ 2.025216] systemd[1]: Finished Apply Kernel Variables.491machine # [ 2.047766] systemd-udevd[79]: Using default interface naming scheme 'v261'.492machine # [ 2.073649] systemd[1]: Finished Create System Files and Directories.493machine # [ 2.092206] systemd[1]: Started Rule-based Manager for Device Events and Files.494machine # [ 2.184163] systemd[1]: Starting Virtual Console Setup...495machine # [ 2.256547] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.496machine # [ 2.260460] systemd[1]: Finished Virtual Console Setup.497machine # [ 2.841454] systemd[1]: Finished Coldplug All udev Devices.498machine # [ 2.844184] systemd[1]: Reached target System Initialization.499machine # [ 2.848225] systemd[1]: Reached target Basic System.500machine # [ 2.969396] systemd[1]: Found device /dev/hvc0.501machine # [ 2.977842] systemd[1]: Found device /dev/ttyAMA0.502machine # [ 2.983241] systemd[1]: Started backdoor.service.503machine # [ 3.016816] backdoor-start[108]: /nix/store/7ha5lhh89qiqfnvv3zlydbcanibmd4n6-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found504machine # connecting to host...505machine # [ 3.027206] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.506machine: Guest shell says: b'Spawning backdoor root shell...\n'507machine: connected to guest root shell508machine # [ 3.035234] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.509machine: (connecting took 3.47 seconds)510machine: (finished: waiting for the VM to finish booting, in 4.10 seconds)511machine # [ 3.044051] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.512machine # [ 3.136195] systemd[1]: Found device /dev/disk/by-label/nixos.513machine # [ 3.139659] systemd[1]: Reached target Initrd Root Device.514machine # [ 3.144163] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...515machine # [ 3.193058] systemd-fsck[124]: nixos: clean, 12/65536 files, 13019/262144 blocks516machine # [ 3.218703] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.517machine # [ 3.224246] systemd[1]: Mounting /sysroot...518machine # [ 3.278317] EXT4-fs (vda): mounted filesystem e0472b85-873b-4ccf-b92c-741e50f7a111 r/w with ordered data mode. Quota mode: none.519machine # [ 3.269646] systemd[1]: Mounted /sysroot.520machine # [ 3.271951] systemd[1]: Reached target Initrd Root File System.521machine # [ 3.276267] systemd[1]: Starting Mountpoints Configured in the Real Root...522machine # [ 3.309449] systemd-sysroot-fstab-check[132]: /sysroot should be mounted in the initrd, will request daemon-reload.523machine # [ 3.316093] systemd[1]: Reload requested from client PID 132 ('systemd-sysroot') (unit initrd-parse-etc.service)...524machine # [ 3.317795] systemd[1]: Reloading...525machine # [ 3.530533] systemd[1]: Reloading finished in 215 ms.526machine # [ 3.560354] systemd-sysroot-fstab-check[132]: Requesting initrd-fs.target/start/replace...527machine # [ 3.565227] systemd-sysroot-fstab-check[132]: Requesting swap.target/start/replace...528machine # [ 3.570089] systemd[1]: initrd-parse-etc.service: Deactivated successfully.529machine # [ 3.573253] systemd[1]: Finished Mountpoints Configured in the Real Root.530machine # [ 3.574287] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.531machine # [ 3.715311] systemd[1]: Mounting /sysroot/nix/.ro-store...532machine # [ 3.732937] systemd[1]: Mounting /sysroot/nix/.rw-store...533machine # [ 3.741402] systemd[1]: Mounting /sysroot/run...534machine # [ 3.781333] systemd[1]: Mounting /sysroot/tmp/shared...535machine # [ 3.791740] systemd[1]: Mounting /sysroot/tmp/xchg...536machine # [ 3.835841] systemd[1]: Mounted /sysroot/nix/.rw-store.537machine # [ 3.860888] fuse: init (API version 7.45)538machine # [ 3.882474] virtiofs virtio6: discovered new tag: nix-store539machine # [ 3.883344] virtiofs virtio6: virtio_fs_setup_dax: No cache capability540machine # [ 3.899198] virtiofs virtio7: discovered new tag: shared541machine # [ 3.900023] virtiofs virtio7: virtio_fs_setup_dax: No cache capability542machine # [ 3.906651] virtiofs virtio8: discovered new tag: xchg543machine # [ 3.907490] virtiofs virtio8: virtio_fs_setup_dax: No cache capability544machine # [ 3.895048] systemd[1]: Starting rw-sysroot-nix-store.service...545machine # [ 3.914661] systemd[1]: Mounted /sysroot/run.546machine # [ 3.925554] systemd[1]: Mounted /sysroot/tmp/shared.547machine # [ 3.935416] systemd[1]: Mounted /sysroot/nix/.ro-store.548machine # [ 3.946536] systemd[1]: Mounted /sysroot/tmp/xchg.549machine # [ 3.957916] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.550machine # [ 3.959993] systemd[1]: Finished rw-sysroot-nix-store.service.551machine # [ 4.573880] (udev-worker)[92]: mtd0ro: Failed to find and pin callout binary "/nix/store/1g1nz2bgg9igl4hxl9i65z83g21a371k-systemd-262-5698092/lib/udev/mtd_probe": No such file or directory552machine # [ 4.577364] (udev-worker)[92]: 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 directory553machine # [ 4.614416] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.554machine # [ 4.615584] systemd[1]: Stopped Virtual Console Setup.555machine # [ 4.620776] systemd[1]: Stopping Virtual Console Setup...556machine # [ 4.621617] systemd[1]: Starting Virtual Console Setup...557machine # [ 4.639821] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.558machine # [ 4.642895] systemd[1]: Stopped Virtual Console Setup.559machine # [ 4.644440] systemd[1]: Starting Virtual Console Setup...560machine # [ 4.675399] systemd-vconsole-setup[177]: Configuration of first virtual console was skipped, ignoring remaining ones.561machine # [ 4.679230] systemd[1]: Finished Virtual Console Setup.562machine # [ 4.714925] systemd[1]: Mounting /sysroot/nix/store...563machine # [ 4.754727] systemd[1]: Mounted /sysroot/nix/store.564machine # [ 4.757327] systemd[1]: Reached target Initrd File Systems.565machine # [ 4.758840] systemd[1]: Starting Find NixOS closure...566machine # [ 4.766172] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...567machine # [ 4.804255] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.568machine # [ 4.809766] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.569machine # [ 4.820243] systemd[1]: Finished Find NixOS closure.570machine # [ 4.821166] systemd[1]: Reached target Initrd Default Target.571machine # [ 4.823264] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...572machine # [ 4.845468] systemd[1]: initrd-cleanup.service: Deactivated successfully.573machine # [ 4.847133] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.574machine # [ 4.860654] systemd[1]: Startup finished in 1.039s (kernel) + 0 (initrd) + 3.820s (userspace) = 4.860s.575machine: (finished: waiting for unit initrd.target, in 6.26 seconds)576machine: must succeed: systemctl status initrd-fs.target577machine: (finished: must succeed: systemctl status initrd-fs.target, in 0.03 seconds)578machine: waiting for unit initrd.target579machine: (finished: waiting for unit initrd.target, in 0.03 seconds)580machine: waiting for the VM to finish booting581machine # [ 5.289609] systemd[1]: Stopped target Initrd Default Target.582machine # [ 5.293172] systemd[1]: Stopped target Basic System.583machine # [ 5.294340] systemd[1]: Stopped target Initrd Root Device.584machine # [ 5.295499] systemd[1]: Stopped target Path Units.585machine # [ 5.302943] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.586machine # [ 5.306831] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.587machine # [ 5.312514] systemd[1]: Stopped target Slice Units.588machine # [ 5.313519] systemd[1]: Stopped target Socket Units.589machine # [ 5.314417] systemd[1]: Stopped target System Initialization.590machine # [ 5.315411] systemd[1]: Stopped target Swaps.591machine # [ 5.320424] systemd[1]: Stopped target Timer Units.592machine # [ 5.321315] systemd[1]: dbus.socket: Deactivated successfully.593machine # [ 5.322262] systemd[1]: Closed D-Bus System Message Bus Socket.594machine # [ 5.323213] systemd[1]: Stopping backdoor.service...595machine # [ 5.328166] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...596machine # [ 5.332683] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.597machine # [ 5.336673] systemd[1]: Stopped Find NixOS closure.598machine # [ 5.340791] systemd[1]: Starting rw-sysroot-nix-store.service...599machine # [ 5.342945] systemd[1]: systemd-sysctl.service: Deactivated successfully.600machine # [ 5.345898] systemd[1]: Stopped Apply Kernel Variables.601machine # [ 5.347669] systemd[1]: systemd-modules-load.service: Deactivated successfully.602machine # [ 5.358526] systemd[1]: Stopped Load Kernel Modules.603machine # [ 5.362973] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.604machine # [ 5.370385] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.605machine # [ 5.371658] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.606machine # [ 5.376397] systemd[1]: Stopped Create System Files and Directories.607machine # [ 5.380287] systemd[1]: Stopped target Local File Systems.608machine # [ 5.381234] systemd[1]: Stopped target Preparation for Local File Systems.609machine # [ 5.382216] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.610machine # [ 5.384708] systemd[1]: Stopped Coldplug All udev Devices.611machine # [ 5.386335] systemd[1]: Stopping Rule-based Manager for Device Events and Files...612machine # [ 5.388852] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.613machine # [ 5.391317] systemd[1]: Stopped Virtual Console Setup.614machine # [ 5.393103] systemd[1]: backdoor.service: Deactivated successfully.615machine # [ 5.394039] systemd[1]: Stopped backdoor.service.616machine # [ 5.394740] systemd[1]: systemd-udevd.service: Deactivated successfully.617machine # [ 5.395679] systemd[1]: Stopped Rule-based Manager for Device Events and Files.618machine # [ 5.402051] systemd[1]: systemd-udevd.service: Consumed 1.524s CPU time over 3.445s wall clock time, 22.3M memory peak.619machine # [ 5.404748] systemd[1]: Starting Cleanup udev Database...620machine # [ 5.408511] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.621machine # [ 5.409896] systemd[1]: Stopped Create Static Device Nodes in /dev.622machine # [ 5.412323] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.623machine # [ 5.416168] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.624machine # [ 5.417240] systemd[1]: kmod-static-nodes.service: Deactivated successfully.625machine # [ 5.420214] systemd[1]: Stopped Create List of Static Device Nodes.626machine # [ 5.421149] systemd[1]: initrd-cleanup.service: Deactivated successfully.627machine # [ 5.424408] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.628machine # [ 5.425418] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.629machine # [ 5.428310] systemd[1]: Finished rw-sysroot-nix-store.service.630machine # [ 5.451519] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.631machine # [ 5.455413] systemd[1]: Finished Cleanup udev Database.632machine # [ 5.457121] systemd[1]: Reached target Switch Root.633machine # [ 5.460406] systemd[1]: Starting NixOS Activation...634machine # [ 5.554729] initrd-nixos-activation-start[220]: booting system configuration /nix/store/sgbymhnd6pd3bgq1lrpzlcjkwz6qna4r-nixos-system-machine-test635machine # [ 5.591741] initrd-nixos-activation-start[220]: running activation script...636machine # [ 5.876722] initrd-nixos-activation-start[243]: setting up /etc...637machine # [ 6.012985] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.638machine # [ 6.015610] systemd[1]: Finished NixOS Activation.639machine # [ 6.017048] systemd[1]: Starting Switch Root...640machine # [ 6.041048] systemd[1]: Switching root.641machine # [ 6.215129] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).642machine # [ 6.738291] systemd[1]: systemd 262-5698092 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)643machine # [ 6.751759] systemd[1]: Detected virtualization qemu.644machine # [ 6.755351] systemd[1]: Detected architecture arm64.645machine # [ 6.759575] systemd[1]: Detected first boot.646machine # [ 6.765480] systemd[1]: Initializing machine ID from random generator.647machine # [ 6.935589] systemd[1]: bpf-restrict-fs: LSM BPF program attached648machine # [ 7.134699] systemd[1]: Applying preset policy.649machine # [ 7.357787] systemd[1]: Populated /etc with preset unit settings.650machine # [ 7.581285] systemd[1]: initrd-switch-root.service: Deactivated successfully.651machine # [ 7.583057] systemd[1]: Stopped initrd-switch-root.service.652machine # [ 7.586756] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.653machine # [ 7.590699] systemd[1]: Created slice Slice /system/getty.654machine # [ 7.593961] systemd[1]: Created slice User and Session Slice.655machine # [ 7.596338] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.656machine # [ 7.599702] systemd[1]: Started Forward Password Requests to Wall Directory Watch.657machine # [ 7.602505] systemd[1]: Expecting device /dev/hvc0...658machine # [ 7.604686] systemd[1]: Expecting device /dev/ttyAMA0...659machine # [ 7.607723] systemd[1]: Reached target Local Encrypted Volumes.660machine # [ 7.609110] systemd[1]: Stopped target initrd-fs.target.661machine # [ 7.610883] systemd[1]: Stopped target initrd-root-fs.target.662machine # [ 7.613562] systemd[1]: Stopped target initrd-switch-root.target.663machine # [ 7.615849] systemd[1]: Reached target Virtual Machines and Containers.664machine # [ 7.618258] systemd[1]: Reached target Path Units.665machine # [ 7.620306] systemd[1]: Reached target Remote File Systems.666machine # [ 7.622562] systemd[1]: Reached target Slice Units.667machine # [ 7.624650] systemd[1]: Reached target Swaps.668machine # [ 7.628587] systemd[1]: Listening on Query the User Interactively for a Password.669machine # [ 7.632262] systemd[1]: Listening on Process Core Dump Socket.670machine # [ 7.634837] systemd[1]: Listening on Credential Encryption/Decryption.671machine # [ 7.637558] systemd[1]: Listening on Factory Reset Management.672machine # [ 7.639055] systemd[1]: Listening on Hostname Service Socket.673machine # [ 7.643798] systemd[1]: Starting Journal Log Access Socket...674machine # [ 7.646518] systemd[1]: Listening on Journal Audit Socket.675machine # [ 7.650822] systemd[1]: Listening on Console Output Muting Service Socket.676machine # [ 7.652721] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.677machine # [ 7.654945] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os678machine # [ 7.658667] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki679machine # [ 7.665470] systemd[1]: Listening on Disk Repartitioning Service Socket.680machine # [ 7.667168] systemd[1]: Listening on udev Varlink Socket.681machine # [ 7.671586] systemd[1]: Mounting Huge Pages File System...682machine # [ 7.677616] systemd[1]: Mounting POSIX Message Queue File System...683machine # [ 7.693056] systemd[1]: Mounting Kernel Debug File System...684machine # [ 7.711287] systemd[1]: Mounting Kernel Trace File System...685machine # [ 7.725662] systemd[1]: Starting Create List of Static Device Nodes...686machine # [ 7.730252] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs687machine # [ 7.747582] systemd[1]: Mounting Kernel Configuration File System...688machine # [ 7.753515] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm689machine # [ 7.765464] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore690machine # [ 7.768686] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse691machine # [ 7.794563] systemd[1]: Mounting FUSE Control File System...692machine # [ 7.799295] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67693machine # [ 7.839650] systemd[1]: Starting Journal Service...694machine # [ 7.860718] systemd[1]: Starting Load Kernel Modules...695machine # [ 7.883266] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...696machine # [ 7.899379] systemd[1]: Starting Remount Root and Kernel File Systems...697machine # [ 7.899850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os698machine # [ 7.926057] systemd[1]: Starting Coldplug All udev Devices...699machine # [ 7.940101] systemd[1]: Listening on Journal Log Access Socket.700machine # [ 7.942205] systemd-journald[314]: Collecting audit messages is enabled.701machine # [ 7.950766] systemd[1]: Mounted Huge Pages File System.702machine # [ 7.957743] systemd[1]: Mounted POSIX Message Queue File System.703machine # [ 7.963085] systemd[1]: Mounted Kernel Debug File System.704machine # [ 7.947872] systemd[1]: Queued start job for default target Multi-User System.705machine # [ 7.967245] systemd[1]: Started Journal Service.706machine # [ 8.061441] EXT4-fs (vda): re-mounted e0472b85-873b-4ccf-b92c-741e50f7a111.707machine # [ 8.227169] EXT4-fs (vda): resizing filesystem from 262144 to 262144 blocks708machine # [ 7.951459] systemd[1]: systemd-journald.service: Deactivated successfully.709machine # [ 8.594624] systemd-journald[314]: Received client request to flush runtime journal.710machine # [ 8.647758] systemd-modules-load[315]: Module 'atkbd' is built in711machine # [ 8.653545] systemd-modules-load[315]: Module 'loop' is built in712machine # [ 8.654664] systemd[1]: Mounted Kernel Trace File System.713machine # [ 8.655594] systemd[1]: Finished Create List of Static Device Nodes.714machine # [ 8.665250] systemd[1]: Mounted Kernel Configuration File System.715machine # [ 8.666359] systemd[1]: Finished Load Kernel Modules.716machine # [ 8.667245] systemd[1]: Starting Firewall...717machine # [ 8.676447] systemd[1]: Starting Apply Kernel Variables...718machine # [ 8.677554] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...719machine # [ 8.678698] systemd[1]: Finished Remount Root and Kernel File Systems.720machine # [ 8.679760] systemd[1]: Mounted FUSE Control File System.721machine # [ 8.692976] systemd[1]: Listening on Disk Image Download Service Socket.722machine # [ 8.694130] systemd[1]: Starting Grow Root File System...723machine # [ 8.695369] systemd-oomd[317]: No swap; memory pressure usage will be degraded724machine # [ 8.714670] systemd[1]: Starting Flush Journal to Persistent Storage...725machine # [ 8.721135] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore726machine # [ 8.722902] systemd[1]: Starting Load/Save OS Random Seed...727machine # [ 8.723885] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os728machine # [ 8.739813] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.729machine # [ 8.744332] systemd[1]: Finished Apply Kernel Variables.730machine # [ 8.745294] systemd-growfs[326]: Successfully resized "/" to 1G bytes.731machine # [ 8.746203] systemd[1]: Finished Grow Root File System.732machine # [ 8.746955] systemd[1]: Finished Load/Save OS Random Seed.733machine # [ 8.747728] systemd[1]: Reached target First Boot Complete.734machine # [ 8.753706] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.735machine # [ 8.755007] systemd[1]: Starting Create Static Device Nodes in /dev...736machine # [ 8.755953] systemd[1]: Finished Create Static Device Nodes in /dev.737machine # [ 8.764362] systemd[1]: Reached target Preparation for Local File Systems.738machine # [ 8.765358] systemd[1]: Mounting /run/wrappers...739machine # [ 8.766060] systemd[1]: Starting Rule-based Manager for Device Events and Files...740machine # [ 8.767132] systemd[1]: Finished Flush Journal to Persistent Storage.741machine # [ 8.800951] systemd[1]: Mounted /run/wrappers.742machine # [ 8.802049] systemd[1]: Reached target Local File Systems.743machine # [ 8.811623] systemd[1]: Listening on Boot Loader Control Service Socket.744machine # [ 8.819444] systemd[1]: Starting Create SUID/SGID Wrappers...745machine # [ 8.820784] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.746machine # [ 8.831802] systemd[1]: Starting Save Transient machine-id to Disk...747machine # [ 8.835233] systemd[1]: Starting Create System Files and Directories...748machine # [ 8.885745] systemd-udevd[343]: Using default interface naming scheme 'v261'.749machine # [ 9.071768] systemd[1]: Finished Create System Files and Directories.750machine # [ 9.084645] systemd[1]: Starting Rebuild Journal Catalog...751machine # [ 9.104650] systemd[1]: Starting Record System Boot/Shutdown in UTMP...752machine # [ 9.105815] systemd[1]: Started Rule-based Manager for Device Events and Files.753machine # [ 9.117114] systemd[1]: Finished Save Transient machine-id to Disk.754machine # [ 9.288457] systemd[1]: Finished Record System Boot/Shutdown in UTMP.755machine # [ 9.328452] systemd[1]: Finished Rebuild Journal Catalog.756machine # [ 9.343809] systemd[1]: Starting Update is Completed...757machine # [ 9.489635] systemd[1]: Finished Update is Completed.758machine # [ 9.528793] systemd[1]: Finished Coldplug All udev Devices.759machine # [ 9.565055] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.760machine # [ 9.693620] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs761machine # [ 9.721726] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse762machine # [ 9.865801] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.763machine # [ 9.870340] systemd[1]: Finished Create SUID/SGID Wrappers.764machine # [ 9.873822] systemd[1]: Reached target System Initialization.765machine # [ 9.874841] systemd[1]: Started Discard unused filesystem blocks once a week.766machine # [ 9.875880] systemd[1]: Started Daily Cleanup of Temporary Directories.767machine # [ 9.886651] systemd[1]: Reached target Timer Units.768machine # [ 9.887451] systemd[1]: Listening on D-Bus System Message Bus Socket.769machine # [ 9.894028] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.770machine # [ 9.895366] systemd[1]: Reached target Socket Units.771machine # [ 9.902450] systemd[1]: Reached target Basic System.772machine # [ 9.903330] systemd[1]: Starting Import lastlog data into lastlog2 database...773machine # [ 9.912587] systemd[1]: Starting Name Service Cache Daemon (nsncd)...774machine # [ 9.913642] systemd[1]: Starting Post-Boot Actions...775machine # [ 9.932092] systemd[1]: Started Reset console on configuration changes.776machine # [ 9.979897] systemd[1]: Starting resolvconf update...777machine # [ 10.049121] systemd[1]: Starting D-Bus System Message Bus...778machine # [ 10.127861] systemd[1]: Finished Post-Boot Actions.779machine # [ 10.131149] systemd[1]: Started Name Service Cache Daemon (nsncd).780machine # [ 10.137554] nsncd[485]: Sep 14 03:00:40.655 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"781machine # [ 10.149296] systemd[1]: Found device /dev/hvc0.782machine # [ 10.150172] systemd[1]: Reached target Host and Network Name Lookups.783machine # [ 10.151153] systemd[1]: Reached target User and Group Name Lookups.784machine # [ 10.184335] systemd[1]: Starting User Login Management...785machine # [ 10.228177] systemd[1]: Found device /dev/ttyAMA0.786machine # [ 10.244667] systemd[1]: Started backdoor.service.787machine # [ 10.261109] systemd[1]: Finished Import lastlog data into lastlog2 database.788machine # [ 10.392736] dbus-broker-launch[494]: Looking up NSS user entry for 'systemd-timesync'...789machine # [ 10.400376] dbus-broker-launch[494]: NSS returned no entry for 'systemd-timesync'790machine # [ 10.401636] dbus-broker-launch[494]: Invalid user-name in /nix/store/m2dlyz3lpny9qs3lm9gzblz5zygr9wfz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"791machine # connecting to host...792machine # [ 10.448280] systemd-logind[513]: New seat seat0.793machine # [ 10.459575] systemd[1]: Started User Login Management.794machine # [ 10.466365] systemd[1]: Starting linger-users.service...795machine # [ 10.467322] systemd[1]: Started D-Bus System Message Bus.796machine # [ 10.529505] dbus-broker-launch[494]: Ready797machine: Guest shell says: b'Spawning backdoor root shell...\n'798machine: connected to guest root shell799machine: (connecting took 5.29 seconds)800machine: (finished: waiting for the VM to finish booting, in 5.29 seconds)801(finished: subtest: testing initrd backdoor, in 11.61 seconds)802subtest: handover to stage-2 systemd works803machine: waiting for unit multi-user.target804machine # [ 10.574896] systemd[1]: Stopped target Host and Network Name Lookups.805machine # [ 10.575963] systemd[1]: Stopping Host and Network Name Lookups...806machine # [ 10.588401] systemd[1]: Stopped target User and Group Name Lookups.807machine # [ 10.589485] systemd[1]: Stopping User and Group Name Lookups...808machine # [ 10.590337] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...809machine # [ 10.600787] systemd[1]: nscd.service: Deactivated successfully.810machine # [ 10.601764] systemd[1]: Stopped Name Service Cache Daemon (nsncd).811machine # [ 10.611889] (udev-worker)[439]: Network interface NamePolicy= disabled on kernel command line.812machine # [ 10.617689] systemd[1]: linger-users.service: Deactivated successfully.813machine # [ 10.618692] systemd[1]: Finished linger-users.service.814machine # [ 10.635204] (udev-worker)[442]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.815machine # [ 10.649149] (udev-worker)[442]: Network interface NamePolicy= disabled on kernel command line.816machine # [ 10.657073] systemd[1]: Starting Name Service Cache Daemon (nsncd)...817machine # [ 10.770959] nsncd[585]: Sep 14 03:00:41.297 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"818machine # [ 10.807332] systemd[1]: Started Name Service Cache Daemon (nsncd).819machine # [ 10.813655] systemd[1]: Reached target Host and Network Name Lookups.820machine # [ 10.814736] systemd[1]: Reached target User and Group Name Lookups.821machine # [ 10.830542] systemd[1]: Finished resolvconf update.822machine # [ 10.850254] systemd[1]: Starting DHCP Client...823machine # [ 11.018828] systemd[1]: Finished Firewall.824machine # [ 11.023544] systemd[1]: Reached target Preparation for Network.825machine # [ 11.028890] systemd[1]: Starting Extra networking commands....826machine # [ 11.113178] dhcpcd[639]: dhcpcd-10.3.2 starting827machine # [ 11.125749] dhcpcd[647]: dev: loaded udev828machine # [ 11.146926] systemd[1]: Condition check resulted in Virtio network device being skipped.829machine # [ 11.150080] systemd[1]: Starting Address configuration of eth1...830machine # [ 11.205662] 8021q: 802.1Q VLAN Support v1.8831machine # [ 11.310305] systemd-logind[513]: Watching system buttons on /dev/input/event0 (gpio-keys)832machine # [ 11.388213] cfg80211: Loading compiled-in X.509 certificates for regulatory database833machine # [ 11.406410] 8021q: adding VLAN 0 to HW filter on device eth1834machine # [ 11.414004] network-addresses-eth1-start[650]: adding address 192.168.1.1/24... done835machine # [ 11.443558] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'836machine # [ 11.444092] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'837machine # [ 11.447074] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2838machine # [ 11.447428] cfg80211: failed to load regulatory.db839machine # [ 11.437969] network-addresses-eth1-start[650]: adding address 2001:db8:1::1/64... done840machine # [ 11.463149] systemd[1]: Finished Extra networking commands..841machine # [ 11.465238] systemd[1]: Reached target Network.842machine # [ 11.471996] systemd[1]: Starting Permit User Sessions...843machine # [ 11.488790] systemd[1]: Finished Address configuration of eth1.844machine # [ 11.550301] systemd[1]: Finished Permit User Sessions.845machine # [ 11.565683] systemd[1]: Started Getty on tty1.846machine # [ 11.566520] systemd[1]: Reached target Login Prompts.847machine # [ 11.599395] 8021q: adding VLAN 0 to HW filter on device eth0848machine # [ 11.585444] dhcpcd[647]: eth0: waiting for carrier849machine # [ 11.586397] dhcpcd[647]: eth0: waiting for carrier850machine # [ 11.605652] mousedev: PS/2 mouse device common for all mice851machine # [ 11.591256] dhcpcd[647]: eth0: carrier acquired852machine # [ 11.603855] dhcpcd[647]: DUID 00:01:00:01:32:3a:1f:da:52:54:00:12:34:56853machine # [ 11.606098] dhcpcd[647]: eth0: IAID 00:12:34:56854machine # [ 11.606836] dhcpcd[647]: eth0: adding address fe80::5054:ff:fe12:3456855machine # [ 11.682280] systemd-logind[513]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)856machine # [ 12.458865] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input3857machine # [ 12.492927] dhcpcd[647]: eth0: soliciting a DHCP lease858machine # [ 12.500705] dhcpcd[647]: eth0: offered 10.0.2.15 from 10.0.2.2859machine # [ 12.508291] dhcpcd[647]: eth0: probing address 10.0.2.15/24860machine # [ 12.793892] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.861machine # [ 12.813761] systemd[1]: Starting Virtual Console Setup...862machine # [ 12.829334] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.863machine # [ 12.832566] systemd[1]: Stopped Virtual Console Setup.864machine # [ 12.844122] systemd[1]: Starting Virtual Console Setup...865machine # [ 12.898905] systemd-logind[513]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)866machine # [ 13.029957] systemd-vconsole-setup[746]: Configuration of first virtual console was skipped, ignoring remaining ones.867machine # [ 13.034603] systemd[1]: Finished Virtual Console Setup.868machine # [ 13.479575] dhcpcd[647]: eth0: soliciting an IPv6 router869machine # [ 13.484399] dhcpcd[647]: eth0: Router Advertisement from fe80::2870machine # [ 13.487039] dhcpcd[647]: eth0: adding address fec0::5054:ff:fe12:3456/64871machine # [ 13.490035] dhcpcd[647]: eth0: adding route to fec0::/64872machine # [ 13.493478] dhcpcd[647]: eth0: adding default route via fe80::2873machine # [ 17.327051] dhcpcd[647]: eth0: leased 10.0.2.15 for 86400 seconds874machine # [ 17.330608] dhcpcd[647]: eth0: adding route to 10.0.2.0/24875machine # [ 17.334714] dhcpcd[647]: eth0: adding default route via 10.0.2.2876machine # [ 17.510824] systemd[1]: Started DHCP Client.877machine # [ 17.517266] systemd[1]: Reached target Multi-User System.878machine # [ 17.519389] systemd[1]: Startup finished in 1.039s (kernel) + 5.256s (initrd) + 11.222s (userspace) = 17.518s.879machine: (finished: waiting for unit multi-user.target, in 8.09 seconds)880machine: must succeed: systemd-analyze | grep -q '(initrd)'881machine: (finished: must succeed: systemd-analyze | grep -q '(initrd)', in 0.04 seconds)882machine: must succeed: touch /testfile883machine: (finished: must succeed: touch /testfile, in 0.02 seconds)884machine: must fail: touch /nix/store/testfile885machine # touch: cannot touch '/nix/store/testfile': Read-only file system886machine: (finished: must fail: touch /nix/store/testfile, in 0.02 seconds)887machine: must succeed: [ -e /run/booted-system ]888machine: (finished: must succeed: [ -e /run/booted-system ], in 0.01 seconds)889machine: must succeed: [ -e /sys/class ]890machine: (finished: must succeed: [ -e /sys/class ], in 0.01 seconds)891machine: must succeed: [ -e /dev/null ]892machine: (finished: must succeed: [ -e /dev/null ], in 0.01 seconds)893machine: must succeed: [ -e /proc/1 ]894machine: (finished: must succeed: [ -e /proc/1 ], in 0.01 seconds)895machine: must succeed: [ -e /dev/shm ]896machine: (finished: must succeed: [ -e /dev/shm ], in 0.01 seconds)897machine: must succeed: [ -e /dev/pts/ptmx ]898machine: (finished: must succeed: [ -e /dev/pts/ptmx ], in 0.01 seconds)899machine: must succeed: [ -e /run/keys ]900machine: (finished: must succeed: [ -e /run/keys ], in 0.01 seconds)901machine: must succeed: [ ! -e /nixos-closure ]902machine: (finished: must succeed: [ ! -e /nixos-closure ], in 0.01 seconds)903(finished: subtest: handover to stage-2 systemd works, in 8.27 seconds)904subtest: groups work905machine: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring'906machine: (finished: must fail: journalctl -b 0 | grep 'systemd-udevd.*Unknown group.*ignoring', in 0.03 seconds)907(finished: subtest: groups work, in 0.03 seconds)908subtest: growfs works909machine: must succeed: df --output=avail / | sed 1d910machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.02 seconds)911machine: waiting for the VM to power off912additionally exposed symbols:913 machine,914 vlan1,915 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_ssh916machine # [ 18.874177] systemd-logind[513]: poweroff requested from client PID 908 ('poweroff') (unit backdoor.service)...917machine # [ 18.878201] systemd-logind[513]: System is powering down.918machine # [ 18.885887] systemd-logind[513]: The system will power off now!919machine # [ 18.896667] systemd[1]: Removed slice Slice /system/modprobe.920machine # [ 18.900854] systemd[1]: Stopped target Multi-User System.921machine # [ 18.901768] systemd[1]: Stopped target Login Prompts.922machine # [ 18.902511] systemd[1]: Stopped target Virtual Machines and Containers.923machine # [ 18.903432] systemd[1]: Stopped target Host and Network Name Lookups.924machine # [ 18.913936] systemd[1]: Stopped target Timer Units.925machine # [ 18.915182] dhcpcd[647]: received SIGTERM, stopping926machine # [ 18.919133] systemd[1]: fstrim.timer: Deactivated successfully.927machine # [ 18.920948] dhcpcd[647]: eth0: removing interface928machine # [ 18.921742] systemd[1]: Stopped Discard unused filesystem blocks once a week.929machine # [ 18.922771] dhcpcd[647]: eth0: deleting address fec0::5054:ff:fe12:3456/64930machine # [ 18.923744] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.931machine # [ 18.932387] dhcpcd[647]: eth0: deleting route to fec0::/64932machine # [ 18.933273] systemd[1]: Stopped Daily Cleanup of Temporary Directories.933machine # [ 18.934211] dhcpcd[647]: eth0: deleting default route via fe80::2934machine # [ 18.935086] systemd[1]: systemd-rfkill.socket: Deactivated successfully.935machine # [ 18.943167] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.936machine # [ 18.949076] systemd[1]: Mounting /run/initramfs...937machine # [ 18.949888] systemd[1]: Stopping backdoor.service...938machine # [ 18.950688] systemd[1]: Stopping DHCP Client...939machine # [ 18.951384] systemd[1]: Stopping Getty on tty1...940machine # [ 18.953664] systemd[1]: lastlog2-import.service: Deactivated successfully.941machine # [ 18.954712] systemd[1]: Stopped Import lastlog data into lastlog2 database.942machine # [ 18.955696] systemd[1]: Stopping Address configuration of eth1...943machine # [ 18.964630] systemd[1]: Stopping Post-Boot Actions...944machine # [ 18.965553] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.945machine # [ 18.966696] systemd[1]: Stopped Reset console on configuration changes.946machine # [ 18.967662] systemd[1]: Stopping User Login Management...947machine # [ 18.977205] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.948machine # [ 18.978376] systemd[1]: Stopped Save Transient machine-id to Disk.949machine # [ 18.979426] systemd[1]: Stopped target First Boot Complete.950machine # [ 18.993616] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...951machine # [ 18.999810] systemd[1]: Stopping Load/Save OS Random Seed...952machine # [ 19.003282] systemd[1]: systemd-oomd.service: Deactivated successfully.953machine # [ 19.009499] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.954machine # [ 19.010455] systemd[1]: systemd-logind.service: Deactivated successfully.955machine # [ 19.011401] systemd[1]: Stopped User Login Management.956machine # [ 19.034927] systemd[1]: backdoor.service: Deactivated successfully.957machine # [ 19.046616] systemd[1]: Stopped backdoor.service.958machine # [ 19.049527] dhcpcd[647]: eth0: deleting address fe80::5054:ff:fe12:3456959machine # [ 19.053511] systemd[1]: getty@tty1.service: Deactivated successfully.960machine # [ 19.060938] systemd[1]: Stopped Getty on tty1.961machine # [ 19.061779] dhcpcd[647]: eth0: deleting route to 10.0.2.0/24962machine # [ 19.062614] dhcpcd[647]: eth0: deleting default route via 10.0.2.2963machine # [ 19.074109] network-addresses-eth1-pre-stop[915]: deleting address 192.168.1.1/24... done964machine # [ 19.080261] systemd[1]: post-boot.service: Deactivated successfully.965machine # [ 19.086486] systemd[1]: Stopped Post-Boot Actions.966machine # [ 19.102928] dhcpcd[647]: dhcpcd exited967machine # [ 19.105904] network-addresses-eth1-pre-stop[915]: deleting address 2001:db8:1::1/64... done968machine # [ 19.112648] systemd[1]: dhcpcd.service: Deactivated successfully.969machine # [ 19.115083] systemd[1]: Stopped DHCP Client.970machine # [ 19.115831] systemd[1]: dhcpcd.service: Consumed 320ms CPU time over 8.262s wall clock time, 5.7M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.971machine # [ 19.124923] systemd[1]: systemd-random-seed.service: Deactivated successfully.972machine # [ 19.126760] systemd[1]: Stopped Load/Save OS Random Seed.973machine # [ 19.129554] systemd[1]: network-addresses-eth1.service: Deactivated successfully.974machine # [ 19.132310] systemd[1]: Stopped Address configuration of eth1.975machine # [ 19.138177] systemd[1]: Removed slice Slice /system/getty.976machine # [ 19.142076] systemd[1]: Stopping Permit User Sessions...977machine # [ 19.149292] systemd[1]: Mounted /run/initramfs.978machine # [ 19.155179] systemd[1]: Starting Generate shutdown ramfs...979machine # [ 19.204844] systemd[1]: systemd-user-sessions.service: Deactivated successfully.980machine # [ 19.208469] systemd[1]: Stopped Permit User Sessions.981machine # [ 19.209356] systemd[1]: Stopped target Network.982machine # [ 19.210061] systemd[1]: Stopped target User and Group Name Lookups.983machine # [ 19.210973] systemd[1]: Stopped target Remote File Systems.984machine # [ 19.211795] systemd[1]: network-local-commands.service: Deactivated successfully.985machine # [ 19.221166] systemd[1]: Stopped Extra networking commands..986machine # [ 19.222061] systemd[1]: Stopped target Preparation for Network.987machine # [ 19.222926] systemd[1]: Stopping Firewall...988machine # [ 19.223583] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...989machine # [ 19.229327] systemd[1]: resolvconf.service: Deactivated successfully.990machine # [ 19.230337] systemd[1]: Stopped resolvconf update.991machine # [ 19.231054] systemd[1]: nscd.service: Deactivated successfully.992machine # [ 19.231889] systemd[1]: Stopped Name Service Cache Daemon (nsncd).993machine # [ 19.240922] systemd[1]: Stopped target Basic System.994machine # [ 19.241756] systemd[1]: Stopped target Path Units.995machine # [ 19.242482] systemd[1]: Stopped target Slice Units.996machine # [ 19.243532] systemd[1]: Removed slice User and Session Slice.997machine # [ 19.246357] systemd[1]: Stopped target Socket Units.998machine # [ 19.247152] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.999machine # [ 19.252350] systemd[1]: Closed Hostname Service Socket.1000machine # [ 19.253149] systemd[1]: systemd-importd.socket: Deactivated successfully.1001machine # [ 19.254103] systemd[1]: Closed Disk Image Download Service Socket.1002machine # [ 19.254975] systemd[1]: systemd-machined.socket: Deactivated successfully.1003machine # [ 19.255925] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1004machine # [ 19.259740] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1005machine # [ 19.261885] make-initrd-ng[944]: /etc/initrd-release -> /nix/store/s0k038sacp3qi1ldk2936dfbm8s8sk55-etc-os-release1006machine # [ 19.263304] make-initrd-ng[944]: /etc/os-release -> /nix/store/s0k038sacp3qi1ldk2936dfbm8s8sk55-etc-os-release1007machine # [ 19.269448] make-initrd-ng[944]: /shutdown -> /nix/store/1g1nz2bgg9igl4hxl9i65z83g21a371k-systemd-262-5698092/lib/systemd/systemd-shutdown1008machine # [ 19.271146] systemd[1]: Closed Console Output Muting Service Socket.1009machine # [ 19.272327] systemd[1]: systemd-oomd.socket: Deactivated successfully.1010machine # [ 19.277966] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1011machine # [ 19.279106] systemd[1]: systemd-repart.socket: Deactivated successfully.1012machine # [ 19.283326] systemd[1]: Closed Disk Repartitioning Service Socket.1013machine # [ 19.287482] dbus-broker[558]: Dispatched 978 messages @ 3(±6)μs / message.1014machine # [ 19.292131] systemd[1]: Stopping D-Bus System Message Bus...1015machine # [ 19.293033] systemd[1]: dbus-broker.service: Deactivated successfully.1016machine # [ 19.293956] systemd[1]: Stopped D-Bus System Message Bus.1017machine # [ 19.294742] systemd[1]: dbus.socket: Deactivated successfully.1018machine # [ 19.295592] systemd[1]: Closed D-Bus System Message Bus Socket.1019machine # [ 19.309521] systemd[1]: Stopped target System Initialization.1020machine # [ 19.310420] systemd[1]: Stopped target Local Encrypted Volumes.1021machine # [ 19.311263] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1022machine # [ 19.317928] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1023machine # [ 19.319074] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1024machine # [ 19.322896] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1025machine # [ 19.324002] systemd[1]: systemd-sysctl.service: Deactivated successfully.1026machine # [ 19.327042] systemd[1]: Stopped Apply Kernel Variables.1027machine # [ 19.327842] systemd[1]: systemd-coredump.socket: Deactivated successfully.1028machine # [ 19.335350] systemd[1]: Closed Process Core Dump Socket.1029machine # [ 19.340221] systemd[1]: systemd-update-done.service: Deactivated successfully.1030machine # [ 19.347841] systemd[1]: Stopped Update is Completed.1031machine # [ 19.350211] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1032machine # [ 19.351350] systemd[1]: Stopped Rebuild Journal Catalog.1033machine # [ 19.355323] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1034machine # [ 19.384480] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1035machine # [ 19.388225] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1036machine # [ 19.389248] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1037machine # [ 19.390272] systemd[1]: Stopped Create System Files and Directories.1038machine # [ 19.391150] systemd[1]: Stopped target Local File Systems.1039machine # [ 19.408283] systemd[1]: Unmounting /run/keys...1040machine # [ 19.409191] systemd[1]: Unmounting /run/wrappers...1041machine # [ 19.409948] systemd[1]: systemd-growfs-root.service: Deactivated successfully.1042machine # [ 19.410987] systemd[1]: Stopped Grow Root File System.1043machine # [ 19.465292] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1044machine # [ 19.468961] systemd[1]: Finished Generate shutdown ramfs.1045machine # [ 19.481864] systemd[1]: firewall.service: Deactivated successfully.1046machine # [ 19.484827] systemd[1]: Stopped Firewall.1047machine # [ 19.486745] systemd[1]: run-keys.mount: Deactivated successfully.1048machine # [ 19.488499] systemd[1]: Unmounted /run/keys.1049machine # [ 19.491071] systemd[1]: run-wrappers.mount: Deactivated successfully.1050machine # [ 19.492337] systemd[1]: Unmounted /run/wrappers.1051machine # [ 19.494157] systemd[1]: Stopped target Preparation for Local File Systems.1052machine # [ 19.496618] systemd[1]: Stopped target Swaps.1053machine # [ 19.500270] systemd[1]: Reached target Unmount All Filesystems.1054machine # [ 19.501186] systemd[1]: systemd-modules-load.service: Deactivated successfully.1055machine # [ 19.502189] systemd[1]: Stopped Load Kernel Modules.1056machine # [ 19.502959] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1057machine # [ 19.503952] systemd[1]: Stopped Remount Root and Kernel File Systems.1058machine # [ 19.508357] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1059machine # [ 19.510761] systemd[1]: Stopped File System Check on Root Device.1060machine # [ 19.511678] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1061machine # [ 19.512914] systemd[1]: Stopped Create Static Device Nodes in /dev.1062machine # [ 19.513788] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1063machine # [ 19.514942] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1064machine # [ 19.515935] systemd[1]: Reached target System Shutdown.1065machine # [ 19.517299] systemd[1]: Reached target Late Shutdown Services.1066machine # [ 19.518183] systemd[1]: systemd-poweroff.service: Deactivated successfully.1067machine # [ 19.519149] systemd[1]: Finished System Power Off.1068machine # [ 19.519875] systemd[1]: Reached target System Power Off.1069machine # [ 19.523482] systemd[1]: Shutting down.1070machine # [ 19.714593] systemd-shutdown[1]: Syncing filesystems and block devices.1071machine # [ 19.759792] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1072machine # [ 19.774881] systemd-journald[314]: Received SIGTERM from PID 1 (systemd-shutdow).1073machine # [ 19.819808] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1074machine # [ 19.832031] systemd-shutdown[1]: Unmounting file systems.1075machine # [ 19.841560] (sd-umount)[974]: Unmounting '/run/credentials/systemd-journald.service'.1076machine # [ 19.848911] (sd-remount)[975]: 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'.1077machine # [ 19.868655] (sd-remount)[976]: 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'.1078machine # [ 19.882797] (sd-umount)[977]: Unmounting '/nix/.ro-store'.1079machine # [ 19.887439] (sd-remount)[978]: Remounting '/tmp/xchg' read-only with options ''.1080machine # [ 19.892707] (sd-umount)[979]: Unmounting '/tmp/xchg'.1081machine # [ 19.897580] (sd-remount)[980]: Remounting '/tmp/shared' read-only with options ''.1082machine # [ 19.901614] (sd-umount)[981]: Unmounting '/tmp/shared'.1083machine # [ 19.906384] (sd-umount)[982]: Unmounting '/nix/.rw-store'.1084machine # [ 19.910698] (sd-remount)[983]: Remounting '/' read-only with options ''.1085machine # [ 19.926674] EXT4-fs (vda): re-mounted e0472b85-873b-4ccf-b92c-741e50f7a111 ro.1086machine # [ 19.932025] systemd-shutdown[1]: All filesystems unmounted.1087machine # [ 19.935169] systemd-shutdown[1]: Deactivating swaps.1088machine # [ 19.938419] systemd-shutdown[1]: All swaps deactivated.1089machine # [ 19.941462] systemd-shutdown[1]: Detaching loop devices.1090machine # [ 19.957656] systemd-shutdown[1]: All loop devices detached.1091machine # [ 19.960508] systemd-shutdown[1]: Stopping MD devices.1092machine # [ 19.963776] systemd-shutdown[1]: All MD devices stopped.1093machine # [ 19.966548] systemd-shutdown[1]: Detaching DM devices.1094machine # [ 19.969420] systemd-shutdown[1]: All DM devices detached.1095machine # [ 19.972145] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1096machine # [ 20.315271] systemd-shutdown[1]: Successfully changed into root pivot.1097machine # [ 20.318261] systemd-shutdown[1]: Entering exitrd...1098machine # [ 20.339172] shutdown[1]: Syncing filesystems and block devices.1099machine # [ 20.343515] shutdown[1]: Sending SIGTERM to remaining processes...1100machine # [ 20.354450] shutdown[1]: Sending SIGKILL to remaining processes...1101machine # [ 20.363334] shutdown[1]: Unmounting file systems.1102machine # [ 20.370486] (sd-umoun[985]: Unmounting '/run/credentials'.1103machine # [ 20.375930] (sd-umoun[986]: Unmounting '/oldroot/sys/fs/fuse/connections'.1104machine # [ 20.381915] (sd-umoun[987]: Unmounting '/oldroot/sys/kernel/config'.1105machine # [ 20.387407] (sd-umoun[988]: Unmounting '/oldroot/sys/kernel/tracing'.1106machine # [ 20.391803] (sd-umoun[989]: Unmounting '/oldroot/sys/kernel/debug'.1107machine # [ 20.396844] (sd-umoun[990]: Unmounting '/oldroot/dev/hugepages'.1108machine # [ 20.401918] (sd-umoun[991]: Unmounting '/oldroot/dev/mqueue'.1109machine # [ 20.406805] (sd-umoun[992]: Unmounting '/oldroot/sys/fs/bpf'.1110machine # [ 20.410514] (sd-umoun[993]: Unmounting '/oldroot/sys/fs/pstore'.1111machine # [ 20.414314] (sd-umoun[994]: Unmounting '/oldroot/sys/fs/cgroup'.1112machine # [ 20.417888] (sd-umoun[995]: Unmounting '/oldroot/sys/kernel/security'.1113machine # [ 20.421573] (sd-umoun[996]: Unmounting '/oldroot/nix/store'.1114machine # [ 20.425544] (sd-umoun[997]: Unmounting '/oldroot/sys'.1115machine # [ 20.428471] (sd-umoun[998]: Unmounting '/oldroot/proc'.1116machine # [ 20.431604] (sd-umoun[999]: Unmounting '/oldroot/dev/shm'.1117machine # [ 20.434698] (sd-umoun[1000]: Unmounting '/oldroot/dev/pts'.1118machine # [ 20.438277] (sd-umoun[1001]: Unmounting '/oldroot/dev'.1119machine # [ 20.441800] (sd-umoun[1002]: Unmounting '/oldroot/nix/store'.1120machine # [ 20.476899] (sd-umoun[1003]: Unmounting '/oldroot/run'.1121machine # [ 20.481434] (sd-umoun[1004]: Unmounting '/oldroot'.1122machine # [ 20.486231] EXT4-fs (vda): unmounting filesystem e0472b85-873b-4ccf-b92c-741e50f7a111.1123machine # [ 20.489723] shutdown[1]: All filesystems unmounted.1124machine # [ 20.491849] shutdown[1]: Deactivating swaps.1125machine # [ 20.494144] shutdown[1]: All swaps deactivated.1126machine # [ 20.496328] shutdown[1]: Detaching loop devices.1127machine # [ 20.501973] shutdown[1]: All loop devices detached.1128machine # [ 20.504266] shutdown[1]: Stopping MD devices.1129machine # [ 20.506838] shutdown[1]: All MD devices stopped.1130machine # [ 20.509001] shutdown[1]: Detaching DM devices.1131machine # [ 20.511321] shutdown[1]: All DM devices detached.1132machine # [ 20.513572] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1133machine # [ 20.516900] shutdown[1]: Syncing filesystems and block devices.1134machine # [ 20.520139] shutdown[1]: Powering off.1135machine # [ 20.549725] Console: switching to colour dummy device 80x251136machine # [ 20.562135] Flash device refused suspend due to active operation (state 20)1137machine # [ 20.562190] Flash device refused suspend due to active operation (state 20)1138machine # [ 20.565250] reboot: Power down1139machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client disconnected, shutting down1140machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client disconnected, shutting down1141machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client disconnected, shutting down1142machine: (finished: waiting for the VM to power off, in 1.86 seconds)1143Image resized.1144machine: starting vm1145machine # Starting virtiofs daemons...1146machine: QEMU running (pid 91)1147machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1148machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1149machine # [2026-09-14T03:00:51Z INFO virtiofsd] Waiting for vhost-user socket connection...1150machine: waiting for unit initrd.target1151machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1152machine: waiting for the VM to finish booting1153machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1154machine # [2026-09-14T03:00:51Z INFO virtiofsd] Waiting for vhost-user socket connection...1155machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)1156machine # [2026-09-14T03:00:51Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether1157machine # [2026-09-14T03:00:51Z INFO virtiofsd] Waiting for vhost-user socket connection...1158machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client connected, servicing requests1159machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client connected, servicing requests1160machine # [2026-09-14T03:00:51Z INFO virtiofsd] Client connected, servicing requests1161machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]1162machine # [ 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 20261163machine # [ 0.000000] KASLR enabled1164machine # [ 0.000000] random: crng init done1165machine # [ 0.000000] Machine model: linux,dummy-virt1166machine # [ 0.000000] efi: UEFI not found.1167machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT1168machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1169machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]1170machine # [ 0.000000] Zone ranges:1171machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1172machine # [ 0.000000] DMA32 empty1173machine # [ 0.000000] Normal empty1174machine # [ 0.000000] Device empty1175machine # [ 0.000000] Movable zone start for each node1176machine # [ 0.000000] Early memory node ranges1177machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]1178machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1179machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001180machine # [ 0.000000] psci: probing for conduit method from DT.1181machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1182machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1183machine # [ 0.000000] psci: Trusted OS migration not required1184machine # [ 0.000000] psci: SMC Calling Convention v1.11185machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1186machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961187machine # [ 0.000000] Detected PIPT I-cache on CPU01188machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1189machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1190machine # [ 0.000000] CPU features: detected: Spectre-v41191machine # [ 0.000000] CPU features: detected: Spectre-BHB1192machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381193machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231194machine # [ 0.000000] alternatives: applying boot alternatives1195machine # [ 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/sgbymhnd6pd3bgq1lrpzlcjkwz6qna4r-nixos-system-machine-test/init regInfo=/nix/store/vh860w6m3xng9sz3w7v0lil7k7icn892-closure-info/registration console=ttyAMA0,115200n8 console=tty01196machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vh860w6m3xng9sz3w7v0lil7k7icn892-closure-info/registration", will be passed to user space.1197machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1198machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1199machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1200machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1201machine # [ 0.000000] software IO TLB: area num 1.1202machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1203machine # [ 0.000000] Fallback order for Node 0: 01204machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441205machine # [ 0.000000] Policy zone: DMA1206machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1207machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11208machine # [ 0.000000] allocated 2097152 bytes of page_ext1209machine # [ 0.000000] ftrace: allocating 74894 entries in 294 pages1210machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1211machine # [ 0.000000] rcu: Hierarchical RCU implementation.1212machine # [ 0.000000] rcu: RCU event tracing is enabled.1213machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1214machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1215machine # [ 0.000000] Rude variant of Tasks RCU enabled.1216machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1217machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1218machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11219machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1220machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1221machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1222machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01223machine # [ 0.000000] GICv3: 256 SPIs implemented1224machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1225machine # [ 0.000000] Root IRQ handler: gic_handle_irq1226machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1227machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01228machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001229machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1230machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)1231machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)1232machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d100001233machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d200001234machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1235machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1236machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1237machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1238machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1239machine # [ 0.000032] arm-pv: using stolen time PV1240machine # [ 0.000508] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1241machine # [ 0.000714] Console: colour dummy device 80x251242machine # [ 0.000724] printk: legacy console [tty0] enabled1243machine # [ 0.000926] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1244machine # [ 0.000933] pid_max: default: 32768 minimum: 3011245machine # [ 0.001013] LSM: initializing lsm=capability,landlock,yama,bpf,ima1246machine # [ 0.001181] landlock: Up and running.1247machine # [ 0.001186] Yama: becoming mindful.1248machine # [ 0.001764] LSM support for eBPF active1249machine # [ 0.001908] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1250machine # [ 0.001928] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1251machine # [ 0.003432] cacheinfo: Unable to detect cache hierarchy for CPU 01252machine # [ 0.004267] rcu: Hierarchical SRCU implementation.1253machine # [ 0.004273] rcu: Max phase no-delay instances is 1000.1254machine # [ 0.005544] fsl-mc MSI: its@8080000 domain created1255machine # [ 0.005639] EFI services will not be available.1256machine # [ 0.005754] smp: Bringing up secondary CPUs ...1257machine # [ 0.005764] smp: Brought up 1 node, 1 CPU1258machine # [ 0.005767] SMP: Total of 1 processors activated.1259machine # [ 0.005770] CPU: All CPU(s) started at EL11260machine # [ 0.005784] CPU features: detected: Branch Target Identification1261machine # [ 0.005789] CPU features: detected: ARMv8.4 Translation Table Level1262machine # [ 0.005792] CPU features: detected: Instruction cache invalidation not required for I/D coherence1263machine # [ 0.005796] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1264machine # [ 0.005799] CPU features: detected: Common not Private translations1265machine # [ 0.005802] CPU features: detected: CRC32 instructions1266machine # [ 0.005805] CPU features: detected: Data cache clean to Point of Deep Persistence1267machine # [ 0.005808] CPU features: detected: Data cache clean to Point of Persistence1268machine # [ 0.005812] CPU features: detected: Data independent timing control (DIT)1269machine # [ 0.005815] CPU features: detected: E0PD1270machine # [ 0.005817] CPU features: detected: Enhanced Counter Virtualization1271machine # [ 0.005820] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1272machine # [ 0.005824] CPU features: detected: Enhanced Virtualization Traps1273machine # [ 0.005827] CPU features: detected: Fine Grained Traps1274machine # [ 0.005831] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1275machine # [ 0.005836] CPU features: detected: RCpc load-acquire (LDAPR)1276machine # [ 0.005839] CPU features: detected: LSE atomic instructions1277machine # [ 0.005842] CPU features: detected: Privileged Access Never1278machine # [ 0.005845] CPU features: detected: PMUv31279machine # [ 0.005848] CPU features: detected: RAS Extension Support1280machine # [ 0.005850] CPU features: detected: RASv1p1 Extension Support1281machine # [ 0.005853] CPU features: detected: Random Number Generator1282machine # [ 0.005856] CPU features: detected: Speculation barrier (SB)1283machine # [ 0.005858] CPU features: detected: Stage-2 Force Write-Back1284machine # [ 0.005862] CPU features: detected: TLB range maintenance instructions1285machine # [ 0.005867] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1286machine # [ 0.005905] alternatives: applying system-wide alternatives1287machine # [ 0.008986] CPU features: detected: BBM Level 2 without TLB conflict abort1288machine # [ 0.009162] Memory: 894004K/1048576K available (24448K kernel code, 7090K rwdata, 26360K rodata, 4736K init, 1107K bss, 113232K reserved, 32768K cma-reserved)1289machine # [ 0.009536] devtmpfs: initialized1290machine # [ 0.011324] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1291machine # [ 0.011348] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1292machine # [ 0.011546] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1293machine # [ 0.011552] 0 pages in range for non-PLT usage1294machine # [ 0.011553] 508288 pages in range for PLT usage1295machine # [ 0.011698] pinctrl core: initialized pinctrl subsystem1296machine # [ 0.012442] DMI not present or invalid.1297machine # [ 0.015835] NET: Registered PF_NETLINK/PF_ROUTE protocol family1298machine # [ 0.018184] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1299machine # [ 0.018340] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1300machine # [ 0.018505] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1301machine # [ 0.018529] audit: initializing netlink subsys (disabled)1302machine # [ 0.019114] thermal_sys: Registered thermal governor 'fair_share'1303machine # [ 0.019116] thermal_sys: Registered thermal governor 'bang_bang'1304machine # [ 0.019120] thermal_sys: Registered thermal governor 'step_wise'1305machine # [ 0.019122] thermal_sys: Registered thermal governor 'user_space'1306machine # [ 0.019128] thermal_sys: Registered thermal governor 'power_allocator'1307machine # [ 0.019152] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=11308machine # [ 0.019161] cpuidle: using governor ladder1309machine # [ 0.019166] cpuidle: using governor menu1310machine # [ 0.019370] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1311machine # [ 0.019387] ASID allocator initialised with 65536 entries1312machine # [ 0.020557] Serial: AMBA PL011 UART driver1313machine # [ 0.026016] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev11314machine # [ 0.026145] printk: console [ttyAMA0] enabled1315machine # [ 0.154153] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1316machine # [ 0.154175] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1317machine # [ 0.154181] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1318machine # [ 0.154185] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1319machine # [ 0.154190] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1320machine # [ 0.154194] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1321machine # [ 0.154199] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1322machine # [ 0.154203] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1323machine # [ 0.162059] fbcon: Taking over console1324machine # [ 0.162080] ACPI: Interpreter disabled.1325machine # [ 0.164033] iommu: Default domain type: Translated1326machine # [ 0.164045] iommu: DMA domain TLB invalidation policy: strict mode1327machine # [ 0.165815] SCSI subsystem initialized1328machine # [ 0.170770] usbcore: registered new interface driver usbfs1329machine # [ 0.170806] usbcore: registered new interface driver hub1330machine # [ 0.170830] usbcore: registered new device driver usb1331machine # [ 0.171103] pps_core: LinuxPPS API ver. 1 registered1332machine # [ 0.171110] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1333machine # [ 0.171120] PTP clock support registered1334machine # [ 0.171166] EDAC MC: Ver: 3.0.01335machine # [ 0.175974] scmi_core: SCMI protocol bus registered1336machine # [ 0.176959] FPGA manager framework1337machine # [ 0.177969] vgaarb: loaded1338machine # [ 0.178641] clocksource: Switched to clocksource arch_sys_counter1339machine # [ 0.185152] VFS: Disk quotas dquot_6.6.01340machine # [ 0.185199] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1341machine # [ 0.186981] netfs: FS-Cache loaded1342machine # [ 0.187092] pnp: PnP ACPI: disabled1343machine # [ 0.191433] NET: Registered PF_INET protocol family1344machine # [ 0.191611] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1345machine # [ 0.222178] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1346machine # [ 0.222235] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1347machine # [ 0.222263] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1348machine # [ 0.222317] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1349machine # [ 0.222392] TCP: Hash tables configured (established 8192 bind 8192)1350machine # [ 0.222483] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1351machine # [ 0.222560] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1352machine # [ 0.222609] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1353machine # [ 0.230207] NET: Registered PF_UNIX/PF_LOCAL protocol family1354machine # [ 0.230233] NET: Registered PF_XDP protocol family1355machine # [ 0.230256] PCI: CLS 0 bytes, default 641356machine # [ 0.230547] Trying to unpack rootfs image as initramfs...1357machine # [ 0.241201] kvm [1]: HYP mode not available1358machine # [ 0.339817] Initialise system trusted keyrings1359machine # [ 0.340612] workingset: timestamp_bits=42 max_order=18 bucket_order=01360machine # [ 0.341981] squashfs: version 4.0 (2009/01/31) Phillip Lougher1361machine # [ 0.342845] 9p: Installing v9fs 9p2000 file system support1362machine # [ 0.370931] Key type asymmetric registered1363machine # [ 0.370974] Asymmetric key parser 'x509' registered1364machine # [ 0.371255] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1365machine # [ 0.373508] io scheduler mq-deadline registered1366machine # [ 0.373520] io scheduler kyber registered1367machine # [ 0.382824] pl061_gpio 9030000.pl061: PL061 GPIO chip registered1368machine # [ 0.384311] ledtrig-cpu: registered to indicate activity on CPUs1369machine # [ 0.384691] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:1370machine # [ 0.384709] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x00000000001371machine # [ 0.384721] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x00100000001372machine # [ 0.384729] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x80000000001373machine # [ 0.384750] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits1374machine # [ 0.384776] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1375machine # [ 0.384865] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:001376machine # [ 0.384875] pci_bus 0000:00: root bus resource [bus 00-ff]1377machine # [ 0.384882] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]1378machine # [ 0.384888] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]1379machine # [ 0.384893] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]1380machine # [ 0.384957] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1381machine # [ 0.385452] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1382machine # [ 0.385642] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]1383machine # [ 0.385659] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]1384machine # [ 0.385690] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1385machine # [ 0.385729] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]1386machine # [ 0.386198] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1387machine # [ 0.386383] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]1388machine # [ 0.386400] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]1389machine # [ 0.386430] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1390machine # [ 0.386916] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1391machine # [ 0.387101] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]1392machine # [ 0.387118] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]1393machine # [ 0.387149] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1394machine # [ 0.387608] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1395machine # [ 0.387802] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]1396machine # [ 0.387819] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]1397machine # [ 0.387851] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1398machine # [ 0.387873] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]1399machine # [ 0.388326] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1400machine # [ 0.388516] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]1401machine # [ 0.388546] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1402machine # [ 0.388999] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1403machine # [ 0.389188] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]1404machine # [ 0.389220] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1405machine # [ 0.389696] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1406machine # [ 0.389910] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]1407machine # [ 0.390170] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1408machine # [ 0.390371] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]1409machine # [ 0.390401] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1410machine # [ 0.435008] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1411machine # [ 0.435232] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]1412machine # [ 0.435264] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1413machine # [ 0.435737] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint1414machine # [ 0.435921] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]1415machine # [ 0.435952] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1416machine # [ 0.436410] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1417machine # [ 0.436710] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]1418machine # [ 0.436729] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]1419machine # [ 0.436760] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1420machine # [ 0.437223] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1421machine # [ 0.437414] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]1422machine # [ 0.437430] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]1423machine # [ 0.437462] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1424machine # [ 0.438105] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1425machine # [ 0.438118] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1426machine # [ 0.438124] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1427machine # [ 0.438170] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1428machine # [ 0.438219] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1429machine # [ 0.438268] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1430machine # [ 0.438318] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1431machine # [ 0.438369] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1432machine # [ 0.438419] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1433machine # [ 0.438466] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1434machine # [ 0.438512] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1435machine # [ 0.438559] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1436machine # [ 0.438634] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1437machine # [ 0.438693] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1438machine # [ 0.438715] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1439machine # [ 0.438740] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1440machine # [ 0.438764] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1441machine # [ 0.438786] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1442machine # [ 0.438809] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1443machine # [ 0.438832] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned1444machine # [ 0.438856] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1445machine # [ 0.438882] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1446machine # [ 0.438904] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned1447machine # [ 0.438927] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned1448machine # [ 0.438950] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1449machine # [ 0.438972] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned1450machine # [ 0.438995] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned1451machine # [ 0.439018] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned1452machine # [ 0.439040] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned1453machine # [ 0.439063] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned1454machine # [ 0.439085] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned1455machine # [ 0.439112] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]1456machine # [ 0.439122] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]1457machine # [ 0.439126] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]1458machine # [ 0.439964] pci 0000:00:07.0: enabling device (0000 -> 0002)1459machine # [ 0.509400] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1460machine # [ 0.516186] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)1461machine # [ 0.518542] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1462machine # [ 0.536285] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1463machine # [ 0.538357] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)1464machine # [ 0.542261] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)1465machine # [ 0.544881] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)1466machine # [ 0.554924] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)1467machine # [ 0.557113] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)1468machine # [ 0.566889] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1469machine # [ 0.570139] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1470machine # [ 0.584029] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1471machine # [ 0.586796] msm_serial: driver initialized1472machine # [ 0.586963] SuperH (H)SCI(F) driver initialized1473machine # [ 0.587021] STM32 USART driver initialized1474machine # [ 0.621001] loop: module loaded1475machine # [ 0.621228] virtio_blk virtio2: 1/0/0 default/read/poll queues1476machine # [ 0.622118] virtio_blk virtio2: [vda] 4194304 512-byte logical blocks (2.15 GB/2.00 GiB)1477machine # [ 0.627320] megasas: 07.734.00.00-rc11478machine # [ 0.628026] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1479machine # [ 0.639371] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001480machine # [ 0.639407] Intel/Sharp Extended Query Table at 0x00311481machine # [ 0.641076] Using buffer write method1482machine # [ 0.641157] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1483machine # [ 0.656831] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001484machine # [ 0.656872] Intel/Sharp Extended Query Table at 0x00311485machine # [ 0.660767] Using buffer write method1486machine # [ 0.660819] Concatenating MTD devices:1487machine # [ 0.660824] (0): "0.flash"1488machine # [ 0.660828] (1): "0.flash"1489machine # [ 0.660834] into device "0.flash"1490machine # [ 0.945898] Freeing initrd memory: 26372K1491machine # [ 0.952267] tun: Universal TUN/TAP device driver, 1.61492machine # [ 0.956405] thunder_xcv, ver 1.01493machine # [ 0.956451] thunder_bgx, ver 1.01494machine # [ 0.956485] nicpf, ver 1.01495machine # [ 0.957062] e1000: Intel(R) PRO/1000 Network Driver1496machine # [ 0.957070] e1000: Copyright (c) 1999-2006 Intel Corporation.1497machine # [ 0.957097] e1000e: Intel(R) PRO/1000 Network Driver1498machine # [ 0.957105] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1499machine # [ 0.957134] igb: Intel(R) Gigabit Ethernet Network Driver1500machine # [ 0.957140] igb: Copyright (c) 2007-2014 Intel Corporation.1501machine # [ 0.957160] igbvf: Intel(R) Gigabit Virtual Function Network Driver1502machine # [ 0.957168] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1503machine # [ 0.957306] sky2: driver version 1.301504machine # [ 0.959367] ehci-pci 0000:00:07.0: EHCI Host Controller1505machine # [ 0.959408] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 11506machine # [ 0.959622] ehci-pci 0000:00:07.0: irq 16, io mem 0x100860001507machine # [ 0.970073] usbcore: registered new interface driver usb-storage1508machine # [ 0.970176] usbcore: registered new interface driver usbserial_generic1509machine # [ 0.970190] usbserial: USB Serial support registered for generic1510machine # [ 0.970702] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.001511machine # [ 0.971236] hub 1-0:1.0: USB hub found1512machine # [ 0.971258] hub 1-0:1.0: 6 ports detected1513machine # [ 0.975986] hv_vmbus: registering driver hyperv_keyboard1514machine # [ 0.977628] rtc-pl031 9010000.pl031: registered as rtc01515machine # [ 0.977662] rtc-pl031 9010000.pl031: setting system clock to 2026-09-14T03:00:53 UTC (1789354853)1516machine # [ 0.978005] i2c_dev: i2c /dev entries driver1517machine # [ 0.983571] sdhci: Secure Digital Host Controller Interface driver1518machine # [ 0.983585] sdhci: Copyright(c) Pierre Ossman1519machine # [ 0.983861] Synopsys Designware Multimedia Card Interface Driver1520machine # [ 0.984237] sdhci-pltfm: SDHCI platform and OF driver helper1521machine # [ 0.985812] hid: raw HID events driver (C) Jiri Kosina1522machine # [ 0.986053] usbcore: registered new interface driver usbhid1523machine # [ 0.986060] usbhid: USB HID core driver1524machine # [ 0.991944] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available1525machine # [ 0.993618] drop_monitor: Initializing network drop monitor service1526machine # [ 0.993828] NET: Registered PF_INET6 protocol family1527machine # [ 0.997295] Segment Routing with IPv61528machine # [ 0.997317] In-situ OAM (IOAM) with IPv61529machine # [ 0.997346] NET: Registered PF_PACKET protocol family1530machine # [ 0.999127] 9pnet: Installing 9P2000 support1531machine # [ 0.999178] Key type dns_resolver registered1532machine # [ 1.006201] registered taskstats version 11533machine # [ 1.006365] Loading compiled-in X.509 certificates1534machine # [ 1.015375] Demotion targets for Node 0: null1535machine # [ 1.015514] Key type .fscrypt registered1536machine # [ 1.015525] Key type fscrypt-provisioning registered1537machine # [ 1.015644] ima: No TPM chip found, activating TPM-bypass!1538machine # [ 1.015670] ima: Allocated hash algorithm: sha11539machine # [ 1.015694] ima: No architecture policies found1540machine # [ 1.020424] input: gpio-keys as /devices/platform/gpio-keys/input/input01541machine # [ 1.040073] clk: Disabling unused clocks1542machine # [ 1.040110] PM: genpd: Disabling unused power domains1543machine # [ 1.044659] Freeing unused kernel memory: 4736K1544machine # [ 1.044879] Run /init as init process1545machine # [ 1.061588] systemd[1]: Successfully made /usr/ read-only.1546machine # [ 1.218745] usb 1-1: new high-speed USB device number 2 using ehci-pci1547machine # [ 1.382146] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11548machine # [ 1.397050] systemd[1]: systemd 262-5698092 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)1549machine # [ 1.408716] systemd[1]: Detected virtualization qemu.1550machine # [ 1.410216] systemd[1]: Detected architecture arm64.1551machine # [ 1.411521] systemd[1]: Running in initrd.1552machine # [ 1.413313] systemd[1]: Initializing machine ID from random generator.1553machine # [ 1.415288] systemd[1]: Hostname set to <machine>.1554machine # [ 1.471046] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input01555machine # [ 1.570494] systemd[1]: bpf-restrict-fs: LSM BPF program attached1556machine # [ 1.594770] usb 1-2: new high-speed USB device number 3 using ehci-pci1557machine # [ 1.634902] systemd[1]: Queued start job for default target Initrd Default Target.1558machine # [ 1.645037] systemd[1]: Created slice Slice /system/modprobe.1559machine # [ 1.646171] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1560machine # [ 1.647486] systemd[1]: Expecting device /dev/disk/by-label/nixos...1561machine # [ 1.648378] systemd[1]: Expecting device /dev/hvc0...1562machine # [ 1.649096] systemd[1]: Expecting device /dev/ttyAMA0...1563machine # [ 1.649881] systemd[1]: Reached target Path Units.1564machine # [ 1.650593] systemd[1]: Reached target Slice Units.1565machine # [ 1.651390] systemd[1]: Reached target Swaps.1566machine # [ 1.652037] systemd[1]: Reached target Timer Units.1567machine # [ 1.652974] systemd[1]: Listening on D-Bus System Message Bus Socket.1568machine # [ 1.654120] systemd[1]: Listening on Journal Socket (/dev/log).1569machine # [ 1.655330] systemd[1]: Listening on Journal Sockets.1570machine # [ 1.655481] systemd[1]: Listening on udev Kernel Socket.1571machine # [ 1.655510] systemd[1]: Reached target Socket Units.1572machine # [ 1.659812] systemd[1]: Starting Create List of Static Device Nodes...1573machine # [ 1.659901] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1574machine # [ 1.670885] systemd[1]: Mounting Kernel Configuration File System...1575machine # [ 1.679033] systemd[1]: Starting Journal Service...1576machine # [ 1.702606] systemd[1]: Starting Load Kernel Modules...1577machine # [ 1.706955] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1578machine # [ 1.725383] systemd-journald[72]: Collecting audit messages is disabled.1579machine # [ 1.726546] systemd[1]: Starting Coldplug All udev Devices...1580machine # [ 1.734998] systemd[1]: Finished Create List of Static Device Nodes.1581machine # [ 1.735840] systemd[1]: Mounted Kernel Configuration File System.1582machine # [ 1.749390] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1583machine # [ 1.755845] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21584machine # [ 1.756021] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input01585machine # [ 1.807436] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1586machine # [ 1.810219] systemd[1]: Starting Create Static Device Nodes in /dev...1587machine # [ 1.827295] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1588machine # [ 1.838811] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1589machine # [ 1.848163] [drm] pci: virtio-gpu-pci detected at 0000:00:05.01590machine # [ 1.848420] [drm] features: -virgl +edid -resource_blob -host_visible1591machine # [ 1.848431] [drm] features: -context_init1592machine # [ 1.849176] [drm] number of scanouts: 11593machine # [ 1.849194] [drm] number of cap sets: 01594machine # [ 1.879424] systemd[1]: Finished Create Static Device Nodes in /dev.1595machine # [ 1.879836] systemd[1]: Reached target Preparation for Local File Systems.1596machine # [ 1.879866] systemd[1]: Reached target Local File Systems.1597machine # [ 1.884118] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic1598machine # [ 1.884141] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 01599machine # [ 1.892780] systemd[1]: Starting Rule-based Manager for Device Events and Files...1600machine # [ 1.909465] Console: switching to colour frame buffer device 160x501601machine # [ 1.908728] systemd-modules-load[74]: Inserted module 'dm_mod'1602machine # [ 1.910102] systemd-modules-load[74]: Module 'virtio_balloon' is built in1603machine # [ 1.911249] systemd-modules-load[74]: Module 'virtio_console' is built in1604machine # [ 1.935011] systemd[1]: Started Journal Service.1605machine # [ 1.943289] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1606machine # [ 1.932908] systemd-modules-load[74]: Inserted module 'virtio_gpu'1607machine # [ 1.934012] systemd-modules-load[74]: Module 'virtio_rng' is built in1608machine # [ 1.941222] systemd[1]: Starting Create System Files and Directories...1609machine # [ 1.956871] systemd[1]: Finished Load Kernel Modules.1610machine # [ 1.979288] systemd-udevd[79]: Using default interface naming scheme 'v261'.1611machine # [ 1.980894] systemd[1]: Starting Apply Kernel Variables...1612machine # [ 2.017618] systemd[1]: Finished Apply Kernel Variables.1613machine # [ 2.028929] systemd[1]: Finished Create System Files and Directories.1614machine # [ 2.041240] systemd[1]: Started Rule-based Manager for Device Events and Files.1615machine # [ 2.120643] systemd[1]: Starting Virtual Console Setup...1616machine # [ 2.203129] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.1617machine # [ 2.206839] systemd[1]: Finished Virtual Console Setup.1618machine # [ 2.842257] systemd[1]: Finished Coldplug All udev Devices.1619machine # [ 2.843292] systemd[1]: Reached target System Initialization.1620machine # [ 2.848224] systemd[1]: Reached target Basic System.1621machine # [ 2.980204] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1622machine # [ 2.984987] systemd[1]: Found device /dev/hvc0.1623machine # [ 2.993584] systemd[1]: Found device /dev/ttyAMA0.1624machine # [ 2.996578] systemd[1]: Started backdoor.service.1625machine # [ 3.030331] backdoor-start[108]: /nix/store/7ha5lhh89qiqfnvv3zlydbcanibmd4n6-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found1626machine # connecting to host...1627machine # [ 3.040102] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.1628machine: Guest shell says: b'Spawning backdoor root shell...\n'1629machine: connected to guest root shell1630machine: (connecting took 3.37 seconds)1631machine: (finished: waiting for the VM to finish booting, in 3.37 seconds)1632machine # [ 3.050500] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1633machine # [ 3.152469] systemd[1]: Found device /dev/disk/by-label/nixos.1634machine # [ 3.153452] systemd[1]: Reached target Initrd Root Device.1635machine # [ 3.160067] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1636machine # [ 3.217617] systemd-fsck[124]: nixos: clean, 225/65536 files, 15235/262144 blocks1637machine # [ 3.223889] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1638machine # [ 3.230148] systemd[1]: Mounting /sysroot...1639machine # [ 3.295153] EXT4-fs (vda): mounted filesystem e0472b85-873b-4ccf-b92c-741e50f7a111 r/w with ordered data mode. Quota mode: none.1640machine # [ 3.283345] systemd[1]: Mounted /sysroot.1641machine # [ 3.288152] systemd[1]: Reached target Initrd Root File System.1642machine # [ 3.293084] systemd[1]: Starting Mountpoints Configured in the Real Root...1643machine # [ 3.333437] systemd-sysroot-fstab-check[132]: /sysroot should be mounted in the initrd, will request daemon-reload.1644machine # [ 3.342578] systemd[1]: Reload requested from client PID 132 ('systemd-sysroot') (unit initrd-parse-etc.service)...1645machine # [ 3.345971] systemd[1]: Reloading...1646machine # [ 3.572125] systemd[1]: Reloading finished in 229 ms.1647machine # [ 3.607839] systemd-sysroot-fstab-check[132]: Requesting initrd-fs.target/start/replace...1648machine # [ 3.611643] systemd-sysroot-fstab-check[132]: Requesting swap.target/start/replace...1649machine # [ 3.619189] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1650machine # [ 3.622426] systemd[1]: Finished Mountpoints Configured in the Real Root.1651machine # [ 3.623473] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1652machine # [ 3.713195] systemd[1]: Mounting /sysroot/nix/.ro-store...1653machine # [ 3.729639] systemd[1]: Mounting /sysroot/nix/.rw-store...1654machine # [ 3.745051] systemd[1]: Mounting /sysroot/run...1655machine # [ 3.760780] systemd[1]: Mounting /sysroot/tmp/shared...1656machine # [ 3.805410] systemd[1]: Mounting /sysroot/tmp/xchg...1657machine # [ 3.848802] fuse: init (API version 7.45)1658machine # [ 3.857013] virtiofs virtio6: discovered new tag: nix-store1659machine # [ 3.857936] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1660machine # [ 3.872493] virtiofs virtio7: discovered new tag: shared1661machine # [ 3.873335] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1662machine # [ 3.862431] systemd[1]: Mounted /sysroot/nix/.rw-store.1663machine # [ 3.885719] virtiofs virtio8: discovered new tag: xchg1664machine # [ 3.886566] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1665machine # [ 3.901860] systemd[1]: Starting rw-sysroot-nix-store.service...1666machine # [ 3.925677] systemd[1]: Mounted /sysroot/nix/.ro-store.1667machine # [ 3.929167] systemd[1]: Mounted /sysroot/run.1668machine # [ 3.932546] systemd[1]: Mounted /sysroot/tmp/shared.1669machine # [ 3.939949] systemd[1]: Mounted /sysroot/tmp/xchg.1670machine # [ 3.957529] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1671machine # [ 3.960684] systemd[1]: Finished rw-sysroot-nix-store.service.1672machine # [ 4.642776] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/1g1nz2bgg9igl4hxl9i65z83g21a371k-systemd-262-5698092/lib/udev/mtd_probe": No such file or directory1673machine # [ 4.645716] (udev-worker)[94]: 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 directory1674machine # [ 4.695997] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1675machine # [ 4.698640] systemd[1]: Stopped Virtual Console Setup.1676machine # [ 4.699471] systemd[1]: Stopping Virtual Console Setup...1677machine # [ 4.704440] systemd[1]: Starting Virtual Console Setup...1678machine # [ 4.717747] systemd[1]: Mounting /sysroot/nix/store...1679machine # [ 4.757086] systemd-vconsole-setup[174]: Configuration of first virtual console was skipped, ignoring remaining ones.1680machine # [ 4.761944] systemd[1]: Finished Virtual Console Setup.1681machine # [ 4.762879] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.1682machine # [ 4.777172] systemd[1]: Mounted /sysroot/nix/store.1683machine # [ 4.778738] systemd[1]: Reached target Initrd File Systems.1684machine # [ 4.781538] systemd[1]: Starting Find NixOS closure...1685machine # [ 4.792726] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1686machine # [ 4.823832] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1687machine # [ 4.834438] systemd[1]: Finished Find NixOS closure.1688machine # [ 4.837678] systemd[1]: Reached target Initrd Default Target.1689machine # [ 4.839442] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1690machine # [ 4.860565] systemd[1]: initrd-cleanup.service: Deactivated successfully.1691machine # [ 4.862502] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1692machine # [ 4.877049] systemd[1]: Startup finished in 1.031s (kernel) + 0 (initrd) + 3.844s (userspace) = 4.876s.1693machine: (finished: waiting for unit initrd.target, in 5.54 seconds)1694machine: waiting for the VM to finish booting1695machine # [ 5.269407] systemd[1]: Stopped target Initrd Default Target.1696machine # [ 5.276237] systemd[1]: Stopped target Basic System.1697machine # [ 5.277655] systemd[1]: Stopped target Initrd Root Device.1698machine # [ 5.279041] systemd[1]: Stopped target Path Units.1699machine # [ 5.284687] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1700machine # [ 5.288726] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1701machine # [ 5.296360] systemd[1]: Stopped target Slice Units.1702machine # [ 5.297762] systemd[1]: Stopped target Socket Units.1703machine # [ 5.299076] systemd[1]: Stopped target System Initialization.1704machine # [ 5.302332] systemd[1]: Stopped target Swaps.1705machine # [ 5.307562] systemd[1]: Stopped target Timer Units.1706machine # [ 5.312399] systemd[1]: dbus.socket: Deactivated successfully.1707machine # [ 5.313923] systemd[1]: Closed D-Bus System Message Bus Socket.1708machine # [ 5.315303] systemd[1]: Stopping backdoor.service...1709machine # [ 5.328424] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1710machine # [ 5.329910] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1711machine # [ 5.331437] systemd[1]: Stopped Find NixOS closure.1712machine # [ 5.338180] systemd[1]: Starting rw-sysroot-nix-store.service...1713machine # [ 5.340180] systemd[1]: systemd-sysctl.service: Deactivated successfully.1714machine # [ 5.343444] systemd[1]: Stopped Apply Kernel Variables.1715machine # [ 5.351557] systemd[1]: systemd-modules-load.service: Deactivated successfully.1716machine # [ 5.361317] systemd[1]: Stopped Load Kernel Modules.1717machine # [ 5.362430] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1718machine # [ 5.363785] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1719machine # [ 5.376701] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1720machine # [ 5.377906] systemd[1]: Stopped Create System Files and Directories.1721machine # [ 5.378806] systemd[1]: Stopped target Local File Systems.1722machine # [ 5.379635] systemd[1]: Stopped target Preparation for Local File Systems.1723machine # [ 5.384286] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1724machine # [ 5.387940] systemd[1]: Stopped Coldplug All udev Devices.1725machine # [ 5.389071] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1726machine # [ 5.391485] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1727machine # [ 5.393721] systemd[1]: Stopped Virtual Console Setup.1728machine # [ 5.394985] systemd[1]: backdoor.service: Deactivated successfully.1729machine # [ 5.395954] systemd[1]: Stopped backdoor.service.1730machine # [ 5.402104] systemd[1]: systemd-udevd.service: Deactivated successfully.1731machine # [ 5.403453] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1732machine # [ 5.408720] systemd[1]: systemd-udevd.service: Consumed 1.593s CPU time over 3.483s wall clock time, 22M memory peak.1733machine # [ 5.410432] systemd[1]: Starting Cleanup udev Database...1734machine # [ 5.412235] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1735machine # [ 5.416261] systemd[1]: Stopped Create Static Device Nodes in /dev.1736machine # [ 5.417240] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1737machine # [ 5.420145] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1738machine # [ 5.421202] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1739machine # [ 5.424374] systemd[1]: Stopped Create List of Static Device Nodes.1740machine # [ 5.425345] systemd[1]: initrd-cleanup.service: Deactivated successfully.1741machine # [ 5.428280] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1742machine # [ 5.429258] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1743machine # [ 5.432334] systemd[1]: Finished rw-sysroot-nix-store.service.1744machine # [ 5.455374] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1745machine # [ 5.459172] systemd[1]: Finished Cleanup udev Database.1746machine # [ 5.460859] systemd[1]: Reached target Switch Root.1747machine # [ 5.464490] systemd[1]: Starting NixOS Activation...1748machine # [ 5.562002] initrd-nixos-activation-start[210]: booting system configuration /nix/store/sgbymhnd6pd3bgq1lrpzlcjkwz6qna4r-nixos-system-machine-test1749machine # [ 5.607045] initrd-nixos-activation-start[210]: running activation script...1750machine # [ 5.712704] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1751machine # [ 5.904689] initrd-nixos-activation-start[233]: setting up /etc...1752machine # [ 6.119544] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1753machine # [ 6.122739] systemd[1]: Finished NixOS Activation.1754machine # [ 6.124098] systemd[1]: Starting Switch Root...1755machine # [ 6.149194] systemd[1]: Switching root.1756machine # [ 6.330190] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1757machine # [ 6.864066] systemd[1]: systemd 262-5698092 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)1758machine # [ 6.877416] systemd[1]: Detected virtualization qemu.1759machine # [ 6.880923] systemd[1]: Detected architecture arm64.1760machine # [ 7.071743] systemd[1]: bpf-restrict-fs: LSM BPF program attached1761machine # [ 7.504684] systemd[1]: initrd-switch-root.service: Deactivated successfully.1762machine # [ 7.506103] systemd[1]: Stopped initrd-switch-root.service.1763machine # [ 7.509625] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1764machine # [ 7.513829] systemd[1]: Created slice Slice /system/getty.1765machine # [ 7.515726] systemd[1]: Created slice User and Session Slice.1766machine # [ 7.516990] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1767machine # [ 7.519193] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1768machine # [ 7.522434] systemd[1]: Expecting device /dev/hvc0...1769machine # [ 7.523936] systemd[1]: Expecting device /dev/ttyAMA0...1770machine # [ 7.525157] systemd[1]: Reached target Local Encrypted Volumes.1771machine # [ 7.526991] systemd[1]: Stopped target initrd-fs.target.1772machine # [ 7.529613] systemd[1]: Stopped target initrd-root-fs.target.1773machine # [ 7.530894] systemd[1]: Stopped target initrd-switch-root.target.1774machine # [ 7.531265] systemd[1]: Reached target Virtual Machines and Containers.1775machine # [ 7.531563] systemd[1]: Reached target Path Units.1776machine # [ 7.531847] systemd[1]: Reached target Remote File Systems.1777machine # [ 7.532184] systemd[1]: Reached target Slice Units.1778machine # [ 7.532479] systemd[1]: Reached target Swaps.1779machine # [ 7.538598] systemd[1]: Listening on Query the User Interactively for a Password.1780machine # [ 7.541850] systemd[1]: Listening on Process Core Dump Socket.1781machine # [ 7.544318] systemd[1]: Listening on Credential Encryption/Decryption.1782machine # [ 7.546917] systemd[1]: Listening on Factory Reset Management.1783machine # [ 7.547399] systemd[1]: Listening on Hostname Service Socket.1784machine # [ 7.553658] systemd[1]: Starting Journal Log Access Socket...1785machine # [ 7.556545] systemd[1]: Listening on Journal Audit Socket.1786machine # [ 7.560858] systemd[1]: Listening on Console Output Muting Service Socket.1787machine # [ 7.563270] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1788machine # [ 7.567324] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1789machine # [ 7.570115] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1790machine # [ 7.576826] systemd[1]: Listening on Disk Repartitioning Service Socket.1791machine # [ 7.578489] systemd[1]: Listening on udev Varlink Socket.1792machine # [ 7.582893] systemd[1]: Mounting Huge Pages File System...1793machine # [ 7.594151] systemd[1]: Mounting POSIX Message Queue File System...1794machine # [ 7.608357] systemd[1]: Mounting Kernel Debug File System...1795machine # [ 7.623349] systemd[1]: Mounting Kernel Trace File System...1796machine # [ 7.641237] systemd[1]: Starting Create List of Static Device Nodes...1797machine # [ 7.645102] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1798machine # [ 7.679132] systemd[1]: Mounting Kernel Configuration File System...1799machine # [ 7.679653] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1800machine # [ 7.679973] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1801machine # [ 7.680390] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1802machine # [ 7.696221] systemd[1]: Mounting FUSE Control File System...1803machine # [ 7.699882] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671804machine # [ 7.731641] systemd[1]: Starting Journal Service...1805machine # [ 7.755168] systemd[1]: Starting Load Kernel Modules...1806machine # [ 7.790078] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1807machine # [ 7.805624] systemd[1]: Starting Remount Root and Kernel File Systems...1808machine # [ 7.806123] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1809machine # [ 7.832177] systemd-journald[304]: Collecting audit messages is enabled.1810machine # [ 7.839127] systemd[1]: Starting Coldplug All udev Devices...1811machine # [ 7.849580] systemd[1]: Listening on Journal Log Access Socket.1812machine # [ 7.853483] systemd[1]: Mounted Huge Pages File System.1813machine # [ 7.854044] systemd[1]: Mounted POSIX Message Queue File System.1814machine # [ 7.854548] systemd[1]: Mounted Kernel Debug File System.1815machine # [ 7.839840] systemd[1]: Queued start job for default target Multi-User System.1816machine # [ 7.842506] systemd[1]: systemd-journald.service: Deactivated successfully.1817machine # [ 7.863420] systemd[1]: Started Journal Service.1818machine # [ 7.850348] systemd[1]: Mounted Kernel Trace File System.1819machine # [ 7.851438] systemd[1]: Finished Create List of Static Device Nodes.1820machine # [ 7.895643] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1821machine # [ 7.909782] systemd[1]: Mounted FUSE Control File System.1822machine # [ 7.921598] systemd-modules-load[305]: Module 'atkbd' is built in1823machine # [ 7.923351] systemd-modules-load[305]: Module 'loop' is built in1824machine # [ 7.944528] systemd-oomd[306]: No swap; memory pressure usage will be degraded1825machine # [ 7.954440] systemd[1]: Finished Load Kernel Modules.1826machine # [ 7.955378] systemd[1]: Mounted Kernel Configuration File System.1827machine # [ 7.982771] EXT4-fs (vda): re-mounted e0472b85-873b-4ccf-b92c-741e50f7a111.1828machine # [ 7.968433] systemd[1]: Starting Firewall...1829machine # [ 7.983101] systemd[1]: Starting Apply Kernel Variables...1830machine # [ 7.985913] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1831machine # [ 7.990392] systemd[1]: Finished Remount Root and Kernel File Systems.1832machine # [ 7.997892] systemd[1]: Listening on Disk Image Download Service Socket.1833machine # [ 8.021746] systemd[1]: Starting Grow Root File System...1834machine # [ 8.038954] systemd[1]: Starting Flush Journal to Persistent Storage...1835machine # [ 8.044215] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1836machine # [ 8.068145] systemd[1]: Starting Load/Save OS Random Seed...1837machine # [ 8.069195] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1838machine # [ 8.152999] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1839machine # [ 8.176342] systemd[1]: Starting Create Static Device Nodes in /dev...1840machine # [ 8.204851] EXT4-fs (vda): resizing filesystem from 262144 to 524288 blocks1841machine # [ 8.207397] systemd-journald[304]: Received client request to flush runtime journal.1842machine # [ 8.242815] EXT4-fs (vda): resized filesystem to 5242881843machine # [ 8.289185] systemd-growfs[324]: Successfully resized "/" to 2G bytes.1844machine # [ 8.290411] systemd[1]: Finished Apply Kernel Variables.1845machine # [ 8.298628] systemd[1]: Finished Grow Root File System.1846machine # [ 8.299689] systemd[1]: Finished Load/Save OS Random Seed.1847machine # [ 8.302831] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes1848machine # [ 8.312694] systemd[1]: Finished Flush Journal to Persistent Storage.1849machine # [ 8.481086] systemd[1]: Finished Create Static Device Nodes in /dev.1850machine # [ 8.484194] systemd[1]: Reached target Preparation for Local File Systems.1851machine # [ 8.491718] systemd[1]: Starting Rule-based Manager for Device Events and Files...1852machine # [ 8.501110] systemd[1]: Mounting /run/wrappers...1853machine # [ 8.625361] systemd[1]: Mounted /run/wrappers.1854machine # [ 8.626230] systemd[1]: Reached target Local File Systems.1855machine # [ 8.631483] systemd[1]: Listening on Boot Loader Control Service Socket.1856machine # [ 8.640122] systemd[1]: Starting Create SUID/SGID Wrappers...1857machine # [ 8.641117] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1858machine # [ 8.642398] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id1859machine # [ 8.660315] systemd[1]: Starting Create System Files and Directories...1860machine # [ 8.717707] systemd-udevd[341]: Using default interface naming scheme 'v261'.1861machine # [ 8.889264] systemd[1]: Finished Create System Files and Directories.1862machine # [ 8.892247] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var1863machine # [ 8.904189] systemd[1]: Update is Completed skipped, no trigger condition checks were met.1864machine # [ 8.909517] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1865machine # [ 8.916290] systemd[1]: Started Rule-based Manager for Device Events and Files.1866machine # [ 9.048673] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1867machine # [ 9.561884] systemd[1]: Finished Coldplug All udev Devices.1868machine # [ 9.630375] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1869machine # [ 9.679576] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1870machine # [ 9.845666] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1871machine # [ 9.850710] systemd[1]: Finished Create SUID/SGID Wrappers.1872machine # [ 9.855277] systemd[1]: Reached target System Initialization.1873machine # [ 9.860711] systemd[1]: Started Discard unused filesystem blocks once a week.1874machine # [ 9.861816] systemd[1]: Started Daily Cleanup of Temporary Directories.1875machine # [ 9.862792] systemd[1]: Reached target Timer Units.1876machine # [ 9.863569] systemd[1]: Listening on D-Bus System Message Bus Socket.1877machine # [ 9.873218] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1878machine # [ 9.874516] systemd[1]: Reached target Socket Units.1879machine # [ 9.875294] systemd[1]: Reached target Basic System.1880machine # [ 9.881704] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db1881machine # [ 9.883615] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1882machine # [ 9.891789] systemd[1]: Starting Post-Boot Actions...1883machine # [ 9.897530] systemd[1]: Started Reset console on configuration changes.1884machine # [ 9.908126] systemd[1]: Starting resolvconf update...1885machine # [ 9.972547] systemd[1]: Starting D-Bus System Message Bus...1886machine # [ 10.043733] systemd[1]: Started Name Service Cache Daemon (nsncd).1887machine # [ 10.055549] nsncd[464]: Sep 14 03:01:02.584 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1888machine # [ 10.069229] systemd[1]: Reached target Host and Network Name Lookups.1889machine # [ 10.070285] systemd[1]: Reached target User and Group Name Lookups.1890machine # [ 10.098377] systemd[1]: Starting User Login Management...1891machine # [ 10.110489] systemd[1]: Finished Post-Boot Actions.1892machine # [ 10.120423] systemd[1]: Found device /dev/hvc0.1893machine # [ 10.219205] systemd[1]: Found device /dev/ttyAMA0.1894machine # [ 10.224051] systemd[1]: Started backdoor.service.1895machine # [ 10.271216] dbus-broker-launch[469]: Looking up NSS user entry for 'systemd-timesync'...1896machine # [ 10.279883] dbus-broker-launch[469]: NSS returned no entry for 'systemd-timesync'1897machine # [ 10.292202] dbus-broker-launch[469]: Invalid user-name in /nix/store/m2dlyz3lpny9qs3lm9gzblz5zygr9wfz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1898machine # [ 10.349069] systemd[1]: Started D-Bus System Message Bus.1899machine # [ 10.403415] systemd-logind[487]: New seat seat0.1900machine # [ 10.420942] dbus-broker-launch[469]: Ready1901machine # [ 10.429070] systemd[1]: Started User Login Management.1902machine # [ 10.443238] systemd[1]: Starting linger-users.service...1903machine # connecting to host...1904machine # [ 10.504986] systemd[1]: Stopped target Host and Network Name Lookups.1905machine # [ 10.506054] systemd[1]: Stopping Host and Network Name Lookups...1906machine # [ 10.507024] systemd[1]: Stopped target User and Group Name Lookups.1907machine # [ 10.507914] systemd[1]: Stopping User and Group Name Lookups...1908machine # [ 10.522460] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1909machine # [ 10.523589] systemd[1]: nscd.service: Deactivated successfully.1910machine: Guest shell says: b'Spawning backdoor root shell...\n'1911machine # [ 10.533060] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1912machine: connected to guest root shell1913machine: (connecting took 5.32 seconds)1914machine: (finished: waiting for the VM to finish booting, in 5.32 seconds)1915machine: must succeed: df --output=avail / | sed 1d1916machine # [ 10.571216] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1917machine # [ 10.609228] systemd[1]: linger-users.service: Deactivated successfully.1918machine # [ 10.615944] systemd[1]: Finished linger-users.service.1919machine # [ 10.620823] (udev-worker)[376]: Network interface NamePolicy= disabled on kernel command line.1920machine # [ 10.636583] (udev-worker)[404]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1921machine # [ 10.665713] (udev-worker)[404]: Network interface NamePolicy= disabled on kernel command line.1922machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.18 seconds)1923(finished: subtest: growfs works, in 13.29 seconds)1924subtest: no warnings from systemd about write permissions1925machine: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges'1926machine # [ 10.743478] systemd[1]: Started Name Service Cache Daemon (nsncd).1927machine # [ 10.751541] systemd[1]: Reached target Host and Network Name Lookups.1928machine # [ 10.759992] nsncd[554]: Sep 14 03:01:03.282 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1929machine # [ 10.767096] systemd[1]: Reached target User and Group Name Lookups.1930machine # [ 10.788357] systemd[1]: Finished resolvconf update.1931machine # [ 10.810075] systemd[1]: Starting DHCP Client...1932machine: (finished: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges', in 0.16 seconds)1933(finished: subtest: no warnings from systemd about write permissions, in 0.16 seconds)1934(finished: run the VM test script, in 33.35 seconds)1935machine # [ 11.141126] dhcpcd[615]: dhcpcd-10.3.2 starting1936machine # [ 11.153908] dhcpcd[628]: dev: loaded udev1937machine # [ 11.156551] dhcpcd[628]: DUID 00:01:00:01:32:3a:1f:da:52:54:00:12:34:561938test script finished in 33.66s1939cleanup1940kill QemuMachine (pid 91)1941machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)1942machine # [2026-09-14T03:01:03Z INFO virtiofsd] Client disconnected, shutting down1943machine # [2026-09-14T03:01:03Z INFO virtiofsd] Client disconnected, shutting down1944machine # [2026-09-14T03:01:03Z INFO virtiofsd] Client disconnected, shutting down1945(finished: cleanup, in 0.18 seconds)