nixbot

builds

succeeded vm-test-run-nix-grpc-store-acme-substituter checks.aarch64-linux.acme-vm · build #204 · raw

1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 600.0 seconds6run the VM test script7start all VMs8host1: starting vm9server: starting vm10host1 # Disk image does not exist, creating the virtualisation disk image...11host1 # Formatting '/build/vm-state-host1/tmp.WJSc5Vb51U', fmt=raw size=107374182412host1: QEMU running (pid 47)13host1 # mke2fs 1.47.4 (6-Mar-2025)14server # Disk image does not exist, creating the virtualisation disk image...15host1 # Discarding device blocks: 0/262144 done16server # Formatting '/build/vm-state-server/tmp.VCYtJRyTnK', fmt=raw size=107374182417host1 # Creating filesystem with 262144 4k blocks and 65536 inodes18server # mke2fs 1.47.4 (6-Mar-2025)19host1 # Filesystem UUID: 6cde2050-13e9-4129-9f71-dac9b5c4d6d920server # Discarding device blocks: 0/262144 done21host1 # Superblock backups stored on blocks:22server # Creating filesystem with 262144 4k blocks and 65536 inodes23host1 # 32768, 98304, 163840, 22937624server # Filesystem UUID: 8cffac7d-3734-464a-b584-58e305d3a61d25host1 # 26server # Superblock backups stored on blocks:27host1 # Allocating group tables: 0/8 done28server # 32768, 98304, 163840, 22937629host1 # Writing inode tables: 0/8 done30server # 31host1 # Creating journal (8192 blocks): done32server # Allocating group tables: 0/8 done33host1 # Writing superblocks and filesystem accounting information: 0/8 done34server # Writing inode tables: 0/8 done35host1 # 36server # Creating journal (8192 blocks): done37host1 # Virtualisation disk image created.38server # Writing superblocks and filesystem accounting information: 0/8 done39server: QEMU running (pid 48)40server # 41server # Virtualisation disk image created.42(finished: start all VMs, in 0.46 seconds)43server: waiting for unit step-ca.service44server: waiting for the VM to finish booting45host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]46host1 # [ 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 202647host1 # [ 0.000000] KASLR enabled48host1 # [ 0.000000] random: crng init done49host1 # [ 0.000000] Machine model: linux,dummy-virt50host1 # [ 0.000000] efi: UEFI not found.51host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT52host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]53host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]54host1 # [ 0.000000] Zone ranges:55host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]56host1 # [ 0.000000] DMA32 empty57host1 # [ 0.000000] Normal empty58host1 # [ 0.000000] Device empty59host1 # [ 0.000000] Movable zone start for each node60host1 # [ 0.000000] Early memory node ranges61host1 # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]62host1 # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]63host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc0000064host1 # [ 0.000000] psci: probing for conduit method from DT.65host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware.66host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs67host1 # [ 0.000000] psci: Trusted OS migration not required68host1 # [ 0.000000] psci: SMC Calling Convention v1.169host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)70host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129671host1 # [ 0.000000] Detected PIPT I-cache on CPU072host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)73host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface74host1 # [ 0.000000] CPU features: detected: Spectre-v475host1 # [ 0.000000] CPU features: detected: Spectre-BHB76host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3877host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2378host1 # [ 0.000000] alternatives: applying boot alternatives79host1 # [ 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/4bc1mgsrjjn6k2kyzhbmgvvyklnm7wn8-nixos-system-host1-test/init regInfo=/nix/store/qj6sw189171m0zh573scg1w860pidzfy-closure-info/registration console=ttyAMA0,115200n8 console=tty080host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/qj6sw189171m0zh573scg1w860pidzfy-closure-info/registration", will be passed to user space.81host1 # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes82host1 # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)83host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)84host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB85host1 # [ 0.000000] software IO TLB: area num 1.86server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]87host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)88host1 # [ 0.000000] Fallback order for Node 0: 089server # [ 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 202690server # [ 0.000000] KASLR enabled91host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 52428892server # [ 0.000000] random: crng init done93host1 # [ 0.000000] Policy zone: DMA94server # [ 0.000000] Machine model: linux,dummy-virt95server # [ 0.000000] efi: UEFI not found.96host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off97host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=198server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT99host1 # [ 0.000000] allocated 4194304 bytes of page_ext100server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]101host1 # [ 0.000000] ftrace: allocating 74885 entries in 294 pages102server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]103host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups104server # [ 0.000000] Zone ranges:105host1 # [ 0.000000] rcu: Hierarchical RCU implementation.106server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]107host1 # [ 0.000000] rcu: RCU event tracing is enabled.108server # [ 0.000000] DMA32 empty109server # [ 0.000000] Normal empty110server # [ 0.000000] Device empty111host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.112server # [ 0.000000] Movable zone start for each node113host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled.114server # [ 0.000000] Early memory node ranges115host1 # [ 0.000000] Rude variant of Tasks RCU enabled.116server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]117host1 # [ 0.000000] Tracing variant of Tasks RCU enabled.118server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]119host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.120server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000121host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1122server # [ 0.000000] psci: probing for conduit method from DT.123server # [ 0.000000] psci: PSCIv1.3 detected in firmware.124host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.125server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs126server # [ 0.000000] psci: Trusted OS migration not required127host1 # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.128server # [ 0.000000] psci: SMC Calling Convention v1.1129host1 # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.130server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)131host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0132host1 # [ 0.000000] GICv3: 256 SPIs implemented133server # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296134host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented135server # [ 0.000000] Detected PIPT I-cache on CPU0136host1 # [ 0.000000] Root IRQ handler: gic_handle_irq137server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)138host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI139host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0140server # [ 0.000000] CPU features: detected: GICv3 CPU interface141server # [ 0.000000] CPU features: detected: Spectre-v4142host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000143server # [ 0.000000] CPU features: detected: Spectre-BHB144host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]145server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38146host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1)147server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23148server # [ 0.000000] alternatives: applying boot alternatives149host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)150host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000151host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000152host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.153server # [ 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/dpy0livxmahpf0cnbxp7nj2vj1zr970a-nixos-system-server-test/init regInfo=/nix/store/4cya98zhx3a7ps62vrmg4klg26kpb1zh-closure-info/registration console=ttyAMA0,115200n8 console=tty0154host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns155host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).156host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns157server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/4cya98zhx3a7ps62vrmg4klg26kpb1zh-closure-info/registration", will be passed to user space.158host1 # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns159server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes160host1 # [ 0.000030] arm-pv: using stolen time PV161server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)162host1 # [ 0.000453] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)163server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)164host1 # [ 0.000622] Console: colour dummy device 80x25165server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB166host1 # [ 0.000630] printk: legacy console [tty0] enabled167server # [ 0.000000] software IO TLB: area num 1.168host1 # [ 0.000842] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)169server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)170server # [ 0.000000] Fallback order for Node 0: 0171host1 # [ 0.000849] pid_max: default: 32768 minimum: 301172host1 # [ 0.000927] LSM: initializing lsm=capability,landlock,yama,bpf,ima173server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288174host1 # [ 0.001075] landlock: Up and running.175server # [ 0.000000] Policy zone: DMA176host1 # [ 0.001078] Yama: becoming mindful.177server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off178host1 # [ 0.001564] LSM support for eBPF active179server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1180host1 # [ 0.001691] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)181server # [ 0.000000] allocated 4194304 bytes of page_ext182host1 # [ 0.001723] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)183server # [ 0.000000] ftrace: allocating 74885 entries in 294 pages184server # [ 0.000000] ftrace: allocated 294 pages with 4 groups185host1 # [ 0.002931] cacheinfo: Unable to detect cache hierarchy for CPU 0186server # [ 0.000000] rcu: Hierarchical RCU implementation.187host1 # [ 0.003639] rcu: Hierarchical SRCU implementation.188server # [ 0.000000] rcu: RCU event tracing is enabled.189host1 # [ 0.003643] rcu: Max phase no-delay instances is 1000.190host1 # [ 0.005151] fsl-mc MSI: its@8080000 domain created191server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.192host1 # [ 0.005243] EFI services will not be available.193server # [ 0.000000] Trampoline variant of Tasks RCU enabled.194host1 # [ 0.005323] smp: Bringing up secondary CPUs ...195server # [ 0.000000] Rude variant of Tasks RCU enabled.196host1 # [ 0.005331] smp: Brought up 1 node, 1 CPU197server # [ 0.000000] Tracing variant of Tasks RCU enabled.198host1 # [ 0.005335] SMP: Total of 1 processors activated.199host1 # [ 0.005337] CPU: All CPU(s) started at EL1200server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.201host1 # [ 0.005351] CPU features: detected: Branch Target Identification202server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1203host1 # [ 0.005356] CPU features: detected: ARMv8.4 Translation Table Level204server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.205host1 # [ 0.005359] CPU features: detected: Instruction cache invalidation not required for I/D coherence206server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.207host1 # [ 0.005363] CPU features: detected: Data cache clean to the PoU not required for I/D coherence208server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.209host1 # [ 0.005366] CPU features: detected: Common not Private translations210server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0211host1 # [ 0.005370] CPU features: detected: CRC32 instructions212server # [ 0.000000] GICv3: 256 SPIs implemented213server # [ 0.000000] GICv3: 0 Extended SPIs implemented214host1 # [ 0.005373] CPU features: detected: Data cache clean to Point of Deep Persistence215server # [ 0.000000] Root IRQ handler: gic_handle_irq216host1 # [ 0.005376] CPU features: detected: Data cache clean to Point of Persistence217server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI218host1 # [ 0.005379] CPU features: detected: Data independent timing control (DIT)219server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0220host1 # [ 0.005383] CPU features: detected: E0PD221server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000222host1 # [ 0.005385] CPU features: detected: Enhanced Counter Virtualization223server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]224host1 # [ 0.005388] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)225server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1)226host1 # [ 0.005391] CPU features: detected: Enhanced Virtualization Traps227host1 # [ 0.005394] CPU features: detected: Fine Grained Traps228server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1)229server # [ 0.000000] GICv3: using LPI property table @0x0000000044b00000230host1 # [ 0.005398] CPU features: detected: Generic authentication (architected QARMA5 algorithm)231host1 # [ 0.005404] CPU features: detected: RCpc load-acquire (LDAPR)232server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b10000233host1 # [ 0.005414] CPU features: detected: LSE atomic instructions234server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.235host1 # [ 0.005417] CPU features: detected: Privileged Access Never236host1 # [ 0.005419] CPU features: detected: PMUv3237server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns238host1 # [ 0.005422] CPU features: detected: RAS Extension Support239server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).240host1 # [ 0.005425] CPU features: detected: RASv1p1 Extension Support241host1 # [ 0.005427] CPU features: detected: Random Number Generator242server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns243host1 # [ 0.005430] CPU features: detected: Speculation barrier (SB)244server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns245host1 # [ 0.005433] CPU features: detected: Stage-2 Force Write-Back246server # [ 0.000029] arm-pv: using stolen time PV247host1 # [ 0.005436] CPU features: detected: TLB range maintenance instructions248server # [ 0.000390] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)249host1 # [ 0.005441] CPU features: detected: Speculative Store Bypassing Safe (SSBS)250server # [ 0.000591] Console: colour dummy device 80x25251host1 # [ 0.005479] alternatives: applying system-wide alternatives252server # [ 0.000599] printk: legacy console [tty0] enabled253host1 # [ 0.008441] CPU features: detected: BBM Level 2 without TLB conflict abort254server # [ 0.000804] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)255server # [ 0.000811] pid_max: default: 32768 minimum: 301256server # [ 0.000897] LSM: initializing lsm=capability,landlock,yama,bpf,ima257server # [ 0.001037] landlock: Up and running.258server # [ 0.001040] Yama: becoming mindful.259server # [ 0.001507] LSM support for eBPF active260server # [ 0.001658] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)261server # [ 0.001698] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)262server # [ 0.002819] cacheinfo: Unable to detect cache hierarchy for CPU 0263server # [ 0.003577] rcu: Hierarchical SRCU implementation.264server # [ 0.003581] rcu: Max phase no-delay instances is 1000.265server # [ 0.004800] fsl-mc MSI: its@8080000 domain created266server # [ 0.004890] EFI services will not be available.267server # [ 0.005237] smp: Bringing up secondary CPUs ...268server # [ 0.005245] smp: Brought up 1 node, 1 CPU269host1 # [ 0.008598] Memory: 1921588K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131976K reserved, 32768K cma-reserved)270server # [ 0.005249] SMP: Total of 1 processors activated.271host1 # [ 0.009034] devtmpfs: initialized272server # [ 0.005251] CPU: All CPU(s) started at EL1273server # [ 0.005264] CPU features: detected: Branch Target Identification274host1 # [ 0.010872] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)275server # [ 0.005268] CPU features: detected: ARMv8.4 Translation Table Level276host1 # [ 0.010895] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).277host1 # [ 0.011118] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL278server # [ 0.005271] CPU features: detected: Instruction cache invalidation not required for I/D coherence279host1 # [ 0.011122] 0 pages in range for non-PLT usage280server # [ 0.005275] CPU features: detected: Data cache clean to the PoU not required for I/D coherence281host1 # [ 0.011123] 508288 pages in range for PLT usage282host1 # [ 0.011220] pinctrl core: initialized pinctrl subsystem283server # [ 0.005278] CPU features: detected: Common not Private translations284host1 # [ 0.011956] DMI not present or invalid.285server # [ 0.005281] CPU features: detected: CRC32 instructions286host1 # [ 0.015249] NET: Registered PF_NETLINK/PF_ROUTE protocol family287server # [ 0.005284] CPU features: detected: Data cache clean to Point of Deep Persistence288host1 # [ 0.017569] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations289server # [ 0.005287] CPU features: detected: Data cache clean to Point of Persistence290host1 # [ 0.017749] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations291server # [ 0.005290] CPU features: detected: Data independent timing control (DIT)292server # [ 0.005293] CPU features: detected: E0PD293host1 # [ 0.017949] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations294server # [ 0.005295] CPU features: detected: Enhanced Counter Virtualization295host1 # [ 0.017970] audit: initializing netlink subsys (disabled)296host1 # [ 0.018520] thermal_sys: Registered thermal governor 'fair_share'297server # [ 0.005298] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)298host1 # [ 0.018522] thermal_sys: Registered thermal governor 'bang_bang'299server # [ 0.005302] CPU features: detected: Enhanced Virtualization Traps300server # [ 0.005305] CPU features: detected: Fine Grained Traps301host1 # [ 0.018526] thermal_sys: Registered thermal governor 'step_wise'302host1 # [ 0.018528] thermal_sys: Registered thermal governor 'user_space'303server # [ 0.005308] CPU features: detected: Generic authentication (architected QARMA5 algorithm)304host1 # [ 0.018533] thermal_sys: Registered thermal governor 'power_allocator'305server # [ 0.005313] CPU features: detected: RCpc load-acquire (LDAPR)306server # [ 0.005316] CPU features: detected: LSE atomic instructions307host1 # [ 0.018559] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1308server # [ 0.005318] CPU features: detected: Privileged Access Never309host1 # [ 0.018567] cpuidle: using governor ladder310server # [ 0.005321] CPU features: detected: PMUv3311host1 # [ 0.018572] cpuidle: using governor menu312host1 # [ 0.018783] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.313server # [ 0.005324] CPU features: detected: RAS Extension Support314host1 # [ 0.018798] ASID allocator initialised with 65536 entries315server # [ 0.005326] CPU features: detected: RASv1p1 Extension Support316host1 # [ 0.019994] Serial: AMBA PL011 UART driver317server # [ 0.005329] CPU features: detected: Random Number Generator318server # [ 0.005332] CPU features: detected: Speculation barrier (SB)319host1 # [ 0.025107] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1320host1 # [ 0.025266] printk: console [ttyAMA0] enabled321server # [ 0.005334] CPU features: detected: Stage-2 Force Write-Back322server # [ 0.005337] CPU features: detected: TLB range maintenance instructions323host1 # [ 0.149617] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages324server # [ 0.005341] CPU features: detected: Speculative Store Bypassing Safe (SSBS)325host1 # [ 0.149636] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page326server # [ 0.005377] alternatives: applying system-wide alternatives327host1 # [ 0.149641] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages328server # [ 0.008375] CPU features: detected: BBM Level 2 without TLB conflict abort329host1 # [ 0.149645] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page330host1 # [ 0.149650] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages331server # [ 0.008517] Memory: 1921608K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131956K reserved, 32768K cma-reserved)332server # [ 0.008911] devtmpfs: initialized333host1 # [ 0.149654] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page334host1 # [ 0.149658] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages335host1 # [ 0.149662] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page336host1 # [ 0.157104] fbcon: Taking over console337host1 # [ 0.157117] ACPI: Interpreter disabled.338server # [ 0.010845] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)339server # [ 0.010875] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).340host1 # [ 0.164138] iommu: Default domain type: Translated341server # [ 0.011044] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL342host1 # [ 0.164147] iommu: DMA domain TLB invalidation policy: strict mode343server # [ 0.011049] 0 pages in range for non-PLT usage344server # [ 0.011050] 508288 pages in range for PLT usage345host1 # [ 0.165871] SCSI subsystem initialized346server # [ 0.011165] pinctrl core: initialized pinctrl subsystem347server # [ 0.011913] DMI not present or invalid.348host1 # [ 0.166548] usbcore: registered new interface driver usbfs349server # [ 0.014952] NET: Registered PF_NETLINK/PF_ROUTE protocol family350host1 # [ 0.166579] usbcore: registered new interface driver hub351server # [ 0.017239] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations352host1 # [ 0.166596] usbcore: registered new device driver usb353host1 # [ 0.166860] pps_core: LinuxPPS API ver. 1 registered354server # [ 0.017435] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations355host1 # [ 0.166866] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>356server # [ 0.017637] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations357host1 # [ 0.166875] PTP clock support registered358server # [ 0.017659] audit: initializing netlink subsys (disabled)359host1 # [ 0.166923] EDAC MC: Ver: 3.0.0360server # [ 0.018286] thermal_sys: Registered thermal governor 'fair_share'361host1 # [ 0.171568] scmi_core: SCMI protocol bus registered362server # [ 0.018288] thermal_sys: Registered thermal governor 'bang_bang'363host1 # [ 0.172565] FPGA manager framework364server # [ 0.018292] thermal_sys: Registered thermal governor 'step_wise'365host1 # [ 0.173546] vgaarb: loaded366server # [ 0.018295] thermal_sys: Registered thermal governor 'user_space'367host1 # [ 0.174181] clocksource: Switched to clocksource arch_sys_counter368server # [ 0.018301] thermal_sys: Registered thermal governor 'power_allocator'369server # [ 0.018332] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1370server # [ 0.018341] cpuidle: using governor ladder371server # [ 0.018346] cpuidle: using governor menu372host1 # [ 0.177338] VFS: Disk quotas dquot_6.6.0373server # [ 0.018527] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.374server # [ 0.018543] ASID allocator initialised with 65536 entries375host1 # [ 0.177370] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)376server # [ 0.019669] Serial: AMBA PL011 UART driver377server # [ 0.024843] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1378server # [ 0.024991] printk: console [ttyAMA0] enabled379host1 # [ 0.180992] netfs: FS-Cache loaded380host1 # [ 0.181111] pnp: PnP ACPI: disabled381server # [ 0.149600] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages382server # [ 0.149618] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page383server # [ 0.149623] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages384server # [ 0.149628] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page385server # [ 0.149632] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages386server # [ 0.149636] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page387host1 # [ 0.184966] NET: Registered PF_INET protocol family388server # [ 0.149641] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages389host1 # [ 0.185555] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)390server # [ 0.149645] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page391server # [ 0.157091] fbcon: Taking over console392server # [ 0.157113] ACPI: Interpreter disabled.393server # [ 0.158986] iommu: Default domain type: Translated394server # [ 0.158996] iommu: DMA domain TLB invalidation policy: strict mode395server # [ 0.160650] SCSI subsystem initialized396server # [ 0.165997] usbcore: registered new interface driver usbfs397server # [ 0.166030] usbcore: registered new interface driver hub398server # [ 0.166054] usbcore: registered new device driver usb399server # [ 0.166318] pps_core: LinuxPPS API ver. 1 registered400server # [ 0.166324] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>401server # [ 0.166335] PTP clock support registered402server # [ 0.166382] EDAC MC: Ver: 3.0.0403server # [ 0.171057] scmi_core: SCMI protocol bus registered404server # [ 0.172036] FPGA manager framework405server # [ 0.172999] vgaarb: loaded406server # [ 0.173652] clocksource: Switched to clocksource arch_sys_counter407server # [ 0.177437] VFS: Disk quotas dquot_6.6.0408server # [ 0.177467] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)409server # [ 0.181165] netfs: FS-Cache loaded410server # [ 0.181297] pnp: PnP ACPI: disabled411server # [ 0.185252] NET: Registered PF_INET protocol family412server # [ 0.185547] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)413host1 # [ 0.215395] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)414host1 # [ 0.215446] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)415host1 # [ 0.215476] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)416host1 # [ 0.215552] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)417host1 # [ 0.215698] TCP: Hash tables configured (established 16384 bind 16384)418host1 # [ 0.215780] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)419host1 # [ 0.215824] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)420host1 # [ 0.215861] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)421host1 # [ 0.215950] NET: Registered PF_UNIX/PF_LOCAL protocol family422host1 # [ 0.215969] NET: Registered PF_XDP protocol family423host1 # [ 0.215990] PCI: CLS 0 bytes, default 64424host1 # [ 0.216238] Trying to unpack rootfs image as initramfs...425host1 # [ 0.232021] kvm [1]: HYP mode not available426server # [ 0.215094] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)427server # [ 0.215140] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)428server # [ 0.215169] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)429server # [ 0.215239] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)430server # [ 0.215384] TCP: Hash tables configured (established 16384 bind 16384)431server # [ 0.215467] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)432server # [ 0.215502] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)433server # [ 0.215541] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)434server # [ 0.215646] NET: Registered PF_UNIX/PF_LOCAL protocol family435server # [ 0.215666] NET: Registered PF_XDP protocol family436server # [ 0.215687] PCI: CLS 0 bytes, default 64437server # [ 0.215926] Trying to unpack rootfs image as initramfs...438server # [ 0.231372] kvm [1]: HYP mode not available439host1 # [ 0.322707] Initialise system trusted keyrings440host1 # [ 0.323445] workingset: timestamp_bits=42 max_order=19 bucket_order=0441host1 # [ 0.324702] squashfs: version 4.0 (2009/01/31) Phillip Lougher442host1 # [ 0.325499] 9p: Installing v9fs 9p2000 file system support443host1 # [ 0.346147] Key type asymmetric registered444host1 # [ 0.346173] Asymmetric key parser 'x509' registered445server # [ 0.322220] Initialise system trusted keyrings446host1 # [ 0.354286] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)447server # [ 0.322987] workingset: timestamp_bits=42 max_order=19 bucket_order=0448host1 # [ 0.355338] io scheduler mq-deadline registered449host1 # [ 0.355349] io scheduler kyber registered450server # [ 0.324325] squashfs: version 4.0 (2009/01/31) Phillip Lougher451server # [ 0.325134] 9p: Installing v9fs 9p2000 file system support452host1 # [ 0.366306] pl061_gpio 9030000.pl061: PL061 GPIO chip registered453host1 # [ 0.366905] ledtrig-cpu: registered to indicate activity on CPUs454host1 # [ 0.367244] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:455host1 # [ 0.367260] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000456host1 # [ 0.367279] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000457host1 # [ 0.367288] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000458host1 # [ 0.367308] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits459host1 # [ 0.367331] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]460host1 # [ 0.367407] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00461host1 # [ 0.367417] pci_bus 0000:00: root bus resource [bus 00-ff]462host1 # [ 0.367423] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]463host1 # [ 0.367428] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]464host1 # [ 0.367432] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]465server # [ 0.353816] Key type asymmetric registered466server # [ 0.353844] Asymmetric key parser 'x509' registered467host1 # [ 0.367507] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint468server # [ 0.353909] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)469host1 # [ 0.367937] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint470server # [ 0.356038] io scheduler mq-deadline registered471host1 # [ 0.368120] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]472server # [ 0.356048] io scheduler kyber registered473host1 # [ 0.368136] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]474host1 # [ 0.368166] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475host1 # [ 0.368182] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]476host1 # [ 0.368626] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint477host1 # [ 0.368819] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]478host1 # [ 0.368836] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]479host1 # [ 0.368865] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]480host1 # [ 0.369313] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint481host1 # [ 0.369494] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]482host1 # [ 0.369509] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]483host1 # [ 0.369538] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]484host1 # [ 0.369984] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint485server # [ 0.365777] pl061_gpio 9030000.pl061: PL061 GPIO chip registered486host1 # [ 0.370163] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]487host1 # [ 0.370178] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]488host1 # [ 0.370229] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]489host1 # [ 0.370680] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint490host1 # [ 0.370857] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]491server # [ 0.367148] ledtrig-cpu: registered to indicate activity on CPUs492host1 # [ 0.370873] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]493server # [ 0.367542] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:494host1 # [ 0.370902] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]495server # [ 0.367559] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000496host1 # [ 0.371361] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint497server # [ 0.367571] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000498host1 # [ 0.371539] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]499host1 # [ 0.371555] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]500server # [ 0.367579] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000501host1 # [ 0.371584] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]502server # [ 0.367599] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits503host1 # [ 0.372058] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint504host1 # [ 0.372237] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]505server # [ 0.367623] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]506host1 # [ 0.372253] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]507server # [ 0.367697] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00508host1 # [ 0.372281] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]509server # [ 0.367706] pci_bus 0000:00: root bus resource [bus 00-ff]510host1 # [ 0.372297] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]511server # [ 0.367712] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]512server # [ 0.367717] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]513host1 # [ 0.372762] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint514server # [ 0.367722] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]515host1 # [ 0.372945] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]516host1 # [ 0.372974] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]517server # [ 0.367808] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint518host1 # [ 0.373417] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint519server # [ 0.368241] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint520host1 # [ 0.373600] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]521server # [ 0.368428] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]522server # [ 0.368446] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]523host1 # [ 0.373629] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]524server # [ 0.368476] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]525host1 # [ 0.374005] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint526server # [ 0.368493] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]527server # [ 0.368944] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint528server # [ 0.369135] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]529server # [ 0.369152] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]530server # [ 0.369182] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]531server # [ 0.369639] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint532server # [ 0.390032] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]533server # [ 0.390052] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]534host1 # [ 0.422202] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]535server # [ 0.390082] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]536host1 # [ 0.422492] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint537server # [ 0.390537] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint538host1 # [ 0.422764] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]539server # [ 0.390722] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]540host1 # [ 0.422781] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]541server # [ 0.390738] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]542host1 # [ 0.422810] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]543server # [ 0.390768] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]544host1 # [ 0.423266] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint545server # [ 0.391230] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint546host1 # [ 0.423449] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]547server # [ 0.391414] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]548host1 # [ 0.423465] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]549server # [ 0.391430] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]550host1 # [ 0.423494] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]551server # [ 0.391459] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]552host1 # [ 0.424064] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned553server # [ 0.391919] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint554host1 # [ 0.424075] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned555server # [ 0.392104] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]556host1 # [ 0.424081] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned557server # [ 0.392120] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]558server # [ 0.392152] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559host1 # [ 0.424126] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned560server # [ 0.392600] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint561host1 # [ 0.424172] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned562server # [ 0.392783] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]563host1 # [ 0.424219] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned564server # [ 0.392801] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]565host1 # [ 0.424264] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned566server # [ 0.392831] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]567server # [ 0.392847] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]568host1 # [ 0.424311] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned569server # [ 0.393336] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint570host1 # [ 0.424359] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned571server # [ 0.393524] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]572host1 # [ 0.424407] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned573server # [ 0.393554] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]574host1 # [ 0.424456] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned575host1 # [ 0.424502] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned576host1 # [ 0.424562] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned577host1 # [ 0.424635] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned578host1 # [ 0.424656] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned579host1 # [ 0.424678] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned580host1 # [ 0.424700] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned581host1 # [ 0.424721] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned582host1 # [ 0.424749] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned583host1 # [ 0.424771] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned584host1 # [ 0.424793] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned585host1 # [ 0.424814] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned586host1 # [ 0.424836] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned587server # [ 0.418093] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint588host1 # [ 0.424858] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned589server # [ 0.418309] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]590host1 # [ 0.424881] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned591server # [ 0.418344] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]592host1 # [ 0.424902] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned593server # [ 0.418742] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint594host1 # [ 0.424923] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned595server # [ 0.418928] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]596host1 # [ 0.424944] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned597server # [ 0.419179] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint598host1 # [ 0.424966] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned599server # [ 0.419459] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]600host1 # [ 0.424987] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned601server # [ 0.419478] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]602host1 # [ 0.425008] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned603server # [ 0.419509] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]604host1 # [ 0.425030] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned605host1 # [ 0.425052] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned606server # [ 0.419967] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint607server # [ 0.420151] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]608host1 # [ 0.425074] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned609server # [ 0.420168] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]610host1 # [ 0.425099] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]611host1 # [ 0.425109] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]612server # [ 0.420200] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]613host1 # [ 0.425114] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]614server # [ 0.420796] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned615server # [ 0.420808] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned616server # [ 0.420814] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned617server # [ 0.420860] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned618server # [ 0.420908] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned619server # [ 0.420955] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned620server # [ 0.421002] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned621server # [ 0.421049] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned622server # [ 0.421113] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned623host1 # [ 0.470333] pci 0000:00:0a.0: enabling device (0000 -> 0002)624server # [ 0.421162] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned625server # [ 0.421211] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned626server # [ 0.421257] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned627server # [ 0.421326] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned628server # [ 0.421375] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned629server # [ 0.421397] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned630server # [ 0.421419] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned631server # [ 0.421441] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned632server # [ 0.421464] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned633server # [ 0.421489] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned634server # [ 0.421511] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned635server # [ 0.421534] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned636server # [ 0.421556] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned637server # [ 0.421579] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned638server # [ 0.421602] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned639server # [ 0.421625] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned640server # [ 0.421647] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned641host1 # [ 0.490905] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)642host1 # [ 0.492999] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)643server # [ 0.461747] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned644server # [ 0.461783] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned645server # [ 0.461807] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned646server # [ 0.461830] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned647server # [ 0.461853] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned648server # [ 0.461875] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned649server # [ 0.461898] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned650server # [ 0.461922] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned651server # [ 0.461958] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]652server # [ 0.461968] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]653server # [ 0.461972] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]654server # [ 0.463152] pci 0000:00:0a.0: enabling device (0000 -> 0002)655host1 # [ 0.504185] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)656host1 # [ 0.510260] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)657host1 # [ 0.512398] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)658server # [ 0.491878] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)659host1 # [ 0.522734] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)660host1 # [ 0.524791] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)661server # [ 0.501924] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)662server # [ 0.506727] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)663server # [ 0.508750] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)664host1 # [ 0.534772] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)665host1 # [ 0.537240] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)666host1 # [ 0.539065] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)667host1 # [ 0.541225] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)668server # [ 0.520499] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)669host1 # [ 0.559401] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled670server # [ 0.526762] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)671host1 # [ 0.561889] msm_serial: driver initialized672host1 # [ 0.562051] SuperH (H)SCI(F) driver initialized673host1 # [ 0.562104] STM32 USART driver initialized674server # [ 0.528862] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)675server # [ 0.539178] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)676server # [ 0.541337] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)677server # [ 0.551664] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)678server # [ 0.554716] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)679host1 # [ 0.596300] loop: module loaded680host1 # [ 0.596498] virtio_blk virtio5: 1/0/0 default/read/poll queues681host1 # [ 0.597270] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682server # [ 0.567723] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled683server # [ 0.570166] msm_serial: driver initialized684server # [ 0.570306] SuperH (H)SCI(F) driver initialized685server # [ 0.570359] STM32 USART driver initialized686host1 # [ 0.602752] megasas: 07.734.00.00-rc1687host1 # [ 0.603406] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]688host1 # [ 0.619286] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689host1 # [ 0.619317] Intel/Sharp Extended Query Table at 0x0031690host1 # [ 0.621761] Using buffer write method691host1 # [ 0.621804] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]692host1 # [ 0.631221] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000693server # [ 0.602205] loop: module loaded694host1 # [ 0.631250] Intel/Sharp Extended Query Table at 0x0031695host1 # [ 0.633761] Using buffer write method696server # [ 0.602378] virtio_blk virtio5: 1/0/0 default/read/poll queues697host1 # [ 0.633789] Concatenating MTD devices:698host1 # [ 0.633792] (0): "0.flash"699host1 # [ 0.633796] (1): "0.flash"700server # [ 0.603127] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)701host1 # [ 0.633799] into device "0.flash"702server # [ 0.610221] megasas: 07.734.00.00-rc1703server # [ 0.610876] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]704server # [ 0.612703] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000705server # [ 0.612732] Intel/Sharp Extended Query Table at 0x0031706server # [ 0.614464] Using buffer write method707server # [ 0.614533] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]708server # [ 0.616430] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000709server # [ 0.616458] Intel/Sharp Extended Query Table at 0x0031710server # [ 0.634398] Using buffer write method711server # [ 0.634436] Concatenating MTD devices:712server # [ 0.634441] (0): "0.flash"713server # [ 0.634446] (1): "0.flash"714server # [ 0.634449] into device "0.flash"715host1 # [ 0.862199] Freeing initrd memory: 26160K716host1 # [ 0.867991] tun: Universal TUN/TAP device driver, 1.6717host1 # [ 0.871761] thunder_xcv, ver 1.0718host1 # [ 0.871802] thunder_bgx, ver 1.0719host1 # [ 0.871826] nicpf, ver 1.0720host1 # [ 0.872356] e1000: Intel(R) PRO/1000 Network Driver721host1 # [ 0.872363] e1000: Copyright (c) 1999-2006 Intel Corporation.722host1 # [ 0.872388] e1000e: Intel(R) PRO/1000 Network Driver723host1 # [ 0.872395] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.724host1 # [ 0.872426] igb: Intel(R) Gigabit Ethernet Network Driver725host1 # [ 0.872432] igb: Copyright (c) 2007-2014 Intel Corporation.726host1 # [ 0.872455] igbvf: Intel(R) Gigabit Virtual Function Network Driver727host1 # [ 0.872460] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.728host1 # [ 0.872592] sky2: driver version 1.30729host1 # [ 0.874161] usbcore: registered new interface driver usb-storage730host1 # [ 0.874905] ehci-pci 0000:00:0a.0: EHCI Host Controller731host1 # [ 0.874935] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1732host1 # [ 0.875180] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000733host1 # [ 0.885213] usbcore: registered new interface driver usbserial_generic734host1 # [ 0.885232] usbserial: USB Serial support registered for generic735server # [ 0.855821] Freeing initrd memory: 26140K736host1 # [ 0.885866] hv_vmbus: registering driver hyperv_keyboard737host1 # [ 0.886221] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00738host1 # [ 0.889350] hub 1-0:1.0: USB hub found739host1 # [ 0.889370] hub 1-0:1.0: 6 ports detected740host1 # [ 0.891319] rtc-pl031 9010000.pl031: registered as rtc0741host1 # [ 0.891346] rtc-pl031 9010000.pl031: setting system clock to 2026-09-19T21:48:25 UTC (1789854505)742server # [ 0.861761] tun: Universal TUN/TAP device driver, 1.6743host1 # [ 0.891641] i2c_dev: i2c /dev entries driver744server # [ 0.865309] thunder_xcv, ver 1.0745server # [ 0.865353] thunder_bgx, ver 1.0746server # [ 0.865378] nicpf, ver 1.0747host1 # [ 0.896507] sdhci: Secure Digital Host Controller Interface driver748host1 # [ 0.896523] sdhci: Copyright(c) Pierre Ossman749host1 # [ 0.896800] Synopsys Designware Multimedia Card Interface Driver750host1 # [ 0.897161] sdhci-pltfm: SDHCI platform and OF driver helper751server # [ 0.867116] e1000: Intel(R) PRO/1000 Network Driver752server # [ 0.867127] e1000: Copyright (c) 1999-2006 Intel Corporation.753host1 # [ 0.901573] hid: raw HID events driver (C) Jiri Kosina754server # [ 0.867152] e1000e: Intel(R) PRO/1000 Network Driver755host1 # [ 0.901807] usbcore: registered new interface driver usbhid756server # [ 0.867159] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.757host1 # [ 0.901813] usbhid: USB HID core driver758server # [ 0.867188] igb: Intel(R) Gigabit Ethernet Network Driver759server # [ 0.867194] igb: Copyright (c) 2007-2014 Intel Corporation.760server # [ 0.867216] igbvf: Intel(R) Gigabit Virtual Function Network Driver761server # [ 0.867223] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.762server # [ 0.867362] sky2: driver version 1.30763host1 # [ 0.904710] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available764server # [ 0.868918] usbcore: registered new interface driver usb-storage765host1 # [ 0.906205] drop_monitor: Initializing network drop monitor service766server # [ 0.868997] usbcore: registered new interface driver usbserial_generic767host1 # [ 0.906344] NET: Registered PF_INET6 protocol family768server # [ 0.869010] usbserial: USB Serial support registered for generic769host1 # [ 0.909330] Segment Routing with IPv6770server # [ 0.869609] hv_vmbus: registering driver hyperv_keyboard771host1 # [ 0.909348] In-situ OAM (IOAM) with IPv6772host1 # [ 0.909393] NET: Registered PF_PACKET protocol family773server # [ 0.879159] ehci-pci 0000:00:0a.0: EHCI Host Controller774server # [ 0.879188] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1775server # [ 0.879457] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000776host1 # [ 0.911025] 9pnet: Installing 9P2000 support777host1 # [ 0.913139] Key type dns_resolver registered778server # [ 0.882669] rtc-pl031 9010000.pl031: registered as rtc0779server # [ 0.882700] rtc-pl031 9010000.pl031: setting system clock to 2026-09-19T21:48:25 UTC (1789854505)780server # [ 0.883000] i2c_dev: i2c /dev entries driver781server # [ 0.887954] sdhci: Secure Digital Host Controller Interface driver782host1 # [ 0.919894] registered taskstats version 1783server # [ 0.887964] sdhci: Copyright(c) Pierre Ossman784host1 # [ 0.920042] Loading compiled-in X.509 certificates785server # [ 0.888230] Synopsys Designware Multimedia Card Interface Driver786server # [ 0.888602] sdhci-pltfm: SDHCI platform and OF driver helper787server # [ 0.889695] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00788server # [ 0.893394] hub 1-0:1.0: USB hub found789server # [ 0.893414] hub 1-0:1.0: 6 ports detected790server # [ 0.895370] hid: raw HID events driver (C) Jiri Kosina791server # [ 0.895613] usbcore: registered new interface driver usbhid792host1 # [ 0.928569] Demotion targets for Node 0: null793server # [ 0.895619] usbhid: USB HID core driver794host1 # [ 0.928672] Key type .fscrypt registered795host1 # [ 0.928679] Key type fscrypt-provisioning registered796host1 # [ 0.928866] ima: No TPM chip found, activating TPM-bypass!797host1 # [ 0.928889] ima: Allocated hash algorithm: sha1798host1 # [ 0.928911] ima: No architecture policies found799server # [ 0.898544] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available800host1 # [ 0.932978] input: gpio-keys as /devices/platform/gpio-keys/input/input0801server # [ 0.900072] drop_monitor: Initializing network drop monitor service802server # [ 0.900210] NET: Registered PF_INET6 protocol family803server # [ 0.903261] Segment Routing with IPv6804server # [ 0.903296] In-situ OAM (IOAM) with IPv6805server # [ 0.903324] NET: Registered PF_PACKET protocol family806server # [ 0.904937] 9pnet: Installing 9P2000 support807server # [ 0.907585] Key type dns_resolver registered808server # [ 0.913796] registered taskstats version 1809server # [ 0.913943] Loading compiled-in X.509 certificates810host1 # [ 0.950518] clk: Disabling unused clocks811host1 # [ 0.950538] PM: genpd: Disabling unused power domains812server # [ 0.922563] Demotion targets for Node 0: null813server # [ 0.922670] Key type .fscrypt registered814host1 # [ 0.954727] Freeing unused kernel memory: 4736K815host1 # [ 0.954914] Run /init as init process816server # [ 0.922676] Key type fscrypt-provisioning registered817server # [ 0.922771] ima: No TPM chip found, activating TPM-bypass!818server # [ 0.922790] ima: Allocated hash algorithm: sha1819server # [ 0.922811] ima: No architecture policies found820server # [ 0.926890] input: gpio-keys as /devices/platform/gpio-keys/input/input0821host1 # [ 0.972445] systemd[1]: Successfully made /usr/ read-only.822server # [ 0.943999] clk: Disabling unused clocks823server # [ 0.944025] PM: genpd: Disabling unused power domains824server # [ 0.948223] Freeing unused kernel memory: 4736K825server # [ 0.948412] Run /init as init process826server # [ 0.963834] systemd[1]: Successfully made /usr/ read-only.827host1 # [ 1.138260] usb 1-1: new high-speed USB device number 2 using ehci-pci828server # [ 1.141727] usb 1-1: new high-speed USB device number 2 using ehci-pci829host1 # [ 1.290540] 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/input1830host1 # [ 1.307273] 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)831host1 # [ 1.319537] systemd[1]: Detected virtualization qemu.832host1 # [ 1.321633] systemd[1]: Detected architecture arm64.833host1 # [ 1.323597] systemd[1]: Running in initrd.834host1 # [ 1.326177] systemd[1]: Initializing machine ID from random generator.835server # [ 1.293839] 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/input1836host1 # [ 1.329112] systemd[1]: Hostname set to <host1>.837server # [ 1.299670] 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)838server # [ 1.311854] systemd[1]: Detected virtualization qemu.839server # [ 1.313927] systemd[1]: Detected architecture arm64.840server # [ 1.315807] systemd[1]: Running in initrd.841server # [ 1.318455] systemd[1]: Initializing machine ID from random generator.842server # [ 1.321315] systemd[1]: Hostname set to <server>.843host1 # [ 1.374516] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0844server # [ 1.381901] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0845host1 # [ 1.502274] usb 1-2: new high-speed USB device number 3 using ehci-pci846server # [ 1.501721] usb 1-2: new high-speed USB device number 3 using ehci-pci847host1 # [ 1.641850] systemd[1]: bpf-restrict-fs: LSM BPF program attached848host1 # [ 1.665229] 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/input2849host1 # [ 1.665541] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0850server # [ 1.644334] systemd[1]: bpf-restrict-fs: LSM BPF program attached851server # [ 1.661751] 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/input2852server # [ 1.666734] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0853host1 # [ 1.755805] systemd[1]: Queued start job for default target Initrd Default Target.854host1 # [ 1.764419] systemd[1]: Created slice Slice /system/modprobe.855host1 # [ 1.765623] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.856host1 # [ 1.767010] systemd[1]: Expecting device /dev/disk/by-label/nixos...857host1 # [ 1.768125] systemd[1]: Reached target Path Units.858host1 # [ 1.768937] systemd[1]: Reached target Slice Units.859host1 # [ 1.769758] systemd[1]: Reached target Swaps.860host1 # [ 1.770546] systemd[1]: Reached target Timer Units.861host1 # [ 1.771538] systemd[1]: Listening on D-Bus System Message Bus Socket.862host1 # [ 1.772759] systemd[1]: Listening on Journal Socket (/dev/log).863host1 # [ 1.773868] systemd[1]: Listening on Journal Sockets.864host1 # [ 1.774917] systemd[1]: Listening on udev Control Socket.865host1 # [ 1.775926] systemd[1]: Listening on udev Kernel Socket.866host1 # [ 1.776842] systemd[1]: Reached target Socket Units.867host1 # [ 1.779269] systemd[1]: Starting Create List of Static Device Nodes...868server # [ 1.753928] systemd[1]: Queued start job for default target Initrd Default Target.869host1 # [ 1.789614] systemd[1]: Starting Load Kernel Module 9pnet_virtio...870host1 # [ 1.790960] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs871server # [ 1.765581] systemd[1]: Created slice Slice /system/modprobe.872server # [ 1.766842] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.873server # [ 1.766885] systemd[1]: Expecting device /dev/disk/by-label/nixos...874server # [ 1.766918] systemd[1]: Reached target Path Units.875server # [ 1.766937] systemd[1]: Reached target Slice Units.876server # [ 1.766957] systemd[1]: Reached target Swaps.877server # [ 1.766975] systemd[1]: Reached target Timer Units.878server # [ 1.767157] systemd[1]: Listening on D-Bus System Message Bus Socket.879server # [ 1.767298] systemd[1]: Listening on Journal Socket (/dev/log).880host1 # [ 1.803793] systemd[1]: Mounting Kernel Configuration File System...881server # [ 1.767426] systemd[1]: Listening on Journal Sockets.882server # [ 1.767546] systemd[1]: Listening on udev Control Socket.883server # [ 1.767656] systemd[1]: Listening on udev Kernel Socket.884server # [ 1.767677] systemd[1]: Reached target Socket Units.885server # [ 1.778959] systemd[1]: Starting Create List of Static Device Nodes...886server # [ 1.789268] systemd[1]: Starting Load Kernel Module 9pnet_virtio...887server # [ 1.790604] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs888host1 # [ 1.826486] systemd[1]: Starting Journal Service...889server # [ 1.803644] systemd[1]: Mounting Kernel Configuration File System...890server # [ 1.822909] systemd[1]: Starting Journal Service...891host1 # [ 1.854441] systemd[1]: Starting Load Kernel Modules...892host1 # [ 1.854581] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os893host1 # [ 1.857953] systemd[1]: Starting Coldplug All udev Devices...894server # [ 1.833981] systemd[1]: Starting Load Kernel Modules...895server # [ 1.835015] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os896host1 # [ 1.871074] systemd-journald[73]: Collecting audit messages is disabled.897host1 # [ 1.878338] systemd[1]: Finished Create List of Static Device Nodes.898host1 # [ 1.880354] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.899server # [ 1.849957] systemd[1]: Starting Coldplug All udev Devices...900server # [ 1.853199] systemd[1]: Finished Create List of Static Device Nodes.901server # [ 1.855118] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.902host1 # [ 1.892199] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.903host1 # [ 1.894507] systemd[1]: Finished Load Kernel Module 9pnet_virtio.904host1 # [ 1.894896] systemd[1]: Mounted Kernel Configuration File System.905host1 # [ 1.906695] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...906host1 # [ 1.914278] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev907server # [ 1.888009] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.908server # [ 1.888534] systemd[1]: Finished Load Kernel Module 9pnet_virtio.909server # [ 1.892881] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...910host1 # [ 1.926168] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0911server # [ 1.894161] systemd[1]: Mounted Kernel Configuration File System.912server # [ 1.905609] systemd-journald[73]: Collecting audit messages is disabled.913host1 # [ 1.938802] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.914server # [ 1.906670] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev915host1 # [ 1.941248] [drm] features: -virgl +edid -resource_blob -host_visible916host1 # [ 1.941269] [drm] features: -context_init917host1 # [ 1.942027] [drm] number of scanouts: 1918host1 # [ 1.942046] [drm] number of cap sets: 0919host1 # [ 1.946614] systemd[1]: Starting Create Static Device Nodes in /dev...920server # [ 1.919424] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0921server # [ 1.919682] [drm] features: -virgl +edid -resource_blob -host_visible922server # [ 1.919692] [drm] features: -context_init923server # [ 1.920405] [drm] number of scanouts: 1924host1 # [ 1.950774] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic925server # [ 1.920424] [drm] number of cap sets: 0926host1 # [ 1.950802] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0927server # [ 1.938011] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic928server # [ 1.938034] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0929host1 # [ 1.982522] Console: switching to colour frame buffer device 160x50930host1 # [ 1.989189] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device931server # [ 1.959851] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.932server # [ 1.962586] systemd[1]: Starting Create Static Device Nodes in /dev...933host1 # [ 2.007442] systemd[1]: Finished Create Static Device Nodes in /dev.934server # [ 1.970156] Console: switching to colour frame buffer device 160x50935host1 # [ 2.007690] systemd[1]: Reached target Preparation for Local File Systems.936server # [ 1.976709] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device937host1 # [ 2.007729] systemd[1]: Reached target Local File Systems.938host1 # [ 2.012965] systemd[1]: Starting Rule-based Manager for Device Events and Files...939host1 # [ 2.030456] systemd[1]: Finished Load Kernel Modules.940server # [ 2.002584] systemd[1]: Finished Load Kernel Modules.941host1 # [ 2.038620] systemd[1]: Starting Apply Kernel Variables...942server # [ 2.010069] systemd[1]: Starting Apply Kernel Variables...943host1 # [ 2.055283] systemd[1]: Started Journal Service.944host1 # [ 2.044866] systemd-modules-load[74]: Inserted module 'dm_mod'945host1 # [ 2.046197] systemd-modules-load[74]: Module 'virtio_balloon' is built in946server # [ 2.026907] systemd[1]: Finished Create Static Device Nodes in /dev.947server # [ 2.027127] systemd[1]: Reached target Preparation for Local File Systems.948server # [ 2.027164] systemd[1]: Reached target Local File Systems.949host1 # [ 2.052264] systemd-modules-load[74]: Module 'virtio_console' is built in950server # [ 2.038161] systemd[1]: Starting Rule-based Manager for Device Events and Files...951host1 # [ 2.060342] systemd-modules-load[74]: Inserted module 'virtio_gpu'952host1 # [ 2.068402] systemd-modules-load[74]: Module 'virtio_rng' is built in953host1 # [ 2.069547] systemd[1]: Starting Create System Files and Directories...954server # [ 2.070427] systemd[1]: Finished Apply Kernel Variables.955host1 # [ 2.105906] systemd[1]: Finished Apply Kernel Variables.956server # [ 2.097911] systemd[1]: Started Journal Service.957host1 # [ 2.117841] systemd[1]: Finished Create System Files and Directories.958server # [ 2.084268] systemd-modules-load[74]: Inserted module 'dm_mod'959server # [ 2.085406] systemd-modules-load[74]: Module 'virtio_balloon' is built in960server # [ 2.092345] systemd-modules-load[74]: Module 'virtio_console' is built in961host1 # [ 2.129492] systemd-udevd[80]: Using default interface naming scheme 'v261'.962server # [ 2.098450] systemd-modules-load[74]: Inserted module 'virtio_gpu'963server # [ 2.099521] systemd-modules-load[74]: Module 'virtio_rng' is built in964server # [ 2.109392] systemd[1]: Starting Create System Files and Directories...965server # [ 2.119718] systemd-udevd[81]: Using default interface naming scheme 'v261'.966host1 # [ 2.158213] systemd[1]: Started Rule-based Manager for Device Events and Files.967server # [ 2.139671] systemd[1]: Finished Create System Files and Directories.968server # [ 2.162806] systemd[1]: Started Rule-based Manager for Device Events and Files.969host1 # [ 2.216059] systemd[1]: Starting Virtual Console Setup...970server # [ 2.213714] systemd[1]: Starting Virtual Console Setup...971host1 # [ 2.264464] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.972host1 # [ 2.267871] systemd[1]: Finished Virtual Console Setup.973server # [ 2.268445] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.974server # [ 2.271908] systemd[1]: Finished Virtual Console Setup.975host1 # [ 2.878739] systemd[1]: Finished Coldplug All udev Devices.976host1 # [ 2.879704] systemd[1]: Reached target System Initialization.977host1 # [ 2.884317] systemd[1]: Reached target Basic System.978server # [ 2.881549] systemd[1]: Finished Coldplug All udev Devices.979server # [ 2.884146] systemd[1]: Reached target System Initialization.980server # [ 2.884986] systemd[1]: Reached target Basic System.981host1 # [ 3.016157] (udev-worker)[108]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.982server # [ 3.015845] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.983host1 # [ 3.059955] (udev-worker)[108]: Network interface NamePolicy= disabled on kernel command line.984host1 # [ 3.067258] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.985server # [ 3.058456] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.986server # [ 3.070926] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.987host1 # [ 3.164825] systemd[1]: Found device /dev/disk/by-label/nixos.988host1 # [ 3.167966] systemd[1]: Reached target Initrd Root Device.989host1 # [ 3.169725] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...990server # [ 3.156005] systemd[1]: Found device /dev/disk/by-label/nixos.991server # [ 3.160858] systemd[1]: Reached target Initrd Root Device.992server # [ 3.164951] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...993host1 # [ 3.213854] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks994host1 # [ 3.221006] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.995host1 # [ 3.223106] systemd[1]: Mounting /sysroot...996server # [ 3.212988] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks997server # [ 3.224187] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.998server # [ 3.228180] systemd[1]: Mounting /sysroot...999host1 # [ 3.281833] EXT4-fs (vda): mounted filesystem 6cde2050-13e9-4129-9f71-dac9b5c4d6d9 r/w with ordered data mode. Quota mode: none.1000host1 # [ 3.274729] systemd[1]: Mounted /sysroot.1001host1 # [ 3.276965] systemd[1]: Reached target Initrd Root File System.1002host1 # [ 3.282028] systemd[1]: Starting Mountpoints Configured in the Real Root...1003server # [ 3.282914] EXT4-fs (vda): mounted filesystem 8cffac7d-3734-464a-b584-58e305d3a61d r/w with ordered data mode. Quota mode: none.1004server # [ 3.272650] systemd[1]: Mounted /sysroot.1005host1 # [ 3.308154] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.1006server # [ 3.275146] systemd[1]: Reached target Initrd Root File System.1007host1 # [ 3.314191] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...1008server # [ 3.280098] systemd[1]: Starting Mountpoints Configured in the Real Root...1009host1 # [ 3.319244] systemd[1]: Reloading...1010server # [ 3.303663] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.1011server # [ 3.309876] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...1012server # [ 3.316140] systemd[1]: Reloading...1013host1 # [ 3.526865] systemd[1]: Reloading finished in 210 ms.1014server # [ 3.525535] systemd[1]: Reloading finished in 213 ms.1015host1 # [ 3.560563] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...1016host1 # [ 3.564405] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...1017host1 # [ 3.570870] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1018host1 # [ 3.577406] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019host1 # [ 3.581294] systemd[1]: Finished Mountpoints Configured in the Real Root.1020host1 # [ 3.584131] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1021server # [ 3.554053] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...1022server # [ 3.559470] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...1023server # [ 3.564703] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1024host1 # [ 3.606562] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1025host1 # [ 3.609318] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1026server # [ 3.579054] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1027server # [ 3.588915] systemd[1]: Finished Mountpoints Configured in the Real Root.1028server # [ 3.589926] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1029server # [ 3.596262] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1030server # [ 3.598617] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1031host1 # [ 3.850887] systemd[1]: Mounting /sysroot/nix/.ro-store...1032host1 # [ 3.867342] systemd[1]: Mounting /sysroot/nix/.rw-store...1033host1 # [ 3.872656] systemd[1]: Mounting /sysroot/run...1034server # [ 3.839065] systemd[1]: Mounting /sysroot/nix/.ro-store...1035host1 # [ 3.886679] systemd[1]: Mounting /sysroot/tmp/shared...1036server # [ 3.855254] systemd[1]: Mounting /sysroot/nix/.rw-store...1037server # [ 3.859318] systemd[1]: Mounting /sysroot/run...1038server # [ 3.869777] systemd[1]: Mounting /sysroot/tmp/shared...1039host1 # [ 3.912730] systemd[1]: Mounting /sysroot/tmp/xchg...1040server # [ 3.895773] systemd[1]: Mounting /sysroot/tmp/xchg...1041host1 # [ 3.945510] systemd[1]: Mounted /sysroot/nix/.rw-store.1042host1 # [ 3.965839] systemd[1]: Starting rw-sysroot-nix-store.service...1043server # [ 3.934388] systemd[1]: Mounted /sysroot/nix/.rw-store.1044host1 # [ 3.970106] systemd[1]: Mounted /sysroot/nix/.ro-store.1045host1 # [ 3.972397] systemd[1]: Mounted /sysroot/run.1046host1 # [ 3.978793] systemd[1]: Mounted /sysroot/tmp/shared.1047server # [ 3.957644] systemd[1]: Starting rw-sysroot-nix-store.service...1048host1 # [ 3.998778] systemd[1]: Mounted /sysroot/tmp/xchg.1049server # [ 3.967510] systemd[1]: Mounted /sysroot/nix/.ro-store.1050server # [ 3.970310] systemd[1]: Mounted /sysroot/run.1051host1 # [ 4.007200] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1052host1 # [ 4.009544] systemd[1]: Finished rw-sysroot-nix-store.service.1053server # [ 3.975003] systemd[1]: Mounted /sysroot/tmp/shared.1054server # [ 3.980178] systemd[1]: Mounted /sysroot/tmp/xchg.1055server # [ 3.998389] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1056server # [ 3.999777] systemd[1]: Finished rw-sysroot-nix-store.service.1057host1 # [ 4.409222] (udev-worker)[92]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1058host1 # [ 4.415310] (udev-worker)[92]: 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 directory1059host1 # [ 4.429142] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1060host1 # [ 4.432135] systemd[1]: Stopped Virtual Console Setup.1061host1 # [ 4.436884] systemd[1]: Stopping Virtual Console Setup...1062host1 # [ 4.438472] systemd[1]: Starting Virtual Console Setup...1063host1 # [ 4.445151] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1064server # [ 4.408881] (udev-worker)[101]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1065host1 # [ 4.446961] systemd[1]: Stopped Virtual Console Setup.1066server # [ 4.414435] (udev-worker)[101]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1067host1 # [ 4.453452] systemd[1]: Starting Virtual Console Setup...1068server # [ 4.433790] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1069server # [ 4.436728] systemd[1]: Stopped Virtual Console Setup.1070server # [ 4.440936] systemd[1]: Stopping Virtual Console Setup...1071server # [ 4.441918] systemd[1]: Starting Virtual Console Setup...1072host1 # [ 4.484788] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones.1073host1 # [ 4.488471] systemd[1]: Finished Virtual Console Setup.1074server # [ 4.454030] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1075server # [ 4.455573] systemd[1]: Stopped Virtual Console Setup.1076server # [ 4.459982] systemd[1]: Starting Virtual Console Setup...1077server # [ 4.478111] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones.1078server # [ 4.481318] systemd[1]: Finished Virtual Console Setup.1079host1 # [ 4.851884] systemd[1]: Mounting /sysroot/nix/store...1080server # [ 4.838019] systemd[1]: Mounting /sysroot/nix/store...1081host1 # [ 4.914394] systemd[1]: Mounted /sysroot/nix/store.1082server # [ 4.882264] systemd[1]: Mounted /sysroot/nix/store.1083server # [ 4.884628] systemd[1]: Reached target Initrd File Systems.1084host1 # [ 4.919847] systemd[1]: Reached target Initrd File Systems.1085server # [ 4.887712] systemd[1]: Starting Find NixOS closure...1086host1 # [ 4.924354] systemd[1]: Starting Find NixOS closure...1087server # [ 4.896303] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1088host1 # [ 4.936387] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1089server # [ 4.933135] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1090server # [ 4.936190] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1091host1 # [ 4.979115] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1092host1 # [ 4.982870] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1093server # [ 4.952721] systemd[1]: Finished Find NixOS closure.1094server # [ 4.955102] systemd[1]: Reached target Initrd Default Target.1095server # [ 4.956775] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1096host1 # [ 4.997144] systemd[1]: Finished Find NixOS closure.1097host1 # [ 5.000248] systemd[1]: Reached target Initrd Default Target.1098host1 # [ 5.002801] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1099server # [ 4.984955] systemd[1]: Stopped target Initrd Default Target.1100server # [ 4.988651] systemd[1]: Stopped target Basic System.1101server # [ 4.989671] systemd[1]: Stopped target Initrd Root Device.1102server # [ 4.991502] systemd[1]: Stopped target Path Units.1103server # [ 4.994478] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1104server # [ 4.997493] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1105host1 # [ 5.032745] systemd[1]: initrd-cleanup.service: Deactivated successfully.1106host1 # [ 5.034703] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1107server # [ 5.000153] systemd[1]: Stopped target Slice Units.1108host1 # [ 5.038359] systemd[1]: Stopped target Initrd Default Target.1109server # [ 5.004181] systemd[1]: Stopped target Socket Units.1110server # [ 5.005139] systemd[1]: Stopped target System Initialization.1111host1 # [ 5.040356] systemd[1]: Stopped target Basic System.1112server # [ 5.006140] systemd[1]: Stopped target Swaps.1113server # [ 5.006926] systemd[1]: Stopped target Timer Units.1114server # [ 5.007823] systemd[1]: dbus.socket: Deactivated successfully.1115host1 # [ 5.043831] systemd[1]: Stopped target Initrd Root Device.1116host1 # [ 5.045192] systemd[1]: Stopped target Path Units.1117host1 # [ 5.048193] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1118host1 # [ 5.049523] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1119server # [ 5.016215] systemd[1]: Closed D-Bus System Message Bus Socket.1120host1 # [ 5.052322] systemd[1]: Stopped target Slice Units.1121server # [ 5.017202] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1122server # [ 5.018400] systemd[1]: Stopped Find NixOS closure.1123server # [ 5.019204] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1124host1 # [ 5.056174] systemd[1]: Stopped target Socket Units.1125host1 # [ 5.057054] systemd[1]: Stopped target System Initialization.1126host1 # [ 5.057957] systemd[1]: Stopped target Swaps.1127host1 # [ 5.060164] systemd[1]: Stopped target Timer Units.1128host1 # [ 5.061004] systemd[1]: dbus.socket: Deactivated successfully.1129host1 # [ 5.063845] systemd[1]: Closed D-Bus System Message Bus Socket.1130server # [ 5.029692] systemd[1]: Starting rw-sysroot-nix-store.service...1131server # [ 5.030642] systemd[1]: systemd-sysctl.service: Deactivated successfully.1132server # [ 5.031616] systemd[1]: Stopped Apply Kernel Variables.1133host1 # [ 5.067711] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1134host1 # [ 5.071157] systemd[1]: Stopped Find NixOS closure.1135server # [ 5.037619] systemd[1]: systemd-modules-load.service: Deactivated successfully.1136host1 # [ 5.073163] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1137server # [ 5.039542] systemd[1]: Stopped Load Kernel Modules.1138host1 # [ 5.075142] systemd[1]: Starting rw-sysroot-nix-store.service...1139server # [ 5.047358] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1140host1 # [ 5.085056] systemd[1]: systemd-sysctl.service: Deactivated successfully.1141server # [ 5.052415] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1142host1 # [ 5.088260] systemd[1]: Stopped Apply Kernel Variables.1143server # [ 5.053652] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1144host1 # [ 5.089189] systemd[1]: systemd-modules-load.service: Deactivated successfully.1145server # [ 5.054755] systemd[1]: Stopped Create System Files and Directories.1146server # [ 5.055643] systemd[1]: Stopped target Local File Systems.1147host1 # [ 5.094476] systemd[1]: Stopped Load Kernel Modules.1148host1 # [ 5.099054] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1149server # [ 5.065225] systemd[1]: Stopped target Preparation for Local File Systems.1150host1 # [ 5.101947] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1151server # [ 5.067015] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1152host1 # [ 5.104175] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1153server # [ 5.069546] systemd[1]: Stopped Coldplug All udev Devices.1154server # [ 5.070371] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1155host1 # [ 5.106502] systemd[1]: Stopped Create System Files and Directories.1156server # [ 5.071381] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1157server # [ 5.076263] systemd[1]: Stopped Virtual Console Setup.1158host1 # [ 5.112178] systemd[1]: Stopped target Local File Systems.1159host1 # [ 5.113022] systemd[1]: Stopped target Preparation for Local File Systems.1160server # [ 5.078349] systemd[1]: initrd-cleanup.service: Deactivated successfully.1161host1 # [ 5.114049] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1162server # [ 5.079459] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1163host1 # [ 5.115051] systemd[1]: Stopped Coldplug All udev Devices.1164server # [ 5.080540] systemd[1]: systemd-udevd.service: Deactivated successfully.1165host1 # [ 5.116302] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1166server # [ 5.081448] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1167host1 # [ 5.117497] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1168server # [ 5.082433] systemd[1]: systemd-udevd.service: Consumed 1.398s CPU time over 3.040s wall clock time, 24.3M memory peak.1169host1 # [ 5.118622] systemd[1]: Stopped Virtual Console Setup.1170server # [ 5.083863] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1171host1 # [ 5.119416] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1172host1 # [ 5.120472] systemd[1]: Finished rw-sysroot-nix-store.service.1173host1 # [ 5.121285] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1174host1 # [ 5.122282] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1175host1 # [ 5.123135] systemd[1]: systemd-udevd.service: Deactivated successfully.1176server # [ 5.092422] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1177host1 # [ 5.127877] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1178server # [ 5.093327] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1179server # [ 5.094564] systemd[1]: Finished rw-sysroot-nix-store.service.1180host1 # [ 5.129363] systemd[1]: systemd-udevd.service: Consumed 1.405s CPU time over 3.102s wall clock time, 23.9M memory peak.1181server # [ 5.096192] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1182server # [ 5.100142] systemd[1]: Closed udev Control Socket.1183server # [ 5.100892] systemd[1]: Starting Cleanup udev Database...1184host1 # [ 5.136347] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1185server # [ 5.101662] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1186host1 # [ 5.137545] systemd[1]: Closed udev Control Socket.1187host1 # [ 5.138281] systemd[1]: Starting Cleanup udev Database...1188host1 # [ 5.139065] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1189server # [ 5.104185] systemd[1]: Stopped Create Static Device Nodes in /dev.1190host1 # [ 5.140183] systemd[1]: Stopped Create Static Device Nodes in /dev.1191server # [ 5.105082] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1192server # [ 5.108326] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1193server # [ 5.109330] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1194host1 # [ 5.144267] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1195host1 # [ 5.145418] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1196host1 # [ 5.146365] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1197server # [ 5.112233] systemd[1]: Stopped Create List of Static Device Nodes.1198host1 # [ 5.148308] systemd[1]: Stopped Create List of Static Device Nodes.1199server # [ 5.134376] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1200host1 # [ 5.172138] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1201server # [ 5.139660] systemd[1]: Finished Cleanup udev Database.1202host1 # [ 5.175254] systemd[1]: Finished Cleanup udev Database.1203host1 # [ 5.176104] systemd[1]: Reached target Switch Root.1204server # [ 5.141072] systemd[1]: Reached target Switch Root.1205server # [ 5.141771] systemd[1]: Starting NixOS Activation...1206host1 # [ 5.177207] systemd[1]: Starting NixOS Activation...1207host1 # [ 5.338043] initrd-nixos-activation-start[184]: booting system configuration /nix/store/4bc1mgsrjjn6k2kyzhbmgvvyklnm7wn8-nixos-system-host1-test1208server # [ 5.303628] initrd-nixos-activation-start[186]: booting system configuration /nix/store/dpy0livxmahpf0cnbxp7nj2vj1zr970a-nixos-system-server-test1209host1 # [ 5.403732] initrd-nixos-activation-start[184]: running activation script...1210server # [ 5.371562] initrd-nixos-activation-start[186]: running activation script...1211host1 # [ 5.817739] initrd-nixos-activation-start[207]: setting up /etc...1212server # [ 5.787698] initrd-nixos-activation-start[209]: setting up /etc...1213host1 # [ 6.086109] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1214host1 # [ 6.088880] systemd[1]: Finished NixOS Activation.1215host1 # [ 6.090047] systemd[1]: Starting Switch Root...1216server # [ 6.057079] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1217server # [ 6.059918] systemd[1]: Finished NixOS Activation.1218server # [ 6.061322] systemd[1]: Starting Switch Root...1219host1 # [ 6.111426] systemd[1]: Switching root.1220server # [ 6.084356] systemd[1]: Switching root.1221host1 # [ 6.301217] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1222server # [ 6.272397] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1223server # [ 6.836113] 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)1224server # [ 6.848249] systemd[1]: Detected virtualization qemu.1225server # [ 6.852259] systemd[1]: Detected architecture arm64.1226server # [ 6.854442] systemd[1]: Detected first boot.1227server # [ 6.861546] systemd[1]: Initializing machine ID from random generator.1228host1 # [ 6.899411] 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)1229host1 # [ 6.905741] systemd[1]: Detected virtualization qemu.1230host1 # [ 6.907619] systemd[1]: Detected architecture arm64.1231host1 # [ 6.909424] systemd[1]: Detected first boot.1232host1 # [ 6.914943] systemd[1]: Initializing machine ID from random generator.1233host1 # [ 7.188783] systemd[1]: bpf-restrict-fs: LSM BPF program attached1234server # [ 7.198683] systemd[1]: bpf-restrict-fs: LSM BPF program attached1235host1 # [ 7.341866] systemd[1]: Applying preset policy.1236server # [ 7.383291] systemd[1]: Applying preset policy.1237host1 # [ 7.802244] systemd[1]: Populated /etc with preset unit settings.1238server # [ 7.880090] systemd[1]: Populated /etc with preset unit settings.1239host1 # [ 8.313723] systemd[1]: initrd-switch-root.service: Deactivated successfully.1240host1 # [ 8.315274] systemd[1]: Stopped initrd-switch-root.service.1241host1 # [ 8.316755] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1242host1 # [ 8.321373] systemd[1]: Created slice Slice /system/getty.1243host1 # [ 8.323137] systemd[1]: Created slice User and Session Slice.1244host1 # [ 8.324392] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1245host1 # [ 8.327116] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1246host1 # [ 8.329243] systemd[1]: Expecting device /dev/hvc0...1247host1 # [ 8.331308] systemd[1]: Expecting device /dev/ttyAMA0...1248host1 # [ 8.333124] systemd[1]: Reached target Local Encrypted Volumes.1249host1 # [ 8.335082] systemd[1]: Stopped target initrd-fs.target.1250host1 # [ 8.336899] systemd[1]: Stopped target initrd-root-fs.target.1251host1 # [ 8.338836] systemd[1]: Stopped target initrd-switch-root.target.1252host1 # [ 8.340734] systemd[1]: Reached target Virtual Machines and Containers.1253host1 # [ 8.342764] systemd[1]: Reached target Path Units.1254host1 # [ 8.344508] systemd[1]: Reached target Remote File Systems.1255host1 # [ 8.346424] systemd[1]: Reached target Slice Units.1256host1 # [ 8.348180] systemd[1]: Reached target Swaps.1257host1 # [ 8.352248] systemd[1]: Listening on Query the User Interactively for a Password.1258host1 # [ 8.356919] systemd[1]: Listening on Process Core Dump Socket.1259host1 # [ 8.360416] systemd[1]: Listening on Credential Encryption/Decryption.1260host1 # [ 8.363917] systemd[1]: Listening on Factory Reset Management.1261host1 # [ 8.365672] systemd[1]: Listening on Hostname Service Socket.1262host1 # [ 8.370948] systemd[1]: Starting Journal Log Access Socket...1263host1 # [ 8.373914] systemd[1]: Listening on Journal Audit Socket.1264host1 # [ 8.378220] systemd[1]: Listening on Console Output Muting Service Socket.1265host1 # [ 8.381010] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1266host1 # [ 8.383413] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1267host1 # [ 8.386000] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1268host1 # [ 8.398122] systemd[1]: Listening on Disk Repartitioning Service Socket.1269host1 # [ 8.399544] systemd[1]: Listening on udev Control Socket.1270host1 # [ 8.401192] systemd[1]: Listening on udev Varlink Socket.1271host1 # [ 8.405817] systemd[1]: Mounting Huge Pages File System...1272server # [ 8.376566] systemd[1]: initrd-switch-root.service: Deactivated successfully.1273server # [ 8.378167] systemd[1]: Stopped initrd-switch-root.service.1274host1 # [ 8.411115] systemd[1]: Mounting POSIX Message Queue File System...1275server # [ 8.381061] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1276server # [ 8.384875] systemd[1]: Created slice Slice /system/getty.1277server # [ 8.387017] systemd[1]: Created slice User and Session Slice.1278server # [ 8.388267] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1279host1 # [ 8.419746] systemd[1]: Mounting Kernel Debug File System...1280server # [ 8.390349] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1281server # [ 8.391947] systemd[1]: Expecting device /dev/hvc0...1282server # [ 8.393602] systemd[1]: Expecting device /dev/ttyAMA0...1283server # [ 8.395892] systemd[1]: Reached target Local Encrypted Volumes.1284server # [ 8.396993] systemd[1]: Stopped target initrd-fs.target.1285server # [ 8.398637] systemd[1]: Stopped target initrd-root-fs.target.1286server # [ 8.400923] systemd[1]: Stopped target initrd-switch-root.target.1287host1 # [ 8.433207] systemd[1]: Mounting Kernel Trace File System...1288server # [ 8.402925] systemd[1]: Reached target Virtual Machines and Containers.1289server # [ 8.404903] systemd[1]: Reached target Path Units.1290server # [ 8.406751] systemd[1]: Reached target Remote File Systems.1291server # [ 8.408595] systemd[1]: Reached target Slice Units.1292server # [ 8.410469] systemd[1]: Reached target Swaps.1293host1 # [ 8.443837] systemd[1]: Starting Create List of Static Device Nodes...1294server # [ 8.414569] systemd[1]: Listening on Query the User Interactively for a Password.1295server # [ 8.419515] systemd[1]: Listening on Process Core Dump Socket.1296server # [ 8.423509] systemd[1]: Listening on Credential Encryption/Decryption.1297server # [ 8.427571] systemd[1]: Listening on Factory Reset Management.1298server # [ 8.429503] systemd[1]: Listening on Hostname Service Socket.1299host1 # [ 8.461699] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1300host1 # [ 8.463518] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1301server # [ 8.435010] systemd[1]: Starting Journal Log Access Socket...1302server # [ 8.437107] systemd[1]: Listening on Journal Audit Socket.1303server # [ 8.440474] systemd[1]: Listening on Console Output Muting Service Socket.1304server # [ 8.442056] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1305host1 # [ 8.474425] systemd[1]: Mounting Kernel Configuration File System...1306server # [ 8.443697] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1307host1 # [ 8.475716] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1308server # [ 8.445475] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1309host1 # [ 8.477904] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1310server # [ 8.457228] systemd[1]: Listening on Disk Repartitioning Service Socket.1311server # [ 8.459751] systemd[1]: Listening on udev Control Socket.1312server # [ 8.460908] systemd[1]: Listening on udev Varlink Socket.1313server # [ 8.465544] systemd[1]: Mounting Huge Pages File System...1314server # [ 8.471092] systemd[1]: Mounting POSIX Message Queue File System...1315host1 # [ 8.503450] systemd[1]: Starting Load Kernel Module fuse...1316host1 # [ 8.505725] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671317server # [ 8.479968] systemd[1]: Mounting Kernel Debug File System...1318server # [ 8.486767] systemd[1]: Mounting Kernel Trace File System...1319server # [ 8.504888] systemd[1]: Starting Create List of Static Device Nodes...1320server # [ 8.520669] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1321server # [ 8.521055] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1322host1 # [ 8.559446] systemd[1]: Starting Journal Service...1323server # [ 8.530494] systemd[1]: Mounting Kernel Configuration File System...1324server # [ 8.532980] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1325server # [ 8.536378] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1326host1 # [ 8.585178] systemd[1]: Starting Load Kernel Modules...1327server # [ 8.554307] systemd[1]: Starting Load Kernel Module fuse...1328server # [ 8.561976] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671329server # [ 8.577591] systemd[1]: Starting Journal Service...1330host1 # [ 8.613584] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1331host1 # [ 8.650022] systemd[1]: Starting Remount Root and Kernel File Systems...1332server # [ 8.627579] systemd[1]: Starting Load Kernel Modules...1333host1 # [ 8.659548] fuse: init (API version 7.45)1334host1 # [ 8.663756] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1335server # [ 8.656729] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1336host1 # [ 8.699955] systemd[1]: Starting Coldplug All udev Devices...1337server # [ 8.677010] systemd[1]: Starting Remount Root and Kernel File Systems...1338server # [ 8.679703] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1339server # [ 8.690576] systemd[1]: Starting Coldplug All udev Devices...1340server # [ 8.696082] systemd[1]: Listening on Journal Log Access Socket.1341server # [ 8.702129] systemd[1]: Mounted Huge Pages File System.1342server # [ 8.702610] systemd[1]: Mounted POSIX Message Queue File System.1343server # [ 8.702999] systemd[1]: Mounted Kernel Debug File System.1344server # [ 8.703366] systemd[1]: Mounted Kernel Trace File System.1345host1 # [ 8.737579] systemd[1]: Listening on Journal Log Access Socket.1346server # [ 8.703737] systemd[1]: Mounted Kernel Configuration File System.1347host1 # [ 8.743455] systemd-journald[278]: Collecting audit messages is enabled.1348host1 # [ 8.747984] systemd[1]: Mounted Huge Pages File System.1349host1 # [ 8.756466] systemd[1]: Mounted POSIX Message Queue File System.1350host1 # [ 8.756975] systemd[1]: Mounted Kernel Debug File System.1351host1 # [ 8.757362] systemd[1]: Mounted Kernel Trace File System.1352host1 # [ 8.758045] systemd[1]: Finished Create List of Static Device Nodes.1353host1 # [ 8.767182] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1354server # [ 8.738188] systemd[1]: Finished Create List of Static Device Nodes.1355host1 # [ 8.773290] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1356server # [ 8.747428] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1357host1 # [ 8.782833] systemd[1]: Mounted Kernel Configuration File System.1358host1 # [ 8.783510] systemd[1]: modprobe@fuse.service: Deactivated successfully.1359host1 # [ 8.788526] systemd[1]: Finished Load Kernel Module fuse.1360host1 # [ 8.793744] systemd[1]: Finished Load Kernel Modules.1361host1 # [ 8.798104] systemd[1]: Started Journal Service.1362host1 # [ 8.786246] systemd[1]: Queued start job for default target Multi-User System.1363host1 # [ 8.802601] EXT4-fs (vda): re-mounted 6cde2050-13e9-4129-9f71-dac9b5c4d6d9.1364host1 # [ 8.794311] systemd[1]: systemd-journald.service: Deactivated successfully.1365host1 # [ 8.802260] systemd-modules-load[279]: Module 'atkbd' is built in1366host1 # [ 8.803326] systemd-modules-load[279]: Module 'loop' is built in1367host1 # [ 8.812077] systemd[1]: Mounting FUSE Control File System...1368host1 # [ 8.815745] systemd[1]: Starting Firewall...1369host1 # [ 8.835613] systemd[1]: Starting Apply Kernel Variables...1370server # [ 8.822553] systemd[1]: Finished Load Kernel Modules.1371server # [ 8.826546] EXT4-fs (vda): re-mounted 8cffac7d-3734-464a-b584-58e305d3a61d.1372host1 # [ 8.846337] systemd-oomd[280]: No swap; memory pressure usage will be degraded1373server # [ 8.836954] systemd[1]: Starting Firewall...1374host1 # [ 8.861809] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1375server # [ 8.843635] systemd[1]: Starting Apply Kernel Variables...1376host1 # [ 8.862997] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1377host1 # [ 8.869335] systemd[1]: Finished Remount Root and Kernel File Systems.1378server # [ 8.851017] systemd[1]: Finished Remount Root and Kernel File Systems.1379server # [ 8.851606] systemd[1]: Listening on Disk Image Download Service Socket.1380server # [ 8.851903] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1381server # [ 8.865709] systemd-journald[280]: Collecting audit messages is enabled.1382server # [ 8.875027] systemd[1]: Starting Load/Save OS Random Seed...1383server # [ 8.877216] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1384server # [ 8.882275] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1385server # [ 8.884881] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1386server # [ 8.902018] systemd[1]: Queued start job for default target Multi-User System.1387server # [ 8.920809] systemd[1]: Started Journal Service.1388server # [ 8.929184] systemd[1]: systemd-journald.service: Deactivated successfully.1389server # [ 8.938939] systemd-modules-load[281]: Module 'atkbd' is built in1390server # [ 8.953837] systemd-modules-load[281]: Module 'loop' is built in1391host1 # [ 8.993463] systemd[1]: Listening on Disk Image Download Service Socket.1392server # [ 8.978666] fuse: init (API version 7.45)1393server # [ 8.965384] systemd[1]: Starting Flush Journal to Persistent Storage...1394server # [ 8.972956] systemd-oomd[282]: No swap; memory pressure usage will be degraded1395host1 # [ 9.011270] systemd[1]: Starting Flush Journal to Persistent Storage...1396host1 # [ 9.013190] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1397host1 # [ 9.024230] systemd[1]: Starting Load/Save OS Random Seed...1398server # [ 8.991622] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1399host1 # [ 9.026848] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1400server # [ 9.000363] systemd[1]: Finished Load/Save OS Random Seed.1401server # [ 9.005858] systemd[1]: Reached target First Boot Complete.1402server # [ 9.014229] systemd[1]: modprobe@fuse.service: Deactivated successfully.1403host1 # [ 9.054052] systemd[1]: Mounted FUSE Control File System.1404server # [ 9.022378] systemd[1]: Finished Load Kernel Module fuse.1405server # [ 9.046241] systemd[1]: Finished Apply Kernel Variables.1406host1 # [ 9.081824] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1407server # [ 9.069329] systemd-journald[280]: Received client request to flush runtime journal.1408host1 # [ 9.102822] systemd[1]: Finished Apply Kernel Variables.1409host1 # [ 9.123716] systemd-journald[278]: Received client request to flush runtime journal.1410server # [ 9.111050] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1411server # [ 9.123033] systemd[1]: Starting Create Static Device Nodes in /dev...1412server # [ 9.125030] systemd[1]: Finished Flush Journal to Persistent Storage.1413host1 # [ 9.183028] systemd[1]: Starting Create Static Device Nodes in /dev...1414host1 # [ 9.192362] systemd[1]: Finished Flush Journal to Persistent Storage.1415host1 # [ 9.200787] systemd[1]: Finished Load/Save OS Random Seed.1416host1 # [ 9.201970] systemd[1]: Reached target First Boot Complete.1417server # [ 9.213677] systemd[1]: Finished Create Static Device Nodes in /dev.1418host1 # [ 9.250502] systemd[1]: Finished Create Static Device Nodes in /dev.1419server # [ 9.216247] systemd[1]: Reached target Preparation for Local File Systems.1420host1 # [ 9.251552] systemd[1]: Reached target Preparation for Local File Systems.1421host1 # [ 9.254714] systemd[1]: Starting Rule-based Manager for Device Events and Files...1422server # [ 9.220519] systemd[1]: Starting Rule-based Manager for Device Events and Files...1423host1 # [ 9.309439] systemd[1]: Mounting /run/wrappers...1424server # [ 9.330728] systemd-udevd[322]: Using default interface naming scheme 'v261'.1425host1 # [ 9.378365] systemd[1]: Mounted /run/wrappers.1426host1 # [ 9.382962] systemd[1]: Reached target Local File Systems.1427host1 # [ 9.392418] systemd-udevd[321]: Using default interface naming scheme 'v261'.1428host1 # [ 9.395587] systemd[1]: Listening on Boot Loader Control Service Socket.1429host1 # [ 9.398809] systemd[1]: Starting register-nix-paths.service...1430server # [ 9.364154] systemd[1]: Mounting /run/wrappers...1431server # [ 9.366176] systemd[1]: Mounting FUSE Control File System...1432host1 # [ 9.414375] systemd[1]: Starting Create SUID/SGID Wrappers...1433host1 # [ 9.416932] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1434host1 # [ 9.442564] systemd[1]: Starting Save Transient machine-id to Disk...1435server # [ 9.415435] systemd[1]: Mounted FUSE Control File System.1436server # [ 9.433885] systemd[1]: Mounted /run/wrappers.1437server # [ 9.435819] systemd[1]: Reached target Local File Systems.1438host1 # [ 9.473525] systemd[1]: Starting Create System Files and Directories...1439server # [ 9.443281] systemd[1]: Listening on Boot Loader Control Service Socket.1440server # [ 9.456747] systemd[1]: Starting register-nix-paths.service...1441server # [ 9.460175] systemd[1]: Starting Create SUID/SGID Wrappers...1442server # [ 9.468400] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1443server # [ 9.481820] systemd[1]: Starting Save Transient machine-id to Disk...1444server # [ 9.485867] systemd[1]: Starting Create System Files and Directories...1445host1 # [ 9.551222] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1446host1 # [ 9.567110] systemd[1]: Finished Save Transient machine-id to Disk.1447server # [ 9.571607] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1448server # [ 9.584656] systemd[1]: Finished Save Transient machine-id to Disk.1449host1 # [ 9.696316] systemd[1]: Started Rule-based Manager for Device Events and Files.1450server # [ 9.668676] systemd[1]: Started Rule-based Manager for Device Events and Files.1451host1 # [ 9.705313] systemd[1]: Finished Create System Files and Directories.1452host1 # [ 9.729010] systemd[1]: Starting Rebuild Journal Catalog...1453server # [ 9.710996] systemd[1]: Finished Create System Files and Directories.1454server # [ 9.716390] systemd[1]: Starting Rebuild Journal Catalog...1455host1 # [ 9.755587] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1456server # [ 9.725231] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1457host1 # [ 9.878354] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1458server # [ 9.839039] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1459host1 # [ 9.925332] systemd[1]: Finished Rebuild Journal Catalog.1460host1 # [ 9.934267] systemd[1]: Starting Update is Completed...1461server # [ 9.940651] systemd[1]: Finished Rebuild Journal Catalog.1462server # [ 9.943644] systemd[1]: Starting Update is Completed...1463host1 # [ 10.021875] systemd[1]: Finished Update is Completed.1464server # [ 10.037133] systemd[1]: Finished Update is Completed.1465host1 # [ 10.414773] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1466host1 # [ 10.421309] systemd[1]: Finished Create SUID/SGID Wrappers.1467server # [ 10.450985] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1468server # [ 10.456660] systemd[1]: Finished Create SUID/SGID Wrappers.1469server # [ 10.859634] systemd[1]: Finished Firewall.1470host1 # [ 10.945561] systemd[1]: Finished Firewall.1471host1 # [ 11.036488] systemd[1]: Finished Coldplug All udev Devices.1472server # [ 11.066184] systemd[1]: Finished Coldplug All udev Devices.1473host1 # [ 11.102749] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1474server # [ 11.141625] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1475host1 # [ 11.264783] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1476host1 # [ 11.313262] systemd[1]: Finished register-nix-paths.service.1477host1 # [ 11.316206] systemd[1]: Reached target System Initialization.1478host1 # [ 11.318730] systemd[1]: Started Renew ACME Certificate for host1.1479host1 # [ 11.322888] systemd[1]: Started Discard unused filesystem blocks once a week.1480host1 # [ 11.325331] systemd[1]: Started Daily Cleanup of Temporary Directories.1481host1 # [ 11.330043] systemd[1]: Reached target Timer Units.1482host1 # [ 11.330824] systemd[1]: Listening on D-Bus System Message Bus Socket.1483host1 # [ 11.331710] systemd[1]: Listening on Nix Daemon Socket.1484host1 # [ 11.335155] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1485host1 # [ 11.342744] systemd[1]: Reached target Socket Units.1486server # [ 11.308155] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1487host1 # [ 11.344464] systemd[1]: Reached target Basic System.1488host1 # [ 11.346736] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1489host1 # [ 11.349650] systemd[1]: Starting Import lastlog data into lastlog2 database...1490host1 # [ 11.354723] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1491host1 # [ 11.370715] systemd[1]: Starting Post-Boot Actions...1492host1 # [ 11.395502] systemd[1]: Started Reset console on configuration changes.1493server # [ 11.368244] systemd[1]: Finished register-nix-paths.service.1494server # [ 11.371567] systemd[1]: Reached target System Initialization.1495server # [ 11.373284] systemd[1]: Started Renew ACME Certificate for server.1496server # [ 11.376364] systemd[1]: Started Discard unused filesystem blocks once a week.1497server # [ 11.382048] systemd[1]: Started Daily Cleanup of Temporary Directories.1498server # [ 11.383138] systemd[1]: Reached target Timer Units.1499server # [ 11.386217] systemd[1]: Listening on D-Bus System Message Bus Socket.1500server # [ 11.390544] systemd[1]: Listening on Nix Daemon Socket.1501host1 # [ 11.430820] systemd[1]: Starting resolvconf update...1502server # [ 11.397967] systemd[1]: Listening on Nix worker-protocol over gRPC.1503host1 # [ 11.433252] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1504server # [ 11.408543] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1505server # [ 11.416956] systemd[1]: Reached target Socket Units.1506server # [ 11.427056] systemd[1]: Reached target Basic System.1507server # [ 11.431885] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1508server # [ 11.445627] systemd[1]: Starting Import lastlog data into lastlog2 database...1509host1 # [ 11.489588] acme-setup-privileged[501]: + set -euo pipefail1510server # [ 11.454620] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1511host1 # [ 11.496122] acme-setup-privileged[501]: + cd /var/lib/acme1512host1 # [ 11.504166] acme-setup-privileged[501]: + chmod -R u=rwX,g=,o= .lego/accounts1513server # [ 11.472450] systemd[1]: Starting Post-Boot Actions...1514host1 # [ 11.509169] acme-setup-privileged[501]: + chown -R acme .lego/accounts1515host1 # [ 11.516247] systemd[1]: Started backdoor.service.1516server # [ 11.487147] systemd[1]: Started Reset console on configuration changes.1517host1 # [ 11.528429] acme-setup-privileged[501]: + for fixpath in host1 .lego/host11518host1 # [ 11.533189] acme-setup-privileged[501]: + '[' -d host1 ']'1519server # [ 11.501152] systemd[1]: Starting resolvconf update...1520host1 # [ 11.535722] acme-setup-privileged[501]: + for fixpath in host1 .lego/host11521host1 # [ 11.539199] acme-setup-privileged[501]: + '[' -d .lego/host1 ']'1522server # [ 11.509610] systemd[1]: Starting step-ca-pki.service...1523host1 # [ 11.545310] systemd[1]: Starting D-Bus System Message Bus...1524host1 # [ 11.557166] nsncd[503]: Sep 19 21:48:36.179 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1525server # [ 11.519181] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1526server # [ 11.534275] systemd[1]: Started backdoor.service.1527host1 # [ 11.581732] systemd[1]: Started Name Service Cache Daemon (nsncd).1528server # [ 11.546043] systemd[1]: Starting D-Bus System Message Bus...1529host1 # [ 11.593547] systemd[1]: Finished Post-Boot Actions.1530host1 # [ 11.640186] systemd[1]: Finished Import lastlog data into lastlog2 database.1531server # [ 11.608260] systemd[1]: Finished Post-Boot Actions.1532host1 # [ 11.643289] systemd[1]: Reached target Host and Network Name Lookups.1533host1 # [ 11.645726] systemd[1]: Reached target User and Group Name Lookups.1534server # [ 11.621049] acme-setup-privileged[509]: + set -euo pipefail1535server # [ 11.630105] acme-setup-privileged[509]: + cd /var/lib/acme1536host1 # [ 11.668189] systemd[1]: Starting User Login Management...1537server # [ 11.637493] acme-setup-privileged[509]: + chmod -R u=rwX,g=,o= .lego/accounts1538server # [ 11.648925] acme-setup-privileged[509]: + chown -R acme .lego/accounts1539host1 # connecting to host...1540server # [ 11.672000] systemd[1]: Started Name Service Cache Daemon (nsncd).1541server # [ 11.684976] nsncd[511]: Sep 19 21:48:36.303 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1542server # [ 11.702534] systemd[1]: Reached target Host and Network Name Lookups.1543server # [ 11.716317] acme-setup-privileged[509]: + for fixpath in server .lego/server1544server # [ 11.722964] acme-setup-privileged[509]: + '[' -d server ']'1545server # connecting to host...1546server # [ 11.730592] acme-setup-privileged[509]: + for fixpath in server .lego/server1547server # [ 11.738613] acme-setup-privileged[509]: + '[' -d .lego/server ']'1548server # [ 11.745214] systemd[1]: Reached target User and Group Name Lookups.1549host1 # [ 11.784941] dbus-broker-launch[517]: Looking up NSS user entry for 'systemd-timesync'...1550server # [ 11.753936] systemd[1]: Starting User Login Management...1551host1 # [ 11.795904] dbus-broker-launch[517]: NSS returned no entry for 'systemd-timesync'1552server # [ 11.761268] systemd[1]: Finished Import lastlog data into lastlog2 database.1553host1 # [ 11.801162] dbus-broker-launch[517]: Invalid user-name in /nix/store/vbp0wjh4964al3ar1y5dzizpgih0kf2v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1554server: Guest shell says: b'Spawning backdoor root shell...\n'1555host1 # [ 11.844155] systemd[1]: Started D-Bus System Message Bus.1556server: connected to guest root shell1557server # [ 11.825527] dbus-broker-launch[521]: Looking up NSS user entry for 'systemd-timesync'...1558server: (connecting took 12.18 seconds)1559server # [ 11.834626] dbus-broker-launch[521]: NSS returned no entry for 'systemd-timesync'1560server: (finished: waiting for the VM to finish booting, in 12.18 seconds)1561server # [ 11.844496] dbus-broker-launch[521]: Invalid user-name in /nix/store/gvyyjgzkykgkdyrbr192yz9972s0sqq0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1562host1 # [ 11.905509] acme-setup-start[530]: + set -euo pipefail1563host1 # [ 11.913581] acme-setup-start[530]: + test -e ca/key.pem1564host1 # [ 11.914355] acme-setup-start[530]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1565host1 # [ 11.915977] systemd-logind[537]: New seat seat0.1566host1 # [ 11.925839] systemd[1]: Started User Login Management.1567host1 # [ 11.930747] systemd[1]: Stopped target Host and Network Name Lookups.1568host1 # [ 11.931732] systemd[1]: Stopping Host and Network Name Lookups...1569server # [ 11.901207] systemd[1]: Started D-Bus System Message Bus.1570host1 # [ 11.937772] systemd[1]: Stopped target User and Group Name Lookups.1571host1 # [ 11.942793] systemd[1]: Stopping User and Group Name Lookups...1572host1 # [ 11.947472] dbus-broker-launch[517]: Ready1573host1 # [ 11.952992] systemd[1]: Starting linger-users.service...1574host1 # [ 11.957251] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1575host1 # [ 11.962138] systemd[1]: nscd.service: Deactivated successfully.1576host1 # [ 11.963019] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1577host1 # [ 12.001177] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1578server # [ 11.989155] dbus-broker-launch[521]: Ready1579server # [ 12.010403] systemd-logind[536]: New seat seat0.1580host1 # [ 12.049663] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1581server # [ 12.020523] systemd[1]: Started User Login Management.1582server # [ 12.025114] systemd[1]: Starting linger-users.service...1583host1 # [ 12.068320] systemd[1]: Starting Ensure certificate for host1...1584host1 # [ 12.069258] systemd[1]: linger-users.service: Deactivated successfully.1585host1 # [ 12.075971] systemd[1]: Finished linger-users.service.1586server # [ 12.057716] acme-setup-start[547]: + set -euo pipefail1587server # [ 12.059179] acme-setup-start[547]: + test -e ca/key.pem1588server # [ 12.059892] acme-setup-start[547]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1589host1 # [ 12.109308] systemd[1]: Finished resolvconf update.1590host1 # [ 12.114183] nsncd[601]: Sep 19 21:48:36.733 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1591host1 # [ 12.124680] systemd[1]: Started Name Service Cache Daemon (nsncd).1592host1 # [ 12.125614] systemd[1]: Reached target Preparation for Network.1593host1 # [ 12.126410] systemd[1]: Reached target Host and Network Name Lookups.1594host1 # [ 12.127284] systemd[1]: Reached target User and Group Name Lookups.1595server # [ 12.094520] systemd[1]: Stopped target Host and Network Name Lookups.1596host1 # [ 12.135277] systemd[1]: Starting DHCP Client...1597server # [ 12.108162] systemd[1]: Stopping Host and Network Name Lookups...1598server # [ 12.109196] systemd[1]: Stopped target User and Group Name Lookups.1599host1 # [ 12.144441] systemd[1]: Starting Extra networking commands....1600server # [ 12.110057] systemd[1]: Stopping User and Group Name Lookups...1601server # [ 12.110841] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1602server # [ 12.139908] systemd[1]: nscd.service: Deactivated successfully.1603server # [ 12.147465] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1604server # [ 12.152991] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1605server # [ 12.179658] systemd[1]: linger-users.service: Deactivated successfully.1606server # [ 12.188365] systemd[1]: Finished linger-users.service.1607host1 # [ 12.241930] acme-host1-start[608]: Waiting to acquire lock in /run/acme/1608host1 # [ 12.270413] acme-host1-start[608]: + '[' -e out/acme-success ']'1609host1 # [ 12.273240] acme-host1-start[608]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=1610server # [ 12.240473] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1611server # [ 12.247555] systemd[1]: Starting Ensure certificate for server...1612host1 # [ 12.302248] (udev-worker)[381]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1613host1 # [ 12.314114] (udev-worker)[381]: Network interface NamePolicy= disabled on kernel command line.1614host1 # [ 12.315627] acme-host1-start[640]: + cd host11615server # [ 12.281537] nsncd[615]: Sep 19 21:48:36.914 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1616host1 # [ 12.320396] acme-host1-start[640]: + cp -vp cert.pem ../out/cert.pem1617host1 # [ 12.326360] (udev-worker)[373]: Network interface NamePolicy= disabled on kernel command line.1618server # [ 12.283569] systemd[1]: Started Name Service Cache Daemon (nsncd).1619server # [ 12.296356] systemd[1]: Reached target Host and Network Name Lookups.1620server # [ 12.297306] systemd[1]: Reached target User and Group Name Lookups.1621host1 # [ 12.333041] acme-host1-start[642]: 'cert.pem' -> '../out/cert.pem'1622host1 # [ 12.333913] systemd-logind[537]: Watching system buttons on /dev/input/event0 (gpio-keys)1623host1 # [ 12.341522] acme-host1-start[640]: + cp -vp key.pem ../out/key.pem1624host1 # [ 12.345479] acme-host1-start[640]: 'key.pem' -> '../out/key.pem'1625host1 # [ 12.349176] acme-host1-start[608]: + cat out/cert.pem ca/cert.pem1626host1 # [ 12.365049] acme-host1-start[608]: + cp ca/cert.pem out/chain.pem1627server # [ 12.331635] systemd[1]: Finished resolvconf update.1628server # [ 12.337473] systemd[1]: Reached target Preparation for Network.1629server # [ 12.341001] systemd[1]: Starting DHCP Client...1630host1 # [ 12.386356] acme-host1-start[608]: + cat out/key.pem out/fullchain.pem1631server # [ 12.352693] systemd[1]: Starting Extra networking commands....1632host1 # [ 12.401796] acme-host1-start[608]: + for fixpath in out certificates1633host1 # [ 12.408175] acme-host1-start[608]: + '[' -d out ']'1634host1 # [ 12.409946] acme-host1-start[608]: + chmod -R u=rwX,g=rX,o= out1635host1 # [ 12.424972] acme-host1-start[608]: + chown -R acme:acme out1636host1 # [ 12.449822] acme-host1-start[608]: + for fixpath in out certificates1637host1 # [ 12.453542] acme-host1-start[608]: + '[' -d certificates ']'1638host1 # [ 12.459784] systemd[1]: Finished Ensure certificate for host1.1639host1 # [ 12.476964] dhcpcd[634]: dhcpcd-10.3.2 starting1640server # [ 12.441640] (udev-worker)[366]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1641host1 # [ 12.492604] dhcpcd[687]: dev: loaded udev1642server # [ 12.463741] acme-server-start[631]: Waiting to acquire lock in /run/acme/1643server # [ 12.470824] (udev-worker)[366]: Network interface NamePolicy= disabled on kernel command line.1644host1 # [ 12.510335] systemd[1]: Condition check resulted in Virtio network device being skipped.1645server # [ 12.479463] (udev-worker)[380]: Network interface NamePolicy= disabled on kernel command line.1646host1 # [ 12.519958] systemd[1]: Starting Address configuration of eth1...1647server # [ 12.500072] acme-server-start[631]: + '[' -e out/acme-success ']'1648server # [ 12.501039] acme-server-start[631]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=1649host1 # [ 12.545257] systemd[1]: Finished Extra networking commands..1650host1 # [ 12.549317] systemd[1]: Reached target Network.1651host1 # [ 12.565797] 8021q: 802.1Q VLAN Support v1.81652host1 # [ 12.558202] systemd[1]: Starting Permit User Sessions...1653server # [ 12.558823] acme-server-start[669]: + cd server1654server # [ 12.562020] acme-server-start[669]: + cp -vp cert.pem ../out/cert.pem1655server # [ 12.577348] acme-server-start[670]: 'cert.pem' -> '../out/cert.pem'1656server # [ 12.581505] acme-server-start[669]: + cp -vp key.pem ../out/key.pem1657host1 # [ 12.623071] systemd[1]: Finished Permit User Sessions.1658server # [ 12.593456] acme-server-start[669]: 'key.pem' -> '../out/key.pem'1659server # [ 12.597150] acme-server-start[631]: + cat out/cert.pem ca/cert.pem1660host1 # [ 12.632683] systemd[1]: Started Getty on tty1.1661host1 # [ 12.637986] systemd[1]: Reached target Login Prompts.1662server # [ 12.629577] acme-server-start[631]: + cp ca/cert.pem out/chain.pem1663host1 # [ 12.681640] 8021q: adding VLAN 0 to HW filter on device eth11664server # [ 12.643255] acme-server-start[631]: + cat out/key.pem out/fullchain.pem1665server # [ 12.657595] step-ca-pki-start[533]: Your certificate has been saved in root_ca.crt.1666host1 # [ 12.709793] cfg80211: Loading compiled-in X.509 certificates for regulatory database1667server # [ 12.667687] step-ca-pki-start[533]: Your private key has been saved in root_ca.key.1668host1 # [ 12.704511] network-addresses-eth1-start[697]: adding address 192.168.1.1/24... done1669server # [ 12.676844] acme-server-start[631]: + for fixpath in out certificates1670server # [ 12.677768] acme-server-start[631]: + '[' -d out ']'1671server # [ 12.678458] acme-server-start[631]: + chmod -R u=rwX,g=rX,o= out1672server # [ 12.679262] systemd[1]: Condition check resulted in Virtio network device being skipped.1673host1 # [ 12.721674] network-addresses-eth1-start[697]: adding address 2001:db8:1::1/64... done1674host1 # [ 12.751612] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1675server # [ 12.704320] systemd[1]: Starting Address configuration of eth1...1676host1 # [ 12.752133] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1677host1 # [ 12.756601] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21678server # [ 12.708939] acme-server-start[631]: + chown -R acme:nix-grpc-daemon out1679host1 # [ 12.756936] cfg80211: failed to load regulatory.db1680host1 # [ 12.759004] systemd[1]: Finished Address configuration of eth1.1681server # [ 12.728075] acme-server-start[631]: + for fixpath in out certificates1682server # [ 12.729036] acme-server-start[631]: + '[' -d certificates ']'1683server # [ 12.741416] systemd[1]: Finished Ensure certificate for server.1684server # [ 12.758844] dhcpcd[657]: dhcpcd-10.3.2 starting1685server # [ 12.781973] dhcpcd[715]: dev: loaded udev1686host1 # [ 12.848593] 8021q: adding VLAN 0 to HW filter on device eth01687host1 # [ 12.837198] dhcpcd[687]: eth0: waiting for carrier1688host1 # [ 12.840996] dhcpcd[687]: eth0: waiting for carrier1689host1 # [ 12.842182] dhcpcd[687]: eth0: carrier acquired1690server # [ 12.839834] 8021q: 802.1Q VLAN Support v1.81691host1 # [ 12.860509] dhcpcd[687]: DUID 00:01:00:01:32:41:bf:b5:52:54:00:12:34:561692host1 # [ 12.861499] dhcpcd[687]: eth0: IAID 00:12:34:561693host1 # [ 12.862173] dhcpcd[687]: eth0: adding address fe80::5054:ff:fe12:34561694host1 # [ 12.889027] mousedev: PS/2 mouse device common for all mice1695server # [ 12.851923] step-ca-pki-start[699]: Your certificate has been saved in intermediate_ca.crt.1696server # [ 12.863186] step-ca-pki-start[699]: Your private key has been saved in intermediate_ca.key.1697server # [ 12.891295] systemd[1]: Finished Extra networking commands..1698server # [ 12.917060] 8021q: adding VLAN 0 to HW filter on device eth11699server # [ 12.909452] systemd[1]: Reached target Network.1700server # [ 12.910238] systemd[1]: Starting Permit User Sessions...1701server # [ 12.937510] cfg80211: Loading compiled-in X.509 certificates for regulatory database1702server # [ 12.945244] systemd[1]: Finished step-ca-pki.service.1703server # [ 12.973125] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1704server # [ 12.973627] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1705server # [ 12.959223] network-addresses-eth1-start[695]: adding address 192.168.1.2/24... done1706server # [ 12.979380] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21707server # [ 12.979701] cfg80211: failed to load regulatory.db1708host1 # [ 13.011527] systemd-logind[537]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1709server # [ 12.986044] network-addresses-eth1-start[695]: adding address 2001:db8:1::2/64... done1710server # [ 13.007509] systemd[1]: Finished Permit User Sessions.1711server # [ 13.012646] systemd[1]: Started Getty on tty1.1712server # [ 13.014875] systemd[1]: Reached target Login Prompts.1713server # [ 13.029256] systemd[1]: Finished Address configuration of eth1.1714server # [ 13.093437] 8021q: adding VLAN 0 to HW filter on device eth01715server # [ 13.078278] dhcpcd[715]: eth0: waiting for carrier1716server # [ 13.080134] dhcpcd[715]: eth0: carrier acquired1717server # [ 13.094124] dhcpcd[715]: DUID 00:01:00:01:32:41:bf:b5:52:54:00:12:34:561718server # [ 13.095081] dhcpcd[715]: eth0: IAID 00:12:34:561719server # [ 13.095754] dhcpcd[715]: eth0: adding address fe80::5054:ff:fe12:34561720server # [ 13.128515] systemd-logind[536]: Watching system buttons on /dev/input/event0 (gpio-keys)1721server # [ 13.391895] mousedev: PS/2 mouse device common for all mice1722server # [ 13.511615] systemd-logind[536]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1723host1 # [ 13.632334] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31724host1 # [ 13.929108] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1725server # [ 13.920463] dhcpcd[715]: eth0: soliciting a DHCP lease1726host1 # [ 13.961865] systemd[1]: Starting Virtual Console Setup...1727server # [ 13.928566] dhcpcd[715]: eth0: offered 10.0.2.15 from 10.0.2.21728server # [ 13.936254] dhcpcd[715]: eth0: probing address 10.0.2.15/241729host1 # [ 13.986224] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1730host1 # [ 13.990848] systemd[1]: Stopped Virtual Console Setup.1731host1 # [ 13.996653] systemd[1]: Starting Virtual Console Setup...1732host1 # [ 14.010301] systemd-logind[537]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1733server # [ 14.018517] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31734server # [ 14.314961] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1735server # [ 14.335697] dhcpcd[715]: eth0: soliciting an IPv6 router1736server # [ 14.342835] dhcpcd[715]: eth0: Router Advertisement from fe80::21737server # [ 14.345993] systemd[1]: Starting Virtual Console Setup...1738server # [ 14.346824] dhcpcd[715]: eth0: adding address fec0::5054:ff:fe12:3456/641739server # [ 14.347739] dhcpcd[715]: eth0: adding route to fec0::/641740host1 # [ 14.389092] systemd-vconsole-setup[747]: Configuration of first virtual console was skipped, ignoring remaining ones.1741host1 # [ 14.393287] systemd[1]: Finished Virtual Console Setup.1742server # [ 14.358768] dhcpcd[715]: eth0: adding default route via fe80::21743server # [ 14.376490] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1744server # [ 14.377593] systemd[1]: Stopped Virtual Console Setup.1745server # [ 14.385786] systemd[1]: Starting Virtual Console Setup...1746server # [ 14.466043] systemd-logind[536]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1747host1 # [ 14.689368] dhcpcd[687]: eth0: soliciting a DHCP lease1748host1 # [ 14.693050] dhcpcd[687]: eth0: offered 10.0.2.15 from 10.0.2.21749host1 # [ 14.700551] dhcpcd[687]: eth0: probing address 10.0.2.15/241750host1 # [ 14.833106] dhcpcd[687]: eth0: soliciting an IPv6 router1751host1 # [ 14.836871] dhcpcd[687]: eth0: Router Advertisement from fe80::21752host1 # [ 14.839438] dhcpcd[687]: eth0: adding address fec0::5054:ff:fe12:3456/641753host1 # [ 14.842396] dhcpcd[687]: eth0: adding route to fec0::/641754host1 # [ 14.844777] dhcpcd[687]: eth0: adding default route via fe80::21755server # [ 14.834335] systemd-vconsole-setup[791]: Configuration of first virtual console was skipped, ignoring remaining ones.1756server # [ 14.839311] systemd[1]: Finished Virtual Console Setup.1757server # [ 18.776785] dhcpcd[715]: eth0: leased 10.0.2.15 for 86400 seconds1758server # [ 18.780340] dhcpcd[715]: eth0: adding route to 10.0.2.0/241759server # [ 18.783520] dhcpcd[715]: eth0: adding default route via 10.0.2.21760server # [ 18.982892] systemd[1]: Started DHCP Client.1761server # [ 18.987112] systemd[1]: Reached target Network is Online.1762server # [ 18.990119] systemd[1]: Starting step-ca service...1763server # [ 19.429204] step-ca[896]: badger 2026/09/19 21:48:44 INFO: All 0 tables opened in 0s1764server # [ 19.449598] step-ca[896]: 2026/09/19 21:48:44 Building new tls configuration using step-ca x509 Signer Interface1765server # [ 19.468813] step-ca[896]: 2026/09/19 21:48:44 Starting Smallstep CA/0.30.2 (linux/arm64)1766server # [ 19.469958] step-ca[896]: 2026/09/19 21:48:44 Documentation: https://u.step.sm/docs/ca1767server # [ 19.470979] step-ca[896]: 2026/09/19 21:48:44 Community Discord: https://u.step.sm/discord1768server # [ 19.472089] step-ca[896]: 2026/09/19 21:48:44 Config file: /etc/smallstep/ca.json1769server # [ 19.473170] step-ca[896]: 2026/09/19 21:48:44 The primary server URL is https://server:84431770server # [ 19.474342] step-ca[896]: 2026/09/19 21:48:44 Root certificates are available at https://server:8443/roots.pem1771server # [ 19.475844] step-ca[896]: 2026/09/19 21:48:44 X.509 Root Fingerprint: a98dc168af90e3af227d212d9ca1b3cc644c56741d423336e04e3cfc52f1aade1772server # [ 19.479973] systemd[1]: Started step-ca service.1773server # [ 19.484908] systemd[1]: Reached target Multi-User System.1774server # [ 19.487362] systemd[1]: Starting Order (and renew) ACME certificate for server...1775server # [ 19.495973] step-ca[896]: 2026/09/19 21:48:44 Serving HTTPS on 0.0.0.0:8443 ...1776server # [ 19.553308] acme-order-renew-server-start[902]: Waiting to acquire lock in /run/acme/1777server # [ 19.564483] acme-order-renew-server-start[902]: + set -euo pipefail1778server # [ 19.565539] acme-order-renew-server-start[902]: + echo 95dbbf40517986466fee1779server # [ 19.566644] acme-order-renew-server-start[902]: + cmp -s domainhash.txt certificates/domainhash.txt1780server # [ 19.574717] acme-order-renew-server-start[902]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server run1781server # [ 19.896158] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 No key found for account root@example.org. Generating a P256 key.1782server # [ 19.906306] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key1783server # [ 19.942992] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] acme: Registering account for root@example.org1784server # [ 19.957206] acme-order-renew-server-start[912]: !!!! HEADS UP !!!!1785server # [ 19.958109] acme-order-renew-server-start[912]: Your account credentials have been saved in your1786server # [ 19.959976] acme-order-renew-server-start[912]: configuration directory at "accounts".1787server # [ 19.961380] acme-order-renew-server-start[912]: You should make a secure backup of this folder now. This1788server # [ 19.962788] acme-order-renew-server-start[912]: configuration directory will also contain private keys1789server # [ 19.964550] acme-order-renew-server-start[912]: generated by lego and certificates obtained from the ACME1790server # [ 19.966074] acme-order-renew-server-start[912]: server. Making regular backups of this folder is ideal.1791server # [ 19.967925] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] acme: Obtaining bundled SAN certificate1792server: (finished: waiting for unit step-ca.service, in 20.37 seconds)1793server: waiting for unit nix-grpc-daemon.socket1794server # [ 20.047432] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] AuthURL: https://server:8443/acme/acme/authz/Xtjkg4R9LVfacVVibwxp2yDR9vkxJBtl1795server # [ 20.050630] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] acme: Could not find solver for: tls-alpn-011796server # [ 20.053412] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] acme: use http-01 solver1797server # [ 20.056838] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] acme: Trying to solve HTTP-011798server # [ 20.064737] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] Served key authentication1799server # [ 20.068672] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] The server validated our request1800server # [ 20.071465] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] acme: Validations succeeded; requesting certificates1801server # [ 20.092997] acme-order-renew-server-start[912]: 2026/09/19 21:48:44 [INFO] [server] Server responded with a certificate.1802server # [ 20.098408] acme-order-renew-server-start[902]: + mv domainhash.txt certificates/1803server # [ 20.106764] acme-order-renew-server-start[902]: + touch out/acme-success1804server # [ 20.115854] acme-order-renew-server-start[902]: + cmp -s certificates/server.crt out/fullchain.pem1805server # [ 20.121258] acme-order-renew-server-start[902]: + touch out/renewed1806server # [ 20.130891] acme-order-renew-server-start[902]: + echo Installing new certificate1807server # [ 20.131927] acme-order-renew-server-start[902]: Installing new certificate1808server # [ 20.133727] acme-order-renew-server-start[902]: + cp -vp certificates/server.crt out/fullchain.pem1809server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.11 seconds)1810server: waiting for TCP port 50051 on localhost1811server # [ 20.142830] acme-order-renew-server-start[930]: 'certificates/server.crt' -> 'out/fullchain.pem'1812server # [ 20.145674] acme-order-renew-server-start[902]: + cp -vp certificates/server.key out/key.pem1813host1 # [ 20.181441] dhcpcd[687]: eth0: leased 10.0.2.15 for 86400 seconds1814host1 # [ 20.181795] dhcpcd[687]: eth0: adding route to 10.0.2.0/241815host1 # [ 20.181932] dhcpcd[687]: eth0: adding default route via 10.0.2.21816server # [ 20.153595] acme-order-renew-server-start[934]: 'certificates/server.key' -> 'out/key.pem'1817server # [ 20.156686] acme-order-renew-server-start[902]: + cp -vp certificates/server.issuer.crt out/chain.pem1818server # [ 20.163500] acme-order-renew-server-start[935]: 'certificates/server.issuer.crt' -> 'out/chain.pem'1819server # [ 20.165472] acme-order-renew-server-start[902]: + ln -sf fullchain.pem out/cert.pem1820server # [ 20.175650] acme-order-renew-server-start[902]: + cat out/key.pem out/fullchain.pem1821server # [ 20.184210] acme-order-renew-server-start[902]: + for fixpath in out certificates1822server # [ 20.185407] acme-order-renew-server-start[902]: + '[' -d out ']'1823server # [ 20.186606] acme-order-renew-server-start[902]: + chmod -R u=rwX,g=rX,o= out1824server # [ 20.193896] acme-order-renew-server-start[902]: + chown -R acme:nix-grpc-daemon out1825server # [ 20.203726] acme-order-renew-server-start[902]: + for fixpath in out certificates1826server # [ 20.205524] acme-order-renew-server-start[902]: + '[' -d certificates ']'1827server # [ 20.206744] acme-order-renew-server-start[902]: + chmod -R u=rwX,g=rX,o= certificates1828server # [ 20.213569] acme-order-renew-server-start[902]: + chown -R acme:nix-grpc-daemon certificates1829server # [ 20.223652] acme-order-renew-server-start[902]: + chmod -R u=rwX,g=,o= accounts/.1830server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!1831server: (finished: waiting for TCP port 50051 on localhost, in 0.10 seconds)1832subtest: host1 obtains a certificate via ACME1833host1: 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'1834host1: waiting for the VM to finish booting1835host1: Guest shell says: b'Spawning backdoor root shell...\n'1836host1: connected to guest root shell1837host1: (connecting took 0.00 seconds)1838host1: (finished: waiting for the VM to finish booting, in 0.00 seconds)1839server # [ 20.288667] systemd[1]: acme-order-renew-server.service: Deactivated successfully.1840server # [ 20.291434] systemd[1]: Finished Order (and renew) ACME certificate for server.1841server # [ 20.293802] systemd[1]: acme-order-renew-server.service: Consumed 209ms CPU time over 803ms wall clock time, 33.6M memory peak, 10.2K incoming IP traffic, 8.2K outgoing IP traffic.1842server # [ 20.301214] systemd[1]: Starting Nix worker-protocol over gRPC...1843host1 # [ 20.400380] systemd[1]: Started DHCP Client.1844host1 # [ 20.401115] systemd[1]: Reached target Network is Online.1845host1 # [ 20.406720] systemd[1]: Starting fetch-ca-root.service...1846host1 # [ 20.514238] systemd[1]: Finished fetch-ca-root.service.1847host1 # [ 20.518118] systemd[1]: Reached target Multi-User System.1848host1 # [ 20.520889] systemd[1]: Starting Order (and renew) ACME certificate for host1...1849server # [ 20.510337] nix-grpc-daemon[954]: ts=2026-09-19T21:48:45Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=11850host1 # [ 20.583651] acme-order-renew-host1-start[823]: Waiting to acquire lock in /run/acme/1851host1 # [ 20.595130] acme-order-renew-host1-start[823]: + set -euo pipefail1852host1 # [ 20.596290] acme-order-renew-host1-start[823]: + echo 76ccde284609af0e376b1853server # [ 20.561666] nix-grpc-daemon[954]: ts=2026-09-19T21:48:45Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket1854host1 # [ 20.597305] acme-order-renew-host1-start[823]: + cmp -s domainhash.txt certificates/domainhash.txt1855server # [ 20.566941] nix-grpc-daemon[954]: ts=2026-09-19T21:48:45Z level=info event=worker_hello addr=0.0.0.0:50051 system=aarch64-linux max_jobs=1 running=01856server # [ 20.570372] systemd[1]: Started Nix worker-protocol over gRPC.1857host1 # [ 20.605789] acme-order-renew-host1-start[823]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 run1858server # [ 20.571978] nix-grpc-daemon[954]: ts=2026-09-19T21:48:45Z level=info event=unhealthy reason=min_free1859server # [ 20.573348] systemd[1]: Startup finished in 935ms (kernel) + 5.407s (initrd) + 14.226s (userspace) = 20.568s.1860host1 # [ 20.906718] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 No key found for account root@example.org. Generating a P256 key.1861host1 # [ 20.911082] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key1862host1 # [ 20.937401] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] acme: Registering account for root@example.org1863host1 # [ 20.954432] acme-order-renew-host1-start[831]: !!!! HEADS UP !!!!1864host1 # [ 20.955317] acme-order-renew-host1-start[831]: Your account credentials have been saved in your1865host1 # [ 20.956879] acme-order-renew-host1-start[831]: configuration directory at "accounts".1866host1 # [ 20.957912] acme-order-renew-host1-start[831]: You should make a secure backup of this folder now. This1867host1 # [ 20.959113] acme-order-renew-host1-start[831]: configuration directory will also contain private keys1868host1 # [ 20.960320] acme-order-renew-host1-start[831]: generated by lego and certificates obtained from the ACME1869host1 # [ 20.961543] acme-order-renew-host1-start[831]: server. Making regular backups of this folder is ideal.1870host1 # [ 20.962726] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] acme: Obtaining bundled SAN certificate1871host1 # [ 21.038113] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] AuthURL: https://server:8443/acme/acme/authz/RWzQzmDkPYweYCSYuQ3iMVIgmvbSx91M1872host1 # [ 21.042405] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] acme: Could not find solver for: tls-alpn-011873host1 # [ 21.045344] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] acme: use http-01 solver1874host1 # [ 21.047554] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] acme: Trying to solve HTTP-011875host1 # [ 21.051919] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] Served key authentication1876host1 # [ 21.059042] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] The server validated our request1877host1 # [ 21.061722] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] acme: Validations succeeded; requesting certificates1878host1 # [ 21.082106] acme-order-renew-host1-start[831]: 2026/09/19 21:48:45 [INFO] [host1] Server responded with a certificate.1879host1 # [ 21.091063] acme-order-renew-host1-start[823]: + mv domainhash.txt certificates/1880host1 # [ 21.103383] acme-order-renew-host1-start[823]: + touch out/acme-success1881host1 # [ 21.114884] acme-order-renew-host1-start[823]: + cmp -s certificates/host1.crt out/fullchain.pem1882host1 # [ 21.122442] acme-order-renew-host1-start[823]: + touch out/renewed1883host1 # [ 21.130705] acme-order-renew-host1-start[823]: + echo Installing new certificate1884host1 # [ 21.132723] acme-order-renew-host1-start[823]: Installing new certificate1885host1 # [ 21.134361] acme-order-renew-host1-start[823]: + cp -vp certificates/host1.crt out/fullchain.pem1886host1 # [ 21.143029] acme-order-renew-host1-start[840]: 'certificates/host1.crt' -> 'out/fullchain.pem'1887host1 # [ 21.147012] acme-order-renew-host1-start[823]: + cp -vp certificates/host1.key out/key.pem1888host1 # [ 21.155096] acme-order-renew-host1-start[841]: 'certificates/host1.key' -> 'out/key.pem'1889host1 # [ 21.157801] acme-order-renew-host1-start[823]: + cp -vp certificates/host1.issuer.crt out/chain.pem1890host1 # [ 21.165776] acme-order-renew-host1-start[842]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'1891host1 # [ 21.168247] acme-order-renew-host1-start[823]: + ln -sf fullchain.pem out/cert.pem1892host1 # [ 21.176843] acme-order-renew-host1-start[823]: + cat out/key.pem out/fullchain.pem1893host1 # [ 21.185758] acme-order-renew-host1-start[823]: + for fixpath in out certificates1894host1 # [ 21.187277] acme-order-renew-host1-start[823]: + '[' -d out ']'1895host1 # [ 21.188834] acme-order-renew-host1-start[823]: + chmod -R u=rwX,g=rX,o= out1896host1 # [ 21.196686] acme-order-renew-host1-start[823]: + chown -R acme:acme out1897host1 # [ 21.207271] acme-order-renew-host1-start[823]: + for fixpath in out certificates1898host1 # [ 21.208782] acme-order-renew-host1-start[823]: + '[' -d certificates ']'1899host1 # [ 21.210067] acme-order-renew-host1-start[823]: + chmod -R u=rwX,g=rX,o= certificates1900host1 # [ 21.216815] acme-order-renew-host1-start[823]: + chown -R acme:acme certificates1901host1 # [ 21.225738] acme-order-renew-host1-start[823]: + chmod -R u=rwX,g=,o= accounts/.1902host1 # [ 21.288600] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.1903host1 # [ 21.291050] systemd[1]: Finished Order (and renew) ACME certificate for host1.1904host1 # [ 21.293258] systemd[1]: Startup finished in 945ms (kernel) + 5.468s (initrd) + 14.876s (userspace) = 21.290s.1905host1 # [ 21.294639] systemd[1]: acme-order-renew-host1.service: Consumed 211ms CPU time over 767ms wall clock time, 33.5M memory peak, 10.3K incoming IP traffic, 8.3K outgoing IP traffic.1906host1: (finished: waiting for success: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA', in 1.24 seconds)1907host1: 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'1908host1: (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)1909(finished: subtest: host1 obtains a certificate via ACME, in 1.30 seconds)1910subtest: server builds and signs a path1911server: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths1912server # 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 60 ms (attempt 1/5)1913server # 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 3 ms (attempt 2/5)1914server # 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 238 ms (attempt 3/5)1915server # 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 382 ms (attempt 4/5)1916server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1917server # this derivation will be built:1918server # /nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv1919server # building '/nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv'...1920server: (finished: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths, in 1.45 seconds)1921server: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1922server # added 1 signatures1923server: (finished: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.27 seconds)1924(finished: subtest: server builds and signs a path, in 1.72 seconds)1925subtest: host1 substitutes the signed path over gRPC (read-only cert)1926host1: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1927host1: (finished: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.05 seconds)1928host1: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1929host1 # 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 5 ms (attempt 1/5)1930host1 # 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 27 ms (attempt 2/5)1931host1 # 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 372 ms (attempt 3/5)1932host1 # 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 231 ms (attempt 4/5)1933host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1934server # [ 24.339310] systemd[1]: Started Nix Daemon.1935server # [ 24.629240] nix-daemon[987]: accepted connection from pid 954, user nix-grpc-daemon (trusted)1936host1 # this path will be fetched (0.0 KiB download, 0.1 KiB unpacked):1937host1 # /nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc1938host1 # copying path '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' from 'grpc://server:50051'...1939server # [ 24.694133] nix-grpc-daemon[954]: ts=2026-09-19T21:48:49Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:34334 duration_s=0 paths=1 nar_bytes_out=1281940host1 # warning: you did not specify '--add-root'; the result might be removed by the garbage collector1941host1: (finished: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 1.47 seconds)1942host1: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1943host1: (finished: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.05 seconds)1944(finished: subtest: host1 substitutes the signed path over gRPC (read-only cert), in 1.57 seconds)1945subtest: read-only host1 cannot write1946host1: must succeed: echo deny > /root/denyfile1947host1: (finished: must succeed: echo deny > /root/denyfile, in 0.02 seconds)1948host1: 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/denyfile1949server # [ 25.098257] nix-grpc-daemon[954]: ts=2026-09-19T21:48:49Z level=info event=denied method=Connect cn=host1 role=read-only1950host1 # error: gRPC Connect on 'server:50051' failed: role 'read-only' may not call Connect1951host1 # error: cannot open connection to remote store 'grpc://server:50051': error: Nix daemon disconnected unexpectedly (maybe it crashed?)1952host1: (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.29 seconds)1953server: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only'1954server: (finished: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only', in 0.08 seconds)1955(finished: subtest: read-only host1 cannot write, in 0.39 seconds)1956(finished: run the VM test script, in 26.02 seconds)1957test script finished in 26.19s1958cleanup1959kill QemuMachine (pid 47)1960host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1961kill QemuMachine (pid 48)1962server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1963(finished: cleanup, in 0.41 seconds)1964additionally exposed symbols:1965 host1, server,1966 vlan1,1967 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