tribuchet: building on eliza Machine state will be reset. To keep it, pass --keep-machine-state start all VLans (finished: start all VLans, in 0.00 seconds) Test will time out and terminate in 3600 seconds run the VM test script start all VMs machine: starting vm machine # Disk image does not exist, creating the virtualisation disk image... machine: QEMU running (pid 13) machine # Formatting '/build/vm-state-machine/tmp.vX3rXanRF3', fmt=raw size=1073741824 machine # mke2fs 1.47.4 (6-Mar-2025) machine # Discarding device blocks: 0/262144 done machine # Creating filesystem with 262144 4k blocks and 65536 inodes machine # Filesystem UUID: 2c5979d5-a958-4bee-8946-3d54988705f4 (finished: start all VMs, in 0.45 seconds) machine # Superblock backups stored on blocks: machine: waiting for unit multi-user.target machine # 32768, 98304, 163840, 229376 machine: waiting for the VM to finish booting machine # machine # Allocating group tables: 0/8 done machine # Writing inode tables: 0/8 done machine # Creating journal (8192 blocks): done machine # Writing superblocks and filesystem accounting information: 0/8 done machine # machine # Virtualisation disk image created. machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Oct 11 13:26:12 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 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/f8nhz0rflpznxxwmb9lrm71x46ay5nhi-nixos-system-machine-test/init regInfo=/nix/store/ad9ahnvdiw1b302hxgc62m1671hm8h3g-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ad9ahnvdiw1b302hxgc62m1671hm8h3g-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74856 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000033] arm-pv: using stolen time PV machine # [ 0.000413] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000621] Console: colour dummy device 80x25 machine # [ 0.000629] printk: legacy console [tty0] enabled machine # [ 0.000820] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000827] pid_max: default: 32768 minimum: 301 machine # [ 0.000903] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001035] landlock: Up and running. machine # [ 0.001038] Yama: becoming mindful. machine # [ 0.001464] LSM support for eBPF active machine # [ 0.001586] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001605] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003631] rcu: Hierarchical SRCU implementation. machine # [ 0.003637] rcu: Max phase no-delay instances is 1000. machine # [ 0.004953] fsl-mc MSI: its@8080000 domain created machine # [ 0.005068] EFI services will not be available. machine # [ 0.005157] smp: Bringing up secondary CPUs ... machine # [ 0.005166] smp: Brought up 1 node, 1 CPU machine # [ 0.005169] SMP: Total of 1 processors activated. machine # [ 0.005172] CPU: All CPU(s) started at EL1 machine # [ 0.005187] CPU features: detected: Branch Target Identification machine # [ 0.005192] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005195] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005198] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005202] CPU features: detected: Common not Private translations machine # [ 0.005205] CPU features: detected: CRC32 instructions machine # [ 0.005208] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005211] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005214] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005217] CPU features: detected: E0PD machine # [ 0.005220] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005223] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005226] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005229] CPU features: detected: Fine Grained Traps machine # [ 0.005233] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005238] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005241] CPU features: detected: LSE atomic instructions machine # [ 0.005244] CPU features: detected: Privileged Access Never machine # [ 0.005247] CPU features: detected: PMUv3 machine # [ 0.005250] CPU features: detected: RAS Extension Support machine # [ 0.005253] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005256] CPU features: detected: Random Number Generator machine # [ 0.005258] CPU features: detected: Speculation barrier (SB) machine # [ 0.005261] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005264] CPU features: detected: TLB range maintenance instructions machine # [ 0.005269] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005308] alternatives: applying system-wide alternatives machine # [ 0.008476] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008659] Memory: 894960K/1048576K available (24384K kernel code, 7090K rwdata, 26576K rodata, 4736K init, 1103K bss, 112336K reserved, 32768K cma-reserved) machine # [ 0.009025] devtmpfs: initialized machine # [ 0.010925] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010948] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.011162] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.011167] 0 pages in range for non-PLT usage machine # [ 0.011168] 508256 pages in range for PLT usage machine # [ 0.011306] pinctrl core: initialized pinctrl subsystem machine # [ 0.012113] DMI not present or invalid. machine # [ 0.015231] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017582] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017765] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017950] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017973] audit: initializing netlink subsys (disabled) machine # [ 0.018661] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018664] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018667] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018670] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018673] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018703] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018712] cpuidle: using governor ladder machine # [ 0.018718] cpuidle: using governor menu machine # [ 0.018920] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018937] ASID allocator initialised with 65536 entries machine # [ 0.020084] Serial: AMBA PL011 UART driver machine # [ 0.025932] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.026218] printk: console [ttyAMA0] enabled machine # [ 0.158133] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.158144] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.158148] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.158150] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.158153] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.158156] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.158159] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.158162] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.159415] fbcon: Taking over console machine # [ 0.159425] ACPI: Interpreter disabled. machine # [ 0.160434] iommu: Default domain type: Translated machine # [ 0.160439] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.160820] SCSI subsystem initialized machine # [ 0.171723] usbcore: registered new interface driver usbfs machine # [ 0.171752] usbcore: registered new interface driver hub machine # [ 0.171767] usbcore: registered new device driver usb machine # [ 0.172092] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.172096] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.172104] PTP clock support registered machine # [ 0.172155] EDAC MC: Ver: 3.0.0 machine # [ 0.172349] scmi_core: SCMI protocol bus registered machine # [ 0.172717] FPGA manager framework machine # [ 0.180188] vgaarb: loaded machine # [ 0.180523] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.187195] VFS: Disk quotas dquot_6.6.0 machine # [ 0.187220] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.190158] netfs: FS-Cache loaded machine # [ 0.190292] pnp: PnP ACPI: disabled machine # [ 0.195559] NET: Registered PF_INET protocol family machine # [ 0.195715] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.227382] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.227423] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.227449] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.227488] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.227561] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.227648] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.227705] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.227755] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.227832] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.227853] NET: Registered PF_XDP protocol family machine # [ 0.227869] PCI: CLS 0 bytes, default 64 machine # [ 0.228159] Trying to unpack rootfs image as initramfs... machine # [ 0.246778] kvm [1]: HYP mode not available machine # [ 0.346640] Initialise system trusted keyrings machine # [ 0.346785] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.347256] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.347303] 9p: Installing v9fs 9p2000 file system support machine # [ 0.371498] Key type asymmetric registered machine # [ 0.371516] Asymmetric key parser 'x509' registered machine # [ 0.371611] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.380600] io scheduler mq-deadline registered machine # [ 0.380614] io scheduler kyber registered machine # [ 0.393182] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.393816] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.394290] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.394304] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.394313] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.394334] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.394366] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.394385] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.394464] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.394472] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.394476] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.394479] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.394482] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.394580] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.395031] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.395222] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.395235] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.395269] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.395282] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.395756] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.395943] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.395955] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.395982] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.396452] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.401587] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.401600] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.401627] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.402179] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.402366] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.402378] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.402405] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.402884] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.403071] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.403083] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.403109] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.403573] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.403758] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.403770] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.403796] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404269] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.404457] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.404468] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.404494] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.404506] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.405031] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.405221] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.405248] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.405709] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.405900] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.405927] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.406338] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.406531] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.406782] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.407069] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.407081] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.407107] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.407574] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.407759] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.407771] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.407797] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.408374] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.408380] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.408384] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.408426] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.408470] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.408513] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.476658] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.476722] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.476770] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.476818] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.476865] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.476911] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.477049] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.477096] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.477115] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.477134] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.477153] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.477172] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.477195] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.477213] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.477232] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.477250] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.477269] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.477289] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.477308] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.477326] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.477343] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.477361] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.477379] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.477396] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.477414] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.477432] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.477450] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.477468] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.477495] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.477500] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.477503] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.478755] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.523532] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.542384] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.544470] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.548724] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.550937] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.561212] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.563538] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.574209] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.576156] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.587514] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.590690] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.603584] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.606230] msm_serial: driver initialized machine # [ 0.606366] SuperH (H)SCI(F) driver initialized machine # [ 0.606422] STM32 USART driver initialized machine # [ 0.643539] loop: module loaded machine # [ 0.643754] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.645865] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.650874] megasas: 07.734.00.00-rc1 machine # [ 0.651594] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.661796] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.661818] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.664189] Using buffer write method machine # [ 0.664274] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.677753] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.677778] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.679548] Using buffer write method machine # [ 0.679568] Concatenating MTD devices: machine # [ 0.679571] (0): "0.flash" machine # [ 0.679574] (1): "0.flash" machine # [ 0.679576] into device "0.flash" machine # [ 0.958181] Freeing initrd memory: 25352K machine # [ 0.964592] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.967852] thunder_xcv, ver 1.0 machine # [ 0.967880] thunder_bgx, ver 1.0 machine # [ 0.967897] nicpf, ver 1.0 machine # [ 0.968464] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.968468] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.968491] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.968500] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.968528] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.974120] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.974157] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.974161] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.974319] sky2: driver version 1.30 machine # [ 0.976040] usbcore: registered new interface driver usb-storage machine # [ 0.976151] usbcore: registered new interface driver usbserial_generic machine # [ 0.976162] usbserial: USB Serial support registered for generic machine # [ 0.977305] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.977332] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.977507] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.985633] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.986639] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.986667] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T07:55:18 UTC (1792655718) machine # [ 0.986976] i2c_dev: i2c /dev entries driver machine # [ 0.993358] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.993364] sdhci: Copyright(c) Pierre Ossman machine # [ 0.993646] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.994135] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.995708] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.995968] usbcore: registered new interface driver usbhid machine # [ 0.995972] usbhid: USB HID core driver machine # [ 1.001225] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 1.001596] hub 1-0:1.0: USB hub found machine # [ 1.001637] hub 1-0:1.0: 6 ports detected machine # [ 1.002741] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 1.004331] drop_monitor: Initializing network drop monitor service machine # [ 1.004463] NET: Registered PF_INET6 protocol family machine # [ 1.009397] Segment Routing with IPv6 machine # [ 1.009428] In-situ OAM (IOAM) with IPv6 machine # [ 1.009475] NET: Registered PF_PACKET protocol family machine # [ 1.009571] 9pnet: Installing 9P2000 support machine # [ 1.011889] Key type dns_resolver registered machine # [ 1.020523] registered taskstats version 1 machine # [ 1.021611] Loading compiled-in X.509 certificates machine # [ 1.029573] Demotion targets for Node 0: null machine # [ 1.029686] Key type .fscrypt registered machine # [ 1.029689] Key type fscrypt-provisioning registered machine # [ 1.029787] ima: No TPM chip found, activating TPM-bypass! machine # [ 1.029805] ima: Allocated hash algorithm: sha1 machine # [ 1.029828] ima: No architecture policies found machine # [ 1.030627] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 1.053662] clk: Disabling unused clocks machine # [ 1.053681] PM: genpd: Disabling unused power domains machine # [ 1.058181] Freeing unused kernel memory: 4736K machine # [ 1.058382] Run /init as init process machine # [ 1.075002] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.248588] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.398271] 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/input1 machine # [ 1.408972] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) machine # [ 1.408997] systemd[1]: Detected virtualization qemu. machine # [ 1.409039] systemd[1]: Detected architecture arm64. machine # [ 1.409047] systemd[1]: Running in initrd. machine # [ 1.409690] systemd[1]: Initializing machine ID from random generator. machine # [ 1.409846] systemd[1]: Hostname set to . machine # [ 1.484895] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 machine # [ 1.510245] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.518825] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.519017] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.519047] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.519068] systemd[1]: Reached target Path Units. machine # [ 1.519084] systemd[1]: Reached target Slice Units. machine # [ 1.519099] systemd[1]: Reached target Swaps. machine # [ 1.519112] systemd[1]: Reached target Timer Units. machine # [ 1.519255] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.519419] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.519601] systemd[1]: Listening on Journal Sockets. machine # [ 1.519723] systemd[1]: Listening on udev Control Socket. machine # [ 1.519797] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.519813] systemd[1]: Reached target Socket Units. machine # [ 1.533460] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.539876] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.539976] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.551320] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.560741] systemd[1]: Starting Journal Service... machine # [ 1.581576] systemd[1]: Starting Load Kernel Modules... machine # [ 1.581639] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 1.586999] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.602299] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.603452] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.603724] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.603936] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.604613] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.612384] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.616799] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.657202] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.661864] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.677640] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.692610] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.713241] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 machine # [ 1.713475] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.713478] [drm] features: -context_init machine # [ 1.714297] [drm] number of scanouts: 1 machine # [ 1.714309] [drm] number of cap sets: 0 machine # [ 1.720333] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.720596] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.720620] systemd[1]: Reached target Local File Systems. machine # [ 1.724706] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic machine # [ 1.724714] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 machine # [ 1.731325] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.755119] Console: switching to colour frame buffer device 160x50 machine # [ 1.771168] 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/input2 machine # [ 1.771290] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 machine # [ 1.789230] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.800656] systemd[1]: Finished Load Kernel Modules. machine # [ 1.810267] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.830773] systemd[1]: Started Journal Service. machine # [ 1.828413] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 1.830865] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 1.831987] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 1.841036] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 1.842176] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 1.843507] systemd-udevd[80]: Using default interface naming scheme 'v260'. machine # [ 1.851953] systemd[1]: Starting Create System Files and Directories... machine # [ 1.857290] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.895549] systemd[1]: Finished Create System Files and Directories. machine # [ 1.898705] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.992136] systemd[1]: Starting Virtual Console Setup... machine # [ 2.061313] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 2.066773] systemd[1]: Finished Virtual Console Setup. machine # [ 2.781012] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.782970] systemd[1]: Reached target System Initialization. machine # [ 2.788943] systemd[1]: Reached target Basic System. machine # [ 2.965735] (udev-worker)[101]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.979422] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.991836] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. machine # [ 3.036351] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 3.039927] systemd[1]: Reached target Initrd Root Device. machine # [ 3.042556] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 3.096686] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks machine # [ 3.104174] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 3.108121] systemd[1]: Mounting /sysroot... machine # [ 3.162934] systemd[1]: Mounted /sysroot. machine # [ 3.177425] EXT4-fs (vda): mounted filesystem 2c5979d5-a958-4bee-8946-3d54988705f4 r/w with ordered data mode. Quota mode: none. machine # [ 3.167574] systemd[1]: Reached target Initrd Root File System. machine # [ 3.175263] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.196131] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.198783] systemd[1]: Mounting /sysroot/run... machine # [ 3.221434] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.256157] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.272114] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 3.286035] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.298473] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.305635] systemd[1]: Mounted /sysroot/run. machine # [ 3.320835] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.327035] systemd-sysroot-fstab-check[126]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 3.347340] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.352152] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.363458] systemd[1]: Reload requested from client PID 126 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.366855] systemd[1]: Reloading... machine # [ 3.622939] systemd[1]: Reloading finished in 261 ms. machine # [ 3.644544] systemd-sysroot-fstab-check[126]: Requesting initrd-fs.target/start/replace... machine # [ 3.648803] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.653189] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.655394] systemd-sysroot-fstab-check[126]: Requesting swap.target/start/replace... machine # [ 3.664241] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.675127] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.677405] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.682046] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.702148] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.704278] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 3.706695] systemd[1]: Mounting /sysroot/nix/store... machine # [ 3.752164] systemd[1]: Mounted /sysroot/nix/store. machine # [ 3.756856] systemd[1]: Mounting /sysroot/var/lib/sops-nix... machine # [ 3.775837] systemd[1]: Starting Find NixOS closure... machine # [ 3.810346] systemd[1]: Mounted /sysroot/var/lib/sops-nix. machine # [ 3.818242] systemd[1]: Reached target Initrd File Systems. machine # [ 3.821739] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 3.854703] systemd[1]: Finished Find NixOS closure. machine # [ 3.866382] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 3.869402] systemd[1]: Reached target Initrd Default Target. machine # [ 3.873916] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 3.915518] systemd[1]: Stopped target Initrd Default Target. machine # [ 3.920107] systemd[1]: Stopped target Basic System. machine # [ 3.924545] systemd[1]: Stopped target Initrd Root Device. machine # [ 3.926741] systemd[1]: Stopped target Path Units. machine # [ 3.928768] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 3.931626] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 3.936348] systemd[1]: Stopped target Slice Units. machine # [ 3.938113] systemd[1]: Stopped target Socket Units. machine # [ 3.941028] systemd[1]: Stopped target System Initialization. machine # [ 3.945567] systemd[1]: Stopped target Swaps. machine # [ 3.947031] systemd[1]: Stopped target Timer Units. machine # [ 3.948671] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 3.953830] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 3.955695] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 3.960671] systemd[1]: Stopped Find NixOS closure. machine # [ 3.961572] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.962498] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.963375] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 3.971350] systemd[1]: Stopped Apply Kernel Variables. machine # [ 3.974349] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 3.977795] systemd[1]: Stopped Load Kernel Modules. machine # [ 3.981350] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 3.985219] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 3.988934] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 3.993315] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.005488] systemd[1]: Stopped target Local File Systems. machine # [ 4.008444] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.013580] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.022206] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.023195] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.025028] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.028156] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.029005] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.030709] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.034661] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 4.035922] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 4.040306] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.041430] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.051027] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.054175] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.055278] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 4.057606] systemd[1]: Closed udev Control Socket. machine # [ 4.060449] systemd[1]: Starting Cleanup udev Database... machine # [ 4.061409] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.064363] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.067263] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.069371] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.070652] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.071697] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.099176] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.102473] systemd[1]: Finished Cleanup udev Database. machine # [ 4.103393] systemd[1]: Reached target Switch Root. machine # [ 4.108445] systemd[1]: Starting NixOS Activation... machine # [ 4.246307] initrd-nixos-activation-start[175]: booting system configuration /nix/store/f8nhz0rflpznxxwmb9lrm71x46ay5nhi-nixos-system-machine-test machine # [ 4.300527] initrd-nixos-activation-start[175]: running activation script... machine # [ 4.418455] initrd-nixos-activation-start[198]: setting up /etc... machine # [ 4.651706] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. machine # [ 4.698472] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 4.701392] systemd[1]: Finished NixOS Activation. machine # [ 4.702634] systemd[1]: Starting Switch Root... machine # [ 4.727121] systemd[1]: Switching root. machine # [ 4.785778] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 5.311289] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) machine # [ 5.311353] systemd[1]: Detected virtualization qemu. machine # [ 5.311430] systemd[1]: Detected architecture arm64. machine # [ 5.311559] systemd[1]: Detected first boot. machine # [ 5.325344] systemd[1]: Initializing machine ID from random generator. machine # [ 5.615245] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 5.788938] systemd[1]: Applying preset policy. machine # [ 6.170103] systemd[1]: Populated /etc with preset unit settings. machine # [ 6.541074] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.541477] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.543946] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.548802] systemd[1]: Created slice Slice /system/getty. machine # [ 6.549554] systemd[1]: Created slice User and Session Slice. machine # [ 6.549680] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.549793] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.551340] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.551630] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.551907] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.552181] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.552437] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.560628] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.561077] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.561799] systemd[1]: Reached target Path Units. machine # [ 6.562463] systemd[1]: Reached target Remote File Systems. machine # [ 6.563097] systemd[1]: Reached target Slice Units. machine # [ 6.563733] systemd[1]: Reached target Swaps. machine # [ 6.571725] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.575467] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.576227] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.579211] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.579629] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.580448] systemd[1]: Listening on udev Control Socket. machine # [ 6.587438] systemd[1]: Mounting Huge Pages File System... machine # [ 6.591805] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.596344] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.606258] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.623262] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.640904] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 6.641495] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.655073] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.655637] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.656490] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 6.727486] systemd[1]: Starting Load Kernel Module fuse... machine # [ 6.756778] systemd[1]: Starting sops-install-secrets-for-users.service... machine # [ 6.758256] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 6.790625] systemd[1]: Starting Journal Service... machine # [ 6.817396] fuse: init (API version 7.45) machine # [ 6.825832] systemd[1]: Starting Load Kernel Modules... machine # [ 6.844404] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 6.849203] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.885727] systemd[1]: Starting Coldplug All udev Devices... machine # [ 6.910540] systemd-journald[264]: Collecting audit messages is enabled. machine # [ 6.915452] systemd[1]: Mounted Huge Pages File System. machine # [ 6.914487] systemd[1]: Queued start job for default target Multi-User System. machine # [ 6.934067] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 6.939648] systemd[1]: Started Journal Service. machine # [ 6.924009] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 6.933027] systemd-modules-load[265]: Module 'atkbd' is built in machine # [ 6.937183] systemd-modules-load[265]: Module 'loop' is built in machine # [ 6.941190] systemd[1]: Mounted Kernel Debug File System. machine # [ 6.947623] systemd[1]: Mounted Kernel Trace File System. machine # [ 6.953422] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 6.959615] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 6.966323] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 6.971696] systemd[1]: Mounted Kernel Configuration File System. machine # [ 6.978994] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 6.997754] EXT4-fs (vda): re-mounted 2c5979d5-a958-4bee-8946-3d54988705f4. machine # [ 6.987382] systemd[1]: Finished Load Kernel Module fuse. machine # [ 6.990931] systemd[1]: Finished Load Kernel Modules. machine # [ 7.000227] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.021873] systemd[1]: Mounting FUSE Control File System... machine # [ 7.031097] systemd[1]: Starting Firewall... machine # [ 7.041739] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.045295] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.084379] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.112776] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.151885] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.157347] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.218612] systemd-journald[264]: Received client request to flush runtime journal. machine # [ 7.333525] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.344472] systemd[1]: Reached target First Boot Complete. machine # [ 7.350961] systemd[1]: Mounted FUSE Control File System. machine # [ 7.372236] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.397305] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.434996] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.578016] systemd[1]: Finished sops-install-secrets-for-users.service. machine # [ 7.587534] systemd[1]: Starting Manage Users and Groups... machine # [ 7.649688] umount[311]: umount: /etc/group: no mount point specified. machine # [ 7.711798] umount[318]: umount: /etc/passwd: no mount point specified. machine # [ 7.778980] umount[326]: umount: /etc/shadow: no mount point specified. machine # [ 7.849134] userborn[333]: Created group adm with GID 55. machine # [ 7.852659] userborn[333]: Created group audio with GID 17. machine # [ 7.854977] userborn[333]: Created group cdrom with GID 24. machine # [ 7.862116] userborn[333]: Created group clock with GID 327. machine # [ 7.863757] userborn[333]: Created group dhcpcd with GID 999. machine # [ 7.868308] userborn[333]: Created group dialout with GID 27. machine # [ 7.872191] userborn[333]: Created group disk with GID 6. machine # [ 7.880411] userborn[333]: Created group floppy with GID 18. machine # [ 7.881285] userborn[333]: Created group input with GID 174. machine # [ 7.882192] userborn[333]: Created group keys with GID 96. machine # [ 7.882981] userborn[333]: Created group kmem with GID 2. machine # [ 7.883758] userborn[333]: Created group kvm with GID 302. machine # [ 7.896309] userborn[333]: Created group lp with GID 20. machine # [ 7.897216] userborn[333]: Created group messagebus with GID 4. machine # [ 7.898178] userborn[333]: Created group nixbld with GID 30000. machine # [ 7.899032] userborn[333]: Created group nogroup with GID 65534. machine # [ 7.899882] userborn[333]: Created group nscd with GID 998. machine # [ 7.904357] userborn[333]: Created group render with GID 303. machine # [ 7.907340] userborn[333]: Created group resolvconf with GID 997. machine # [ 7.913291] userborn[333]: Created group root with GID 0. machine # [ 7.916561] userborn[333]: Created group sgx with GID 304. machine # [ 7.919457] userborn[333]: Created group shadow with GID 318. machine # [ 7.924419] userborn[333]: Created group systemd-coredump with GID 996. machine # [ 7.925789] userborn[333]: Created group systemd-journal with GID 62. machine # [ 7.927298] userborn[333]: Created group systemd-network with GID 152. machine # [ 7.936382] userborn[333]: Created group systemd-oom with GID 995. machine # [ 7.937306] userborn[333]: Created group systemd-resolve with GID 153. machine # [ 7.938345] userborn[333]: Created group tape with GID 25. machine # [ 7.939150] userborn[333]: Created group tty with GID 3. machine # [ 7.939939] userborn[333]: Created group users with GID 100. machine # [ 7.946779] userborn[333]: Created group utmp with GID 29. machine # [ 7.950354] userborn[333]: Created group uucp with GID 19. machine # [ 7.956804] userborn[333]: Created group video with GID 26. machine # [ 7.964307] userborn[333]: Created group wheel with GID 1. machine # [ 7.965760] userborn[333]: Created user dhcpcd with UID 999. machine # [ 7.966852] userborn[333]: Created user example-user with UID 1000. machine # [ 7.968183] userborn[333]: Created user messagebus with UID 4. machine # [ 7.973961] userborn[333]: Created user nixbld1 with UID 30001. machine # [ 7.976965] userborn[333]: Created user nixbld10 with UID 30010. machine # [ 7.978887] userborn[333]: Created user nixbld11 with UID 30011. machine # [ 7.984798] userborn[333]: Created user nixbld12 with UID 30012. machine # [ 7.989278] userborn[333]: Created user nixbld13 with UID 30013. machine # [ 7.991352] userborn[333]: Created user nixbld14 with UID 30014. machine # [ 7.997615] userborn[333]: Created user nixbld15 with UID 30015. machine # [ 7.999384] userborn[333]: Created user nixbld16 with UID 30016. machine # [ 8.005294] userborn[333]: Created user nixbld17 with UID 30017. machine # [ 8.006590] userborn[333]: Created user nixbld18 with UID 30018. machine # [ 8.009180] userborn[333]: Created user nixbld19 with UID 30019. machine # [ 8.012412] userborn[333]: Created user nixbld2 with UID 30002. machine # [ 8.017729] userborn[333]: Created user nixbld20 with UID 30020. machine # [ 8.024433] userborn[333]: Created user nixbld21 with UID 30021. machine # [ 8.025452] userborn[333]: Created user nixbld22 with UID 30022. machine # [ 8.027127] userborn[333]: Created user nixbld23 with UID 30023. machine # [ 8.030182] userborn[333]: Created user nixbld24 with UID 30024. machine # [ 8.035093] userborn[333]: Created user nixbld25 with UID 30025. machine # [ 8.042045] userborn[333]: Created user nixbld26 with UID 30026. machine # [ 8.048531] userborn[333]: Created user nixbld27 with UID 30027. machine # [ 8.049936] userborn[333]: Created user nixbld28 with UID 30028. machine # [ 8.052361] userborn[333]: Created user nixbld29 with UID 30029. machine # [ 8.053705] userborn[333]: Created user nixbld3 with UID 30003. machine # [ 8.059812] userborn[333]: Created user nixbld30 with UID 30030. machine # [ 8.068394] userborn[333]: Created user nixbld31 with UID 30031. machine # [ 8.069304] userborn[333]: Created user nixbld32 with UID 30032. machine # [ 8.070179] userborn[333]: Created user nixbld4 with UID 30004. machine # [ 8.071019] userborn[333]: Created user nixbld5 with UID 30005. machine # [ 8.071860] userborn[333]: Created user nixbld6 with UID 30006. machine # [ 8.078533] userborn[333]: Created user nixbld7 with UID 30007. machine # [ 8.080995] userborn[333]: Created user nixbld8 with UID 30008. machine # [ 8.083979] userborn[333]: Created user nixbld9 with UID 30009. machine # [ 8.096180] userborn[333]: Created user nobody with UID 65534. machine # [ 8.097172] userborn[333]: Created user nscd with UID 998. machine # [ 8.098455] userborn[333]: Created user root with UID 0. machine # [ 8.100270] userborn[333]: Created user systemd-coredump with UID 151. machine # [ 8.102363] userborn[333]: Created user systemd-network with UID 152. machine # [ 8.110040] userborn[333]: Created user systemd-oom with UID 997. machine # [ 8.113380] userborn[333]: Created user systemd-resolve with UID 153. machine # [ 8.133697] systemd[1]: Finished Manage Users and Groups. machine # [ 8.145049] systemd[1]: Starting Journal Log Access Socket... machine # [ 8.158116] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 8.170385] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.173565] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.327351] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.330999] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.333555] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.353313] systemd-oomd[363]: No swap; memory pressure usage will be degraded machine # [ 8.365197] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.546900] systemd[1]: Mounting /run/wrappers... machine # [ 8.640901] systemd[1]: Mounted /run/wrappers. machine # [ 8.644249] systemd[1]: Reached target Local File Systems. machine # [ 8.662650] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.672282] systemd[1]: Starting register-nix-paths.service... machine # [ 8.678425] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.690515] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.713883] systemd[1]: Starting Save Transient machine-id to Disk... machine # [ 8.749059] systemd[1]: Starting Create System Files and Directories... machine # [ 8.926482] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. machine # [ 8.946105] systemd[1]: Finished Save Transient machine-id to Disk. machine # [ 8.967190] systemd-udevd[374]: Using default interface naming scheme 'v260'. machine # [ 9.104274] systemd[1]: Finished Create System Files and Directories. machine # [ 9.123193] systemd[1]: Starting Rebuild Journal Catalog... machine # [ 9.128468] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.337891] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.387956] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 9.434478] systemd[1]: Finished Rebuild Journal Catalog. machine # [ 9.442663] systemd[1]: Starting Update is Completed... machine # [ 9.488086] systemd[1]: Finished Firewall. machine # [ 9.558681] systemd[1]: Finished Update is Completed. machine # [ 9.832251] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.920104] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.926038] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 10.078854] systemd[1]: Finished register-nix-paths.service. machine # [ 10.082068] systemd[1]: Reached target System Initialization. machine # [ 10.084824] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 10.089062] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 10.094509] systemd[1]: Reached target Timer Units. machine # [ 10.095446] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 10.098212] systemd[1]: Listening on Nix Daemon Socket. machine # [ 10.102830] systemd[1]: Listening on Hostname Service Socket. machine # [ 10.105546] systemd[1]: Reached target Socket Units. machine # [ 10.108183] systemd[1]: Reached target Basic System. machine # [ 10.111655] systemd[1]: Starting Import lastlog data into lastlog2 database... machine # [ 10.114414] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.120272] systemd[1]: Starting Post-Boot Actions... machine # [ 10.131029] systemd[1]: Started Reset console on configuration changes. machine # [ 10.161758] systemd[1]: Starting resolvconf update... machine # [ 10.212605] systemd[1]: Starting D-Bus System Message Bus... machine # [ 10.281009] systemd[1]: Finished Post-Boot Actions. machine # [ 10.293329] nsncd[504]: Oct 22 07:55:27.818 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.301936] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.312823] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.319049] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.345405] systemd[1]: Starting User Login Management... machine # [ 10.401611] systemd[1]: Finished Import lastlog data into lastlog2 database. machine # [ 10.482661] dbus-broker-launch[509]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.505129] dbus-broker-launch[509]: NSS returned no entry for 'systemd-timesync' machine # [ 10.510988] dbus-broker-launch[509]: Invalid user-name in /nix/store/4rrxzk34h7nj1h722k3xx67s8cb869qz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.544123] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.569204] systemd-logind[525]: New seat seat0. machine # [ 10.573927] systemd[1]: Started User Login Management. machine # [ 10.582722] systemd[1]: Starting linger-users.service... machine # [ 10.596397] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.601303] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.605016] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.609912] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.614229] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.620488] dbus-broker-launch[509]: Ready machine # [ 10.624396] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.628276] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.672470] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.706761] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.713055] systemd[1]: Finished linger-users.service. machine # [ 10.747430] systemd[1]: Finished resolvconf update. machine # [ 10.751889] systemd[1]: Reached target Preparation for Network. machine # [ 10.762106] systemd[1]: Starting DHCP Client... machine # [ 10.773311] nsncd[579]: Oct 22 07:55:28.299 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.781622] systemd[1]: Starting Extra networking commands.... machine # [ 10.784772] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.788404] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.792529] systemd[1]: Reached target User and Group Name Lookups. machine # [ 11.034154] dhcpcd[605]: dhcpcd-10.3.1 starting machine # [ 11.050760] dhcpcd[640]: dev: loaded udev machine # [ 11.058832] dhcpcd[640]: no valid interfaces found machine # [ 11.060561] dhcpcd[640]: libudev: received NULL device machine # [ 11.063116] dhcpcd[640]: no valid interfaces found machine # [ 11.066711] dhcpcd[640]: libudev: received NULL device machine # [ 11.111680] systemd[1]: Finished Extra networking commands.. machine # [ 11.117618] systemd[1]: Reached target Network. machine # [ 11.122548] systemd[1]: Starting Permit User Sessions... machine # [ 11.173895] systemd[1]: Finished Permit User Sessions. machine # [ 11.182155] systemd[1]: Started Getty on tty1. machine # [ 11.183909] systemd[1]: Reached target Login Prompts. machine # [ 11.580994] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 machine # [ 11.963142] systemd[1]: Starting Virtual Console Setup... machine # [ 11.993385] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 11.996979] systemd[1]: Stopped Virtual Console Setup. machine # [ 12.006507] systemd[1]: Starting Virtual Console Setup... machine # [ 12.138958] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 12.390256] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 12.405373] systemd-vconsole-setup[664]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.411633] systemd[1]: Finished Virtual Console Setup. machine # [ 12.438771] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 12.449009] systemd[1]: Started backdoor.service. machine # connecting to host... machine # [ 12.576758] 8021q: 802.1Q VLAN Support v1.8 machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 12.86 seconds) machine: (finished: waiting for the VM to finish booting, in 12.86 seconds) machine # [ 12.627247] (udev-worker)[670]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.684577] (udev-worker)[671]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 12.702443] (udev-worker)[671]: Network interface NamePolicy= disabled on kernel command line. machine # [ 12.727497] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # [ 12.759363] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 12.759947] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 12.765218] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 12.765612] cfg80211: failed to load regulatory.db machine # [ 12.966116] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 12.977338] systemd[1]: Starting Address configuration of eth1... machine # [ 13.017009] systemd-logind[525]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 13.059481] dhcpcd[640]: eth0: waiting for carrier[ 13.072844] 8021q: adding VLAN 0 to HW filter on device eth0 machine # machine # [ 13.063824] dhcpcd[640]: eth0: carrier acquired machine # [ 13.081137] dhcpcd[640]: DUID 00:01:00:01:32:6c:7d:f2:52:54:00:12:34:56 machine # [ 13.082282] dhcpcd[640]: eth0: IAID 00:12:34:56 machine # [ 13.082977] dhcpcd[640]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 13.106523] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 13.108412] network-addresses-eth1-start[703]: adding address 192.168.1.1/24... done machine # [ 13.121555] network-addresses-eth1-start[703]: adding address 2001:db8:1::1/64... done machine # [ 13.141532] systemd[1]: Finished Address configuration of eth1. machine # [ 13.227787] mousedev: PS/2 mouse device common for all mice machine # [ 13.251424] systemd-logind[525]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 14.186037] dhcpcd[640]: eth0: soliciting a DHCP lease machine # [ 14.192577] dhcpcd[640]: eth0: offered 10.0.2.15 from 10.0.2.2 machine # [ 14.200283] dhcpcd[640]: eth0: probing address 10.0.2.15/24 machine # [ 14.551009] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 14.565949] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.571529] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.572490] systemd[1]: Stopping Virtual Console Setup... machine # [ 14.578329] systemd[1]: Starting Virtual Console Setup... machine # [ 14.609748] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 14.613338] systemd[1]: Stopped Virtual Console Setup. machine # [ 14.620639] systemd[1]: Starting Virtual Console Setup... machine # [ 14.655310] systemd-logind[525]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 14.846787] systemd-vconsole-setup[735]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 14.851223] systemd[1]: Finished Virtual Console Setup. machine # [ 15.501146] dhcpcd[640]: eth0: soliciting an IPv6 router machine # [ 15.504206] dhcpcd[640]: eth0: Router Advertisement from fe80::2 machine # [ 15.505719] dhcpcd[640]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 15.507270] dhcpcd[640]: eth0: adding route to fec0::/64 machine # [ 15.508580] dhcpcd[640]: eth0: adding default route via fe80::2 machine # [ 19.674371] dhcpcd[640]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 19.676344] dhcpcd[640]: eth0: adding route to 10.0.2.0/24 machine # [ 19.678099] dhcpcd[640]: eth0: adding default route via 10.0.2.2 machine # [ 19.797960] systemd[1]: Started DHCP Client. machine # [ 19.799932] systemd[1]: Reached target Multi-User System. machine # [ 19.801445] systemd[1]: Startup finished in 1.047s (kernel) + 3.806s (initrd) + 14.946s (userspace) = 19.800s. machine: (finished: waiting for unit multi-user.target, in 20.84 seconds) machine: must succeed: getent shadow example-user | grep -q :test_value: machine: (finished: must succeed: getent shadow example-user | grep -q :test_value:, in 0.03 seconds) machine: must succeed: systemctl show -p After --value sops-install-secrets-for-users.service machine: (finished: must succeed: systemctl show -p After --value sops-install-secrets-for-users.service, in 0.06 seconds) machine: waiting for the VM to power off additionally exposed symbols: machine, vlan1, start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh machine # [ 20.660527] systemd-logind[525]: The system will power off now! machine # [ 20.664146] systemd-logind[525]: System is powering down. machine # [ 20.682754] systemd[1]: Removed slice Slice /system/modprobe. machine # [ 20.687484] systemd[1]: Stopped target Multi-User System. machine # [ 20.688905] systemd[1]: Stopped target Login Prompts. machine # [ 20.689844] systemd[1]: Stopped target Virtual Machines and Containers. machine # [ 20.690817] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 20.691745] systemd[1]: Stopped target Timer Units. machine # [ 20.692886] systemd[1]: fstrim.timer: Deactivated successfully. machine # [ 20.694108] systemd[1]: Stopped Discard unused filesystem blocks once a week. machine # [ 20.699863] systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. machine # [ 20.703244] dhcpcd[640]: received SIGTERM, stopping machine # [ 20.708610] systemd[1]: Stopped Daily Cleanup of Temporary Directories. machine # [ 20.709879] dhcpcd[640]: eth0: removing interface machine # [ 20.710858] systemd[1]: systemd-rfkill.socket: Deactivated successfully. machine # [ 20.713523] dhcpcd[640]: eth0: deleting address fec0::5054:ff:fe12:3456/64 machine # [ 20.717049] systemd[1]: Closed Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 20.720770] dhcpcd[640]: eth0: deleting route to fec0::/64 machine # [ 20.724230] systemd[1]: Mounting /run/initramfs... machine # [ 20.726880] dhcpcd[640]: eth0: deleting default route via fe80::2 machine # [ 20.729606] systemd[1]: Stopping backdoor.service... machine # [ 20.733511] dhcpcd[640]: script_status: /nix/store/qgrj8lq05hffvrycblx1dqcag006awr3-dhcpcd-10.3.1/libexec/dhcpcd-run-hooks: Terminated machine # [ 20.744298] systemd[1]: Stopping DHCP Client... machine # [ 20.745581] dhcpcd[640]: eth0: deleting address fe80::5054:ff:fe12:3456 machine # [ 20.749155] systemd[1]: Stopping Getty on tty1... machine # [ 20.752515] dhcpcd[640]: eth0: deleting route to 10.0.2.0/24 machine # [ 20.756466] systemd[1]: lastlog2-import.service: Deactivated successfully. machine # [ 20.758700] dhcpcd[640]: eth0: deleting default route via 10.0.2.2 machine # [ 20.762549] systemd[1]: Stopped Import lastlog data into lastlog2 database. machine # [ 20.767156] systemd[1]: Stopping Address configuration of eth1... machine # [ 20.768294] systemd[1]: Stopping Post-Boot Actions... machine # [ 20.771178] systemd[1]: reload-systemd-vconsole-setup.service: Deactivated successfully. machine # [ 20.775592] systemd[1]: Stopped Reset console on configuration changes. machine # [ 20.778146] systemd[1]: Stopping User Login Management... machine # [ 20.781219] systemd[1]: systemd-machine-id-commit.service: Deactivated successfully. machine # [ 20.784162] dhcpcd[640]: dhcpcd exited machine # [ 20.785362] systemd[1]: Stopped Save Transient machine-id to Disk. machine # [ 20.787363] systemd[1]: Stopped target First Boot Complete. machine # [ 20.792338] systemd[1]: Stopping Userspace Out-Of-Memory (OOM) Killer... machine # [ 20.793447] systemd[1]: Stopping Load/Save OS Random Seed... machine # [ 20.803963] systemd[1]: systemd-oomd.service: Deactivated successfully. machine # [ 20.811751] systemd[1]: Stopped Userspace Out-Of-Memory (OOM) Killer. machine # [ 20.825042] systemd[1]: systemd-logind.service: Deactivated successfully. machine # [ 20.830950] systemd[1]: Stopped User Login Management. machine # [ 20.844970] network-addresses-eth1-pre-stop[866]: deleting address 192.168.1.1/24... done machine # [ 20.850386] systemd[1]: dhcpcd.service: Deactivated successfully. machine # [ 20.854406] systemd[1]: Stopped DHCP Client. machine # [ 20.860009] systemd[1]: dhcpcd.service: Consumed 250ms CPU time over 10.090s wall clock time, 5.5M memory peak, 8K written to disk, 96B incoming IP traffic, 56B outgoing IP traffic. machine # [ 20.867446] network-addresses-eth1-pre-stop[866]: deleting address 2001:db8:1::1/64... done machine # [ 20.871421] systemd[1]: getty@tty1.service: Deactivated successfully. machine # [ 20.877925] systemd[1]: Stopped Getty on tty1. machine # [ 20.882831] systemd[1]: backdoor.service: Deactivated successfully. machine # [ 20.885706] systemd[1]: Stopped backdoor.service. machine # [ 20.887589] systemd[1]: Mounted /run/initramfs. machine # [ 20.889881] systemd[1]: network-addresses-eth1.service: Deactivated successfully. machine # [ 20.892285] systemd[1]: Stopped Address configuration of eth1. machine # [ 20.893713] systemd[1]: post-boot.service: Deactivated successfully. machine # [ 20.896629] systemd[1]: Stopped Post-Boot Actions. machine # [ 20.897915] systemd[1]: systemd-random-seed.service: Deactivated successfully. machine # [ 20.900620] systemd[1]: Stopped Load/Save OS Random Seed. machine # [ 20.905055] systemd[1]: Removed slice Slice /system/getty. machine # [ 20.909036] systemd[1]: Starting Generate shutdown ramfs... machine # [ 20.912974] systemd[1]: Stopping Permit User Sessions... machine # [ 20.958873] systemd[1]: systemd-user-sessions.service: Deactivated successfully. machine # [ 20.966932] systemd[1]: Stopped Permit User Sessions. machine # [ 20.967834] systemd[1]: Stopped target Network. machine # [ 20.968876] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 20.969882] systemd[1]: Stopped target Remote File Systems. machine # [ 20.970701] systemd[1]: network-local-commands.service: Deactivated successfully. machine # [ 20.971771] systemd[1]: Stopped Extra networking commands.. machine # [ 20.976217] systemd[1]: Stopped target Preparation for Network. machine # [ 20.982092] systemd[1]: Stopping Firewall... machine # [ 20.984453] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 20.992322] systemd[1]: resolvconf.service: Deactivated successfully. machine # [ 20.993293] systemd[1]: Stopped resolvconf update. machine # [ 20.995799] systemd[1]: nscd.service: Deactivated successfully. machine # [ 21.000237] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 21.007267] systemd[1]: Stopped target Basic System. machine # [ 21.011748] systemd[1]: Stopped target Path Units. machine # [ 21.015065] systemd[1]: Stopped target Slice Units. machine # [ 21.019312] systemd[1]: Removed slice User and Session Slice. machine # [ 21.022593] systemd[1]: Stopped target Socket Units. machine # [ 21.023978] systemd[1]: nix-daemon.socket: Deactivated successfully. machine # [ 21.026274] systemd[1]: Closed Nix Daemon Socket. machine # [ 21.027763] systemd[1]: systemd-hostnamed.socket: Deactivated successfully. machine # [ 21.029931] systemd[1]: Closed Hostname Service Socket. machine # [ 21.031249] systemd[1]: systemd-oomd.socket: Deactivated successfully. machine # [ 21.038986] systemd[1]: Closed Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 21.045727] make-initrd-ng[890]: /etc/initrd-release -> /nix/store/lhf2prkx2jjzrpdlmfy5223jvk8fj6vy-etc-os-release machine # [ 21.052472] make-initrd-ng[890]: /etc/os-release -> /nix/store/lhf2prkx2jjzrpdlmfy5223jvk8fj6vy-etc-os-release machine # [ 21.056782] make-initrd-ng[890]: /shutdown -> /nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/systemd/systemd-shutdown machine # [ 21.065273] dbus-broker[564]: Dispatched 1114 messages @ 3(±5)μs / message. machine # [ 21.069046] systemd[1]: Stopping D-Bus System Message Bus... machine # [ 21.070964] systemd[1]: dbus-broker.service: Deactivated successfully. machine # [ 21.073597] systemd[1]: Stopped D-Bus System Message Bus. machine # [ 21.080161] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 21.081517] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 21.083244] systemd[1]: Stopped target System Initialization. machine # [ 21.087139] systemd[1]: Stopped target Local Encrypted Volumes. machine # [ 21.090690] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 21.095885] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 21.100720] systemd[1]: systemd-ask-password-wall.path: Deactivated successfully. machine # [ 21.103625] systemd[1]: Stopped Forward Password Requests to Wall Directory Watch. machine # [ 21.107043] systemd[1]: register-nix-paths.service: Deactivated successfully. machine # [ 21.112262] systemd[1]: Stopped register-nix-paths.service. machine # [ 21.113299] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 21.116597] systemd[1]: Stopped Apply Kernel Variables. machine # [ 21.119375] systemd[1]: systemd-coredump.socket: Deactivated successfully. machine # [ 21.129754] systemd[1]: Closed Process Core Dump Socket. machine # [ 21.132932] systemd[1]: systemd-update-done.service: Deactivated successfully. machine # [ 21.138036] systemd[1]: Stopped Update is Completed. machine # [ 21.141555] systemd[1]: systemd-journal-catalog-update.service: Deactivated successfully. machine # [ 21.148241] systemd[1]: Stopped Rebuild Journal Catalog. machine # [ 21.150085] systemd[1]: Stopping Record System Boot/Shutdown in UTMP... machine # [ 21.151257] systemd[1]: systemd-update-utmp.service: Deactivated successfully. machine # [ 21.156190] systemd[1]: Stopped Record System Boot/Shutdown in UTMP. machine # [ 21.159573] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 21.163541] systemd[1]: Stopped Create System Files and Directories. machine # [ 21.167322] systemd[1]: Stopped target Local File Systems. machine # [ 21.169975] systemd[1]: Unmounting /etc/group... machine # [ 21.171044] systemd[1]: Unmounting /etc/passwd... machine # [ 21.175782] systemd[1]: Unmounting /etc/shadow... machine # [ 21.176872] systemd[1]: Unmounting /run/keys... machine # [ 21.190020] systemd[1]: Unmounting /run/secrets-for-users.d... machine # [ 21.201913] systemd[1]: Unmounting /run/wrappers... machine # [ 21.226308] systemd[1]: Unmounting /var/lib/sops-nix... machine # [ 21.227357] systemd[1]: firewall.service: Deactivated successfully. machine # [ 21.241958] systemd[1]: Stopped Firewall. machine # [ 21.249509] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 21.251609] systemd[1]: Stopped Load Kernel Modules. machine # [ 21.315310] make-initrd-ng[890]: Warning: Couldn't satisfy dependency libcrypt.so.1 for "/nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/systemd/libsystemd-shared-260.so" machine # [ 21.320715] make-initrd-ng[890]: Warning: Couldn't satisfy dependency libcrypt.so.1.1 for "/nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/systemd/libsystemd-shared-260.so" machine # [ 21.325170] systemd[1]: etc-group.mount: Deactivated successfully. machine # [ 21.331996] systemd[1]: Unmounted /etc/group. machine # [ 21.339847] systemd[1]: etc-passwd.mount: Deactivated successfully. machine # [ 21.342353] systemd[1]: Unmounted /etc/passwd. machine # [ 21.345662] systemd[1]: etc-shadow.mount: Deactivated successfully. machine # [ 21.347513] systemd[1]: Unmounted /etc/shadow. machine # [ 21.349936] systemd[1]: run-keys.mount: Deactivated successfully. machine # [ 21.352491] systemd[1]: Unmounted /run/keys. machine # [ 21.354899] systemd[1]: run-secrets\x2dfor\x2dusers.d.mount: Deactivated successfully. machine # [ 21.357631] systemd[1]: Unmounted /run/secrets-for-users.d. machine # [ 21.359472] systemd[1]: run-wrappers.mount: Deactivated successfully. machine # [ 21.362179] systemd[1]: Unmounted /run/wrappers. machine # [ 21.367044] systemd[1]: var-lib-sops\x2dnix.mount: Deactivated successfully. machine # [ 21.370485] systemd[1]: Unmounted /var/lib/sops-nix. machine # [ 21.372847] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 21.374982] systemd[1]: Stopped target Swaps. machine # [ 21.375824] systemd[1]: Reached target Unmount All Filesystems. machine # [ 21.377282] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 21.378590] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 21.379646] systemd[1]: userborn.service: Deactivated successfully. machine # [ 21.381080] systemd[1]: Stopped Manage Users and Groups. machine # [ 21.381981] systemd[1]: systemd-remount-fs.service: Deactivated successfully. machine # [ 21.383095] systemd[1]: Stopped Remount Root and Kernel File Systems. machine # [ 21.384443] systemd[1]: systemd-fsck-root.service: Deactivated successfully. machine # [ 21.385709] systemd[1]: Stopped File System Check on Root Device. machine # [ 21.386678] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 21.387968] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 21.471893] systemd[1]: generate-shutdown-ramfs.service: Deactivated successfully. machine # [ 21.475398] systemd[1]: Finished Generate shutdown ramfs. machine # [ 21.480531] systemd[1]: Reached target System Shutdown. machine # [ 21.481425] systemd[1]: Reached target Late Shutdown Services. machine # [ 21.482280] systemd[1]: systemd-poweroff.service: Deactivated successfully. machine # [ 21.483265] systemd[1]: Finished System Power Off. machine # [ 21.483980] systemd[1]: Reached target System Power Off. machine # [ 21.489127] systemd[1]: Shutting down. machine # [ 21.681172] systemd-shutdown[1]: Syncing filesystems and block devices. machine # [ 21.687090] systemd-shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 21.694595] systemd-journald[264]: Received SIGTERM from PID 1 (systemd-shutdow). machine # [ 21.729213] systemd-shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 21.735121] systemd-shutdown[1]: Unmounting file systems. machine # [ 21.740364] (sd-umount)[931]: Unmounting '/run/credentials/systemd-journald.service'. machine # [ 21.743954] (sd-remount)[932]: 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'. machine # [ 21.757682] (sd-remount)[933]: 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'. machine # [ 21.758921] (sd-remount)[934]: Remounting '/tmp/xchg' read-only with options 'access=client,msize=16384,trans=virtio'. machine # [ 21.760007] (sd-umount)[935]: Unmounting '/tmp/xchg'. machine # [ 21.781797] (sd-remount)[936]: Remounting '/tmp/shared' read-only with options 'access=client,msize=16384,trans=virtio'. machine # [ 21.783022] (sd-umount)[937]: Unmounting '/tmp/shared'. machine # [ 21.793712] (sd-remount)[938]: Remounting '/nix/.ro-store' read-only with options 'cache=0xf,access=client,msize=16384,trans=virtio'. machine # [ 21.863055] (sd-umount)[939]: Unmounting '/nix/.ro-store'. machine # [ 21.863878] (sd-umount)[940]: Unmounting '/nix/.rw-store'. machine # [ 21.866818] (sd-remount)[941]: Remounting '/' read-only with options ''. machine # [ 21.871859] EXT4-fs (vda): re-mounted 2c5979d5-a958-4bee-8946-3d54988705f4 ro. machine # [ 21.874951] systemd-shutdown[1]: All filesystems unmounted. machine # [ 21.875043] systemd-shutdown[1]: Deactivating swaps. machine # [ 21.875932] systemd-shutdown[1]: All swaps deactivated. machine # [ 21.875950] systemd-shutdown[1]: Detaching loop devices. machine # [ 21.885328] systemd-shutdown[1]: All loop devices detached. machine # [ 21.885421] systemd-shutdown[1]: Stopping MD devices. machine # [ 21.885604] systemd-shutdown[1]: All MD devices stopped. machine # [ 21.885617] systemd-shutdown[1]: Detaching DM devices. machine # [ 21.885708] systemd-shutdown[1]: All DM devices detached. machine # [ 21.885720] systemd-shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. machine # [ 21.887300] systemd-shutdown[1]: Failed to chase and open directory '/etc/systemd/system-shutdown', ignoring: Input/output error machine # [ 22.222188] systemd-shutdown[1]: Successfully changed into root pivot. machine # [ 22.222210] systemd-shutdown[1]: Entering exitrd... machine # [ 22.238300] shutdown[1]: Syncing filesystems and block devices. machine # [ 22.239282] shutdown[1]: Sending SIGTERM to remaining processes... machine # [ 22.245415] shutdown[1]: Sending SIGKILL to remaining processes... machine # [ 22.250217] shutdown[1]: Unmounting file systems. machine # [ 22.252326] (sd-umoun[943]: Unmounting '/run/credentials'. machine # [ 22.256366] (sd-umoun[944]: Unmounting '/oldroot/sys/fs/fuse/connections'. machine # [ 22.259506] (sd-umoun[945]: Unmounting '/oldroot/sys/kernel/config'. machine # [ 22.262043] (sd-umoun[946]: Unmounting '/oldroot/dev/mqueue'. machine # [ 22.263201] (sd-umoun[947]: Unmounting '/oldroot/dev/hugepages'. machine # [ 22.264316] (sd-umoun[948]: Unmounting '/oldroot/sys/kernel/tracing'. machine # [ 22.269630] (sd-umoun[949]: Unmounting '/oldroot/sys/kernel/debug'. machine # [ 22.270761] (sd-umoun[950]: Unmounting '/oldroot/sys/fs/bpf'. machine # [ 22.271844] (sd-umoun[951]: Unmounting '/oldroot/sys/fs/pstore'. machine # [ 22.276761] (sd-umoun[952]: Unmounting '/oldroot/sys/fs/cgroup'. machine # [ 22.277876] (sd-umoun[953]: Unmounting '/oldroot/sys/kernel/security'. machine # [ 22.278964] (sd-umoun[954]: Unmounting '/oldroot/nix/store'. machine # [ 22.280091] (sd-umoun[955]: Unmounting '/oldroot/sys'. machine # [ 22.286327] (sd-umoun[956]: Unmounting '/oldroot/proc'. machine # [ 22.287837] (sd-umoun[957]: Unmounting '/oldroot/dev/shm'. machine # [ 22.292120] (sd-umoun[958]: Unmounting '/oldroot/dev/pts'. machine # [ 22.295416] (sd-umoun[959]: Unmounting '/oldroot/dev'. machine # [ 22.298066] (sd-umoun[960]: Unmounting '/oldroot/nix/store'. machine # [ 22.338294] (sd-umoun[961]: Unmounting '/oldroot/run'. machine # [ 22.339632] (sd-umoun[962]: Unmounting '/oldroot'. machine # [ 22.344262] EXT4-fs (vda): unmounting filesystem 2c5979d5-a958-4bee-8946-3d54988705f4. machine # [ 22.347749] shutdown[1]: All filesystems unmounted. machine # [ 22.348152] shutdown[1]: Deactivating swaps. machine # [ 22.351741] shutdown[1]: All swaps deactivated. machine # [ 22.352105] shutdown[1]: Detaching loop devices. machine # [ 22.357800] shutdown[1]: All loop devices detached. machine # [ 22.358167] shutdown[1]: Stopping MD devices. machine # [ 22.359029] shutdown[1]: All MD devices stopped. machine # [ 22.359552] shutdown[1]: Detaching DM devices. machine # [ 22.360371] shutdown[1]: All DM devices detached. machine # [ 22.366542] shutdown[1]: All filesystems, swaps, loop devices, MD devices and DM devices detached. machine # [ 22.367326] shutdown[1]: Syncing filesystems and block devices. machine # [ 22.368423] shutdown[1]: Powering off. machine # [ 22.400877] Console: switching to colour dummy device 80x25 machine # [ 22.412678] Flash device refused suspend due to active operation (state 20) machine # [ 22.412695] Flash device refused suspend due to active operation (state 20) machine # [ 22.415632] reboot: Power down machine: (finished: waiting for the VM to power off, in 1.91 seconds) machine: starting vm machine: QEMU running (pid 45) machine: waiting for unit multi-user.target machine: waiting for the VM to finish booting machine # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] machine # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sun Oct 11 13:26:12 UTC 2026 machine # [ 0.000000] KASLR enabled machine # [ 0.000000] random: crng init done machine # [ 0.000000] Machine model: linux,dummy-virt machine # [ 0.000000] efi: UEFI not found. machine # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT machine # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf] machine # [ 0.000000] Zone ranges: machine # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] DMA32 empty machine # [ 0.000000] Normal empty machine # [ 0.000000] Device empty machine # [ 0.000000] Movable zone start for each node machine # [ 0.000000] Early memory node ranges machine # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] machine # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 machine # [ 0.000000] psci: probing for conduit method from DT. machine # [ 0.000000] psci: PSCIv1.3 detected in firmware. machine # [ 0.000000] psci: Using standard PSCI v0.2 function IDs machine # [ 0.000000] psci: Trusted OS migration not required machine # [ 0.000000] psci: SMC Calling Convention v1.1 machine # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) machine # [ 0.000000] percpu: Embedded 76 pages/cpu s186520 r8192 d116584 u311296 machine # [ 0.000000] Detected PIPT I-cache on CPU0 machine # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) machine # [ 0.000000] CPU features: detected: GICv3 CPU interface machine # [ 0.000000] CPU features: detected: Spectre-v4 machine # [ 0.000000] CPU features: detected: Spectre-BHB machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 machine # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 machine # [ 0.000000] alternatives: applying boot alternatives machine # [ 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/f8nhz0rflpznxxwmb9lrm71x46ay5nhi-nixos-system-machine-test/init regInfo=/nix/store/ad9ahnvdiw1b302hxgc62m1671hm8h3g-closure-info/registration console=ttyAMA0,115200n8 console=tty0 machine # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/ad9ahnvdiw1b302hxgc62m1671hm8h3g-closure-info/registration", will be passed to user space. machine # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes machine # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) machine # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) machine # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB machine # [ 0.000000] software IO TLB: area num 1. machine # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) machine # [ 0.000000] Fallback order for Node 0: 0 machine # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 machine # [ 0.000000] Policy zone: DMA machine # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off machine # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 machine # [ 0.000000] allocated 2097152 bytes of page_ext machine # [ 0.000000] ftrace: allocating 74856 entries in 294 pages machine # [ 0.000000] ftrace: allocated 294 pages with 4 groups machine # [ 0.000000] rcu: Hierarchical RCU implementation. machine # [ 0.000000] rcu: RCU event tracing is enabled. machine # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. machine # [ 0.000000] Trampoline variant of Tasks RCU enabled. machine # [ 0.000000] Rude variant of Tasks RCU enabled. machine # [ 0.000000] Tracing variant of Tasks RCU enabled. machine # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. machine # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 machine # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. machine # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 machine # [ 0.000000] GICv3: 256 SPIs implemented machine # [ 0.000000] GICv3: 0 Extended SPIs implemented machine # [ 0.000000] Root IRQ handler: gic_handle_irq machine # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI machine # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 machine # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 machine # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44cf0000 (indirect, esz 8, psz 64K, shr 1) machine # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44d00000 (flat, esz 8, psz 64K, shr 1) machine # [ 0.000000] GICv3: using LPI property table @0x0000000044d10000 machine # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d20000 machine # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. machine # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns machine # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). machine # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns machine # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns machine # [ 0.000029] arm-pv: using stolen time PV machine # [ 0.000400] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) machine # [ 0.000580] Console: colour dummy device 80x25 machine # [ 0.000588] printk: legacy console [tty0] enabled machine # [ 0.000789] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) machine # [ 0.000796] pid_max: default: 32768 minimum: 301 machine # [ 0.000889] LSM: initializing lsm=capability,landlock,yama,bpf,ima machine # [ 0.001022] landlock: Up and running. machine # [ 0.001025] Yama: becoming mindful. machine # [ 0.001480] LSM support for eBPF active machine # [ 0.001593] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.001620] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) machine # [ 0.003539] rcu: Hierarchical SRCU implementation. machine # [ 0.003544] rcu: Max phase no-delay instances is 1000. machine # [ 0.004808] fsl-mc MSI: its@8080000 domain created machine # [ 0.004922] EFI services will not be available. machine # [ 0.005004] smp: Bringing up secondary CPUs ... machine # [ 0.005012] smp: Brought up 1 node, 1 CPU machine # [ 0.005015] SMP: Total of 1 processors activated. machine # [ 0.005018] CPU: All CPU(s) started at EL1 machine # [ 0.005031] CPU features: detected: Branch Target Identification machine # [ 0.005036] CPU features: detected: ARMv8.4 Translation Table Level machine # [ 0.005040] CPU features: detected: Instruction cache invalidation not required for I/D coherence machine # [ 0.005043] CPU features: detected: Data cache clean to the PoU not required for I/D coherence machine # [ 0.005047] CPU features: detected: Common not Private translations machine # [ 0.005050] CPU features: detected: CRC32 instructions machine # [ 0.005053] CPU features: detected: Data cache clean to Point of Deep Persistence machine # [ 0.005056] CPU features: detected: Data cache clean to Point of Persistence machine # [ 0.005059] CPU features: detected: Data independent timing control (DIT) machine # [ 0.005062] CPU features: detected: E0PD machine # [ 0.005065] CPU features: detected: Enhanced Counter Virtualization machine # [ 0.005068] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) machine # [ 0.005072] CPU features: detected: Enhanced Virtualization Traps machine # [ 0.005075] CPU features: detected: Fine Grained Traps machine # [ 0.005078] CPU features: detected: Generic authentication (architected QARMA5 algorithm) machine # [ 0.005083] CPU features: detected: RCpc load-acquire (LDAPR) machine # [ 0.005086] CPU features: detected: LSE atomic instructions machine # [ 0.005089] CPU features: detected: Privileged Access Never machine # [ 0.005092] CPU features: detected: PMUv3 machine # [ 0.005094] CPU features: detected: RAS Extension Support machine # [ 0.005097] CPU features: detected: RASv1p1 Extension Support machine # [ 0.005100] CPU features: detected: Random Number Generator machine # [ 0.005102] CPU features: detected: Speculation barrier (SB) machine # [ 0.005105] CPU features: detected: Stage-2 Force Write-Back machine # [ 0.005108] CPU features: detected: TLB range maintenance instructions machine # [ 0.005113] CPU features: detected: Speculative Store Bypassing Safe (SSBS) machine # [ 0.005148] alternatives: applying system-wide alternatives machine # [ 0.008111] CPU features: detected: BBM Level 2 without TLB conflict abort machine # [ 0.008274] Memory: 894932K/1048576K available (24384K kernel code, 7090K rwdata, 26576K rodata, 4736K init, 1103K bss, 112336K reserved, 32768K cma-reserved) machine # [ 0.008628] devtmpfs: initialized machine # [ 0.010372] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.010395] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). machine # [ 0.010575] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL machine # [ 0.010579] 0 pages in range for non-PLT usage machine # [ 0.010581] 508256 pages in range for PLT usage machine # [ 0.010669] pinctrl core: initialized pinctrl subsystem machine # [ 0.011523] DMI not present or invalid. machine # [ 0.014660] NET: Registered PF_NETLINK/PF_ROUTE protocol family machine # [ 0.017251] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations machine # [ 0.017413] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations machine # [ 0.017658] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations machine # [ 0.017680] audit: initializing netlink subsys (disabled) machine # [ 0.018217] thermal_sys: Registered thermal governor 'fair_share' machine # [ 0.018219] thermal_sys: Registered thermal governor 'bang_bang' machine # [ 0.018223] thermal_sys: Registered thermal governor 'step_wise' machine # [ 0.018226] thermal_sys: Registered thermal governor 'user_space' machine # [ 0.018228] thermal_sys: Registered thermal governor 'power_allocator' machine # [ 0.018255] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 machine # [ 0.018263] cpuidle: using governor ladder machine # [ 0.018269] cpuidle: using governor menu machine # [ 0.018455] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. machine # [ 0.018471] ASID allocator initialised with 65536 entries machine # [ 0.019708] Serial: AMBA PL011 UART driver machine # [ 0.025211] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 machine # [ 0.025371] printk: console [ttyAMA0] enabled machine # [ 0.153052] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages machine # [ 0.153062] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page machine # [ 0.153065] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages machine # [ 0.153068] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page machine # [ 0.153071] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages machine # [ 0.153074] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page machine # [ 0.153077] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages machine # [ 0.153079] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page machine # [ 0.154283] fbcon: Taking over console machine # [ 0.154293] ACPI: Interpreter disabled. machine # [ 0.162745] iommu: Default domain type: Translated machine # [ 0.162750] iommu: DMA domain TLB invalidation policy: strict mode machine # [ 0.163120] SCSI subsystem initialized machine # [ 0.165155] usbcore: registered new interface driver usbfs machine # [ 0.165174] usbcore: registered new interface driver hub machine # [ 0.165196] usbcore: registered new device driver usb machine # [ 0.165540] pps_core: LinuxPPS API ver. 1 registered machine # [ 0.165543] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti machine # [ 0.165550] PTP clock support registered machine # [ 0.165601] EDAC MC: Ver: 3.0.0 machine # [ 0.165775] scmi_core: SCMI protocol bus registered machine # [ 0.172467] FPGA manager framework machine # [ 0.173003] vgaarb: loaded machine # [ 0.173274] clocksource: Switched to clocksource arch_sys_counter machine # [ 0.181063] VFS: Disk quotas dquot_6.6.0 machine # [ 0.181093] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) machine # [ 0.184924] netfs: FS-Cache loaded machine # [ 0.185020] pnp: PnP ACPI: disabled machine # [ 0.189080] NET: Registered PF_INET protocol family machine # [ 0.189242] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) machine # [ 0.218843] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) machine # [ 0.218878] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) machine # [ 0.218901] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) machine # [ 0.218944] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) machine # [ 0.219016] TCP: Hash tables configured (established 8192 bind 8192) machine # [ 0.219096] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) machine # [ 0.219161] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.219209] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) machine # [ 0.219285] NET: Registered PF_UNIX/PF_LOCAL protocol family machine # [ 0.219305] NET: Registered PF_XDP protocol family machine # [ 0.219321] PCI: CLS 0 bytes, default 64 machine # [ 0.219706] Trying to unpack rootfs image as initramfs... machine # [ 0.231428] kvm [1]: HYP mode not available machine # [ 0.323483] Initialise system trusted keyrings machine # [ 0.323618] workingset: timestamp_bits=42 max_order=18 bucket_order=0 machine # [ 0.324103] squashfs: version 4.0 (2009/01/31) Phillip Lougher machine # [ 0.324160] 9p: Installing v9fs 9p2000 file system support machine # [ 0.355053] Key type asymmetric registered machine # [ 0.355071] Asymmetric key parser 'x509' registered machine # [ 0.355149] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) machine # [ 0.355264] io scheduler mq-deadline registered machine # [ 0.355269] io scheduler kyber registered machine # [ 0.369439] pl061_gpio 9030000.pl061: PL061 GPIO chip registered machine # [ 0.370101] ledtrig-cpu: registered to indicate activity on CPUs machine # [ 0.370483] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: machine # [ 0.370496] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 machine # [ 0.370514] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 machine # [ 0.370520] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 machine # [ 0.370538] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits machine # [ 0.370560] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] machine # [ 0.370631] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 machine # [ 0.370637] pci_bus 0000:00: root bus resource [bus 00-ff] machine # [ 0.370641] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] machine # [ 0.370644] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] machine # [ 0.370647] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] machine # [ 0.370768] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint machine # [ 0.371211] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.371404] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.371417] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.371444] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.371456] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.371918] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.372102] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.372114] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.372140] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.372599] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.372783] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.372795] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.372821] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.378063] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.378249] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.378261] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.378286] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.378750] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint machine # [ 0.378933] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.378945] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.378971] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.379420] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint machine # [ 0.379601] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] machine # [ 0.379613] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.379639] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.380088] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint machine # [ 0.380270] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.380281] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.380306] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.380318] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] machine # [ 0.380809] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint machine # [ 0.380994] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.381020] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.381556] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint machine # [ 0.381741] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.381767] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.382161] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint machine # [ 0.382344] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] machine # [ 0.382593] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint machine # [ 0.382872] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] machine # [ 0.382885] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.382911] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.383393] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint machine # [ 0.383574] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] machine # [ 0.383585] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] machine # [ 0.383611] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] machine # [ 0.384182] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned machine # [ 0.384188] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned machine # [ 0.384192] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned machine # [ 0.384235] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned machine # [ 0.384276] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned machine # [ 0.384319] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned machine # [ 0.384361] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned machine # [ 0.384403] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned machine # [ 0.384446] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned machine # [ 0.384488] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned machine # [ 0.384530] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned machine # [ 0.384573] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned machine # [ 0.384628] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned machine # [ 0.384670] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned machine # [ 0.384687] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned machine # [ 0.384705] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned machine # [ 0.384722] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned machine # [ 0.384739] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned machine # [ 0.384759] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned machine # [ 0.384777] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned machine # [ 0.384795] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned machine # [ 0.384813] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned machine # [ 0.384830] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned machine # [ 0.384849] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned machine # [ 0.384867] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned machine # [ 0.384884] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned machine # [ 0.384902] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned machine # [ 0.384918] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned machine # [ 0.384935] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned machine # [ 0.384952] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned machine # [ 0.384970] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned machine # [ 0.384987] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned machine # [ 0.385005] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned machine # [ 0.385022] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned machine # [ 0.385044] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] machine # [ 0.385049] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] machine # [ 0.385051] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] machine # [ 0.474362] pci 0000:00:0a.0: enabling device (0000 -> 0002) machine # [ 0.499000] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) machine # [ 0.501073] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) machine # [ 0.512544] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) machine # [ 0.515383] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) machine # [ 0.525475] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) machine # [ 0.527545] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) machine # [ 0.531233] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) machine # [ 0.534415] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) machine # [ 0.537026] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) machine # [ 0.546831] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) machine # [ 0.561520] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) machine # [ 0.567290] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled machine # [ 0.568969] msm_serial: driver initialized machine # [ 0.569100] SuperH (H)SCI(F) driver initialized machine # [ 0.569155] STM32 USART driver initialized machine # [ 0.607180] loop: module loaded machine # [ 0.607350] virtio_blk virtio5: 1/0/0 default/read/poll queues machine # [ 0.608102] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) machine # [ 0.617390] megasas: 07.734.00.00-rc1 machine # [ 0.618272] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] machine # [ 0.620276] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.620291] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.625625] Using buffer write method machine # [ 0.625680] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] machine # [ 0.627537] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 machine # [ 0.627550] Intel/Sharp Extended Query Table at 0x0031 machine # [ 0.637806] Using buffer write method machine # [ 0.637821] Concatenating MTD devices: machine # [ 0.637824] (0): "0.flash" machine # [ 0.637826] (1): "0.flash" machine # [ 0.637828] into device "0.flash" machine # [ 0.864513] Freeing initrd memory: 25352K machine # [ 0.870617] tun: Universal TUN/TAP device driver, 1.6 machine # [ 0.874432] thunder_xcv, ver 1.0 machine # [ 0.874457] thunder_bgx, ver 1.0 machine # [ 0.874476] nicpf, ver 1.0 machine # [ 0.875033] e1000: Intel(R) PRO/1000 Network Driver machine # [ 0.875037] e1000: Copyright (c) 1999-2006 Intel Corporation. machine # [ 0.875060] e1000e: Intel(R) PRO/1000 Network Driver machine # [ 0.875069] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. machine # [ 0.875097] igb: Intel(R) Gigabit Ethernet Network Driver machine # [ 0.875101] igb: Copyright (c) 2007-2014 Intel Corporation. machine # [ 0.875121] igbvf: Intel(R) Gigabit Virtual Function Network Driver machine # [ 0.875125] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. machine # [ 0.875265] sky2: driver version 1.30 machine # [ 0.876902] usbcore: registered new interface driver usb-storage machine # [ 0.876995] usbcore: registered new interface driver usbserial_generic machine # [ 0.877006] usbserial: USB Serial support registered for generic machine # [ 0.887532] ehci-pci 0000:00:0a.0: EHCI Host Controller machine # [ 0.887553] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 machine # [ 0.887711] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 machine # [ 0.888176] hv_vmbus: registering driver hyperv_keyboard machine # [ 0.889070] rtc-pl031 9010000.pl031: registered as rtc0 machine # [ 0.889091] rtc-pl031 9010000.pl031: setting system clock to 2026-10-22T07:55:41 UTC (1792655741) machine # [ 0.894254] i2c_dev: i2c /dev entries driver machine # [ 0.897318] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 machine # [ 0.897669] hub 1-0:1.0: USB hub found machine # [ 0.897732] hub 1-0:1.0: 6 ports detected machine # [ 0.900524] sdhci: Secure Digital Host Controller Interface driver machine # [ 0.900529] sdhci: Copyright(c) Pierre Ossman machine # [ 0.900805] Synopsys Designware Multimedia Card Interface Driver machine # [ 0.901190] sdhci-pltfm: SDHCI platform and OF driver helper machine # [ 0.905637] hid: raw HID events driver (C) Jiri Kosina machine # [ 0.905870] usbcore: registered new interface driver usbhid machine # [ 0.905874] usbhid: USB HID core driver machine # [ 0.907012] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available machine # [ 0.908553] drop_monitor: Initializing network drop monitor service machine # [ 0.908711] NET: Registered PF_INET6 protocol family machine # [ 0.909222] Segment Routing with IPv6 machine # [ 0.909237] In-situ OAM (IOAM) with IPv6 machine # [ 0.909261] NET: Registered PF_PACKET protocol family machine # [ 0.915368] 9pnet: Installing 9P2000 support machine # [ 0.918053] Key type dns_resolver registered machine # [ 0.924651] registered taskstats version 1 machine # [ 0.924806] Loading compiled-in X.509 certificates machine # [ 0.933384] Demotion targets for Node 0: null machine # [ 0.933492] Key type .fscrypt registered machine # [ 0.933495] Key type fscrypt-provisioning registered machine # [ 0.933588] ima: No TPM chip found, activating TPM-bypass! machine # [ 0.933604] ima: Allocated hash algorithm: sha1 machine # [ 0.933623] ima: No architecture policies found machine # [ 0.934177] input: gpio-keys as /devices/platform/gpio-keys/input/input0 machine # [ 0.955091] clk: Disabling unused clocks machine # [ 0.955104] PM: genpd: Disabling unused power domains machine # [ 0.959359] Freeing unused kernel memory: 4736K machine # [ 0.959571] Run /init as init process machine # [ 0.975594] systemd[1]: Successfully made /usr/ read-only. machine # [ 1.145320] usb 1-1: new high-speed USB device number 2 using ehci-pci machine # [ 1.294943] 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/input1 machine # [ 1.309583] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) machine # [ 1.309606] systemd[1]: Detected virtualization qemu. machine # [ 1.309647] systemd[1]: Detected architecture arm64. machine # [ 1.309656] systemd[1]: Running in initrd. machine # [ 1.310334] systemd[1]: Initializing machine ID from random generator. machine # [ 1.310482] systemd[1]: Hostname set to . machine # [ 1.381657] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 machine # [ 1.407390] systemd[1]: Queued start job for default target Initrd Default Target. machine # [ 1.415065] systemd[1]: Created slice Slice /system/modprobe. machine # [ 1.415223] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 1.415247] systemd[1]: Expecting device /dev/disk/by-label/nixos... machine # [ 1.415265] systemd[1]: Reached target Path Units. machine # [ 1.415278] systemd[1]: Reached target Slice Units. machine # [ 1.415291] systemd[1]: Reached target Swaps. machine # [ 1.415303] systemd[1]: Reached target Timer Units. machine # [ 1.415415] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 1.415552] systemd[1]: Listening on Journal Socket (/dev/log). machine # [ 1.415709] systemd[1]: Listening on Journal Sockets. machine # [ 1.415810] systemd[1]: Listening on udev Control Socket. machine # [ 1.415872] systemd[1]: Listening on udev Kernel Socket. machine # [ 1.415885] systemd[1]: Reached target Socket Units. machine # [ 1.417050] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 1.430396] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 1.430462] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 1.439472] systemd[1]: Mounting Kernel Configuration File System... machine # [ 1.446658] systemd[1]: Starting Journal Service... machine # [ 1.473522] systemd[1]: Starting Load Kernel Modules... machine # [ 1.473586] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 1.474758] systemd[1]: Starting Coldplug All udev Devices... machine # [ 1.487421] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 1.488260] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 1.495750] systemd-journald[73]: Collecting audit messages is disabled. machine # [ 1.498079] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 1.498384] systemd[1]: Mounted Kernel Configuration File System. machine # [ 1.501789] usb 1-2: new high-speed USB device number 3 using ehci-pci machine # [ 1.514076] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 1.550957] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. machine # [ 1.551736] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 1.553201] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 1.569880] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev machine # [ 1.586906] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 machine # [ 1.587134] [drm] features: -virgl +edid -resource_blob -host_visible machine # [ 1.587137] [drm] features: -context_init machine # [ 1.587827] [drm] number of scanouts: 1 machine # [ 1.587838] [drm] number of cap sets: 0 machine # [ 1.597662] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic machine # [ 1.597669] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 machine # [ 1.613941] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 1.614302] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 1.614324] systemd[1]: Reached target Local File Systems. machine # [ 1.621791] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 1.633660] Console: switching to colour frame buffer device 160x50 machine # [ 1.649929] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device machine # [ 1.659564] 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/input2 machine # [ 1.659783] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 machine # [ 1.673927] systemd[1]: Finished Load Kernel Modules. machine # [ 1.679043] systemd[1]: Starting Apply Kernel Variables... machine # [ 1.692360] systemd-modules-load[74]: Inserted module 'dm_mod' machine # [ 1.693484] systemd-modules-load[74]: Module 'virtio_balloon' is built in machine # [ 1.694596] systemd-modules-load[74]: Module 'virtio_console' is built in machine # [ 1.695672] systemd-modules-load[74]: Inserted module 'virtio_gpu' machine # [ 1.714189] systemd[1]: Started Journal Service. machine # [ 1.709326] systemd-modules-load[74]: Module 'virtio_rng' is built in machine # [ 1.710688] systemd-udevd[81]: Using default interface naming scheme 'v260'. machine # [ 1.711852] systemd[1]: Starting Create System Files and Directories... machine # [ 1.730436] systemd[1]: Finished Apply Kernel Variables. machine # [ 1.761991] systemd[1]: Finished Create System Files and Directories. machine # [ 1.768402] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 1.846408] systemd[1]: Starting Virtual Console Setup... machine # [ 1.924453] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 1.928255] systemd[1]: Finished Virtual Console Setup. machine # [ 2.616281] systemd[1]: Finished Coldplug All udev Devices. machine # [ 2.617251] systemd[1]: Reached target System Initialization. machine # [ 2.620114] systemd[1]: Reached target Basic System. machine # [ 2.763242] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.791673] (udev-worker)[100]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 2.796623] (udev-worker)[100]: Network interface NamePolicy= disabled on kernel command line. machine # [ 2.851562] systemd[1]: Found device /dev/disk/by-label/nixos. machine # [ 2.853533] systemd[1]: Reached target Initrd Root Device. machine # [ 2.856929] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... machine # [ 2.903075] systemd-fsck[113]: nixos: clean, 242/65536 files, 17372/262144 blocks machine # [ 2.910573] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. machine # [ 2.915284] systemd[1]: Mounting /sysroot... machine # [ 2.970690] EXT4-fs (vda): mounted filesystem 2c5979d5-a958-4bee-8946-3d54988705f4 r/w with ordered data mode. Quota mode: none. machine # [ 2.959036] systemd[1]: Mounted /sysroot. machine # [ 2.961526] systemd[1]: Reached target Initrd Root File System. machine # [ 2.972113] systemd[1]: Starting Mountpoints Configured in the Real Root... machine # [ 2.991263] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload. machine # [ 2.998486] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)... machine # [ 3.004113] systemd[1]: Reloading... machine # [ 3.235714] systemd[1]: Reloading finished in 233 ms. machine # [ 3.254656] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace... machine # [ 3.258496] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace... machine # [ 3.264251] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 3.274225] systemd[1]: initrd-parse-etc.service: Deactivated successfully. machine # [ 3.276269] systemd[1]: Finished Mountpoints Configured in the Real Root. machine # [ 3.277920] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. machine # [ 3.297889] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 3.299335] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 3.461042] systemd[1]: Mounting /sysroot/nix/.ro-store... machine # [ 3.479541] systemd[1]: Mounting /sysroot/nix/.rw-store... machine # [ 3.483944] systemd[1]: Mounting /sysroot/run... machine # [ 3.498543] systemd[1]: Mounting /sysroot/tmp/shared... machine # [ 3.517863] systemd[1]: Mounting /sysroot/tmp/xchg... machine # [ 3.542947] systemd[1]: Mounted /sysroot/nix/.rw-store. machine # [ 3.563966] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 3.575845] systemd[1]: Mounted /sysroot/nix/.ro-store. machine # [ 3.578497] systemd[1]: Mounted /sysroot/run. machine # [ 3.585833] systemd[1]: Mounted /sysroot/tmp/shared. machine # [ 3.590013] systemd[1]: Mounted /sysroot/tmp/xchg. machine # [ 3.606790] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 3.608295] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.214054] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/lib/udev/mtd_probe": No such file or directory machine # [ 4.220239] (udev-worker)[95]: mtd0ro: /nix/store/jnsrd8c9vfdwv114xnkryg2ng2nsrcn0-systemd-260.5/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 directory machine # [ 4.241724] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.244767] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.245868] systemd[1]: Stopping Virtual Console Setup... machine # [ 4.248364] systemd[1]: Starting Virtual Console Setup... machine # [ 4.279976] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 4.282826] systemd[1]: Finished Virtual Console Setup. machine # [ 4.461938] systemd[1]: Mounting /sysroot/nix/store... machine # [ 4.501137] systemd[1]: Mounted /sysroot/nix/store. machine # [ 4.505450] systemd[1]: Mounting /sysroot/var/lib/sops-nix... machine # [ 4.516359] systemd[1]: Starting Find NixOS closure... machine # [ 4.546645] systemd[1]: Mounted /sysroot/var/lib/sops-nix. machine # [ 4.552264] systemd[1]: Reached target Initrd File Systems. machine # [ 4.560243] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... machine # [ 4.577073] systemd[1]: Finished Find NixOS closure. machine # [ 4.583708] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. machine # [ 4.587111] systemd[1]: Reached target Initrd Default Target. machine # [ 4.592529] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... machine # [ 4.613697] systemd[1]: Stopped target Initrd Default Target. machine # [ 4.615324] systemd[1]: Stopped target Basic System. machine # [ 4.620475] systemd[1]: Stopped target Initrd Root Device. machine # [ 4.621445] systemd[1]: Stopped target Path Units. machine # [ 4.622253] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. machine # [ 4.623488] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. machine # [ 4.626858] systemd[1]: Stopped target Slice Units. machine # [ 4.632219] systemd[1]: Stopped target Socket Units. machine # [ 4.633096] systemd[1]: Stopped target System Initialization. machine # [ 4.634023] systemd[1]: Stopped target Swaps. machine # [ 4.634756] systemd[1]: Stopped target Timer Units. machine # [ 4.635544] systemd[1]: dbus.socket: Deactivated successfully. machine # [ 4.641312] systemd[1]: Closed D-Bus System Message Bus Socket. machine # [ 4.644839] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. machine # [ 4.651662] systemd[1]: Stopped Find NixOS closure. machine # [ 4.652703] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 4.653588] systemd[1]: Starting rw-sysroot-nix-store.service... machine # [ 4.654439] systemd[1]: systemd-sysctl.service: Deactivated successfully. machine # [ 4.655373] systemd[1]: Stopped Apply Kernel Variables. machine # [ 4.660291] systemd[1]: systemd-modules-load.service: Deactivated successfully. machine # [ 4.661524] systemd[1]: Stopped Load Kernel Modules. machine # [ 4.663284] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. machine # [ 4.675724] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. machine # [ 4.678231] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. machine # [ 4.679412] systemd[1]: Stopped Create System Files and Directories. machine # [ 4.683986] systemd[1]: Stopped target Local File Systems. machine # [ 4.685185] systemd[1]: Stopped target Preparation for Local File Systems. machine # [ 4.688240] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. machine # [ 4.689755] systemd[1]: Stopped Coldplug All udev Devices. machine # [ 4.691547] systemd[1]: Stopping Rule-based Manager for Device Events and Files... machine # [ 4.696345] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. machine # [ 4.697463] systemd[1]: Stopped Virtual Console Setup. machine # [ 4.698813] systemd[1]: systemd-udevd.service: Deactivated successfully. machine # [ 4.700561] systemd[1]: Stopped Rule-based Manager for Device Events and Files. machine # [ 4.701691] systemd[1]: systemd-udevd.service: Consumed 1.535s CPU time over 3.076s wall clock time, 22.9M memory peak. machine # [ 4.703150] systemd[1]: initrd-cleanup.service: Deactivated successfully. machine # [ 4.704249] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. machine # [ 4.705183] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 4.706200] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 4.707063] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. machine # [ 4.712311] systemd[1]: Finished rw-sysroot-nix-store.service. machine # [ 4.716182] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. machine # [ 4.717504] systemd[1]: Closed udev Control Socket. machine # [ 4.718260] systemd[1]: Starting Cleanup udev Database... machine # [ 4.720273] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. machine # [ 4.724192] systemd[1]: Stopped Create Static Device Nodes in /dev. machine # [ 4.725114] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. machine # [ 4.726257] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. machine # [ 4.732358] systemd[1]: kmod-static-nodes.service: Deactivated successfully. machine # [ 4.733412] systemd[1]: Stopped Create List of Static Device Nodes. machine # [ 4.755115] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. machine # [ 4.756334] systemd[1]: Finished Cleanup udev Database. machine # [ 4.757104] systemd[1]: Reached target Switch Root. machine # [ 4.760582] systemd[1]: Starting NixOS Activation... machine # [ 4.884927] initrd-nixos-activation-start[182]: booting system configuration /nix/store/f8nhz0rflpznxxwmb9lrm71x46ay5nhi-nixos-system-machine-test machine # [ 4.936191] initrd-nixos-activation-start[182]: running activation script... machine # [ 5.052574] initrd-nixos-activation-start[205]: setting up /etc... machine # [ 5.350460] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. machine # [ 5.353412] systemd[1]: Finished NixOS Activation. machine # [ 5.354626] systemd[1]: Starting Switch Root... machine # [ 5.378117] systemd[1]: Switching root. machine # [ 5.446466] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). machine # [ 5.968844] systemd[1]: systemd 260.5 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -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) machine # [ 5.968904] systemd[1]: Detected virtualization qemu. machine # [ 5.968955] systemd[1]: Detected architecture arm64. machine # [ 6.245738] systemd[1]: bpf-restrict-fs: LSM BPF program attached machine # [ 6.845435] systemd[1]: initrd-switch-root.service: Deactivated successfully. machine # [ 6.845816] systemd[1]: Stopped initrd-switch-root.service. machine # [ 6.847184] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. machine # [ 6.848193] systemd[1]: Created slice Slice /system/getty. machine # [ 6.848875] systemd[1]: Created slice User and Session Slice. machine # [ 6.848996] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. machine # [ 6.849127] systemd[1]: Started Forward Password Requests to Wall Directory Watch. machine # [ 6.849158] systemd[1]: Expecting device /dev/hvc0... machine # [ 6.849172] systemd[1]: Expecting device /dev/ttyAMA0... machine # [ 6.849198] systemd[1]: Reached target Local Encrypted Volumes. machine # [ 6.849221] systemd[1]: Stopped target initrd-fs.target. machine # [ 6.860013] systemd[1]: Stopped target initrd-root-fs.target. machine # [ 6.860455] systemd[1]: Stopped target initrd-switch-root.target. machine # [ 6.861100] systemd[1]: Reached target Virtual Machines and Containers. machine # [ 6.864474] systemd[1]: Reached target Path Units. machine # [ 6.864863] systemd[1]: Reached target Remote File Systems. machine # [ 6.867194] systemd[1]: Reached target Slice Units. machine # [ 6.867577] systemd[1]: Reached target Swaps. machine # [ 6.872062] systemd[1]: Listening on Process Core Dump Socket. machine # [ 6.875280] systemd[1]: Listening on Credential Encryption/Decryption. machine # [ 6.875958] systemd[1]: Listening on Journal Audit Socket. machine # [ 6.876549] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. machine # [ 6.876943] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 6.881726] systemd[1]: Listening on udev Control Socket. machine # [ 6.884444] systemd[1]: Mounting Huge Pages File System... machine # [ 6.889020] systemd[1]: Mounting POSIX Message Queue File System... machine # [ 6.897458] systemd[1]: Mounting Kernel Debug File System... machine # [ 6.905195] systemd[1]: Mounting Kernel Trace File System... machine # [ 6.918514] systemd[1]: Starting Create List of Static Device Nodes... machine # [ 6.931113] systemd[1]: Starting Load Kernel Module 9pnet_virtio... machine # [ 6.931740] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 6.947358] systemd[1]: Mounting Kernel Configuration File System... machine # [ 6.949166] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm machine # [ 6.958642] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore machine # [ 7.009890] systemd[1]: Starting Load Kernel Module fuse... machine # [ 7.031995] systemd[1]: Starting sops-install-secrets-for-users.service... machine # [ 7.032940] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 machine # [ 7.058629] systemd[1]: Starting Journal Service... machine # [ 7.076323] systemd[1]: Starting Load Kernel Modules... machine # [ 7.095072] fuse: init (API version 7.45) machine # [ 7.100130] systemd[1]: Starting Remount Root and Kernel File Systems... machine # [ 7.104348] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.129360] systemd[1]: Starting Coldplug All udev Devices... machine # [ 7.136611] systemd[1]: Mounted Huge Pages File System. machine # [ 7.144231] systemd-journald[270]: Collecting audit messages is enabled. machine # [ 7.145069] systemd[1]: Mounted POSIX Message Queue File System. machine # [ 7.154695] systemd[1]: Mounted Kernel Debug File System. machine # [ 7.149621] systemd[1]: Queued start job for default target Multi-User System. machine # [ 7.151475] systemd[1]: systemd-journald.service: Deactivated successfully. machine # [ 7.179735] systemd[1]: Started Journal Service. machine # [ 7.168121] systemd[1]: Mounted Kernel Trace File System. machine # [ 7.173334] systemd[1]: Finished Create List of Static Device Nodes. machine # [ 7.180252] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. machine # [ 7.186716] systemd[1]: Finished Load Kernel Module 9pnet_virtio. machine # [ 7.190236] systemd[1]: Mounted Kernel Configuration File System. machine # [ 7.209910] EXT4-fs (vda): re-mounted 2c5979d5-a958-4bee-8946-3d54988705f4. machine # [ 7.194975] systemd[1]: modprobe@fuse.service: Deactivated successfully. machine # [ 7.203878] systemd[1]: Finished Load Kernel Module fuse. machine # [ 7.207267] systemd-modules-load[271]: Module 'atkbd' is built in machine # [ 7.212932] systemd-modules-load[271]: Module 'loop' is built in machine # [ 7.217068] systemd[1]: Finished Load Kernel Modules. machine # [ 7.218715] systemd[1]: Finished Remount Root and Kernel File Systems. machine # [ 7.238178] systemd[1]: Mounting FUSE Control File System... machine # [ 7.247109] systemd[1]: Starting Firewall... machine # [ 7.258319] systemd[1]: Starting Flush Journal to Persistent Storage... machine # [ 7.259516] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore machine # [ 7.291890] systemd[1]: Starting Load/Save OS Random Seed... machine # [ 7.320310] systemd[1]: Starting Apply Kernel Variables... machine # [ 7.346228] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... machine # [ 7.348117] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki machine # [ 7.434898] systemd-journald[270]: Received client request to flush runtime journal. machine # [ 7.540108] systemd[1]: Finished Load/Save OS Random Seed. machine # [ 7.548708] systemd[1]: First Boot Complete skipped, unmet condition check ConditionFirstBoot=yes machine # [ 7.554265] systemd[1]: Mounted FUSE Control File System. machine # [ 7.561851] systemd[1]: Finished Flush Journal to Persistent Storage. machine # [ 7.568223] systemd[1]: Finished Apply Kernel Variables. machine # [ 7.600238] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. machine # [ 7.739668] systemd[1]: Finished sops-install-secrets-for-users.service. machine # [ 7.746144] systemd[1]: Starting Manage Users and Groups... machine # [ 7.797902] umount[321]: umount: /etc/group: not mounted. machine # [ 7.855679] umount[329]: umount: /etc/passwd: not mounted. machine # [ 7.905954] umount[336]: umount: /etc/shadow: not mounted. machine # [ 8.149666] systemd[1]: Finished Manage Users and Groups. machine # [ 8.159608] systemd[1]: Starting Journal Log Access Socket... machine # [ 8.172237] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... machine # [ 8.182971] systemd[1]: Starting Create Static Device Nodes in /dev... machine # [ 8.192645] systemd[1]: Listening on Journal Log Access Socket. machine # [ 8.331389] systemd-oomd[374]: No swap; memory pressure usage will be degraded machine # [ 8.337444] systemd[1]: Finished Create Static Device Nodes in /dev. machine # [ 8.345403] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. machine # [ 8.346900] systemd[1]: Reached target Preparation for Local File Systems. machine # [ 8.349996] systemd[1]: Starting Rule-based Manager for Device Events and Files... machine # [ 8.465607] systemd-udevd[384]: Using default interface naming scheme 'v260'. machine # [ 8.627846] systemd[1]: Started Rule-based Manager for Device Events and Files. machine # [ 8.842140] systemd[1]: Mounting /run/wrappers... machine # [ 8.913693] systemd[1]: Mounted /run/wrappers. machine # [ 8.914590] systemd[1]: Reached target Local File Systems. machine # [ 8.926656] systemd[1]: Listening on Boot Loader Control Service Socket. machine # [ 8.935458] systemd[1]: Starting register-nix-paths.service... machine # [ 8.942805] systemd[1]: Starting Create SUID/SGID Wrappers... machine # [ 8.948249] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. machine # [ 8.949537] systemd[1]: Save Transient machine-id to Disk skipped, unmet condition check ConditionPathIsMountPoint=/etc/machine-id machine # [ 8.957646] systemd[1]: Starting Create System Files and Directories... machine # [ 9.008957] systemd[1]: Finished Firewall. machine # [ 9.211020] systemd[1]: Finished Create System Files and Directories. machine # [ 9.212336] systemd[1]: Rebuild Journal Catalog skipped, unmet condition check ConditionNeedsUpdate=/var machine # [ 9.216943] systemd[1]: Update is Completed skipped, no trigger condition checks were met. machine # [ 9.226719] systemd[1]: Starting Record System Boot/Shutdown in UTMP... machine # [ 9.300379] systemd[1]: Finished Coldplug All udev Devices. machine # [ 9.329482] systemd[1]: Finished Record System Boot/Shutdown in UTMP. machine # [ 9.466332] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs machine # [ 9.708144] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. machine # [ 9.713016] systemd[1]: Finished Create SUID/SGID Wrappers. machine # [ 9.762429] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. machine # [ 9.814162] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. machine # [ 9.838868] systemd[1]: Finished register-nix-paths.service. machine # [ 9.840249] systemd[1]: Reached target System Initialization. machine # [ 9.844145] systemd[1]: Started Discard unused filesystem blocks once a week. machine # [ 9.846481] systemd[1]: Started Daily Cleanup of Temporary Directories. machine # [ 9.849886] systemd[1]: Reached target Timer Units. machine # [ 9.852709] systemd[1]: Listening on D-Bus System Message Bus Socket. machine # [ 9.855442] systemd[1]: Listening on Nix Daemon Socket. machine # [ 9.859801] systemd[1]: Listening on Hostname Service Socket. machine # [ 9.862338] systemd[1]: Reached target Socket Units. machine # [ 9.866109] systemd[1]: Reached target Basic System. machine # [ 9.868102] systemd[1]: Started backdoor.service. machine # [ 9.869778] systemd[1]: Import lastlog data into lastlog2 database skipped, unmet condition check ConditionPathExists=!/var/lib/lastlog/lastlog2.db machine # [ 9.877941] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 9.880183] systemd[1]: Starting Post-Boot Actions... machine # [ 9.892206] systemd[1]: Started Reset console on configuration changes. machine # [ 9.912314] systemd[1]: Starting resolvconf update... machine # [ 9.964383] systemd[1]: Starting D-Bus System Message Bus... machine # [ 9.992503] systemd[1]: Finished Post-Boot Actions. machine # connecting to host... machine # [ 10.024922] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.026169] nsncd[505]: Oct 22 07:55:50.652 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.041084] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.048288] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.049195] systemd[1]: Starting User Login Management... machine: Guest shell says: b'Spawning backdoor root shell...\n' machine: connected to guest root shell machine: (connecting took 10.36 seconds) machine: (finished: waiting for the VM to finish booting, in 10.36 seconds) machine # [ 10.185068] dbus-broker-launch[510]: Looking up NSS user entry for 'systemd-timesync'... machine # [ 10.251144] systemd-logind[527]: New seat seat0. machine # [ 10.283265] systemd[1]: Started User Login Management. machine # [ 10.290566] dbus-broker-launch[510]: NSS returned no entry for 'systemd-timesync' machine # [ 10.291658] dbus-broker-launch[510]: Invalid user-name in /nix/store/4rrxzk34h7nj1h722k3xx67s8cb869qz-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" machine # [ 10.307279] systemd[1]: Starting linger-users.service... machine # [ 10.343915] systemd[1]: Started D-Bus System Message Bus. machine # [ 10.350595] systemd[1]: Stopped target Host and Network Name Lookups. machine # [ 10.361285] systemd[1]: Stopping Host and Network Name Lookups... machine # [ 10.362260] systemd[1]: Stopped target User and Group Name Lookups. machine # [ 10.363140] systemd[1]: Stopping User and Group Name Lookups... machine # [ 10.363957] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... machine # [ 10.382120] systemd[1]: nscd.service: Deactivated successfully. machine # [ 10.382989] systemd[1]: Stopped Name Service Cache Daemon (nsncd). machine # [ 10.404981] dbus-broker-launch[510]: Ready machine # [ 10.405687] systemd[1]: Starting Name Service Cache Daemon (nsncd)... machine # [ 10.418955] systemd[1]: linger-users.service: Deactivated successfully. machine # [ 10.426899] (udev-worker)[410]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.432169] systemd[1]: Finished linger-users.service. machine # [ 10.437033] (udev-worker)[407]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. machine # [ 10.439175] (udev-worker)[407]: Network interface NamePolicy= disabled on kernel command line. machine # [ 10.502520] systemd[1]: Started Name Service Cache Daemon (nsncd). machine # [ 10.507773] nsncd[583]: Oct 22 07:55:51.129 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" machine # [ 10.513967] systemd[1]: Reached target Host and Network Name Lookups. machine # [ 10.514898] systemd[1]: Reached target User and Group Name Lookups. machine # [ 10.527446] systemd[1]: Finished resolvconf update. machine # [ 10.531244] systemd[1]: Reached target Preparation for Network. machine # [ 10.535125] systemd[1]: Starting DHCP Client... machine # [ 10.541776] systemd[1]: Starting Extra networking commands.... machine # [ 10.697221] systemd-logind[527]: Watching system buttons on /dev/input/event0 (gpio-keys) machine # [ 10.759238] dhcpcd[620]: dhcpcd-10.3.1 starting machine # [ 10.772779] dhcpcd[652]: dev: loaded udev machine # [ 10.776914] dhcpcd[652]: DUID 00:01:00:01:32:6c:7d:f2:52:54:00:12:34:56 machine # [ 10.795778] systemd[1]: Condition check resulted in Virtio network device being skipped. machine # [ 10.805603] systemd[1]: Starting Address configuration of eth1... machine # [ 10.841051] 8021q: 802.1Q VLAN Support v1.8 machine # [ 10.869055] systemd[1]: Finished Extra networking commands.. machine # [ 10.876329] systemd[1]: Reached target Network. machine # [ 10.882349] systemd[1]: Starting Permit User Sessions... machine # [ 10.947601] 8021q: adding VLAN 0 to HW filter on device eth1 machine # [ 10.973132] network-addresses-eth1-start[663]: adding address 192.168.1.1/24... done machine # [ 10.979729] systemd[1]: Finished Permit User Sessions. machine # [ 10.987589] systemd[1]: Started Getty on tty1.[ 11.003506] cfg80211: Loading compiled-in X.509 certificates for regulatory database machine # machine # [ 10.990691] systemd[1]: Reached target Login Prompts. machine # [ 11.005213] network-addresses-eth1-start[663]: adding address 2001:db8:1::1/64... done machine # [ 11.027010] systemd[1]: Finished Address configuration of eth1. machine # [ 11.045564] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' machine # [ 11.046034] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' machine # [ 11.048276] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 machine # [ 11.048579] cfg80211: failed to load regulatory.db machine # [ 11.063349] mousedev: PS/2 mouse device common for all mice machine # [ 11.126709] 8021q: adding VLAN 0 to HW filter on device eth0 machine # [ 11.110717] dhcpcd[652]: eth0: waiting for carrier machine # [ 11.113667] dhcpcd[652]: eth0: waiting for carrier machine # [ 11.116993] dhcpcd[652]: eth0: carrier acquired machine # [ 11.129055] dhcpcd[652]: eth0: IAID 00:12:34:56 machine # [ 11.129791] dhcpcd[652]: eth0: adding address fe80::5054:ff:fe12:3456 machine # [ 11.199230] systemd-logind[527]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) machine # [ 11.968003] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 machine # [ 12.049056] dhcpcd[652]: eth0: rebinding lease of 10.0.2.15 machine # [ 12.064541] dhcpcd[652]: eth0: probing address 10.0.2.15/24 machine # [ 12.273323] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. machine # [ 12.308408] systemd[1]: Starting Virtual Console Setup... machine # [ 12.365961] systemd-logind[527]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) machine # [ 12.617273] systemd-vconsole-setup[722]: Configuration of first virtual console was skipped, ignoring remaining ones. machine # [ 12.625135] systemd[1]: Finished Virtual Console Setup. machine # [ 12.816000] dhcpcd[652]: eth0: soliciting an IPv6 router machine # [ 12.818058] dhcpcd[652]: eth0: Router Advertisement from fe80::2 machine # [ 12.819397] dhcpcd[652]: eth0: adding address fec0::5054:ff:fe12:3456/64 machine # [ 12.820934] dhcpcd[652]: eth0: adding route to fec0::/64 machine # [ 12.822093] dhcpcd[652]: eth0: adding default route via fe80::2 machine # [ 17.564167] dhcpcd[652]: eth0: leased 10.0.2.15 for 86400 seconds machine # [ 17.566055] dhcpcd[652]: eth0: adding route to 10.0.2.0/24 machine # [ 17.567302] dhcpcd[652]: eth0: adding default route via 10.0.2.2 machine # [ 17.720691] systemd[1]: Started DHCP Client. machine # [ 17.722693] systemd[1]: Reached target Multi-User System. machine # [ 17.723521] systemd[1]: Startup finished in 947ms (kernel) + 4.570s (initrd) + 12.204s (userspace) = 17.722s. machine: (finished: waiting for unit multi-user.target, in 18.29 seconds) machine: must succeed: getent shadow example-user | grep -q :test_value: machine: (finished: must succeed: getent shadow example-user | grep -q :test_value:, in 0.03 seconds) machine: must succeed: journalctl -b -1 --no-pager -o cat _PID=1 machine: (finished: must succeed: journalctl -b -1 --no-pager -o cat _PID=1, in 0.03 seconds) (finished: run the VM test script, in 41.94 seconds) test script finished in 41.98s cleanup kill QemuMachine (pid 45) machine # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/q1khrhbn506imjxx7kiqcbihycawa6kl-python3-3.13.15/bin/python3.13) (finished: cleanup, in 0.16 seconds)