vm-test-run-systemd-initrd-simple
checks.aarch64-linux.systemd-initrd-simple
· build #33
· 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: QEMU running (pid 45)12machine # Disk image does not exist, creating the virtualisation disk image...13machine # Formatting '/build/vm-state-machine/tmp.c7KOo7E0Cm', 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: d5da9096-5b7f-4f67-aab6-e3bdfc07309218machine # 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 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]28machine # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 202629machine # [ 0.000000] KASLR enabled30machine # [ 0.000000] random: crng init done31machine # [ 0.000000] Machine model: linux,dummy-virt32machine # [ 0.000000] efi: UEFI not found.33machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT34machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]35machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]36machine # [ 0.000000] Zone ranges:37machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]38machine # [ 0.000000] DMA32 empty39machine # [ 0.000000] Normal empty40machine # [ 0.000000] Device empty41machine # [ 0.000000] Movable zone start for each node42machine # [ 0.000000] Early memory node ranges43machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]44machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]45machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000046machine # [ 0.000000] psci: probing for conduit method from DT.47machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.48machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs49machine # [ 0.000000] psci: Trusted OS migration not required50machine # [ 0.000000] psci: SMC Calling Convention v1.151machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)52machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129653machine # [ 0.000000] Detected PIPT I-cache on CPU054machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)55machine # [ 0.000000] CPU features: detected: GICv3 CPU interface56machine # [ 0.000000] CPU features: detected: Spectre-v457machine # [ 0.000000] CPU features: detected: Spectre-BHB58machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3859machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2360machine # [ 0.000000] alternatives: applying boot alternatives61machine # [ 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/6ijy5cg34pv6ym977z2bddgyv7w6gcjd-nixos-system-machine-test/init regInfo=/nix/store/xam14axn9py9zvvzxkspsm2hrgkvc59n-closure-info/registration console=ttyAMA0,115200n8 console=tty062machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/xam14axn9py9zvvzxkspsm2hrgkvc59n-closure-info/registration", will be passed to user space.63machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes64machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)65machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)66machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB67machine # [ 0.000000] software IO TLB: area num 1.68machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)69machine # [ 0.000000] Fallback order for Node 0: 070machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214471machine # [ 0.000000] Policy zone: DMA72machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off73machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=174machine # [ 0.000000] allocated 2097152 bytes of page_ext75machine # [ 0.000000] ftrace: allocating 74885 entries in 294 pages76machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups77machine # [ 0.000000] rcu: Hierarchical RCU implementation.78machine # [ 0.000000] rcu: RCU event tracing is enabled.79machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.80machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.81machine # [ 0.000000] Rude variant of Tasks RCU enabled.82machine # [ 0.000000] Tracing variant of Tasks RCU enabled.83machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.84machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=185machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.86machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.87machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.88machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 089machine # [ 0.000000] GICv3: 256 SPIs implemented90machine # [ 0.000000] GICv3: 0 Extended SPIs implemented91machine # [ 0.000000] Root IRQ handler: gic_handle_irq92machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI93machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=094machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a000095machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]96machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)97machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)98machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d1000099machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000100machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.101machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns102machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).103machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns104machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns105machine # [ 0.000030] arm-pv: using stolen time PV106machine # [ 0.000393] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)107machine # [ 0.000579] Console: colour dummy device 80x25108machine # [ 0.000587] printk: legacy console [tty0] enabled109machine # [ 0.000783] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)110machine # [ 0.000790] pid_max: default: 32768 minimum: 301111machine # [ 0.000860] LSM: initializing lsm=capability,landlock,yama,bpf,ima112machine # [ 0.001034] landlock: Up and running.113machine # [ 0.001037] Yama: becoming mindful.114machine # [ 0.001456] LSM support for eBPF active115machine # [ 0.001604] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)116machine # [ 0.001624] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)117machine # [ 0.002752] cacheinfo: Unable to detect cache hierarchy for CPU 0118machine # [ 0.003513] rcu: Hierarchical SRCU implementation.119machine # [ 0.003517] rcu: Max phase no-delay instances is 1000.120machine # [ 0.004734] fsl-mc MSI: its@8080000 domain created121machine # [ 0.004825] EFI services will not be available.122machine # [ 0.004908] smp: Bringing up secondary CPUs ...123machine # [ 0.004918] smp: Brought up 1 node, 1 CPU124machine # [ 0.004921] SMP: Total of 1 processors activated.125machine # [ 0.004924] CPU: All CPU(s) started at EL1126machine # [ 0.004937] CPU features: detected: Branch Target Identification127machine # [ 0.004942] CPU features: detected: ARMv8.4 Translation Table Level128machine # [ 0.004945] CPU features: detected: Instruction cache invalidation not required for I/D coherence129machine # [ 0.004949] CPU features: detected: Data cache clean to the PoU not required for I/D coherence130machine # [ 0.004953] CPU features: detected: Common not Private translations131machine # [ 0.004956] CPU features: detected: CRC32 instructions132machine # [ 0.004959] CPU features: detected: Data cache clean to Point of Deep Persistence133machine # [ 0.004962] CPU features: detected: Data cache clean to Point of Persistence134machine # [ 0.004966] CPU features: detected: Data independent timing control (DIT)135machine # [ 0.004969] CPU features: detected: E0PD136machine # [ 0.004971] CPU features: detected: Enhanced Counter Virtualization137machine # [ 0.004974] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)138machine # [ 0.004978] CPU features: detected: Enhanced Virtualization Traps139machine # [ 0.004981] CPU features: detected: Fine Grained Traps140machine # [ 0.004984] CPU features: detected: Generic authentication (architected QARMA5 algorithm)141machine # [ 0.004988] CPU features: detected: RCpc load-acquire (LDAPR)142machine # [ 0.004991] CPU features: detected: LSE atomic instructions143machine # [ 0.004995] CPU features: detected: Privileged Access Never144machine # [ 0.004997] CPU features: detected: PMUv3145machine # [ 0.005000] CPU features: detected: RAS Extension Support146machine # [ 0.005003] CPU features: detected: RASv1p1 Extension Support147machine # [ 0.005005] CPU features: detected: Random Number Generator148machine # [ 0.005008] CPU features: detected: Speculation barrier (SB)149machine # [ 0.005011] CPU features: detected: Stage-2 Force Write-Back150machine # [ 0.005014] CPU features: detected: TLB range maintenance instructions151machine # [ 0.005019] CPU features: detected: Speculative Store Bypassing Safe (SSBS)152machine # [ 0.005056] alternatives: applying system-wide alternatives153machine # [ 0.008097] CPU features: detected: BBM Level 2 without TLB conflict abort154machine # [ 0.008330] Memory: 894180K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 113060K reserved, 32768K cma-reserved)155machine # [ 0.008684] devtmpfs: initialized156machine # [ 0.010441] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)157machine # [ 0.010465] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).158machine # [ 0.010654] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL159machine # [ 0.010659] 0 pages in range for non-PLT usage160machine # [ 0.010660] 508288 pages in range for PLT usage161machine # [ 0.010756] pinctrl core: initialized pinctrl subsystem162machine # [ 0.011563] DMI not present or invalid.163machine # [ 0.014727] NET: Registered PF_NETLINK/PF_ROUTE protocol family164machine # [ 0.017038] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations165machine # [ 0.017203] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations166machine # [ 0.017368] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations167machine # [ 0.017389] audit: initializing netlink subsys (disabled)168machine # [ 0.018012] thermal_sys: Registered thermal governor 'fair_share'169machine # [ 0.018014] thermal_sys: Registered thermal governor 'bang_bang'170machine # [ 0.018018] thermal_sys: Registered thermal governor 'step_wise'171machine # [ 0.018020] thermal_sys: Registered thermal governor 'user_space'172machine # [ 0.018025] thermal_sys: Registered thermal governor 'power_allocator'173machine # [ 0.018066] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1174machine # [ 0.018075] cpuidle: using governor ladder175machine # [ 0.018080] cpuidle: using governor menu176machine # [ 0.018305] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.177machine # [ 0.018320] ASID allocator initialised with 65536 entries178machine # [ 0.019465] Serial: AMBA PL011 UART driver179machine # [ 0.024646] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1180machine # [ 0.024815] printk: console [ttyAMA0] enabled181machine # [ 0.151154] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages182machine # [ 0.151177] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page183machine # [ 0.151182] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages184machine # [ 0.151186] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page185machine # [ 0.151190] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages186machine # [ 0.151195] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page187machine # [ 0.151199] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages188machine # [ 0.151203] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page189machine # [ 0.158977] fbcon: Taking over console190machine # [ 0.158994] ACPI: Interpreter disabled.191machine # [ 0.165153] iommu: Default domain type: Translated192machine # [ 0.165164] iommu: DMA domain TLB invalidation policy: strict mode193machine # [ 0.166985] SCSI subsystem initialized194machine # [ 0.167672] usbcore: registered new interface driver usbfs195machine # [ 0.167701] usbcore: registered new interface driver hub196machine # [ 0.167720] usbcore: registered new device driver usb197machine # [ 0.167979] pps_core: LinuxPPS API ver. 1 registered198machine # [ 0.167986] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>199machine # [ 0.168005] PTP clock support registered200machine # [ 0.168056] EDAC MC: Ver: 3.0.0201machine # [ 0.172807] scmi_core: SCMI protocol bus registered202machine # [ 0.173835] FPGA manager framework203machine # [ 0.174851] vgaarb: loaded204machine # [ 0.175504] clocksource: Switched to clocksource arch_sys_counter205machine # [ 0.181784] VFS: Disk quotas dquot_6.6.0206machine # [ 0.181836] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)207machine # [ 0.183588] netfs: FS-Cache loaded208machine # [ 0.183720] pnp: PnP ACPI: disabled209machine # [ 0.187615] NET: Registered PF_INET protocol family210machine # [ 0.187775] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)211machine # [ 0.217772] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)212machine # [ 0.217829] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)213machine # [ 0.217858] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)214machine # [ 0.217907] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)215machine # [ 0.217989] TCP: Hash tables configured (established 8192 bind 8192)216machine # [ 0.218078] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)217machine # [ 0.218161] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)218machine # [ 0.218187] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)219machine # [ 0.218278] NET: Registered PF_UNIX/PF_LOCAL protocol family220machine # [ 0.218299] NET: Registered PF_XDP protocol family221machine # [ 0.218339] PCI: CLS 0 bytes, default 64222machine # [ 0.218614] Trying to unpack rootfs image as initramfs...223machine # [ 0.239566] kvm [1]: HYP mode not available224machine # [ 0.348102] Initialise system trusted keyrings225machine # [ 0.348889] workingset: timestamp_bits=42 max_order=18 bucket_order=0226machine # [ 0.350206] squashfs: version 4.0 (2009/01/31) Phillip Lougher227machine # [ 0.351009] 9p: Installing v9fs 9p2000 file system support228machine # [ 0.379812] Key type asymmetric registered229machine # [ 0.379843] Asymmetric key parser 'x509' registered230machine # [ 0.379930] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)231machine # [ 0.382103] io scheduler mq-deadline registered232machine # [ 0.382140] io scheduler kyber registered233machine # [ 0.391708] pl061_gpio 9030000.pl061: PL061 GPIO chip registered234machine # [ 0.393197] ledtrig-cpu: registered to indicate activity on CPUs235machine # [ 0.393626] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:236machine # [ 0.393646] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000237machine # [ 0.393658] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000238machine # [ 0.393677] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000239machine # [ 0.393699] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits240machine # [ 0.393725] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]241machine # [ 0.393811] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00242machine # [ 0.393829] pci_bus 0000:00: root bus resource [bus 00-ff]243machine # [ 0.393838] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]244machine # [ 0.393843] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]245machine # [ 0.393848] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]246machine # [ 0.393925] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint247machine # [ 0.394396] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint248machine # [ 0.394581] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]249machine # [ 0.394598] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]250machine # [ 0.394627] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]251machine # [ 0.394643] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]252machine # [ 0.395095] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint253machine # [ 0.395277] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]254machine # [ 0.395293] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]255machine # [ 0.395322] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]256machine # [ 0.415122] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint257machine # [ 0.415309] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]258machine # [ 0.415326] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]259machine # [ 0.415355] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]260machine # [ 0.423956] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint261machine # [ 0.424173] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]262machine # [ 0.424190] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]263machine # [ 0.424220] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]264machine # [ 0.424693] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint265machine # [ 0.424879] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]266machine # [ 0.424895] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]267machine # [ 0.424924] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]268machine # [ 0.425382] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint269machine # [ 0.425565] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]270machine # [ 0.425581] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]271machine # [ 0.425611] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]272machine # [ 0.426059] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint273machine # [ 0.426264] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]274machine # [ 0.426281] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]275machine # [ 0.426310] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]276machine # [ 0.426326] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]277machine # [ 0.426786] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint278machine # [ 0.426975] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]279machine # [ 0.427005] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]280machine # [ 0.427470] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint281machine # [ 0.445351] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]282machine # [ 0.445385] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]283machine # [ 0.445812] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint284machine # [ 0.445993] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]285machine # [ 0.446254] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint286machine # [ 0.446534] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]287machine # [ 0.446551] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]288machine # [ 0.446580] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]289machine # [ 0.447035] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint290machine # [ 0.447221] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]291machine # [ 0.447237] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]292machine # [ 0.447266] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]293machine # [ 0.464006] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned294machine # [ 0.464036] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned295machine # [ 0.464042] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned296machine # [ 0.464095] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned297machine # [ 0.464145] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned298machine # [ 0.464195] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned299machine # [ 0.464243] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned300machine # [ 0.464293] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned301machine # [ 0.464341] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned302machine # [ 0.464390] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned303machine # [ 0.464438] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned304machine # [ 0.464486] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned305machine # [ 0.465021] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned306machine # [ 0.465071] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned307machine # [ 0.465094] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned308machine # [ 0.465116] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned309machine # [ 0.465137] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned310machine # [ 0.465160] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned311machine # [ 0.465185] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned312machine # [ 0.465207] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned313machine # [ 0.465261] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned314machine # [ 0.465284] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned315machine # [ 0.465306] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned316machine # [ 0.465330] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned317machine # [ 0.465353] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned318machine # [ 0.465374] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned319machine # [ 0.465396] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned320machine # [ 0.465418] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned321machine # [ 0.465439] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned322machine # [ 0.465460] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned323machine # [ 0.465482] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned324machine # [ 0.465503] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned325machine # [ 0.465525] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned326machine # [ 0.465547] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned327machine # [ 0.465575] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]328machine # [ 0.465585] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]329machine # [ 0.465589] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]330machine # [ 0.466782] pci 0000:00:0a.0: enabling device (0000 -> 0002)331machine # [ 0.526892] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)332machine # [ 0.530227] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)333machine # [ 0.536703] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)334machine # [ 0.548318] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)335machine # [ 0.550540] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)336machine # [ 0.561327] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)337machine # [ 0.567744] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)338machine # [ 0.570172] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)339machine # [ 0.581312] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)340machine # [ 0.583399] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)341machine # [ 0.594400] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)342machine # [ 0.608901] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled343machine # [ 0.611795] msm_serial: driver initialized344machine # [ 0.611951] SuperH (H)SCI(F) driver initialized345machine # [ 0.612005] STM32 USART driver initialized346machine # [ 0.646529] loop: module loaded347machine # [ 0.646760] virtio_blk virtio5: 1/0/0 default/read/poll queues348machine # [ 0.648867] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)349machine # [ 0.660379] megasas: 07.734.00.00-rc1350machine # [ 0.661240] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]351machine # [ 0.663321] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000352machine # [ 0.663368] Intel/Sharp Extended Query Table at 0x0031353machine # [ 0.665086] Using buffer write method354machine # [ 0.665206] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]355machine # [ 0.667121] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000356machine # [ 0.667202] Intel/Sharp Extended Query Table at 0x0031357machine # [ 0.687409] Using buffer write method358machine # [ 0.687479] Concatenating MTD devices:359machine # [ 0.687483] (0): "0.flash"360machine # [ 0.687487] (1): "0.flash"361machine # [ 0.687491] into device "0.flash"362machine # [ 0.970278] Freeing initrd memory: 26200K363machine # [ 0.976595] tun: Universal TUN/TAP device driver, 1.6364machine # [ 0.980576] thunder_xcv, ver 1.0365machine # [ 0.980628] thunder_bgx, ver 1.0366machine # [ 0.980650] nicpf, ver 1.0367machine # [ 0.981209] e1000: Intel(R) PRO/1000 Network Driver368machine # [ 0.981218] e1000: Copyright (c) 1999-2006 Intel Corporation.369machine # [ 0.981245] e1000e: Intel(R) PRO/1000 Network Driver370machine # [ 0.981254] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.371machine # [ 0.981279] igb: Intel(R) Gigabit Ethernet Network Driver372machine # [ 0.981285] igb: Copyright (c) 2007-2014 Intel Corporation.373machine # [ 0.981307] igbvf: Intel(R) Gigabit Virtual Function Network Driver374machine # [ 0.981313] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.375machine # [ 0.981452] sky2: driver version 1.30376machine # [ 0.983058] usbcore: registered new interface driver usb-storage377machine # [ 0.983109] usbcore: registered new interface driver usbserial_generic378machine # [ 0.983123] usbserial: USB Serial support registered for generic379machine # [ 0.984338] ehci-pci 0000:00:0a.0: EHCI Host Controller380machine # [ 0.984397] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1381machine # [ 0.984670] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000382machine # [ 0.995764] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00383machine # [ 0.996134] hub 1-0:1.0: USB hub found384machine # [ 0.996150] hub 1-0:1.0: 6 ports detected385machine # [ 0.999237] hv_vmbus: registering driver hyperv_keyboard386machine # [ 1.000953] rtc-pl031 9010000.pl031: registered as rtc0387machine # [ 1.000990] rtc-pl031 9010000.pl031: setting system clock to 2026-09-12T02:46:33 UTC (1789181193)388machine # [ 1.001308] i2c_dev: i2c /dev entries driver389machine # [ 1.006396] sdhci: Secure Digital Host Controller Interface driver390machine # [ 1.006412] sdhci: Copyright(c) Pierre Ossman391machine # [ 1.006698] Synopsys Designware Multimedia Card Interface Driver392machine # [ 1.007065] sdhci-pltfm: SDHCI platform and OF driver helper393machine # [ 1.011489] hid: raw HID events driver (C) Jiri Kosina394machine # [ 1.012457] usbcore: registered new interface driver usbhid395machine # [ 1.012469] usbhid: USB HID core driver396machine # [ 1.014840] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available397machine # [ 1.017514] drop_monitor: Initializing network drop monitor service398machine # [ 1.017682] NET: Registered PF_INET6 protocol family399machine # [ 1.019915] Segment Routing with IPv6400machine # [ 1.019938] In-situ OAM (IOAM) with IPv6401machine # [ 1.019986] NET: Registered PF_PACKET protocol family402machine # [ 1.021679] 9pnet: Installing 9P2000 support403machine # [ 1.024470] Key type dns_resolver registered404machine # [ 1.030883] registered taskstats version 1405machine # [ 1.031054] Loading compiled-in X.509 certificates406machine # [ 1.039965] Demotion targets for Node 0: null407machine # [ 1.040092] Key type .fscrypt registered408machine # [ 1.040100] Key type fscrypt-provisioning registered409machine # [ 1.040205] ima: No TPM chip found, activating TPM-bypass!410machine # [ 1.040226] ima: Allocated hash algorithm: sha1411machine # [ 1.040251] ima: No architecture policies found412machine # [ 1.044834] input: gpio-keys as /devices/platform/gpio-keys/input/input0413machine # [ 1.063397] clk: Disabling unused clocks414machine # [ 1.063438] PM: genpd: Disabling unused power domains415machine # [ 1.067890] Freeing unused kernel memory: 4736K416machine # [ 1.068087] Run /init as init process417machine # [ 1.085949] systemd[1]: Successfully made /usr/ read-only.418machine # [ 1.243624] usb 1-1: new high-speed USB device number 2 using ehci-pci419machine # [ 1.398207] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1420machine # [ 1.421076] systemd[1]: systemd 262-b504aa0 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)421machine # [ 1.433389] systemd[1]: Detected virtualization qemu.422machine # [ 1.435644] systemd[1]: Detected architecture arm64.423machine # [ 1.437559] systemd[1]: Running in initrd.424machine # [ 1.440436] systemd[1]: Initializing machine ID from random generator.425machine # [ 1.443345] systemd[1]: Hostname set to <machine>.426machine # [ 1.495891] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0427machine # [ 1.608139] systemd[1]: bpf-restrict-fs: LSM BPF program attached428machine # [ 1.619594] usb 1-2: new high-speed USB device number 3 using ehci-pci429machine # [ 1.666929] systemd[1]: Queued start job for default target Initrd Default Target.430machine # [ 1.673609] systemd[1]: Created slice Slice /system/modprobe.431machine # [ 1.674656] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.432machine # [ 1.675779] systemd[1]: Expecting device /dev/disk/by-label/nixos...433machine # [ 1.675799] systemd[1]: Expecting device /dev/hvc0...434machine # [ 1.675812] systemd[1]: Expecting device /dev/ttyAMA0...435machine # [ 1.675839] systemd[1]: Reached target Path Units.436machine # [ 1.675855] systemd[1]: Reached target Slice Units.437machine # [ 1.675875] systemd[1]: Reached target Swaps.438machine # [ 1.675893] systemd[1]: Reached target Timer Units.439machine # [ 1.676082] systemd[1]: Listening on D-Bus System Message Bus Socket.440machine # [ 1.676210] systemd[1]: Listening on Journal Socket (/dev/log).441machine # [ 1.676329] systemd[1]: Listening on Journal Sockets.442machine # [ 1.676407] systemd[1]: Listening on udev Kernel Socket.443machine # [ 1.676428] systemd[1]: Reached target Socket Units.444machine # [ 1.685980] systemd[1]: Starting Create List of Static Device Nodes...445machine # [ 1.695854] systemd[1]: Starting Load Kernel Module 9pnet_virtio...446machine # [ 1.696791] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs447machine # [ 1.708976] systemd[1]: Mounting Kernel Configuration File System...448machine # [ 1.727848] systemd[1]: Starting Journal Service...449machine # [ 1.735721] systemd[1]: Starting Load Kernel Modules...450machine # [ 1.736572] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os451machine # [ 1.745945] systemd[1]: Starting Coldplug All udev Devices...452machine # [ 1.767829] systemd[1]: Finished Create List of Static Device Nodes.453machine # [ 1.768891] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.454machine # [ 1.769205] systemd[1]: Finished Load Kernel Module 9pnet_virtio.455machine # [ 1.769447] systemd[1]: Mounted Kernel Configuration File System.456machine # [ 1.782926] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...457machine # [ 1.789242] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2458machine # [ 1.791200] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0459machine # [ 1.810052] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.460machine # [ 1.822414] systemd-journald[73]: Collecting audit messages is disabled.461machine # [ 1.839589] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev462machine # [ 1.844497] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0463machine # [ 1.844755] [drm] features: -virgl +edid -resource_blob -host_visible464machine # [ 1.844766] [drm] features: -context_init465machine # [ 1.845489] [drm] number of scanouts: 1466machine # [ 1.845508] [drm] number of cap sets: 0467machine # [ 1.855679] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.468machine # [ 1.858514] systemd[1]: Starting Create Static Device Nodes in /dev...469machine # [ 1.871909] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic470machine # [ 1.871936] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0471machine # [ 1.891953] Console: switching to colour frame buffer device 160x50472machine # [ 1.926972] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device473machine # [ 1.930781] systemd[1]: Finished Create Static Device Nodes in /dev.474machine # [ 1.933387] systemd[1]: Finished Load Kernel Modules.475machine # [ 1.933550] systemd[1]: Reached target Preparation for Local File Systems.476machine # [ 1.933580] systemd[1]: Reached target Local File Systems.477machine # [ 1.943926] systemd[1]: Starting Apply Kernel Variables...478machine # [ 1.975716] systemd[1]: Starting Rule-based Manager for Device Events and Files...479machine # [ 1.982446] systemd-modules-load[74]: Inserted module 'dm_mod'480machine # [ 1.999299] systemd[1]: Started Journal Service.481machine # [ 1.996409] systemd-modules-load[74]: Module 'virtio_balloon' is built in482machine # [ 2.000107] systemd-modules-load[74]: Module 'virtio_console' is built in483machine # [ 2.008393] systemd-modules-load[74]: Inserted module 'virtio_gpu'484machine # [ 2.013382] systemd-modules-load[74]: Module 'virtio_rng' is built in485machine # [ 2.015627] systemd[1]: Starting Create System Files and Directories...486machine # [ 2.026056] systemd[1]: Finished Apply Kernel Variables.487machine # [ 2.057264] systemd[1]: Finished Create System Files and Directories.488machine # [ 2.061859] systemd-udevd[81]: Using default interface naming scheme 'v261'.489machine # [ 2.094169] systemd[1]: Started Rule-based Manager for Device Events and Files.490machine # [ 2.176130] systemd[1]: Starting Virtual Console Setup...491machine # [ 2.248537] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.492machine # [ 2.252871] systemd[1]: Finished Virtual Console Setup.493machine # [ 2.860466] systemd[1]: Finished Coldplug All udev Devices.494machine # [ 2.861683] systemd[1]: Reached target System Initialization.495machine # [ 2.864123] systemd[1]: Reached target Basic System.496machine # [ 2.979940] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.497machine # [ 2.983874] systemd[1]: Found device /dev/hvc0.498machine # [ 3.005291] systemd[1]: Found device /dev/ttyAMA0.499machine # [ 3.008618] systemd[1]: Started backdoor.service.500machine # [ 3.041728] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.501machine # [ 3.045295] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.502machine # [ 3.048540] backdoor-start[111]: /nix/store/5ch6a58ajz4w5gxfgjlb1n2jy5qxi4va-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found503machine # connecting to host...504machine: Guest shell says: b'Spawning backdoor root shell...\n'505machine: connected to guest root shell506machine: (connecting took 3.38 seconds)507machine: (finished: waiting for the VM to finish booting, in 3.84 seconds)508machine # [ 3.146987] systemd[1]: Found device /dev/disk/by-label/nixos.509machine # [ 3.150494] systemd[1]: Reached target Initrd Root Device.510machine # [ 3.156119] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...511machine # [ 3.214243] systemd-fsck[126]: nixos: clean, 12/65536 files, 13019/262144 blocks512machine # [ 3.220598] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.513machine # [ 3.234386] systemd[1]: Mounting /sysroot...514machine # [ 3.291372] EXT4-fs (vda): mounted filesystem d5da9096-5b7f-4f67-aab6-e3bdfc073092 r/w with ordered data mode. Quota mode: none.515machine # [ 3.285122] systemd[1]: Mounted /sysroot.516machine # [ 3.287250] systemd[1]: Reached target Initrd Root File System.517machine # [ 3.288636] systemd[1]: Starting Mountpoints Configured in the Real Root...518machine # [ 3.317796] systemd-sysroot-fstab-check[134]: /sysroot should be mounted in the initrd, will request daemon-reload.519machine # [ 3.325443] systemd[1]: Reload requested from client PID 134 ('systemd-sysroot') (unit initrd-parse-etc.service)...520machine # [ 3.331141] systemd[1]: Reloading...521machine # [ 3.534397] systemd[1]: Reloading finished in 206 ms.522machine # [ 3.563522] systemd-sysroot-fstab-check[134]: Requesting initrd-fs.target/start/replace...523machine # [ 3.568074] systemd-sysroot-fstab-check[134]: Requesting swap.target/start/replace...524machine # [ 3.574423] systemd[1]: Starting Load Kernel Module 9pnet_virtio...525machine # [ 3.577280] systemd[1]: initrd-parse-etc.service: Deactivated successfully.526machine # [ 3.581634] systemd[1]: Finished Mountpoints Configured in the Real Root.527machine # [ 3.582671] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.528machine # [ 3.609077] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.529machine # [ 3.611610] systemd[1]: Finished Load Kernel Module 9pnet_virtio.530machine # [ 3.753548] systemd[1]: Mounting /sysroot/nix/.ro-store...531machine # [ 3.771101] systemd[1]: Mounting /sysroot/nix/.rw-store...532machine # [ 3.779559] systemd[1]: Mounting /sysroot/run...533machine # [ 3.801926] systemd[1]: Mounting /sysroot/tmp/shared...534machine # [ 3.828270] systemd[1]: Mounting /sysroot/tmp/xchg...535machine # [ 3.871463] systemd[1]: Mounted /sysroot/nix/.ro-store.536machine # [ 3.891363] systemd[1]: Mounted /sysroot/nix/.rw-store.537machine # [ 3.893417] systemd[1]: Mounted /sysroot/run.538machine # [ 3.908751] systemd[1]: Mounted /sysroot/tmp/shared.539machine # [ 3.919719] systemd[1]: Mounted /sysroot/tmp/xchg.540machine # [ 3.929940] systemd[1]: Starting rw-sysroot-nix-store.service...541machine # [ 3.960897] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.542machine # [ 3.962394] systemd[1]: Finished rw-sysroot-nix-store.service.543machine # [ 4.556830] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/zmx0fkcv0rzx39v279ji6d69ps1wah29-systemd-262-b504aa0/lib/udev/mtd_probe": No such file or directory544machine # [ 4.563681] (udev-worker)[99]: mtd0ro: /nix/store/zmx0fkcv0rzx39v279ji6d69ps1wah29-systemd-262-b504aa0/lib/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 directory545machine # [ 4.585939] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.546machine # [ 4.587130] systemd[1]: Stopped Virtual Console Setup.547machine # [ 4.587869] systemd[1]: Stopping Virtual Console Setup...548machine # [ 4.596228] systemd[1]: Starting Virtual Console Setup...549machine # [ 4.610345] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.550machine # [ 4.611523] systemd[1]: Stopped Virtual Console Setup.551machine # [ 4.613028] systemd[1]: Starting Virtual Console Setup...552machine # [ 4.636635] systemd-vconsole-setup[178]: Configuration of first virtual console was skipped, ignoring remaining ones.553machine # [ 4.640177] systemd[1]: Finished Virtual Console Setup.554machine # [ 4.755129] systemd[1]: Mounting /sysroot/nix/store...555machine # [ 4.808164] systemd[1]: Mounted /sysroot/nix/store.556machine # [ 4.810889] systemd[1]: Reached target Initrd File Systems.557machine # [ 4.815623] systemd[1]: Starting Find NixOS closure...558machine # [ 4.828512] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...559machine # [ 4.870286] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.560machine # [ 4.874140] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.561machine # [ 4.887970] systemd[1]: Finished Find NixOS closure.562machine # [ 4.890051] systemd[1]: Reached target Initrd Default Target.563machine # [ 4.893915] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...564machine # [ 4.918817] systemd[1]: initrd-cleanup.service: Deactivated successfully.565machine # [ 4.920789] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.566machine # [ 4.922494] systemd[1]: Startup finished in 1.057s (kernel) + 0 (initrd) + 3.864s (userspace) = 4.922s.567machine: (finished: waiting for unit initrd.target, in 6.00 seconds)568machine: must succeed: systemctl status initrd-fs.target569machine: (finished: must succeed: systemctl status initrd-fs.target, in 0.04 seconds)570machine: waiting for unit initrd.target571machine: (finished: waiting for unit initrd.target, in 0.03 seconds)572machine: waiting for the VM to finish booting573machine # [ 5.327286] systemd[1]: Stopped target Initrd Default Target.574machine # [ 5.332262] systemd[1]: Stopped target Basic System.575machine # [ 5.333334] systemd[1]: Stopped target Initrd Root Device.576machine # [ 5.334384] systemd[1]: Stopped target Path Units.577machine # [ 5.335315] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.578machine # [ 5.342079] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.579machine # [ 5.345554] systemd[1]: Stopped target Slice Units.580machine # [ 5.348351] systemd[1]: Stopped target Socket Units.581machine # [ 5.349358] systemd[1]: Stopped target System Initialization.582machine # [ 5.351804] systemd[1]: Stopped target Swaps.583machine # [ 5.356448] systemd[1]: Stopped target Timer Units.584machine # [ 5.357350] systemd[1]: dbus.socket: Deactivated successfully.585machine # [ 5.358329] systemd[1]: Closed D-Bus System Message Bus Socket.586machine # [ 5.359289] systemd[1]: Stopping backdoor.service...587machine # [ 5.363417] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...588machine # [ 5.364798] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.589machine # [ 5.368195] systemd[1]: Stopped Find NixOS closure.590machine # [ 5.369061] systemd[1]: Starting Load Kernel Module 9pnet_virtio...591machine # [ 5.381691] systemd[1]: Starting rw-sysroot-nix-store.service...592machine # [ 5.382800] systemd[1]: systemd-sysctl.service: Deactivated successfully.593machine # [ 5.388375] systemd[1]: Stopped Apply Kernel Variables.594machine # [ 5.395435] systemd[1]: systemd-modules-load.service: Deactivated successfully.595machine # [ 5.397999] systemd[1]: Stopped Load Kernel Modules.596machine # [ 5.405090] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.597machine # [ 5.408401] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.598machine # [ 5.414527] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.599machine # [ 5.417856] systemd[1]: Stopped Create System Files and Directories.600machine # [ 5.420378] systemd[1]: Stopped target Local File Systems.601machine # [ 5.422909] systemd[1]: Stopped target Preparation for Local File Systems.602machine # [ 5.424183] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.603machine # [ 5.425224] systemd[1]: Stopped Coldplug All udev Devices.604machine # [ 5.426017] systemd[1]: Stopping Rule-based Manager for Device Events and Files...605machine # [ 5.427083] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.606machine # [ 5.435966] systemd[1]: Stopped Virtual Console Setup.607machine # [ 5.443440] systemd[1]: backdoor.service: Deactivated successfully.608machine # [ 5.445389] systemd[1]: Stopped backdoor.service.609machine # [ 5.446120] systemd[1]: initrd-cleanup.service: Deactivated successfully.610machine # [ 5.447091] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.611machine # [ 5.452317] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.612machine # [ 5.453880] systemd[1]: Finished Load Kernel Module 9pnet_virtio.613machine # [ 5.456198] systemd[1]: systemd-udevd.service: Deactivated successfully.614machine # [ 5.457813] systemd[1]: Stopped Rule-based Manager for Device Events and Files.615machine # [ 5.462280] systemd[1]: systemd-udevd.service: Consumed 1.510s CPU time over 3.473s wall clock time, 22.2M memory peak.616machine # [ 5.464163] systemd[1]: Starting Cleanup udev Database...617machine # [ 5.465362] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.618machine # [ 5.466522] systemd[1]: Stopped Create Static Device Nodes in /dev.619machine # [ 5.467432] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.620machine # [ 5.472446] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.621machine # [ 5.475570] systemd[1]: kmod-static-nodes.service: Deactivated successfully.622machine # [ 5.480678] systemd[1]: Stopped Create List of Static Device Nodes.623machine # [ 5.481911] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.624machine # [ 5.483006] systemd[1]: Finished rw-sysroot-nix-store.service.625machine # [ 5.514964] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.626machine # [ 5.517298] systemd[1]: Finished Cleanup udev Database.627machine # [ 5.520293] systemd[1]: Reached target Switch Root.628machine # [ 5.523141] systemd[1]: Starting NixOS Activation...629machine # [ 5.708668] initrd-nixos-activation-start[223]: booting system configuration /nix/store/6ijy5cg34pv6ym977z2bddgyv7w6gcjd-nixos-system-machine-test630machine # [ 5.786854] initrd-nixos-activation-start[223]: running activation script...631machine # [ 6.224773] initrd-nixos-activation-start[246]: setting up /etc...632machine # [ 6.521057] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.633machine # [ 6.524215] systemd[1]: Finished NixOS Activation.634machine # [ 6.525475] systemd[1]: Starting Switch Root...635machine # [ 6.550451] systemd[1]: Switching root.636machine # [ 6.734907] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).637machine # [ 7.359334] systemd[1]: systemd 262-b504aa0 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)638machine # [ 7.371854] systemd[1]: Detected virtualization qemu.639machine # [ 7.376214] systemd[1]: Detected architecture arm64.640machine # [ 7.378551] systemd[1]: Detected first boot.641machine # [ 7.385409] systemd[1]: Initializing machine ID from random generator.642machine # [ 7.553120] systemd[1]: bpf-restrict-fs: LSM BPF program attached643machine # [ 7.733455] systemd[1]: Applying preset policy.644machine # [ 8.221319] systemd[1]: Populated /etc with preset unit settings.645machine # [ 8.761257] systemd[1]: initrd-switch-root.service: Deactivated successfully.646machine # [ 8.762677] systemd[1]: Stopped initrd-switch-root.service.647machine # [ 8.766271] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.648machine # [ 8.768949] systemd[1]: Created slice Slice /system/getty.649machine # [ 8.770696] systemd[1]: Created slice User and Session Slice.650machine # [ 8.772329] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.651machine # [ 8.774234] systemd[1]: Started Forward Password Requests to Wall Directory Watch.652machine # [ 8.776218] systemd[1]: Expecting device /dev/hvc0...653machine # [ 8.777760] systemd[1]: Expecting device /dev/ttyAMA0...654machine # [ 8.779416] systemd[1]: Reached target Local Encrypted Volumes.655machine # [ 8.781917] systemd[1]: Stopped target initrd-fs.target.656machine # [ 8.783037] systemd[1]: Stopped target initrd-root-fs.target.657machine # [ 8.784809] systemd[1]: Stopped target initrd-switch-root.target.658machine # [ 8.787588] systemd[1]: Reached target Virtual Machines and Containers.659machine # [ 8.788815] systemd[1]: Reached target Path Units.660machine # [ 8.790322] systemd[1]: Reached target Remote File Systems.661machine # [ 8.792010] systemd[1]: Reached target Slice Units.662machine # [ 8.794432] systemd[1]: Reached target Swaps.663machine # [ 8.798926] systemd[1]: Listening on Query the User Interactively for a Password.664machine # [ 8.804089] systemd[1]: Listening on Process Core Dump Socket.665machine # [ 8.808370] systemd[1]: Listening on Credential Encryption/Decryption.666machine # [ 8.812470] systemd[1]: Listening on Factory Reset Management.667machine # [ 8.813723] systemd[1]: Listening on Hostname Service Socket.668machine # [ 8.821775] systemd[1]: Starting Journal Log Access Socket...669machine # [ 8.824149] systemd[1]: Listening on Journal Audit Socket.670machine # [ 8.830784] systemd[1]: Listening on Console Output Muting Service Socket.671machine # [ 8.832698] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.672machine # [ 8.834635] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os673machine # [ 8.837087] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki674machine # [ 8.850715] systemd[1]: Listening on Disk Repartitioning Service Socket.675machine # [ 8.852801] systemd[1]: Listening on udev Varlink Socket.676machine # [ 8.858360] systemd[1]: Mounting Huge Pages File System...677machine # [ 8.863263] systemd[1]: Mounting POSIX Message Queue File System...678machine # [ 8.871934] systemd[1]: Mounting Kernel Debug File System...679machine # [ 8.888762] systemd[1]: Mounting Kernel Trace File System...680machine # [ 8.903712] systemd[1]: Starting Create List of Static Device Nodes...681machine # [ 8.919885] systemd[1]: Starting Load Kernel Module 9pnet_virtio...682machine # [ 8.921667] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs683machine # [ 8.943790] systemd[1]: Mounting Kernel Configuration File System...684machine # [ 8.946930] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm685machine # [ 8.954590] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore686machine # [ 8.979922] systemd[1]: Starting Load Kernel Module fuse...687machine # [ 8.982719] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67688machine # [ 9.066880] systemd[1]: Starting Journal Service...689machine # [ 9.103251] systemd[1]: Starting Load Kernel Modules...690machine # [ 9.149061] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...691machine # [ 9.176280] systemd[1]: Starting Remount Root and Kernel File Systems...692machine # [ 9.179374] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os693machine # [ 9.209095] fuse: init (API version 7.45)694machine # [ 9.220372] systemd[1]: Starting Coldplug All udev Devices...695machine # [ 9.229820] systemd[1]: Listening on Journal Log Access Socket.696machine # [ 9.248860] systemd[1]: Mounted Huge Pages File System.697machine # [ 9.259966] systemd-journald[318]: Collecting audit messages is enabled.698machine # [ 9.265760] systemd[1]: Mounted POSIX Message Queue File System.699machine # [ 9.268676] systemd[1]: Mounted Kernel Debug File System.700machine # [ 9.271082] systemd[1]: Mounted Kernel Trace File System.701machine # [ 9.284163] systemd[1]: Finished Create List of Static Device Nodes.702machine # [ 9.270427] systemd[1]: Queued start job for default target Multi-User System.703machine # [ 9.291175] systemd[1]: Started Journal Service.704machine # [ 9.327691] EXT4-fs (vda): re-mounted d5da9096-5b7f-4f67-aab6-e3bdfc073092.705machine # [ 9.528919] EXT4-fs (vda): resizing filesystem from 262144 to 262144 blocks706machine # [ 9.275293] systemd[1]: systemd-journald.service: Deactivated successfully.707machine # [ 9.916948] systemd-journald[318]: Received client request to flush runtime journal.708machine # [ 10.000282] systemd-modules-load[319]: Module 'atkbd' is built in709machine # [ 10.009257] systemd-modules-load[319]: Module 'loop' is built in710machine # [ 10.017021] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.711machine # [ 10.023238] systemd[1]: Finished Load Kernel Module 9pnet_virtio.712machine # [ 10.037606] systemd[1]: Mounted Kernel Configuration File System.713machine # [ 10.038971] systemd[1]: modprobe@fuse.service: Deactivated successfully.714machine # [ 10.046766] systemd[1]: Finished Load Kernel Module fuse.715machine # [ 10.056547] systemd[1]: Finished Load Kernel Modules.716machine # [ 10.057717] systemd[1]: Mounting FUSE Control File System...717machine # [ 10.060842] systemd[1]: Starting Firewall...718machine # [ 10.065622] systemd[1]: Starting Apply Kernel Variables...719machine # [ 10.073791] systemd-oomd[320]: No swap; memory pressure usage will be degraded720machine # [ 10.088357] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...721machine # [ 10.093932] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.722machine # [ 10.106659] systemd[1]: Finished Remount Root and Kernel File Systems.723machine # [ 10.114799] systemd[1]: Listening on Disk Image Download Service Socket.724machine # [ 10.127084] systemd[1]: Starting Grow Root File System...725machine # [ 10.130816] systemd[1]: Starting Flush Journal to Persistent Storage...726machine # [ 10.139783] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore727machine # [ 10.157004] systemd[1]: Starting Load/Save OS Random Seed...728machine # [ 10.159802] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os729machine # [ 10.172644] systemd[1]: Mounted FUSE Control File System.730machine # [ 10.173576] systemd[1]: Finished Apply Kernel Variables.731machine # [ 10.174586] systemd-growfs[331]: Successfully resized "/" to 1G bytes.732machine # [ 10.175518] systemd[1]: Finished Grow Root File System.733machine # [ 10.186874] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.734machine # [ 10.193057] systemd[1]: Starting Create Static Device Nodes in /dev...735machine # [ 10.201028] systemd[1]: Finished Load/Save OS Random Seed.736machine # [ 10.207234] systemd[1]: Reached target First Boot Complete.737machine # [ 10.211409] systemd[1]: Finished Create Static Device Nodes in /dev.738machine # [ 10.219013] systemd[1]: Reached target Preparation for Local File Systems.739machine # [ 10.227809] systemd[1]: Starting Rule-based Manager for Device Events and Files...740machine # [ 10.229498] systemd[1]: Mounting /run/wrappers...741machine # [ 10.231287] systemd[1]: Mounted /run/wrappers.742machine # [ 10.240335] systemd[1]: Reached target Local File Systems.743machine # [ 10.251022] systemd[1]: Listening on Boot Loader Control Service Socket.744machine # [ 10.256879] systemd[1]: Starting Create SUID/SGID Wrappers...745machine # [ 10.266448] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.746machine # [ 10.272163] systemd[1]: Starting Save Transient machine-id to Disk...747machine # [ 10.288319] systemd-udevd[347]: Using default interface naming scheme 'v261'.748machine # [ 10.292496] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.749machine # [ 10.296973] systemd[1]: Finished Save Transient machine-id to Disk.750machine # [ 10.303944] systemd[1]: Finished Flush Journal to Persistent Storage.751machine # [ 10.314373] systemd[1]: Starting Create System Files and Directories...752machine # [ 10.315506] systemd[1]: Finished Create System Files and Directories.753machine # [ 10.323162] systemd[1]: Starting Rebuild Journal Catalog...754machine # [ 10.331990] systemd[1]: Starting Record System Boot/Shutdown in UTMP...755machine # [ 10.340722] systemd[1]: Started Rule-based Manager for Device Events and Files.756machine # [ 10.472710] systemd[1]: Finished Record System Boot/Shutdown in UTMP.757machine # [ 10.531365] systemd[1]: Finished Rebuild Journal Catalog.758machine # [ 10.543161] systemd[1]: Starting Update is Completed...759machine # [ 10.623625] systemd[1]: Finished Update is Completed.760machine # [ 11.066924] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.761machine # [ 11.069644] systemd[1]: Finished Create SUID/SGID Wrappers.762machine # [ 11.319159] systemd[1]: Finished Coldplug All udev Devices.763machine # [ 11.321907] systemd[1]: Reached target System Initialization.764machine # [ 11.327426] systemd[1]: Started Discard unused filesystem blocks once a week.765machine # [ 11.334251] systemd[1]: Started Daily Cleanup of Temporary Directories.766machine # [ 11.335462] systemd[1]: Reached target Timer Units.767machine # [ 11.337209] systemd[1]: Listening on D-Bus System Message Bus Socket.768machine # [ 11.345746] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.769machine # [ 11.349095] systemd[1]: Reached target Socket Units.770machine # [ 11.352422] systemd[1]: Reached target Basic System.771machine # [ 11.357405] systemd[1]: Starting Import lastlog data into lastlog2 database...772machine # [ 11.359634] systemd[1]: Starting Name Service Cache Daemon (nsncd)...773machine # [ 11.389573] systemd[1]: Starting Post-Boot Actions...774machine # [ 11.414246] systemd[1]: Started Reset console on configuration changes.775machine # [ 11.448218] systemd[1]: Starting resolvconf update...776machine # [ 11.527069] systemd[1]: Starting D-Bus System Message Bus...777machine # [ 11.534810] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs778machine # [ 11.545223] nsncd[510]: Sep 12 02:46:44.047 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"779machine # [ 11.561671] systemd[1]: Started Name Service Cache Daemon (nsncd).780machine # [ 11.590171] systemd[1]: Finished Post-Boot Actions.781machine # [ 11.621905] systemd[1]: Reached target Host and Network Name Lookups.782machine # [ 11.626953] systemd[1]: Reached target User and Group Name Lookups.783machine # [ 11.646403] systemd[1]: Starting User Login Management...784machine # [ 11.714628] systemd[1]: Finished Import lastlog data into lastlog2 database.785machine # [ 11.838971] systemd[1]: Finished Firewall.786machine # [ 11.847325] dbus-broker-launch[523]: Looking up NSS user entry for 'systemd-timesync'...787machine # [ 11.858467] dbus-broker-launch[523]: NSS returned no entry for 'systemd-timesync'788machine # [ 11.864794] dbus-broker-launch[523]: Invalid user-name in /nix/store/9kv8dq8g2d35d432gq16rzvw9i61zlx4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"789machine # [ 11.904196] systemd-logind[543]: New seat seat0.790machine # [ 11.909927] systemd[1]: Started User Login Management.791machine # [ 11.916425] systemd[1]: Started D-Bus System Message Bus.792machine # [ 11.923462] systemd[1]: Starting linger-users.service...793machine # [ 11.960166] systemd[1]: Stopped target Host and Network Name Lookups.794machine # [ 11.965594] systemd[1]: Stopping Host and Network Name Lookups...795machine # [ 11.970861] systemd[1]: Stopped target User and Group Name Lookups.796machine # [ 11.977441] systemd[1]: Stopping User and Group Name Lookups...797machine # [ 11.983324] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...798machine # [ 11.990137] dbus-broker-launch[523]: Ready799machine # [ 11.990926] systemd[1]: nscd.service: Deactivated successfully.800machine # [ 11.991819] systemd[1]: Stopped Name Service Cache Daemon (nsncd).801machine # [ 12.030749] systemd[1]: Starting Name Service Cache Daemon (nsncd)...802machine # [ 12.053672] systemd[1]: linger-users.service: Deactivated successfully.803machine # [ 12.058177] systemd[1]: Finished linger-users.service.804machine # [ 12.126194] systemd[1]: Started Name Service Cache Daemon (nsncd).805machine # [ 12.130932] systemd[1]: Reached target Host and Network Name Lookups.806machine # [ 12.136131] nsncd[603]: Sep 12 02:46:44.643 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"807machine # [ 12.141758] systemd[1]: Reached target User and Group Name Lookups.808machine # [ 12.147285] systemd[1]: Found device /dev/hvc0.809machine # [ 12.171100] systemd[1]: Finished resolvconf update.810machine # [ 12.176585] systemd[1]: Reached target Preparation for Network.811machine # [ 12.185231] systemd[1]: Starting DHCP Client...812machine # [ 12.198008] systemd[1]: Starting Extra networking commands....813machine # [ 12.219672] systemd[1]: Found device /dev/ttyAMA0.814machine # [ 12.235125] systemd[1]: Started backdoor.service.815machine # connecting to host...816machine: Guest shell says: b'Spawning backdoor root shell...\n'817machine: connected to guest root shell818machine: (connecting took 7.16 seconds)819machine: (finished: waiting for the VM to finish booting, in 7.16 seconds)820(finished: subtest: testing initrd backdoor, in 13.23 seconds)821subtest: handover to stage-2 systemd works822machine: waiting for unit multi-user.target823machine # [ 12.549109] dhcpcd[636]: dhcpcd-10.3.2 starting824machine # [ 12.577686] dhcpcd[674]: dev: loaded udev825machine # [ 12.650430] 8021q: 802.1Q VLAN Support v1.8826machine # [ 12.700488] systemd[1]: Finished Extra networking commands..827machine # [ 12.732100] systemd[1]: Reached target Network.828machine # [ 12.748322] systemd[1]: Starting Permit User Sessions...829machine # [ 12.783470] (udev-worker)[414]: Network interface NamePolicy= disabled on kernel command line.830machine # [ 12.813934] cfg80211: Loading compiled-in X.509 certificates for regulatory database831machine # [ 12.817253] (udev-worker)[420]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.832machine # [ 12.825313] (udev-worker)[420]: Network interface NamePolicy= disabled on kernel command line.833machine # [ 12.869279] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'834machine # [ 12.869813] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'835machine # [ 12.876799] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2836machine # [ 12.877187] cfg80211: failed to load regulatory.db837machine # [ 12.867905] systemd[1]: Finished Permit User Sessions.838machine # [ 12.881832] systemd[1]: Started Getty on tty1.839machine # [ 12.888787] systemd[1]: Reached target Login Prompts.840machine # [ 12.969912] systemd[1]: Condition check resulted in Virtio network device being skipped.841machine # [ 12.979823] systemd[1]: Starting Address configuration of eth1...842machine # [ 12.999874] 8021q: adding VLAN 0 to HW filter on device eth0843machine # [ 12.992278] dhcpcd[674]: eth0: waiting for carrier844machine # [ 12.995334] dhcpcd[674]: eth0: waiting for carrier845machine # [ 12.998149] dhcpcd[674]: eth0: carrier acquired846machine # [ 13.016992] dhcpcd[674]: DUID 00:01:00:01:32:37:79:95:52:54:00:12:34:56847machine # [ 13.018951] dhcpcd[674]: eth0: IAID 00:12:34:56848machine # [ 13.019950] dhcpcd[674]: eth0: adding address fe80::5054:ff:fe12:3456849machine # [ 13.107031] 8021q: adding VLAN 0 to HW filter on device eth1850machine # [ 13.116309] network-addresses-eth1-start[716]: adding address 192.168.1.1/24... done851machine # [ 13.134726] network-addresses-eth1-start[716]: adding address 2001:db8:1::1/64... done852machine # [ 13.159150] systemd[1]: Finished Address configuration of eth1.853machine # [ 13.175070] systemd-logind[543]: Watching system buttons on /dev/input/event0 (gpio-keys)854machine # [ 13.292633] mousedev: PS/2 mouse device common for all mice855machine # [ 13.385625] systemd-logind[543]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)856machine # [ 14.064619] dhcpcd[674]: eth0: soliciting a DHCP lease857machine # [ 14.072790] dhcpcd[674]: eth0: offered 10.0.2.15 from 10.0.2.2858machine # [ 14.080246] dhcpcd[674]: eth0: probing address 10.0.2.15/24859machine # [ 14.115964] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3860machine # [ 14.422317] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.861machine # [ 14.439848] systemd[1]: Starting Virtual Console Setup...862machine # [ 14.472325] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.863machine # [ 14.473537] systemd[1]: Stopped Virtual Console Setup.864machine # [ 14.480419] systemd[1]: Starting Virtual Console Setup...865machine # [ 14.526710] systemd-logind[543]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)866machine # [ 14.942226] systemd-vconsole-setup[753]: Configuration of first virtual console was skipped, ignoring remaining ones.867machine # [ 14.946580] systemd[1]: Finished Virtual Console Setup.868machine # [ 15.245911] dhcpcd[674]: eth0: soliciting an IPv6 router869machine # [ 15.250049] dhcpcd[674]: eth0: Router Advertisement from fe80::2870machine # [ 15.252777] dhcpcd[674]: eth0: adding address fec0::5054:ff:fe12:3456/64871machine # [ 15.255625] dhcpcd[674]: eth0: adding route to fec0::/64872machine # [ 15.257991] dhcpcd[674]: eth0: adding default route via fe80::2873machine # [ 18.760701] dhcpcd[674]: eth0: leased 10.0.2.15 for 86400 seconds874machine # [ 18.764252] dhcpcd[674]: eth0: adding route to 10.0.2.0/24875machine # [ 18.766754] dhcpcd[674]: eth0: adding default route via 10.0.2.2876machine # [ 18.952418] systemd[1]: Started DHCP Client.877machine # [ 18.954428] systemd[1]: Reached target Multi-User System.878machine # [ 18.955836] systemd[1]: Startup finished in 1.057s (kernel) + 5.790s (initrd) + 12.107s (userspace) = 18.955s.879machine: (finished: waiting for unit multi-user.target, in 7.11 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.03 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.04 seconds)887machine: must succeed: [ -e /run/booted-system ]888machine: (finished: must succeed: [ -e /run/booted-system ], in 0.02 seconds)889machine: must succeed: [ -e /sys/class ]890machine: (finished: must succeed: [ -e /sys/class ], in 0.02 seconds)891machine: must succeed: [ -e /dev/null ]892machine: (finished: must succeed: [ -e /dev/null ], in 0.02 seconds)893machine: must succeed: [ -e /proc/1 ]894machine: (finished: must succeed: [ -e /proc/1 ], in 0.02 seconds)895machine: must succeed: [ -e /dev/shm ]896machine: (finished: must succeed: [ -e /dev/shm ], in 0.02 seconds)897machine: must succeed: [ -e /dev/pts/ptmx ]898machine: (finished: must succeed: [ -e /dev/pts/ptmx ], in 0.02 seconds)899machine: must succeed: [ -e /run/keys ]900machine: (finished: must succeed: [ -e /run/keys ], in 0.02 seconds)901machine: must succeed: [ ! -e /nixos-closure ]902machine: (finished: must succeed: [ ! -e /nixos-closure ], in 0.02 seconds)903(finished: subtest: handover to stage-2 systemd works, in 7.40 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.04 seconds)907(finished: subtest: groups work, in 0.04 seconds)908subtest: growfs works909machine: must succeed: df --output=avail / | sed 1d910machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.04 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 # [ 19.947207] systemd-logind[543]: poweroff requested from client PID 903 ('poweroff') (unit backdoor.service)...917machine # [ 19.952427] systemd-logind[543]: System is powering down.918machine # [ 19.965197] systemd-logind[543]: The system will power off now!919machine # [ 19.975803] systemd[1]: Removed slice Slice /system/modprobe.920machine # [ 19.980522] systemd[1]: Stopped target Multi-User System.921machine # [ 19.981411] systemd[1]: Stopped target Login Prompts.922machine # [ 19.982141] systemd[1]: Stopped target Virtual Machines and Containers.923machine # [ 19.983112] systemd[1]: Stopped target Host and Network Name Lookups.924machine # [ 19.984487] systemd[1]: Stopped target Timer Units.925machine # [ 19.985410] systemd[1]: fstrim.timer: Deactivated successfully.926machine # [ 19.986600] systemd[1]: Stopped Discard unused filesystem blocks once a week.927machine # [ 19.987730] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully.928machine # [ 19.994897] systemd[1]: Stopped Daily Cleanup of Temporary Directories.929machine # [ 19.999213] dhcpcd[674]: received SIGTERM, stopping930machine # [ 20.000918] systemd[1]: systemd-rfkill.socket: Deactivated successfully.931machine # [ 20.008404] dhcpcd[674]: eth0: removing interface932machine # [ 20.009236] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch.933machine # [ 20.010312] dhcpcd[674]: eth0: deleting address fec0::5054:ff:fe12:3456/64934machine # [ 20.011280] systemd[1]: Mounting /run/initramfs...935machine # [ 20.012543] dhcpcd[674]: eth0: deleting route to fec0::/64936machine # [ 20.017044] systemd[1]: Stopping backdoor.service...937machine # [ 20.020370] dhcpcd[674]: eth0: deleting default route via fe80::2938machine # [ 20.024418] systemd[1]: Stopping DHCP Client...939machine # [ 20.028465] systemd[1]: Stopping Getty on tty1...940machine # [ 20.029646] systemd[1]: lastlog2-import.service: Deactivated successfully.941machine # [ 20.030740] systemd[1]: Stopped Import lastlog data into lastlog2 database.942machine # [ 20.034280] systemd[1]: Stopping Address configuration of eth1...943machine # [ 20.038020] systemd[1]: Stopping Post-Boot Actions...944machine # [ 20.040971] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully.945machine # [ 20.046032] systemd[1]: Stopped Reset console on configuration changes.946machine # [ 20.054634] systemd[1]: Stopping User Login Management...947machine # [ 20.057493] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully.948machine # [ 20.063693] systemd[1]: Stopped Save Transient machine-id to Disk.949machine # [ 20.068862] systemd[1]: Stopped target First Boot Complete.950machine # [ 20.072780] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer...951machine # [ 20.086263] systemd[1]: Stopping Load/Save OS Random Seed...952machine # [ 20.112115] dhcpcd[674]: eth0: deleting address fe80::5054:ff:fe12:3456953machine # [ 20.117403] dhcpcd[674]: eth0: deleting route to 10.0.2.0/24954machine # [ 20.122478] dhcpcd[674]: eth0: deleting default route via 10.0.2.2955machine # [ 20.127648] systemd[1]: systemd-oomd.service: Deactivated successfully.956machine # [ 20.134498] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer.957machine # [ 20.140780] systemd[1]: systemd-logind.service: Deactivated successfully.958machine # [ 20.149625] systemd[1]: Stopped User Login Management.959machine # [ 20.159537] network-addresses-eth1-pre-stop[910]: deleting address 192.168.1.1/24... done960machine # [ 20.188101] dhcpcd[674]: dhcpcd exited961machine # [ 20.191326] network-addresses-eth1-pre-stop[910]: deleting address 2001:db8:1::1/64... done962machine # [ 20.198552] systemd[1]: backdoor.service: Deactivated successfully.963machine # [ 20.202293] systemd[1]: Stopped backdoor.service.964machine # [ 20.211164] systemd[1]: dhcpcd.service: Deactivated successfully.965machine # [ 20.216536] systemd[1]: Stopped DHCP Client.966machine # [ 20.217843] systemd[1]: dhcpcd.service: Consumed 326ms CPU time over 8.030s wall clock time, 5.8M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic.967machine # [ 20.226105] systemd[1]: getty@tty1.service: Deactivated successfully.968machine # [ 20.229266] systemd[1]: Stopped Getty on tty1.969machine # [ 20.239335] systemd[1]: Mounted /run/initramfs.970machine # [ 20.241897] systemd[1]: network-addresses-eth1.service: Deactivated successfully.971machine # [ 20.244801] systemd[1]: Stopped Address configuration of eth1.972machine # [ 20.247620] systemd[1]: post-boot.service: Deactivated successfully.973machine # [ 20.248902] systemd[1]: Stopped Post-Boot Actions.974machine # [ 20.251111] systemd[1]: systemd-random-seed.service: Deactivated successfully.975machine # [ 20.253815] systemd[1]: Stopped Load/Save OS Random Seed.976machine # [ 20.261538] systemd[1]: Removed slice Slice /system/getty.977machine # [ 20.267012] systemd[1]: Starting Generate shutdown ramfs...978machine # [ 20.273919] systemd[1]: Stopping Permit User Sessions...979machine # [ 20.328752] systemd[1]: systemd-user-sessions.service: Deactivated successfully.980machine # [ 20.332586] systemd[1]: Stopped Permit User Sessions.981machine # [ 20.336553] systemd[1]: Stopped target Network.982machine # [ 20.337446] systemd[1]: Stopped target User and Group Name Lookups.983machine # [ 20.340481] systemd[1]: Stopped target Remote File Systems.984machine # [ 20.342007] systemd[1]: network-local-commands.service: Deactivated successfully.985machine # [ 20.348303] systemd[1]: Stopped Extra networking commands..986machine # [ 20.352640] systemd[1]: Stopped target Preparation for Network.987machine # [ 20.353619] systemd[1]: Stopping Firewall...988machine # [ 20.354275] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...989machine # [ 20.355217] systemd[1]: resolvconf.service: Deactivated successfully.990machine # [ 20.364267] systemd[1]: Stopped resolvconf update.991machine # [ 20.368745] systemd[1]: nscd.service: Deactivated successfully.992machine # [ 20.369890] systemd[1]: Stopped Name Service Cache Daemon (nsncd).993machine # [ 20.382570] systemd[1]: Stopped target Basic System.994machine # [ 20.385944] systemd[1]: Stopped target Path Units.995machine # [ 20.387708] make-initrd-ng[938]: /etc/initrd-release -> /nix/store/vq8whsd6zaycfzm97b62z2qxfql1wiz4-etc-os-release996machine # [ 20.391605] make-initrd-ng[938]: /etc/os-release -> /nix/store/vq8whsd6zaycfzm97b62z2qxfql1wiz4-etc-os-release997machine # [ 20.398196] systemd[1]: Stopped target Slice Units.998machine # [ 20.405066] make-initrd-ng[938]: /shutdown -> /nix/store/zmx0fkcv0rzx39v279ji6d69ps1wah29-systemd-262-b504aa0/lib/systemd/systemd-shutdown999machine # [ 20.408087] systemd[1]: Removed slice User and Session Slice.1000machine # [ 20.413864] systemd[1]: Stopped target Socket Units.1001machine # [ 20.416800] systemd[1]: systemd-hostnamed.socket: Deactivated successfully.1002machine # [ 20.425814] systemd[1]: Closed Hostname Service Socket.1003machine # [ 20.426953] systemd[1]: systemd-importd.socket: Deactivated successfully.1004machine # [ 20.431618] systemd[1]: Closed Disk Image Download Service Socket.1005machine # [ 20.435373] systemd[1]: systemd-machined.socket: Deactivated successfully.1006machine # [ 20.438032] systemd[1]: Closed Virtual Machine and Container Registration Service Socket.1007machine # [ 20.441896] systemd[1]: systemd-mute-console.socket: Deactivated successfully.1008machine # [ 20.443993] systemd[1]: Closed Console Output Muting Service Socket.1009machine # [ 20.448641] systemd[1]: systemd-oomd.socket: Deactivated successfully.1010machine # [ 20.451294] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket.1011machine # [ 20.453548] systemd[1]: systemd-repart.socket: Deactivated successfully.1012machine # [ 20.460711] systemd[1]: Closed Disk Repartitioning Service Socket.1013machine # [ 20.468191] dbus-broker[593]: Dispatched 1087 messages @ 3(±6)μs / message.1014machine # [ 20.472450] systemd[1]: Stopping D-Bus System Message Bus...1015machine # [ 20.476880] systemd[1]: dbus-broker.service: Deactivated successfully.1016machine # [ 20.478293] systemd[1]: Stopped D-Bus System Message Bus.1017machine # [ 20.480435] systemd[1]: dbus.socket: Deactivated successfully.1018machine # [ 20.485982] systemd[1]: Closed D-Bus System Message Bus Socket.1019machine # [ 20.487666] systemd[1]: Stopped target System Initialization.1020machine # [ 20.489923] systemd[1]: Stopped target Local Encrypted Volumes.1021machine # [ 20.491873] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1022machine # [ 20.495026] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1023machine # [ 20.498973] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully.1024machine # [ 20.503135] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch.1025machine # [ 20.506429] systemd[1]: systemd-sysctl.service: Deactivated successfully.1026machine # [ 20.510014] systemd[1]: Stopped Apply Kernel Variables.1027machine # [ 20.511949] systemd[1]: systemd-coredump.socket: Deactivated successfully.1028machine # [ 20.513883] systemd[1]: Closed Process Core Dump Socket.1029machine # [ 20.515522] systemd[1]: systemd-update-done.service: Deactivated successfully.1030machine # [ 20.517940] systemd[1]: Stopped Update is Completed.1031machine # [ 20.522640] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully.1032machine # [ 20.527492] systemd[1]: Stopped Rebuild Journal Catalog.1033machine # [ 20.530478] systemd[1]: Stopping Record System Boot/Shutdown in UTMP...1034machine # [ 20.545288] systemd[1]: systemd-update-utmp.service: Deactivated successfully.1035machine # [ 20.547685] systemd[1]: Stopped Record System Boot/Shutdown in UTMP.1036machine # [ 20.551204] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1037machine # [ 20.555163] systemd[1]: Stopped Create System Files and Directories.1038machine # [ 20.558718] systemd[1]: Stopped target Local File Systems.1039machine # [ 20.561655] systemd[1]: Unmounting /run/keys...1040machine # [ 20.564572] systemd[1]: Unmounting /run/wrappers...1041machine # [ 20.566709] systemd[1]: systemd-growfs-root.service: Deactivated successfully.1042machine # [ 20.571240] systemd[1]: Stopped Grow Root File System.1043machine # [ 20.598280] systemd[1]: firewall.service: Deactivated successfully.1044machine # [ 20.600869] systemd[1]: Stopped Firewall.1045machine # [ 20.603309] systemd[1]: systemd-modules-load.service: Deactivated successfully.1046machine # [ 20.605674] systemd[1]: Stopped Load Kernel Modules.1047machine # [ 20.635782] systemd[1]: run-keys.mount: Deactivated successfully.1048machine # [ 20.641321] systemd[1]: Unmounted /run/keys.1049machine # [ 20.642123] systemd[1]: run-wrappers.mount: Deactivated successfully.1050machine # [ 20.644474] systemd[1]: Unmounted /run/wrappers.1051machine # [ 20.648692] systemd[1]: Stopped target Preparation for Local File Systems.1052machine # [ 20.651019] systemd[1]: Stopped target Swaps.1053machine # [ 20.651761] systemd[1]: Reached target Unmount All Filesystems.1054machine # [ 20.652878] systemd[1]: systemd-remount-fs.service: Deactivated successfully.1055machine # [ 20.654001] systemd[1]: Stopped Remount Root and Kernel File Systems.1056machine # [ 20.655004] systemd[1]: systemd-fsck-root.service: Deactivated successfully.1057machine # [ 20.656291] systemd[1]: Stopped File System Check on Root Device.1058machine # [ 20.657241] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1059machine # [ 20.658464] systemd[1]: Stopped Create Static Device Nodes in /dev.1060machine # [ 20.659431] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1061machine # [ 20.660843] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1062machine # [ 20.721426] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully.1063machine # [ 20.724234] systemd[1]: Finished Generate shutdown ramfs.1064machine # [ 20.726138] systemd[1]: Reached target System Shutdown.1065machine # [ 20.728292] systemd[1]: Reached target Late Shutdown Services.1066machine # [ 20.732999] systemd[1]: systemd-poweroff.service: Deactivated successfully.1067machine # [ 20.734079] systemd[1]: Finished System Power Off.1068machine # [ 20.734817] systemd[1]: Reached target System Power Off.1069machine # [ 20.736362] systemd[1]: Shutting down.1070machine # [ 20.940347] systemd-shutdown[1]: Syncing filesystems and block devices.1071machine # [ 20.952793] systemd-shutdown[1]: Sending SIGTERM to remaining processes...1072machine # [ 20.967057] systemd-journald[318]: Received SIGTERM from PID 1 (systemd-shutdow).1073machine # [ 21.010564] systemd-shutdown[1]: Sending SIGKILL to remaining processes...1074machine # [ 21.022611] systemd-shutdown[1]: Unmounting file systems.1075machine # [ 21.032618] (sd-umount)[969]: Unmounting '/run/credentials/systemd-journald.service'.1076machine # [ 21.038025] (sd-remount)[970]: 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 # [ 21.057103] (sd-remount)[971]: 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 # [ 21.071890] (sd-remount)[972]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'.1079machine # [ 21.078092] (sd-umount)[973]: Unmounting '/tmp/xchg'.1080machine # [ 21.093849] (sd-remount)[974]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'.1081machine # [ 21.100635] (sd-umount)[975]: Unmounting '/tmp/shared'.1082machine # [ 21.117646] (sd-remount)[976]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'.1083machine # [ 21.217201] (sd-umount)[977]: Unmounting '/nix/.ro-store'.1084machine # [ 21.220838] (sd-umount)[978]: Unmounting '/nix/.rw-store'.1085machine # [ 21.223973] (sd-remount)[979]: Remounting '/' read-only with options ''.1086machine # [ 21.235060] EXT4-fs (vda): re-mounted d5da9096-5b7f-4f67-aab6-e3bdfc073092 ro.1087machine # [ 21.239137] systemd-shutdown[1]: All filesystems unmounted.1088machine # [ 21.241551] systemd-shutdown[1]: Deactivating swaps.1089machine # [ 21.243939] systemd-shutdown[1]: All swaps deactivated.1090machine # [ 21.246182] systemd-shutdown[1]: Detaching loop devices.1091machine # [ 21.257560] systemd-shutdown[1]: All loop devices detached.1092machine # [ 21.259903] systemd-shutdown[1]: Stopping MD devices.1093machine # [ 21.262276] systemd-shutdown[1]: All MD devices stopped.1094machine # [ 21.264522] systemd-shutdown[1]: Detaching DM devices.1095machine # [ 21.266942] systemd-shutdown[1]: All DM devices detached.1096machine # [ 21.269322] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1097machine # [ 21.274338] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error1098machine # [ 21.612759] systemd-shutdown[1]: Successfully changed into root pivot.1099machine # [ 21.614792] systemd-shutdown[1]: Entering exitrd...1100machine # [ 21.633622] shutdown[1]: Syncing filesystems and block devices.1101machine # [ 21.638788] shutdown[1]: Sending SIGTERM to remaining processes...1102machine # [ 21.649721] shutdown[1]: Sending SIGKILL to remaining processes...1103machine # [ 21.660665] shutdown[1]: Unmounting file systems.1104machine # [ 21.668240] (sd-umoun[981]: Unmounting '/run/credentials'.1105machine # [ 21.674203] (sd-umoun[982]: Unmounting '/oldroot/sys/fs/fuse/connections'.1106machine # [ 21.681283] (sd-umoun[983]: Unmounting '/oldroot/sys/kernel/config'.1107machine # [ 21.687326] (sd-umoun[984]: Unmounting '/oldroot/dev/hugepages'.1108machine # [ 21.693118] (sd-umoun[985]: Unmounting '/oldroot/dev/mqueue'.1109machine # [ 21.697879] (sd-umoun[986]: Unmounting '/oldroot/sys/kernel/debug'.1110machine # [ 21.702356] (sd-umoun[987]: Unmounting '/oldroot/sys/kernel/tracing'.1111machine # [ 21.707855] (sd-umoun[988]: Unmounting '/oldroot/sys/fs/bpf'.1112machine # [ 21.711700] (sd-umoun[989]: Unmounting '/oldroot/sys/fs/pstore'.1113machine # [ 21.715327] (sd-umoun[990]: Unmounting '/oldroot/sys/fs/cgroup'.1114machine # [ 21.719088] (sd-umoun[991]: Unmounting '/oldroot/sys/kernel/security'.1115machine # [ 21.723939] (sd-umoun[992]: Unmounting '/oldroot/nix/store'.1116machine # [ 21.727136] (sd-umoun[993]: Unmounting '/oldroot/sys'.1117machine # [ 21.730352] (sd-umoun[994]: Unmounting '/oldroot/proc'.1118machine # [ 21.734146] (sd-umoun[995]: Unmounting '/oldroot/dev/shm'.1119machine # [ 21.737746] (sd-umoun[996]: Unmounting '/oldroot/dev/pts'.1120machine # [ 21.741220] (sd-umoun[997]: Unmounting '/oldroot/dev'.1121machine # [ 21.744438] (sd-umoun[998]: Unmounting '/oldroot/nix/store'.1122machine # [ 21.778527] (sd-umoun[999]: Unmounting '/oldroot/run'.1123machine # [ 21.783150] (sd-umoun[1000]: Unmounting '/oldroot'.1124machine # [ 21.789444] EXT4-fs (vda): unmounting filesystem d5da9096-5b7f-4f67-aab6-e3bdfc073092.1125machine # [ 21.794691] shutdown[1]: All filesystems unmounted.1126machine # [ 21.798098] shutdown[1]: Deactivating swaps.1127machine # [ 21.801208] shutdown[1]: All swaps deactivated.1128machine # [ 21.803946] shutdown[1]: Detaching loop devices.1129machine # [ 21.810424] shutdown[1]: All loop devices detached.1130machine # [ 21.813252] shutdown[1]: Stopping MD devices.1131machine # [ 21.816570] shutdown[1]: All MD devices stopped.1132machine # [ 21.819309] shutdown[1]: Detaching DM devices.1133machine # [ 21.822128] shutdown[1]: All DM devices detached.1134machine # [ 21.824679] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached.1135machine # [ 21.828971] shutdown[1]: Syncing filesystems and block devices.1136machine # [ 21.833068] shutdown[1]: Powering off.1137machine # [ 21.863935] Console: switching to colour dummy device 80x251138machine # [ 21.880213] Flash device refused suspend due to active operation (state 20)1139machine # [ 21.880262] Flash device refused suspend due to active operation (state 20)1140machine # [ 21.884266] reboot: Power down1141machine: (finished: waiting for the VM to power off, in 2.11 seconds)1142Image resized.1143machine: starting vm1144machine: QEMU running (pid 78)1145machine: waiting for unit initrd.target1146machine: waiting for the VM to finish booting1147machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]1148machine # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 20261149machine # [ 0.000000] KASLR enabled1150machine # [ 0.000000] random: crng init done1151machine # [ 0.000000] Machine model: linux,dummy-virt1152machine # [ 0.000000] efi: UEFI not found.1153machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT1154machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]1155machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded700-0x7fdf0e7f]1156machine # [ 0.000000] Zone ranges:1157machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]1158machine # [ 0.000000] DMA32 empty1159machine # [ 0.000000] Normal empty1160machine # [ 0.000000] Device empty1161machine # [ 0.000000] Movable zone start for each node1162machine # [ 0.000000] Early memory node ranges1163machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]1164machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]1165machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc000001166machine # [ 0.000000] psci: probing for conduit method from DT.1167machine # [ 0.000000] psci: PSCIv1.3 detected in firmware.1168machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs1169machine # [ 0.000000] psci: Trusted OS migration not required1170machine # [ 0.000000] psci: SMC Calling Convention v1.11171machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)1172machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u3112961173machine # [ 0.000000] Detected PIPT I-cache on CPU01174machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)1175machine # [ 0.000000] CPU features: detected: GICv3 CPU interface1176machine # [ 0.000000] CPU features: detected: Spectre-v41177machine # [ 0.000000] CPU features: detected: Spectre-BHB1178machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_381179machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_231180machine # [ 0.000000] alternatives: applying boot alternatives1181machine # [ 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/6ijy5cg34pv6ym977z2bddgyv7w6gcjd-nixos-system-machine-test/init regInfo=/nix/store/xam14axn9py9zvvzxkspsm2hrgkvc59n-closure-info/registration console=ttyAMA0,115200n8 console=tty01182machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/xam14axn9py9zvvzxkspsm2hrgkvc59n-closure-info/registration", will be passed to user space.1183machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes1184machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)1185machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)1186machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB1187machine # [ 0.000000] software IO TLB: area num 1.1188machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)1189machine # [ 0.000000] Fallback order for Node 0: 01190machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 2621441191machine # [ 0.000000] Policy zone: DMA1192machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off1193machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=11194machine # [ 0.000000] allocated 2097152 bytes of page_ext1195machine # [ 0.000000] ftrace: allocating 74885 entries in 294 pages1196machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups1197machine # [ 0.000000] rcu: Hierarchical RCU implementation.1198machine # [ 0.000000] rcu: RCU event tracing is enabled.1199machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.1200machine # [ 0.000000] Trampoline variant of Tasks RCU enabled.1201machine # [ 0.000000] Rude variant of Tasks RCU enabled.1202machine # [ 0.000000] Tracing variant of Tasks RCU enabled.1203machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.1204machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=11205machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1206machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1207machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.1208machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 01209machine # [ 0.000000] GICv3: 256 SPIs implemented1210machine # [ 0.000000] GICv3: 0 Extended SPIs implemented1211machine # [ 0.000000] Root IRQ handler: gic_handle_irq1212machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI1213machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=01214machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a00001215machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]1216machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1)1217machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1)1218machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d100001219machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d200001220machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.1221machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns1222machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).1223machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns1224machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns1225machine # [ 0.000029] arm-pv: using stolen time PV1226machine # [ 0.000420] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)1227machine # [ 0.000601] Console: colour dummy device 80x251228machine # [ 0.000609] printk: legacy console [tty0] enabled1229machine # [ 0.000798] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)1230machine # [ 0.000806] pid_max: default: 32768 minimum: 3011231machine # [ 0.000888] LSM: initializing lsm=capability,landlock,yama,bpf,ima1232machine # [ 0.001020] landlock: Up and running.1233machine # [ 0.001022] Yama: becoming mindful.1234machine # [ 0.001462] LSM support for eBPF active1235machine # [ 0.001620] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1236machine # [ 0.001644] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)1237machine # [ 0.002788] cacheinfo: Unable to detect cache hierarchy for CPU 01238machine # [ 0.003540] rcu: Hierarchical SRCU implementation.1239machine # [ 0.003545] rcu: Max phase no-delay instances is 1000.1240machine # [ 0.004816] fsl-mc MSI: its@8080000 domain created1241machine # [ 0.004910] EFI services will not be available.1242machine # [ 0.004997] smp: Bringing up secondary CPUs ...1243machine # [ 0.005006] smp: Brought up 1 node, 1 CPU1244machine # [ 0.005009] SMP: Total of 1 processors activated.1245machine # [ 0.005012] CPU: All CPU(s) started at EL11246machine # [ 0.005026] CPU features: detected: Branch Target Identification1247machine # [ 0.005032] CPU features: detected: ARMv8.4 Translation Table Level1248machine # [ 0.005035] CPU features: detected: Instruction cache invalidation not required for I/D coherence1249machine # [ 0.005038] CPU features: detected: Data cache clean to the PoU not required for I/D coherence1250machine # [ 0.005042] CPU features: detected: Common not Private translations1251machine # [ 0.005045] CPU features: detected: CRC32 instructions1252machine # [ 0.005048] CPU features: detected: Data cache clean to Point of Deep Persistence1253machine # [ 0.005052] CPU features: detected: Data cache clean to Point of Persistence1254machine # [ 0.005055] CPU features: detected: Data independent timing control (DIT)1255machine # [ 0.005059] CPU features: detected: E0PD1256machine # [ 0.005061] CPU features: detected: Enhanced Counter Virtualization1257machine # [ 0.005064] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)1258machine # [ 0.005067] CPU features: detected: Enhanced Virtualization Traps1259machine # [ 0.005070] CPU features: detected: Fine Grained Traps1260machine # [ 0.005074] CPU features: detected: Generic authentication (architected QARMA5 algorithm)1261machine # [ 0.005080] CPU features: detected: RCpc load-acquire (LDAPR)1262machine # [ 0.005083] CPU features: detected: LSE atomic instructions1263machine # [ 0.005086] CPU features: detected: Privileged Access Never1264machine # [ 0.005089] CPU features: detected: PMUv31265machine # [ 0.005092] CPU features: detected: RAS Extension Support1266machine # [ 0.005094] CPU features: detected: RASv1p1 Extension Support1267machine # [ 0.005097] CPU features: detected: Random Number Generator1268machine # [ 0.005100] CPU features: detected: Speculation barrier (SB)1269machine # [ 0.005103] CPU features: detected: Stage-2 Force Write-Back1270machine # [ 0.005106] CPU features: detected: TLB range maintenance instructions1271machine # [ 0.005112] CPU features: detected: Speculative Store Bypassing Safe (SSBS)1272machine # [ 0.005149] alternatives: applying system-wide alternatives1273machine # [ 0.008199] CPU features: detected: BBM Level 2 without TLB conflict abort1274machine # [ 0.008501] Memory: 893992K/1048576K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 113060K reserved, 32768K cma-reserved)1275machine # [ 0.008869] devtmpfs: initialized1276machine # [ 0.010561] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)1277machine # [ 0.010583] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).1278machine # [ 0.010777] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL1279machine # [ 0.010782] 0 pages in range for non-PLT usage1280machine # [ 0.010783] 508288 pages in range for PLT usage1281machine # [ 0.010893] pinctrl core: initialized pinctrl subsystem1282machine # [ 0.011688] DMI not present or invalid.1283machine # [ 0.014734] NET: Registered PF_NETLINK/PF_ROUTE protocol family1284machine # [ 0.016982] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations1285machine # [ 0.017128] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations1286machine # [ 0.017294] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations1287machine # [ 0.017318] audit: initializing netlink subsys (disabled)1288machine # [ 0.017933] thermal_sys: Registered thermal governor 'fair_share'1289machine # [ 0.017935] thermal_sys: Registered thermal governor 'bang_bang'1290machine # [ 0.017939] thermal_sys: Registered thermal governor 'step_wise'1291machine # [ 0.017942] thermal_sys: Registered thermal governor 'user_space'1292machine # [ 0.017948] thermal_sys: Registered thermal governor 'power_allocator'1293machine # [ 0.017981] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=11294machine # [ 0.017989] cpuidle: using governor ladder1295machine # [ 0.017995] cpuidle: using governor menu1296machine # [ 0.018199] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.1297machine # [ 0.018216] ASID allocator initialised with 65536 entries1298machine # [ 0.019360] Serial: AMBA PL011 UART driver1299machine # [ 0.024781] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev11300machine # [ 0.024919] printk: console [ttyAMA0] enabled1301machine # [ 0.148020] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages1302machine # [ 0.148041] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page1303machine # [ 0.148047] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages1304machine # [ 0.148051] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page1305machine # [ 0.148056] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages1306machine # [ 0.148060] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page1307machine # [ 0.148065] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages1308machine # [ 0.148069] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page1309machine # [ 0.155572] fbcon: Taking over console1310machine # [ 0.155589] ACPI: Interpreter disabled.1311machine # [ 0.157548] iommu: Default domain type: Translated1312machine # [ 0.157557] iommu: DMA domain TLB invalidation policy: strict mode1313machine # [ 0.159306] SCSI subsystem initialized1314machine # [ 0.164489] usbcore: registered new interface driver usbfs1315machine # [ 0.164522] usbcore: registered new interface driver hub1316machine # [ 0.164540] usbcore: registered new device driver usb1317machine # [ 0.164826] pps_core: LinuxPPS API ver. 1 registered1318machine # [ 0.164832] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>1319machine # [ 0.164842] PTP clock support registered1320machine # [ 0.164893] EDAC MC: Ver: 3.0.01321machine # [ 0.169623] scmi_core: SCMI protocol bus registered1322machine # [ 0.170597] FPGA manager framework1323machine # [ 0.171529] vgaarb: loaded1324machine # [ 0.172171] clocksource: Switched to clocksource arch_sys_counter1325machine # [ 0.176150] VFS: Disk quotas dquot_6.6.01326machine # [ 0.178783] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)1327machine # [ 0.179969] netfs: FS-Cache loaded1328machine # [ 0.180105] pnp: PnP ACPI: disabled1329machine # [ 0.184101] NET: Registered PF_INET protocol family1330machine # [ 0.184941] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)1331machine # [ 0.215682] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)1332machine # [ 0.215743] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)1333machine # [ 0.215771] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)1334machine # [ 0.215825] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)1335machine # [ 0.215901] TCP: Hash tables configured (established 8192 bind 8192)1336machine # [ 0.216009] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)1337machine # [ 0.216067] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)1338machine # [ 0.216094] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)1339machine # [ 0.223377] NET: Registered PF_UNIX/PF_LOCAL protocol family1340machine # [ 0.223425] NET: Registered PF_XDP protocol family1341machine # [ 0.223448] PCI: CLS 0 bytes, default 641342machine # [ 0.223697] Trying to unpack rootfs image as initramfs...1343machine # [ 0.234738] kvm [1]: HYP mode not available1344machine # [ 0.392842] Initialise system trusted keyrings1345machine # [ 0.393622] workingset: timestamp_bits=42 max_order=18 bucket_order=01346machine # [ 0.394909] squashfs: version 4.0 (2009/01/31) Phillip Lougher1347machine # [ 0.395677] 9p: Installing v9fs 9p2000 file system support1348machine # [ 0.424539] Key type asymmetric registered1349machine # [ 0.424572] Asymmetric key parser 'x509' registered1350machine # [ 0.424662] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)1351machine # [ 0.426824] io scheduler mq-deadline registered1352machine # [ 0.426835] io scheduler kyber registered1353machine # [ 0.436392] pl061_gpio 9030000.pl061: PL061 GPIO chip registered1354machine # [ 0.437876] ledtrig-cpu: registered to indicate activity on CPUs1355machine # [ 0.438305] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:1356machine # [ 0.438322] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x00000000001357machine # [ 0.438335] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x00100000001358machine # [ 0.438344] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x80000000001359machine # [ 0.438373] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits1360machine # [ 0.438399] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]1361machine # [ 0.438480] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:001362machine # [ 0.438489] pci_bus 0000:00: root bus resource [bus 00-ff]1363machine # [ 0.438496] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]1364machine # [ 0.438501] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]1365machine # [ 0.438507] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]1366machine # [ 0.438572] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint1367machine # [ 0.439016] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1368machine # [ 0.439203] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]1369machine # [ 0.439220] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]1370machine # [ 0.439248] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1371machine # [ 0.439265] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]1372machine # [ 0.439748] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1373machine # [ 0.439928] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]1374machine # [ 0.439944] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]1375machine # [ 0.439973] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1376machine # [ 0.459767] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1377machine # [ 0.459958] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]1378machine # [ 0.459974] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]1379machine # [ 0.460003] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1380machine # [ 0.468665] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1381machine # [ 0.468874] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]1382machine # [ 0.468891] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]1383machine # [ 0.468923] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1384machine # [ 0.469386] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint1385machine # [ 0.469564] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]1386machine # [ 0.469580] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]1387machine # [ 0.469611] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1388machine # [ 0.470059] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint1389machine # [ 0.470243] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]1390machine # [ 0.470261] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]1391machine # [ 0.470291] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1392machine # [ 0.470765] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint1393machine # [ 0.470962] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]1394machine # [ 0.470980] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]1395machine # [ 0.471013] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1396machine # [ 0.471031] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]1397machine # [ 0.471529] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint1398machine # [ 0.471726] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]1399machine # [ 0.471758] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1400machine # [ 0.472261] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint1401machine # [ 0.472455] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]1402machine # [ 0.472486] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1403machine # [ 0.472874] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint1404machine # [ 0.473054] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]1405machine # [ 0.473310] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint1406machine # [ 0.473587] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]1407machine # [ 0.473605] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]1408machine # [ 0.473634] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1409machine # [ 0.474088] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint1410machine # [ 0.474268] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]1411machine # [ 0.474284] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]1412machine # [ 0.474313] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]1413machine # [ 0.474887] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned1414machine # [ 0.474898] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned1415machine # [ 0.474904] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned1416machine # [ 0.474948] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned1417machine # [ 0.474995] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned1418machine # [ 0.475041] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned1419machine # [ 0.475086] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned1420machine # [ 0.475133] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned1421machine # [ 0.475179] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned1422machine # [ 0.475228] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned1423machine # [ 0.475276] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned1424machine # [ 0.475322] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned1425machine # [ 0.475399] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned1426machine # [ 0.475444] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned1427machine # [ 0.475466] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned1428machine # [ 0.475487] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned1429machine # [ 0.475509] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned1430machine # [ 0.475530] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned1431machine # [ 0.475557] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned1432machine # [ 0.475581] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned1433machine # [ 0.475603] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned1434machine # [ 0.475625] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned1435machine # [ 0.475647] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned1436machine # [ 0.475670] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned1437machine # [ 0.475692] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned1438machine # [ 0.475714] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned1439machine # [ 0.475735] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned1440machine # [ 0.475756] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned1441machine # [ 0.475777] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned1442machine # [ 0.475798] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned1443machine # [ 0.475820] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned1444machine # [ 0.475841] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned1445machine # [ 0.475863] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned1446machine # [ 0.475884] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned1447machine # [ 0.475910] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]1448machine # [ 0.475920] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]1449machine # [ 0.475925] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]1450machine # [ 0.541274] pci 0000:00:0a.0: enabling device (0000 -> 0002)1451machine # [ 0.562637] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)1452machine # [ 0.573026] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)1453machine # [ 0.584971] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)1454machine # [ 0.587208] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)1455machine # [ 0.591081] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)1456machine # [ 0.598311] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)1457machine # [ 0.604424] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)1458machine # [ 0.606643] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)1459machine # [ 0.616503] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)1460machine # [ 0.618496] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)1461machine # [ 0.628988] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)1462machine # [ 0.645080] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled1463machine # [ 0.647816] msm_serial: driver initialized1464machine # [ 0.648009] SuperH (H)SCI(F) driver initialized1465machine # [ 0.648072] STM32 USART driver initialized1466machine # [ 0.679141] loop: module loaded1467machine # [ 0.679376] virtio_blk virtio5: 1/0/0 default/read/poll queues1468machine # [ 0.681526] virtio_blk virtio5: [vda] 4194304 512-byte logical blocks (2.15 GB/2.00 GiB)1469machine # [ 0.693011] megasas: 07.734.00.00-rc11470machine # [ 0.693808] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]1471machine # [ 0.696197] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001472machine # [ 0.696262] Intel/Sharp Extended Query Table at 0x00311473machine # [ 0.697775] Using buffer write method1474machine # [ 0.697858] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]1475machine # [ 0.699613] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x0000001476machine # [ 0.699640] Intel/Sharp Extended Query Table at 0x00311477machine # [ 0.718328] Using buffer write method1478machine # [ 0.718379] Concatenating MTD devices:1479machine # [ 0.718384] (0): "0.flash"1480machine # [ 0.718388] (1): "0.flash"1481machine # [ 0.718392] into device "0.flash"1482machine # [ 0.999112] Freeing initrd memory: 26200K1483machine # [ 1.005637] tun: Universal TUN/TAP device driver, 1.61484machine # [ 1.009759] thunder_xcv, ver 1.01485machine # [ 1.009814] thunder_bgx, ver 1.01486machine # [ 1.009838] nicpf, ver 1.01487machine # [ 1.010422] e1000: Intel(R) PRO/1000 Network Driver1488machine # [ 1.010429] e1000: Copyright (c) 1999-2006 Intel Corporation.1489machine # [ 1.010460] e1000e: Intel(R) PRO/1000 Network Driver1490machine # [ 1.010468] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.1491machine # [ 1.010493] igb: Intel(R) Gigabit Ethernet Network Driver1492machine # [ 1.010498] igb: Copyright (c) 2007-2014 Intel Corporation.1493machine # [ 1.010521] igbvf: Intel(R) Gigabit Virtual Function Network Driver1494machine # [ 1.010526] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.1495machine # [ 1.010662] sky2: driver version 1.301496machine # [ 1.019887] usbcore: registered new interface driver usb-storage1497machine # [ 1.020013] usbcore: registered new interface driver usbserial_generic1498machine # [ 1.020036] usbserial: USB Serial support registered for generic1499machine # [ 1.020959] ehci-pci 0000:00:0a.0: EHCI Host Controller1500machine # [ 1.021012] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 11501machine # [ 1.021183] ehci-pci 0000:00:0a.0: irq 15, io mem 0x100890001502machine # [ 1.026687] hv_vmbus: registering driver hyperv_keyboard1503machine # [ 1.028486] rtc-pl031 9010000.pl031: registered as rtc01504machine # [ 1.028523] rtc-pl031 9010000.pl031: setting system clock to 2026-09-12T02:46:56 UTC (1789181216)1505machine # [ 1.028861] i2c_dev: i2c /dev entries driver1506machine # [ 1.034451] sdhci: Secure Digital Host Controller Interface driver1507machine # [ 1.034468] sdhci: Copyright(c) Pierre Ossman1508machine # [ 1.034756] Synopsys Designware Multimedia Card Interface Driver1509machine # [ 1.035155] sdhci-pltfm: SDHCI platform and OF driver helper1510machine # [ 1.039019] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.001511machine # [ 1.039397] hub 1-0:1.0: USB hub found1512machine # [ 1.039418] hub 1-0:1.0: 6 ports detected1513machine # [ 1.042396] hid: raw HID events driver (C) Jiri Kosina1514machine # [ 1.042676] usbcore: registered new interface driver usbhid1515machine # [ 1.042683] usbhid: USB HID core driver1516machine # [ 1.045725] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available1517machine # [ 1.047347] drop_monitor: Initializing network drop monitor service1518machine # [ 1.047526] NET: Registered PF_INET6 protocol family1519machine # [ 1.050881] Segment Routing with IPv61520machine # [ 1.050908] In-situ OAM (IOAM) with IPv61521machine # [ 1.050936] NET: Registered PF_PACKET protocol family1522machine # [ 1.052688] 9pnet: Installing 9P2000 support1523machine # [ 1.055013] Key type dns_resolver registered1524machine # [ 1.062445] registered taskstats version 11525machine # [ 1.062650] Loading compiled-in X.509 certificates1526machine # [ 1.071710] Demotion targets for Node 0: null1527machine # [ 1.071844] Key type .fscrypt registered1528machine # [ 1.071853] Key type fscrypt-provisioning registered1529machine # [ 1.071960] ima: No TPM chip found, activating TPM-bypass!1530machine # [ 1.071981] ima: Allocated hash algorithm: sha11531machine # [ 1.072010] ima: No architecture policies found1532machine # [ 1.076411] input: gpio-keys as /devices/platform/gpio-keys/input/input01533machine # [ 1.096850] clk: Disabling unused clocks1534machine # [ 1.096885] PM: genpd: Disabling unused power domains1535machine # [ 1.101338] Freeing unused kernel memory: 4736K1536machine # [ 1.101556] Run /init as init process1537machine # [ 1.118741] systemd[1]: Successfully made /usr/ read-only.1538machine # [ 1.284323] usb 1-1: new high-speed USB device number 2 using ehci-pci1539machine # [ 1.436280] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input11540machine # [ 1.453557] systemd[1]: systemd 262-b504aa0 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)1541machine # [ 1.458858] systemd[1]: Detected virtualization qemu.1542machine # [ 1.459846] systemd[1]: Detected architecture arm64.1543machine # [ 1.460746] systemd[1]: Running in initrd.1544machine # [ 1.462005] systemd[1]: Initializing machine ID from random generator.1545machine # [ 1.463357] systemd[1]: Hostname set to <machine>.1546machine # [ 1.524531] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input01547machine # [ 1.604381] systemd[1]: bpf-restrict-fs: LSM BPF program attached1548machine # [ 1.644413] usb 1-2: new high-speed USB device number 3 using ehci-pci1549machine # [ 1.665370] systemd[1]: Queued start job for default target Initrd Default Target.1550machine # [ 1.674322] systemd[1]: Created slice Slice /system/modprobe.1551machine # [ 1.675342] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1552machine # [ 1.676500] systemd[1]: Expecting device /dev/disk/by-label/nixos...1553machine # [ 1.677326] systemd[1]: Expecting device /dev/hvc0...1554machine # [ 1.678081] systemd[1]: Expecting device /dev/ttyAMA0...1555machine # [ 1.678808] systemd[1]: Reached target Path Units.1556machine # [ 1.679509] systemd[1]: Reached target Slice Units.1557machine # [ 1.680165] systemd[1]: Reached target Swaps.1558machine # [ 1.680953] systemd[1]: Reached target Timer Units.1559machine # [ 1.681795] systemd[1]: Listening on D-Bus System Message Bus Socket.1560machine # [ 1.682842] systemd[1]: Listening on Journal Socket (/dev/log).1561machine # [ 1.683756] systemd[1]: Listening on Journal Sockets.1562machine # [ 1.684563] systemd[1]: Listening on udev Kernel Socket.1563machine # [ 1.685258] systemd[1]: Reached target Socket Units.1564machine # [ 1.687524] systemd[1]: Starting Create List of Static Device Nodes...1565machine # [ 1.696476] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1566machine # [ 1.696578] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1567machine # [ 1.704574] systemd[1]: Mounting Kernel Configuration File System...1568machine # [ 1.724834] systemd[1]: Starting Journal Service...1569machine # [ 1.752406] systemd[1]: Starting Load Kernel Modules...1570machine # [ 1.752574] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1571machine # [ 1.756032] systemd[1]: Starting Coldplug All udev Devices...1572machine # [ 1.774441] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.1573machine # [ 1.777595] systemd[1]: Finished Create List of Static Device Nodes.1574machine # [ 1.778927] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1575machine # [ 1.779260] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1576machine # [ 1.791270] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev1577machine # [ 1.798397] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input21578machine # [ 1.798578] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input01579machine # [ 1.809195] [drm] pci: virtio-gpu-pci detected at 0000:00:08.01580machine # [ 1.809464] [drm] features: -virgl +edid -resource_blob -host_visible1581machine # [ 1.809475] [drm] features: -context_init1582machine # [ 1.810331] [drm] number of scanouts: 11583machine # [ 1.810352] [drm] number of cap sets: 01584machine # [ 1.816364] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1585machine # [ 1.816955] systemd[1]: Mounted Kernel Configuration File System.1586machine # [ 1.836718] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic1587machine # [ 1.836751] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 01588machine # [ 1.852540] systemd-journald[73]: Collecting audit messages is disabled.1589machine # [ 1.872598] Console: switching to colour frame buffer device 160x501590machine # [ 1.893136] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1591machine # [ 1.900669] systemd[1]: Starting Create Static Device Nodes in /dev...1592machine # [ 1.905065] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device1593machine # [ 1.924594] systemd[1]: Finished Load Kernel Modules.1594machine # [ 1.942245] systemd[1]: Starting Apply Kernel Variables...1595machine # [ 1.968581] systemd[1]: Finished Create Static Device Nodes in /dev.1596machine # [ 1.968991] systemd[1]: Reached target Preparation for Local File Systems.1597machine # [ 1.969042] systemd[1]: Reached target Local File Systems.1598machine # [ 1.986057] systemd[1]: Starting Rule-based Manager for Device Events and Files...1599machine # [ 2.024712] systemd[1]: Finished Apply Kernel Variables.1600machine # [ 2.044134] systemd[1]: Started Journal Service.1601machine # [ 2.044388] systemd-modules-load[74]: Inserted module 'dm_mod'1602machine # [ 2.045704] systemd-modules-load[74]: Module 'virtio_balloon' is built in1603machine # [ 2.046872] systemd-modules-load[74]: Module 'virtio_console' is built in1604machine # [ 2.047965] systemd-modules-load[74]: Inserted module 'virtio_gpu'1605machine # [ 2.058661] systemd-modules-load[74]: Module 'virtio_rng' is built in1606machine # [ 2.068643] systemd[1]: Starting Create System Files and Directories...1607machine # [ 2.102166] systemd-udevd[82]: Using default interface naming scheme 'v261'.1608machine # [ 2.111992] systemd[1]: Finished Create System Files and Directories.1609machine # [ 2.142404] systemd[1]: Started Rule-based Manager for Device Events and Files.1610machine # [ 2.245386] systemd[1]: Starting Virtual Console Setup...1611machine # [ 2.336751] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1612machine # [ 2.343390] systemd[1]: Finished Virtual Console Setup.1613machine # [ 2.993403] systemd[1]: Finished Coldplug All udev Devices.1614machine # [ 2.994447] systemd[1]: Reached target System Initialization.1615machine # [ 2.995302] systemd[1]: Reached target Basic System.1616machine # [ 3.122845] systemd[1]: Found device /dev/hvc0.1617machine # [ 3.160657] (udev-worker)[103]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1618machine # [ 3.176597] systemd[1]: Found device /dev/ttyAMA0.1619machine # [ 3.179640] systemd[1]: Started backdoor.service.1620machine # [ 3.187203] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.1621machine # [ 3.215767] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line.1622machine # [ 3.219652] backdoor-start[112]: /nix/store/5ch6a58ajz4w5gxfgjlb1n2jy5qxi4va-unit-script-backdoor-start/bin/backdoor-start: line 10: grep: command not found1623machine # connecting to host...1624machine: Guest shell says: b'Spawning backdoor root shell...\n'1625machine: connected to guest root shell1626machine: (connecting took 3.49 seconds)1627machine: (finished: waiting for the VM to finish booting, in 3.49 seconds)1628machine # [ 3.328602] systemd[1]: Found device /dev/disk/by-label/nixos.1629machine # [ 3.331745] systemd[1]: Reached target Initrd Root Device.1630machine # [ 3.340205] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1631machine # [ 3.397059] systemd-fsck[127]: nixos: clean, 225/65536 files, 15235/262144 blocks1632machine # [ 3.408184] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1633machine # [ 3.416368] systemd[1]: Mounting /sysroot...1634machine # [ 3.482932] EXT4-fs (vda): mounted filesystem d5da9096-5b7f-4f67-aab6-e3bdfc073092 r/w with ordered data mode. Quota mode: none.1635machine # [ 3.473160] systemd[1]: Mounted /sysroot.1636machine # [ 3.477156] systemd[1]: Reached target Initrd Root File System.1637machine # [ 3.482370] systemd[1]: Starting Mountpoints Configured in the Real Root...1638machine # [ 3.517168] systemd-sysroot-fstab-check[135]: /sysroot should be mounted in the initrd, will request daemon-reload.1639machine # [ 3.526309] systemd[1]: Reload requested from client PID 135 ('systemd-sysroot') (unit initrd-parse-etc.service)...1640machine # [ 3.527943] systemd[1]: Reloading...1641machine # [ 3.746653] systemd[1]: Reloading finished in 221 ms.1642machine # [ 3.783225] systemd-sysroot-fstab-check[135]: Requesting initrd-fs.target/start/replace...1643machine # [ 3.788103] systemd-sysroot-fstab-check[135]: Requesting swap.target/start/replace...1644machine # [ 3.796187] systemd[1]: Mounting /sysroot/nix/.rw-store...1645machine # [ 3.803413] systemd[1]: Mounting /sysroot/run...1646machine # [ 3.825801] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1647machine # [ 3.852949] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1648machine # [ 3.855286] systemd[1]: Finished Mountpoints Configured in the Real Root.1649machine # [ 3.857014] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1650machine # [ 3.882820] systemd[1]: Mounted /sysroot/nix/.rw-store.1651machine # [ 3.890020] systemd[1]: Mounted /sysroot/run.1652machine # [ 3.896387] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1653machine # [ 3.901083] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1654machine # [ 3.907063] systemd[1]: Mounting /sysroot/nix/.ro-store...1655machine # [ 3.920182] systemd[1]: Mounting /sysroot/tmp/shared...1656machine # [ 3.934948] systemd[1]: Mounting /sysroot/tmp/xchg...1657machine # [ 3.960139] systemd[1]: Starting rw-sysroot-nix-store.service...1658machine # [ 4.002171] systemd[1]: Mounted /sysroot/nix/.ro-store.1659machine # [ 4.015028] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1660machine # [ 4.023970] systemd[1]: Finished rw-sysroot-nix-store.service.1661machine # [ 4.025165] systemd[1]: Mounted /sysroot/tmp/shared.1662machine # [ 4.038187] systemd[1]: Mounted /sysroot/tmp/xchg.1663machine # [ 4.790739] systemd[1]: Mounting /sysroot/nix/store...1664machine # [ 4.842946] systemd[1]: Mounted /sysroot/nix/store.1665machine # [ 4.845811] systemd[1]: Reached target Initrd File Systems.1666machine # [ 4.853646] systemd[1]: Starting Find NixOS closure...1667machine # [ 4.872603] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1668machine # [ 4.915359] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1669machine # [ 4.917339] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1670machine # [ 4.936182] systemd[1]: Finished Find NixOS closure.1671machine # [ 4.937218] systemd[1]: Reached target Initrd Default Target.1672machine # [ 4.944343] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1673machine # [ 4.976241] systemd[1]: initrd-cleanup.service: Deactivated successfully.1674machine # [ 4.979631] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1675machine # [ 4.992955] systemd[1]: Startup finished in 1.090s (kernel) + 0 (initrd) + 3.901s (userspace) = 4.992s.1676machine # [ 5.045919] (udev-worker)[98]: mtd0ro: Failed to find and pin callout binary "/nix/store/zmx0fkcv0rzx39v279ji6d69ps1wah29-systemd-262-b504aa0/lib/udev/mtd_probe": No such file or directory1677machine # [ 5.051221] (udev-worker)[98]: mtd0ro: /nix/store/zmx0fkcv0rzx39v279ji6d69ps1wah29-systemd-262-b504aa0/lib/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 directory1678machine # [ 5.088472] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1679machine # [ 5.089626] systemd[1]: Stopped Virtual Console Setup.1680machine # [ 5.090351] systemd[1]: Stopping Virtual Console Setup...1681machine # [ 5.091087] systemd[1]: Starting Virtual Console Setup...1682machine # [ 5.112835] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1683machine # [ 5.116122] systemd[1]: Stopped Virtual Console Setup.1684machine # [ 5.132296] systemd[1]: Starting Virtual Console Setup...1685machine # [ 5.171864] systemd-vconsole-setup[194]: Configuration of first virtual console was skipped, ignoring remaining ones.1686machine # [ 5.175713] systemd[1]: Finished Virtual Console Setup.1687machine: (finished: waiting for unit initrd.target, in 5.68 seconds)1688machine: waiting for the VM to finish booting1689machine # [ 5.474343] systemd[1]: Stopped target Initrd Default Target.1690machine # [ 5.477877] systemd[1]: Stopped target Basic System.1691machine # [ 5.480849] systemd[1]: Stopped target Initrd Root Device.1692machine # [ 5.482503] systemd[1]: Stopped target Path Units.1693machine # [ 5.483916] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1694machine # [ 5.495953] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1695machine # [ 5.498372] systemd[1]: Stopped target Slice Units.1696machine # [ 5.499764] systemd[1]: Stopped target Socket Units.1697machine # [ 5.508525] systemd[1]: Stopped target System Initialization.1698machine # [ 5.510259] systemd[1]: Stopped target Swaps.1699machine # [ 5.511408] systemd[1]: Stopped target Timer Units.1700machine # [ 5.516313] systemd[1]: dbus.socket: Deactivated successfully.1701machine # [ 5.520275] systemd[1]: Closed D-Bus System Message Bus Socket.1702machine # [ 5.521722] systemd[1]: Stopping backdoor.service...1703machine # [ 5.524255] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1704machine # [ 5.528439] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1705machine # [ 5.534870] systemd[1]: Stopped Find NixOS closure.1706machine # [ 5.544365] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1707machine # [ 5.546012] systemd[1]: Starting rw-sysroot-nix-store.service...1708machine # [ 5.547320] systemd[1]: systemd-sysctl.service: Deactivated successfully.1709machine # [ 5.555658] systemd[1]: Stopped Apply Kernel Variables.1710machine # [ 5.568642] systemd[1]: systemd-modules-load.service: Deactivated successfully.1711machine # [ 5.570423] systemd[1]: Stopped Load Kernel Modules.1712machine # [ 5.571635] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1713machine # [ 5.580331] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1714machine # [ 5.589256] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1715machine # [ 5.591696] systemd[1]: Stopped Create System Files and Directories.1716machine # [ 5.594368] systemd[1]: Stopped target Local File Systems.1717machine # [ 5.597955] systemd[1]: Stopped target Preparation for Local File Systems.1718machine # [ 5.599180] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1719machine # [ 5.608317] systemd[1]: Stopped Coldplug All udev Devices.1720machine # [ 5.613714] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1721machine # [ 5.617209] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1722machine # [ 5.621578] systemd[1]: Stopped Virtual Console Setup.1723machine # [ 5.622736] systemd[1]: systemd-udevd.service: Deactivated successfully.1724machine # [ 5.625180] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1725machine # [ 5.628251] systemd[1]: systemd-udevd.service: Consumed 1.760s CPU time over 3.608s wall clock time, 22.1M memory peak.1726machine # [ 5.630885] systemd[1]: backdoor.service: Deactivated successfully.1727machine # [ 5.634033] systemd[1]: Stopped backdoor.service.1728machine # [ 5.635208] systemd[1]: initrd-cleanup.service: Deactivated successfully.1729machine # [ 5.636487] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1730machine # [ 5.637469] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1731machine # [ 5.638518] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1732machine # [ 5.639460] systemd[1]: Starting Cleanup udev Database...1733machine # [ 5.644421] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1734machine # [ 5.645654] systemd[1]: Stopped Create Static Device Nodes in /dev.1735machine # [ 5.648319] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1736machine # [ 5.652265] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1737machine # [ 5.653665] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1738machine # [ 5.656293] systemd[1]: Stopped Create List of Static Device Nodes.1739machine # [ 5.660218] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1740machine # [ 5.661328] systemd[1]: Finished rw-sysroot-nix-store.service.1741machine # [ 5.693412] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1742machine # [ 5.695578] systemd[1]: Finished Cleanup udev Database.1743machine # [ 5.698782] systemd[1]: Reached target Switch Root.1744machine # [ 5.700669] systemd[1]: Starting NixOS Activation...1745machine # [ 5.789576] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.1746machine # [ 5.907890] initrd-nixos-activation-start[217]: booting system configuration /nix/store/6ijy5cg34pv6ym977z2bddgyv7w6gcjd-nixos-system-machine-test1747machine # [ 5.990169] initrd-nixos-activation-start[217]: running activation script...1748machine # [ 6.498747] initrd-nixos-activation-start[240]: setting up /etc...1749machine # [ 6.916762] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1750machine # [ 6.920337] systemd[1]: Finished NixOS Activation.1751machine # [ 6.921709] systemd[1]: Starting Switch Root...1752machine # [ 6.947682] systemd[1]: Switching root.1753machine # [ 7.132095] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1754machine # [ 7.730553] systemd[1]: systemd 262-b504aa0 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)1755machine # [ 7.743692] systemd[1]: Detected virtualization qemu.1756machine # [ 7.747681] systemd[1]: Detected architecture arm64.1757machine # [ 7.933407] systemd[1]: bpf-restrict-fs: LSM BPF program attached1758machine # [ 8.771364] systemd[1]: initrd-switch-root.service: Deactivated successfully.1759machine # [ 8.772989] systemd[1]: Stopped initrd-switch-root.service.1760machine # [ 8.774504] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1761machine # [ 8.775571] systemd[1]: Created slice Slice /system/getty.1762machine # [ 8.779470] systemd[1]: Created slice User and Session Slice.1763machine # [ 8.780950] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1764machine # [ 8.783931] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1765machine # [ 8.786326] systemd[1]: Expecting device /dev/hvc0...1766machine # [ 8.788337] systemd[1]: Expecting device /dev/ttyAMA0...1767machine # [ 8.790315] systemd[1]: Reached target Local Encrypted Volumes.1768machine # [ 8.792450] systemd[1]: Stopped target initrd-fs.target.1769machine # [ 8.794392] systemd[1]: Stopped target initrd-root-fs.target.1770machine # [ 8.796421] systemd[1]: Stopped target initrd-switch-root.target.1771machine # [ 8.798440] systemd[1]: Reached target Virtual Machines and Containers.1772machine # [ 8.800563] systemd[1]: Reached target Path Units.1773machine # [ 8.802419] systemd[1]: Reached target Remote File Systems.1774machine # [ 8.804442] systemd[1]: Reached target Slice Units.1775machine # [ 8.806316] systemd[1]: Reached target Swaps.1776machine # [ 8.811167] systemd[1]: Listening on Query the User Interactively for a Password.1777machine # [ 8.816115] systemd[1]: Listening on Process Core Dump Socket.1778machine # [ 8.820256] systemd[1]: Listening on Credential Encryption/Decryption.1779machine # [ 8.824175] systemd[1]: Listening on Factory Reset Management.1780machine # [ 8.826335] systemd[1]: Listening on Hostname Service Socket.1781machine # [ 8.831800] systemd[1]: Starting Journal Log Access Socket...1782machine # [ 8.834825] systemd[1]: Listening on Journal Audit Socket.1783machine # [ 8.839171] systemd[1]: Listening on Console Output Muting Service Socket.1784machine # [ 8.841781] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1785machine # [ 8.844418] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1786machine # [ 8.846962] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1787machine # [ 8.858130] systemd[1]: Listening on Disk Repartitioning Service Socket.1788machine # [ 8.860584] systemd[1]: Listening on udev Varlink Socket.1789machine # [ 8.865655] systemd[1]: Mounting Huge Pages File System...1790machine # [ 8.871209] systemd[1]: Mounting POSIX Message Queue File System...1791machine # [ 8.879264] systemd[1]: Mounting Kernel Debug File System...1792machine # [ 8.888844] systemd[1]: Mounting Kernel Trace File System...1793machine # [ 8.903885] systemd[1]: Starting Create List of Static Device Nodes...1794machine # [ 8.921310] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1795machine # [ 8.924085] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1796machine # [ 8.943470] systemd[1]: Mounting Kernel Configuration File System...1797machine # [ 8.946720] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1798machine # [ 8.962295] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1799machine # [ 8.981695] systemd[1]: Starting Load Kernel Module fuse...1800machine # [ 8.986998] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671801machine # [ 9.068548] systemd[1]: Starting Journal Service...1802machine # [ 9.106370] systemd[1]: Starting Load Kernel Modules...1803machine # [ 9.142946] fuse: init (API version 7.45)1804machine # [ 9.144861] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1805machine # [ 9.174489] systemd[1]: Starting Remount Root and Kernel File Systems...1806machine # [ 9.184345] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1807machine # [ 9.205769] systemd[1]: Starting Coldplug All udev Devices...1808machine # [ 9.226398] systemd-journald[312]: Collecting audit messages is enabled.1809machine # [ 9.226846] systemd[1]: Queued start job for default target Multi-User System.1810machine # [ 9.233939] systemd[1]: systemd-journald.service: Deactivated successfully.1811machine # [ 9.237634] systemd-modules-load[313]: Module 'atkbd' is built in1812machine # [ 9.242415] systemd-modules-load[313]: Module 'loop' is built in1813machine # [ 9.262634] systemd[1]: Started Journal Service.1814machine # [ 9.254087] systemd[1]: Listening on Journal Log Access Socket.1815machine # [ 9.256290] systemd[1]: Mounted Huge Pages File System.1816machine # [ 9.261952] systemd[1]: Mounted POSIX Message Queue File System.1817machine # [ 9.283761] EXT4-fs (vda): re-mounted d5da9096-5b7f-4f67-aab6-e3bdfc073092.1818machine # [ 9.273452] systemd[1]: Mounted Kernel Debug File System.1819machine # [ 9.277109] systemd[1]: Mounted Kernel Trace File System.1820machine # [ 9.282495] systemd[1]: Finished Create List of Static Device Nodes.1821machine # [ 9.283561] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1822machine # [ 9.290523] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1823machine # [ 9.292861] systemd[1]: Mounted Kernel Configuration File System.1824machine # [ 9.297234] systemd[1]: modprobe@fuse.service: Deactivated successfully.1825machine # [ 9.301762] systemd[1]: Finished Load Kernel Module fuse.1826machine # [ 9.309065] systemd[1]: Finished Load Kernel Modules.1827machine # [ 9.309837] systemd[1]: Finished Remount Root and Kernel File Systems.1828machine # [ 9.312402] systemd[1]: Listening on Disk Image Download Service Socket.1829machine # [ 9.320129] systemd[1]: Mounting FUSE Control File System...1830machine # [ 9.325372] systemd[1]: Starting Firewall...1831machine # [ 9.340571] systemd-oomd[314]: No swap; memory pressure usage will be degraded1832machine # [ 9.354067] systemd[1]: Starting Grow Root File System...1833machine # [ 9.362207] systemd[1]: Starting Flush Journal to Persistent Storage...1834machine # [ 9.364156] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1835machine # [ 9.373973] systemd[1]: Starting Load/Save OS Random Seed...1836machine # [ 9.401947] systemd[1]: Starting Apply Kernel Variables...1837machine # [ 9.471967] EXT4-fs (vda): resizing filesystem from 262144 to 524288 blocks1838machine # [ 9.458500] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1839machine # [ 9.468286] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1840machine # [ 9.497136] EXT4-fs (vda): resized filesystem to 5242881841machine # [ 9.488397] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1842machine # [ 9.496774] systemd-growfs[332]: Successfully resized "/" to 2G bytes.1843machine # [ 9.524985] systemd-journald[312]: Received client request to flush runtime journal.1844machine # [ 9.610086] systemd[1]: Finished Grow Root File System.1845machine # [ 9.625084] systemd[1]: Mounted FUSE Control File System.1846machine # [ 9.627617] systemd[1]: Finished Load/Save OS Random Seed.1847machine # [ 9.630172] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes1848machine # [ 9.633559] systemd[1]: Finished Flush Journal to Persistent Storage.1849machine # [ 9.665165] systemd[1]: Finished Apply Kernel Variables.1850machine # [ 9.685645] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1851machine # [ 9.693860] systemd[1]: Starting Create Static Device Nodes in /dev...1852machine # [ 9.806173] systemd[1]: Finished Create Static Device Nodes in /dev.1853machine # [ 9.814050] systemd[1]: Reached target Preparation for Local File Systems.1854machine # [ 9.821203] systemd[1]: Mounting /run/wrappers...1855machine # [ 9.838907] systemd[1]: Starting Rule-based Manager for Device Events and Files...1856machine # [ 9.921011] systemd[1]: Mounted /run/wrappers.1857machine # [ 9.922251] systemd[1]: Reached target Local File Systems.1858machine # [ 9.928139] systemd[1]: Listening on Boot Loader Control Service Socket.1859machine # [ 9.941251] systemd[1]: Starting Create SUID/SGID Wrappers...1860machine # [ 9.943696] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1861machine # [ 9.949876] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id1862machine # [ 9.964341] systemd[1]: Starting Create System Files and Directories...1863machine # [ 10.028551] systemd-udevd[363]: Using default interface naming scheme 'v261'.1864machine # [ 10.148003] systemd[1]: Finished Create System Files and Directories.1865machine # [ 10.149293] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var1866machine # [ 10.150578] systemd[1]: Update is Completed skipped, no trigger condition checks were met.1867machine # [ 10.159336] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1868machine # [ 10.260000] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1869machine # [ 10.302563] systemd[1]: Started Rule-based Manager for Device Events and Files.1870machine # [ 10.965497] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1871machine # [ 10.967515] systemd[1]: Finished Create SUID/SGID Wrappers.1872machine # [ 11.147390] systemd[1]: Finished Coldplug All udev Devices.1873machine # [ 11.149688] systemd[1]: Reached target System Initialization.1874machine # [ 11.153619] systemd[1]: Started Discard unused filesystem blocks once a week.1875machine # [ 11.160273] systemd[1]: Started Daily Cleanup of Temporary Directories.1876machine # [ 11.161910] systemd[1]: Reached target Timer Units.1877machine # [ 11.165066] systemd[1]: Listening on D-Bus System Message Bus Socket.1878machine # [ 11.166567] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1879machine # [ 11.172972] systemd[1]: Reached target Socket Units.1880machine # [ 11.176448] systemd[1]: Reached target Basic System.1881machine # [ 11.182531] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db1882machine # [ 11.189512] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1883machine # [ 11.192197] systemd[1]: Starting Post-Boot Actions...1884machine # [ 11.200247] systemd[1]: Started Reset console on configuration changes.1885machine # [ 11.241724] systemd[1]: Starting resolvconf update...1886machine # [ 11.285236] systemd[1]: Starting D-Bus System Message Bus...1887machine # [ 11.291757] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1888machine # [ 11.326150] systemd[1]: Finished Post-Boot Actions.1889machine # [ 11.345934] nsncd[496]: Sep 12 02:47:06.832 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1890machine # [ 11.354439] systemd[1]: Started Name Service Cache Daemon (nsncd).1891machine # [ 11.362308] systemd[1]: Reached target Host and Network Name Lookups.1892machine # [ 11.370259] systemd[1]: Reached target User and Group Name Lookups.1893machine # [ 11.387542] systemd[1]: Starting User Login Management...1894machine # [ 11.570753] dbus-broker-launch[506]: Looking up NSS user entry for 'systemd-timesync'...1895machine # [ 11.580973] dbus-broker-launch[506]: NSS returned no entry for 'systemd-timesync'1896machine # [ 11.586935] dbus-broker-launch[506]: Invalid user-name in /nix/store/9kv8dq8g2d35d432gq16rzvw9i61zlx4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1897machine # [ 11.622414] systemd-logind[524]: New seat seat0.1898machine # [ 11.631603] systemd[1]: Started User Login Management.1899machine # [ 11.647312] systemd[1]: Starting linger-users.service...1900machine # [ 11.653590] systemd[1]: Started D-Bus System Message Bus.1901machine # [ 11.679294] systemd[1]: Finished Firewall.1902machine # [ 11.697566] dbus-broker-launch[506]: Ready1903machine # [ 11.725645] systemd[1]: Stopped target Host and Network Name Lookups.1904machine # [ 11.731144] systemd[1]: Stopping Host and Network Name Lookups...1905machine # [ 11.735933] systemd[1]: Stopped target User and Group Name Lookups.1906machine # [ 11.742584] systemd[1]: Stopping User and Group Name Lookups...1907machine # [ 11.746587] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1908machine # [ 11.753859] systemd[1]: nscd.service: Deactivated successfully.1909machine # [ 11.758203] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1910machine # [ 11.779039] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1911machine # [ 11.782292] systemd[1]: linger-users.service: Deactivated successfully.1912machine # [ 11.786130] systemd[1]: Finished linger-users.service.1913machine # [ 11.847164] systemd[1]: Found device /dev/hvc0.1914machine # [ 11.870264] systemd[1]: Started Name Service Cache Daemon (nsncd).1915machine # [ 11.874317] systemd[1]: Reached target Host and Network Name Lookups.1916machine # [ 11.878502] nsncd[586]: Sep 12 02:47:07.358 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1917machine # [ 11.886705] systemd[1]: Reached target User and Group Name Lookups.1918machine # [ 11.901519] systemd[1]: Finished resolvconf update.1919machine # [ 11.904628] systemd[1]: Reached target Preparation for Network.1920machine # [ 11.914887] systemd[1]: Starting DHCP Client...1921machine # [ 11.923211] systemd[1]: Starting Extra networking commands....1922machine # [ 11.925178] systemd[1]: Found device /dev/ttyAMA0.1923machine # [ 11.939411] systemd[1]: Started backdoor.service.1924machine # connecting to host...1925machine: Guest shell says: b'Spawning backdoor root shell...\n'1926machine: connected to guest root shell1927machine: (connecting took 6.71 seconds)1928machine: (finished: waiting for the VM to finish booting, in 6.71 seconds)1929machine: must succeed: df --output=avail / | sed 1d1930machine: (finished: must succeed: df --output=avail / | sed 1d, in 0.12 seconds)1931(finished: subtest: growfs works, in 15.03 seconds)1932subtest: no warnings from systemd about write permissions1933machine: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges'1934machine # [ 12.258979] dhcpcd[620]: dhcpcd-10.3.2 starting1935machine # [ 12.284477] dhcpcd[665]: dev: loaded udev1936machine # [ 12.289376] dhcpcd[665]: DUID 00:01:00:01:32:37:79:95:52:54:00:12:34:561937machine # [ 12.369905] 8021q: 802.1Q VLAN Support v1.81938machine: (finished: must fail: journalctl -b 0 | grep 'is marked world-writable, which is a security risk as it is executed with privileges', in 0.12 seconds)1939(finished: subtest: no warnings from systemd about write permissions, in 0.12 seconds)1940(finished: run the VM test script, in 35.82 seconds)1941machine # [ 12.387748] systemd[1]: Finished Extra networking commands..1942machine # [ 12.403575] systemd[1]: Reached target Network.1943machine # [ 12.412701] systemd[1]: Starting Permit User Sessions...1944machine # [ 12.492135] systemd[1]: Finished Permit User Sessions.1945test script finished in 35.94s1946cleanup1947kill QemuMachine (pid 78)1948machine # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1949(finished: cleanup, in 0.13 seconds)