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 server # Disk image does not exist, creating the virtualisation disk image... server: QEMU running (pid 48) server # Formatting '/build/vm-state-server/tmp.KbKJZOsrTd', fmt=raw size=1073741824 host1 # Disk image does not exist, creating the virtualisation disk image... server # mke2fs 1.47.4 (6-Mar-2025) host1 # Formatting '/build/vm-state-host1/tmp.hXrgXdrMaA', fmt=raw size=1073741824 server # Discarding device blocks: 0/262144 done host1 # mke2fs 1.47.4 (6-Mar-2025) server # Creating filesystem with 262144 4k blocks and 65536 inodes host1 # Discarding device blocks: 0/262144 done server # Filesystem UUID: 4749a991-77d9-4a8f-8bad-67f06a2a49b3 host1 # Creating filesystem with 262144 4k blocks and 65536 inodes server # Superblock backups stored on blocks: host1 # Filesystem UUID: 51e8bc18-1023-43e1-ae96-0c635174dbe2 server # 32768, 98304, 163840, 229376 host1 # Superblock backups stored on blocks: server # host1 # 32768, 98304, 163840, 229376 server # Allocating group tables: 0/8 done host1 # server # Writing inode tables: 0/8 done host1 # Allocating group tables: 0/8 done server # Creating journal (8192 blocks): done host1 # Writing inode tables: 0/8 done server # Writing superblocks and filesystem accounting information: 0/8 done host1 # Creating journal (8192 blocks): done server # host1 # Writing superblocks and filesystem accounting information: 0/8 done server # Virtualisation disk image created. host1 # host1: QEMU running (pid 47) host1 # Virtualisation disk image created. (finished: start all VMs, in 0.55 seconds) server: waiting for unit step-ca.service server: waiting for the VM to finish booting server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] 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 server # [ 0.000000] KASLR enabled server # [ 0.000000] random: crng init done server # [ 0.000000] Machine model: linux,dummy-virt server # [ 0.000000] efi: UEFI not found. server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f] server # [ 0.000000] Zone ranges: server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] server # [ 0.000000] DMA32 empty server # [ 0.000000] Normal empty server # [ 0.000000] Device empty server # [ 0.000000] Movable zone start for each node server # [ 0.000000] Early memory node ranges server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000 server # [ 0.000000] psci: probing for conduit method from DT. server # [ 0.000000] psci: PSCIv1.3 detected in firmware. server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs server # [ 0.000000] psci: Trusted OS migration not required server # [ 0.000000] psci: SMC Calling Convention v1.1 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 server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) server # [ 0.000000] CPU features: detected: GICv3 CPU interface server # [ 0.000000] CPU features: detected: Spectre-v4 server # [ 0.000000] CPU features: detected: Spectre-BHB server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 server # [ 0.000000] alternatives: applying boot alternatives 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/4sgbb71nw078lpy3940kgcqaqc98ppqm-nixos-system-server-test/init regInfo=/nix/store/8kpzqb0wms92f03i5ylz6n4438d8aa1b-closure-info/registration console=ttyAMA0,115200n8 console=tty0 server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/8kpzqb0wms92f03i5ylz6n4438d8aa1b-closure-info/registration", will be passed to user space. server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB server # [ 0.000000] software IO TLB: area num 1. server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB) server # [ 0.000000] Fallback order for Node 0: 0 server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288 server # [ 0.000000] Policy zone: DMA server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 server # [ 0.000000] allocated 4194304 bytes of page_ext 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 server # [ 0.000000] ftrace: allocating 74885 entries in 294 pages host1 # [ 0.000000] random: crng init done server # [ 0.000000] ftrace: allocated 294 pages with 4 groups host1 # [ 0.000000] Machine model: linux,dummy-virt server # [ 0.000000] rcu: Hierarchical RCU implementation. host1 # [ 0.000000] efi: UEFI not found. server # [ 0.000000] rcu: RCU event tracing is enabled. host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] server # [ 0.000000] Trampoline variant of Tasks RCU enabled. host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f] server # [ 0.000000] Rude variant of Tasks RCU enabled. host1 # [ 0.000000] Zone ranges: server # [ 0.000000] Tracing variant of Tasks RCU enabled. host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] DMA32 empty server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. host1 # [ 0.000000] Normal empty host1 # [ 0.000000] Device empty server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 host1 # [ 0.000000] Movable zone start for each node host1 # [ 0.000000] Early memory node ranges 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.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] 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.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000 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.000000] psci: probing for conduit method from DT. server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware. server # [ 0.000000] GICv3: 256 SPIs implemented host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs server # [ 0.000000] GICv3: 0 Extended SPIs implemented host1 # [ 0.000000] psci: Trusted OS migration not required server # [ 0.000000] Root IRQ handler: gic_handle_irq host1 # [ 0.000000] psci: SMC Calling Convention v1.1 server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296 server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] host1 # [ 0.000000] Detected PIPT I-cache on CPU0 server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1) host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1) host1 # [ 0.000000] CPU features: detected: Spectre-v4 host1 # [ 0.000000] CPU features: detected: Spectre-BHB server # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000 host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000 host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. host1 # [ 0.000000] alternatives: applying boot alternatives 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 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/gs9wxvhqnagxz34vl4cmjirjiipkv6ss-nixos-system-host1-test/init regInfo=/nix/store/jb5xlsfl8dnmdaw4sldki64rjjzvimbj-closure-info/registration console=ttyAMA0,115200n8 console=tty0 server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns server # [ 0.000032] arm-pv: using stolen time PV server # [ 0.000443] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/jb5xlsfl8dnmdaw4sldki64rjjzvimbj-closure-info/registration", will be passed to user space. server # [ 0.000632] Console: colour dummy device 80x25 server # [ 0.000640] printk: legacy console [tty0] enabled 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) server # [ 0.000836] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) server # [ 0.000843] pid_max: default: 32768 minimum: 301 host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) server # [ 0.000919] LSM: initializing lsm=capability,landlock,yama,bpf,ima host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB server # [ 0.001055] landlock: Up and running. host1 # [ 0.000000] software IO TLB: area num 1. server # [ 0.001058] Yama: becoming mindful. server # [ 0.001537] LSM support for eBPF active host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB) server # [ 0.001677] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) host1 # [ 0.000000] Fallback order for Node 0: 0 host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288 server # [ 0.001715] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) host1 # [ 0.000000] Policy zone: DMA server # [ 0.002841] cacheinfo: Unable to detect cache hierarchy for CPU 0 host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off server # [ 0.003559] rcu: Hierarchical SRCU implementation. host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 server # [ 0.003564] rcu: Max phase no-delay instances is 1000. host1 # [ 0.000000] allocated 4194304 bytes of page_ext server # [ 0.005042] fsl-mc MSI: its@8080000 domain created host1 # [ 0.000000] ftrace: allocating 74885 entries in 294 pages server # [ 0.005134] EFI services will not be available. host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups server # [ 0.005202] smp: Bringing up secondary CPUs ... server # [ 0.005210] smp: Brought up 1 node, 1 CPU host1 # [ 0.000000] rcu: Hierarchical RCU implementation. server # [ 0.005214] SMP: Total of 1 processors activated. host1 # [ 0.000000] rcu: RCU event tracing is enabled. server # [ 0.005216] CPU: All CPU(s) started at EL1 host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. server # [ 0.005231] CPU features: detected: Branch Target Identification host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled. server # [ 0.005236] CPU features: detected: ARMv8.4 Translation Table Level host1 # [ 0.000000] Rude variant of Tasks RCU enabled. host1 # [ 0.000000] Tracing variant of Tasks RCU enabled. server # [ 0.005239] CPU features: detected: Instruction cache invalidation not required for I/D coherence host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. server # [ 0.005242] CPU features: detected: Data cache clean to the PoU not required for I/D coherence host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 server # [ 0.005246] CPU features: detected: Common not Private translations server # [ 0.005249] CPU features: detected: CRC32 instructions host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.005252] CPU features: detected: Data cache clean to Point of Deep Persistence host1 # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.005255] CPU features: detected: Data cache clean to Point of Persistence host1 # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. server # [ 0.005259] CPU features: detected: Data independent timing control (DIT) host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 server # [ 0.005262] CPU features: detected: E0PD host1 # [ 0.000000] GICv3: 256 SPIs implemented server # [ 0.005264] CPU features: detected: Enhanced Counter Virtualization host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented host1 # [ 0.000000] Root IRQ handler: gic_handle_irq server # [ 0.005267] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI server # [ 0.005271] CPU features: detected: Enhanced Virtualization Traps host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 server # [ 0.005274] CPU features: detected: Fine Grained Traps host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] server # [ 0.005277] CPU features: detected: Generic authentication (architected QARMA5 algorithm) server # [ 0.005282] CPU features: detected: RCpc load-acquire (LDAPR) host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1) server # [ 0.005285] CPU features: detected: LSE atomic instructions server # [ 0.005288] CPU features: detected: Privileged Access Never host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1) server # [ 0.005291] CPU features: detected: PMUv3 host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000 host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000 server # [ 0.005293] CPU features: detected: RAS Extension Support server # [ 0.005296] CPU features: detected: RASv1p1 Extension Support host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. server # [ 0.005299] CPU features: detected: Random Number Generator host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns server # [ 0.005301] CPU features: detected: Speculation barrier (SB) host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). server # [ 0.005304] CPU features: detected: Stage-2 Force Write-Back server # [ 0.005307] CPU features: detected: TLB range maintenance instructions host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns server # [ 0.005312] CPU features: detected: Speculative Store Bypassing Safe (SSBS) host1 # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns server # [ 0.005349] alternatives: applying system-wide alternatives host1 # [ 0.000029] arm-pv: using stolen time PV server # [ 0.008408] CPU features: detected: BBM Level 2 without TLB conflict abort host1 # [ 0.000386] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) host1 # [ 0.000552] Console: colour dummy device 80x25 server # [ 0.008674] Memory: 1921600K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131956K reserved, 32768K cma-reserved) host1 # [ 0.000560] printk: legacy console [tty0] enabled server # [ 0.009101] devtmpfs: initialized server # [ 0.011074] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) host1 # [ 0.000752] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) host1 # [ 0.000758] pid_max: default: 32768 minimum: 301 server # [ 0.011097] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). host1 # [ 0.000827] LSM: initializing lsm=capability,landlock,yama,bpf,ima server # [ 0.011292] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL host1 # [ 0.000995] landlock: Up and running. server # [ 0.011296] 0 pages in range for non-PLT usage host1 # [ 0.000998] Yama: becoming mindful. host1 # [ 0.001431] LSM support for eBPF active server # [ 0.011297] 508288 pages in range for PLT usage server # [ 0.011401] pinctrl core: initialized pinctrl subsystem host1 # [ 0.001549] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) server # [ 0.012260] DMI not present or invalid. host1 # [ 0.001582] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) server # [ 0.015441] NET: Registered PF_NETLINK/PF_ROUTE protocol family host1 # [ 0.002687] cacheinfo: Unable to detect cache hierarchy for CPU 0 server # [ 0.017817] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations host1 # [ 0.003578] rcu: Hierarchical SRCU implementation. server # [ 0.018001] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations host1 # [ 0.003583] rcu: Max phase no-delay instances is 1000. host1 # [ 0.004801] fsl-mc MSI: its@8080000 domain created server # [ 0.018208] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations host1 # [ 0.004890] EFI services will not be available. server # [ 0.018229] audit: initializing netlink subsys (disabled) host1 # [ 0.004952] smp: Bringing up secondary CPUs ... host1 # [ 0.004960] smp: Brought up 1 node, 1 CPU server # [ 0.018791] thermal_sys: Registered thermal governor 'fair_share' host1 # [ 0.004963] SMP: Total of 1 processors activated. server # [ 0.018794] thermal_sys: Registered thermal governor 'bang_bang' host1 # [ 0.004966] CPU: All CPU(s) started at EL1 server # [ 0.018797] thermal_sys: Registered thermal governor 'step_wise' host1 # [ 0.004979] CPU features: detected: Branch Target Identification server # [ 0.018800] thermal_sys: Registered thermal governor 'user_space' host1 # [ 0.004984] CPU features: detected: ARMv8.4 Translation Table Level server # [ 0.018805] thermal_sys: Registered thermal governor 'power_allocator' host1 # [ 0.004988] CPU features: detected: Instruction cache invalidation not required for I/D coherence server # [ 0.018836] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 server # [ 0.018845] cpuidle: using governor ladder host1 # [ 0.004991] CPU features: detected: Data cache clean to the PoU not required for I/D coherence server # [ 0.018850] cpuidle: using governor menu host1 # [ 0.004995] CPU features: detected: Common not Private translations server # [ 0.019053] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. host1 # [ 0.004998] CPU features: detected: CRC32 instructions server # [ 0.019069] ASID allocator initialised with 65536 entries server # [ 0.020314] Serial: AMBA PL011 UART driver host1 # [ 0.005001] CPU features: detected: Data cache clean to Point of Deep Persistence host1 # [ 0.005005] CPU features: detected: Data cache clean to Point of Persistence server # [ 0.025519] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 server # [ 0.025676] printk: console [ttyAMA0] enabled host1 # [ 0.005008] CPU features: detected: Data independent timing control (DIT) host1 # [ 0.005011] CPU features: detected: E0PD host1 # [ 0.005014] CPU features: detected: Enhanced Counter Virtualization host1 # [ 0.005016] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) host1 # [ 0.005019] CPU features: detected: Enhanced Virtualization Traps host1 # [ 0.005022] CPU features: detected: Fine Grained Traps host1 # [ 0.005026] CPU features: detected: Generic authentication (architected QARMA5 algorithm) host1 # [ 0.005031] CPU features: detected: RCpc load-acquire (LDAPR) host1 # [ 0.005034] CPU features: detected: LSE atomic instructions host1 # [ 0.005038] CPU features: detected: Privileged Access Never host1 # [ 0.005040] CPU features: detected: PMUv3 host1 # [ 0.005043] CPU features: detected: RAS Extension Support host1 # [ 0.005046] CPU features: detected: RASv1p1 Extension Support server # [ 0.148713] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages host1 # [ 0.005049] CPU features: detected: Random Number Generator server # [ 0.148731] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page host1 # [ 0.005051] CPU features: detected: Speculation barrier (SB) server # [ 0.148737] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages host1 # [ 0.005054] CPU features: detected: Stage-2 Force Write-Back server # [ 0.148741] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page host1 # [ 0.005057] CPU features: detected: TLB range maintenance instructions server # [ 0.148745] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages host1 # [ 0.005062] CPU features: detected: Speculative Store Bypassing Safe (SSBS) server # [ 0.148750] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page host1 # [ 0.005099] alternatives: applying system-wide alternatives server # [ 0.148754] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages host1 # [ 0.007962] CPU features: detected: BBM Level 2 without TLB conflict abort server # [ 0.148758] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page host1 # [ 0.008113] Memory: 1921564K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131976K reserved, 32768K cma-reserved) host1 # [ 0.008532] devtmpfs: initialized server # [ 0.156361] fbcon: Taking over console server # [ 0.156377] ACPI: Interpreter disabled. host1 # [ 0.010426] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) server # [ 0.165008] iommu: Default domain type: Translated host1 # [ 0.010449] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). server # [ 0.165020] iommu: DMA domain TLB invalidation policy: strict mode host1 # [ 0.010614] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL server # [ 0.165424] SCSI subsystem initialized host1 # [ 0.010619] 0 pages in range for non-PLT usage host1 # [ 0.010620] 508288 pages in range for PLT usage server # [ 0.167497] usbcore: registered new interface driver usbfs host1 # [ 0.010697] pinctrl core: initialized pinctrl subsystem server # [ 0.167530] usbcore: registered new interface driver hub host1 # [ 0.011462] DMI not present or invalid. server # [ 0.167555] usbcore: registered new device driver usb host1 # [ 0.014574] NET: Registered PF_NETLINK/PF_ROUTE protocol family server # [ 0.167832] pps_core: LinuxPPS API ver. 1 registered host1 # [ 0.016834] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations server # [ 0.167841] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti host1 # [ 0.017027] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations server # [ 0.167850] PTP clock support registered server # [ 0.167905] EDAC MC: Ver: 3.0.0 host1 # [ 0.017235] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations server # [ 0.172686] scmi_core: SCMI protocol bus registered host1 # [ 0.017256] audit: initializing netlink subsys (disabled) host1 # [ 0.017919] thermal_sys: Registered thermal governor 'fair_share' server # [ 0.173704] FPGA manager framework server # [ 0.174664] vgaarb: loaded host1 # [ 0.017921] thermal_sys: Registered thermal governor 'bang_bang' host1 # [ 0.017925] thermal_sys: Registered thermal governor 'step_wise' server # [ 0.175329] clocksource: Switched to clocksource arch_sys_counter host1 # [ 0.017927] thermal_sys: Registered thermal governor 'user_space' host1 # [ 0.017933] thermal_sys: Registered thermal governor 'power_allocator' host1 # [ 0.017957] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 host1 # [ 0.017966] cpuidle: using governor ladder host1 # [ 0.017972] cpuidle: using governor menu host1 # [ 0.018154] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. server # [ 0.179850] VFS: Disk quotas dquot_6.6.0 host1 # [ 0.018169] ASID allocator initialised with 65536 entries host1 # [ 0.019293] Serial: AMBA PL011 UART driver server # [ 0.179899] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) host1 # [ 0.024411] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 server # [ 0.181615] netfs: FS-Cache loaded server # [ 0.181740] pnp: PnP ACPI: disabled host1 # [ 0.024529] printk: console [ttyAMA0] enabled host1 # [ 0.148434] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages host1 # [ 0.148457] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page host1 # [ 0.148462] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages host1 # [ 0.148466] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page host1 # [ 0.148471] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages server # [ 0.186095] NET: Registered PF_INET protocol family host1 # [ 0.148475] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page server # [ 0.186359] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) host1 # [ 0.148479] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages host1 # [ 0.148483] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page host1 # [ 0.156190] fbcon: Taking over console host1 # [ 0.156209] ACPI: Interpreter disabled. host1 # [ 0.158098] iommu: Default domain type: Translated host1 # [ 0.158108] iommu: DMA domain TLB invalidation policy: strict mode host1 # [ 0.159734] SCSI subsystem initialized host1 # [ 0.164885] usbcore: registered new interface driver usbfs host1 # [ 0.164917] usbcore: registered new interface driver hub host1 # [ 0.164941] usbcore: registered new device driver usb host1 # [ 0.165227] pps_core: LinuxPPS API ver. 1 registered host1 # [ 0.165236] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti host1 # [ 0.165247] PTP clock support registered host1 # [ 0.165303] EDAC MC: Ver: 3.0.0 host1 # [ 0.169914] scmi_core: SCMI protocol bus registered host1 # [ 0.170888] FPGA manager framework host1 # [ 0.171871] vgaarb: loaded host1 # [ 0.172521] clocksource: Switched to clocksource arch_sys_counter host1 # [ 0.176574] VFS: Disk quotas dquot_6.6.0 host1 # [ 0.176605] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) host1 # [ 0.180336] netfs: FS-Cache loaded host1 # [ 0.180457] pnp: PnP ACPI: disabled host1 # [ 0.184841] NET: Registered PF_INET protocol family server # [ 0.216488] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) host1 # [ 0.185113] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) server # [ 0.216532] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) server # [ 0.216561] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) server # [ 0.216637] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) server # [ 0.216786] TCP: Hash tables configured (established 16384 bind 16384) server # [ 0.216879] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) server # [ 0.216915] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.216953] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) server # [ 0.217055] NET: Registered PF_UNIX/PF_LOCAL protocol family server # [ 0.217092] NET: Registered PF_XDP protocol family server # [ 0.217112] PCI: CLS 0 bytes, default 64 server # [ 0.217367] Trying to unpack rootfs image as initramfs... server # [ 0.233171] kvm [1]: HYP mode not available host1 # [ 0.215359] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) host1 # [ 0.215407] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) host1 # [ 0.215436] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) host1 # [ 0.215512] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) host1 # [ 0.215657] TCP: Hash tables configured (established 16384 bind 16384) host1 # [ 0.215760] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear) host1 # [ 0.215793] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear) host1 # [ 0.215854] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear) host1 # [ 0.215964] NET: Registered PF_UNIX/PF_LOCAL protocol family host1 # [ 0.215994] NET: Registered PF_XDP protocol family host1 # [ 0.216019] PCI: CLS 0 bytes, default 64 host1 # [ 0.216291] Trying to unpack rootfs image as initramfs... host1 # [ 0.234417] kvm [1]: HYP mode not available server # [ 0.332084] Initialise system trusted keyrings server # [ 0.332856] workingset: timestamp_bits=42 max_order=19 bucket_order=0 server # [ 0.334250] squashfs: version 4.0 (2009/01/31) Phillip Lougher server # [ 0.335028] 9p: Installing v9fs 9p2000 file system support server # [ 0.363898] Key type asymmetric registered server # [ 0.363927] Asymmetric key parser 'x509' registered server # [ 0.364022] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) host1 # [ 0.331188] Initialise system trusted keyrings server # [ 0.366183] io scheduler mq-deadline registered server # [ 0.366198] io scheduler kyber registered host1 # [ 0.331975] workingset: timestamp_bits=42 max_order=19 bucket_order=0 host1 # [ 0.333364] squashfs: version 4.0 (2009/01/31) Phillip Lougher host1 # [ 0.334157] 9p: Installing v9fs 9p2000 file system support server # [ 0.379742] pl061_gpio 9030000.pl061: PL061 GPIO chip registered server # [ 0.380448] ledtrig-cpu: registered to indicate activity on CPUs server # [ 0.380878] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: host1 # [ 0.354252] Key type asymmetric registered host1 # [ 0.354280] Asymmetric key parser 'x509' registered server # [ 0.380898] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 host1 # [ 0.354354] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) server # [ 0.380911] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 server # [ 0.380919] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 server # [ 0.380960] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits server # [ 0.380991] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] server # [ 0.381099] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 host1 # [ 0.360593] io scheduler mq-deadline registered host1 # [ 0.360610] io scheduler kyber registered server # [ 0.381112] pci_bus 0000:00: root bus resource [bus 00-ff] server # [ 0.381118] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] server # [ 0.381123] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] server # [ 0.381128] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] server # [ 0.381227] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint server # [ 0.381689] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.381890] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] server # [ 0.381908] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.381937] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.381953] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] server # [ 0.382422] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.382611] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] server # [ 0.382633] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.382663] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.383116] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.383298] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] host1 # [ 0.372699] pl061_gpio 9030000.pl061: PL061 GPIO chip registered server # [ 0.383319] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.383377] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.383825] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.374177] ledtrig-cpu: registered to indicate activity on CPUs server # [ 0.384017] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] server # [ 0.384034] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.374567] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: server # [ 0.384063] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.374586] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 server # [ 0.384531] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.374606] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 server # [ 0.384711] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] server # [ 0.384727] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.374615] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 server # [ 0.384757] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.374646] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits server # [ 0.385215] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint server # [ 0.385395] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] host1 # [ 0.374670] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] server # [ 0.385411] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.374777] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 host1 # [ 0.374876] pci_bus 0000:00: root bus resource [bus 00-ff] server # [ 0.385440] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.374894] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] server # [ 0.385879] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint host1 # [ 0.374909] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] server # [ 0.386061] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] server # [ 0.386081] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.374915] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] server # [ 0.386109] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.374972] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint server # [ 0.386125] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] host1 # [ 0.375413] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.386630] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint host1 # [ 0.375616] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] server # [ 0.386815] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.375638] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.386845] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.375667] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.375683] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] server # [ 0.387303] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint host1 # [ 0.376145] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint host1 # [ 0.376332] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] host1 # [ 0.376348] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.376377] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.435582] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.435630] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.436097] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint server # [ 0.436281] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] server # [ 0.436536] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint server # [ 0.436825] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] server # [ 0.436844] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.436874] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.437330] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint server # [ 0.437510] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] server # [ 0.437526] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.404959] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint host1 # [ 0.405164] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] server # [ 0.437555] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] host1 # [ 0.405182] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438121] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned host1 # [ 0.405211] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438133] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned host1 # [ 0.405686] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.438138] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned host1 # [ 0.405870] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] server # [ 0.438184] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned host1 # [ 0.405887] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] host1 # [ 0.405923] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438232] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned host1 # [ 0.406395] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint server # [ 0.438279] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned host1 # [ 0.406579] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] server # [ 0.438325] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned host1 # [ 0.406595] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438372] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned host1 # [ 0.406624] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438426] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned host1 # [ 0.407096] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint host1 # [ 0.407282] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] server # [ 0.438475] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned host1 # [ 0.407298] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438523] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned host1 # [ 0.407328] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438570] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned host1 # [ 0.407781] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint server # [ 0.438640] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned host1 # [ 0.407969] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] server # [ 0.438687] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned host1 # [ 0.407985] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438709] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned host1 # [ 0.408015] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438731] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned host1 # [ 0.408031] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] server # [ 0.438753] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned host1 # [ 0.408545] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint server # [ 0.438774] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned host1 # [ 0.408734] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438799] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned host1 # [ 0.408764] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438821] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned host1 # [ 0.409243] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint server # [ 0.438843] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned host1 # [ 0.409432] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.438865] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned host1 # [ 0.409462] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.438887] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned host1 # [ 0.409868] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint server # [ 0.438910] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned host1 # [ 0.410052] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] server # [ 0.438932] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned host1 # [ 0.410299] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint server # [ 0.438954] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned host1 # [ 0.410593] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] server # [ 0.438976] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned host1 # [ 0.410611] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.439004] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned host1 # [ 0.410641] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.439025] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned server # [ 0.439046] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned host1 # [ 0.411100] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint host1 # [ 0.411284] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] server # [ 0.439068] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned host1 # [ 0.411300] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] server # [ 0.439090] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned server # [ 0.439112] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned host1 # [ 0.411329] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] server # [ 0.439134] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned host1 # [ 0.411914] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned server # [ 0.439161] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] host1 # [ 0.411925] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned server # [ 0.439171] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] host1 # [ 0.411931] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned server # [ 0.439175] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] host1 # [ 0.411976] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned host1 # [ 0.412022] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned host1 # [ 0.412069] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned server # [ 0.482052] pci 0000:00:0a.0: enabling device (0000 -> 0002) host1 # [ 0.412114] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned host1 # [ 0.412167] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned host1 # [ 0.412215] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned host1 # [ 0.412262] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned host1 # [ 0.412313] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned host1 # [ 0.412359] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned host1 # [ 0.412433] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned host1 # [ 0.412480] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned host1 # [ 0.412501] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned host1 # [ 0.460553] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned host1 # [ 0.460593] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned host1 # [ 0.460624] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned host1 # [ 0.460650] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned host1 # [ 0.460674] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned host1 # [ 0.460697] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned host1 # [ 0.460719] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned host1 # [ 0.460741] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned host1 # [ 0.460764] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned host1 # [ 0.460787] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned host1 # [ 0.460810] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned host1 # [ 0.460831] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned server # [ 0.506649] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) host1 # [ 0.460853] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned host1 # [ 0.460873] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned host1 # [ 0.460896] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned host1 # [ 0.460917] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned host1 # [ 0.460939] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned host1 # [ 0.460960] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned host1 # [ 0.460982] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned host1 # [ 0.461014] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] host1 # [ 0.461024] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] host1 # [ 0.461029] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] host1 # [ 0.462198] pci 0000:00:0a.0: enabling device (0000 -> 0002) server # [ 0.516838] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) server # [ 0.527996] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) server # [ 0.530363] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) server # [ 0.532455] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) server # [ 0.534739] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) host1 # [ 0.507503] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) host1 # [ 0.510598] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) server # [ 0.544799] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) server # [ 0.546911] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) server # [ 0.558365] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) host1 # [ 0.520747] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) host1 # [ 0.522811] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) host1 # [ 0.524800] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) host1 # [ 0.526941] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) server # [ 0.564379] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) server # [ 0.566691] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) host1 # [ 0.537110] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) host1 # [ 0.539512] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) server # [ 0.584034] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled server # [ 0.586784] msm_serial: driver initialized host1 # [ 0.549716] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) server # [ 0.586978] SuperH (H)SCI(F) driver initialized server # [ 0.587035] STM32 USART driver initialized host1 # [ 0.551764] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) host1 # [ 0.563541] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) host1 # [ 0.574049] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled host1 # [ 0.581989] msm_serial: driver initialized host1 # [ 0.582142] SuperH (H)SCI(F) driver initialized host1 # [ 0.582194] STM32 USART driver initialized server # [ 0.621241] loop: module loaded server # [ 0.621436] virtio_blk virtio5: 1/0/0 default/read/poll queues server # [ 0.622216] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) server # [ 0.628077] megasas: 07.734.00.00-rc1 server # [ 0.628821] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] server # [ 0.630815] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 server # [ 0.630842] Intel/Sharp Extended Query Table at 0x0031 server # [ 0.640682] Using buffer write method server # [ 0.640789] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] server # [ 0.642492] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 server # [ 0.642526] Intel/Sharp Extended Query Table at 0x0031 host1 # [ 0.611920] loop: module loaded host1 # [ 0.612101] virtio_blk virtio5: 1/0/0 default/read/poll queues host1 # [ 0.612873] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) server # [ 0.656079] Using buffer write method server # [ 0.656131] Concatenating MTD devices: server # [ 0.656135] (0): "0.flash" server # [ 0.656140] (1): "0.flash" server # [ 0.656143] into device "0.flash" host1 # [ 0.625249] megasas: 07.734.00.00-rc1 host1 # [ 0.626062] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] host1 # [ 0.628431] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 host1 # [ 0.628457] Intel/Sharp Extended Query Table at 0x0031 host1 # [ 0.633454] Using buffer write method host1 # [ 0.633529] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] host1 # [ 0.635216] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 host1 # [ 0.635239] Intel/Sharp Extended Query Table at 0x0031 host1 # [ 0.652620] Using buffer write method host1 # [ 0.652672] Concatenating MTD devices: host1 # [ 0.652677] (0): "0.flash" host1 # [ 0.652693] (1): "0.flash" host1 # [ 0.652699] into device "0.flash" server # [ 0.940496] Freeing initrd memory: 26140K server # [ 0.947180] tun: Universal TUN/TAP device driver, 1.6 server # [ 0.951139] thunder_xcv, ver 1.0 server # [ 0.951188] thunder_bgx, ver 1.0 server # [ 0.951213] nicpf, ver 1.0 server # [ 0.953027] e1000: Intel(R) PRO/1000 Network Driver server # [ 0.953040] e1000: Copyright (c) 1999-2006 Intel Corporation. server # [ 0.953065] e1000e: Intel(R) PRO/1000 Network Driver server # [ 0.953073] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. server # [ 0.953103] igb: Intel(R) Gigabit Ethernet Network Driver server # [ 0.953108] igb: Copyright (c) 2007-2014 Intel Corporation. server # [ 0.953142] igbvf: Intel(R) Gigabit Virtual Function Network Driver server # [ 0.953151] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. server # [ 0.953303] sky2: driver version 1.30 server # [ 0.954995] usbcore: registered new interface driver usb-storage server # [ 0.955131] usbcore: registered new interface driver usbserial_generic server # [ 0.955148] usbserial: USB Serial support registered for generic server # [ 0.956150] ehci-pci 0000:00:0a.0: EHCI Host Controller server # [ 0.956190] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 server # [ 0.956420] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 server # [ 0.967754] hv_vmbus: registering driver hyperv_keyboard server # [ 0.969269] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 server # [ 0.970325] hub 1-0:1.0: USB hub found server # [ 0.970819] hub 1-0:1.0: 6 ports detected host1 # [ 0.935344] Freeing initrd memory: 26160K server # [ 0.972021] rtc-pl031 9010000.pl031: registered as rtc0 server # [ 0.972053] rtc-pl031 9010000.pl031: setting system clock to 2026-09-21T13:48:30 UTC (1789998510) server # [ 0.972449] i2c_dev: i2c /dev entries driver host1 # [ 0.942361] tun: Universal TUN/TAP device driver, 1.6 server # [ 0.977657] sdhci: Secure Digital Host Controller Interface driver server # [ 0.977673] sdhci: Copyright(c) Pierre Ossman server # [ 0.977959] Synopsys Designware Multimedia Card Interface Driver server # [ 0.978374] sdhci-pltfm: SDHCI platform and OF driver helper host1 # [ 0.946418] thunder_xcv, ver 1.0 server # [ 0.983032] hid: raw HID events driver (C) Jiri Kosina host1 # [ 0.946470] thunder_bgx, ver 1.0 host1 # [ 0.946496] nicpf, ver 1.0 server # [ 0.983333] usbcore: registered new interface driver usbhid host1 # [ 0.947152] e1000: Intel(R) PRO/1000 Network Driver host1 # [ 0.947164] e1000: Copyright (c) 1999-2006 Intel Corporation. server # [ 0.984697] usbhid: USB HID core driver host1 # [ 0.947199] e1000e: Intel(R) PRO/1000 Network Driver host1 # [ 0.947207] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. host1 # [ 0.947240] igb: Intel(R) Gigabit Ethernet Network Driver server # [ 0.986456] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available host1 # [ 0.947247] igb: Copyright (c) 2007-2014 Intel Corporation. host1 # [ 0.947279] igbvf: Intel(R) Gigabit Virtual Function Network Driver host1 # [ 0.947291] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. server # [ 0.989325] drop_monitor: Initializing network drop monitor service host1 # [ 0.947436] sky2: driver version 1.30 server # [ 0.989598] NET: Registered PF_INET6 protocol family server # [ 0.991666] Segment Routing with IPv6 server # [ 0.991686] In-situ OAM (IOAM) with IPv6 host1 # [ 0.957279] ehci-pci 0000:00:0a.0: EHCI Host Controller server # [ 0.991721] NET: Registered PF_PACKET protocol family host1 # [ 0.957319] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 host1 # [ 0.957618] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 server # [ 0.993465] 9pnet: Installing 9P2000 support host1 # [ 0.960620] usbcore: registered new interface driver usb-storage host1 # [ 0.960712] usbcore: registered new interface driver usbserial_generic host1 # [ 0.960730] usbserial: USB Serial support registered for generic host1 # [ 0.961403] hv_vmbus: registering driver hyperv_keyboard server # [ 0.996569] Key type dns_resolver registered host1 # [ 0.965463] rtc-pl031 9010000.pl031: registered as rtc0 host1 # [ 0.965496] rtc-pl031 9010000.pl031: setting system clock to 2026-09-21T13:48:30 UTC (1789998510) host1 # [ 0.965855] i2c_dev: i2c /dev entries driver host1 # [ 0.968878] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 host1 # [ 0.969939] hub 1-0:1.0: USB hub found host1 # [ 0.970472] hub 1-0:1.0: 6 ports detected server # [ 1.003424] registered taskstats version 1 server # [ 1.003657] Loading compiled-in X.509 certificates host1 # [ 0.973646] sdhci: Secure Digital Host Controller Interface driver host1 # [ 0.973668] sdhci: Copyright(c) Pierre Ossman host1 # [ 0.973953] Synopsys Designware Multimedia Card Interface Driver host1 # [ 0.974444] sdhci-pltfm: SDHCI platform and OF driver helper server # [ 1.012925] Demotion targets for Node 0: null host1 # [ 0.976356] hid: raw HID events driver (C) Jiri Kosina server # [ 1.013063] Key type .fscrypt registered server # [ 1.013070] Key type fscrypt-provisioning registered server # [ 1.013181] ima: No TPM chip found, activating TPM-bypass! host1 # [ 0.980007] usbcore: registered new interface driver usbhid host1 # [ 0.980020] usbhid: USB HID core driver server # [ 1.013203] ima: Allocated hash algorithm: sha1 server # [ 1.013233] ima: No architecture policies found server # [ 1.017870] input: gpio-keys as /devices/platform/gpio-keys/input/input0 host1 # [ 0.982447] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available host1 # [ 0.984043] drop_monitor: Initializing network drop monitor service host1 # [ 0.984244] NET: Registered PF_INET6 protocol family host1 # [ 0.987373] Segment Routing with IPv6 host1 # [ 0.987393] In-situ OAM (IOAM) with IPv6 host1 # [ 0.987424] NET: Registered PF_PACKET protocol family host1 # [ 0.989119] 9pnet: Installing 9P2000 support host1 # [ 0.991393] Key type dns_resolver registered host1 # [ 0.998966] registered taskstats version 1 host1 # [ 0.999164] Loading compiled-in X.509 certificates server # [ 1.037840] clk: Disabling unused clocks server # [ 1.037871] PM: genpd: Disabling unused power domains host1 # [ 1.008153] Demotion targets for Node 0: null server # [ 1.042772] Freeing unused kernel memory: 4736K host1 # [ 1.008285] Key type .fscrypt registered server # [ 1.043033] Run /init as init process host1 # [ 1.008292] Key type fscrypt-provisioning registered host1 # [ 1.008397] ima: No TPM chip found, activating TPM-bypass! host1 # [ 1.008417] ima: Allocated hash algorithm: sha1 host1 # [ 1.008444] ima: No architecture policies found host1 # [ 1.012657] input: gpio-keys as /devices/platform/gpio-keys/input/input0 server # [ 1.061743] systemd[1]: Successfully made /usr/ read-only. host1 # [ 1.031959] clk: Disabling unused clocks host1 # [ 1.031990] PM: genpd: Disabling unused power domains host1 # [ 1.036764] Freeing unused kernel memory: 4736K host1 # [ 1.037023] Run /init as init process host1 # [ 1.055077] systemd[1]: Successfully made /usr/ read-only. server # [ 1.219424] usb 1-1: new high-speed USB device number 2 using ehci-pci host1 # [ 1.216619] usb 1-1: new high-speed USB device number 2 using ehci-pci server # [ 1.372003] 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.396453] 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.403216] systemd[1]: Detected virtualization qemu. server # [ 1.404452] systemd[1]: Detected architecture arm64. server # [ 1.405571] systemd[1]: Running in initrd. host1 # [ 1.368880] 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.407172] systemd[1]: Initializing machine ID from random generator. server # [ 1.408934] systemd[1]: Hostname set to . host1 # [ 1.390288] 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.402801] systemd[1]: Detected virtualization qemu. host1 # [ 1.404957] systemd[1]: Detected architecture arm64. host1 # [ 1.406927] systemd[1]: Running in initrd. host1 # [ 1.410039] systemd[1]: Initializing machine ID from random generator. host1 # [ 1.413277] systemd[1]: Hostname set to . server # [ 1.467686] 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.465019] 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.591386] usb 1-2: new high-speed USB device number 3 using ehci-pci host1 # [ 1.588580] usb 1-2: new high-speed USB device number 3 using ehci-pci server # [ 1.751968] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 1.757009] 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.757397] 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.746936] 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.756836] 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.787687] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 1.865072] systemd[1]: Queued start job for default target Initrd Default Target. server # [ 1.874058] systemd[1]: Created slice Slice /system/modprobe. server # [ 1.875284] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 1.876715] systemd[1]: Expecting device /dev/disk/by-label/nixos... server # [ 1.877752] systemd[1]: Reached target Path Units. server # [ 1.878545] systemd[1]: Reached target Slice Units. server # [ 1.879381] systemd[1]: Reached target Swaps. server # [ 1.880116] systemd[1]: Reached target Timer Units. server # [ 1.881135] systemd[1]: Listening on D-Bus System Message Bus Socket. server # [ 1.882383] systemd[1]: Listening on Journal Socket (/dev/log). server # [ 1.883574] systemd[1]: Listening on Journal Sockets. server # [ 1.884608] systemd[1]: Listening on udev Control Socket. server # [ 1.885659] systemd[1]: Listening on udev Kernel Socket. server # [ 1.886556] systemd[1]: Reached target Socket Units. server # [ 1.889227] systemd[1]: Starting Create List of Static Device Nodes... server # [ 1.896183] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 1.897246] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs server # [ 1.908386] systemd[1]: Mounting Kernel Configuration File System... host1 # [ 1.892188] systemd[1]: Queued start job for default target Initrd Default Target. host1 # [ 1.903360] systemd[1]: Created slice Slice /system/modprobe. server # [ 1.939638] systemd[1]: Starting Journal Service... host1 # [ 1.904746] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. host1 # [ 1.904792] systemd[1]: Expecting device /dev/disk/by-label/nixos... host1 # [ 1.904824] systemd[1]: Reached target Path Units. host1 # [ 1.904871] systemd[1]: Reached target Slice Units. host1 # [ 1.904899] systemd[1]: Reached target Swaps. host1 # [ 1.904921] systemd[1]: Reached target Timer Units. server # [ 1.947573] systemd[1]: Starting Load Kernel Modules... host1 # [ 1.905149] systemd[1]: Listening on D-Bus System Message Bus Socket. host1 # [ 1.905372] systemd[1]: Listening on Journal Socket (/dev/log). server # [ 1.948492] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 1.905582] systemd[1]: Listening on Journal Sockets. host1 # [ 1.905771] systemd[1]: Listening on udev Control Socket. host1 # [ 1.905937] systemd[1]: Listening on udev Kernel Socket. host1 # [ 1.905963] systemd[1]: Reached target Socket Units. host1 # [ 1.918689] systemd[1]: Starting Create List of Static Device Nodes... host1 # [ 1.925945] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 1.960982] systemd[1]: Starting Coldplug All udev Devices... host1 # [ 1.927208] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 1.938019] systemd[1]: Mounting Kernel Configuration File System... server # [ 1.983623] systemd[1]: Finished Create List of Static Device Nodes. server # [ 1.984862] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 1.985229] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 1.985545] systemd[1]: Mounted Kernel Configuration File System. host1 # [ 1.967289] systemd[1]: Starting Journal Service... server # [ 2.003750] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... host1 # [ 1.976013] systemd[1]: Starting Load Kernel Modules... host1 # [ 1.977037] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 2.012342] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. server # [ 2.018094] systemd-journald[73]: Collecting audit messages is disabled. host1 # [ 1.984793] systemd[1]: Starting Coldplug All udev Devices... server # [ 2.027517] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev host1 # [ 2.006374] systemd[1]: Finished Create List of Static Device Nodes. host1 # [ 2.007372] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 2.007703] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 2.007987] systemd[1]: Mounted Kernel Configuration File System. server # [ 2.042420] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 server # [ 2.042690] [drm] features: -virgl +edid -resource_blob -host_visible server # [ 2.042700] [drm] features: -context_init server # [ 2.052898] [drm] number of scanouts: 1 server # [ 2.052933] [drm] number of cap sets: 0 server # [ 2.054631] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic server # [ 2.054652] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 host1 # [ 2.025755] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... server # [ 2.080195] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 2.047190] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. server # [ 2.087773] systemd[1]: Starting Create Static Device Nodes in /dev... host1 # [ 2.061106] systemd-journald[73]: Collecting audit messages is disabled. host1 # [ 2.068647] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev host1 # [ 2.076981] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0 server # [ 2.111455] Console: switching to colour frame buffer device 160x50 host1 # [ 2.077259] [drm] features: -virgl +edid -resource_blob -host_visible server # [ 2.112185] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device host1 # [ 2.077268] [drm] features: -context_init host1 # [ 2.078014] [drm] number of scanouts: 1 host1 # [ 2.078032] [drm] number of cap sets: 0 server # [ 2.125147] systemd[1]: Finished Load Kernel Modules. host1 # [ 2.093328] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 2.096086] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 2.131812] systemd[1]: Starting Apply Kernel Variables... host1 # [ 2.105060] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic host1 # [ 2.105081] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0 server # [ 2.163717] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 2.164028] systemd[1]: Reached target Preparation for Local File Systems. server # [ 2.164086] systemd[1]: Reached target Local File Systems. host1 # [ 2.128900] Console: switching to colour frame buffer device 160x50 server # [ 2.169306] systemd[1]: Starting Rule-based Manager for Device Events and Files... host1 # [ 2.162293] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device host1 # [ 2.166539] systemd[1]: Finished Load Kernel Modules. host1 # [ 2.169790] systemd[1]: Starting Apply Kernel Variables... server # [ 2.205683] systemd[1]: Finished Apply Kernel Variables. host1 # [ 2.188699] systemd[1]: Finished Create Static Device Nodes in /dev. host1 # [ 2.189242] systemd[1]: Reached target Preparation for Local File Systems. host1 # [ 2.189287] systemd[1]: Reached target Local File Systems. server # [ 2.227515] systemd[1]: Started Journal Service. host1 # [ 2.200971] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 2.224363] systemd-modules-load[74]: Inserted module 'dm_mod' server # [ 2.228474] systemd-modules-load[74]: Module 'virtio_balloon' is built in server # [ 2.229607] systemd-modules-load[74]: Module 'virtio_console' is built in server # [ 2.230688] systemd-modules-load[74]: Inserted module 'virtio_gpu' server # [ 2.231677] systemd-modules-load[74]: Module 'virtio_rng' is built in server # [ 2.244193] systemd[1]: Starting Create System Files and Directories... server # [ 2.252459] systemd-udevd[80]: Using default interface naming scheme 'v261'. host1 # [ 2.236865] systemd[1]: Finished Apply Kernel Variables. server # [ 2.281450] systemd[1]: Finished Create System Files and Directories. host1 # [ 2.264821] systemd[1]: Started Journal Service. host1 # [ 2.256171] systemd-modules-load[74]: Inserted module 'dm_mod' host1 # [ 2.260443] systemd-modules-load[74]: Module 'virtio_balloon' is built in host1 # [ 2.261550] systemd-modules-load[74]: Module 'virtio_console' is built in host1 # [ 2.262585] systemd-modules-load[74]: Inserted module 'virtio_gpu' host1 # [ 2.263560] systemd-modules-load[74]: Module 'virtio_rng' is built in server # [ 2.304913] systemd[1]: Started Rule-based Manager for Device Events and Files. host1 # [ 2.282024] systemd[1]: Starting Create System Files and Directories... host1 # [ 2.295061] systemd-udevd[81]: Using default interface naming scheme 'v261'. host1 # [ 2.306874] systemd[1]: Finished Create System Files and Directories. server # [ 2.358958] systemd[1]: Starting Virtual Console Setup... host1 # [ 2.334003] systemd[1]: Started Rule-based Manager for Device Events and Files. server # [ 2.420545] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 2.424373] systemd[1]: Finished Virtual Console Setup. host1 # [ 2.398964] systemd[1]: Starting Virtual Console Setup... host1 # [ 2.452505] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 2.456084] systemd[1]: Finished Virtual Console Setup. server # [ 3.169824] systemd[1]: Finished Coldplug All udev Devices. server # [ 3.170832] systemd[1]: Reached target System Initialization. server # [ 3.171666] systemd[1]: Reached target Basic System. host1 # [ 3.139317] systemd[1]: Finished Coldplug All udev Devices. host1 # [ 3.140370] systemd[1]: Reached target System Initialization. host1 # [ 3.141203] systemd[1]: Reached target Basic System. server # [ 3.335527] (udev-worker)[96]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.327523] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 3.378843] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. server # [ 3.383725] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.359306] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 3.362565] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line. server # [ 3.471789] systemd[1]: Found device /dev/disk/by-label/nixos. server # [ 3.474038] systemd[1]: Reached target Initrd Root Device. host1 # [ 3.438203] systemd[1]: Found device /dev/disk/by-label/nixos. server # [ 3.477077] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... host1 # [ 3.447102] systemd[1]: Reached target Initrd Root Device. host1 # [ 3.453235] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... server # [ 3.529380] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks server # [ 3.539171] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. server # [ 3.544382] systemd[1]: Mounting /sysroot... host1 # [ 3.510048] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks host1 # [ 3.520178] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. host1 # [ 3.524640] systemd[1]: Mounting /sysroot... server # [ 3.603029] EXT4-fs (vda): mounted filesystem 4749a991-77d9-4a8f-8bad-67f06a2a49b3 r/w with ordered data mode. Quota mode: none. server # [ 3.593631] systemd[1]: Mounted /sysroot. server # [ 3.597156] systemd[1]: Reached target Initrd Root File System. server # [ 3.604125] systemd[1]: Starting Mountpoints Configured in the Real Root... host1 # [ 3.585051] EXT4-fs (vda): mounted filesystem 51e8bc18-1023-43e1-ae96-0c635174dbe2 r/w with ordered data mode. Quota mode: none. host1 # [ 3.577950] systemd[1]: Mounted /sysroot. host1 # [ 3.579855] systemd[1]: Reached target Initrd Root File System. host1 # [ 3.588125] systemd[1]: Starting Mountpoints Configured in the Real Root... server # [ 3.632387] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload. server # [ 3.637731] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)... server # [ 3.643394] systemd[1]: Reloading... host1 # [ 3.615331] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload. host1 # [ 3.623495] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)... host1 # [ 3.626252] systemd[1]: Reloading... server # [ 3.888198] systemd[1]: Reloading finished in 248 ms. host1 # [ 3.864145] systemd[1]: Reloading finished in 242 ms. server # [ 3.923416] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace... server # [ 3.927653] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace... server # [ 3.931031] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 3.897689] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace... server # [ 3.938512] systemd[1]: initrd-parse-etc.service: Deactivated successfully. host1 # [ 3.904279] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace... server # [ 3.940689] systemd[1]: Finished Mountpoints Configured in the Real Root. server # [ 3.943038] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. host1 # [ 3.907755] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 3.912831] systemd[1]: initrd-parse-etc.service: Deactivated successfully. host1 # [ 3.923349] systemd[1]: Finished Mountpoints Configured in the Real Root. host1 # [ 3.927812] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. server # [ 3.967340] systemd[1]: Mounting /sysroot/nix/.rw-store... server # [ 3.977934] systemd[1]: Mounting /sysroot/run... host1 # [ 3.944536] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 3.946769] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 3.992499] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 3.997255] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 4.020127] systemd[1]: Mounting /sysroot/nix/.ro-store... host1 # [ 3.999176] systemd[1]: Mounting /sysroot/nix/.ro-store... server # [ 4.040908] systemd[1]: Mounting /sysroot/tmp/shared... host1 # [ 4.015519] systemd[1]: Mounting /sysroot/nix/.rw-store... host1 # [ 4.020085] systemd[1]: Mounting /sysroot/run... host1 # [ 4.029890] systemd[1]: Mounting /sysroot/tmp/shared... server # [ 4.073448] systemd[1]: Mounting /sysroot/tmp/xchg... server # [ 4.079193] systemd[1]: Mounted /sysroot/nix/.rw-store. server # [ 4.080153] systemd[1]: Mounted /sysroot/run. host1 # [ 4.062164] systemd[1]: Mounting /sysroot/tmp/xchg... server # [ 4.111996] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 4.114000] systemd[1]: Mounted /sysroot/nix/.ro-store. host1 # [ 4.109458] systemd[1]: Mounted /sysroot/nix/.rw-store. host1 # [ 4.119585] systemd[1]: Mounted /sysroot/nix/.ro-store. server # [ 4.155512] systemd[1]: Mounted /sysroot/tmp/shared. server # [ 4.158450] systemd[1]: Mounted /sysroot/tmp/xchg. server # [ 4.168187] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 4.169485] systemd[1]: Finished rw-sysroot-nix-store.service. host1 # [ 4.135012] systemd[1]: Mounted /sysroot/run. host1 # [ 4.139714] systemd[1]: Mounted /sysroot/tmp/shared. host1 # [ 4.147254] systemd[1]: Mounted /sysroot/tmp/xchg. host1 # [ 4.157358] systemd[1]: Starting rw-sysroot-nix-store.service... host1 # [ 4.187363] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. host1 # [ 4.188999] systemd[1]: Finished rw-sysroot-nix-store.service. host1 # [ 4.834155] (udev-worker)[93]: 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.840160] (udev-worker)[93]: 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 server # [ 4.888762] (udev-worker)[100]: 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.892098] (udev-worker)[100]: 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.866203] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 4.867302] systemd[1]: Stopped Virtual Console Setup. host1 # [ 4.873839] systemd[1]: Stopping Virtual Console Setup... host1 # [ 4.874683] systemd[1]: Starting Virtual Console Setup... server # [ 4.919183] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 4.921560] systemd[1]: Stopped Virtual Console Setup. server # [ 4.922950] systemd[1]: Stopping Virtual Console Setup... host1 # [ 4.888759] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 4.891242] systemd[1]: Stopped Virtual Console Setup. server # [ 4.927545] systemd[1]: Starting Virtual Console Setup... host1 # [ 4.892440] systemd[1]: Starting Virtual Console Setup... host1 # [ 4.913684] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 4.916974] systemd[1]: Finished Virtual Console Setup. server # [ 4.955915] systemd[1]: Mounting /sysroot/nix/store... server # [ 4.960512] systemd-vconsole-setup[158]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 4.964108] systemd[1]: Finished Virtual Console Setup. server # [ 4.965770] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. server # [ 4.985884] systemd[1]: Mounted /sysroot/nix/store. server # [ 4.987336] systemd[1]: Reached target Initrd File Systems. server # [ 4.989819] systemd[1]: Starting Find NixOS closure... server # [ 4.996527] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... server # [ 5.022386] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. server # [ 5.024604] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. host1 # [ 4.996995] systemd[1]: Mounting /sysroot/nix/store... server # [ 5.036791] systemd[1]: Finished Find NixOS closure. server # [ 5.038781] systemd[1]: Reached target Initrd Default Target. server # [ 5.039958] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... server # [ 5.063943] systemd[1]: Stopped target Initrd Default Target. server # [ 5.065447] systemd[1]: Stopped target Basic System. server # [ 5.068434] systemd[1]: Stopped target Initrd Root Device. server # [ 5.069289] systemd[1]: Stopped target Path Units. server # [ 5.069981] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. server # [ 5.072110] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. server # [ 5.074838] systemd[1]: Stopped target Slice Units. host1 # [ 5.042996] systemd[1]: Mounted /sysroot/nix/store. server # [ 5.079526] systemd[1]: Stopped target Socket Units. server # [ 5.080402] systemd[1]: Stopped target System Initialization. server # [ 5.081335] systemd[1]: Stopped target Swaps. server # [ 5.082000] systemd[1]: Stopped target Timer Units. host1 # [ 5.045495] systemd[1]: Reached target Initrd File Systems. server # [ 5.082708] systemd[1]: dbus.socket: Deactivated successfully. host1 # [ 5.049531] systemd[1]: Starting Find NixOS closure... server # [ 5.088909] systemd[1]: Closed D-Bus System Message Bus Socket. host1 # [ 5.056985] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... server # [ 5.094403] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. server # [ 5.100995] systemd[1]: Stopped Find NixOS closure. server # [ 5.102974] systemd[1]: Starting Load Kernel Module 9pnet_virtio... server # [ 5.104984] systemd[1]: Starting rw-sysroot-nix-store.service... server # [ 5.113141] systemd[1]: systemd-sysctl.service: Deactivated successfully. server # [ 5.116176] systemd[1]: Stopped Apply Kernel Variables. server # [ 5.119857] systemd[1]: systemd-modules-load.service: Deactivated successfully. server # [ 5.124439] systemd[1]: Stopped Load Kernel Modules. server # [ 5.126909] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. server # [ 5.128608] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. server # [ 5.129700] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. server # [ 5.130690] systemd[1]: Stopped Create System Files and Directories. server # [ 5.131563] systemd[1]: Stopped target Local File Systems. server # [ 5.136309] systemd[1]: Stopped target Preparation for Local File Systems. host1 # [ 5.101023] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. server # [ 5.137624] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. server # [ 5.140316] systemd[1]: Stopped Coldplug All udev Devices. host1 # [ 5.104340] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. server # [ 5.141614] systemd[1]: Stopping Rule-based Manager for Device Events and Files... server # [ 5.143925] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 5.146534] systemd[1]: Stopped Virtual Console Setup. server # [ 5.148466] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. server # [ 5.151939] systemd[1]: Finished rw-sysroot-nix-store.service. server # [ 5.153074] systemd[1]: initrd-cleanup.service: Deactivated successfully. server # [ 5.153997] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. host1 # [ 5.118582] systemd[1]: Finished Find NixOS closure. server # [ 5.155096] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 5.156193] systemd[1]: Finished Load Kernel Module 9pnet_virtio. server # [ 5.157048] systemd[1]: systemd-udevd.service: Deactivated successfully. host1 # [ 5.121402] systemd[1]: Reached target Initrd Default Target. server # [ 5.157960] systemd[1]: Stopped Rule-based Manager for Device Events and Files. host1 # [ 5.122983] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... server # [ 5.158947] systemd[1]: systemd-udevd.service: Consumed 1.574s CPU time over 2.985s wall clock time, 27.4M memory peak. server # [ 5.164258] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. server # [ 5.165365] systemd[1]: Closed udev Control Socket. server # [ 5.168388] systemd[1]: Starting Cleanup udev Database... server # [ 5.169347] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. server # [ 5.172271] systemd[1]: Stopped Create Static Device Nodes in /dev. server # [ 5.173209] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. server # [ 5.176120] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. server # [ 5.177136] systemd[1]: kmod-static-nodes.service: Deactivated successfully. server # [ 5.180169] systemd[1]: Stopped Create List of Static Device Nodes. host1 # [ 5.151950] systemd[1]: Stopped target Initrd Default Target. host1 # [ 5.156418] systemd[1]: Stopped target Basic System. host1 # [ 5.157447] systemd[1]: Stopped target Initrd Root Device. host1 # [ 5.158423] systemd[1]: Stopped target Path Units. host1 # [ 5.160138] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. host1 # [ 5.163660] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. host1 # [ 5.168222] systemd[1]: Stopped target Slice Units. host1 # [ 5.169108] systemd[1]: Stopped target Socket Units. host1 # [ 5.169900] systemd[1]: Stopped target System Initialization. host1 # [ 5.170777] systemd[1]: Stopped target Swaps. host1 # [ 5.171472] systemd[1]: Stopped target Timer Units. server # [ 5.207251] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. host1 # [ 5.174360] systemd[1]: dbus.socket: Deactivated successfully. server # [ 5.212644] systemd[1]: Finished Cleanup udev Database. server # [ 5.213411] systemd[1]: Reached target Switch Root. server # [ 5.214101] systemd[1]: Starting NixOS Activation... host1 # [ 5.178905] systemd[1]: Closed D-Bus System Message Bus Socket. host1 # [ 5.179870] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. host1 # [ 5.181223] systemd[1]: Stopped Find NixOS closure. host1 # [ 5.182697] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 5.185626] systemd[1]: Starting rw-sysroot-nix-store.service... host1 # [ 5.200337] systemd[1]: systemd-sysctl.service: Deactivated successfully. host1 # [ 5.202844] systemd[1]: Stopped Apply Kernel Variables. host1 # [ 5.204958] systemd[1]: systemd-modules-load.service: Deactivated successfully. host1 # [ 5.210322] systemd[1]: Stopped Load Kernel Modules. host1 # [ 5.213042] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. host1 # [ 5.218879] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. host1 # [ 5.221981] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. host1 # [ 5.225679] systemd[1]: Stopped Create System Files and Directories. host1 # [ 5.227503] systemd[1]: Stopped target Local File Systems. host1 # [ 5.230863] systemd[1]: Stopped target Preparation for Local File Systems. host1 # [ 5.231855] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. host1 # [ 5.236296] systemd[1]: Stopped Coldplug All udev Devices. host1 # [ 5.237157] systemd[1]: Stopping Rule-based Manager for Device Events and Files... host1 # [ 5.238183] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 5.240406] systemd[1]: Stopped Virtual Console Setup. host1 # [ 5.241891] systemd[1]: initrd-cleanup.service: Deactivated successfully. host1 # [ 5.242930] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. host1 # [ 5.243843] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 5.245021] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 5.245865] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. host1 # [ 5.246864] systemd[1]: Finished rw-sysroot-nix-store.service. host1 # [ 5.247676] systemd[1]: systemd-udevd.service: Deactivated successfully. host1 # [ 5.252289] systemd[1]: Stopped Rule-based Manager for Device Events and Files. host1 # [ 5.253374] systemd[1]: systemd-udevd.service: Consumed 1.549s CPU time over 3.044s wall clock time, 26.9M memory peak. host1 # [ 5.256437] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. host1 # [ 5.260198] systemd[1]: Closed udev Control Socket. host1 # [ 5.260996] systemd[1]: Starting Cleanup udev Database... host1 # [ 5.264119] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. host1 # [ 5.265204] systemd[1]: Stopped Create Static Device Nodes in /dev. host1 # [ 5.266066] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. host1 # [ 5.268148] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. host1 # [ 5.272263] systemd[1]: kmod-static-nodes.service: Deactivated successfully. host1 # [ 5.273277] systemd[1]: Stopped Create List of Static Device Nodes. host1 # [ 5.295803] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. host1 # [ 5.299137] systemd[1]: Finished Cleanup udev Database. host1 # [ 5.300468] systemd[1]: Reached target Switch Root. host1 # [ 5.304461] systemd[1]: Starting NixOS Activation... server # [ 5.372830] initrd-nixos-activation-start[184]: booting system configuration /nix/store/4sgbb71nw078lpy3940kgcqaqc98ppqm-nixos-system-server-test server # [ 5.436551] initrd-nixos-activation-start[184]: running activation script... host1 # [ 5.466947] initrd-nixos-activation-start[184]: booting system configuration /nix/store/gs9wxvhqnagxz34vl4cmjirjiipkv6ss-nixos-system-host1-test host1 # [ 5.531855] initrd-nixos-activation-start[184]: running activation script... server # [ 5.841504] initrd-nixos-activation-start[207]: setting up /etc... host1 # [ 5.935786] initrd-nixos-activation-start[207]: setting up /etc... server # [ 6.095291] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. server # [ 6.098113] systemd[1]: Finished NixOS Activation. server # [ 6.100093] systemd[1]: Starting Switch Root... server # [ 6.115435] systemd[1]: Switching root. host1 # [ 6.179588] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. host1 # [ 6.182464] systemd[1]: Finished NixOS Activation. host1 # [ 6.183620] systemd[1]: Starting Switch Root... host1 # [ 6.207881] systemd[1]: Switching root. server # [ 6.306597] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). host1 # [ 6.399999] systemd-journald[73]: Received SIGTERM from PID 1 (systemd). server # [ 6.906719] 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 # [ 6.919234] systemd[1]: Detected virtualization qemu. server # [ 6.923122] systemd[1]: Detected architecture arm64. server # [ 6.925376] systemd[1]: Detected first boot. server # [ 6.932574] systemd[1]: Initializing machine ID from random generator. host1 # [ 6.977738] 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 # [ 6.990074] systemd[1]: Detected virtualization qemu. host1 # [ 6.994132] systemd[1]: Detected architecture arm64. host1 # [ 6.996209] systemd[1]: Detected first boot. host1 # [ 7.003366] systemd[1]: Initializing machine ID from random generator. server # [ 7.267573] systemd[1]: bpf-restrict-fs: LSM BPF program attached host1 # [ 7.336491] systemd[1]: bpf-restrict-fs: LSM BPF program attached server # [ 7.449552] systemd[1]: Applying preset policy. host1 # [ 7.520383] systemd[1]: Applying preset policy. server # [ 7.905048] systemd[1]: Populated /etc with preset unit settings. host1 # [ 7.999347] systemd[1]: Populated /etc with preset unit settings. server # [ 8.423855] systemd[1]: initrd-switch-root.service: Deactivated successfully. server # [ 8.425172] systemd[1]: Stopped initrd-switch-root.service. server # [ 8.428969] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. server # [ 8.432882] systemd[1]: Created slice Slice /system/getty. server # [ 8.434903] systemd[1]: Created slice User and Session Slice. server # [ 8.436280] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. server # [ 8.438674] systemd[1]: Started Forward Password Requests to Wall Directory Watch. server # [ 8.440127] systemd[1]: Expecting device /dev/hvc0... server # [ 8.441439] systemd[1]: Expecting device /dev/ttyAMA0... server # [ 8.442833] systemd[1]: Reached target Local Encrypted Volumes. server # [ 8.444402] systemd[1]: Stopped target initrd-fs.target. server # [ 8.445741] systemd[1]: Stopped target initrd-root-fs.target. server # [ 8.447159] systemd[1]: Stopped target initrd-switch-root.target. server # [ 8.448644] systemd[1]: Reached target Virtual Machines and Containers. server # [ 8.450174] systemd[1]: Reached target Path Units. server # [ 8.451514] systemd[1]: Reached target Remote File Systems. server # [ 8.452918] systemd[1]: Reached target Slice Units. server # [ 8.454248] systemd[1]: Reached target Swaps. server # [ 8.458361] systemd[1]: Listening on Query the User Interactively for a Password. server # [ 8.463177] systemd[1]: Listening on Process Core Dump Socket. server # [ 8.467007] systemd[1]: Listening on Credential Encryption/Decryption. server # [ 8.470856] systemd[1]: Listening on Factory Reset Management. server # [ 8.471266] systemd[1]: Listening on Hostname Service Socket. server # [ 8.477197] systemd[1]: Starting Journal Log Access Socket... server # [ 8.479259] systemd[1]: Listening on Journal Audit Socket. server # [ 8.483631] systemd[1]: Listening on Console Output Muting Service Socket. server # [ 8.485254] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. server # [ 8.487476] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os server # [ 8.490232] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki server # [ 8.500375] systemd[1]: Listening on Disk Repartitioning Service Socket. server # [ 8.500806] systemd[1]: Listening on udev Control Socket. server # [ 8.501161] systemd[1]: Listening on udev Varlink Socket. server # [ 8.507422] systemd[1]: Mounting Huge Pages File System... server # [ 8.511811] systemd[1]: Mounting POSIX Message Queue File System... server # [ 8.524519] systemd[1]: Mounting Kernel Debug File System... server # [ 8.537511] systemd[1]: Mounting Kernel Trace File System... host1 # [ 8.507186] systemd[1]: initrd-switch-root.service: Deactivated successfully. host1 # [ 8.508462] systemd[1]: Stopped initrd-switch-root.service. server # [ 8.543973] systemd[1]: Starting Create List of Static Device Nodes... host1 # [ 8.511976] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. host1 # [ 8.515875] systemd[1]: Created slice Slice /system/getty. host1 # [ 8.517984] systemd[1]: Created slice User and Session Slice. host1 # [ 8.519769] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. host1 # [ 8.521287] systemd[1]: Started Forward Password Requests to Wall Directory Watch. host1 # [ 8.522633] systemd[1]: Expecting device /dev/hvc0... server # [ 8.554916] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 8.523748] systemd[1]: Expecting device /dev/ttyAMA0... server # [ 8.555267] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 8.524997] systemd[1]: Reached target Local Encrypted Volumes. host1 # [ 8.526213] systemd[1]: Stopped target initrd-fs.target. host1 # [ 8.527325] systemd[1]: Stopped target initrd-root-fs.target. host1 # [ 8.528482] systemd[1]: Stopped target initrd-switch-root.target. host1 # [ 8.529727] systemd[1]: Reached target Virtual Machines and Containers. host1 # [ 8.531432] systemd[1]: Reached target Path Units. host1 # [ 8.532917] systemd[1]: Reached target Remote File Systems. server # [ 8.567001] systemd[1]: Mounting Kernel Configuration File System... host1 # [ 8.534436] systemd[1]: Reached target Slice Units. host1 # [ 8.535878] systemd[1]: Reached target Swaps. server # [ 8.569869] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm host1 # [ 8.539401] systemd[1]: Listening on Query the User Interactively for a Password. server # [ 8.575694] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore host1 # [ 8.543674] systemd[1]: Listening on Process Core Dump Socket. host1 # [ 8.547129] systemd[1]: Listening on Credential Encryption/Decryption. server # [ 8.581702] systemd[1]: Starting Load Kernel Module fuse... host1 # [ 8.550665] systemd[1]: Listening on Factory Reset Management. host1 # [ 8.552392] systemd[1]: Listening on Hostname Service Socket. server # [ 8.586456] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 host1 # [ 8.557421] systemd[1]: Starting Journal Log Access Socket... host1 # [ 8.559948] systemd[1]: Listening on Journal Audit Socket. host1 # [ 8.563635] systemd[1]: Listening on Console Output Muting Service Socket. host1 # [ 8.565137] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. server # [ 8.600746] systemd[1]: Starting Journal Service... host1 # [ 8.567330] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 8.569647] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki host1 # [ 8.581051] systemd[1]: Listening on Disk Repartitioning Service Socket. host1 # [ 8.582453] systemd[1]: Listening on udev Control Socket. host1 # [ 8.584005] systemd[1]: Listening on udev Varlink Socket. host1 # [ 8.588325] systemd[1]: Mounting Huge Pages File System... host1 # [ 8.593588] systemd[1]: Mounting POSIX Message Queue File System... host1 # [ 8.605262] systemd[1]: Mounting Kernel Debug File System... host1 # [ 8.610930] systemd[1]: Mounting Kernel Trace File System... host1 # [ 8.621987] systemd[1]: Starting Create List of Static Device Nodes... server # [ 8.663801] systemd[1]: Starting Load Kernel Modules... host1 # [ 8.636436] systemd[1]: Starting Load Kernel Module 9pnet_virtio... host1 # [ 8.637993] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs server # [ 8.684902] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... host1 # [ 8.657109] systemd[1]: Mounting Kernel Configuration File System... host1 # [ 8.663302] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm host1 # [ 8.666723] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore server # [ 8.709065] systemd[1]: Starting Remount Root and Kernel File Systems... server # [ 8.711756] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 8.723763] systemd[1]: Starting Coldplug All udev Devices... server # [ 8.726337] systemd[1]: Listening on Journal Log Access Socket. server # [ 8.726747] systemd[1]: Mounted Huge Pages File System. server # [ 8.727141] systemd[1]: Mounted POSIX Message Queue File System. server # [ 8.735690] systemd[1]: Mounted Kernel Debug File System. server # [ 8.737762] systemd[1]: Mounted Kernel Trace File System. server # [ 8.743325] systemd[1]: Mounted Kernel Configuration File System. host1 # [ 8.733402] systemd[1]: Starting Load Kernel Module fuse... host1 # [ 8.743990] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 server # [ 8.801652] systemd[1]: Finished Create List of Static Device Nodes. host1 # [ 8.772787] systemd[1]: Starting Journal Service... server # [ 8.810721] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... host1 # [ 8.790298] systemd[1]: Starting Load Kernel Modules... server # [ 8.848605] EXT4-fs (vda): re-mounted 4749a991-77d9-4a8f-8bad-67f06a2a49b3. host1 # [ 8.815979] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... server # [ 8.855458] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. host1 # [ 8.823760] fuse: init (API version 7.45) server # [ 8.857975] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 8.828937] systemd[1]: Starting Remount Root and Kernel File Systems... host1 # [ 8.832047] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os server # [ 8.872727] systemd[1]: Finished Remount Root and Kernel File Systems. server # [ 8.875010] systemd[1]: Listening on Disk Image Download Service Socket. server # [ 8.877058] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore server # [ 8.885261] systemd[1]: Starting Load/Save OS Random Seed... server # [ 8.887592] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 8.854908] systemd[1]: Starting Coldplug All udev Devices... server # [ 8.892042] systemd[1]: Finished Load Kernel Modules. host1 # [ 8.863431] systemd[1]: Listening on Journal Log Access Socket. server # [ 8.899896] systemd[1]: Starting Firewall... server # [ 8.915643] systemd[1]: Starting Apply Kernel Variables... server # [ 8.918803] systemd-journald[278]: Collecting audit messages is enabled. host1 # [ 8.884515] systemd[1]: Mounted Huge Pages File System. host1 # [ 8.892946] systemd[1]: Mounted POSIX Message Queue File System. host1 # [ 8.895698] systemd-journald[278]: Collecting audit messages is enabled. host1 # [ 8.898903] systemd[1]: Mounted Kernel Debug File System. host1 # [ 8.902520] systemd[1]: Mounted Kernel Trace File System. host1 # [ 8.911582] systemd[1]: Finished Create List of Static Device Nodes. host1 # [ 8.912333] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. server # [ 8.949770] fuse: init (API version 7.45) host1 # [ 8.916049] systemd[1]: Finished Load Kernel Module 9pnet_virtio. host1 # [ 8.918714] systemd[1]: Mounted Kernel Configuration File System. host1 # [ 8.919362] systemd[1]: modprobe@fuse.service: Deactivated successfully. host1 # [ 8.927774] systemd[1]: Finished Load Kernel Module fuse. host1 # [ 8.931109] systemd[1]: Finished Load Kernel Modules. server # [ 8.958812] systemd[1]: Queued start job for default target Multi-User System. server # [ 8.975261] systemd[1]: Started Journal Service. host1 # [ 8.925465] systemd[1]: Queued start job for default target Multi-User System. host1 # [ 8.928714] systemd[1]: systemd-journald.service: Deactivated successfully. host1 # [ 8.947910] systemd[1]: Mounting FUSE Control File System... server # [ 8.971416] systemd[1]: systemd-journald.service: Deactivated successfully. host1 # [ 8.938615] systemd-modules-load[279]: Module 'atkbd' is built in host1 # [ 8.939607] systemd-modules-load[279]: Module 'loop' is built in host1 # [ 8.966654] systemd[1]: Starting Firewall... server # [ 8.986742] systemd-modules-load[279]: Module 'atkbd' is built in server # [ 8.996247] systemd-modules-load[279]: Module 'loop' is built in host1 # [ 8.984639] EXT4-fs (vda): re-mounted 51e8bc18-1023-43e1-ae96-0c635174dbe2. host1 # [ 8.987074] systemd[1]: Starting Apply Kernel Variables... server # [ 9.012637] systemd[1]: Starting Flush Journal to Persistent Storage... server # [ 9.018206] systemd[1]: modprobe@fuse.service: Deactivated successfully. server # [ 9.025220] systemd[1]: Finished Load Kernel Module fuse. server # [ 9.036456] systemd[1]: Finished Load/Save OS Random Seed. server # [ 9.039363] systemd[1]: Reached target First Boot Complete. host1 # [ 9.028217] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... server # [ 9.049744] systemd-oomd[280]: No swap; memory pressure usage will be degraded server # [ 9.061603] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. host1 # [ 9.047996] systemd[1]: Started Journal Service. host1 # [ 9.035787] systemd-oomd[280]: No swap; memory pressure usage will be degraded server # [ 9.082665] systemd[1]: Finished Apply Kernel Variables. server # [ 9.102241] systemd-journald[278]: Received client request to flush runtime journal. host1 # [ 9.060707] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. host1 # [ 9.073993] systemd[1]: Finished Remount Root and Kernel File Systems. server # [ 9.156868] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 9.125117] systemd[1]: Listening on Disk Image Download Service Socket. server # [ 9.174432] systemd[1]: Starting Create Static Device Nodes in /dev... host1 # [ 9.142644] systemd[1]: Starting Flush Journal to Persistent Storage... host1 # [ 9.146238] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore server # [ 9.184665] systemd[1]: Finished Flush Journal to Persistent Storage. host1 # [ 9.157023] systemd[1]: Starting Load/Save OS Random Seed... host1 # [ 9.159504] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os host1 # [ 9.169732] systemd[1]: Mounted FUSE Control File System. host1 # [ 9.177395] systemd[1]: Finished Apply Kernel Variables. host1 # [ 9.222082] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. host1 # [ 9.230971] systemd[1]: Starting Create Static Device Nodes in /dev... server # [ 9.279118] systemd[1]: Finished Create Static Device Nodes in /dev. server # [ 9.280295] systemd[1]: Reached target Preparation for Local File Systems. server # [ 9.283262] systemd[1]: Starting Rule-based Manager for Device Events and Files... host1 # [ 9.268874] systemd-journald[278]: Received client request to flush runtime journal. host1 # [ 9.325557] systemd[1]: Finished Load/Save OS Random Seed. host1 # [ 9.328992] systemd[1]: Reached target First Boot Complete. host1 # [ 9.333915] systemd[1]: Finished Flush Journal to Persistent Storage. server # [ 9.396683] systemd-udevd[319]: Using default interface naming scheme 'v261'. host1 # [ 9.362842] systemd[1]: Finished Create Static Device Nodes in /dev. host1 # [ 9.363952] systemd[1]: Reached target Preparation for Local File Systems. host1 # [ 9.366760] systemd[1]: Starting Rule-based Manager for Device Events and Files... server # [ 9.413107] systemd[1]: Mounting /run/wrappers... server # [ 9.426463] systemd[1]: Mounting FUSE Control File System... server # [ 9.464849] systemd[1]: Mounted FUSE Control File System. server # [ 9.487002] systemd[1]: Mounted /run/wrappers. server # [ 9.491268] systemd[1]: Reached target Local File Systems. server # [ 9.492497] systemd[1]: Listening on Boot Loader Control Service Socket. server # [ 9.495180] systemd[1]: Starting register-nix-paths.service... server # [ 9.500380] systemd[1]: Starting Create SUID/SGID Wrappers... server # [ 9.507505] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 9.523662] systemd[1]: Starting Save Transient machine-id to Disk... server # [ 9.525634] systemd[1]: Starting Create System Files and Directories... host1 # [ 9.492468] systemd-udevd[321]: Using default interface naming scheme 'v261'. host1 # [ 9.499383] systemd[1]: Mounting /run/wrappers... host1 # [ 9.551855] systemd[1]: Mounted /run/wrappers. host1 # [ 9.557311] systemd[1]: Reached target Local File Systems. host1 # [ 9.563019] systemd[1]: Listening on Boot Loader Control Service Socket. host1 # [ 9.566574] systemd[1]: Starting register-nix-paths.service... host1 # [ 9.583790] systemd[1]: Starting Create SUID/SGID Wrappers... host1 # [ 9.589166] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. server # [ 9.628375] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. server # [ 9.638705] systemd[1]: Finished Save Transient machine-id to Disk. host1 # [ 9.612223] systemd[1]: Starting Save Transient machine-id to Disk... host1 # [ 9.615801] systemd[1]: Starting Create System Files and Directories... server # [ 9.727833] systemd[1]: Started Rule-based Manager for Device Events and Files. host1 # [ 9.723763] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. server # [ 9.766318] systemd[1]: Finished Create System Files and Directories. server # [ 9.771822] systemd[1]: Starting Rebuild Journal Catalog... host1 # [ 9.739683] systemd[1]: Finished Save Transient machine-id to Disk. server # [ 9.784963] systemd[1]: Starting Record System Boot/Shutdown in UTMP... host1 # [ 9.789155] systemd[1]: Started Rule-based Manager for Device Events and Files. host1 # [ 9.841840] systemd[1]: Finished Create System Files and Directories. server # [ 9.895542] systemd[1]: Finished Record System Boot/Shutdown in UTMP. host1 # [ 9.868384] systemd[1]: Starting Rebuild Journal Catalog... host1 # [ 9.878611] systemd[1]: Starting Record System Boot/Shutdown in UTMP... server # [ 9.966468] systemd[1]: Finished Rebuild Journal Catalog. server # [ 9.971940] systemd[1]: Starting Update is Completed... host1 # [ 9.991689] systemd[1]: Finished Record System Boot/Shutdown in UTMP. server # [ 10.046823] systemd[1]: Finished Update is Completed. host1 # [ 10.062420] systemd[1]: Finished Rebuild Journal Catalog. host1 # [ 10.074698] systemd[1]: Starting Update is Completed... host1 # [ 10.139226] systemd[1]: Finished Update is Completed. server # [ 10.472860] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. server # [ 10.474346] systemd[1]: Finished Create SUID/SGID Wrappers. host1 # [ 10.529213] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. host1 # [ 10.534295] systemd[1]: Finished Create SUID/SGID Wrappers. server # [ 10.976401] systemd[1]: Finished Firewall. host1 # [ 11.057069] systemd[1]: Finished Firewall. host1 # [ 11.070782] systemd[1]: Finished Coldplug All udev Devices. server # [ 11.110373] systemd[1]: Finished Coldplug All udev Devices. server # [ 11.170345] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 11.142794] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs host1 # [ 11.301601] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. server # [ 11.354645] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. host1 # [ 11.357382] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. server # [ 11.415790] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. server # [ 11.440283] systemd[1]: Finished register-nix-paths.service. server # [ 11.441742] systemd[1]: Reached target System Initialization. server # [ 11.443844] systemd[1]: Started Renew ACME Certificate for server. server # [ 11.446075] systemd[1]: Started Discard unused filesystem blocks once a week. server # [ 11.448215] systemd[1]: Started Daily Cleanup of Temporary Directories. server # [ 11.453781] systemd[1]: Reached target Timer Units. server # [ 11.455536] systemd[1]: Listening on D-Bus System Message Bus Socket. server # [ 11.462672] systemd[1]: Listening on Nix Daemon Socket. server # [ 11.468364] systemd[1]: Listening on Nix worker-protocol over gRPC. server # [ 11.477630] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. server # [ 11.489297] systemd[1]: Reached target Socket Units. server # [ 11.498606] systemd[1]: Reached target Basic System. host1 # [ 11.462935] systemd[1]: Finished register-nix-paths.service. host1 # [ 11.464290] systemd[1]: Reached target System Initialization. host1 # [ 11.466250] systemd[1]: Started Renew ACME Certificate for host1. server # [ 11.505195] systemd[1]: Starting Set up the ACME certificate renewal infrastructure... host1 # [ 11.471355] systemd[1]: Started Discard unused filesystem blocks once a week. host1 # [ 11.473473] systemd[1]: Started Daily Cleanup of Temporary Directories. host1 # [ 11.475266] systemd[1]: Reached target Timer Units. server # [ 11.514581] systemd[1]: Started backdoor.service. host1 # [ 11.477228] systemd[1]: Listening on D-Bus System Message Bus Socket. host1 # [ 11.481304] systemd[1]: Listening on Nix Daemon Socket. server # [ 11.521161] systemd[1]: Starting Import lastlog data into lastlog2 database... host1 # [ 11.483053] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket. host1 # [ 11.488287] systemd[1]: Reached target Socket Units. host1 # [ 11.490009] systemd[1]: Reached target Basic System. host1 # [ 11.496338] systemd[1]: Starting Set up the ACME certificate renewal infrastructure... host1 # [ 11.500996] systemd[1]: Started backdoor.service. server # [ 11.537067] systemd[1]: Starting Name Service Cache Daemon (nsncd)... host1 # [ 11.504367] systemd[1]: Starting Import lastlog data into lastlog2 database... server # [ 11.549531] systemd[1]: Starting Post-Boot Actions... host1 # [ 11.523780] systemd[1]: Starting Name Service Cache Daemon (nsncd)... server # [ 11.560480] systemd[1]: Started Reset console on configuration changes. server # [ 11.572707] systemd[1]: Starting resolvconf update... host1 # [ 11.544258] systemd[1]: Starting Post-Boot Actions... server # [ 11.583961] systemd[1]: Starting step-ca-pki.service... server # [ 11.596192] systemd[1]: Starting D-Bus System Message Bus... host1 # [ 11.559739] systemd[1]: Started Reset console on configuration changes. host1 # [ 11.608525] systemd[1]: Starting resolvconf update... server # [ 11.651323] systemd[1]: Finished Post-Boot Actions. host1 # connecting to host... server # [ 11.693227] acme-setup-privileged[507]: + set -euo pipefail server # [ 11.701225] acme-setup-privileged[507]: + cd /var/lib/acme server # [ 11.706746] acme-setup-privileged[507]: + chmod -R u=rwX,g=,o= .lego/accounts host1 # [ 11.675684] acme-setup-privileged[501]: + set -euo pipefail server # [ 11.720354] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 11.689933] acme-setup-privileged[501]: + cd /var/lib/acme host1 # [ 11.690741] acme-setup-privileged[501]: + chmod -R u=rwX,g=,o= .lego/accounts host1 # [ 11.701078] acme-setup-privileged[501]: + chown -R acme .lego/accounts server # [ 11.730850] nsncd[510]: Sep 21 13:48:41.262 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 11.750504] acme-setup-privileged[507]: + chown -R acme .lego/accounts server # [ 11.751419] systemd[1]: Reached target Host and Network Name Lookups. host1 # [ 11.714520] nsncd[504]: Sep 21 13:48:41.261 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # connecting to host... host1 # [ 11.727339] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 11.732843] acme-setup-privileged[501]: + for fixpath in host1 .lego/host1 server # [ 11.769562] acme-setup-privileged[507]: + for fixpath in server .lego/server server # [ 11.770567] acme-setup-privileged[507]: + '[' -d server ']' server # [ 11.771307] acme-setup-privileged[507]: + for fixpath in server .lego/server host1 # [ 11.737757] acme-setup-privileged[501]: + '[' -d host1 ']' host1 # [ 11.743128] acme-setup-privileged[501]: + for fixpath in host1 .lego/host1 host1 # [ 11.748880] acme-setup-privileged[501]: + '[' -d .lego/host1 ']' server # [ 11.789306] acme-setup-privileged[507]: + '[' -d .lego/server ']' host1 # [ 11.755761] systemd[1]: Reached target Host and Network Name Lookups. server # [ 11.796256] systemd[1]: Reached target User and Group Name Lookups. host1 # [ 11.761169] systemd[1]: Reached target User and Group Name Lookups. server # [ 11.805721] systemd[1]: Starting User Login Management... server # [ 11.813001] systemd[1]: Finished Import lastlog data into lastlog2 database. host1 # [ 11.780118] systemd[1]: Starting D-Bus System Message Bus... server: Guest shell says: b'Spawning backdoor root shell...\n' host1 # [ 11.804950] systemd[1]: Starting User Login Management... server: connected to guest root shell host1 # [ 11.817795] systemd[1]: Finished Post-Boot Actions. server: (connecting took 12.13 seconds) server: (finished: waiting for the VM to finish booting, in 12.13 seconds) host1 # [ 11.830573] systemd[1]: Finished Import lastlog data into lastlog2 database. server # [ 11.878312] dbus-broker-launch[518]: Looking up NSS user entry for 'systemd-timesync'... server # [ 11.889218] dbus-broker-launch[518]: NSS returned no entry for 'systemd-timesync' server # [ 11.896389] dbus-broker-launch[518]: Invalid user-name in /nix/store/pilyp4chpidfsxm2sh90rz8rhf5i0nka-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" server # [ 11.952558] systemd[1]: Started D-Bus System Message Bus. server # [ 12.039045] dbus-broker-launch[518]: Ready host1 # [ 12.013531] dbus-broker-launch[536]: Looking up NSS user entry for 'systemd-timesync'... host1 # [ 12.023178] dbus-broker-launch[536]: NSS returned no entry for 'systemd-timesync' host1 # [ 12.029489] dbus-broker-launch[536]: Invalid user-name in /nix/store/a9ijqx61hpssavy5d9lh27li51m8hnl7-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" host1 # [ 12.040484] systemd-logind[538]: New seat seat0. server # [ 12.075759] systemd-logind[533]: New seat seat0. host1 # [ 12.045441] acme-setup-start[533]: + set -euo pipefail host1 # [ 12.049116] acme-setup-start[533]: + test -e ca/key.pem server # [ 12.087631] systemd[1]: Started User Login Management. host1 # [ 12.053429] acme-setup-start[533]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local server # [ 12.094261] systemd[1]: Starting linger-users.service... host1 # [ 12.060552] systemd[1]: Stopped target Host and Network Name Lookups. host1 # [ 12.067719] systemd[1]: Stopping Host and Network Name Lookups... host1 # [ 12.071509] systemd[1]: Stopped target User and Group Name Lookups. host1 # [ 12.074674] systemd[1]: Stopping User and Group Name Lookups... host1 # [ 12.080711] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... host1 # [ 12.081640] systemd[1]: Started User Login Management. host1 # [ 12.082343] systemd[1]: nscd.service: Deactivated successfully. server # [ 12.118331] acme-setup-start[546]: + set -euo pipefail server # [ 12.119159] acme-setup-start[546]: + test -e ca/key.pem host1 # [ 12.083158] systemd[1]: Stopped Name Service Cache Daemon (nsncd). server # [ 12.119873] acme-setup-start[546]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local host1 # [ 12.096271] systemd[1]: Starting linger-users.service... host1 # [ 12.099913] systemd[1]: Starting Name Service Cache Daemon (nsncd)... host1 # [ 12.104422] systemd[1]: Started D-Bus System Message Bus. server # [ 12.149109] systemd[1]: Stopped target Host and Network Name Lookups. server # [ 12.150091] systemd[1]: Stopping Host and Network Name Lookups... server # [ 12.150926] systemd[1]: Stopped target User and Group Name Lookups. server # [ 12.151805] systemd[1]: Stopping User and Group Name Lookups... host1 # [ 12.124518] dbus-broker-launch[536]: Ready server # [ 12.184677] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... server # [ 12.194349] systemd[1]: nscd.service: Deactivated successfully. server # [ 12.195276] systemd[1]: Stopped Name Service Cache Daemon (nsncd). server # [ 12.206244] systemd[1]: Starting Name Service Cache Daemon (nsncd)... host1 # [ 12.173390] systemd-logind[538]: Watching system buttons on /dev/input/event0 (gpio-keys) host1 # [ 12.181456] (udev-worker)[464]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. host1 # [ 12.183586] (udev-worker)[464]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 12.200295] systemd[1]: Finished Set up the ACME certificate renewal infrastructure. host1 # [ 12.209030] systemd[1]: Starting Ensure certificate for host1... server # [ 12.246015] systemd[1]: linger-users.service: Deactivated successfully. server # [ 12.252166] systemd[1]: Finished linger-users.service. host1 # [ 12.221648] (udev-worker)[468]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 12.229324] nsncd[590]: Sep 21 13:48:41.777 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" host1 # [ 12.240681] systemd[1]: Started Name Service Cache Daemon (nsncd). host1 # [ 12.246525] systemd[1]: linger-users.service: Deactivated successfully. host1 # [ 12.250172] systemd[1]: Finished linger-users.service. host1 # [ 12.254274] systemd[1]: Reached target Host and Network Name Lookups. host1 # [ 12.260315] systemd[1]: Reached target User and Group Name Lookups. server # [ 12.306668] systemd[1]: Finished Set up the ACME certificate renewal infrastructure. server # [ 12.312986] systemd[1]: Starting Ensure certificate for server... server # [ 12.324622] systemd[1]: Started Name Service Cache Daemon (nsncd). server # [ 12.327504] nsncd[612]: Sep 21 13:48:41.865 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" server # [ 12.336462] systemd[1]: Reached target Host and Network Name Lookups. host1 # [ 12.305989] systemd[1]: Finished resolvconf update. server # [ 12.342802] systemd[1]: Reached target User and Group Name Lookups. host1 # [ 12.309372] systemd[1]: Reached target Preparation for Network. host1 # [ 12.322025] systemd[1]: Starting DHCP Client... host1 # [ 12.328266] systemd[1]: Starting Extra networking commands.... server # [ 12.380889] systemd[1]: Finished resolvconf update. host1 # [ 12.350440] acme-host1-start[605]: Waiting to acquire lock in /run/acme/ server # [ 12.382970] systemd[1]: Reached target Preparation for Network. server # [ 12.390247] systemd[1]: Starting DHCP Client... server # [ 12.398933] systemd[1]: Starting Extra networking commands.... host1 # [ 12.373835] acme-host1-start[605]: + '[' -e out/acme-success ']' host1 # [ 12.377137] acme-host1-start[605]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses= host1 # [ 12.420581] acme-host1-start[639]: + cd host1 host1 # [ 12.421298] acme-host1-start[639]: + cp -vp cert.pem ../out/cert.pem host1 # [ 12.433140] acme-host1-start[641]: 'cert.pem' -> '../out/cert.pem' server # [ 12.476123] (udev-worker)[375]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. host1 # [ 12.439289] acme-host1-start[639]: + cp -vp key.pem ../out/key.pem host1 # [ 12.450177] acme-host1-start[639]: 'key.pem' -> '../out/key.pem' server # [ 12.490309] (udev-worker)[375]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 12.460181] acme-host1-start[605]: + cat out/cert.pem ca/cert.pem server # [ 12.495092] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line. host1 # [ 12.476159] acme-host1-start[605]: + cp ca/cert.pem out/chain.pem host1 # [ 12.493894] systemd[1]: Condition check resulted in Virtio network device being skipped. host1 # [ 12.497652] acme-host1-start[605]: + cat out/key.pem out/fullchain.pem server # [ 12.537976] acme-server-start[631]: Waiting to acquire lock in /run/acme/ host1 # [ 12.509153] systemd[1]: Starting Address configuration of eth1... host1 # [ 12.514889] acme-host1-start[605]: + for fixpath in out certificates host1 # [ 12.515789] acme-host1-start[605]: + '[' -d out ']' host1 # [ 12.517552] acme-host1-start[605]: + chmod -R u=rwX,g=rX,o= out server # [ 12.572207] acme-server-start[631]: + '[' -e out/acme-success ']' host1 # [ 12.536520] acme-host1-start[605]: + chown -R acme:acme out server # [ 12.576255] acme-server-start[631]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses= host1 # [ 12.569000] acme-host1-start[605]: + for fixpath in out certificates host1 # [ 12.569932] acme-host1-start[605]: + '[' -d certificates ']' host1 # [ 12.578228] systemd[1]: Finished Ensure certificate for host1. server # [ 12.624251] acme-server-start[670]: + cd server server # [ 12.624991] acme-server-start[670]: + cp -vp cert.pem ../out/cert.pem server # [ 12.641419] acme-server-start[671]: 'cert.pem' -> '../out/cert.pem' server # [ 12.650765] acme-server-start[670]: + cp -vp key.pem ../out/key.pem server # [ 12.660732] acme-server-start[670]: 'key.pem' -> '../out/key.pem' server # [ 12.666581] acme-server-start[631]: + cat out/cert.pem ca/cert.pem host1 # [ 12.649438] dhcpcd[643]: dhcpcd-10.3.2 starting server # [ 12.686841] systemd[1]: Condition check resulted in Virtio network device being skipped. server # [ 12.693951] acme-server-start[631]: + cp ca/cert.pem out/chain.pem host1 # [ 12.665819] dhcpcd[688]: dev: loaded udev server # [ 12.703602] systemd[1]: Starting Address configuration of eth1... host1 # [ 12.670477] network-addresses-eth1-start[651]: adding address 192.168.1.1/24... done server # [ 12.715511] acme-server-start[631]: + cat out/key.pem out/fullchain.pem host1 # [ 12.689923] network-addresses-eth1-start[651]: adding address 2001:db8:1::1/64... done server # [ 12.731654] acme-server-start[631]: + for fixpath in out certificates server # [ 12.736420] acme-server-start[631]: + '[' -d out ']' server # [ 12.737742] acme-server-start[631]: + chmod -R u=rwX,g=rX,o= out server # [ 12.752272] acme-server-start[631]: + chown -R acme:nix-grpc-daemon out host1 # [ 12.718163] systemd[1]: Finished Address configuration of eth1. host1 # [ 12.738197] 8021q: 802.1Q VLAN Support v1.8 host1 # [ 12.738530] 8021q: adding VLAN 0 to HW filter on device eth1 server # [ 12.771888] dhcpcd[655]: dhcpcd-10.3.2 starting host1 # [ 12.742975] systemd[1]: Finished Extra networking commands.. server # [ 12.780717] acme-server-start[631]: + for fixpath in out certificates server # [ 12.781626] acme-server-start[631]: + '[' -d certificates ']' host1 # [ 12.746410] systemd[1]: Reached target Network. host1 # [ 12.754675] systemd[1]: Starting Permit User Sessions... server # [ 12.792632] systemd[1]: Finished Ensure certificate for server. server # [ 12.797781] step-ca-pki-start[531]: Your certificate has been saved in root_ca.crt. server # [ 12.798832] step-ca-pki-start[531]: Your private key has been saved in root_ca.key. server # [ 12.809272] dhcpcd[701]: dev: loaded udev server # [ 12.864130] 8021q: 802.1Q VLAN Support v1.8 host1 # [ 12.823401] systemd[1]: Finished Permit User Sessions. host1 # [ 12.830645] systemd[1]: Started Getty on tty1. host1 # [ 12.832449] systemd[1]: Reached target Login Prompts. host1 # [ 12.870992] cfg80211: Loading compiled-in X.509 certificates for regulatory database server # [ 12.927731] 8021q: adding VLAN 0 to HW filter on device eth1 host1 # [ 12.908010] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' host1 # [ 12.908503] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' host1 # [ 12.913812] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 host1 # [ 12.914140] cfg80211: failed to load regulatory.db server # [ 12.953794] cfg80211: Loading compiled-in X.509 certificates for regulatory database server # [ 12.965241] network-addresses-eth1-start[682]: adding address 192.168.1.2/24... done server # [ 12.989731] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' server # [ 12.990265] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' server # [ 12.995518] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 server # [ 12.995871] cfg80211: failed to load regulatory.db server # [ 12.995398] systemd[1]: Finished Extra networking commands.. server # [ 12.997086] systemd[1]: Reached target Network. server # [ 13.004427] systemd[1]: Starting Permit User Sessions... host1 # [ 12.986346] 8021q: adding VLAN 0 to HW filter on device eth0 host1 # [ 12.971392] dhcpcd[688]: eth0: waiting for carrier host1 # [ 12.973266] dhcpcd[688]: eth0: carrier acquired host1 # [ 12.988103] dhcpcd[688]: DUID 00:01:00:01:32:43:f2:3a:52:54:00:12:34:56 server # [ 13.024408] network-addresses-eth1-start[682]: adding address 2001:db8:1::2/64... done host1 # [ 12.989089] dhcpcd[688]: eth0: IAID 00:12:34:56 host1 # [ 12.989758] dhcpcd[688]: eth0: adding address fe80::5054:ff:fe12:3456 server # [ 13.039688] step-ca-pki-start[712]: Your certificate has been saved in intermediate_ca.crt. server # [ 13.050301] step-ca-pki-start[712]: Your private key has been saved in intermediate_ca.key. server # [ 13.060662] systemd[1]: Finished Address configuration of eth1. host1 # [ 13.042557] mousedev: PS/2 mouse device common for all mice server # [ 13.093928] systemd[1]: Finished step-ca-pki.service. server # [ 13.099987] systemd[1]: Finished Permit User Sessions. server # [ 13.104712] systemd[1]: Started Getty on tty1. server # [ 13.109656] systemd[1]: Reached target Login Prompts. host1 # [ 13.091786] systemd-logind[538]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) server # [ 13.149684] 8021q: adding VLAN 0 to HW filter on device eth0 server # [ 13.137544] dhcpcd[701]: eth0: waiting for carrier server # [ 13.139083] dhcpcd[701]: eth0: carrier acquired server # [ 13.155062] dhcpcd[701]: DUID 00:01:00:01:32:43:f2:3a:52:54:00:12:34:56 server # [ 13.158399] dhcpcd[701]: eth0: IAID 00:12:34:56 server # [ 13.159136] dhcpcd[701]: eth0: adding address fe80::5054:ff:fe12:3456 server # [ 13.182147] systemd-logind[533]: Watching system buttons on /dev/input/event0 (gpio-keys) server # [ 13.240403] dhcpcd[701]: eth0: soliciting a DHCP lease server # [ 13.251478] dhcpcd[701]: eth0: offered 10.0.2.15 from 10.0.2.2 server # [ 13.256231] dhcpcd[701]: eth0: probing address 10.0.2.15/24 server # [ 13.427671] mousedev: PS/2 mouse device common for all mice server # [ 13.487628] systemd-logind[533]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) host1 # [ 13.618237] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 host1 # [ 13.899236] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. host1 # [ 13.921147] systemd[1]: Starting Virtual Console Setup... host1 # [ 13.943877] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. host1 # [ 13.947148] systemd[1]: Stopped Virtual Console Setup. host1 # [ 13.958461] systemd[1]: Starting Virtual Console Setup... server # [ 14.037569] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input3 host1 # [ 13.998492] systemd-logind[538]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) server # [ 14.329778] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. server # [ 14.358700] systemd[1]: Starting Virtual Console Setup... server # [ 14.378636] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. server # [ 14.382936] systemd[1]: Stopped Virtual Console Setup. server # [ 14.388938] systemd[1]: Starting Virtual Console Setup... host1 # [ 14.366002] systemd-vconsole-setup[748]: Configuration of first virtual console was skipped, ignoring remaining ones. host1 # [ 14.370179] systemd[1]: Finished Virtual Console Setup. server # [ 14.476995] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) host1 # [ 14.598526] dhcpcd[688]: eth0: soliciting a DHCP lease host1 # [ 14.605637] dhcpcd[688]: eth0: offered 10.0.2.15 from 10.0.2.2 host1 # [ 14.612708] dhcpcd[688]: eth0: probing address 10.0.2.15/24 server # [ 14.829166] systemd-vconsole-setup[787]: Configuration of first virtual console was skipped, ignoring remaining ones. server # [ 14.834475] systemd[1]: Finished Virtual Console Setup. server # [ 14.969342] dhcpcd[701]: eth0: soliciting an IPv6 router server # [ 14.973159] dhcpcd[701]: eth0: Router Advertisement from fe80::2 server # [ 14.975813] dhcpcd[701]: eth0: adding address fec0::5054:ff:fe12:3456/64 server # [ 14.978906] dhcpcd[701]: eth0: adding route to fec0::/64 server # [ 14.981300] dhcpcd[701]: eth0: adding default route via fe80::2 host1 # [ 15.242423] dhcpcd[688]: eth0: soliciting an IPv6 router host1 # [ 15.245859] dhcpcd[688]: eth0: Router Advertisement from fe80::2 host1 # [ 15.249111] dhcpcd[688]: eth0: adding address fec0::5054:ff:fe12:3456/64 host1 # [ 15.251931] dhcpcd[688]: eth0: adding route to fec0::/64 host1 # [ 15.254293] dhcpcd[688]: eth0: adding default route via fe80::2 server # [ 18.050059] dhcpcd[701]: eth0: leased 10.0.2.15 for 86400 seconds server # [ 18.052969] dhcpcd[701]: eth0: adding route to 10.0.2.0/24 server # [ 18.055363] dhcpcd[701]: eth0: adding default route via 10.0.2.2 server # [ 18.257688] systemd[1]: Started DHCP Client. server # [ 18.260540] systemd[1]: Reached target Network is Online. server # [ 18.265702] systemd[1]: Starting step-ca service... server # [ 18.766336] step-ca[885]: badger 2026/09/21 13:48:48 INFO: All 0 tables opened in 0s server # [ 18.791979] step-ca[885]: 2026/09/21 13:48:48 Building new tls configuration using step-ca x509 Signer Interface server # [ 18.810758] step-ca[885]: 2026/09/21 13:48:48 Starting Smallstep CA/0.30.2 (linux/arm64) server # [ 18.811900] step-ca[885]: 2026/09/21 13:48:48 Documentation: https://u.step.sm/docs/ca server # [ 18.813049] step-ca[885]: 2026/09/21 13:48:48 Community Discord: https://u.step.sm/discord server # [ 18.814227] step-ca[885]: 2026/09/21 13:48:48 Config file: /etc/smallstep/ca.json server # [ 18.815290] step-ca[885]: 2026/09/21 13:48:48 The primary server URL is https://server:8443 server # [ 18.817967] step-ca[885]: 2026/09/21 13:48:48 Root certificates are available at https://server:8443/roots.pem server # [ 18.819350] step-ca[885]: 2026/09/21 13:48:48 X.509 Root Fingerprint: 10a2113621dc7ffc630a967d3ed40750bcbf38a7582b5b49ea45c401a32b6a99 server # [ 18.823236] systemd[1]: Started step-ca service. server # [ 18.826352] systemd[1]: Reached target Multi-User System. server # [ 18.831661] systemd[1]: Starting Order (and renew) ACME certificate for server... server # [ 18.836712] step-ca[885]: 2026/09/21 13:48:48 Serving HTTPS on 0.0.0.0:8443 ... server # [ 18.910704] acme-order-renew-server-start[891]: Waiting to acquire lock in /run/acme/ server # [ 18.923912] acme-order-renew-server-start[891]: + set -euo pipefail server # [ 18.925422] acme-order-renew-server-start[891]: + echo 95dbbf40517986466fee server # [ 18.926681] acme-order-renew-server-start[891]: + cmp -s domainhash.txt certificates/domainhash.txt server # [ 18.942164] acme-order-renew-server-start[891]: + 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 server: (finished: waiting for unit step-ca.service, in 19.24 seconds) server: waiting for unit nix-grpc-daemon.socket server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.07 seconds) server: waiting for TCP port 50051 on localhost server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded! server: (finished: waiting for TCP port 50051 on localhost, in 0.09 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) server # [ 19.350258] acme-order-renew-server-start[905]: 2026/09/21 13:48:48 No key found for account root@example.org. Generating a P256 key. server # [ 19.355150] acme-order-renew-server-start[905]: 2026/09/21 13:48:48 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key server # [ 19.390976] acme-order-renew-server-start[905]: 2026/09/21 13:48:48 [INFO] acme: Registering account for root@example.org server # [ 19.405305] acme-order-renew-server-start[905]: !!!! HEADS UP !!!! server # [ 19.407085] acme-order-renew-server-start[905]: Your account credentials have been saved in your server # [ 19.408596] acme-order-renew-server-start[905]: configuration directory at "accounts". server # [ 19.409705] acme-order-renew-server-start[905]: You should make a secure backup of this folder now. This server # [ 19.411015] acme-order-renew-server-start[905]: configuration directory will also contain private keys server # [ 19.412768] acme-order-renew-server-start[905]: generated by lego and certificates obtained from the ACME server # [ 19.414163] acme-order-renew-server-start[905]: server. Making regular backups of this folder is ideal. server # [ 19.415432] acme-order-renew-server-start[905]: 2026/09/21 13:48:48 [INFO] [server] acme: Obtaining bundled SAN certificate server # [ 19.490307] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] AuthURL: https://server:8443/acme/acme/authz/zWnwyt6ZAPOnM7UsQ1gSKFarepkYgQ4a server # [ 19.493784] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] acme: Could not find solver for: tls-alpn-01 server # [ 19.495572] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] acme: use http-01 solver server # [ 19.497235] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] acme: Trying to solve HTTP-01 server # [ 19.506536] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] Served key authentication server # [ 19.512350] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] The server validated our request server # [ 19.514290] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] acme: Validations succeeded; requesting certificates server # [ 19.534896] acme-order-renew-server-start[905]: 2026/09/21 13:48:49 [INFO] [server] Server responded with a certificate. server # [ 19.537822] acme-order-renew-server-start[891]: + mv domainhash.txt certificates/ server # [ 19.546902] acme-order-renew-server-start[891]: + touch out/acme-success server # [ 19.555270] acme-order-renew-server-start[891]: + cmp -s certificates/server.crt out/fullchain.pem server # [ 19.560939] acme-order-renew-server-start[891]: + touch out/renewed server # [ 19.567721] acme-order-renew-server-start[891]: + echo Installing new certificate server # [ 19.569213] acme-order-renew-server-start[891]: Installing new certificate server # [ 19.570317] acme-order-renew-server-start[891]: + cp -vp certificates/server.crt out/fullchain.pem server # [ 19.577914] acme-order-renew-server-start[922]: 'certificates/server.crt' -> 'out/fullchain.pem' server # [ 19.580064] acme-order-renew-server-start[891]: + cp -vp certificates/server.key out/key.pem server # [ 19.586868] acme-order-renew-server-start[923]: 'certificates/server.key' -> 'out/key.pem' server # [ 19.588926] acme-order-renew-server-start[891]: + cp -vp certificates/server.issuer.crt out/chain.pem server # [ 19.595478] acme-order-renew-server-start[924]: 'certificates/server.issuer.crt' -> 'out/chain.pem' server # [ 19.597453] acme-order-renew-server-start[891]: + ln -sf fullchain.pem out/cert.pem server # [ 19.603568] acme-order-renew-server-start[891]: + cat out/key.pem out/fullchain.pem server # [ 19.609968] acme-order-renew-server-start[891]: + for fixpath in out certificates server # [ 19.611094] acme-order-renew-server-start[891]: + '[' -d out ']' server # [ 19.612105] acme-order-renew-server-start[891]: + chmod -R u=rwX,g=rX,o= out server # [ 19.618081] acme-order-renew-server-start[891]: + chown -R acme:nix-grpc-daemon out server # [ 19.626289] acme-order-renew-server-start[891]: + for fixpath in out certificates server # [ 19.627337] acme-order-renew-server-start[891]: + '[' -d certificates ']' server # [ 19.628525] acme-order-renew-server-start[891]: + chmod -R u=rwX,g=rX,o= certificates server # [ 19.634643] acme-order-renew-server-start[891]: + chown -R acme:nix-grpc-daemon certificates server # [ 19.642376] acme-order-renew-server-start[891]: + chmod -R u=rwX,g=,o= accounts/. server # [ 19.713435] systemd[1]: acme-order-renew-server.service: Deactivated successfully. server # [ 19.716681] systemd[1]: Finished Order (and renew) ACME certificate for server. server # [ 19.720118] systemd[1]: acme-order-renew-server.service: Consumed 218ms CPU time over 883ms wall clock time, 33.6M memory peak, 10.2K incoming IP traffic, 8.2K outgoing IP traffic. server # [ 19.727492] systemd[1]: Starting Nix worker-protocol over gRPC... host1 # [ 19.877741] dhcpcd[688]: eth0: leased 10.0.2.15 for 86400 seconds host1 # [ 19.881974] dhcpcd[688]: eth0: adding route to 10.0.2.0/24 host1 # [ 19.884972] dhcpcd[688]: eth0: adding default route via 10.0.2.2 server # [ 19.941628] nix-grpc-daemon[942]: ts=2026-09-21T13:48:49Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=1 server # [ 19.977712] nix-grpc-daemon[942]: WARNING: All log messages before absl::InitializeLog() is called are written to STDERR server # [ 19.979390] nix-grpc-daemon[942]: E0000 00:00:1789998529.520704 942 tls_security_connector.cc:771] TlsServerCertificateWatcher getting identity_cert_error: UNKNOWN:Unable to get latest identity certificates. server # [ 19.992615] nix-grpc-daemon[942]: E0000 00:00:1789998529.535667 942 tls_security_connector.cc:767] TlsServerCertificateWatcher getting root_cert_error: UNKNOWN:Unable to get latest root certificates. server # [ 19.995825] nix-grpc-daemon[942]: ts=2026-09-21T13:48:49Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket server # [ 19.999788] nix-grpc-daemon[942]: ts=2026-09-21T13:48:49Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=0 server # [ 20.002085] nix-grpc-daemon[942]: ts=2026-09-21T13:48:49Z level=info event=unhealthy reason=min_free server # [ 20.003386] systemd[1]: Started Nix worker-protocol over gRPC. server # [ 20.004658] systemd[1]: Startup finished in 1.032s (kernel) + 5.379s (initrd) + 13.585s (userspace) = 19.998s. host1 # [ 20.039555] systemd[1]: Started DHCP Client. host1 # [ 20.042227] systemd[1]: Reached target Network is Online. host1 # [ 20.046576] systemd[1]: Starting fetch-ca-root.service... host1 # [ 20.154782] systemd[1]: Finished fetch-ca-root.service. host1 # [ 20.158757] systemd[1]: Reached target Multi-User System. host1 # [ 20.161646] systemd[1]: Starting Order (and renew) ACME certificate for host1... host1 # [ 20.224769] acme-order-renew-host1-start[824]: Waiting to acquire lock in /run/acme/ host1 # [ 20.238771] acme-order-renew-host1-start[824]: + set -euo pipefail host1 # [ 20.240158] acme-order-renew-host1-start[824]: + echo 76ccde284609af0e376b host1 # [ 20.241207] acme-order-renew-host1-start[824]: + cmp -s domainhash.txt certificates/domainhash.txt host1 # [ 20.251317] acme-order-renew-host1-start[824]: + 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 host1 # [ 20.573986] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 No key found for account root@example.org. Generating a P256 key. host1 # [ 20.578317] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key host1 # [ 20.608088] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] acme: Registering account for root@example.org host1 # [ 20.626308] acme-order-renew-host1-start[836]: !!!! HEADS UP !!!! host1 # [ 20.627730] acme-order-renew-host1-start[836]: Your account credentials have been saved in your host1 # [ 20.629000] acme-order-renew-host1-start[836]: configuration directory at "accounts". host1 # [ 20.630055] acme-order-renew-host1-start[836]: You should make a secure backup of this folder now. This host1 # [ 20.631261] acme-order-renew-host1-start[836]: configuration directory will also contain private keys host1 # [ 20.632506] acme-order-renew-host1-start[836]: generated by lego and certificates obtained from the ACME host1 # [ 20.633744] acme-order-renew-host1-start[836]: server. Making regular backups of this folder is ideal. host1 # [ 20.634929] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] acme: Obtaining bundled SAN certificate host1 # [ 20.710508] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] AuthURL: https://server:8443/acme/acme/authz/WiVeckiuxUcmbjoLsclm7ZFwTVHnTlzs host1 # [ 20.716878] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] acme: Could not find solver for: tls-alpn-01 host1 # [ 20.720701] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] acme: use http-01 solver host1 # [ 20.723769] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] acme: Trying to solve HTTP-01 host1 # [ 20.729039] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] Served key authentication host1 # [ 20.736108] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] The server validated our request host1 # [ 20.739261] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] acme: Validations succeeded; requesting certificates host1 # [ 20.769094] acme-order-renew-host1-start[836]: 2026/09/21 13:48:50 [INFO] [host1] Server responded with a certificate. host1 # [ 20.780929] acme-order-renew-host1-start[824]: + mv domainhash.txt certificates/ host1 # [ 20.795560] acme-order-renew-host1-start[824]: + touch out/acme-success host1 # [ 20.809247] acme-order-renew-host1-start[824]: + cmp -s certificates/host1.crt out/fullchain.pem host1 # [ 20.818217] acme-order-renew-host1-start[824]: + touch out/renewed host1 # [ 20.828443] acme-order-renew-host1-start[824]: + echo Installing new certificate host1 # [ 20.831067] acme-order-renew-host1-start[824]: Installing new certificate host1 # [ 20.833623] acme-order-renew-host1-start[824]: + cp -vp certificates/host1.crt out/fullchain.pem host1 # [ 20.844735] acme-order-renew-host1-start[846]: 'certificates/host1.crt' -> 'out/fullchain.pem' host1 # [ 20.848777] acme-order-renew-host1-start[824]: + cp -vp certificates/host1.key out/key.pem host1 # [ 20.857776] acme-order-renew-host1-start[847]: 'certificates/host1.key' -> 'out/key.pem' host1 # [ 20.860570] acme-order-renew-host1-start[824]: + cp -vp certificates/host1.issuer.crt out/chain.pem host1 # [ 20.867933] acme-order-renew-host1-start[848]: 'certificates/host1.issuer.crt' -> 'out/chain.pem' host1 # [ 20.870438] acme-order-renew-host1-start[824]: + ln -sf fullchain.pem out/cert.pem host1 # [ 20.878370] acme-order-renew-host1-start[824]: + cat out/key.pem out/fullchain.pem host1 # [ 20.887426] acme-order-renew-host1-start[824]: + for fixpath in out certificates host1 # [ 20.889313] acme-order-renew-host1-start[824]: + '[' -d out ']' host1 # [ 20.890690] acme-order-renew-host1-start[824]: + chmod -R u=rwX,g=rX,o= out host1 # [ 20.898381] acme-order-renew-host1-start[824]: + chown -R acme:acme out host1 # [ 20.908627] acme-order-renew-host1-start[824]: + for fixpath in out certificates host1 # [ 20.909974] acme-order-renew-host1-start[824]: + '[' -d certificates ']' host1 # [ 20.911150] acme-order-renew-host1-start[824]: + chmod -R u=rwX,g=rX,o= certificates host1 # [ 20.917519] acme-order-renew-host1-start[824]: + chown -R acme:acme certificates host1 # [ 20.925913] acme-order-renew-host1-start[824]: + chmod -R u=rwX,g=,o= accounts/. host1 # [ 20.989381] systemd[1]: acme-order-renew-host1.service: Deactivated successfully. host1 # [ 20.991435] systemd[1]: Finished Order (and renew) ACME certificate for host1. host1 # [ 21.005060] systemd[1]: Startup finished in 1.025s (kernel) + 5.485s (initrd) + 14.493s (userspace) = 21.004s. host1 # [ 21.006461] systemd[1]: acme-order-renew-host1.service: Consumed 225ms CPU time over 829ms wall clock time, 33.4M memory peak, 10.3K incoming IP traffic, 8.3K outgoing IP traffic. 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 2.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.06 seconds) (finished: subtest: host1 obtains a certificate via ACME, in 2.36 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 31 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 70 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 48 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 605 ms (attempt 4/5) server # disabling binary cache 'https://cache.nixos.org' for 60 seconds 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.43 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.23 seconds) (finished: subtest: server builds and signs a path, in 1.66 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.03 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 10 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 55 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 342 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 514 ms (attempt 4/5) host1 # disabling binary cache 'https://cache.nixos.org' for 60 seconds 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 # [ 24.345953] systemd[1]: Started Nix Daemon. server # [ 24.552678] nix-daemon[978]: accepted connection from pid 942, 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 # [ 24.606932] nix-grpc-daemon[942]: ts=2026-09-21T13:48:54Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:60888 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.03 seconds) (finished: subtest: host1 substitutes the signed path over gRPC (read-only cert), in 1.57 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 # [ 24.939397] nix-grpc-daemon[942]: ts=2026-09-21T13:48:54Z 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.24 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.06 seconds) (finished: subtest: read-only host1 cannot write, in 0.32 seconds) (finished: run the VM test script, in 25.87 seconds) test script finished in 25.99s 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.46 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