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 600.0 seconds run the VM test script start all VMs host1: starting vm server: starting vm host1 # Disk image does not exist, creating the virtualisation disk image... host1: QEMU running (pid 47) host1 # Formatting '/build/vm-state-host1/tmp.GKYx7YvHro', fmt=raw size=1073741824 host1 # mke2fs 1.47.4 (6-Mar-2025) host1 # Discarding device blocks: 0/262144 done host1 # Creating filesystem with 262144 4k blocks and 65536 inodes host1 # Filesystem UUID: 76f121dd-7a6a-417a-aeb1-52a73737f101 host1 # Superblock backups stored on blocks: host1 # 32768, 98304, 163840, 229376 host1 # host1 # Allocating group tables: 0/8 done host1 # Writing inode tables: 0/8 done host1 # Creating journal (8192 blocks): done host1 # Writing superblocks and filesystem accounting information: 0/8 done host1 # host1 # Virtualisation disk image created. server: QEMU running (pid 48) server # Disk image does not exist, creating the virtualisation disk image... server # Formatting '/build/vm-state-server/tmp.3HFwqPUbqi', fmt=raw size=1073741824 server # mke2fs 1.47.4 (6-Mar-2025) (finished: start all VMs, in 0.64 seconds) server # Discarding device blocks: 0/262144 done server: waiting for unit step-ca.service server # Creating filesystem with 262144 4k blocks and 65536 inodes server # Filesystem UUID: 643e7b39-cab2-445c-a624-d6cc20f771b5 server # Superblock backups stored on blocks: server: waiting for the VM to finish booting server # 32768, 98304, 163840, 229376 server # server # Allocating group tables: 0/8 done server # Writing inode tables: 0/8 done server # Creating journal (8192 blocks): done server # Writing superblocks and filesystem accounting information: 0/8 done server # server # Virtualisation disk image created. host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] host1 # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 host1 # [ 0.000000] KASLR enabled host1 # [ 0.000000] random: crng init done host1 # [ 0.000000] Machine model: linux,dummy-virt host1 # [ 0.000000] efi: UEFI not found. host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f] host1 # [ 0.000000] Zone ranges: host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] DMA32 empty host1 # [ 0.000000] Normal empty host1 # [ 0.000000] Device empty host1 # [ 0.000000] Movable zone start for each node host1 # [ 0.000000] Early memory node ranges host1 # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000 host1 # [ 0.000000] psci: probing for conduit method from DT. host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware. host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs host1 # [ 0.000000] psci: Trusted OS migration not required host1 # [ 0.000000] psci: SMC Calling Convention v1.1 host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 host1 # [ 0.000000] Detected PIPT I-cache on CPU0 host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface host1 # [ 0.000000] CPU features: detected: Spectre-v4 host1 # [ 0.000000] CPU features: detected: Spectre-BHB host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 host1 # [ 0.000000] alternatives: applying boot alternatives host1 # [ 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/b7h8aacpsy3m4h4k81ssk2nsc1jyq9p9-nixos-system-host1-test/init regInfo=/nix/store/vixwllgmw6vmpqjv00a1g1hsjm685l9c-closure-info/registration console=ttyAMA0,115200n8 console=tty0 host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/vixwllgmw6vmpqjv00a1g1hsjm685l9c-closure-info/registration", will be passed to user space. host1 # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes host1 # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB host1 # [ 0.000000] software IO TLB: area num 1. host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB) host1 # [ 0.000000] Fallback order for Node 0: 0 host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288 host1 # [ 0.000000] Policy zone: DMA host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 host1 # [ 0.000000] allocated 4194304 bytes of page_ext host1 # [ 0.000000] ftrace: allocating 74885 entries in 294 pages host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups host1 # [ 0.000000] rcu: Hierarchical RCU implementation. host1 # [ 0.000000] rcu: RCU event tracing is enabled. host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled. host1 # [ 0.000000] Rude variant of Tasks RCU enabled. host1 # [ 0.000000] Tracing variant of Tasks RCU enabled. host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 host1 # [ 0.000000] GICv3: 256 SPIs implemented host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented host1 # [ 0.000000] Root IRQ handler: gic_handle_irq host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1) host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1) host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b00000 host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b10000 host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns host1 # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns host1 # [ 0.000044] arm-pv: using stolen time PV host1 # [ 0.001065] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) host1 # [ 0.001272] Console: colour dummy device 80x25 host1 # [ 0.001281] printk: legacy console [tty0] enabled host1 # [ 0.001492] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) host1 # [ 0.001500] pid_max: default: 32768 minimum: 301 host1 # [ 0.001586] LSM: initializing lsm=capability,landlock,yama,bpf,ima host1 # [ 0.001834] landlock: Up and running. host1 # [ 0.001837] Yama: becoming mindful. host1 # [ 0.002823] LSM support for eBPF active host1 # [ 0.003039] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) host1 # [ 0.003077] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) host1 # [ 0.004389] cacheinfo: Unable to detect cache hierarchy for CPU 0 host1 # [ 0.005226] rcu: Hierarchical SRCU implementation. host1 # [ 0.005231] rcu: Max phase no-delay instances is 1000. host1 # [ 0.006488] fsl-mc MSI: its@8080000 domain created host1 # [ 0.006584] EFI services will not be available. host1 # [ 0.006754] smp: Bringing up secondary CPUs ... host1 # [ 0.006764] smp: Brought up 1 node, 1 CPU host1 # [ 0.006767] SMP: Total of 1 processors activated. host1 # [ 0.006770] CPU: All CPU(s) started at EL1 host1 # [ 0.006786] CPU features: detected: Branch Target Identification host1 # [ 0.006792] CPU features: detected: ARMv8.4 Translation Table Level host1 # [ 0.006795] CPU features: detected: Instruction cache invalidation not required for I/D coherence host1 # [ 0.006798] CPU features: detected: Data cache clean to the PoU not required for I/D coherence host1 # [ 0.006802] CPU features: detected: Common not Private translations host1 # [ 0.006805] CPU features: detected: CRC32 instructions server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] host1 # [ 0.006808] CPU features: detected: Data cache clean to Point of Deep Persistence host1 # [ 0.006811] CPU features: detected: Data cache clean to Point of Persistence host1 # [ 0.006815] CPU features: detected: Data independent timing control (DIT) server # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 2026 host1 # [ 0.006818] CPU features: detected: E0PD server # [ 0.000000] KASLR enabled server # [ 0.000000] random: crng init done server # [ 0.000000] Machine model: linux,dummy-virt host1 # [ 0.006820] CPU features: detected: Enhanced Counter Virtualization server # [ 0.000000] efi: UEFI not found. host1 # [ 0.006823] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT host1 # [ 0.006827] CPU features: detected: Enhanced Virtualization Traps server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.006830] CPU features: detected: Fine Grained Traps server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f] server # [ 0.000000] Zone ranges: host1 # [ 0.006834] CPU features: detected: Generic authentication (architected QARMA5 algorithm) server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.006839] CPU features: detected: RCpc load-acquire (LDAPR) server # [ 0.000000] DMA32 empty server # [ 0.000000] Normal empty host1 # [ 0.006842] CPU features: detected: LSE atomic instructions server # [ 0.000000] Device empty host1 # [ 0.006845] CPU features: detected: Privileged Access Never server # [ 0.000000] Movable zone start for each node host1 # [ 0.006848] CPU features: detected: PMUv3 server # [ 0.000000] Early memory node ranges host1 # [ 0.006850] CPU features: detected: RAS Extension Support server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.006853] CPU features: detected: RASv1p1 Extension Support server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.006855] CPU features: detected: Random Number Generator server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000 host1 # [ 0.006858] CPU features: detected: Speculation barrier (SB) server # [ 0.000000] psci: probing for conduit method from DT. host1 # [ 0.006861] CPU features: detected: Stage-2 Force Write-Back server # [ 0.000000] psci: PSCIv1.3 detected in firmware. host1 # [ 0.006864] CPU features: detected: TLB range maintenance instructions server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs server # [ 0.000000] psci: Trusted OS migration not required host1 # [ 0.006868] CPU features: detected: Speculative Store Bypassing Safe (SSBS) server # [ 0.000000] psci: SMC Calling Convention v1.1 host1 # [ 0.006916] alternatives: applying system-wide alternatives host1 # [ 0.010140] CPU features: detected: BBM Level 2 without TLB conflict abort server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) server # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 server # [ 0.000000] Detected PIPT I-cache on CPU0 host1 # [ 0.010360] Memory: 1921620K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131976K reserved, 32768K cma-reserved) host1 # [ 0.010904] devtmpfs: initialized server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) host1 # [ 0.013050] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) server # [ 0.000000] CPU features: detected: GICv3 CPU interface server # [ 0.000000] CPU features: detected: Spectre-v4 host1 # [ 0.013076] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). server # [ 0.000000] CPU features: detected: Spectre-BHB host1 # [ 0.013319] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 host1 # [ 0.013325] 0 pages in range for non-PLT usage server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 host1 # [ 0.013326] 508288 pages in range for PLT usage server # [ 0.000000] alternatives: applying boot alternatives host1 # [ 0.013443] pinctrl core: initialized pinctrl subsystem host1 # [ 0.014466] DMI not present or invalid. host1 # [ 0.019112] NET: Registered PF_NETLINK/PF_ROUTE protocol family host1 # [ 0.022010] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations host1 # [ 0.022297] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations server # [ 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/9l9qzzlcm0wdn973d4af335dpab2qfab-nixos-system-server-test/init regInfo=/nix/store/fhp960xcgqc4d5fanwppv6ngahxmcyhr-closure-info/registration console=ttyAMA0,115200n8 console=tty0 host1 # [ 0.022522] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations host1 # [ 0.022558] audit: initializing netlink subsys (disabled) server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/fhp960xcgqc4d5fanwppv6ngahxmcyhr-closure-info/registration", will be passed to user space. host1 # [ 0.023237] thermal_sys: Registered thermal governor 'fair_share' host1 # [ 0.023239] thermal_sys: Registered thermal governor 'bang_bang' server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes host1 # [ 0.023243] thermal_sys: Registered thermal governor 'step_wise' server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) host1 # [ 0.023246] thermal_sys: Registered thermal governor 'user_space' server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) host1 # [ 0.023251] thermal_sys: Registered thermal governor 'power_allocator' server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB host1 # [ 0.023276] audit: type=2000 audit(0.020:1): state=initialized audit_enabled=0 res=1 server # [ 0.000000] software IO TLB: area num 1. host1 # [ 0.023287] cpuidle: using governor ladder host1 # [ 0.023293] cpuidle: using governor menu server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB) server # [ 0.000000] Fallback order for Node 0: 0 host1 # [ 0.023503] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. host1 # [ 0.023520] ASID allocator initialised with 65536 entries server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288 server # [ 0.000000] Policy zone: DMA host1 # [ 0.024797] Serial: AMBA PL011 UART driver server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off host1 # [ 0.030408] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 host1 # [ 0.030552] printk: console [ttyAMA0] enabled server # [ 0.000000] allocated 4194304 bytes of page_ext server # [ 0.000000] ftrace: allocating 74885 entries in 294 pages server # [ 0.000000] ftrace: allocated 294 pages with 4 groups server # [ 0.000000] rcu: Hierarchical RCU implementation. server # [ 0.000000] rcu: RCU event tracing is enabled. server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. server # [ 0.000000] Trampoline variant of Tasks RCU enabled. server # [ 0.000000] Rude variant of Tasks RCU enabled. server # [ 0.000000] Tracing variant of Tasks RCU enabled. server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.156621] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.156643] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. host1 # [ 0.156648] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 host1 # [ 0.156652] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page server # [ 0.000000] GICv3: 256 SPIs implemented server # [ 0.000000] GICv3: 0 Extended SPIs implemented host1 # [ 0.156657] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages server # [ 0.000000] Root IRQ handler: gic_handle_irq host1 # [ 0.156661] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI host1 # [ 0.156665] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 host1 # [ 0.156669] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1) host1 # [ 0.164488] fbcon: Taking over console host1 # [ 0.164508] ACPI: Interpreter disabled. server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1) server # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000 server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000 server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns host1 # [ 0.173079] iommu: Default domain type: Translated server # [ 0.000033] arm-pv: using stolen time PV host1 # [ 0.173092] iommu: DMA domain TLB invalidation policy: strict mode server # [ 0.000445] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) host1 # [ 0.174934] SCSI subsystem initialized server # [ 0.000652] Console: colour dummy device 80x25 server # [ 0.000660] printk: legacy console [tty0] enabled host1 # [ 0.175625] usbcore: registered new interface driver usbfs host1 # [ 0.175666] usbcore: registered new interface driver hub server # [ 0.000857] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) server # [ 0.000864] pid_max: default: 32768 minimum: 301 host1 # [ 0.175683] usbcore: registered new device driver usb host1 # [ 0.175999] pps_core: LinuxPPS API ver. 1 registered server # [ 0.000937] LSM: initializing lsm=capability,landlock,yama,bpf,ima server # [ 0.001093] landlock: Up and running. server # [ 0.001096] Yama: becoming mindful. host1 # [ 0.176005] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti server # [ 0.001858] LSM support for eBPF active host1 # [ 0.176015] PTP clock support registered host1 # [ 0.176067] EDAC MC: Ver: 3.0.0 server # [ 0.002134] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) host1 # [ 0.180856] scmi_core: SCMI protocol bus registered server # [ 0.002176] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) server # [ 0.003854] cacheinfo: Unable to detect cache hierarchy for CPU 0 host1 # [ 0.181922] FPGA manager framework host1 # [ 0.182910] vgaarb: loaded server # [ 0.004710] rcu: Hierarchical SRCU implementation. host1 # [ 0.183583] clocksource: Switched to clocksource arch_sys_counter server # [ 0.004715] rcu: Max phase no-delay instances is 1000. server # [ 0.005971] fsl-mc MSI: its@8080000 domain created server # [ 0.006066] EFI services will not be available. server # [ 0.006155] smp: Bringing up secondary CPUs ... server # [ 0.006164] smp: Brought up 1 node, 1 CPU server # [ 0.006167] SMP: Total of 1 processors activated. server # [ 0.006170] CPU: All CPU(s) started at EL1 server # [ 0.006186] CPU features: detected: Branch Target Identification host1 # [ 0.188304] VFS: Disk quotas dquot_6.6.0 server # [ 0.006192] CPU features: detected: ARMv8.4 Translation Table Level host1 # [ 0.188370] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) host1 # [ 0.190084] netfs: FS-Cache loaded server # [ 0.006195] CPU features: detected: Instruction cache invalidation not required for I/D coherence host1 # [ 0.190242] pnp: PnP ACPI: disabled server # [ 0.006198] CPU features: detected: Data cache clean to the PoU not required for I/D coherence server # [ 0.006202] CPU features: detected: Common not Private translations server # [ 0.006205] CPU features: detected: CRC32 instructions server # [ 0.006208] CPU features: detected: Data cache clean to Point of Deep Persistence server # [ 0.006212] CPU features: detected: Data cache clean to Point of Persistence server # [ 0.006216] CPU features: detected: Data independent timing control (DIT) host1 # [ 0.194391] NET: Registered PF_INET protocol family server # [ 0.006219] CPU features: detected: E0PD host1 # [ 0.194697] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) server # [ 0.006221] CPU features: detected: Enhanced Counter Virtualization server # [ 0.006224] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) server # [ 0.006228] CPU features: detected: Enhanced Virtualization Traps server # [ 0.006231] CPU features: detected: Fine Grained Traps server # [ 0.006235] CPU features: detected: Generic authentication (architected QARMA5 algorithm) server # [ 0.006239] CPU features: detected: RCpc load-acquire (LDAPR) server # [ 0.006242] CPU features: detected: LSE atomic instructions server # [ 0.006246] CPU features: detected: Privileged Access Never server # [ 0.006248] CPU features: detected: PMUv3 server # [ 0.006251] CPU features: detected: RAS Extension Support server # [ 0.006254] CPU features: detected: RASv1p1 Extension Support server # [ 0.006257] CPU features: detected: Random Number Generator server # [ 0.006260] CPU features: detected: Speculation barrier (SB) server # [ 0.006263] CPU features: detected: Stage-2 Force Write-Back server # [ 0.006266] CPU features: detected: TLB range maintenance instructions server # [ 0.006271] CPU features: detected: Speculative Store Bypassing Safe (SSBS) server # [ 0.006311] alternatives: applying system-wide alternatives server # [ 0.009632] CPU features: detected: BBM Level 2 without TLB conflict abort server # [ 0.009815] Memory: 1921620K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131956K reserved, 32768K cma-reserved) server # [ 0.010296] devtmpfs: initialized server # [ 0.012437] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) server # [ 0.012463] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). server # [ 0.012658] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL server # [ 0.012662] 0 pages in range for non-PLT usage server # [ 0.012663] 508288 pages in range for PLT usage server # [ 0.012789] pinctrl core: initialized pinctrl subsystem server # [ 0.013612] DMI not present or invalid. server # [ 0.017127] NET: Registered PF_NETLINK/PF_ROUTE protocol family server # [ 0.019623] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations server # [ 0.019835] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations server # [ 0.020059] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations server # [ 0.020087] audit: initializing netlink subsys (disabled) server # [ 0.020701] thermal_sys: Registered thermal governor 'fair_share' server # [ 0.020704] thermal_sys: Registered thermal governor 'bang_bang' server # [ 0.020708] thermal_sys: Registered thermal governor 'step_wise' server # [ 0.020710] thermal_sys: Registered thermal governor 'user_space' server # [ 0.020718] thermal_sys: Registered thermal governor 'power_allocator' server # [ 0.020762] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 server # [ 0.020770] cpuidle: using governor ladder server # [ 0.020776] cpuidle: using governor menu server # [ 0.020992] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. server # [ 0.021010] ASID allocator initialised with 65536 entries server # [ 0.022245] Serial: AMBA PL011 UART driver server # [ 0.027624] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 server # [ 0.027774] printk: console [ttyAMA0] enabled host1 # [ 0.226407] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) host1 # [ 0.226470] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) host1 # [ 0.226501] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) host1 # [ 0.226591] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) host1 # [ 0.226769] TCP: Hash tables configured (established 16384 bind 16384) server # [ 0.155960] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages host1 # [ 0.226886] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) server # [ 0.155986] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page host1 # [ 0.226936] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.155991] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages host1 # [ 0.226979] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.155996] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page host1 # [ 0.227075] NET: Registered PF_UNIX/PF_LOCAL protocol family server # [ 0.156000] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages host1 # [ 0.227102] NET: Registered PF_XDP protocol family server # [ 0.156004] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page host1 # [ 0.227126] PCI: CLS 0 bytes, default 64 host1 # [ 0.227408] Trying to unpack rootfs image as initramfs... server # [ 0.156009] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages server # [ 0.156013] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page server # [ 0.163824] fbcon: Taking over console server # [ 0.163843] ACPI: Interpreter disabled. server # [ 0.165743] iommu: Default domain type: Translated server # [ 0.165753] iommu: DMA domain TLB invalidation policy: strict mode server # [ 0.167485] SCSI subsystem initialized host1 # [ 0.245665] kvm [1]: HYP mode not available server # [ 0.172563] usbcore: registered new interface driver usbfs server # [ 0.172601] usbcore: registered new interface driver hub server # [ 0.172620] usbcore: registered new device driver usb server # [ 0.172906] pps_core: LinuxPPS API ver. 1 registered server # [ 0.172912] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti server # [ 0.172929] PTP clock support registered server # [ 0.172977] EDAC MC: Ver: 3.0.0 server # [ 0.177762] scmi_core: SCMI protocol bus registered server # [ 0.178794] FPGA manager framework server # [ 0.179804] vgaarb: loaded server # [ 0.180484] clocksource: Switched to clocksource arch_sys_counter server # [ 0.187224] VFS: Disk quotas dquot_6.6.0 server # [ 0.187292] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) server # [ 0.189067] netfs: FS-Cache loaded server # [ 0.189213] pnp: PnP ACPI: disabled server # [ 0.193268] NET: Registered PF_INET protocol family server # [ 0.193556] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) server # [ 0.225306] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) server # [ 0.225367] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) server # [ 0.225402] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) server # [ 0.225500] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) server # [ 0.225646] TCP: Hash tables configured (established 16384 bind 16384) server # [ 0.225747] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) server # [ 0.225789] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.225836] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.225939] NET: Registered PF_UNIX/PF_LOCAL protocol family server # [ 0.225967] NET: Registered PF_XDP protocol family server # [ 0.225989] PCI: CLS 0 bytes, default 64 server # [ 0.226267] Trying to unpack rootfs image as initramfs... server # [ 0.242651] kvm [1]: HYP mode not available host1 # [ 0.420925] Initialise system trusted keyrings host1 # [ 0.421736] workingset: timestamp_bits=42 max_order=19 bucket_order=0 host1 # [ 0.423093] squashfs: version 4.0 (2009/01/31) Phillip Lougher host1 # [ 0.423928] 9p: Installing v9fs 9p2000 file system support host1 # [ 0.444361] Key type asymmetric registered host1 # [ 0.444391] Asymmetric key parser 'x509' registered host1 # [ 0.444468] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) host1 # [ 0.451761] io scheduler mq-deadline registered host1 # [ 0.451788] io scheduler kyber registered host1 # [ 0.463793] pl061_gpio 9030000.pl061: PL061 GPIO chip registered host1 # [ 0.464517] ledtrig-cpu: registered to indicate activity on CPUs host1 # [ 0.464888] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: host1 # [ 0.464907] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 host1 # [ 0.464921] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 host1 # [ 0.464929] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 host1 # [ 0.464954] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits host1 # [ 0.464981] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] host1 # [ 0.465062] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 host1 # [ 0.465073] pci_bus 0000:00: root bus resource [bus 00-ff] host1 # [ 0.465079] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] host1 # [ 0.465085] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] host1 # [ 0.465089] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] host1 # [ 0.465219] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint host1 # [ 0.465657] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint host1 # [ 0.465905] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.465922] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.465952] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.465968] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] host1 # [ 0.466435] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint host1 # [ 0.466626] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.466642] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.466707] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.467171] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.467353] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] host1 # [ 0.467369] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.467401] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.467883] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.468063] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.468079] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.468108] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.468566] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.468756] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.468772] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.468802] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.417739] Initialise system trusted keyrings host1 # [ 0.469246] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint host1 # [ 0.469433] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] server # [ 0.418530] workingset: timestamp_bits=42 max_order=19 bucket_order=0 host1 # [ 0.469449] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.419911] squashfs: version 4.0 (2009/01/31) Phillip Lougher host1 # [ 0.469479] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.469927] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint host1 # [ 0.470111] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.470126] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.470155] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.470171] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] host1 # [ 0.470675] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint host1 # [ 0.470862] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.470891] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.471338] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint server # [ 0.420777] 9p: Installing v9fs 9p2000 file system support host1 # [ 0.471522] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.471552] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.520153] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint server # [ 0.440782] Key type asymmetric registered host1 # [ 0.520370] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] server # [ 0.440806] Asymmetric key parser 'x509' registered host1 # [ 0.520638] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint server # [ 0.440890] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) host1 # [ 0.520957] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] host1 # [ 0.520975] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.521004] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.521468] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint host1 # [ 0.521655] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.521671] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.521701] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.522322] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned server # [ 0.448632] io scheduler mq-deadline registered server # [ 0.448660] io scheduler kyber registered host1 # [ 0.522335] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned host1 # [ 0.522340] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned host1 # [ 0.522386] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned host1 # [ 0.522434] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned host1 # [ 0.522482] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned host1 # [ 0.522534] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned host1 # [ 0.522584] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned host1 # [ 0.522634] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned host1 # [ 0.522703] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned host1 # [ 0.522751] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned host1 # [ 0.522799] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned host1 # [ 0.522871] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned host1 # [ 0.522921] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned server # [ 0.460684] pl061_gpio 9030000.pl061: PL061 GPIO chip registered host1 # [ 0.522943] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned host1 # [ 0.522964] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned host1 # [ 0.522986] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned server # [ 0.462243] ledtrig-cpu: registered to indicate activity on CPUs host1 # [ 0.523008] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned server # [ 0.462660] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: host1 # [ 0.523033] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned host1 # [ 0.523055] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned server # [ 0.462679] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 host1 # [ 0.523076] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned server # [ 0.462691] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 host1 # [ 0.523099] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned server # [ 0.462699] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 host1 # [ 0.523122] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned host1 # [ 0.523145] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned server # [ 0.462722] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits host1 # [ 0.523167] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned server # [ 0.462749] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] host1 # [ 0.523189] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned server # [ 0.462831] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 host1 # [ 0.523211] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned server # [ 0.462841] pci_bus 0000:00: root bus resource [bus 00-ff] host1 # [ 0.523232] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned server # [ 0.462848] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] host1 # [ 0.523254] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned server # [ 0.462853] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] host1 # [ 0.523275] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned server # [ 0.462858] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] host1 # [ 0.523296] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned host1 # [ 0.523318] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned server # [ 0.462964] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint host1 # [ 0.523339] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned server # [ 0.463456] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint host1 # [ 0.523361] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned server # [ 0.463654] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.523387] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] server # [ 0.463671] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.523397] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] server # [ 0.463701] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.523402] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] server # [ 0.463717] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] server # [ 0.464196] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.464386] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] server # [ 0.464402] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.464432] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.568715] pci 0000:00:0a.0: enabling device (0000 -> 0002) server # [ 0.484717] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.484912] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] server # [ 0.484929] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.484960] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.485421] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.485608] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] server # [ 0.485623] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.485653] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.486124] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.486310] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] server # [ 0.486326] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.486355] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.486833] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint server # [ 0.487046] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] server # [ 0.487062] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.487091] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.487552] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.487741] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] server # [ 0.487756] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.487786] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.487802] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] server # [ 0.488294] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint host1 # [ 0.594428] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) server # [ 0.512526] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.512614] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.513171] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint server # [ 0.513382] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.513414] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.605373] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) server # [ 0.513835] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint server # [ 0.514026] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] server # [ 0.514296] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint server # [ 0.514585] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] server # [ 0.514603] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.608767] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) server # [ 0.514632] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.611050] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) server # [ 0.515138] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.515329] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] server # [ 0.515344] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.515373] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.515976] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned server # [ 0.515988] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned server # [ 0.515994] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned server # [ 0.516040] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned server # [ 0.516088] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned server # [ 0.516135] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned server # [ 0.516182] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned host1 # [ 0.621275] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) server # [ 0.516229] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned server # [ 0.516279] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned server # [ 0.516327] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned server # [ 0.516374] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned server # [ 0.516420] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned host1 # [ 0.624669] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) host1 # [ 0.626833] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) server # [ 0.516529] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned server # [ 0.516576] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned server # [ 0.516597] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned server # [ 0.516618] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned server # [ 0.516640] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned server # [ 0.516661] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned server # [ 0.516686] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned server # [ 0.516709] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned server # [ 0.516730] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned server # [ 0.516752] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned server # [ 0.516779] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned server # [ 0.516801] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned server # [ 0.516824] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned host1 # [ 0.637265] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) server # [ 0.516845] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned server # [ 0.516866] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned server # [ 0.516890] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned server # [ 0.516911] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned server # [ 0.516933] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned server # [ 0.516955] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned server # [ 0.516977] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned server # [ 0.516998] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned server # [ 0.517020] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned server # [ 0.517049] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] server # [ 0.517059] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] server # [ 0.517064] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] host1 # [ 0.643798] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) server # [ 0.518286] pci 0000:00:0a.0: enabling device (0000 -> 0002) host1 # [ 0.645886] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) host1 # [ 0.657071] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) host1 # [ 0.669004] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled host1 # [ 0.671917] msm_serial: driver initialized host1 # [ 0.672081] SuperH (H)SCI(F) driver initialized server # [ 0.591214] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) host1 # [ 0.672136] STM32 USART driver initialized server # [ 0.597853] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) server # [ 0.600124] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) server # [ 0.610176] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) server # [ 0.612456] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) host1 # [ 0.708667] loop: module loaded host1 # [ 0.708897] virtio_blk virtio5: 1/0/0 default/read/poll queues host1 # [ 0.709715] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) server # [ 0.625169] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) server # [ 0.627612] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) server # [ 0.639409] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) host1 # [ 0.724398] megasas: 07.734.00.00-rc1 host1 # [ 0.725151] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] server # [ 0.646116] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) host1 # [ 0.727809] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 host1 # [ 0.727841] Intel/Sharp Extended Query Table at 0x0031 server # [ 0.648202] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) host1 # [ 0.729837] Using buffer write method host1 # [ 0.729934] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] host1 # [ 0.737152] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 host1 # [ 0.737185] Intel/Sharp Extended Query Table at 0x0031 host1 # [ 0.748282] Using buffer write method server # [ 0.662304] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) host1 # [ 0.748332] Concatenating MTD devices: host1 # [ 0.748336] (0): "0.flash" host1 # [ 0.748341] (1): "0.flash" host1 # [ 0.748345] into device "0.flash" server # [ 0.671601] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled server # [ 0.681981] msm_serial: driver initialized server # [ 0.682144] SuperH (H)SCI(F) driver initialized server # [ 0.682195] STM32 USART driver initialized server # [ 0.714834] loop: module loaded server # [ 0.715340] virtio_blk virtio5: 1/0/0 default/read/poll queues server # [ 0.716229] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) server # [ 0.721230] megasas: 07.734.00.00-rc1 server # [ 0.721943] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] server # [ 0.732536] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 server # [ 0.732592] Intel/Sharp Extended Query Table at 0x0031 server # [ 0.734731] Using buffer write method server # [ 0.734834] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] server # [ 0.736986] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 server # [ 0.737023] Intel/Sharp Extended Query Table at 0x0031 server # [ 0.739169] Using buffer write method server # [ 0.739206] Concatenating MTD devices: server # [ 0.739210] (0): "0.flash" server # [ 0.739214] (1): "0.flash" server # [ 0.739217] into device "0.flash" host1 # [ 1.033935] Freeing initrd memory: 26160K host1 # [ 1.040234] tun: Universal TUN/TAP device driver, 1.6 host1 # [ 1.044637] thunder_xcv, ver 1.0 host1 # [ 1.044706] thunder_bgx, ver 1.0 host1 # [ 1.044732] nicpf, ver 1.0 host1 # [ 1.045322] e1000: Intel(R) PRO/1000 Network Driver host1 # [ 1.045330] e1000: Copyright (c) 1999-2006 Intel Corporation. host1 # [ 1.045355] e1000e: Intel(R) PRO/1000 Network Driver host1 # [ 1.045365] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. host1 # [ 1.045395] igb: Intel(R) Gigabit Ethernet Network Driver host1 # [ 1.045401] igb: Copyright (c) 2007-2014 Intel Corporation. host1 # [ 1.045425] igbvf: Intel(R) Gigabit Virtual Function Network Driver host1 # [ 1.045431] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. host1 # [ 1.045567] sky2: driver version 1.30 host1 # [ 1.047261] usbcore: registered new interface driver usb-storage host1 # [ 1.047351] usbcore: registered new interface driver usbserial_generic host1 # [ 1.047365] usbserial: USB Serial support registered for generic host1 # [ 1.048525] ehci-pci 0000:00:0a.0: EHCI Host Controller host1 # [ 1.048561] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 host1 # [ 1.048949] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 host1 # [ 1.060825] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 host1 # [ 1.061256] hub 1-0:1.0: USB hub found host1 # [ 1.061295] hub 1-0:1.0: 6 ports detected host1 # [ 1.064041] hv_vmbus: registering driver hyperv_keyboard host1 # [ 1.065721] rtc-pl031 9010000.pl031: registered as rtc0 host1 # [ 1.065758] rtc-pl031 9010000.pl031: setting system clock to 2026-09-20T07:59:46 UTC (1789891186) host1 # [ 1.066120] i2c_dev: i2c /dev entries driver host1 # [ 1.071243] sdhci: Secure Digital Host Controller Interface driver host1 # [ 1.071261] sdhci: Copyright(c) Pierre Ossman host1 # [ 1.071532] Synopsys Designware Multimedia Card Interface Driver host1 # [ 1.074015] sdhci-pltfm: SDHCI platform and OF driver helper host1 # [ 1.076519] hid: raw HID events driver (C) Jiri Kosina host1 # [ 1.076791] usbcore: registered new interface driver usbhid host1 # [ 1.076800] usbhid: USB HID core driver host1 # [ 1.079903] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available host1 # [ 1.081494] drop_monitor: Initializing network drop monitor service host1 # [ 1.081739] NET: Registered PF_INET6 protocol family host1 # [ 1.085205] Segment Routing with IPv6 host1 # [ 1.085233] In-situ OAM (IOAM) with IPv6 host1 # [ 1.085288] NET: Registered PF_PACKET protocol family host1 # [ 1.087010] 9pnet: Installing 9P2000 support host1 # [ 1.090269] Key type dns_resolver registered host1 # [ 1.096962] registered taskstats version 1 host1 # [ 1.097126] Loading compiled-in X.509 certificates host1 # [ 1.106150] Demotion targets for Node 0: null host1 # [ 1.106292] Key type .fscrypt registered host1 # [ 1.106300] Key type fscrypt-provisioning registered host1 # [ 1.106411] ima: No TPM chip found, activating TPM-bypass! host1 # [ 1.106431] ima: Allocated hash algorithm: sha1 host1 # [ 1.106459] ima: No architecture policies found host1 # [ 1.110932] input: gpio-keys as /devices/platform/gpio-keys/input/input0 server # [ 1.040474] Freeing initrd memory: 26140K host1 # [ 1.131145] clk: Disabling unused clocks host1 # [ 1.131191] PM: genpd: Disabling unused power domains host1 # [ 1.135626] Freeing unused kernel memory: 4736K server # [ 1.046844] tun: Universal TUN/TAP device driver, 1.6 host1 # [ 1.135832] Run /init as init process server # [ 1.050301] thunder_xcv, ver 1.0 server # [ 1.050347] thunder_bgx, ver 1.0 server # [ 1.050369] nicpf, ver 1.0 server # [ 1.050916] e1000: Intel(R) PRO/1000 Network Driver server # [ 1.050924] e1000: Copyright (c) 1999-2006 Intel Corporation. server # [ 1.050948] e1000e: Intel(R) PRO/1000 Network Driver server # [ 1.050957] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. server # [ 1.051018] igb: Intel(R) Gigabit Ethernet Network Driver server # [ 1.051024] igb: Copyright (c) 2007-2014 Intel Corporation. server # [ 1.051045] igbvf: Intel(R) Gigabit Virtual Function Network Driver server # [ 1.051051] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. server # [ 1.051182] sky2: driver version 1.30 server # [ 1.061057] usbcore: registered new interface driver usb-storage server # [ 1.061168] usbcore: registered new interface driver usbserial_generic server # [ 1.061184] usbserial: USB Serial support registered for generic server # [ 1.061807] hv_vmbus: registering driver hyperv_keyboard server # [ 1.063309] ehci-pci 0000:00:0a.0: EHCI Host Controller server # [ 1.063342] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 server # [ 1.063553] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 server # [ 1.069560] rtc-pl031 9010000.pl031: registered as rtc0 host1 # [ 1.154628] systemd[1]: Successfully made /usr/ read-only. server # [ 1.069597] rtc-pl031 9010000.pl031: setting system clock to 2026-09-20T07:59:46 UTC (1789891186) server # [ 1.070017] i2c_dev: i2c /dev entries driver server # [ 1.073292] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 server # [ 1.073660] hub 1-0:1.0: USB hub found server # [ 1.073682] hub 1-0:1.0: 6 ports detected server # [ 1.077815] sdhci: Secure Digital Host Controller Interface driver server # [ 1.077832] sdhci: Copyright(c) Pierre Ossman server # [ 1.078099] Synopsys Designware Multimedia Card Interface Driver server # [ 1.078469] sdhci-pltfm: SDHCI platform and OF driver helper server # [ 1.080320] hid: raw HID events driver (C) Jiri Kosina server # [ 1.084057] usbcore: registered new interface driver usbhid server # [ 1.084070] usbhid: USB HID core driver server # [ 1.086456] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available server # [ 1.087984] drop_monitor: Initializing network drop monitor service server # [ 1.088150] NET: Registered PF_INET6 protocol family server # [ 1.091590] Segment Routing with IPv6 server # [ 1.091626] In-situ OAM (IOAM) with IPv6 server # [ 1.091656] NET: Registered PF_PACKET protocol family server # [ 1.093469] 9pnet: Installing 9P2000 support server # [ 1.096282] Key type dns_resolver registered server # [ 1.103635] registered taskstats version 1 server # [ 1.103793] Loading compiled-in X.509 certificates server # [ 1.112940] Demotion targets for Node 0: null server # [ 1.113104] Key type .fscrypt registered server # [ 1.113111] Key type fscrypt-provisioning registered server # [ 1.113221] ima: No TPM chip found, activating TPM-bypass! server # [ 1.113242] ima: Allocated hash algorithm: sha1 server # [ 1.113267] ima: No architecture policies found server # [ 1.117713] input: gpio-keys as /devices/platform/gpio-keys/input/input0 server # [ 1.138841] clk: Disabling unused clocks server # [ 1.138889] PM: genpd: Disabling unused power domains server # [ 1.143724] Freeing unused kernel memory: 4736K server # [ 1.143945] Run /init as init process server # [ 1.159235] systemd[1]: Successfully made /usr/ read-only. host1 # [ 1.307744] usb 1-1: new high-speed USB device number 2 using ehci-pci server # [ 1.320539] usb 1-1: new high-speed USB device number 2 using ehci-pci host1 # [ 1.457098] 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 host1 # [ 1.489632] systemd[1]: systemd 261.2 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) host1 # [ 1.493704] systemd[1]: Detected virtualization qemu. host1 # [ 1.494376] systemd[1]: Detected architecture arm64. host1 # [ 1.495022] systemd[1]: Running in initrd. host1 # [ 1.496006] systemd[1]: Initializing machine ID from random generator. host1 # [ 1.497010] systemd[1]: Hostname set to . host1 # [ 1.543702] 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 server # [ 1.478994] 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 server # [ 1.494412] systemd[1]: systemd 261.2 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) server # [ 1.507159] systemd[1]: Detected virtualization qemu. server # [ 1.509301] systemd[1]: Detected architecture arm64. server # [ 1.511408] systemd[1]: Running in initrd. server # [ 1.514500] systemd[1]: Initializing machine ID from random generator. server # [ 1.517864] systemd[1]: Hostname set to . server # [ 1.568855] 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 host1 # [ 1.663661] usb 1-2: new high-speed USB device number 3 using ehci-pci host1 # [ 1.751734] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 1.692600] usb 1-2: new high-speed USB device number 3 using ehci-pci host1 # [ 1.822272] systemd[1]: Queued start job for default target Initrd Default Target. host1 # [ 1.825747] 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 host1 # [ 1.827565] 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 host1 # [ 1.831238] systemd[1]: Created slice Slice /system/modprobe. host1 # [ 1.832336] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. host1 # [ 1.833406] systemd[1]: Expecting device /dev/disk/by-label/nixos... host1 # [ 1.834236] systemd[1]: Reached target Path Units. host1 # [ 1.834975] systemd[1]: Reached target Slice Units. host1 # [ 1.835656] systemd[1]: Reached target Swaps. host1 # [ 1.836232] systemd[1]: Reached target Timer Units. host1 # [ 1.837106] systemd[1]: Listening on D-Bus System Message Bus Socket. host1 # [ 1.838684] systemd[1]: Listening on Journal Socket (/dev/log). host1 # [ 1.839697] systemd[1]: Listening on Journal Sockets. host1 # [ 1.840577] systemd[1]: Listening on udev Control Socket. host1 # [ 1.841410] systemd[1]: Listening on udev Kernel Socket. host1 # [ 1.842107] systemd[1]: Reached target Socket Units. host1 # [ 1.844420] systemd[1]: Starting Create List of Static Device Nodes... host1 # [ 1.851800] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 1.852845] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 1.863805] systemd[1]: Mounting Kernel Configuration File System... host1 # [ 1.889961] systemd[1]: Starting Journal Service... host1 # [ 1.897054] systemd[1]: Starting Load Kernel Modules... host1 # [ 1.897965] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 1.909751] systemd[1]: Starting Coldplug All udev Devices... host1 # [ 1.918168] systemd[1]: Finished Create List of Static Device Nodes. server # [ 1.839445] systemd[1]: bpf-restrict-fs: LSM BPF program attached host1 # [ 1.929013] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 1.933320] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 1.934778] systemd[1]: Mounted Kernel Configuration File System. server # [ 1.853396] 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 server # [ 1.859947] 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 host1 # [ 1.948163] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... host1 # [ 1.973535] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. host1 # [ 1.988670] systemd-journald[73]: Collecting audit messages is disabled. host1 # [ 1.996546] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev host1 # [ 2.011983] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 host1 # [ 2.012268] [drm] features: -virgl +edid -resource_blob -host_visible host1 # [ 2.012281] [drm] features: -context_init host1 # [ 2.013116] [drm] number of scanouts: 1 host1 # [ 2.013137] [drm] number of cap sets: 0 host1 # [ 2.027755] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 2.030672] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic host1 # [ 2.030706] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 host1 # [ 2.033846] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 1.950671] systemd[1]: Queued start job for default target Initrd Default Target. server # [ 1.959404] systemd[1]: Created slice Slice /system/modprobe. server # [ 1.960767] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 1.962076] systemd[1]: Expecting device /dev/disk/by-label/nixos... server # [ 1.963101] systemd[1]: Reached target Path Units. server # [ 1.963832] systemd[1]: Reached target Slice Units. server # [ 1.964674] systemd[1]: Reached target Swaps. server # [ 1.965396] systemd[1]: Reached target Timer Units. server # [ 1.966411] systemd[1]: Listening on D-Bus System Message Bus Socket. server # [ 1.967673] systemd[1]: Listening on Journal Socket (/dev/log). server # [ 1.968818] systemd[1]: Listening on Journal Sockets. server # [ 1.968960] systemd[1]: Listening on udev Control Socket. server # [ 1.969094] systemd[1]: Listening on udev Kernel Socket. server # [ 1.969118] systemd[1]: Reached target Socket Units. server # [ 1.974668] systemd[1]: Starting Create List of Static Device Nodes... server # [ 1.982227] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 1.983438] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 2.064897] Console: switching to colour frame buffer device 160x50 host1 # [ 2.073071] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device server # [ 1.993961] systemd[1]: Mounting Kernel Configuration File System... host1 # [ 2.104521] systemd[1]: Finished Create Static Device Nodes in /dev. host1 # [ 2.104782] systemd[1]: Reached target Preparation for Local File Systems. host1 # [ 2.104820] systemd[1]: Reached target Local File Systems. host1 # [ 2.110785] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 2.028907] systemd[1]: Starting Journal Service... server # [ 2.031666] systemd[1]: Starting Load Kernel Modules... server # [ 2.032705] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 2.042165] systemd[1]: Starting Coldplug All udev Devices... host1 # [ 2.123859] systemd[1]: Finished Load Kernel Modules. host1 # [ 2.139806] systemd[1]: Starting Apply Kernel Variables... server # [ 2.060687] systemd[1]: Finished Create List of Static Device Nodes. server # [ 2.062004] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 2.062358] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 2.062677] systemd[1]: Mounted Kernel Configuration File System. server # [ 2.081198] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... host1 # [ 2.160494] systemd-modules-load[74]: Inserted module 'dm_mod' host1 # [ 2.161835] systemd-modules-load[74]: Module 'virtio_balloon' is built in host1 # [ 2.163031] systemd-modules-load[74]: Module 'virtio_console' is built in host1 # [ 2.187945] systemd[1]: Started Journal Service. host1 # [ 2.173613] systemd-modules-load[74]: Inserted module 'virtio_gpu' server # [ 2.113318] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. host1 # [ 2.185281] systemd-modules-load[74]: Module 'virtio_rng' is built in server # [ 2.125049] systemd-journald[73]: Collecting audit messages is disabled. server # [ 2.129609] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev host1 # [ 2.204142] systemd[1]: Starting Create System Files and Directories... host1 # [ 2.207598] systemd[1]: Finished Apply Kernel Variables. server # [ 2.145026] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 server # [ 2.145326] [drm] features: -virgl +edid -resource_blob -host_visible server # [ 2.145339] [drm] features: -context_init server # [ 2.146088] [drm] number of scanouts: 1 server # [ 2.146110] [drm] number of cap sets: 0 server # [ 2.161301] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. server # [ 2.164176] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic server # [ 2.164214] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 server # [ 2.173128] systemd[1]: Starting Create Static Device Nodes in /dev... host1 # [ 2.241581] systemd-udevd[79]: Using default interface naming scheme 'v261'. host1 # [ 2.246418] systemd[1]: Finished Create System Files and Directories. server # [ 2.196819] Console: switching to colour frame buffer device 160x50 host1 # [ 2.275091] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 2.217107] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device server # [ 2.225484] systemd[1]: Finished Load Kernel Modules. server # [ 2.233088] systemd[1]: Starting Apply Kernel Variables... server # [ 2.252737] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 2.253138] systemd[1]: Reached target Preparation for Local File Systems. server # [ 2.253185] systemd[1]: Reached target Local File Systems. server # [ 2.261217] systemd[1]: Starting Rule-based Manager for Device Events and Files... host1 # [ 2.348170] systemd[1]: Starting Virtual Console Setup... server # [ 2.301326] systemd-modules-load[74]: Inserted module 'dm_mod' server # [ 2.323108] systemd[1]: Started Journal Service. server # [ 2.307216] systemd-modules-load[74]: Module 'virtio_balloon' is built in server # [ 2.321146] systemd-modules-load[74]: Module 'virtio_console' is built in server # [ 2.322369] systemd-modules-load[74]: Inserted module 'virtio_gpu' server # [ 2.323512] systemd-modules-load[74]: Module 'virtio_rng' is built in host1 # [ 2.408540] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 2.412329] systemd[1]: Finished Virtual Console Setup. server # [ 2.328511] systemd[1]: Starting Create System Files and Directories... server # [ 2.333376] systemd[1]: Finished Apply Kernel Variables. server # [ 2.357570] systemd-udevd[80]: Using default interface naming scheme 'v261'. server # [ 2.393414] systemd[1]: Finished Create System Files and Directories. server # [ 2.405720] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 2.477180] systemd[1]: Starting Virtual Console Setup... server # [ 2.528585] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 2.536219] systemd[1]: Finished Virtual Console Setup. host1 # [ 2.991974] systemd[1]: Finished Coldplug All udev Devices. host1 # [ 2.996171] systemd[1]: Reached target System Initialization. host1 # [ 2.997066] systemd[1]: Reached target Basic System. host1 # [ 3.168485] (udev-worker)[95]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. host1 # [ 3.210180] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.228800] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line. server # [ 3.161221] systemd[1]: Finished Coldplug All udev Devices. server # [ 3.163031] systemd[1]: Reached target System Initialization. server # [ 3.163892] systemd[1]: Reached target Basic System. host1 # [ 3.322923] systemd[1]: Found device /dev/disk/by-label/nixos. host1 # [ 3.326252] systemd[1]: Reached target Initrd Root Device. host1 # [ 3.328612] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... host1 # [ 3.378744] systemd-fsck[115]: nixos: clean, 12/65536 files, 13019/262144 blocks host1 # [ 3.388174] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. server # [ 3.304736] (udev-worker)[107]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.392901] systemd[1]: Mounting /sysroot... host1 # [ 3.466920] EXT4-fs (vda): mounted filesystem 76f121dd-7a6a-417a-aeb1-52a73737f101 r/w with ordered data mode. Quota mode: none. host1 # [ 3.454200] systemd[1]: Mounted /sysroot. host1 # [ 3.456816] systemd[1]: Reached target Initrd Root File System. host1 # [ 3.462518] systemd[1]: Starting Mountpoints Configured in the Real Root... server # [ 3.380977] (udev-worker)[94]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 3.385774] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.492475] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload. host1 # [ 3.501510] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)... host1 # [ 3.508085] systemd[1]: Reloading... server # [ 3.476842] systemd[1]: Found device /dev/disk/by-label/nixos. server # [ 3.480675] systemd[1]: Reached target Initrd Root Device. server # [ 3.488245] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... server # [ 3.535813] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks server # [ 3.543638] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. server # [ 3.547785] systemd[1]: Mounting /sysroot... server # [ 3.611966] EXT4-fs (vda): mounted filesystem 643e7b39-cab2-445c-a624-d6cc20f771b5 r/w with ordered data mode. Quota mode: none. server # [ 3.598216] systemd[1]: Mounted /sysroot. server # [ 3.601470] systemd[1]: Reached target Initrd Root File System. server # [ 3.607176] systemd[1]: Starting Mountpoints Configured in the Real Root... server # [ 3.640444] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload. server # [ 3.648151] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)... server # [ 3.652155] systemd[1]: Reloading... host1 # [ 3.745991] systemd[1]: Reloading finished in 241 ms. host1 # [ 3.781152] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace... host1 # [ 3.787660] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace... host1 # [ 3.792438] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 3.807457] systemd[1]: initrd-parse-etc.service: Deactivated successfully. host1 # [ 3.810468] systemd[1]: Finished Mountpoints Configured in the Real Root. host1 # [ 3.813948] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. host1 # [ 3.829774] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 3.831441] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 3.900878] systemd[1]: Mounting /sysroot/nix/.ro-store... host1 # [ 3.920291] systemd[1]: Mounting /sysroot/nix/.rw-store... host1 # [ 3.925107] systemd[1]: Mounting /sysroot/run... host1 # [ 3.943818] systemd[1]: Mounting /sysroot/tmp/shared... server # [ 3.896106] systemd[1]: Reloading finished in 248 ms. host1 # [ 3.982832] systemd[1]: Mounting /sysroot/tmp/xchg... server # [ 3.929278] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace... server # [ 3.935143] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace... host1 # [ 4.022069] systemd[1]: Mounted /sysroot/nix/.rw-store. server # [ 3.940269] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 3.950156] systemd[1]: initrd-parse-etc.service: Deactivated successfully. server # [ 3.953663] systemd[1]: Finished Mountpoints Configured in the Real Root. server # [ 3.958381] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. host1 # [ 4.043621] systemd[1]: Mounted /sysroot/nix/.ro-store. server # [ 3.979383] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 4.065742] systemd[1]: Mounted /sysroot/run. server # [ 3.983399] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 4.071260] systemd[1]: Mounted /sysroot/tmp/shared. host1 # [ 4.074975] systemd[1]: Mounted /sysroot/tmp/xchg. host1 # [ 4.086650] systemd[1]: Starting rw-sysroot-nix-store.service... host1 # [ 4.115586] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. host1 # [ 4.117486] systemd[1]: Finished rw-sysroot-nix-store.service. server # [ 4.047004] systemd[1]: Mounting /sysroot/nix/.ro-store... server # [ 4.060122] systemd[1]: Mounting /sysroot/nix/.rw-store... server # [ 4.073742] systemd[1]: Mounting /sysroot/run... server # [ 4.101998] systemd[1]: Mounting /sysroot/tmp/shared... server # [ 4.123234] systemd[1]: Mounting /sysroot/tmp/xchg... server # [ 4.164092] systemd[1]: Mounted /sysroot/nix/.ro-store. server # [ 4.175997] systemd[1]: Mounted /sysroot/nix/.rw-store. server # [ 4.189160] systemd[1]: Mounted /sysroot/run. server # [ 4.220754] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 4.223867] systemd[1]: Mounted /sysroot/tmp/shared. server # [ 4.229869] systemd[1]: Mounted /sysroot/tmp/xchg. server # [ 4.256766] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 4.258293] systemd[1]: Finished rw-sysroot-nix-store.service. host1 # [ 4.717061] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory host1 # [ 4.723345] (udev-worker)[101]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/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 host1 # [ 4.756105] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 4.759286] systemd[1]: Stopped Virtual Console Setup. host1 # [ 4.765043] systemd[1]: Stopping Virtual Console Setup... host1 # [ 4.765928] systemd[1]: Starting Virtual Console Setup... host1 # [ 4.779604] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 4.781540] systemd[1]: Stopped Virtual Console Setup. host1 # [ 4.782863] systemd[1]: Starting Virtual Console Setup... host1 # [ 4.815413] systemd-vconsole-setup[158]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 4.819679] systemd[1]: Finished Virtual Console Setup. host1 # [ 4.903269] systemd[1]: Mounting /sysroot/nix/store... host1 # [ 4.956795] systemd[1]: Mounted /sysroot/nix/store. host1 # [ 4.960259] systemd[1]: Reached target Initrd File Systems. host1 # [ 4.964245] systemd[1]: Starting Find NixOS closure... host1 # [ 4.976537] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... server # [ 4.920144] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory server # [ 4.924747] (udev-worker)[96]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/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 host1 # [ 5.019937] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. host1 # [ 5.028624] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. host1 # [ 5.040358] systemd[1]: Finished Find NixOS closure. host1 # [ 5.043163] systemd[1]: Reached target Initrd Default Target. server # [ 4.958783] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 5.044892] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... server # [ 4.961173] systemd[1]: Stopped Virtual Console Setup. server # [ 4.962625] systemd[1]: Stopping Virtual Console Setup... server # [ 4.968222] systemd[1]: Starting Virtual Console Setup... server # [ 4.985009] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 4.986719] systemd[1]: Stopped Virtual Console Setup. host1 # [ 5.073235] systemd[1]: Stopped target Initrd Default Target. server # [ 4.989671] systemd[1]: Starting Virtual Console Setup... host1 # [ 5.076392] systemd[1]: Stopped target Basic System. host1 # [ 5.077384] systemd[1]: Stopped target Initrd Root Device. host1 # [ 5.080346] systemd[1]: Stopped target Path Units. host1 # [ 5.081257] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. host1 # [ 5.083926] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. host1 # [ 5.087978] systemd[1]: Stopped target Slice Units. host1 # [ 5.088876] systemd[1]: Stopped target Socket Units. host1 # [ 5.089637] systemd[1]: Stopped target System Initialization. host1 # [ 5.090496] systemd[1]: Stopped target Swaps. host1 # [ 5.091216] systemd[1]: Stopped target Timer Units. host1 # [ 5.091934] systemd[1]: dbus.socket: Deactivated successfully. host1 # [ 5.100293] systemd[1]: Closed D-Bus System Message Bus Socket. host1 # [ 5.101289] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. server # [ 5.015888] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 5.102403] systemd[1]: Stopped Find NixOS closure. host1 # [ 5.103135] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 5.020836] systemd[1]: Finished Virtual Console Setup. host1 # [ 5.105607] systemd[1]: Starting rw-sysroot-nix-store.service... host1 # [ 5.110405] systemd[1]: systemd-sysctl.service: Deactivated successfully. host1 # [ 5.113502] systemd[1]: Stopped Apply Kernel Variables. host1 # [ 5.116575] systemd[1]: systemd-modules-load.service: Deactivated successfully. host1 # [ 5.119228] systemd[1]: Stopped Load Kernel Modules. server # [ 5.043470] systemd[1]: Mounting /sysroot/nix/store... host1 # [ 5.133737] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. host1 # [ 5.136428] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. host1 # [ 5.145687] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. host1 # [ 5.153930] systemd[1]: Stopped Create System Files and Directories. host1 # [ 5.157267] systemd[1]: Stopped target Local File Systems. host1 # [ 5.161146] systemd[1]: Stopped target Preparation for Local File Systems. host1 # [ 5.163366] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. server # [ 5.080244] systemd[1]: Mounted /sysroot/nix/store. host1 # [ 5.165862] systemd[1]: Stopped Coldplug All udev Devices. server # [ 5.082121] systemd[1]: Reached target Initrd File Systems. host1 # [ 5.167308] systemd[1]: Stopping Rule-based Manager for Device Events and Files... server # [ 5.085163] systemd[1]: Starting Find NixOS closure... host1 # [ 5.172388] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 5.176313] systemd[1]: Stopped Virtual Console Setup. host1 # [ 5.177189] systemd[1]: initrd-cleanup.service: Deactivated successfully. host1 # [ 5.178910] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. server # [ 5.095697] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... host1 # [ 5.184661] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 5.185877] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 5.186785] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. host1 # [ 5.188181] systemd[1]: Finished rw-sysroot-nix-store.service. host1 # [ 5.190408] systemd[1]: systemd-udevd.service: Deactivated successfully. host1 # [ 5.191604] systemd[1]: Stopped Rule-based Manager for Device Events and Files. host1 # [ 5.192917] systemd[1]: systemd-udevd.service: Consumed 1.556s CPU time over 3.083s wall clock time, 27.2M memory peak. host1 # [ 5.194421] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. host1 # [ 5.195488] systemd[1]: Closed udev Control Socket. host1 # [ 5.200317] systemd[1]: Starting Cleanup udev Database... host1 # [ 5.201265] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. host1 # [ 5.203700] systemd[1]: Stopped Create Static Device Nodes in /dev. host1 # [ 5.208399] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. host1 # [ 5.209658] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. host1 # [ 5.212466] systemd[1]: kmod-static-nodes.service: Deactivated successfully. server # [ 5.128234] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. host1 # [ 5.213563] systemd[1]: Stopped Create List of Static Device Nodes. server # [ 5.131304] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. server # [ 5.145415] systemd[1]: Finished Find NixOS closure. server # [ 5.148132] systemd[1]: Reached target Initrd Default Target. server # [ 5.149537] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... host1 # [ 5.246034] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. host1 # [ 5.249021] systemd[1]: Finished Cleanup udev Database. host1 # [ 5.251913] systemd[1]: Reached target Switch Root. host1 # [ 5.253658] systemd[1]: Starting NixOS Activation... server # [ 5.179236] systemd[1]: initrd-cleanup.service: Deactivated successfully. server # [ 5.184331] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. server # [ 5.185362] systemd[1]: Stopped target Initrd Default Target. server # [ 5.186212] systemd[1]: Stopped target Basic System. server # [ 5.186998] systemd[1]: Stopped target Initrd Root Device. server # [ 5.187820] systemd[1]: Stopped target Path Units. server # [ 5.192467] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. server # [ 5.193635] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. server # [ 5.194803] systemd[1]: Stopped target Slice Units. server # [ 5.195562] systemd[1]: Stopped target Socket Units. server # [ 5.200464] systemd[1]: Stopped target System Initialization. server # [ 5.202968] systemd[1]: Stopped target Swaps. server # [ 5.203752] systemd[1]: Stopped target Timer Units. server # [ 5.204961] systemd[1]: dbus.socket: Deactivated successfully. server # [ 5.208232] systemd[1]: Closed D-Bus System Message Bus Socket. server # [ 5.213217] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. server # [ 5.215442] systemd[1]: Stopped Find NixOS closure. server # [ 5.218525] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 5.222247] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 5.227846] systemd[1]: systemd-sysctl.service: Deactivated successfully. server # [ 5.237762] systemd[1]: Stopped Apply Kernel Variables. server # [ 5.238699] systemd[1]: systemd-modules-load.service: Deactivated successfully. server # [ 5.245197] systemd[1]: Stopped Load Kernel Modules. server # [ 5.250791] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. server # [ 5.259306] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. server # [ 5.262690] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. server # [ 5.265276] systemd[1]: Stopped Create System Files and Directories. server # [ 5.267179] systemd[1]: Stopped target Local File Systems. server # [ 5.270066] systemd[1]: Stopped target Preparation for Local File Systems. server # [ 5.271258] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. server # [ 5.276780] systemd[1]: Stopped Coldplug All udev Devices. server # [ 5.277674] systemd[1]: Stopping Rule-based Manager for Device Events and Files... server # [ 5.278758] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 5.279813] systemd[1]: Stopped Virtual Console Setup. server # [ 5.283210] systemd[1]: systemd-udevd.service: Deactivated successfully. server # [ 5.284499] systemd[1]: Stopped Rule-based Manager for Device Events and Files. server # [ 5.285562] systemd[1]: systemd-udevd.service: Consumed 1.593s CPU time over 3.021s wall clock time, 24.2M memory peak. server # [ 5.287027] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 5.288161] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 5.289032] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 5.290056] systemd[1]: Finished rw-sysroot-nix-store.service. server # [ 5.290902] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. server # [ 5.291888] systemd[1]: Closed udev Control Socket. server # [ 5.296367] systemd[1]: Starting Cleanup udev Database... server # [ 5.298957] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. server # [ 5.304611] systemd[1]: Stopped Create Static Device Nodes in /dev. server # [ 5.305564] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. server # [ 5.306762] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. server # [ 5.307763] systemd[1]: kmod-static-nodes.service: Deactivated successfully. server # [ 5.312293] systemd[1]: Stopped Create List of Static Device Nodes. server # [ 5.345878] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. server # [ 5.348169] systemd[1]: Finished Cleanup udev Database. server # [ 5.352220] systemd[1]: Reached target Switch Root. server # [ 5.353120] systemd[1]: Starting NixOS Activation... host1 # [ 5.444409] initrd-nixos-activation-start[184]: booting system configuration /nix/store/b7h8aacpsy3m4h4k81ssk2nsc1jyq9p9-nixos-system-host1-test host1 # [ 5.520533] initrd-nixos-activation-start[184]: running activation script... server # [ 5.550959] initrd-nixos-activation-start[185]: booting system configuration /nix/store/9l9qzzlcm0wdn973d4af335dpab2qfab-nixos-system-server-test server # [ 5.624540] initrd-nixos-activation-start[185]: running activation script... host1 # [ 6.000581] initrd-nixos-activation-start[207]: setting up /etc... server # [ 6.132807] initrd-nixos-activation-start[208]: setting up /etc... host1 # [ 6.312318] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. host1 # [ 6.315679] systemd[1]: Finished NixOS Activation. host1 # [ 6.317363] systemd[1]: Starting Switch Root... host1 # [ 6.339799] systemd[1]: Switching root. host1 # [ 6.531135] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). server # [ 6.429932] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. server # [ 6.433146] systemd[1]: Finished NixOS Activation. server # [ 6.434536] systemd[1]: Starting Switch Root... server # [ 6.458278] systemd[1]: Switching root. server # [ 6.651317] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). host1 # [ 7.118825] systemd[1]: systemd 261.2 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) host1 # [ 7.131565] systemd[1]: Detected virtualization qemu. host1 # [ 7.135004] systemd[1]: Detected architecture arm64. host1 # [ 7.139705] systemd[1]: Detected first boot. host1 # [ 7.147867] systemd[1]: Initializing machine ID from random generator. server # [ 7.228878] systemd[1]: systemd 261.2 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) server # [ 7.233798] systemd[1]: Detected virtualization qemu. server # [ 7.236532] systemd[1]: Detected architecture arm64. server # [ 7.238685] systemd[1]: Detected first boot. server # [ 7.246328] systemd[1]: Initializing machine ID from random generator. host1 # [ 7.475385] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 7.540643] systemd[1]: bpf-restrict-fs: LSM BPF program attached host1 # [ 7.659761] systemd[1]: Applying preset policy. server # [ 7.778749] systemd[1]: Applying preset policy. host1 # [ 8.313012] systemd[1]: Populated /etc with preset unit settings. server # [ 8.411814] systemd[1]: Populated /etc with preset unit settings. host1 # [ 8.854878] systemd[1]: initrd-switch-root.service: Deactivated successfully. host1 # [ 8.856578] systemd[1]: Stopped initrd-switch-root.service. host1 # [ 8.858848] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. host1 # [ 8.864547] systemd[1]: Created slice Slice /system/getty. host1 # [ 8.866422] systemd[1]: Created slice User and Session Slice. host1 # [ 8.869264] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. host1 # [ 8.872041] systemd[1]: Started Forward Password Requests to Wall Directory Watch. host1 # [ 8.873487] systemd[1]: Expecting device /dev/hvc0... host1 # [ 8.874540] systemd[1]: Expecting device /dev/ttyAMA0... host1 # [ 8.875737] systemd[1]: Reached target Local Encrypted Volumes. host1 # [ 8.879547] systemd[1]: Stopped target initrd-fs.target. host1 # [ 8.880745] systemd[1]: Stopped target initrd-root-fs.target. host1 # [ 8.883004] systemd[1]: Stopped target initrd-switch-root.target. host1 # [ 8.885128] systemd[1]: Reached target Virtual Machines and Containers. host1 # [ 8.887226] systemd[1]: Reached target Path Units. host1 # [ 8.889427] systemd[1]: Reached target Remote File Systems. host1 # [ 8.891478] systemd[1]: Reached target Slice Units. host1 # [ 8.893375] systemd[1]: Reached target Swaps. host1 # [ 8.899329] systemd[1]: Listening on Query the User Interactively for a Password. host1 # [ 8.905913] systemd[1]: Listening on Process Core Dump Socket. host1 # [ 8.910397] systemd[1]: Listening on Credential Encryption/Decryption. host1 # [ 8.914786] systemd[1]: Listening on Factory Reset Management. host1 # [ 8.917232] systemd[1]: Listening on Hostname Service Socket. host1 # [ 8.923431] systemd[1]: Starting Journal Log Access Socket... host1 # [ 8.926984] systemd[1]: Listening on Journal Audit Socket. host1 # [ 8.932697] systemd[1]: Listening on Console Output Muting Service Socket. host1 # [ 8.936814] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. host1 # [ 8.939550] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 8.943003] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki host1 # [ 8.956300] systemd[1]: Listening on Disk Repartitioning Service Socket. host1 # [ 8.956918] systemd[1]: Listening on udev Control Socket. host1 # [ 8.957457] systemd[1]: Listening on udev Varlink Socket. host1 # [ 8.965014] systemd[1]: Mounting Huge Pages File System... host1 # [ 8.970878] systemd[1]: Mounting POSIX Message Queue File System... host1 # [ 8.979371] systemd[1]: Mounting Kernel Debug File System... host1 # [ 8.998223] systemd[1]: Mounting Kernel Trace File System... host1 # [ 9.018164] systemd[1]: Starting Create List of Static Device Nodes... host1 # [ 9.042799] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 8.967015] systemd[1]: initrd-switch-root.service: Deactivated successfully. host1 # [ 9.048918] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs server # [ 8.968629] systemd[1]: Stopped initrd-switch-root.service. server # [ 8.972141] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. server # [ 8.977498] systemd[1]: Created slice Slice /system/getty. server # [ 8.981174] systemd[1]: Created slice User and Session Slice. server # [ 8.983834] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 8.987142] systemd[1]: Started Forward Password Requests to Wall Directory Watch. server # [ 8.990449] systemd[1]: Expecting device /dev/hvc0... server # [ 8.992740] systemd[1]: Expecting device /dev/ttyAMA0... server # [ 8.995154] systemd[1]: Reached target Local Encrypted Volumes. server # [ 8.998011] systemd[1]: Stopped target initrd-fs.target. server # [ 9.000487] systemd[1]: Stopped target initrd-root-fs.target. host1 # [ 9.083899] systemd[1]: Mounting Kernel Configuration File System... server # [ 9.002710] systemd[1]: Stopped target initrd-switch-root.target. server # [ 9.005561] systemd[1]: Reached target Virtual Machines and Containers. server # [ 9.008699] systemd[1]: Reached target Path Units. host1 # [ 9.092204] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm server # [ 9.011263] systemd[1]: Reached target Remote File Systems. server # [ 9.013429] systemd[1]: Reached target Slice Units. server # [ 9.015408] systemd[1]: Reached target Swaps. host1 # [ 9.100037] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore server # [ 9.020419] systemd[1]: Listening on Query the User Interactively for a Password. server # [ 9.029644] systemd[1]: Listening on Process Core Dump Socket. server # [ 9.035815] systemd[1]: Listening on Credential Encryption/Decryption. host1 # [ 9.124220] systemd[1]: Starting Load Kernel Module fuse... server # [ 9.040817] systemd[1]: Listening on Factory Reset Management. server # [ 9.043727] systemd[1]: Listening on Hostname Service Socket. host1 # [ 9.132059] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 server # [ 9.053593] systemd[1]: Starting Journal Log Access Socket... server # [ 9.057431] systemd[1]: Listening on Journal Audit Socket. server # [ 9.065122] systemd[1]: Listening on Console Output Muting Service Socket. server # [ 9.067976] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. server # [ 9.070552] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os server # [ 9.073444] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki host1 # [ 9.165633] systemd[1]: Starting Journal Service... server # [ 9.084219] systemd[1]: Listening on Disk Repartitioning Service Socket. server # [ 9.084883] systemd[1]: Listening on udev Control Socket. server # [ 9.085411] systemd[1]: Listening on udev Varlink Socket. server # [ 9.092913] systemd[1]: Mounting Huge Pages File System... host1 # [ 9.184176] systemd[1]: Starting Load Kernel Modules... server # [ 9.102269] systemd[1]: Mounting POSIX Message Queue File System... server # [ 9.118142] systemd[1]: Mounting Kernel Debug File System... server # [ 9.132117] systemd[1]: Mounting Kernel Trace File System... host1 # [ 9.222216] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... server # [ 9.153599] systemd[1]: Starting Create List of Static Device Nodes... host1 # [ 9.241291] fuse: init (API version 7.45) host1 # [ 9.252403] systemd[1]: Starting Remount Root and Kernel File Systems... host1 # [ 9.259914] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 9.180324] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 9.185437] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 9.289082] systemd[1]: Starting Coldplug All udev Devices... server # [ 9.211488] systemd[1]: Mounting Kernel Configuration File System... server # [ 9.216381] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm server # [ 9.221380] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore host1 # [ 9.303930] systemd-journald[278]: Collecting audit messages is enabled. host1 # [ 9.316258] systemd[1]: Listening on Journal Log Access Socket. server # [ 9.237518] systemd[1]: Starting Load Kernel Module fuse... host1 # [ 9.322757] systemd[1]: Mounted Huge Pages File System. server # [ 9.242842] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 host1 # [ 9.337475] systemd[1]: Mounted POSIX Message Queue File System. host1 # [ 9.321144] systemd[1]: Queued start job for default target Multi-User System. host1 # [ 9.344492] systemd[1]: Started Journal Service. host1 # [ 9.326138] systemd[1]: systemd-journald.service: Deactivated successfully. host1 # [ 9.333788] systemd-modules-load[279]: Module 'atkbd' is built in host1 # [ 9.342642] systemd-modules-load[279]: Module 'loop' is built in host1 # [ 9.351486] systemd[1]: Mounted Kernel Debug File System. host1 # [ 9.358265] systemd[1]: Mounted Kernel Trace File System. host1 # [ 9.365708] systemd[1]: Finished Create List of Static Device Nodes. host1 # [ 9.372665] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 9.382205] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 9.317757] systemd[1]: Starting Journal Service... host1 # [ 9.385265] systemd[1]: Mounted Kernel Configuration File System. host1 # [ 9.390495] systemd[1]: modprobe@fuse.service: Deactivated successfully. host1 # [ 9.418555] EXT4-fs (vda): re-mounted 76f121dd-7a6a-417a-aeb1-52a73737f101. host1 # [ 9.402889] systemd[1]: Finished Load Kernel Module fuse. host1 # [ 9.403947] systemd[1]: Finished Load Kernel Modules. server # [ 9.344468] systemd[1]: Starting Load Kernel Modules... host1 # [ 9.423357] systemd[1]: Mounting FUSE Control File System... host1 # [ 9.426618] systemd[1]: Starting Firewall... server # [ 9.360789] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... server # [ 9.370619] systemd[1]: Starting Remount Root and Kernel File Systems... server # [ 9.376760] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 9.445954] systemd[1]: Starting Apply Kernel Variables... server # [ 9.390021] systemd[1]: Starting Coldplug All udev Devices... server # [ 9.399880] systemd[1]: Listening on Journal Log Access Socket. host1 # [ 9.465530] systemd-oomd[281]: No swap; memory pressure usage will be degraded server # [ 9.404963] systemd[1]: Mounted Huge Pages File System. host1 # [ 9.472577] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... server # [ 9.409046] systemd[1]: Mounted POSIX Message Queue File System. server # [ 9.412714] systemd[1]: Mounted Kernel Debug File System. host1 # [ 9.480448] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. server # [ 9.417026] systemd[1]: Mounted Kernel Trace File System. server # [ 9.419485] systemd[1]: Mounted Kernel Configuration File System. host1 # [ 9.513684] systemd[1]: Finished Remount Root and Kernel File Systems. host1 # [ 9.529876] systemd[1]: Listening on Disk Image Download Service Socket. server # [ 9.467841] systemd[1]: Finished Create List of Static Device Nodes. server # [ 9.474645] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... host1 # [ 9.547700] systemd[1]: Starting Flush Journal to Persistent Storage... host1 # [ 9.555837] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore host1 # [ 9.604400] systemd[1]: Starting Load/Save OS Random Seed... host1 # [ 9.606365] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 9.581768] EXT4-fs (vda): re-mounted 643e7b39-cab2-445c-a624-d6cc20f771b5. server # [ 9.589617] systemd-journald[279]: Collecting audit messages is enabled. host1 # [ 9.668342] systemd[1]: Finished Apply Kernel Variables. server # [ 9.603104] systemd[1]: Finished Remount Root and Kernel File Systems. server # [ 9.606621] systemd[1]: Listening on Disk Image Download Service Socket. server # [ 9.609920] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore server # [ 9.629160] systemd[1]: Starting Load/Save OS Random Seed... host1 # [ 9.693546] systemd[1]: Mounted FUSE Control File System. server # [ 9.630963] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 9.720609] systemd-journald[278]: Received client request to flush runtime journal. server # [ 9.637519] systemd[1]: Finished Load Kernel Modules. server # [ 9.653716] systemd[1]: Starting Firewall... server # [ 9.672738] systemd[1]: Starting Apply Kernel Variables... server # [ 9.673466] systemd[1]: Started Journal Service. server # [ 9.651527] systemd[1]: Queued start job for default target Multi-User System. server # [ 9.671071] systemd[1]: systemd-journald.service: Deactivated successfully. server # [ 9.685075] systemd-modules-load[280]: Module 'atkbd' is built in host1 # [ 9.782459] systemd[1]: Finished Load/Save OS Random Seed. server # [ 9.700751] systemd-modules-load[280]: Module 'loop' is built in host1 # [ 9.790723] systemd[1]: Reached target First Boot Complete. host1 # [ 9.795731] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. server # [ 9.719042] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 9.804683] systemd[1]: Starting Create Static Device Nodes in /dev... host1 # [ 9.805686] systemd[1]: Finished Flush Journal to Persistent Storage. server # [ 9.731428] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 9.770746] fuse: init (API version 7.45) server # [ 9.755063] systemd[1]: Starting Flush Journal to Persistent Storage... server # [ 9.784299] systemd-oomd[281]: No swap; memory pressure usage will be degraded server # [ 9.801699] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. host1 # [ 9.896292] systemd[1]: Finished Create Static Device Nodes in /dev. host1 # [ 9.901834] systemd[1]: Reached target Preparation for Local File Systems. server # [ 9.818773] systemd[1]: modprobe@fuse.service: Deactivated successfully. server # [ 9.828580] systemd[1]: Finished Load Kernel Module fuse. host1 # [ 9.916200] systemd[1]: Mounting /run/wrappers... host1 # [ 9.919669] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 9.876400] systemd-journald[279]: Received client request to flush runtime journal. host1 # [ 10.035732] systemd[1]: Mounted /run/wrappers. host1 # [ 10.039417] systemd[1]: Reached target Local File Systems. host1 # [ 10.048425] systemd[1]: Listening on Boot Loader Control Service Socket. host1 # [ 10.053564] systemd[1]: Starting register-nix-paths.service... server # [ 9.973740] systemd[1]: Finished Load/Save OS Random Seed. host1 # [ 10.073941] systemd[1]: Starting Create SUID/SGID Wrappers... server # [ 9.989783] systemd[1]: Reached target First Boot Complete. host1 # [ 10.081989] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 10.003960] systemd[1]: Finished Apply Kernel Variables. server # [ 10.012274] systemd[1]: Mounting FUSE Control File System... host1 # [ 10.104810] systemd[1]: Starting Save Transient machine-id to Disk... server # [ 10.028147] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 10.113957] systemd-udevd[321]: Using default interface naming scheme 'v261'. server # [ 10.030085] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 10.032752] systemd[1]: Finished Flush Journal to Persistent Storage. server # [ 10.037246] systemd[1]: Mounted FUSE Control File System. host1 # [ 10.132762] systemd[1]: Starting Create System Files and Directories... server # [ 10.153220] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 10.155855] systemd[1]: Reached target Preparation for Local File Systems. server # [ 10.163347] systemd[1]: Mounting /run/wrappers... server # [ 10.166662] systemd[1]: Starting Rule-based Manager for Device Events and Files... host1 # [ 10.268407] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. host1 # [ 10.285158] systemd[1]: Finished Save Transient machine-id to Disk. server # [ 10.240445] systemd[1]: Mounted /run/wrappers. server # [ 10.249352] systemd[1]: Reached target Local File Systems. server # [ 10.250564] systemd[1]: Listening on Boot Loader Control Service Socket. server # [ 10.259142] systemd[1]: Starting register-nix-paths.service... server # [ 10.272597] systemd[1]: Starting Create SUID/SGID Wrappers... server # [ 10.284285] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 10.301060] systemd[1]: Starting Save Transient machine-id to Disk... server # [ 10.311354] systemd[1]: Starting Create System Files and Directories... host1 # [ 10.407485] systemd[1]: Finished Create System Files and Directories. host1 # [ 10.430381] systemd[1]: Starting Rebuild Journal Catalog... host1 # [ 10.445413] systemd[1]: Starting Record System Boot/Shutdown in UTMP... host1 # [ 10.456481] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 10.431855] systemd[1]: Finished Save Transient machine-id to Disk. server # [ 10.470237] systemd-udevd[325]: Using default interface naming scheme 'v261'. host1 # [ 10.600635] systemd[1]: Finished Record System Boot/Shutdown in UTMP. server # [ 10.574256] systemd[1]: Finished Create System Files and Directories. server # [ 10.584402] systemd[1]: Starting Rebuild Journal Catalog... server # [ 10.593464] systemd[1]: Starting Record System Boot/Shutdown in UTMP... host1 # [ 10.689759] systemd[1]: Finished Rebuild Journal Catalog. host1 # [ 10.701585] systemd[1]: Starting Update is Completed... host1 # [ 10.803789] systemd[1]: Finished Update is Completed. server # [ 10.729862] systemd[1]: Finished Record System Boot/Shutdown in UTMP. server # [ 10.822505] systemd[1]: Finished Rebuild Journal Catalog. server # [ 10.835606] systemd[1]: Starting Update is Completed... server # [ 10.862495] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 10.948175] systemd[1]: Finished Update is Completed. server # [ 10.956795] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. host1 # [ 11.333951] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. host1 # [ 11.340750] systemd[1]: Finished Create SUID/SGID Wrappers. server # [ 11.566060] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. server # [ 11.567408] systemd[1]: Finished Create SUID/SGID Wrappers. host1 # [ 11.896866] systemd[1]: Finished Coldplug All udev Devices. host1 # [ 12.032623] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 12.047083] systemd[1]: Finished Firewall. host1 # [ 12.259267] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. host1 # [ 12.282684] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. server # [ 12.297219] systemd[1]: Finished Firewall. host1 # [ 12.398110] systemd[1]: Finished register-nix-paths.service. host1 # [ 12.401476] systemd[1]: Reached target System Initialization. host1 # [ 12.404815] systemd[1]: Started Renew ACME Certificate for host1. host1 # [ 12.408526] systemd[1]: Started Discard unused filesystem blocks once a week. host1 # [ 12.411413] systemd[1]: Started Daily Cleanup of Temporary Directories. host1 # [ 12.413975] systemd[1]: Reached target Timer Units. host1 # [ 12.418168] systemd[1]: Listening on D-Bus System Message Bus Socket. host1 # [ 12.420836] systemd[1]: Listening on Nix Daemon Socket. host1 # [ 12.422853] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. host1 # [ 12.428842] systemd[1]: Reached target Socket Units. host1 # [ 12.430749] systemd[1]: Reached target Basic System. host1 # [ 12.432491] systemd[1]: Starting Set up the ACME certificate renewal infrastructure... host1 # [ 12.440506] systemd[1]: Started backdoor.service. host1 # [ 12.453086] systemd[1]: Starting Import lastlog data into lastlog2 database... server # [ 12.369665] systemd[1]: Finished Coldplug All udev Devices. host1 # [ 12.480204] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 12.421269] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 12.509261] systemd[1]: Starting Post-Boot Actions... host1 # [ 12.528605] systemd[1]: Started Reset console on configuration changes. host1 # [ 12.581303] systemd[1]: Starting resolvconf update... host1 # [ 12.595656] acme-setup-privileged[501]: + set -euo pipefail host1 # [ 12.600733] acme-setup-privileged[501]: + cd /var/lib/acme host1 # [ 12.605906] acme-setup-privileged[501]: + chmod -R u=rwX,g=,o= .lego/accounts host1 # connecting to host... host1 # [ 12.617176] acme-setup-privileged[501]: + chown -R acme .lego/accounts host1 # [ 12.638374] acme-setup-privileged[501]: + for fixpath in host1 .lego/host1 host1 # [ 12.644274] acme-setup-privileged[501]: + '[' -d host1 ']' host1 # [ 12.645098] acme-setup-privileged[501]: + for fixpath in host1 .lego/host1 host1 # [ 12.645975] acme-setup-privileged[501]: + '[' -d .lego/host1 ']' host1 # [ 12.676761] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 12.688703] nsncd[504]: Sep 20 07:59:58.129 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 12.624185] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. host1 # [ 12.736494] systemd[1]: Finished Post-Boot Actions. host1 # [ 12.788514] systemd[1]: Reached target Host and Network Name Lookups. host1 # [ 12.789584] systemd[1]: Reached target User and Group Name Lookups. host1 # [ 12.801738] systemd[1]: Starting D-Bus System Message Bus... server # [ 12.717965] systemd[1]: Finished register-nix-paths.service. server # [ 12.723378] systemd[1]: Reached target System Initialization. server # [ 12.725134] systemd[1]: Started Renew ACME Certificate for server. server # [ 12.727591] systemd[1]: Started Discard unused filesystem blocks once a week. server # [ 12.730732] systemd[1]: Started Daily Cleanup of Temporary Directories. server # [ 12.736521] systemd[1]: Reached target Timer Units. server # [ 12.738765] systemd[1]: Listening on D-Bus System Message Bus Socket. host1 # [ 12.827829] systemd[1]: Starting User Login Management... server # [ 12.744681] systemd[1]: Listening on Nix Daemon Socket. host1 # [ 12.833805] systemd[1]: Finished Import lastlog data into lastlog2 database. server # [ 12.754696] systemd[1]: Listening on Nix worker-protocol over gRPC. server # [ 12.759509] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. server # [ 12.772612] systemd[1]: Reached target Socket Units. server # [ 12.783323] systemd[1]: Reached target Basic System. server # [ 12.797466] systemd[1]: Starting Set up the ACME certificate renewal infrastructure... server # [ 12.807774] systemd[1]: Starting Import lastlog data into lastlog2 database... server # [ 12.821795] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 12.836748] systemd[1]: Starting Post-Boot Actions... server # [ 12.850173] systemd[1]: Started Reset console on configuration changes. server # [ 12.868872] systemd[1]: Starting resolvconf update... server # [ 12.880485] systemd[1]: Starting step-ca-pki.service... server # [ 12.895346] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. server # [ 12.915115] systemd[1]: Started backdoor.service. server # [ 12.929956] systemd[1]: Starting D-Bus System Message Bus... host1 # [ 13.050142] acme-setup-start[520]: + set -euo pipefail host1 # [ 13.054925] acme-setup-start[520]: + test -e ca/key.pem host1 # [ 13.060745] acme-setup-start[520]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local server # [ 12.989375] systemd[1]: Finished Post-Boot Actions. host1 # [ 13.078733] systemd-logind[540]: New seat seat0. host1 # [ 13.086432] dbus-broker-launch[537]: Looking up NSS user entry for 'systemd-timesync'... host1 # [ 13.093019] systemd[1]: Started User Login Management. host1 # [ 13.098132] systemd[1]: Stopped target Host and Network Name Lookups. host1 # [ 13.103378] dbus-broker-launch[537]: NSS returned no entry for 'systemd-timesync' server # [ 13.027942] acme-setup-privileged[508]: + set -euo pipefail host1 # [ 13.113777] dbus-broker-launch[537]: Invalid user-name in /nix/store/vbp0wjh4964al3ar1y5dzizpgih0kf2v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" server # [ 13.038548] acme-setup-privileged[508]: + cd /var/lib/acme host1 # [ 13.127423] systemd[1]: Stopping Host and Network Name Lookups... server # [ 13.045768] acme-setup-privileged[508]: + chmod -R u=rwX,g=,o= .lego/accounts host1 # [ 13.131703] systemd[1]: Stopped target User and Group Name Lookups. host1 # [ 13.138694] systemd[1]: Stopping User and Group Name Lookups... host1 # [ 13.144856] systemd[1]: Starting linger-users.service... server # [ 13.059642] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 13.152186] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... host1 # [ 13.158795] systemd[1]: nscd.service: Deactivated successfully. host1 # [ 13.159766] systemd[1]: Stopped Name Service Cache Daemon (nsncd). server # [ 13.076566] nsncd[510]: Sep 20 07:59:58.506 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 13.097454] acme-setup-privileged[508]: + chown -R acme .lego/accounts host1 # [ 13.183296] systemd[1]: Started D-Bus System Message Bus. server # [ 13.113016] systemd[1]: Reached target Host and Network Name Lookups. server # connecting to host... server # [ 13.127372] acme-setup-privileged[508]: + for fixpath in server .lego/server host1 # [ 13.214003] (udev-worker)[459]: Network interface NamePolicy= disabled on kernel command line. server # [ 13.133067] acme-setup-privileged[508]: + '[' -d server ']' server # [ 13.133946] acme-setup-privileged[508]: + for fixpath in server .lego/server server # [ 13.134905] acme-setup-privileged[508]: + '[' -d .lego/server ']' host1 # [ 13.220139] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 13.135799] systemd[1]: Reached target User and Group Name Lookups. host1 # [ 13.246468] dbus-broker-launch[537]: Ready host1 # [ 13.250543] systemd[1]: Finished Set up the ACME certificate renewal infrastructure. server # [ 13.166856] systemd[1]: Starting User Login Management... server # [ 13.167777] systemd[1]: Finished Import lastlog data into lastlog2 database. host1 # [ 13.258368] systemd-logind[540]: Watching system buttons on /dev/input/event0 (gpio-keys) host1 # [ 13.259956] (udev-worker)[464]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. host1 # [ 13.273951] (udev-worker)[464]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 13.280915] systemd[1]: Starting Ensure certificate for host1... host1 # [ 13.304802] systemd[1]: linger-users.service: Deactivated successfully. server: Guest shell says: b'Spawning backdoor root shell...\n' host1 # [ 13.309750] systemd[1]: Finished linger-users.service. host1 # [ 13.350247] systemd[1]: Finished resolvconf update. server: connected to guest root shell server # [ 13.269955] dbus-broker-launch[521]: Looking up NSS user entry for 'systemd-timesync'... server: (connecting took 13.88 seconds) server: (finished: waiting for the VM to finish booting, in 13.88 seconds) host1 # [ 13.359116] systemd[1]: Reached target Preparation for Network. server # [ 13.281692] dbus-broker-launch[521]: NSS returned no entry for 'systemd-timesync' server # [ 13.282918] dbus-broker-launch[521]: Invalid user-name in /nix/store/gvyyjgzkykgkdyrbr192yz9972s0sqq0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" host1 # [ 13.370830] nsncd[603]: Sep 20 07:59:58.820 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" host1 # [ 13.381254] systemd[1]: Starting DHCP Client... host1 # [ 13.386981] systemd[1]: Starting Extra networking commands.... host1 # [ 13.396402] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 13.405209] systemd[1]: Reached target Host and Network Name Lookups. host1 # [ 13.406309] systemd[1]: Reached target User and Group Name Lookups. server # [ 13.343784] systemd[1]: Started D-Bus System Message Bus. host1 # [ 13.462508] systemd[1]: Condition check resulted in Virtio network device being skipped. host1 # [ 13.473528] systemd[1]: Starting Address configuration of eth1... host1 # [ 13.483537] acme-host1-start[607]: Waiting to acquire lock in /run/acme/ host1 # [ 13.516929] acme-host1-start[607]: + '[' -e out/acme-success ']' host1 # [ 13.517941] acme-host1-start[607]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses= server # [ 13.447839] dbus-broker-launch[521]: Ready server # [ 13.459632] systemd-logind[534]: New seat seat0. server # [ 13.468283] systemd[1]: Started User Login Management. server # [ 13.480615] systemd[1]: Starting linger-users.service... host1 # [ 13.574444] acme-host1-start[645]: + cd host1 host1 # [ 13.575220] acme-host1-start[645]: + cp -vp cert.pem ../out/cert.pem host1 # [ 13.591050] acme-host1-start[646]: 'cert.pem' -> '../out/cert.pem' host1 # [ 13.598729] acme-host1-start[645]: + cp -vp key.pem ../out/key.pem host1 # [ 13.614943] acme-host1-start[645]: 'key.pem' -> '../out/key.pem' server # [ 13.534492] acme-setup-start[546]: + set -euo pipefail server # [ 13.535360] acme-setup-start[546]: + test -e ca/key.pem host1 # [ 13.620422] acme-host1-start[607]: + cat out/cert.pem ca/cert.pem server # [ 13.552121] acme-setup-start[546]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local host1 # [ 13.641760] acme-host1-start[607]: + cp ca/cert.pem out/chain.pem server # [ 13.569732] systemd[1]: Stopped target Host and Network Name Lookups. server # [ 13.570913] systemd[1]: Stopping Host and Network Name Lookups... server # [ 13.571787] systemd[1]: Stopped target User and Group Name Lookups. host1 # [ 13.661401] acme-host1-start[607]: + cat out/key.pem out/fullchain.pem server # [ 13.596808] systemd[1]: Stopping User and Group Name Lookups... server # [ 13.597772] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... host1 # [ 13.684689] acme-host1-start[607]: + for fixpath in out certificates host1 # [ 13.689964] acme-host1-start[607]: + '[' -d out ']' server # [ 13.608763] systemd[1]: nscd.service: Deactivated successfully. host1 # [ 13.696427] acme-host1-start[607]: + chmod -R u=rwX,g=rX,o= out server # [ 13.622231] systemd[1]: Stopped Name Service Cache Daemon (nsncd). host1 # [ 13.708343] acme-host1-start[607]: + chown -R acme:acme out server # [ 13.632212] systemd[1]: Starting Name Service Cache Daemon (nsncd)... host1 # [ 13.733184] network-addresses-eth1-start[633]: adding address 192.168.1.1/24... done host1 # [ 13.744234] acme-host1-start[607]: + for fixpath in out certificates host1 # [ 13.745241] acme-host1-start[607]: + '[' -d certificates ']' server # [ 13.663162] systemd[1]: linger-users.service: Deactivated successfully. server # [ 13.670540] systemd[1]: Finished linger-users.service. host1 # [ 13.756565] systemd[1]: Finished Ensure certificate for host1. host1 # [ 13.773295] network-addresses-eth1-start[633]: adding address 2001:db8:1::1/64... done host1 # [ 13.822783] systemd[1]: Finished Address configuration of eth1. host1 # [ 13.828911] dhcpcd[642]: dhcpcd-10.3.2 starting server # [ 13.754166] nsncd[610]: Sep 20 07:59:59.201 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" host1 # [ 13.847671] dhcpcd[714]: dev: loaded udev server # [ 13.764168] systemd[1]: Started Name Service Cache Daemon (nsncd). server # [ 13.766125] systemd[1]: Reached target Host and Network Name Lookups. server # [ 13.767108] systemd[1]: Reached target User and Group Name Lookups. server # [ 13.776674] systemd[1]: Finished Set up the ACME certificate renewal infrastructure. server # [ 13.779641] systemd[1]: Starting Ensure certificate for server... host1 # [ 13.917632] 8021q: 802.1Q VLAN Support v1.8 host1 # [ 13.918108] 8021q: adding VLAN 0 to HW filter on device eth1 host1 # [ 13.910071] systemd[1]: Finished Extra networking commands.. host1 # [ 13.914524] systemd[1]: Reached target Network. host1 # [ 13.924237] systemd[1]: Starting Permit User Sessions... server # [ 13.859061] systemd[1]: Finished resolvconf update. server # [ 13.868674] systemd[1]: Reached target Preparation for Network. server # [ 13.872655] systemd[1]: Starting DHCP Client... server # [ 13.879223] systemd[1]: Starting Extra networking commands.... host1 # [ 14.007039] systemd[1]: Finished Permit User Sessions. host1 # [ 14.016469] systemd[1]: Started Getty on tty1. host1 # [ 14.028171] systemd[1]: Reached target Login Prompts. host1 # [ 14.072566] cfg80211: Loading compiled-in X.509 certificates for regulatory database host1 # [ 14.113373] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' host1 # [ 14.113895] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' host1 # [ 14.118947] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 host1 # [ 14.119328] cfg80211: failed to load regulatory.db server # [ 14.025014] acme-server-start[641]: Waiting to acquire lock in /run/acme/ server # [ 14.065910] acme-server-start[641]: + '[' -e out/acme-success ']' server # [ 14.072792] acme-server-start[641]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses= host1 # [ 14.190466] mousedev: PS/2 mouse device common for all mice host1 # [ 14.233073] 8021q: adding VLAN 0 to HW filter on device eth0 host1 # [ 14.216003] dhcpcd[714]: eth0: waiting for carrier host1 # [ 14.218128] dhcpcd[714]: eth0: carrier acquired host1 # [ 14.239269] dhcpcd[714]: DUID 00:01:00:01:32:42:4e:ff:52:54:00:12:34:56 host1 # [ 14.241477] dhcpcd[714]: eth0: IAID 00:12:34:56 host1 # [ 14.242187] dhcpcd[714]: eth0: adding address fe80::5054:ff:fe12:3456 server # [ 14.159010] acme-server-start[678]: + cd server server # [ 14.161143] acme-server-start[678]: + cp -vp cert.pem ../out/cert.pem server # [ 14.184190] acme-server-start[679]: 'cert.pem' -> '../out/cert.pem' server # [ 14.191899] acme-server-start[678]: + cp -vp key.pem ../out/key.pem server # [ 14.207691] acme-server-start[678]: 'key.pem' -> '../out/key.pem' server # [ 14.211978] acme-server-start[641]: + cat out/cert.pem ca/cert.pem host1 # [ 14.298893] systemd-logind[540]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) server # [ 14.241053] step-ca-pki-start[532]: Your certificate has been saved in root_ca.crt. server # [ 14.250231] step-ca-pki-start[532]: Your private key has been saved in root_ca.key. server # [ 14.257114] acme-server-start[641]: + cp ca/cert.pem out/chain.pem server # [ 14.285913] acme-server-start[641]: + cat out/key.pem out/fullchain.pem server # [ 14.308215] acme-server-start[641]: + for fixpath in out certificates server # [ 14.316276] acme-server-start[641]: + '[' -d out ']' server # [ 14.321227] acme-server-start[641]: + chmod -R u=rwX,g=rX,o= out server # [ 14.331251] acme-server-start[641]: + chown -R acme:nix-grpc-daemon out server # [ 14.366210] acme-server-start[641]: + for fixpath in out certificates server # [ 14.367286] acme-server-start[641]: + '[' -d certificates ']' server # [ 14.380535] systemd[1]: Finished Ensure certificate for server. server # [ 14.423677] dhcpcd[671]: dhcpcd-10.3.2 starting server # [ 14.453342] step-ca-pki-start[692]: Your certificate has been saved in intermediate_ca.crt. server # [ 14.460209] dhcpcd[725]: dev: loaded udev server # [ 14.465605] step-ca-pki-start[692]: Your private key has been saved in intermediate_ca.key. server # [ 14.525715] 8021q: 802.1Q VLAN Support v1.8 server # [ 14.518628] systemd[1]: Finished step-ca-pki.service. server # [ 14.548438] (udev-worker)[646]: Network interface NamePolicy= disabled on kernel command line. server # [ 14.549796] systemd[1]: Finished Extra networking commands.. server # [ 14.550642] systemd[1]: Reached target Network. server # [ 14.575601] systemd[1]: Starting Permit User Sessions... server # [ 14.586345] (udev-worker)[647]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 14.614925] (udev-worker)[647]: Network interface NamePolicy= disabled on kernel command line. server # [ 14.638169] cfg80211: Loading compiled-in X.509 certificates for regulatory database server # [ 14.689171] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' server # [ 14.689778] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' server # [ 14.696049] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 server # [ 14.696445] cfg80211: failed to load regulatory.db server # [ 14.693898] systemd[1]: Finished Permit User Sessions. server # [ 14.699274] systemd[1]: Started Getty on tty1. server # [ 14.702977] systemd[1]: Reached target Login Prompts. server # [ 14.841028] 8021q: adding VLAN 0 to HW filter on device eth0 server # [ 14.823789] dhcpcd[725]: eth0: waiting for carrier server # [ 14.829630] dhcpcd[725]: eth0: carrier acquired server # [ 14.853703] dhcpcd[725]: DUID 00:01:00:01:32:42:4f:00:52:54:00:12:34:56 server # [ 14.856754] dhcpcd[725]: eth0: IAID 00:12:34:56 server # [ 14.859218] dhcpcd[725]: eth0: adding address fe80::5054:ff:fe12:3456 server # [ 14.918726] systemd-logind[534]: Watching system buttons on /dev/input/event0 (gpio-keys) host1 # [ 15.080937] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 server # [ 15.004973] dhcpcd[725]: eth0: IAID 00:12:34:56 server # [ 15.008845] systemd[1]: Condition check resulted in Virtio network device being skipped. server # [ 15.012672] systemd[1]: Starting Address configuration of eth1... server # [ 15.152709] 8021q: adding VLAN 0 to HW filter on device eth1 server # [ 15.160672] network-addresses-eth1-start[769]: adding address 192.168.1.2/24... done server # [ 15.181061] network-addresses-eth1-start[769]: adding address 2001:db8:1::2/64... done server # [ 15.209947] systemd[1]: Finished Address configuration of eth1. server # [ 15.248811] mousedev: PS/2 mouse device common for all mice host1 # [ 15.323949] dhcpcd[714]: eth0: soliciting an IPv6 router host1 # [ 15.325438] dhcpcd[714]: eth0: Router Advertisement from fe80::2 host1 # [ 15.328201] dhcpcd[714]: eth0: adding address fec0::5054:ff:fe12:3456/64 host1 # [ 15.329739] dhcpcd[714]: eth0: adding route to fec0::/64 host1 # [ 15.330522] dhcpcd[714]: eth0: adding default route via fe80::2 host1 # [ 15.383094] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. server # [ 15.309364] systemd-logind[534]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) host1 # [ 15.403269] systemd[1]: Starting Virtual Console Setup... host1 # [ 15.432122] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 15.439660] systemd[1]: Stopped Virtual Console Setup. host1 # [ 15.446284] systemd[1]: Starting Virtual Console Setup... host1 # [ 15.486886] systemd-logind[540]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) host1 # [ 15.783860] dhcpcd[714]: eth0: soliciting a DHCP lease host1 # [ 15.788572] dhcpcd[714]: eth0: offered 10.0.2.15 from 10.0.2.2 host1 # [ 15.796316] dhcpcd[714]: eth0: probing address 10.0.2.15/24 host1 # [ 15.928068] systemd-vconsole-setup[747]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 15.931845] systemd[1]: Finished Virtual Console Setup. server # [ 16.210121] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 server # [ 16.292727] dhcpcd[725]: eth0: soliciting a DHCP lease server # [ 16.300820] dhcpcd[725]: eth0: offered 10.0.2.15 from 10.0.2.2 server # [ 16.308317] dhcpcd[725]: eth0: probing address 10.0.2.15/24 server # [ 16.487720] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. server # [ 16.522822] systemd[1]: Starting Virtual Console Setup... server # [ 16.550430] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 16.555261] systemd[1]: Stopped Virtual Console Setup. server # [ 16.560779] systemd[1]: Starting Virtual Console Setup... server # [ 16.739386] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) server # [ 17.038131] systemd-vconsole-setup[795]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 17.043208] systemd[1]: Finished Virtual Console Setup. server # [ 17.354988] dhcpcd[725]: eth0: soliciting an IPv6 router server # [ 17.359203] dhcpcd[725]: eth0: Router Advertisement from fe80::2 server # [ 17.362079] dhcpcd[725]: eth0: adding address fec0::5054:ff:fe12:3456/64 server # [ 17.365170] dhcpcd[725]: eth0: adding route to fec0::/64 server # [ 17.367635] dhcpcd[725]: eth0: adding default route via fe80::2 host1 # [ 20.013366] dhcpcd[714]: eth0: leased 10.0.2.15 for 86400 seconds host1 # [ 20.017627] dhcpcd[714]: eth0: adding route to 10.0.2.0/24 host1 # [ 20.018180] dhcpcd[714]: eth0: adding default route via 10.0.2.2 host1 # [ 20.190929] systemd[1]: Started DHCP Client. host1 # [ 20.196553] systemd[1]: Reached target Network is Online. host1 # [ 20.199533] systemd[1]: Starting fetch-ca-root.service... host1 # [ 20.307204] fetch-ca-root-start[812]: curl: (7) Failed to connect to server:8443 after 15 ms: Could not connect to server server # [ 21.157411] dhcpcd[725]: eth0: leased 10.0.2.15 for 86400 seconds server # [ 21.164246] dhcpcd[725]: eth0: adding route to 10.0.2.0/24 server # [ 21.166867] dhcpcd[725]: eth0: adding default route via 10.0.2.2 host1 # [ 21.312329] fetch-ca-root-start[812]: curl: (7) Failed to connect to server:8443 after 2 ms: Could not connect to server server # [ 21.427165] systemd[1]: Started DHCP Client. server # [ 21.431837] systemd[1]: Reached target Network is Online. server # [ 21.435240] systemd[1]: Starting step-ca service... server # [ 21.949828] step-ca[901]: badger 2026/09/20 08:00:07 INFO: All 0 tables opened in 0s server # [ 21.980597] step-ca[901]: 2026/09/20 08:00:07 Building new tls configuration using step-ca x509 Signer Interface server # [ 21.999653] step-ca[901]: 2026/09/20 08:00:07 Starting Smallstep CA/0.30.2 (linux/arm64) server # [ 22.001066] step-ca[901]: 2026/09/20 08:00:07 Documentation: https://u.step.sm/docs/ca server # [ 22.002291] step-ca[901]: 2026/09/20 08:00:07 Community Discord: https://u.step.sm/discord server # [ 22.003835] step-ca[901]: 2026/09/20 08:00:07 Config file: /etc/smallstep/ca.json server # [ 22.005259] step-ca[901]: 2026/09/20 08:00:07 The primary server URL is https://server:8443 server # [ 22.006591] step-ca[901]: 2026/09/20 08:00:07 Root certificates are available at https://server:8443/roots.pem server # [ 22.008511] step-ca[901]: 2026/09/20 08:00:07 X.509 Root Fingerprint: 9e07f672f45d91c64deeb7c1374c94e9436194d7bdae4178209831deb4ee9889 server # [ 22.015551] systemd[1]: Started step-ca service. server # [ 22.018767] systemd[1]: Reached target Multi-User System. server # [ 22.022561] step-ca[901]: 2026/09/20 08:00:07 Serving HTTPS on 0.0.0.0:8443 ... server # [ 22.026168] systemd[1]: Starting Order (and renew) ACME certificate for server... server # [ 22.102400] acme-order-renew-server-start[913]: Waiting to acquire lock in /run/acme/ server # [ 22.114133] acme-order-renew-server-start[913]: + set -euo pipefail server # [ 22.115162] acme-order-renew-server-start[913]: + echo 95dbbf40517986466fee server # [ 22.116223] acme-order-renew-server-start[913]: + cmp -s domainhash.txt certificates/domainhash.txt server # [ 22.124516] acme-order-renew-server-start[913]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server run host1 # [ 22.369955] systemd[1]: Finished fetch-ca-root.service. host1 # [ 22.376536] systemd[1]: Reached target Multi-User System. host1 # [ 22.389844] systemd[1]: Starting Order (and renew) ACME certificate for host1... host1 # [ 22.506453] acme-order-renew-host1-start[817]: Waiting to acquire lock in /run/acme/ host1 # [ 22.522391] acme-order-renew-host1-start[817]: + set -euo pipefail host1 # [ 22.523909] acme-order-renew-host1-start[817]: + echo 76ccde284609af0e376b host1 # [ 22.525673] acme-order-renew-host1-start[817]: + cmp -s domainhash.txt certificates/domainhash.txt host1 # [ 22.536600] acme-order-renew-host1-start[817]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 run server # [ 22.465428] acme-order-renew-server-start[921]: 2026/09/20 08:00:07 No key found for account root@example.org. Generating a P256 key. server # [ 22.477772] acme-order-renew-server-start[921]: 2026/09/20 08:00:07 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key server # [ 22.518205] acme-order-renew-server-start[921]: 2026/09/20 08:00:07 [INFO] acme: Registering account for root@example.org server # [ 22.535367] acme-order-renew-server-start[921]: !!!! HEADS UP !!!! server # [ 22.537699] acme-order-renew-server-start[921]: Your account credentials have been saved in your server # [ 22.539167] acme-order-renew-server-start[921]: configuration directory at "accounts". server # [ 22.540413] acme-order-renew-server-start[921]: You should make a secure backup of this folder now. This server # [ 22.542110] acme-order-renew-server-start[921]: configuration directory will also contain private keys server # [ 22.543771] acme-order-renew-server-start[921]: generated by lego and certificates obtained from the ACME server # [ 22.545311] acme-order-renew-server-start[921]: server. Making regular backups of this folder is ideal. server # [ 22.546641] acme-order-renew-server-start[921]: 2026/09/20 08:00:07 [INFO] [server] acme: Obtaining bundled SAN certificate server # [ 22.624461] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] AuthURL: https://server:8443/acme/acme/authz/6KzC2mYQwfIpHctNrMsFu4u0peh1pul9 server # [ 22.627978] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] acme: Could not find solver for: tls-alpn-01 server # [ 22.634159] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] acme: use http-01 solver server # [ 22.635871] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] acme: Trying to solve HTTP-01 server # [ 22.654662] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] Served key authentication server # [ 22.665555] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] The server validated our request server # [ 22.667477] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] acme: Validations succeeded; requesting certificates server # [ 22.700293] acme-order-renew-server-start[921]: 2026/09/20 08:00:08 [INFO] [server] Server responded with a certificate. server # [ 22.706970] acme-order-renew-server-start[913]: + mv domainhash.txt certificates/ server # [ 22.721572] acme-order-renew-server-start[913]: + touch out/acme-success server: (finished: waiting for unit step-ca.service, in 23.35 seconds) server # [ 22.731048] acme-order-renew-server-start[913]: + cmp -s certificates/server.crt out/fullchain.pem server: waiting for unit nix-grpc-daemon.socket server # [ 22.736962] acme-order-renew-server-start[913]: + touch out/renewed server # [ 22.746148] acme-order-renew-server-start[913]: + echo Installing new certificate server # [ 22.747344] acme-order-renew-server-start[913]: Installing new certificate server # [ 22.748516] acme-order-renew-server-start[913]: + cp -vp certificates/server.crt out/fullchain.pem server # [ 22.760756] acme-order-renew-server-start[938]: 'certificates/server.crt' -> 'out/fullchain.pem' server # [ 22.763574] acme-order-renew-server-start[913]: + cp -vp certificates/server.key out/key.pem server # [ 22.773981] acme-order-renew-server-start[939]: 'certificates/server.key' -> 'out/key.pem' server # [ 22.776114] acme-order-renew-server-start[913]: + cp -vp certificates/server.issuer.crt out/chain.pem server # [ 22.785910] acme-order-renew-server-start[941]: 'certificates/server.issuer.crt' -> 'out/chain.pem' server # [ 22.790069] acme-order-renew-server-start[913]: + ln -sf fullchain.pem out/cert.pem host1 # [ 22.879912] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 No key found for account root@example.org. Generating a P256 key. host1 # [ 22.884742] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key server # [ 22.804440] acme-order-renew-server-start[913]: + cat out/key.pem out/fullchain.pem server # [ 22.812119] acme-order-renew-server-start[913]: + for fixpath in out certificates server # [ 22.814271] acme-order-renew-server-start[913]: + '[' -d out ']' server # [ 22.815399] acme-order-renew-server-start[913]: + chmod -R u=rwX,g=rX,o= out server # [ 22.823957] acme-order-renew-server-start[913]: + chown -R acme:nix-grpc-daemon out host1 # [ 22.917462] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] acme: Registering account for root@example.org server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.11 seconds) server # [ 22.847136] acme-order-renew-server-start[913]: + for fixpath in out certificates server: waiting for TCP port 50051 on localhost server # [ 22.851128] acme-order-renew-server-start[913]: + '[' -d certificates ']' server # [ 22.854243] acme-order-renew-server-start[913]: + chmod -R u=rwX,g=rX,o= certificates host1 # [ 22.944223] acme-order-renew-host1-start[825]: !!!! HEADS UP !!!! host1 # [ 22.946118] acme-order-renew-host1-start[825]: Your account credentials have been saved in your host1 # [ 22.947493] acme-order-renew-host1-start[825]: configuration directory at "accounts". host1 # [ 22.948611] acme-order-renew-host1-start[825]: You should make a secure backup of this folder now. This host1 # [ 22.949810] acme-order-renew-host1-start[825]: configuration directory will also contain private keys host1 # [ 22.951015] acme-order-renew-host1-start[825]: generated by lego and certificates obtained from the ACME host1 # [ 22.952289] acme-order-renew-host1-start[825]: server. Making regular backups of this folder is ideal. server # [ 22.868129] acme-order-renew-server-start[913]: + chown -R acme:nix-grpc-daemon certificates host1 # [ 22.953505] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] acme: Obtaining bundled SAN certificate server # [ 22.888497] acme-order-renew-server-start[913]: + chmod -R u=rwX,g=,o= accounts/. host1 # [ 23.040198] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] AuthURL: https://server:8443/acme/acme/authz/rolzyGF5MBjLoHKQ1JkO1pO2JfnZV6Tb host1 # [ 23.047898] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] acme: Could not find solver for: tls-alpn-01 host1 # [ 23.052341] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] acme: use http-01 solver host1 # [ 23.055823] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] acme: Trying to solve HTTP-01 server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded! host1 # [ 23.063705] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] Served key authentication server: (finished: waiting for TCP port 50051 on localhost, in 0.14 seconds) subtest: host1 obtains a certificate via ACME host1: waiting for success: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA' host1: waiting for the VM to finish booting host1: Guest shell says: b'Spawning backdoor root shell...\n' host1: connected to guest root shell host1: (connecting took 0.00 seconds) host1: (finished: waiting for the VM to finish booting, in 0.00 seconds) host1 # [ 23.077624] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] The server validated our request server # [ 23.004925] systemd[1]: acme-order-renew-server.service: Deactivated successfully. host1 # [ 23.087317] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] acme: Validations succeeded; requesting certificates server # [ 23.009191] systemd[1]: Finished Order (and renew) ACME certificate for server. server # [ 23.010381] systemd[1]: acme-order-renew-server.service: Consumed 279ms CPU time over 980ms wall clock time, 33.6M memory peak, 10.2K incoming IP traffic, 8.2K outgoing IP traffic. server # [ 23.025346] systemd[1]: Starting Nix worker-protocol over gRPC... host1 # [ 23.138809] acme-order-renew-host1-start[825]: 2026/09/20 08:00:08 [INFO] [host1] Server responded with a certificate. host1 # [ 23.148346] acme-order-renew-host1-start[817]: + mv domainhash.txt certificates/ host1 # [ 23.163838] acme-order-renew-host1-start[817]: + touch out/acme-success host1 # [ 23.178445] acme-order-renew-host1-start[817]: + cmp -s certificates/host1.crt out/fullchain.pem host1 # [ 23.185778] acme-order-renew-host1-start[817]: + touch out/renewed host1 # [ 23.201599] acme-order-renew-host1-start[817]: + echo Installing new certificate host1 # [ 23.203063] acme-order-renew-host1-start[817]: Installing new certificate host1 # [ 23.205169] acme-order-renew-host1-start[817]: + cp -vp certificates/host1.crt out/fullchain.pem host1 # [ 23.216450] acme-order-renew-host1-start[839]: 'certificates/host1.crt' -> 'out/fullchain.pem' host1 # [ 23.219810] acme-order-renew-host1-start[817]: + cp -vp certificates/host1.key out/key.pem host1 # [ 23.229535] acme-order-renew-host1-start[840]: 'certificates/host1.key' -> 'out/key.pem' host1 # [ 23.234318] acme-order-renew-host1-start[817]: + cp -vp certificates/host1.issuer.crt out/chain.pem host1 # [ 23.244501] acme-order-renew-host1-start[841]: 'certificates/host1.issuer.crt' -> 'out/chain.pem' host1 # [ 23.248656] acme-order-renew-host1-start[817]: + ln -sf fullchain.pem out/cert.pem host1 # [ 23.262384] acme-order-renew-host1-start[817]: + cat out/key.pem out/fullchain.pem host1 # [ 23.270291] acme-order-renew-host1-start[817]: + for fixpath in out certificates host1 # [ 23.271623] acme-order-renew-host1-start[817]: + '[' -d out ']' host1 # [ 23.272879] acme-order-renew-host1-start[817]: + chmod -R u=rwX,g=rX,o= out host1 # [ 23.280467] acme-order-renew-host1-start[817]: + chown -R acme:acme out host1 # [ 23.291396] acme-order-renew-host1-start[817]: + for fixpath in out certificates host1 # [ 23.292831] acme-order-renew-host1-start[817]: + '[' -d certificates ']' host1 # [ 23.293881] acme-order-renew-host1-start[817]: + chmod -R u=rwX,g=rX,o= certificates host1 # [ 23.301310] acme-order-renew-host1-start[817]: + chown -R acme:acme certificates host1 # [ 23.311046] acme-order-renew-host1-start[817]: + chmod -R u=rwX,g=,o= accounts/. server # [ 23.283422] nix-grpc-daemon[963]: ts=2026-09-20T08:00:08Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1 host1 # [ 23.382506] systemd[1]: acme-order-renew-host1.service: Deactivated successfully. host1 # [ 23.385081] systemd[1]: Finished Order (and renew) ACME certificate for host1. host1 # [ 23.400398] systemd[1]: Startup finished in 1.121s (kernel) + 5.489s (initrd) + 16.789s (userspace) = 23.400s. host1 # [ 23.404395] systemd[1]: acme-order-renew-host1.service: Consumed 291ms CPU time over 994ms wall clock time, 33.6M memory peak, 10.4K incoming IP traffic, 8.3K outgoing IP traffic. server # [ 23.339391] nix-grpc-daemon[963]: ts=2026-09-20T08:00:08Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket server # [ 23.343161] nix-grpc-daemon[963]: ts=2026-09-20T08:00:08Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0 server # [ 23.345692] systemd[1]: Started Nix worker-protocol over gRPC. server # [ 23.346928] nix-grpc-daemon[963]: ts=2026-09-20T08:00:08Z level=info event=unhealthy reason=min_free server # [ 23.348355] systemd[1]: Startup finished in 1.128s (kernel) + 5.594s (initrd) + 16.618s (userspace) = 23.341s. host1: (finished: waiting for success: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA', in 1.31 seconds) host1: must succeed: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1' host1: (finished: must succeed: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1', in 0.07 seconds) (finished: subtest: host1 obtains a certificate via ACME, in 1.38 seconds) subtest: server builds and signs a path server: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 14 ms (attempt 1/5) server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 72 ms (attempt 2/5) server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 283 ms (attempt 3/5) server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 105 ms (attempt 4/5) server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org server # this derivation will be built: server # /nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv server # building '/nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv'... server: (finished: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths, in 1.23 seconds) server: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' server # added 1 signatures server: (finished: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.25 seconds) (finished: subtest: server builds and signs a path, in 1.48 seconds) subtest: host1 substitutes the signed path over gRPC (read-only cert) host1: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' host1: (finished: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.05 seconds) host1: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 41 ms (attempt 1/5) host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 178 ms (attempt 2/5) host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 278 ms (attempt 3/5) host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 235 ms (attempt 4/5) host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org server # [ 26.994795] systemd[1]: Started Nix Daemon. server # [ 27.273183] nix-daemon[996]: accepted connection from pid 963, user nix-grpc-daemon (trusted) host1 # this path will be fetched (0.0 KiB download, 0.1 KiB unpacked): host1 # /nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc host1 # copying path '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' from 'grpc://server:50051'... server # [ 27.329564] nix-grpc-daemon[963]: ts=2026-09-20T08:00:12Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:43584 duration_s=0 paths=1 nar_bytes_out=128 host1 # warning: you did not specify '--add-root'; the result might be removed by the garbage collector host1: (finished: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 1.51 seconds) host1: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' host1: (finished: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.04 seconds) (finished: subtest: host1 substitutes the signed path over gRPC (read-only cert), in 1.60 seconds) subtest: read-only host1 cannot write host1: must succeed: echo deny > /root/denyfile host1: (finished: must succeed: echo deny > /root/denyfile, in 0.02 seconds) host1: must fail: nix store add --store 'grpc://server:50051?ca-cert=/run/root_ca.crt&client-cert=/var/lib/acme/host1/cert.pem&client-key=/var/lib/acme/host1/key.pem' /root/denyfile server # [ 27.727530] nix-grpc-daemon[963]: ts=2026-09-20T08:00:13Z level=info event=denied method=Connect cn=host1 role=read-only host1 # error: gRPC Connect on 'server:50051' failed: role 'read-only' may not call Connect host1 # error: cannot open connection to remote store 'grpc://server:50051': error: Nix daemon disconnected unexpectedly (maybe it crashed?) host1: (finished: must fail: nix store add --store 'grpc://server:50051?ca-cert=/run/root_ca.crt&client-cert=/var/lib/acme/host1/cert.pem&client-key=/var/lib/acme/host1/key.pem' /root/denyfile, in 0.31 seconds) server: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only' server: (finished: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only', in 0.07 seconds) (finished: subtest: read-only host1 cannot write, in 0.41 seconds) (finished: run the VM test script, in 29.09 seconds) test script finished in 29.26s cleanup kill QemuMachine (pid 47) host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) kill QemuMachine (pid 48) server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14) (finished: cleanup, in 0.52 seconds) additionally exposed symbols: host1, server, 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