vm-test-run-nix-grpc-store-acme-substituter
checks.aarch64-linux.acme-vm
· build #560
· 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 vm10server: QEMU running (pid 48)11server # Disk image does not exist, creating the virtualisation disk image...12host1: QEMU running (pid 47)13server # Formatting '/build/vm-state-server/tmp.s5Ptv9MvLG', fmt=raw size=107374182414host1 # Disk image does not exist, creating the virtualisation disk image...15server # mke2fs 1.47.4 (6-Mar-2025)16host1 # Formatting '/build/vm-state-host1/tmp.SLSOZS4iT7', fmt=raw size=107374182417server # Discarding device blocks: 0/262144 done18host1 # mke2fs 1.47.4 (6-Mar-2025)19server # Creating filesystem with 262144 4k blocks and 65536 inodes20host1 # Discarding device blocks: 0/262144 done21server # Filesystem UUID: 1bd5aeee-649c-4dec-b277-a557bf034b1d22host1 # Creating filesystem with 262144 4k blocks and 65536 inodes23server # Superblock backups stored on blocks:24host1 # Filesystem UUID: b7a81090-2ea1-4b9d-bb6b-51cb255f6c3525server # 32768, 98304, 163840, 22937626host1 # Superblock backups stored on blocks:27server # 28host1 # 32768, 98304, 163840, 22937629server # Allocating group tables: 0/8 done30host1 # 31server # Writing inode tables: 0/8 done32host1 # Allocating group tables: 0/8 done33server # Creating journal (8192 blocks): done34host1 # Writing inode tables: 0/8 done35server # Writing superblocks and filesystem accounting information: 0/8 done36host1 # Creating journal (8192 blocks): done37server # 38host1 # Writing superblocks and filesystem accounting information: 0/8 done39server # Virtualisation disk image created.40host1 # 41server # Starting virtiofs daemons...42host1 # Virtualisation disk image created.43server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)44host1 # Starting virtiofs daemons...45server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether46host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)47server # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...48host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether49server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)50host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)51server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether52host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether53server # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...54host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...55server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)56host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...57server # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether58host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)59server # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...60host1 # [2026-09-25T16:49:42Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether61server # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests62host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Waiting for vhost-user socket connection...63server # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests64host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests65server # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests66host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests67(finished: start all VMs, in 0.42 seconds)68host1 # [2026-09-25T16:49:42Z INFO virtiofsd] Client connected, servicing requests69server: waiting for unit step-ca.service70server: waiting for the VM to finish booting71server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]72server # [ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 14 11:36:19 UTC 202673server # [ 0.000000] KASLR enabled74server # [ 0.000000] random: crng init done75server # [ 0.000000] Machine model: linux,dummy-virt76server # [ 0.000000] efi: UEFI not found.77server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT78server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]79server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]80server # [ 0.000000] Zone ranges:81server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]82server # [ 0.000000] DMA32 empty83server # [ 0.000000] Normal empty84server # [ 0.000000] Device empty85server # [ 0.000000] Movable zone start for each node86server # [ 0.000000] Early memory node ranges87server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]88server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]89server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc0000090server # [ 0.000000] psci: probing for conduit method from DT.91server # [ 0.000000] psci: PSCIv1.3 detected in firmware.92server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs93host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]94server # [ 0.000000] psci: Trusted OS migration not required95server # [ 0.000000] psci: SMC Calling Convention v1.196host1 # [ 0.000000] Linux version 6.18.52 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 14 11:36:19 UTC 202697server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)98host1 # [ 0.000000] KASLR enabled99host1 # [ 0.000000] random: crng init done100server # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296101host1 # [ 0.000000] Machine model: linux,dummy-virt102server # [ 0.000000] Detected PIPT I-cache on CPU0103host1 # [ 0.000000] efi: UEFI not found.104server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)105host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT106server # [ 0.000000] CPU features: detected: GICv3 CPU interface107host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]108server # [ 0.000000] CPU features: detected: Spectre-v4109host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]110server # [ 0.000000] CPU features: detected: Spectre-BHB111host1 # [ 0.000000] Zone ranges:112server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38113host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]114host1 # [ 0.000000] DMA32 empty115server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23116host1 # [ 0.000000] Normal empty117host1 # [ 0.000000] Device empty118server # [ 0.000000] alternatives: applying boot alternatives119host1 # [ 0.000000] Movable zone start for each node120host1 # [ 0.000000] Early memory node ranges121host1 # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]122host1 # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]123host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000124host1 # [ 0.000000] psci: probing for conduit method from DT.125server # [ 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/1vq7rykwv3sxqhqlwlk6900a14v5jj6y-nixos-system-server-test/init regInfo=/nix/store/gq1040aj6zdq4s27pjk8casj3b5nvrrs-closure-info/registration console=ttyAMA0,115200n8 console=tty0126host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware.127host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs128host1 # [ 0.000000] psci: Trusted OS migration not required129host1 # [ 0.000000] psci: SMC Calling Convention v1.1130server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/gq1040aj6zdq4s27pjk8casj3b5nvrrs-closure-info/registration", will be passed to user space.131host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)132server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes133host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186712 r8192 d116392 u311296134server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)135host1 # [ 0.000000] Detected PIPT I-cache on CPU0136server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)137host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)138server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB139host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface140server # [ 0.000000] software IO TLB: area num 1.141host1 # [ 0.000000] CPU features: detected: Spectre-v4142host1 # [ 0.000000] CPU features: detected: Spectre-BHB143server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)144host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38145server # [ 0.000000] Fallback order for Node 0: 0146host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23147server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288148server # [ 0.000000] Policy zone: DMA149host1 # [ 0.000000] alternatives: applying boot alternatives150server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off151server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1152server # [ 0.000000] allocated 4194304 bytes of page_ext153server # [ 0.000000] ftrace: allocating 74950 entries in 294 pages154server # [ 0.000000] ftrace: allocated 294 pages with 4 groups155host1 # [ 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/v6baswar5glbvvh4a5zadjbgwblwy97q-nixos-system-host1-test/init regInfo=/nix/store/81fg8afdj1n8hhjf8z6zpgqbi6acdak0-closure-info/registration console=ttyAMA0,115200n8 console=tty0156server # [ 0.000000] rcu: Hierarchical RCU implementation.157server # [ 0.000000] rcu: RCU event tracing is enabled.158server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.159server # [ 0.000000] Trampoline variant of Tasks RCU enabled.160host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/81fg8afdj1n8hhjf8z6zpgqbi6acdak0-closure-info/registration", will be passed to user space.161server # [ 0.000000] Rude variant of Tasks RCU enabled.162server # [ 0.000000] Tracing variant of Tasks RCU enabled.163host1 # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes164server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.165host1 # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)166server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1167host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)168host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB169server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.170host1 # [ 0.000000] software IO TLB: area num 1.171server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.172host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)173host1 # [ 0.000000] Fallback order for Node 0: 0174server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.175host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288176server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0177host1 # [ 0.000000] Policy zone: DMA178server # [ 0.000000] GICv3: 256 SPIs implemented179host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off180server # [ 0.000000] GICv3: 0 Extended SPIs implemented181server # [ 0.000000] Root IRQ handler: gic_handle_irq182host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1183server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI184host1 # [ 0.000000] allocated 4194304 bytes of page_ext185server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0186host1 # [ 0.000000] ftrace: allocating 74950 entries in 294 pages187host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups188server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000189server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]190host1 # [ 0.000000] rcu: Hierarchical RCU implementation.191host1 # [ 0.000000] rcu: RCU event tracing is enabled.192server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1)193host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.194host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled.195server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)196host1 # [ 0.000000] Rude variant of Tasks RCU enabled.197host1 # [ 0.000000] Tracing variant of Tasks RCU enabled.198server # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000199server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000200host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.201host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1202server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.203host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.204server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns205server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).206host1 # [ 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.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.208server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns209host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0210server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns211host1 # [ 0.000000] GICv3: 256 SPIs implemented212server # [ 0.000031] arm-pv: using stolen time PV213host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented214host1 # [ 0.000000] Root IRQ handler: gic_handle_irq215server # [ 0.000435] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)216host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI217server # [ 0.000616] Console: colour dummy device 80x25218host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0219server # [ 0.000624] printk: legacy console [tty0] enabled220host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000221host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]222server # [ 0.000883] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)223server # [ 0.000890] pid_max: default: 32768 minimum: 301224host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1)225server # [ 0.000976] LSM: initializing lsm=capability,landlock,yama,bpf,ima226server # [ 0.001122] landlock: Up and running.227host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)228server # [ 0.001125] Yama: becoming mindful.229host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000230server # [ 0.001592] LSM support for eBPF active231host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000232server # [ 0.001743] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)233host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.234server # [ 0.001783] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)235server # [ 0.003760] rcu: Hierarchical SRCU implementation.236host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns237server # [ 0.003766] rcu: Max phase no-delay instances is 1000.238host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).239server # [ 0.005093] fsl-mc MSI: its@8080000 domain created240server # [ 0.005183] EFI services will not be available.241host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns242server # [ 0.005310] smp: Bringing up secondary CPUs ...243server # [ 0.005319] smp: Brought up 1 node, 1 CPU244host1 # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns245server # [ 0.005322] SMP: Total of 1 processors activated.246host1 # [ 0.000032] arm-pv: using stolen time PV247server # [ 0.005324] CPU: All CPU(s) started at EL1248server # [ 0.005337] CPU features: detected: Branch Target Identification249host1 # [ 0.000403] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)250host1 # [ 0.000586] Console: colour dummy device 80x25251server # [ 0.005342] CPU features: detected: ARMv8.4 Translation Table Level252host1 # [ 0.000594] printk: legacy console [tty0] enabled253server # [ 0.005345] CPU features: detected: Instruction cache invalidation not required for I/D coherence254host1 # [ 0.000781] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)255server # [ 0.005349] CPU features: detected: Data cache clean to the PoU not required for I/D coherence256host1 # [ 0.000788] pid_max: default: 32768 minimum: 301257server # [ 0.005353] CPU features: detected: Common not Private translations258host1 # [ 0.000862] LSM: initializing lsm=capability,landlock,yama,bpf,ima259host1 # [ 0.000992] landlock: Up and running.260server # [ 0.005356] CPU features: detected: CRC32 instructions261host1 # [ 0.000995] Yama: becoming mindful.262host1 # [ 0.001439] LSM support for eBPF active263server # [ 0.005359] CPU features: detected: Data cache clean to Point of Deep Persistence264host1 # [ 0.001578] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)265server # [ 0.005362] CPU features: detected: Data cache clean to Point of Persistence266server # [ 0.005365] CPU features: detected: Data independent timing control (DIT)267host1 # [ 0.001611] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)268server # [ 0.005368] CPU features: detected: E0PD269host1 # [ 0.003452] rcu: Hierarchical SRCU implementation.270host1 # [ 0.003456] rcu: Max phase no-delay instances is 1000.271server # [ 0.005370] CPU features: detected: Enhanced Counter Virtualization272host1 # [ 0.004730] fsl-mc MSI: its@8080000 domain created273server # [ 0.005374] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)274host1 # [ 0.004820] EFI services will not be available.275server # [ 0.005377] CPU features: detected: Enhanced Virtualization Traps276host1 # [ 0.004900] smp: Bringing up secondary CPUs ...277host1 # [ 0.004908] smp: Brought up 1 node, 1 CPU278server # [ 0.005381] CPU features: detected: Fine Grained Traps279host1 # [ 0.004911] SMP: Total of 1 processors activated.280host1 # [ 0.004914] CPU: All CPU(s) started at EL1281server # [ 0.005384] CPU features: detected: Generic authentication (architected QARMA5 algorithm)282host1 # [ 0.004925] CPU features: detected: Branch Target Identification283host1 # [ 0.004930] CPU features: detected: ARMv8.4 Translation Table Level284host1 # [ 0.004933] CPU features: detected: Instruction cache invalidation not required for I/D coherence285host1 # [ 0.004937] CPU features: detected: Data cache clean to the PoU not required for I/D coherence286host1 # [ 0.004940] CPU features: detected: Common not Private translations287host1 # [ 0.004944] CPU features: detected: CRC32 instructions288host1 # [ 0.004946] CPU features: detected: Data cache clean to Point of Deep Persistence289host1 # [ 0.004950] CPU features: detected: Data cache clean to Point of Persistence290host1 # [ 0.004953] CPU features: detected: Data independent timing control (DIT)291host1 # [ 0.004957] CPU features: detected: E0PD292server # [ 0.005389] CPU features: detected: RCpc load-acquire (LDAPR)293host1 # [ 0.004959] CPU features: detected: Enhanced Counter Virtualization294server # [ 0.005392] CPU features: detected: LSE atomic instructions295host1 # [ 0.004962] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)296server # [ 0.005395] CPU features: detected: Privileged Access Never297host1 # [ 0.004965] CPU features: detected: Enhanced Virtualization Traps298server # [ 0.005398] CPU features: detected: PMUv3299host1 # [ 0.004969] CPU features: detected: Fine Grained Traps300server # [ 0.005400] CPU features: detected: RAS Extension Support301server # [ 0.005403] CPU features: detected: RASv1p1 Extension Support302host1 # [ 0.004973] CPU features: detected: Generic authentication (architected QARMA5 algorithm)303server # [ 0.005406] CPU features: detected: Random Number Generator304host1 # [ 0.004978] CPU features: detected: RCpc load-acquire (LDAPR)305server # [ 0.005409] CPU features: detected: Speculation barrier (SB)306host1 # [ 0.004981] CPU features: detected: LSE atomic instructions307server # [ 0.005411] CPU features: detected: Stage-2 Force Write-Back308host1 # [ 0.004983] CPU features: detected: Privileged Access Never309host1 # [ 0.004986] CPU features: detected: PMUv3310server # [ 0.005414] CPU features: detected: TLB range maintenance instructions311host1 # [ 0.004989] CPU features: detected: RAS Extension Support312server # [ 0.005419] CPU features: detected: Speculative Store Bypassing Safe (SSBS)313host1 # [ 0.004992] CPU features: detected: RASv1p1 Extension Support314server # [ 0.005456] alternatives: applying system-wide alternatives315host1 # [ 0.004995] CPU features: detected: Random Number Generator316server # [ 0.008337] CPU features: detected: BBM Level 2 without TLB conflict abort317host1 # [ 0.004997] CPU features: detected: Speculation barrier (SB)318host1 # [ 0.005000] CPU features: detected: Stage-2 Force Write-Back319host1 # [ 0.005002] CPU features: detected: TLB range maintenance instructions320server # [ 0.008521] Memory: 1920720K/2097152K available (24448K kernel code, 7094K rwdata, 26372K rodata, 4736K init, 1107K bss, 132828K reserved, 32768K cma-reserved)321server # [ 0.008997] devtmpfs: initialized322host1 # [ 0.005007] CPU features: detected: Speculative Store Bypassing Safe (SSBS)323server # [ 0.010853] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)324host1 # [ 0.005044] alternatives: applying system-wide alternatives325server # [ 0.010876] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).326host1 # [ 0.008005] CPU features: detected: BBM Level 2 without TLB conflict abort327server # [ 0.011044] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL328server # [ 0.011048] 0 pages in range for non-PLT usage329host1 # [ 0.008190] Memory: 1920692K/2097152K available (24448K kernel code, 7094K rwdata, 26372K rodata, 4736K init, 1107K bss, 132852K reserved, 32768K cma-reserved)330server # [ 0.011049] 508272 pages in range for PLT usage331host1 # [ 0.008604] devtmpfs: initialized332server # [ 0.011146] pinctrl core: initialized pinctrl subsystem333server # [ 0.011971] DMI not present or invalid.334host1 # [ 0.010481] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)335server # [ 0.015176] NET: Registered PF_NETLINK/PF_ROUTE protocol family336host1 # [ 0.010502] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).337server # [ 0.017543] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations338host1 # [ 0.010699] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL339host1 # [ 0.010703] 0 pages in range for non-PLT usage340server # [ 0.017710] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations341host1 # [ 0.010704] 508272 pages in range for PLT usage342server # [ 0.017902] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations343host1 # [ 0.010783] pinctrl core: initialized pinctrl subsystem344host1 # [ 0.011532] DMI not present or invalid.345server # [ 0.017924] audit: initializing netlink subsys (disabled)346server # [ 0.018460] thermal_sys: Registered thermal governor 'fair_share'347server # [ 0.018462] thermal_sys: Registered thermal governor 'bang_bang'348server # [ 0.018466] thermal_sys: Registered thermal governor 'step_wise'349server # [ 0.018469] thermal_sys: Registered thermal governor 'user_space'350server # [ 0.018471] thermal_sys: Registered thermal governor 'power_allocator'351server # [ 0.018504] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1352server # [ 0.018513] cpuidle: using governor ladder353server # [ 0.018518] cpuidle: using governor menu354server # [ 0.018694] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.355server # [ 0.018710] ASID allocator initialised with 65536 entries356server # [ 0.019866] Serial: AMBA PL011 UART driver357host1 # [ 0.014689] NET: Registered PF_NETLINK/PF_ROUTE protocol family358server # [ 0.025103] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1359host1 # [ 0.016898] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations360server # [ 0.025220] printk: console [ttyAMA0] enabled361host1 # [ 0.017075] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations362server # [ 0.157213] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages363host1 # [ 0.017267] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations364server # [ 0.157232] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page365host1 # [ 0.017287] audit: initializing netlink subsys (disabled)366host1 # [ 0.017837] thermal_sys: Registered thermal governor 'fair_share'367server # [ 0.157238] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages368host1 # [ 0.017839] thermal_sys: Registered thermal governor 'bang_bang'369server # [ 0.157242] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page370host1 # [ 0.017842] thermal_sys: Registered thermal governor 'step_wise'371server # [ 0.157247] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages372host1 # [ 0.017845] thermal_sys: Registered thermal governor 'user_space'373server # [ 0.157251] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page374host1 # [ 0.017848] thermal_sys: Registered thermal governor 'power_allocator'375server # [ 0.157256] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages376host1 # [ 0.017888] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1377server # [ 0.157261] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page378host1 # [ 0.017897] cpuidle: using governor ladder379host1 # [ 0.017902] cpuidle: using governor menu380host1 # [ 0.018101] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.381server # [ 0.165336] fbcon: Taking over console382host1 # [ 0.018115] ASID allocator initialised with 65536 entries383server # [ 0.165352] ACPI: Interpreter disabled.384host1 # [ 0.019233] Serial: AMBA PL011 UART driver385host1 # [ 0.024496] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1386host1 # [ 0.024617] printk: console [ttyAMA0] enabled387host1 # [ 0.154156] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages388host1 # [ 0.154175] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page389host1 # [ 0.154181] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages390host1 # [ 0.154185] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page391host1 # [ 0.154190] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages392host1 # [ 0.154195] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page393server # [ 0.173838] iommu: Default domain type: Translated394host1 # [ 0.154199] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages395server # [ 0.173848] iommu: DMA domain TLB invalidation policy: strict mode396host1 # [ 0.154204] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page397server # [ 0.174181] SCSI subsystem initialized398server # [ 0.176271] usbcore: registered new interface driver usbfs399server # [ 0.176309] usbcore: registered new interface driver hub400host1 # [ 0.162420] fbcon: Taking over console401server # [ 0.176331] usbcore: registered new device driver usb402host1 # [ 0.162435] ACPI: Interpreter disabled.403server # [ 0.176609] pps_core: LinuxPPS API ver. 1 registered404server # [ 0.176616] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>405server # [ 0.176626] PTP clock support registered406server # [ 0.176675] EDAC MC: Ver: 3.0.0407server # [ 0.181663] scmi_core: SCMI protocol bus registered408server # [ 0.182684] FPGA manager framework409server # [ 0.183697] vgaarb: loaded410server # [ 0.184347] clocksource: Switched to clocksource arch_sys_counter411host1 # [ 0.169976] iommu: Default domain type: Translated412host1 # [ 0.169987] iommu: DMA domain TLB invalidation policy: strict mode413host1 # [ 0.171756] SCSI subsystem initialized414server # [ 0.186295] VFS: Disk quotas dquot_6.6.0415server # [ 0.186333] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)416host1 # [ 0.172451] usbcore: registered new interface driver usbfs417host1 # [ 0.172483] usbcore: registered new interface driver hub418host1 # [ 0.172498] usbcore: registered new device driver usb419host1 # [ 0.172780] pps_core: LinuxPPS API ver. 1 registered420server # [ 0.190583] netfs: FS-Cache loaded421server # [ 0.190689] pnp: PnP ACPI: disabled422host1 # [ 0.172787] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>423host1 # [ 0.172797] PTP clock support registered424host1 # [ 0.172852] EDAC MC: Ver: 3.0.0425host1 # [ 0.177840] scmi_core: SCMI protocol bus registered426host1 # [ 0.178863] FPGA manager framework427host1 # [ 0.179846] vgaarb: loaded428host1 # [ 0.180488] clocksource: Switched to clocksource arch_sys_counter429server # [ 0.194762] NET: Registered PF_INET protocol family430server # [ 0.195040] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)431host1 # [ 0.183498] VFS: Disk quotas dquot_6.6.0432host1 # [ 0.183533] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)433host1 # [ 0.187399] netfs: FS-Cache loaded434host1 # [ 0.187528] pnp: PnP ACPI: disabled435host1 # [ 0.191510] NET: Registered PF_INET protocol family436host1 # [ 0.191793] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)437server # [ 0.224019] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)438server # [ 0.224060] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)439server # [ 0.224087] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)440server # [ 0.224159] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)441server # [ 0.224302] TCP: Hash tables configured (established 16384 bind 16384)442server # [ 0.229415] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)443server # [ 0.229451] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)444server # [ 0.229490] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)445server # [ 0.229581] NET: Registered PF_UNIX/PF_LOCAL protocol family446server # [ 0.229602] NET: Registered PF_XDP protocol family447server # [ 0.229621] PCI: CLS 0 bytes, default 64448server # [ 0.229858] Trying to unpack rootfs image as initramfs...449host1 # [ 0.221764] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)450host1 # [ 0.221808] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)451host1 # [ 0.221837] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)452host1 # [ 0.222008] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)453host1 # [ 0.222152] TCP: Hash tables configured (established 16384 bind 16384)454server # [ 0.241767] kvm [1]: HYP mode not available455host1 # [ 0.222233] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)456host1 # [ 0.222268] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)457host1 # [ 0.222306] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)458host1 # [ 0.222395] NET: Registered PF_UNIX/PF_LOCAL protocol family459host1 # [ 0.222433] NET: Registered PF_XDP protocol family460host1 # [ 0.222450] PCI: CLS 0 bytes, default 64461host1 # [ 0.222689] Trying to unpack rootfs image as initramfs...462host1 # [ 0.238809] kvm [1]: HYP mode not available463server # [ 0.332931] Initialise system trusted keyrings464server # [ 0.333688] workingset: timestamp_bits=42 max_order=19 bucket_order=0465server # [ 0.334975] squashfs: version 4.0 (2009/01/31) Phillip Lougher466server # [ 0.335804] 9p: Installing v9fs 9p2000 file system support467host1 # [ 0.329032] Initialise system trusted keyrings468host1 # [ 0.329781] workingset: timestamp_bits=42 max_order=19 bucket_order=0469host1 # [ 0.331138] squashfs: version 4.0 (2009/01/31) Phillip Lougher470host1 # [ 0.331937] 9p: Installing v9fs 9p2000 file system support471server # [ 0.364615] Key type asymmetric registered472server # [ 0.364642] Asymmetric key parser 'x509' registered473server # [ 0.364715] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)474server # [ 0.366981] io scheduler mq-deadline registered475server # [ 0.366991] io scheduler kyber registered476host1 # [ 0.360678] Key type asymmetric registered477host1 # [ 0.360708] Asymmetric key parser 'x509' registered478host1 # [ 0.360788] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)479server # [ 0.376496] pl061_gpio 9030000.pl061: PL061 GPIO chip registered480host1 # [ 0.363075] io scheduler mq-deadline registered481host1 # [ 0.363087] io scheduler kyber registered482server # [ 0.378028] ledtrig-cpu: registered to indicate activity on CPUs483server # [ 0.378454] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:484server # [ 0.378472] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000485server # [ 0.378484] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000486server # [ 0.378493] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000487server # [ 0.378513] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits488server # [ 0.378539] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]489server # [ 0.378618] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00490host1 # [ 0.372636] pl061_gpio 9030000.pl061: PL061 GPIO chip registered491server # [ 0.378628] pci_bus 0000:00: root bus resource [bus 00-ff]492server # [ 0.378634] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]493server # [ 0.378639] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]494server # [ 0.378645] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]495host1 # [ 0.374064] ledtrig-cpu: registered to indicate activity on CPUs496host1 # [ 0.374443] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:497server # [ 0.378699] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint498server # [ 0.379148] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint499host1 # [ 0.374459] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000500server # [ 0.379338] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]501host1 # [ 0.374472] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000502server # [ 0.379355] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]503server # [ 0.379385] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]504host1 # [ 0.374480] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000505server # [ 0.379402] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]506host1 # [ 0.374508] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits507server # [ 0.379884] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint508host1 # [ 0.374534] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]509server # [ 0.380098] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]510host1 # [ 0.374622] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00511server # [ 0.380114] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]512host1 # [ 0.374632] pci_bus 0000:00: root bus resource [bus 00-ff]513server # [ 0.380144] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]514host1 # [ 0.374638] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]515host1 # [ 0.374644] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]516host1 # [ 0.374649] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]517host1 # [ 0.374740] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint518host1 # [ 0.375187] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint519server # [ 0.400998] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint520host1 # [ 0.375380] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]521server # [ 0.401196] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]522host1 # [ 0.375397] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]523server # [ 0.401213] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]524host1 # [ 0.375428] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]525server # [ 0.401244] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]526host1 # [ 0.375445] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]527server # [ 0.401725] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint528host1 # [ 0.375920] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint529server # [ 0.401924] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]530host1 # [ 0.376108] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]531server # [ 0.401941] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]532host1 # [ 0.376125] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]533server # [ 0.401973] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]534host1 # [ 0.376155] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]535server # [ 0.401990] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]536server # [ 0.402474] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint537server # [ 0.402676] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]538server # [ 0.402708] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]539server # [ 0.403235] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint540host1 # [ 0.396977] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint541server # [ 0.403429] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]542host1 # [ 0.397170] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]543server # [ 0.403460] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]544host1 # [ 0.397187] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]545server # [ 0.403864] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint546host1 # [ 0.397218] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]547server # [ 0.404054] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]548host1 # [ 0.397685] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint549server # [ 0.404307] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint550host1 # [ 0.397875] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]551host1 # [ 0.397891] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]552host1 # [ 0.397974] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]553host1 # [ 0.397991] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]554host1 # [ 0.398453] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint555host1 # [ 0.398646] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]556host1 # [ 0.398677] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]557host1 # [ 0.399146] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint558host1 # [ 0.399340] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]559host1 # [ 0.399370] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560server # [ 0.424557] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]561host1 # [ 0.399773] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint562server # [ 0.424599] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]563host1 # [ 0.399961] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]564server # [ 0.425157] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint565host1 # [ 0.400255] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint566server # [ 0.425356] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]567host1 # [ 0.400449] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]568server # [ 0.425388] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]569host1 # [ 0.400479] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]570server # [ 0.425853] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint571server # [ 0.426045] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]572server # [ 0.426076] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]573server # [ 0.426556] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint574server # [ 0.426830] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]575server # [ 0.426848] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]576server # [ 0.426879] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]577server # [ 0.427347] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint578server # [ 0.427537] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]579server # [ 0.427554] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]580server # [ 0.427584] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]581server # [ 0.428169] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned582server # [ 0.428181] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned583server # [ 0.428187] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned584server # [ 0.428234] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned585server # [ 0.428283] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned586server # [ 0.428331] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned587host1 # [ 0.429108] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint588host1 # [ 0.429320] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]589host1 # [ 0.429352] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]590host1 # [ 0.429821] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint591host1 # [ 0.430072] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]592host1 # [ 0.430103] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]593host1 # [ 0.430586] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint594server # [ 0.452452] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned595host1 # [ 0.430869] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]596server # [ 0.452513] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned597host1 # [ 0.430887] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]598server # [ 0.452563] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned599host1 # [ 0.430918] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]600server # [ 0.452612] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned601host1 # [ 0.431388] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint602host1 # [ 0.431578] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]603server # [ 0.452662] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned604host1 # [ 0.431594] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]605server # [ 0.452711] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned606host1 # [ 0.431625] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]607server # [ 0.452824] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned608host1 # [ 0.432217] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned609server # [ 0.452875] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned610host1 # [ 0.432229] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned611server # [ 0.452899] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned612host1 # [ 0.432235] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned613server # [ 0.452922] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned614host1 # [ 0.432284] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned615server # [ 0.452946] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned616host1 # [ 0.432333] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned617server # [ 0.452969] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned618server # [ 0.453000] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned619host1 # [ 0.432382] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned620server # [ 0.453021] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned621host1 # [ 0.432433] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned622server # [ 0.453045] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned623host1 # [ 0.432483] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned624server # [ 0.453071] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned625host1 # [ 0.432558] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned626server # [ 0.453094] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned627host1 # [ 0.432607] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned628server # [ 0.453117] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned629server # [ 0.453140] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned630host1 # [ 0.432655] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned631server # [ 0.453163] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned632host1 # [ 0.432703] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned633server # [ 0.453185] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned634host1 # [ 0.432768] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned635server # [ 0.453207] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned636host1 # [ 0.432816] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned637server # [ 0.453230] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned638server # [ 0.453252] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned639host1 # [ 0.432839] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned640server # [ 0.453275] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned641host1 # [ 0.432861] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned642server # [ 0.453303] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]643host1 # [ 0.432883] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned644server # [ 0.453314] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]645host1 # [ 0.432905] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned646server # [ 0.453319] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]647host1 # [ 0.432928] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned648server # [ 0.454162] pci 0000:00:07.0: enabling device (0000 -> 0002)649host1 # [ 0.432950] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned650host1 # [ 0.432974] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned651host1 # [ 0.432999] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned652host1 # [ 0.433022] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned653host1 # [ 0.433045] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned654host1 # [ 0.433069] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned655host1 # [ 0.433091] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned656host1 # [ 0.433113] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned657host1 # [ 0.433134] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned658host1 # [ 0.433156] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned659host1 # [ 0.433178] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned660host1 # [ 0.433200] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned661host1 # [ 0.433227] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]662host1 # [ 0.433237] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]663host1 # [ 0.433242] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]664host1 # [ 0.434071] pci 0000:00:07.0: enabling device (0000 -> 0002)665server # [ 0.506907] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)666server # [ 0.513089] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)667server # [ 0.515116] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)668host1 # [ 0.501852] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)669host1 # [ 0.504092] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)670server # [ 0.525295] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)671server # [ 0.527322] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)672host1 # [ 0.514594] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)673server # [ 0.531246] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)674host1 # [ 0.517425] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)675host1 # [ 0.519780] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)676server # [ 0.536951] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)677server # [ 0.538743] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)678host1 # [ 0.529986] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)679host1 # [ 0.531657] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)680host1 # [ 0.535111] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)681server # [ 0.548559] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)682server # [ 0.550484] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)683server # [ 0.552911] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)684host1 # [ 0.541407] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)685host1 # [ 0.543910] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)686server # [ 0.565880] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled687host1 # [ 0.554694] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)688server # [ 0.573621] msm_serial: driver initialized689server # [ 0.573774] SuperH (H)SCI(F) driver initialized690server # [ 0.573827] STM32 USART driver initialized691host1 # [ 0.569725] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled692host1 # [ 0.572382] msm_serial: driver initialized693host1 # [ 0.573123] SuperH (H)SCI(F) driver initialized694host1 # [ 0.573183] STM32 USART driver initialized695server # [ 0.603597] loop: module loaded696server # [ 0.603774] virtio_blk virtio2: 1/0/0 default/read/poll queues697server # [ 0.612614] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)698host1 # [ 0.605051] loop: module loaded699host1 # [ 0.605234] virtio_blk virtio2: 1/0/0 default/read/poll queues700host1 # [ 0.606116] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)701server # [ 0.615425] megasas: 07.734.00.00-rc1702server # [ 0.616089] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]703server # [ 0.626214] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000704server # [ 0.626239] Intel/Sharp Extended Query Table at 0x0031705server # [ 0.627839] Using buffer write method706server # [ 0.627905] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]707host1 # [ 0.613063] megasas: 07.734.00.00-rc1708host1 # [ 0.613774] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]709host1 # [ 0.615771] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000710host1 # [ 0.615836] Intel/Sharp Extended Query Table at 0x0031711host1 # [ 0.617497] Using buffer write method712host1 # [ 0.617571] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]713host1 # [ 0.619494] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000714host1 # [ 0.619517] Intel/Sharp Extended Query Table at 0x0031715server # [ 0.649610] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000716server # [ 0.649642] Intel/Sharp Extended Query Table at 0x0031717server # [ 0.651433] Using buffer write method718host1 # [ 0.638658] Using buffer write method719server # [ 0.651459] Concatenating MTD devices:720host1 # [ 0.638693] Concatenating MTD devices:721server # [ 0.651463] (0): "0.flash"722host1 # [ 0.638698] (0): "0.flash"723server # [ 0.651467] (1): "0.flash"724host1 # [ 0.638702] (1): "0.flash"725server # [ 0.651471] into device "0.flash"726host1 # [ 0.638706] into device "0.flash"727server # [ 0.893602] Freeing initrd memory: 26948K728server # [ 0.899634] tun: Universal TUN/TAP device driver, 1.6729server # [ 0.903513] thunder_xcv, ver 1.0730host1 # [ 0.889539] Freeing initrd memory: 26972K731server # [ 0.903557] thunder_bgx, ver 1.0732server # [ 0.903597] nicpf, ver 1.0733server # [ 0.904138] e1000: Intel(R) PRO/1000 Network Driver734server # [ 0.904147] e1000: Copyright (c) 1999-2006 Intel Corporation.735server # [ 0.904171] e1000e: Intel(R) PRO/1000 Network Driver736server # [ 0.904179] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.737server # [ 0.904207] igb: Intel(R) Gigabit Ethernet Network Driver738server # [ 0.904213] igb: Copyright (c) 2007-2014 Intel Corporation.739server # [ 0.904235] igbvf: Intel(R) Gigabit Virtual Function Network Driver740host1 # [ 0.895479] tun: Universal TUN/TAP device driver, 1.6741server # [ 0.904241] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.742server # [ 0.911384] sky2: driver version 1.30743host1 # [ 0.899190] thunder_xcv, ver 1.0744host1 # [ 0.899235] thunder_bgx, ver 1.0745host1 # [ 0.899282] nicpf, ver 1.0746server # [ 0.913078] usbcore: registered new interface driver usb-storage747host1 # [ 0.899815] e1000: Intel(R) PRO/1000 Network Driver748server # [ 0.913213] usbcore: registered new interface driver usbserial_generic749host1 # [ 0.899822] e1000: Copyright (c) 1999-2006 Intel Corporation.750server # [ 0.913231] usbserial: USB Serial support registered for generic751host1 # [ 0.899846] e1000e: Intel(R) PRO/1000 Network Driver752server # [ 0.913814] hv_vmbus: registering driver hyperv_keyboard753host1 # [ 0.899854] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.754server # [ 0.915010] ehci-pci 0000:00:07.0: EHCI Host Controller755host1 # [ 0.899881] igb: Intel(R) Gigabit Ethernet Network Driver756server # [ 0.915037] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1757host1 # [ 0.899887] igb: Copyright (c) 2007-2014 Intel Corporation.758server # [ 0.915203] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000759host1 # [ 0.899909] igbvf: Intel(R) Gigabit Virtual Function Network Driver760host1 # [ 0.899915] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.761host1 # [ 0.900047] sky2: driver version 1.30762server # [ 0.921594] rtc-pl031 9010000.pl031: registered as rtc0763server # [ 0.921622] rtc-pl031 9010000.pl031: setting system clock to 2026-09-25T16:49:43 UTC (1790354983)764server # [ 0.921949] i2c_dev: i2c /dev entries driver765server # [ 0.925174] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00766server # [ 0.925439] hub 1-0:1.0: USB hub found767host1 # [ 0.909145] usbcore: registered new interface driver usb-storage768server # [ 0.925476] hub 1-0:1.0: 6 ports detected769host1 # [ 0.909255] usbcore: registered new interface driver usbserial_generic770host1 # [ 0.909268] usbserial: USB Serial support registered for generic771host1 # [ 0.909839] hv_vmbus: registering driver hyperv_keyboard772host1 # [ 0.911277] ehci-pci 0000:00:07.0: EHCI Host Controller773host1 # [ 0.911304] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1774host1 # [ 0.911470] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000775server # [ 0.929992] sdhci: Secure Digital Host Controller Interface driver776server # [ 0.930005] sdhci: Copyright(c) Pierre Ossman777host1 # [ 0.917114] rtc-pl031 9010000.pl031: registered as rtc0778server # [ 0.930272] Synopsys Designware Multimedia Card Interface Driver779host1 # [ 0.917142] rtc-pl031 9010000.pl031: setting system clock to 2026-09-25T16:49:43 UTC (1790354983)780server # [ 0.930641] sdhci-pltfm: SDHCI platform and OF driver helper781host1 # [ 0.917465] i2c_dev: i2c /dev entries driver782server # [ 0.932148] hid: raw HID events driver (C) Jiri Kosina783host1 # [ 0.920663] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00784server # [ 0.936032] usbcore: registered new interface driver usbhid785host1 # [ 0.920977] hub 1-0:1.0: USB hub found786server # [ 0.936047] usbhid: USB HID core driver787host1 # [ 0.920997] hub 1-0:1.0: 6 ports detected788server # [ 0.938463] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available789server # [ 0.939956] drop_monitor: Initializing network drop monitor service790server # [ 0.940094] NET: Registered PF_INET6 protocol family791server # [ 0.943273] Segment Routing with IPv6792host1 # [ 0.925392] sdhci: Secure Digital Host Controller Interface driver793server # [ 0.943292] In-situ OAM (IOAM) with IPv6794host1 # [ 0.925404] sdhci: Copyright(c) Pierre Ossman795server # [ 0.943320] NET: Registered PF_PACKET protocol family796host1 # [ 0.925669] Synopsys Designware Multimedia Card Interface Driver797host1 # [ 0.926096] sdhci-pltfm: SDHCI platform and OF driver helper798host1 # [ 0.927547] hid: raw HID events driver (C) Jiri Kosina799host1 # [ 0.927764] usbcore: registered new interface driver usbhid800host1 # [ 0.927774] usbhid: USB HID core driver801server # [ 0.945131] 9pnet: Installing 9P2000 support802server # [ 0.945176] Key type dns_resolver registered803host1 # [ 0.933620] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available804host1 # [ 0.935203] drop_monitor: Initializing network drop monitor service805host1 # [ 0.935332] NET: Registered PF_INET6 protocol family806server # [ 0.951981] registered taskstats version 1807server # [ 0.952137] Loading compiled-in X.509 certificates808host1 # [ 0.938416] Segment Routing with IPv6809host1 # [ 0.938439] In-situ OAM (IOAM) with IPv6810host1 # [ 0.938466] NET: Registered PF_PACKET protocol family811host1 # [ 0.940149] 9pnet: Installing 9P2000 support812host1 # [ 0.940195] Key type dns_resolver registered813server # [ 0.960883] Demotion targets for Node 0: null814server # [ 0.960981] Key type .fscrypt registered815server # [ 0.960991] Key type fscrypt-provisioning registered816server # [ 0.961088] ima: No TPM chip found, activating TPM-bypass!817host1 # [ 0.946931] registered taskstats version 1818server # [ 0.961107] ima: Allocated hash algorithm: sha1819host1 # [ 0.947085] Loading compiled-in X.509 certificates820server # [ 0.961128] ima: No architecture policies found821server # [ 0.965564] input: gpio-keys as /devices/platform/gpio-keys/input/input0822host1 # [ 0.955890] Demotion targets for Node 0: null823host1 # [ 0.955996] Key type .fscrypt registered824host1 # [ 0.956008] Key type fscrypt-provisioning registered825host1 # [ 0.956100] ima: No TPM chip found, activating TPM-bypass!826host1 # [ 0.956119] ima: Allocated hash algorithm: sha1827host1 # [ 0.956141] ima: No architecture policies found828host1 # [ 0.960532] input: gpio-keys as /devices/platform/gpio-keys/input/input0829server # [ 0.982856] clk: Disabling unused clocks830server # [ 0.982881] PM: genpd: Disabling unused power domains831server # [ 0.987131] Freeing unused kernel memory: 4736K832server # [ 0.987316] Run /init as init process833host1 # [ 0.977807] clk: Disabling unused clocks834host1 # [ 0.977831] PM: genpd: Disabling unused power domains835host1 # [ 0.982129] Freeing unused kernel memory: 4736K836host1 # [ 0.982298] Run /init as init process837server # [ 1.002614] systemd[1]: Successfully made /usr/ read-only.838host1 # [ 0.998703] systemd[1]: Successfully made /usr/ read-only.839server # [ 1.172392] usb 1-1: new high-speed USB device number 2 using ehci-pci840host1 # [ 1.168533] usb 1-1: new high-speed USB device number 2 using ehci-pci841server # [ 1.322147] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1842host1 # [ 1.318164] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1843server # [ 1.337295] 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)844server # [ 1.343142] systemd[1]: Detected virtualization qemu.845server # [ 1.344083] systemd[1]: Detected architecture arm64.846server # [ 1.345049] systemd[1]: Running in initrd.847server # [ 1.346289] systemd[1]: Initializing machine ID from random generator.848server # [ 1.347590] systemd[1]: Hostname set to <server>.849host1 # [ 1.333390] 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)850host1 # [ 1.339898] systemd[1]: Detected virtualization qemu.851host1 # [ 1.340981] systemd[1]: Detected architecture arm64.852host1 # [ 1.342037] systemd[1]: Running in initrd.853host1 # [ 1.343444] systemd[1]: Initializing machine ID from random generator.854host1 # [ 1.344994] systemd[1]: Hostname set to <host1>.855server # [ 1.400559] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0856host1 # [ 1.396712] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0857server # [ 1.520401] usb 1-2: new high-speed USB device number 3 using ehci-pci858host1 # [ 1.516553] usb 1-2: new high-speed USB device number 3 using ehci-pci859server # [ 1.589937] systemd[1]: bpf-restrict-fs: LSM BPF program attached860host1 # [ 1.616137] systemd[1]: bpf-restrict-fs: LSM BPF program attached861server # [ 1.647535] systemd[1]: Queued start job for default target Initrd Default Target.862server # [ 1.658508] systemd[1]: Created slice Slice /system/modprobe.863server # [ 1.659573] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.864server # [ 1.660705] systemd[1]: Expecting device /dev/disk/by-label/nixos...865server # [ 1.661582] systemd[1]: Reached target Path Units.866server # [ 1.662239] systemd[1]: Reached target Slice Units.867server # [ 1.662942] systemd[1]: Reached target Swaps.868server # [ 1.663542] systemd[1]: Reached target Timer Units.869server # [ 1.664342] systemd[1]: Listening on D-Bus System Message Bus Socket.870server # [ 1.665478] systemd[1]: Listening on Journal Socket (/dev/log).871server # [ 1.666433] systemd[1]: Listening on Journal Sockets.872server # [ 1.667228] systemd[1]: Listening on udev Control Socket.873server # [ 1.668049] systemd[1]: Listening on udev Kernel Socket.874server # [ 1.668995] systemd[1]: Reached target Socket Units.875server # [ 1.671167] systemd[1]: Starting Create List of Static Device Nodes...876server # [ 1.672282] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs877server # [ 1.678451] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2878server # [ 1.680213] systemd[1]: Mounting Kernel Configuration File System...879host1 # [ 1.666094] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2880server # [ 1.683149] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0881host1 # [ 1.666257] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0882server # [ 1.692599] systemd[1]: Starting Journal Service...883host1 # [ 1.695226] systemd[1]: Queued start job for default target Initrd Default Target.884server # [ 1.716905] systemd[1]: Starting Load Kernel Modules...885server # [ 1.717850] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os886host1 # [ 1.706987] systemd[1]: Created slice Slice /system/modprobe.887host1 # [ 1.708176] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.888host1 # [ 1.709530] systemd[1]: Expecting device /dev/disk/by-label/nixos...889host1 # [ 1.710566] systemd[1]: Reached target Path Units.890host1 # [ 1.711347] systemd[1]: Reached target Slice Units.891host1 # [ 1.712195] systemd[1]: Reached target Swaps.892host1 # [ 1.712977] systemd[1]: Reached target Timer Units.893host1 # [ 1.713971] systemd[1]: Listening on D-Bus System Message Bus Socket.894host1 # [ 1.715150] systemd[1]: Listening on Journal Socket (/dev/log).895host1 # [ 1.716228] systemd[1]: Listening on Journal Sockets.896host1 # [ 1.717231] systemd[1]: Listening on udev Control Socket.897host1 # [ 1.717347] systemd[1]: Listening on udev Kernel Socket.898host1 # [ 1.717369] systemd[1]: Reached target Socket Units.899host1 # [ 1.721566] systemd[1]: Starting Create List of Static Device Nodes...900server # [ 1.736639] systemd[1]: Starting Coldplug All udev Devices...901host1 # [ 1.722693] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs902server # [ 1.738892] systemd-journald[72]: Collecting audit messages is disabled.903host1 # [ 1.730293] systemd[1]: Mounting Kernel Configuration File System...904host1 # [ 1.740768] systemd[1]: Starting Journal Service...905server # [ 1.756581] systemd[1]: Finished Create List of Static Device Nodes.906server # [ 1.757402] systemd[1]: Mounted Kernel Configuration File System.907server # [ 1.772775] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...908host1 # [ 1.764993] systemd[1]: Starting Load Kernel Modules...909host1 # [ 1.765116] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os910host1 # [ 1.784738] systemd[1]: Starting Coldplug All udev Devices...911server # [ 1.798640] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.912host1 # [ 1.787586] systemd-journald[72]: Collecting audit messages is disabled.913host1 # [ 1.801224] systemd[1]: Finished Create List of Static Device Nodes.914host1 # [ 1.802015] systemd[1]: Mounted Kernel Configuration File System.915server # [ 1.824464] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev916server # [ 1.830823] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0917server # [ 1.831062] [drm] features: -virgl +edid -resource_blob -host_visible918server # [ 1.831073] [drm] features: -context_init919server # [ 1.831806] [drm] number of scanouts: 1920server # [ 1.831826] [drm] number of cap sets: 0921host1 # [ 1.820917] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...922server # [ 1.845092] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.923server # [ 1.848726] systemd[1]: Starting Create Static Device Nodes in /dev...924host1 # [ 1.850684] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.925server # [ 1.860491] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic926server # [ 1.860512] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0927server # [ 1.880710] Console: switching to colour frame buffer device 160x50928server # [ 1.884936] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device929host1 # [ 1.868550] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev930host1 # [ 1.875007] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0931host1 # [ 1.875248] [drm] features: -virgl +edid -resource_blob -host_visible932host1 # [ 1.875258] [drm] features: -context_init933host1 # [ 1.875972] [drm] number of scanouts: 1934host1 # [ 1.875990] [drm] number of cap sets: 0935host1 # [ 1.885104] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.936host1 # [ 1.887619] systemd[1]: Starting Create Static Device Nodes in /dev...937server # [ 1.905776] systemd[1]: Finished Create Static Device Nodes in /dev.938server # [ 1.906140] systemd[1]: Reached target Preparation for Local File Systems.939server # [ 1.906175] systemd[1]: Reached target Local File Systems.940server # [ 1.911138] systemd[1]: Starting Rule-based Manager for Device Events and Files...941server # [ 1.906563] systemd-modules-load[74]: Inserted module 'dm_mod'942host1 # [ 1.904847] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic943server # [ 1.907714] systemd-modules-load[74]: Module 'virtio_balloon' is built in944host1 # [ 1.904864] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0945server # [ 1.929425] systemd[1]: Finished Load Kernel Modules.946server # [ 1.931348] systemd[1]: Started Journal Service.947server # [ 1.921379] systemd-modules-load[74]: Module 'virtio_console' is built in948server # [ 1.923966] systemd-modules-load[74]: Inserted module 'virtio_gpu'949server # [ 1.928423] systemd-modules-load[74]: Module 'virtio_rng' is built in950host1 # [ 1.932840] Console: switching to colour frame buffer device 160x50951server # [ 1.933351] systemd[1]: Starting Apply Kernel Variables...952host1 # [ 1.941165] systemd[1]: Finished Create Static Device Nodes in /dev.953host1 # [ 1.941534] systemd[1]: Reached target Preparation for Local File Systems.954host1 # [ 1.941562] systemd[1]: Reached target Local File Systems.955host1 # [ 1.945782] systemd[1]: Starting Rule-based Manager for Device Events and Files...956server # [ 1.949160] systemd[1]: Starting Create System Files and Directories...957host1 # [ 1.957136] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device958host1 # [ 1.965114] systemd[1]: Finished Load Kernel Modules.959host1 # [ 1.980942] systemd[1]: Starting Apply Kernel Variables...960host1 # [ 1.970028] systemd-modules-load[74]: Inserted module 'dm_mod'961host1 # [ 1.971408] systemd-modules-load[74]: Module 'virtio_balloon' is built in962host1 # [ 1.972656] systemd-modules-load[74]: Module 'virtio_console' is built in963host1 # [ 1.990283] systemd[1]: Started Journal Service.964host1 # [ 1.976312] systemd-modules-load[74]: Inserted module 'virtio_gpu'965host1 # [ 1.981346] systemd-modules-load[74]: Module 'virtio_rng' is built in966server # [ 1.994084] systemd-udevd[78]: Using default interface naming scheme 'v261'.967server # [ 2.001149] systemd[1]: Finished Create System Files and Directories.968server # [ 2.002213] systemd[1]: Finished Apply Kernel Variables.969host1 # [ 2.000103] systemd[1]: Starting Create System Files and Directories...970server # [ 2.026880] systemd[1]: Started Rule-based Manager for Device Events and Files.971host1 # [ 2.029166] systemd[1]: Finished Apply Kernel Variables.972host1 # [ 2.038838] systemd-udevd[78]: Using default interface naming scheme 'v261'.973host1 # [ 2.041672] systemd[1]: Finished Create System Files and Directories.974host1 # [ 2.074160] systemd[1]: Started Rule-based Manager for Device Events and Files.975server # [ 2.092966] systemd[1]: Starting Virtual Console Setup...976host1 # [ 2.132107] systemd[1]: Starting Virtual Console Setup...977server # [ 2.163743] systemd-vconsole-setup[102]: Configuration of first virtual console was skipped, ignoring remaining ones.978server # [ 2.172264] systemd[1]: Finished Virtual Console Setup.979host1 # [ 2.184454] systemd-vconsole-setup[101]: Configuration of first virtual console was skipped, ignoring remaining ones.980host1 # [ 2.188058] systemd[1]: Finished Virtual Console Setup.981server # [ 2.800998] systemd[1]: Finished Coldplug All udev Devices.982server # [ 2.801970] systemd[1]: Reached target System Initialization.983server # [ 2.804098] systemd[1]: Reached target Basic System.984host1 # [ 2.849710] systemd[1]: Finished Coldplug All udev Devices.985host1 # [ 2.850662] systemd[1]: Reached target System Initialization.986host1 # [ 2.851493] systemd[1]: Reached target Basic System.987server # [ 2.968317] (udev-worker)[93]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.988server # [ 2.999361] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.989host1 # [ 2.992095] (udev-worker)[92]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.990server # [ 3.005540] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.991host1 # [ 3.022804] (udev-worker)[92]: Network interface NamePolicy= disabled on kernel command line.992host1 # [ 3.033211] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.993server # [ 3.092691] systemd[1]: Found device /dev/disk/by-label/nixos.994server # [ 3.095824] systemd[1]: Reached target Initrd Root Device.995server # [ 3.098411] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...996host1 # [ 3.116133] systemd[1]: Found device /dev/disk/by-label/nixos.997host1 # [ 3.119165] systemd[1]: Reached target Initrd Root Device.998host1 # [ 3.122802] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...999server # [ 3.139131] systemd-fsck[115]: nixos: clean, 12/65536 files, 13019/262144 blocks1000server # [ 3.148085] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1001server # [ 3.152187] systemd[1]: Mounting /sysroot...1002host1 # [ 3.169175] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks1003host1 # [ 3.175598] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1004server # [ 3.206200] EXT4-fs (vda): mounted filesystem 1bd5aeee-649c-4dec-b277-a557bf034b1d r/w with ordered data mode. Quota mode: none.1005host1 # [ 3.180264] systemd[1]: Mounting /sysroot...1006server # [ 3.192632] systemd[1]: Mounted /sysroot.1007server # [ 3.194477] systemd[1]: Reached target Initrd Root File System.1008server # [ 3.206400] systemd[1]: Starting Mountpoints Configured in the Real Root...1009server # [ 3.216355] systemd-sysroot-fstab-check[123]: /sysroot should be mounted in the initrd, will request daemon-reload.1010host1 # [ 3.226220] EXT4-fs (vda): mounted filesystem b7a81090-2ea1-4b9d-bb6b-51cb255f6c35 r/w with ordered data mode. Quota mode: none.1011server # [ 3.222913] systemd[1]: Reload requested from client PID 123 ('systemd-sysroot') (unit initrd-parse-etc.service)...1012host1 # [ 3.216701] systemd[1]: Mounted /sysroot.1013server # [ 3.228239] systemd[1]: Reloading...1014host1 # [ 3.218472] systemd[1]: Reached target Initrd Root File System.1015host1 # [ 3.223278] systemd[1]: Starting Mountpoints Configured in the Real Root...1016host1 # [ 3.251739] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.1017host1 # [ 3.257347] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...1018host1 # [ 3.262380] systemd[1]: Reloading...1019server # [ 3.430930] systemd[1]: Reloading finished in 205 ms.1020server # [ 3.463828] systemd-sysroot-fstab-check[123]: Requesting initrd-fs.target/start/replace...1021server # [ 3.468269] systemd-sysroot-fstab-check[123]: Requesting swap.target/start/replace...1022server # [ 3.474985] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1023host1 # [ 3.464133] systemd[1]: Reloading finished in 203 ms.1024server # [ 3.477359] systemd[1]: Finished Mountpoints Configured in the Real Root.1025server # [ 3.479246] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1026host1 # [ 3.495993] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...1027host1 # [ 3.500215] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...1028host1 # [ 3.506416] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1029host1 # [ 3.509313] systemd[1]: Finished Mountpoints Configured in the Real Root.1030host1 # [ 3.511373] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1031server # [ 3.732906] systemd[1]: Mounting /sysroot/nix/.ro-store...1032server # [ 3.750081] systemd[1]: Mounting /sysroot/nix/.rw-store...1033server # [ 3.754726] systemd[1]: Mounting /sysroot/run...1034server # [ 3.773370] systemd[1]: Mounting /sysroot/tmp/shared...1035server # [ 3.792855] systemd[1]: Mounting /sysroot/tmp/xchg...1036host1 # [ 3.788236] systemd[1]: Mounting /sysroot/nix/.ro-store...1037host1 # [ 3.800774] systemd[1]: Mounting /sysroot/nix/.rw-store...1038server # [ 3.824239] systemd[1]: Mounted /sysroot/nix/.rw-store.1039host1 # [ 3.814376] systemd[1]: Mounting /sysroot/run...1040host1 # [ 3.823940] systemd[1]: Mounting /sysroot/tmp/shared...1041server # [ 3.860065] fuse: init (API version 7.45)1042host1 # [ 3.838618] systemd[1]: Mounting /sysroot/tmp/xchg...1043server # [ 3.851094] systemd[1]: Starting rw-sysroot-nix-store.service...1044server # [ 3.879836] virtiofs virtio6: discovered new tag: nix-store1045server # [ 3.885177] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1046server # [ 3.901992] virtiofs virtio7: discovered new tag: shared1047server # [ 3.902823] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1048server # [ 3.888918] systemd[1]: Mounted /sysroot/run.1049server # [ 3.913106] virtiofs virtio8: discovered new tag: xchg1050server # [ 3.913875] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1051host1 # [ 3.910039] fuse: init (API version 7.45)1052host1 # [ 3.916003] virtiofs virtio6: discovered new tag: nix-store1053server # [ 3.914315] systemd[1]: Mounted /sysroot/tmp/shared.1054server # [ 3.918500] systemd[1]: Mounted /sysroot/nix/.ro-store.1055host1 # [ 3.923671] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1056server # [ 3.921247] systemd[1]: Mounted /sysroot/tmp/xchg.1057server # [ 3.923658] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1058server # [ 3.927436] systemd[1]: Finished rw-sysroot-nix-store.service.1059host1 # [ 3.939286] virtiofs virtio7: discovered new tag: shared1060host1 # [ 3.940043] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1061host1 # [ 3.945848] virtiofs virtio8: discovered new tag: xchg1062host1 # [ 3.946599] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1063host1 # [ 3.937745] systemd[1]: Mounted /sysroot/nix/.rw-store.1064host1 # [ 3.946588] systemd[1]: Mounted /sysroot/run.1065host1 # [ 3.955380] systemd[1]: Mounted /sysroot/nix/.ro-store.1066host1 # [ 3.959339] systemd[1]: Mounted /sysroot/tmp/shared.1067host1 # [ 3.960863] systemd[1]: Mounted /sysroot/tmp/xchg.1068host1 # [ 3.970130] systemd[1]: Starting rw-sysroot-nix-store.service...1069host1 # [ 3.995817] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1070host1 # [ 3.997445] systemd[1]: Finished rw-sysroot-nix-store.service.1071server # [ 4.379175] (udev-worker)[92]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1072server # [ 4.385368] (udev-worker)[92]: mtd0ro: /etc/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 directory1073server # [ 4.416136] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1074server # [ 4.419146] systemd[1]: Stopped Virtual Console Setup.1075server # [ 4.423987] systemd[1]: Stopping Virtual Console Setup...1076server # [ 4.425199] systemd[1]: Starting Virtual Console Setup...1077host1 # [ 4.417914] (udev-worker)[106]: mtd0ro: Failed to find and pin callout binary "/nix/store/gnadg5slifq2r638xvz4pv6vrsdl9xkj-systemd-261.2/lib/udev/mtd_probe": No such file or directory1078host1 # [ 4.423075] (udev-worker)[106]: mtd0ro: /etc/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 directory1079server # [ 4.439004] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1080server # [ 4.440672] systemd[1]: Stopped Virtual Console Setup.1081server # [ 4.444227] systemd[1]: Starting Virtual Console Setup...1082host1 # [ 4.460079] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1083host1 # [ 4.461213] systemd[1]: Stopped Virtual Console Setup.1084server # [ 4.471993] systemd-vconsole-setup[161]: Configuration of first virtual console was skipped, ignoring remaining ones.1085host1 # [ 4.463042] systemd[1]: Stopping Virtual Console Setup...1086server # [ 4.475265] systemd[1]: Finished Virtual Console Setup.1087host1 # [ 4.468444] systemd[1]: Starting Virtual Console Setup...1088host1 # [ 4.469791] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1089host1 # [ 4.471253] systemd[1]: Stopped Virtual Console Setup.1090host1 # [ 4.480843] systemd[1]: Starting Virtual Console Setup...1091host1 # [ 4.508734] systemd-vconsole-setup[157]: Configuration of first virtual console was skipped, ignoring remaining ones.1092host1 # [ 4.512079] systemd[1]: Finished Virtual Console Setup.1093server # [ 4.732928] systemd[1]: Mounting /sysroot/nix/store...1094server # [ 4.777358] systemd[1]: Mounted /sysroot/nix/store.1095server # [ 4.780176] systemd[1]: Reached target Initrd File Systems.1096server # [ 4.783433] systemd[1]: Starting Find NixOS closure...1097server # [ 4.792344] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1098host1 # [ 4.788121] systemd[1]: Mounting /sysroot/nix/store...1099server # [ 4.832172] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1100host1 # [ 4.828455] systemd[1]: Mounted /sysroot/nix/store.1101server # [ 4.838483] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1102host1 # [ 4.831976] systemd[1]: Reached target Initrd File Systems.1103host1 # [ 4.836294] systemd[1]: Starting Find NixOS closure...1104server # [ 4.848115] systemd[1]: Finished Find NixOS closure.1105server # [ 4.849839] systemd[1]: Reached target Initrd Default Target.1106host1 # [ 4.839196] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1107server # [ 4.853077] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1108server # [ 4.882867] systemd[1]: Stopped target Initrd Default Target.1109server # [ 4.884560] systemd[1]: Stopped target Basic System.1110server # [ 4.887817] systemd[1]: Stopped target Initrd Root Device.1111server # [ 4.888964] systemd[1]: Stopped target Path Units.1112server # [ 4.890459] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1113host1 # [ 4.881808] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1114server # [ 4.894436] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1115host1 # [ 4.885229] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1116server # [ 4.897629] systemd[1]: Stopped target Slice Units.1117server # [ 4.899726] systemd[1]: Stopped target Socket Units.1118server # [ 4.901922] systemd[1]: Stopped target System Initialization.1119server # [ 4.903910] systemd[1]: Stopped target Swaps.1120host1 # [ 4.897301] systemd[1]: Finished Find NixOS closure.1121server # [ 4.908822] systemd[1]: Stopped target Timer Units.1122server # [ 4.909626] systemd[1]: dbus.socket: Deactivated successfully.1123server # [ 4.910512] systemd[1]: Closed D-Bus System Message Bus Socket.1124host1 # [ 4.899689] systemd[1]: Reached target Initrd Default Target.1125server # [ 4.911413] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1126host1 # [ 4.904311] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1127server # [ 4.917896] systemd[1]: Stopped Find NixOS closure.1128server # [ 4.918662] systemd[1]: Starting rw-sysroot-nix-store.service...1129server # [ 4.919526] systemd[1]: systemd-sysctl.service: Deactivated successfully.1130server # [ 4.921570] systemd[1]: Stopped Apply Kernel Variables.1131server # [ 4.922345] systemd[1]: systemd-modules-load.service: Deactivated successfully.1132server # [ 4.923363] systemd[1]: Stopped Load Kernel Modules.1133server # [ 4.930420] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1134server # [ 4.934175] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1135host1 # [ 4.928704] systemd[1]: initrd-cleanup.service: Deactivated successfully.1136server # [ 4.940659] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1137server # [ 4.941826] systemd[1]: Stopped Create System Files and Directories.1138host1 # [ 4.930523] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1139server # [ 4.943924] systemd[1]: Stopped target Local File Systems.1140host1 # [ 4.934336] systemd[1]: Stopped target Initrd Default Target.1141host1 # [ 4.935423] systemd[1]: Stopped target Basic System.1142server # [ 4.947304] systemd[1]: Stopped target Preparation for Local File Systems.1143host1 # [ 4.936924] systemd[1]: Stopped target Initrd Root Device.1144server # [ 4.948708] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1145server # [ 4.949986] systemd[1]: Stopped Coldplug All udev Devices.1146server # [ 4.950809] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1147host1 # [ 4.940539] systemd[1]: Stopped target Path Units.1148server # [ 4.951866] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1149server # [ 4.953180] systemd[1]: Stopped Virtual Console Setup.1150server # [ 4.953947] systemd[1]: initrd-cleanup.service: Deactivated successfully.1151server # [ 4.954905] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1152host1 # [ 4.944238] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1153server # [ 4.955862] systemd[1]: systemd-udevd.service: Deactivated successfully.1154host1 # [ 4.945642] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1155host1 # [ 4.946941] systemd[1]: Stopped target Slice Units.1156host1 # [ 4.947784] systemd[1]: Stopped target Socket Units.1157server # [ 4.960282] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1158server # [ 4.964176] systemd[1]: systemd-udevd.service: Consumed 1.497s CPU time over 3.041s wall clock time, 27.3M memory peak.1159server # [ 4.968148] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1160server # [ 4.969270] systemd[1]: Closed udev Control Socket.1161host1 # [ 4.958616] systemd[1]: Stopped target System Initialization.1162server # [ 4.969990] systemd[1]: Starting Cleanup udev Database...1163server # [ 4.972193] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1164host1 # [ 4.962944] systemd[1]: Stopped target Swaps.1165host1 # [ 4.963815] systemd[1]: Stopped target Timer Units.1166host1 # [ 4.964831] systemd[1]: dbus.socket: Deactivated successfully.1167server # [ 4.976123] systemd[1]: Stopped Create Static Device Nodes in /dev.1168host1 # [ 4.965750] systemd[1]: Closed D-Bus System Message Bus Socket.1169server # [ 4.977063] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1170host1 # [ 4.966641] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1171server # [ 4.978226] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1172host1 # [ 4.967768] systemd[1]: Stopped Find NixOS closure.1173server # [ 4.984392] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1174server # [ 4.985443] systemd[1]: Stopped Create List of Static Device Nodes.1175server # [ 4.986341] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1176server # [ 4.987359] systemd[1]: Finished rw-sysroot-nix-store.service.1177host1 # [ 4.976162] systemd[1]: Starting rw-sysroot-nix-store.service...1178host1 # [ 4.984573] systemd[1]: systemd-sysctl.service: Deactivated successfully.1179host1 # [ 4.985687] systemd[1]: Stopped Apply Kernel Variables.1180host1 # [ 4.986482] systemd[1]: systemd-modules-load.service: Deactivated successfully.1181host1 # [ 4.987495] systemd[1]: Stopped Load Kernel Modules.1182host1 # [ 4.990084] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1183host1 # [ 4.991252] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1184host1 # [ 4.992457] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1185host1 # [ 4.993519] systemd[1]: Stopped Create System Files and Directories.1186host1 # [ 4.994431] systemd[1]: Stopped target Local File Systems.1187host1 # [ 4.995235] systemd[1]: Stopped target Preparation for Local File Systems.1188server # [ 5.008764] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1189server # [ 5.010361] systemd[1]: Finished Cleanup udev Database.1190server # [ 5.012564] systemd[1]: Reached target Switch Root.1191server # [ 5.014835] systemd[1]: Starting NixOS Activation...1192host1 # [ 5.004226] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1193host1 # [ 5.005299] systemd[1]: Stopped Coldplug All udev Devices.1194host1 # [ 5.006379] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1195host1 # [ 5.007477] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1196host1 # [ 5.012247] systemd[1]: Stopped Virtual Console Setup.1197host1 # [ 5.013018] systemd[1]: systemd-udevd.service: Deactivated successfully.1198host1 # [ 5.014013] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1199host1 # [ 5.015032] systemd[1]: systemd-udevd.service: Consumed 1.453s CPU time over 3.045s wall clock time, 24.1M memory peak.1200host1 # [ 5.020479] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1201host1 # [ 5.021537] systemd[1]: Closed udev Control Socket.1202host1 # [ 5.022254] systemd[1]: Starting Cleanup udev Database...1203host1 # [ 5.024132] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1204host1 # [ 5.028418] systemd[1]: Stopped Create Static Device Nodes in /dev.1205host1 # [ 5.029480] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1206host1 # [ 5.032197] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1207host1 # [ 5.033239] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1208host1 # [ 5.036304] systemd[1]: Stopped Create List of Static Device Nodes.1209host1 # [ 5.037234] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1210host1 # [ 5.040235] systemd[1]: Finished rw-sysroot-nix-store.service.1211host1 # [ 5.054885] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1212host1 # [ 5.060494] systemd[1]: Finished Cleanup udev Database.1213host1 # [ 5.061453] systemd[1]: Reached target Switch Root.1214host1 # [ 5.062196] systemd[1]: Starting NixOS Activation...1215server # [ 5.086513] initrd-nixos-activation-start[185]: booting system configuration /nix/store/1vq7rykwv3sxqhqlwlk6900a14v5jj6y-nixos-system-server-test1216server # [ 5.115551] initrd-nixos-activation-start[185]: running activation script...1217host1 # [ 5.132467] initrd-nixos-activation-start[181]: booting system configuration /nix/store/v6baswar5glbvvh4a5zadjbgwblwy97q-nixos-system-host1-test1218host1 # [ 5.161755] initrd-nixos-activation-start[181]: running activation script...1219server # [ 5.328621] initrd-nixos-activation-start[208]: setting up /etc...1220host1 # [ 5.366401] initrd-nixos-activation-start[204]: setting up /etc...1221server # [ 5.439077] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1222server # [ 5.442008] systemd[1]: Finished NixOS Activation.1223server # [ 5.443105] systemd[1]: Starting Switch Root...1224server # [ 5.467264] systemd[1]: Switching root.1225host1 # [ 5.476476] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1226host1 # [ 5.479293] systemd[1]: Finished NixOS Activation.1227host1 # [ 5.484192] systemd[1]: Starting Switch Root...1228host1 # [ 5.503022] systemd[1]: Switching root.1229server # [ 5.657326] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1230host1 # [ 5.686040] systemd-journald[72]: Received SIGTERM from PID 1 (systemd).1231server # [ 6.140869] 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)1232server # [ 6.148012] systemd[1]: Detected virtualization qemu.1233server # [ 6.149994] systemd[1]: Detected architecture arm64.1234server # [ 6.152339] systemd[1]: Detected first boot.1235server # [ 6.155721] systemd[1]: Initializing machine ID from random generator.1236host1 # [ 6.149433] 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)1237host1 # [ 6.156323] systemd[1]: Detected virtualization qemu.1238host1 # [ 6.158363] systemd[1]: Detected architecture arm64.1239host1 # [ 6.160949] systemd[1]: Detected first boot.1240host1 # [ 6.164399] systemd[1]: Initializing machine ID from random generator.1241server # [ 6.421669] systemd[1]: bpf-restrict-fs: LSM BPF program attached1242host1 # [ 6.426884] systemd[1]: bpf-restrict-fs: LSM BPF program attached1243server # [ 6.577305] systemd[1]: Applying preset policy.1244host1 # [ 6.579122] systemd[1]: Applying preset policy.1245server # [ 6.781669] systemd[1]: Populated /etc with preset unit settings.1246host1 # [ 6.781728] systemd[1]: Populated /etc with preset unit settings.1247server # [ 6.990353] systemd[1]: initrd-switch-root.service: Deactivated successfully.1248server # [ 6.992001] systemd[1]: Stopped initrd-switch-root.service.1249server # [ 6.995221] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1250server # [ 6.999411] systemd[1]: Created slice Slice /system/getty.1251server # [ 7.001507] systemd[1]: Created slice User and Session Slice.1252host1 # [ 6.986668] systemd[1]: initrd-switch-root.service: Deactivated successfully.1253server # [ 7.002766] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1254host1 # [ 6.988382] systemd[1]: Stopped initrd-switch-root.service.1255server # [ 7.004348] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1256server # [ 7.005851] systemd[1]: Expecting device /dev/hvc0...1257server # [ 7.007492] systemd[1]: Expecting device /dev/ttyAMA0...1258host1 # [ 6.992382] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1259server # [ 7.009314] systemd[1]: Reached target Local Encrypted Volumes.1260server # [ 7.010469] systemd[1]: Stopped target initrd-fs.target.1261host1 # [ 6.996722] systemd[1]: Created slice Slice /system/getty.1262server # [ 7.011697] systemd[1]: Stopped target initrd-root-fs.target.1263host1 # [ 6.998753] systemd[1]: Created slice User and Session Slice.1264server # [ 7.013513] systemd[1]: Stopped target initrd-switch-root.target.1265host1 # [ 7.000043] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1266server # [ 7.015181] systemd[1]: Reached target Virtual Machines and Containers.1267server # [ 7.017074] systemd[1]: Reached target Path Units.1268host1 # [ 7.001909] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1269server # [ 7.018064] systemd[1]: Reached target Remote File Systems.1270host1 # [ 7.004009] systemd[1]: Expecting device /dev/hvc0...1271server # [ 7.019805] systemd[1]: Reached target Slice Units.1272host1 # [ 7.005819] systemd[1]: Expecting device /dev/ttyAMA0...1273server # [ 7.020901] systemd[1]: Reached target Swaps.1274host1 # [ 7.006947] systemd[1]: Reached target Local Encrypted Volumes.1275host1 # [ 7.008336] systemd[1]: Stopped target initrd-fs.target.1276server # [ 7.023829] systemd[1]: Listening on Query the User Interactively for a Password.1277host1 # [ 7.009632] systemd[1]: Stopped target initrd-root-fs.target.1278server # [ 7.026845] systemd[1]: Listening on Process Core Dump Socket.1279host1 # [ 7.011523] systemd[1]: Stopped target initrd-switch-root.target.1280host1 # [ 7.013364] systemd[1]: Reached target Virtual Machines and Containers.1281server # [ 7.029005] systemd[1]: Listening on Credential Encryption/Decryption.1282host1 # [ 7.015188] systemd[1]: Reached target Path Units.1283server # [ 7.031266] systemd[1]: Listening on Factory Reset Management.1284host1 # [ 7.016189] systemd[1]: Reached target Remote File Systems.1285host1 # [ 7.017610] systemd[1]: Reached target Slice Units.1286server # [ 7.032586] systemd[1]: Listening on Hostname Service Socket.1287host1 # [ 7.018904] systemd[1]: Reached target Swaps.1288host1 # [ 7.021552] systemd[1]: Listening on Query the User Interactively for a Password.1289server # [ 7.037084] systemd[1]: Starting Journal Log Access Socket...1290server # [ 7.038714] systemd[1]: Listening on Journal Audit Socket.1291host1 # [ 7.024556] systemd[1]: Listening on Process Core Dump Socket.1292server # [ 7.041508] systemd[1]: Listening on Console Output Muting Service Socket.1293host1 # [ 7.026747] systemd[1]: Listening on Credential Encryption/Decryption.1294server # [ 7.043056] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1295host1 # [ 7.029122] systemd[1]: Listening on Factory Reset Management.1296server # [ 7.044490] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1297host1 # [ 7.030497] systemd[1]: Listening on Hostname Service Socket.1298server # [ 7.046589] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1299host1 # [ 7.034260] systemd[1]: Starting Journal Log Access Socket...1300host1 # [ 7.036387] systemd[1]: Listening on Journal Audit Socket.1301server # [ 7.052072] systemd[1]: Listening on Disk Repartitioning Service Socket.1302server # [ 7.053481] systemd[1]: Listening on udev Control Socket.1303server # [ 7.054664] systemd[1]: Listening on udev Varlink Socket.1304host1 # [ 7.039902] systemd[1]: Listening on Console Output Muting Service Socket.1305host1 # [ 7.041602] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1306server # [ 7.057743] systemd[1]: Mounting Huge Pages File System...1307host1 # [ 7.044406] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1308server # [ 7.060916] systemd[1]: Mounting POSIX Message Queue File System...1309host1 # [ 7.046061] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1310host1 # [ 7.050727] systemd[1]: Listening on Disk Repartitioning Service Socket.1311host1 # [ 7.052081] systemd[1]: Listening on udev Control Socket.1312host1 # [ 7.053636] systemd[1]: Listening on udev Varlink Socket.1313host1 # [ 7.057368] systemd[1]: Mounting Huge Pages File System...1314server # [ 7.073059] systemd[1]: Mounting Kernel Debug File System...1315host1 # [ 7.064827] systemd[1]: Mounting POSIX Message Queue File System...1316server # [ 7.080613] systemd[1]: Mounting Kernel Trace File System...1317server # [ 7.091722] systemd[1]: Starting Create List of Static Device Nodes...1318host1 # [ 7.076616] systemd[1]: Mounting Kernel Debug File System...1319server # [ 7.094769] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1320host1 # [ 7.083935] systemd[1]: Mounting Kernel Trace File System...1321server # [ 7.109640] systemd[1]: Mounting Kernel Configuration File System...1322server # [ 7.110001] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1323host1 # [ 7.099002] systemd[1]: Starting Create List of Static Device Nodes...1324server # [ 7.110269] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1325server # [ 7.110529] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1326host1 # [ 7.102482] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1327host1 # [ 7.116185] systemd[1]: Mounting Kernel Configuration File System...1328server # [ 7.132961] systemd[1]: Mounting FUSE Control File System...1329server # [ 7.133358] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671330host1 # [ 7.120716] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1331host1 # [ 7.126796] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1332host1 # [ 7.129531] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1333host1 # [ 7.152761] systemd[1]: Mounting FUSE Control File System...1334server # [ 7.169631] systemd[1]: Starting Journal Service...1335host1 # [ 7.154108] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671336server # [ 7.191763] systemd[1]: Starting Load Kernel Modules...1337server # [ 7.201445] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1338host1 # [ 7.194441] systemd[1]: Starting Journal Service...1339server # [ 7.210467] systemd[1]: Starting Remount Root and Kernel File Systems...1340server # [ 7.212477] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1341server # [ 7.221296] systemd[1]: Starting Coldplug All udev Devices...1342host1 # [ 7.208240] systemd[1]: Starting Load Kernel Modules...1343server # [ 7.226834] systemd[1]: Listening on Journal Log Access Socket.1344server # [ 7.232169] systemd[1]: Mounted Huge Pages File System.1345server # [ 7.234197] systemd[1]: Mounted POSIX Message Queue File System.1346server # [ 7.236648] systemd[1]: Mounted Kernel Debug File System.1347server # [ 7.237119] systemd[1]: Mounted Kernel Trace File System.1348server # [ 7.237487] systemd[1]: Mounted Kernel Configuration File System.1349server # [ 7.237847] systemd[1]: Mounted FUSE Control File System.1350host1 # [ 7.231504] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1351host1 # [ 7.242255] systemd[1]: Starting Remount Root and Kernel File Systems...1352host1 # [ 7.242620] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1353host1 # [ 7.259346] systemd[1]: Starting Coldplug All udev Devices...1354host1 # [ 7.263320] systemd[1]: Listening on Journal Log Access Socket.1355host1 # [ 7.270366] systemd-journald[274]: Collecting audit messages is enabled.1356server # [ 7.287143] systemd[1]: Finished Create List of Static Device Nodes.1357server # [ 7.292540] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1358host1 # [ 7.281368] systemd[1]: Mounted Huge Pages File System.1359host1 # [ 7.283992] systemd[1]: Mounted POSIX Message Queue File System.1360host1 # [ 7.275303] systemd[1]: Queued start job for default target Multi-User System.1361host1 # [ 7.280455] systemd[1]: systemd-journald.service: Deactivated successfully.1362host1 # [ 7.281933] systemd-modules-load[275]: Module 'atkbd' is built in1363host1 # [ 7.282969] systemd-modules-load[275]: Module 'loop' is built in1364host1 # [ 7.307582] systemd[1]: Started Journal Service.1365host1 # [ 7.299370] systemd[1]: Mounted Kernel Debug File System.1366host1 # [ 7.302056] systemd[1]: Mounted Kernel Trace File System.1367server # [ 7.338192] EXT4-fs (vda): re-mounted 1bd5aeee-649c-4dec-b277-a557bf034b1d.1368host1 # [ 7.309045] systemd[1]: Finished Create List of Static Device Nodes.1369host1 # [ 7.310112] systemd[1]: Mounted Kernel Configuration File System.1370server # [ 7.342410] systemd[1]: Finished Load Kernel Modules.1371server # [ 7.346638] systemd-journald[278]: Collecting audit messages is enabled.1372host1 # [ 7.316689] systemd[1]: Finished Load Kernel Modules.1373server # [ 7.349583] systemd[1]: Starting Firewall...1374host1 # [ 7.332141] systemd[1]: Mounted FUSE Control File System.1375server # [ 7.369592] systemd[1]: Starting Apply Kernel Variables...1376server # [ 7.372542] systemd[1]: Finished Remount Root and Kernel File Systems.1377host1 # [ 7.360728] EXT4-fs (vda): re-mounted b7a81090-2ea1-4b9d-bb6b-51cb255f6c35.1378server # [ 7.373150] systemd[1]: Listening on Disk Image Download Service Socket.1379server # [ 7.373463] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1380host1 # [ 7.348264] systemd[1]: Starting Firewall...1381host1 # [ 7.358155] systemd[1]: Starting Apply Kernel Variables...1382server # [ 7.389129] systemd[1]: Starting Load/Save OS Random Seed...1383host1 # [ 7.361286] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1384server # [ 7.392455] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1385host1 # [ 7.383182] systemd[1]: Finished Remount Root and Kernel File Systems.1386host1 # [ 7.384511] systemd[1]: Listening on Disk Image Download Service Socket.1387host1 # [ 7.394364] systemd[1]: Starting Flush Journal to Persistent Storage...1388host1 # [ 7.395385] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1389server # [ 7.409861] systemd[1]: Queued start job for default target Multi-User System.1390server # [ 7.431352] systemd[1]: Started Journal Service.1391server # [ 7.413343] systemd[1]: systemd-journald.service: Deactivated successfully.1392host1 # [ 7.406518] systemd-oomd[277]: No swap; memory pressure usage will be degraded1393host1 # [ 7.407887] systemd[1]: Starting Load/Save OS Random Seed...1394server # [ 7.428257] systemd-modules-load[279]: Module 'atkbd' is built in1395host1 # [ 7.424519] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1396host1 # [ 7.434439] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1397server # [ 7.447161] systemd-modules-load[279]: Module 'loop' is built in1398server # [ 7.455262] systemd[1]: Starting Flush Journal to Persistent Storage...1399server # [ 7.489599] systemd-oomd[280]: No swap; memory pressure usage will be degraded1400server # [ 7.504166] systemd[1]: Finished Load/Save OS Random Seed.1401server # [ 7.514912] systemd[1]: Reached target First Boot Complete.1402server # [ 7.515808] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1403host1 # [ 7.523083] systemd-journald[274]: Received client request to flush runtime journal.1404server # [ 7.533415] systemd[1]: Finished Apply Kernel Variables.1405server # [ 7.569713] systemd-journald[278]: Received client request to flush runtime journal.1406host1 # [ 7.576872] systemd[1]: Finished Apply Kernel Variables.1407host1 # [ 7.577829] systemd[1]: Finished Load/Save OS Random Seed.1408host1 # [ 7.578657] systemd[1]: Reached target First Boot Complete.1409host1 # [ 7.586888] systemd[1]: Finished Flush Journal to Persistent Storage.1410server # [ 7.602766] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1411server # [ 7.603994] systemd[1]: Starting Create Static Device Nodes in /dev...1412server # [ 7.612527] systemd[1]: Finished Flush Journal to Persistent Storage.1413host1 # [ 7.632349] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1414host1 # [ 7.644706] systemd[1]: Starting Create Static Device Nodes in /dev...1415server # [ 7.722793] systemd[1]: Finished Create Static Device Nodes in /dev.1416server # [ 7.728681] systemd[1]: Reached target Preparation for Local File Systems.1417server # [ 7.733331] systemd[1]: Starting Rule-based Manager for Device Events and Files...1418host1 # [ 7.781275] systemd[1]: Finished Create Static Device Nodes in /dev.1419host1 # [ 7.784202] systemd[1]: Reached target Preparation for Local File Systems.1420host1 # [ 7.789055] systemd[1]: Starting Rule-based Manager for Device Events and Files...1421server # [ 7.846135] systemd-udevd[318]: Using default interface naming scheme 'v261'.1422host1 # [ 7.928827] systemd-udevd[316]: Using default interface naming scheme 'v261'.1423server # [ 7.974671] systemd[1]: Mounting /run/wrappers...1424host1 # [ 7.980270] systemd[1]: Mounting /run/wrappers...1425server # [ 8.000856] systemd[1]: Started Rule-based Manager for Device Events and Files.1426host1 # [ 8.031578] systemd[1]: Mounted /run/wrappers.1427host1 # [ 8.032888] systemd[1]: Reached target Local File Systems.1428server # [ 8.050222] systemd[1]: Mounted /run/wrappers.1429server # [ 8.051033] systemd[1]: Reached target Local File Systems.1430server # [ 8.051823] systemd[1]: Listening on Boot Loader Control Service Socket.1431host1 # [ 8.040273] systemd[1]: Listening on Boot Loader Control Service Socket.1432host1 # [ 8.044160] systemd[1]: Starting register-nix-paths.service...1433host1 # [ 8.049607] systemd[1]: Starting Create SUID/SGID Wrappers...1434host1 # [ 8.050517] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1435host1 # [ 8.059585] systemd[1]: Starting Save Transient machine-id to Disk...1436server # [ 8.071605] systemd[1]: Starting register-nix-paths.service...1437host1 # [ 8.062822] systemd[1]: Starting Create System Files and Directories...1438server # [ 8.080823] systemd[1]: Starting Create SUID/SGID Wrappers...1439server # [ 8.088378] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1440server # [ 8.095352] systemd[1]: Starting Save Transient machine-id to Disk...1441host1 # [ 8.087613] systemd[1]: Started Rule-based Manager for Device Events and Files.1442server # [ 8.106370] systemd[1]: Starting Create System Files and Directories...1443server # [ 8.177761] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1444server # [ 8.183588] systemd[1]: Finished Save Transient machine-id to Disk.1445host1 # [ 8.201110] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1446host1 # [ 8.215315] systemd[1]: Finished Save Transient machine-id to Disk.1447server # [ 8.284372] systemd[1]: Finished Create System Files and Directories.1448server # [ 8.291231] systemd[1]: Starting Rebuild Journal Catalog...1449server # [ 8.305318] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1450host1 # [ 8.295615] systemd[1]: Finished Create System Files and Directories.1451host1 # [ 8.309333] systemd[1]: Starting Rebuild Journal Catalog...1452host1 # [ 8.314198] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1453server # [ 8.411923] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1454host1 # [ 8.437519] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1455host1 # [ 8.469595] systemd[1]: Finished Rebuild Journal Catalog.1456server # [ 8.481713] systemd[1]: Finished Rebuild Journal Catalog.1457server # [ 8.486673] systemd[1]: Starting Update is Completed...1458host1 # [ 8.484200] systemd[1]: Starting Update is Completed...1459host1 # [ 8.556501] systemd[1]: Finished Update is Completed.1460server # [ 8.620852] systemd[1]: Finished Update is Completed.1461server # [ 8.907445] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1462server # [ 8.912231] systemd[1]: Finished Create SUID/SGID Wrappers.1463server # [ 9.124511] systemd[1]: Finished Firewall.1464host1 # [ 9.132396] systemd[1]: Finished Coldplug All udev Devices.1465host1 # [ 9.193093] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1466host1 # [ 9.199984] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1467host1 # [ 9.202693] systemd[1]: Finished Create SUID/SGID Wrappers.1468host1 # [ 9.227154] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1469server # [ 9.462761] systemd[1]: Finished Coldplug All udev Devices.1470host1 # [ 9.463514] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1471server # [ 9.545528] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1472server # [ 9.575951] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1473host1 # [ 9.580170] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1474server # [ 9.618102] systemd[1]: Finished register-nix-paths.service.1475server # [ 9.620238] systemd[1]: Reached target System Initialization.1476server # [ 9.622440] systemd[1]: Started Renew ACME Certificate for server.1477server # [ 9.624372] systemd[1]: Started Discard unused filesystem blocks once a week.1478server # [ 9.632329] systemd[1]: Started Daily Cleanup of Temporary Directories.1479server # [ 9.642411] systemd[1]: Reached target Timer Units.1480server # [ 9.643229] systemd[1]: Listening on D-Bus System Message Bus Socket.1481server # [ 9.668298] systemd[1]: Listening on Nix Daemon Socket.1482server # [ 9.676648] systemd[1]: Listening on Nix worker-protocol over gRPC.1483server # [ 9.683866] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1484server # [ 9.696284] systemd[1]: Reached target Socket Units.1485server # [ 9.708222] systemd[1]: Reached target Basic System.1486server # [ 9.717747] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1487server # [ 9.736407] systemd[1]: Starting Import lastlog data into lastlog2 database...1488server # [ 9.746675] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1489server # [ 9.759616] systemd[1]: Starting Post-Boot Actions...1490server # [ 9.772177] systemd[1]: Started Reset console on configuration changes.1491server # [ 9.787089] systemd[1]: Starting resolvconf update...1492host1 # [ 9.776128] systemd[1]: Finished register-nix-paths.service.1493host1 # [ 9.777158] systemd[1]: Reached target System Initialization.1494host1 # [ 9.778106] systemd[1]: Started Renew ACME Certificate for host1.1495host1 # [ 9.778982] systemd[1]: Started Discard unused filesystem blocks once a week.1496host1 # [ 9.779995] systemd[1]: Started Daily Cleanup of Temporary Directories.1497server # [ 9.799955] systemd[1]: Starting step-ca-pki.service...1498host1 # [ 9.789657] systemd[1]: Reached target Timer Units.1499host1 # [ 9.790456] systemd[1]: Listening on D-Bus System Message Bus Socket.1500host1 # [ 9.791405] systemd[1]: Listening on Nix Daemon Socket.1501server # [ 9.811028] systemd[1]: Starting D-Bus System Message Bus...1502host1 # [ 9.801088] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1503host1 # [ 9.802437] systemd[1]: Reached target Socket Units.1504host1 # [ 9.803194] systemd[1]: Reached target Basic System.1505host1 # [ 9.803938] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1506server # [ 9.821663] systemd[1]: Finished Post-Boot Actions.1507host1 # [ 9.815711] systemd[1]: Started backdoor.service.1508host1 # [ 9.820318] systemd[1]: Starting Import lastlog data into lastlog2 database...1509host1 # [ 9.821801] (udev-worker)[343]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1510server # [ 9.842302] systemd[1]: Started Name Service Cache Daemon (nsncd).1511host1 # [ 9.837439] (udev-worker)[420]: Network interface NamePolicy= disabled on kernel command line.1512host1 # [ 9.838747] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1513server # [ 9.851566] systemd[1]: Reached target Host and Network Name Lookups.1514host1 # [ 9.843439] (udev-worker)[343]: Network interface NamePolicy= disabled on kernel command line.1515server # [ 9.860896] nsncd[504]: Sep 25 16:49:52.442 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1516host1 # [ 9.856820] systemd[1]: Starting Post-Boot Actions...1517server # [ 9.882377] acme-setup-privileged[502]: + set -euo pipefail1518server # [ 9.891081] acme-setup-privileged[502]: + cd /var/lib/acme1519host1 # [ 9.880966] systemd[1]: Started Reset console on configuration changes.1520server # [ 9.900136] acme-setup-privileged[502]: + chmod -R u=rwX,g=,o= .lego/accounts1521server # [ 9.905973] acme-setup-privileged[502]: + chown -R acme .lego/accounts1522server # [ 9.911933] systemd[1]: Reached target User and Group Name Lookups.1523server # [ 9.923762] acme-setup-privileged[502]: + for fixpath in server .lego/server1524host1 # [ 9.913153] systemd[1]: Starting resolvconf update...1525host1 # [ 9.919338] systemd[1]: Finished Firewall.1526server # [ 9.932707] acme-setup-privileged[502]: + '[' -d server ']'1527host1 # [ 9.931412] acme-setup-privileged[490]: + set -euo pipefail1528server # [ 9.939195] acme-setup-privileged[502]: + for fixpath in server .lego/server1529server # [ 9.945489] acme-setup-privileged[502]: + '[' -d .lego/server ']'1530host1 # [ 9.936301] acme-setup-privileged[490]: + cd /var/lib/acme1531host1 # [ 9.937131] acme-setup-privileged[490]: + chmod -R u=rwX,g=,o= .lego/accounts1532server # [ 9.952435] systemd[1]: Starting User Login Management...1533server # [ 9.960866] dbus-broker-launch[509]: Looking up NSS user entry for 'systemd-timesync'...1534host1 # [ 9.956540] acme-setup-privileged[490]: + chown -R acme .lego/accounts1535host1 # connecting to host...1536server # [ 9.971838] systemd[1]: Finished Import lastlog data into lastlog2 database.1537server # [ 9.978585] dbus-broker-launch[509]: NSS returned no entry for 'systemd-timesync'1538host1 # [ 9.975242] acme-setup-privileged[490]: + for fixpath in host1 .lego/host11539server # [ 9.988878] dbus-broker-launch[509]: Invalid user-name in /nix/store/x9c1gmxs67a50kqpcwagg5qx6gav0cv1-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1540host1 # [ 9.981794] acme-setup-privileged[490]: + '[' -d host1 ']'1541host1 # [ 9.982639] acme-setup-privileged[490]: + for fixpath in host1 .lego/host11542host1 # [ 9.983580] acme-setup-privileged[490]: + '[' -d .lego/host1 ']'1543server # [ 10.004761] systemd[1]: Started D-Bus System Message Bus.1544host1 # [ 10.017538] systemd[1]: Starting D-Bus System Message Bus...1545host1 # [ 10.021051] nsncd[494]: Sep 25 16:49:52.617 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1546host1 # [ 10.040425] systemd[1]: Started Name Service Cache Daemon (nsncd).1547server # [ 10.067964] dbus-broker-launch[509]: Ready1548host1 # [ 10.090828] systemd[1]: Finished Post-Boot Actions.1549host1 # [ 10.118355] systemd[1]: Reached target Host and Network Name Lookups.1550host1 # [ 10.125156] systemd[1]: Reached target User and Group Name Lookups.1551server # [ 10.148211] systemd-logind[533]: New seat seat0.1552server # [ 10.155024] systemd[1]: Started User Login Management.1553server # [ 10.163519] systemd[1]: Starting linger-users.service...1554host1 # [ 10.157938] systemd[1]: Starting User Login Management...1555server # [ 10.195114] acme-setup-start[538]: + set -euo pipefail1556server # [ 10.198818] acme-setup-start[538]: + test -e ca/key.pem1557server # [ 10.204260] acme-setup-start[538]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1558server # [ 10.217401] systemd[1]: Stopped target Host and Network Name Lookups.1559server # [ 10.231802] systemd[1]: Stopping Host and Network Name Lookups...1560server # [ 10.243784] systemd[1]: Stopped target User and Group Name Lookups.1561host1 # [ 10.236254] systemd[1]: Finished Import lastlog data into lastlog2 database.1562server # [ 10.249458] systemd[1]: Stopping User and Group Name Lookups...1563server # [ 10.255838] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1564server # [ 10.266190] systemd[1]: nscd.service: Deactivated successfully.1565server # [ 10.271804] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1566server # [ 10.279099] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1567server # [ 10.286911] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1568server # [ 10.308254] systemd[1]: linger-users.service: Deactivated successfully.1569server # [ 10.314296] systemd[1]: Finished linger-users.service.1570host1 # [ 10.299493] dbus-broker-launch[515]: Looking up NSS user entry for 'systemd-timesync'...1571host1 # [ 10.308130] dbus-broker-launch[515]: NSS returned no entry for 'systemd-timesync'1572host1 # [ 10.309184] dbus-broker-launch[515]: Invalid user-name in /nix/store/flsxa7d757b7zpdiv9wsbs42iawcisak-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1573host1 # [ 10.324429] acme-setup-start[526]: + set -euo pipefail1574host1 # [ 10.325278] acme-setup-start[526]: + test -e ca/key.pem1575host1 # [ 10.326101] acme-setup-start[526]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1576server # [ 10.349257] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1577server # [ 10.357006] systemd[1]: Starting Ensure certificate for server...1578host1 # [ 10.365761] systemd[1]: Started D-Bus System Message Bus.1579host1 # [ 10.367021] systemd-logind[539]: New seat seat0.1580host1 # [ 10.376767] systemd[1]: Started User Login Management.1581server # [ 10.390549] systemd[1]: Started Name Service Cache Daemon (nsncd).1582host1 # [ 10.381306] systemd[1]: Starting linger-users.service...1583server # [ 10.394912] systemd[1]: Reached target Host and Network Name Lookups.1584host1 # [ 10.387609] systemd-logind[539]: Watching system buttons on /dev/input/event0 (gpio-keys)1585server # [ 10.400171] nsncd[595]: Sep 25 16:49:52.991 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1586server # [ 10.411152] systemd[1]: Reached target User and Group Name Lookups.1587host1 # [ 10.418727] dbus-broker-launch[515]: Ready1588server # [ 10.429733] systemd[1]: Finished resolvconf update.1589host1 # [ 10.424402] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1590server # [ 10.434331] systemd[1]: Reached target Preparation for Network.1591server # [ 10.444583] systemd[1]: Starting DHCP Client...1592host1 # [ 10.434698] systemd[1]: Starting Ensure certificate for host1...1593server # [ 10.452168] systemd[1]: Starting Extra networking commands....1594server # [ 10.472999] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1595server # [ 10.481972] systemd[1]: Started backdoor.service.1596host1 # [ 10.476997] systemd[1]: Stopped target Host and Network Name Lookups.1597host1 # [ 10.478028] systemd[1]: Stopping Host and Network Name Lookups...1598host1 # [ 10.478909] systemd[1]: Stopped target User and Group Name Lookups.1599host1 # [ 10.479776] systemd[1]: Stopping User and Group Name Lookups...1600host1 # [ 10.496709] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1601host1 # [ 10.497816] systemd[1]: nscd.service: Deactivated successfully.1602host1 # [ 10.498770] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1603server # [ 10.515167] step-ca-pki-start[522]: Your certificate has been saved in root_ca.crt.1604server # [ 10.519528] step-ca-pki-start[522]: Your private key has been saved in root_ca.key.1605host1 # [ 10.510597] systemd[1]: linger-users.service: Deactivated successfully.1606host1 # [ 10.514888] systemd[1]: Finished linger-users.service.1607host1 # [ 10.527395] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1608host1 # [ 10.615410] systemd[1]: Started Name Service Cache Daemon (nsncd).1609server # [ 10.627491] acme-server-start[611]: Waiting to acquire lock in /run/acme/1610host1 # [ 10.620900] nsncd[604]: Sep 25 16:49:53.219 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1611server # connecting to host...1612host1 # [ 10.631661] systemd[1]: Reached target Host and Network Name Lookups.1613host1 # [ 10.634536] systemd[1]: Reached target User and Group Name Lookups.1614host1 # [ 10.635799] acme-host1-start[590]: Waiting to acquire lock in /run/acme/1615host1 # [ 10.639984] systemd[1]: Finished resolvconf update.1616host1 # [ 10.644628] systemd[1]: Reached target Preparation for Network.1617host1 # [ 10.645508] systemd[1]: Starting DHCP Client...1618host1 # [ 10.651069] systemd[1]: Starting Extra networking commands....1619server # [ 10.664360] acme-server-start[611]: + '[' -e out/acme-success ']'1620host1 # [ 10.651983] systemd[1]: Condition check resulted in Virtio network device being skipped.1621server # [ 10.670165] acme-server-start[611]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=1622host1 # [ 10.667178] systemd[1]: Starting Address configuration of eth1...1623host1 # [ 10.673956] acme-host1-start[590]: + '[' -e out/acme-success ']'1624host1 # [ 10.674855] acme-host1-start[590]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=1625server: Guest shell says: b'Spawning backdoor root shell...\n'1626host1 # [ 10.707003] acme-host1-start[631]: + cd host11627server # [ 10.723256] step-ca-pki-start[632]: Your certificate has been saved in intermediate_ca.crt.1628host1 # [ 10.707672] acme-host1-start[631]: + cp -vp cert.pem ../out/cert.pem1629server # [ 10.732987] step-ca-pki-start[632]: Your private key has been saved in intermediate_ca.key.1630host1 # [ 10.723142] acme-host1-start[632]: 'cert.pem' -> '../out/cert.pem'1631server # [ 10.734350] acme-server-start[661]: + cd server1632host1 # [ 10.731625] acme-host1-start[631]: + cp -vp key.pem ../out/key.pem1633server # [ 10.734969] acme-server-start[661]: + cp -vp cert.pem ../out/cert.pem1634server: connected to guest root shell1635server: (connecting took 11.09 seconds)1636server: (finished: waiting for the VM to finish booting, in 11.09 seconds)1637host1 # [ 10.736887] acme-host1-start[631]: 'key.pem' -> '../out/key.pem'1638host1 # [ 10.740680] acme-host1-start[590]: + cat out/cert.pem ca/cert.pem1639server # [ 10.756884] acme-server-start[663]: 'cert.pem' -> '../out/cert.pem'1640server # [ 10.757810] acme-server-start[661]: + cp -vp key.pem ../out/key.pem1641server # [ 10.765811] acme-server-start[661]: 'key.pem' -> '../out/key.pem'1642host1 # [ 10.759003] acme-host1-start[590]: + cp ca/cert.pem out/chain.pem1643server # [ 10.772144] acme-server-start[611]: + cat out/cert.pem ca/cert.pem1644host1 # [ 10.777728] acme-host1-start[590]: + cat out/key.pem out/fullchain.pem1645server # [ 10.789031] acme-server-start[611]: + cp ca/cert.pem out/chain.pem1646server # [ 10.796816] systemd[1]: Finished step-ca-pki.service.1647host1 # [ 10.791167] acme-host1-start[590]: + for fixpath in out certificates1648host1 # [ 10.797397] acme-host1-start[590]: + '[' -d out ']'1649host1 # [ 10.798161] acme-host1-start[590]: + chmod -R u=rwX,g=rX,o= out1650server # [ 10.810453] acme-server-start[611]: + cat out/key.pem out/fullchain.pem1651host1 # [ 10.808318] acme-host1-start[590]: + chown -R acme:acme out1652server # [ 10.820003] acme-server-start[611]: + for fixpath in out certificates1653server # [ 10.821101] acme-server-start[611]: + '[' -d out ']'1654server # [ 10.821789] acme-server-start[611]: + chmod -R u=rwX,g=rX,o= out1655server # [ 10.838489] acme-server-start[611]: + chown -R acme:nix-grpc-daemon out1656host1 # [ 10.837570] acme-host1-start[590]: + for fixpath in out certificates1657host1 # [ 10.838532] acme-host1-start[590]: + '[' -d certificates ']'1658server # [ 10.857907] acme-server-start[611]: + for fixpath in out certificates1659server # [ 10.858860] acme-server-start[611]: + '[' -d certificates ']'1660host1 # [ 10.851177] systemd[1]: Finished Ensure certificate for host1.1661host1 # [ 10.860537] network-addresses-eth1-start[625]: adding address 192.168.1.1/24... done1662host1 # [ 10.882302] mousedev: PS/2 mouse device common for all mice1663server # [ 10.883997] systemd[1]: Finished Ensure certificate for server.1664server # [ 10.890657] dhcpcd[640]: dhcpcd-10.3.2 starting1665host1 # [ 10.888716] network-addresses-eth1-start[625]: adding address 2001:db8:1::1/64... done1666server # [ 10.903145] dhcpcd[702]: dev: loaded udev1667server # [ 10.944190] 8021q: 802.1Q VLAN Support v1.81668host1 # [ 10.924445] systemd[1]: Finished Address configuration of eth1.1669server # [ 10.937622] (udev-worker)[352]: Network interface NamePolicy= disabled on kernel command line.1670server # [ 10.945381] (udev-worker)[350]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1671server # [ 10.947554] (udev-worker)[350]: Network interface NamePolicy= disabled on kernel command line.1672host1 # [ 10.942820] systemd-logind[539]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1673host1 # [ 10.989472] dhcpcd[644]: dhcpcd-10.3.2 starting1674host1 # [ 10.997893] dhcpcd[691]: dev: loaded udev1675server # [ 11.024419] systemd[1]: Finished Extra networking commands..1676server # [ 11.025368] systemd[1]: Reached target Network.1677server # [ 11.031968] systemd[1]: Starting Permit User Sessions...1678server # [ 11.054859] cfg80211: Loading compiled-in X.509 certificates for regulatory database1679host1 # [ 11.043788] 8021q: 802.1Q VLAN Support v1.81680host1 # [ 11.044171] 8021q: adding VLAN 0 to HW filter on device eth11681server # [ 11.086253] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1682server # [ 11.086763] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1683server # [ 11.089962] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21684server # [ 11.090284] cfg80211: failed to load regulatory.db1685host1 # [ 11.062074] systemd[1]: Finished Extra networking commands..1686host1 # [ 11.064880] systemd[1]: Reached target Network.1687host1 # [ 11.081198] systemd[1]: Starting Permit User Sessions...1688server # [ 11.103468] systemd[1]: Finished Permit User Sessions.1689server # [ 11.108704] systemd[1]: Started Getty on tty1.1690server # [ 11.109387] systemd[1]: Reached target Login Prompts.1691server # [ 11.123436] systemd[1]: Condition check resulted in Virtio network device being skipped.1692server # [ 11.129754] systemd[1]: Starting Address configuration of eth1...1693host1 # [ 11.168251] cfg80211: Loading compiled-in X.509 certificates for regulatory database1694server # [ 11.185447] 8021q: adding VLAN 0 to HW filter on device eth01695server # [ 11.171119] dhcpcd[702]: eth0: waiting for carrier1696server # [ 11.171914] dhcpcd[702]: eth0: waiting for carrier1697server # [ 11.177838] dhcpcd[702]: eth0: carrier acquired1698host1 # [ 11.182236] systemd[1]: Finished Permit User Sessions.1699server # [ 11.194183] dhcpcd[702]: DUID 00:01:00:01:32:49:62:b1:52:54:00:12:34:561700server # [ 11.195167] dhcpcd[702]: eth0: IAID 00:12:34:561701server # [ 11.195814] dhcpcd[702]: eth0: adding address fe80::5054:ff:fe12:34561702host1 # [ 11.189214] systemd[1]: Started Getty on tty1.1703host1 # [ 11.191710] systemd[1]: Reached target Login Prompts.1704server # [ 11.234913] 8021q: adding VLAN 0 to HW filter on device eth11705server # [ 11.228581] network-addresses-eth1-start[734]: adding address 192.168.1.2/24... done1706host1 # [ 11.241878] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1707host1 # [ 11.242385] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1708server # [ 11.239180] network-addresses-eth1-start[734]: adding address 2001:db8:1::2/64... done1709host1 # [ 11.245421] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21710host1 # [ 11.245733] cfg80211: failed to load regulatory.db1711server # [ 11.255283] systemd[1]: Finished Address configuration of eth1.1712host1 # [ 11.321538] 8021q: adding VLAN 0 to HW filter on device eth01713host1 # [ 11.307215] dhcpcd[691]: eth0: waiting for carrier1714host1 # [ 11.308246] dhcpcd[691]: eth0: carrier acquired1715host1 # [ 11.320149] dhcpcd[691]: DUID 00:01:00:01:32:49:62:b1:52:54:00:12:34:561716host1 # [ 11.321167] dhcpcd[691]: eth0: IAID 00:12:34:561717host1 # [ 11.321841] dhcpcd[691]: eth0: adding address fe80::5054:ff:fe12:34561718server # [ 11.436527] systemd-logind[533]: Watching system buttons on /dev/input/event0 (gpio-keys)1719server # [ 11.587106] mousedev: PS/2 mouse device common for all mice1720server # [ 11.654706] systemd-logind[533]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1721host1 # [ 11.827378] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input31722host1 # [ 12.175938] systemd[1]: Starting Virtual Console Setup...1723host1 # [ 12.206552] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1724host1 # [ 12.219859] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1725host1 # [ 12.221342] systemd[1]: Stopped Virtual Console Setup.1726host1 # [ 12.230363] systemd[1]: Starting Virtual Console Setup...1727host1 # [ 12.258620] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1728server # [ 12.292820] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input31729host1 # [ 12.281616] dhcpcd[691]: eth0: soliciting a DHCP lease1730host1 # [ 12.284479] dhcpcd[691]: eth0: offered 10.0.2.15 from 10.0.2.21731host1 # [ 12.292171] dhcpcd[691]: eth0: probing address 10.0.2.15/241732host1 # [ 12.344510] systemd-vconsole-setup[742]: Configuration of first virtual console was skipped, ignoring remaining ones.1733host1 # [ 12.347868] systemd[1]: Finished Virtual Console Setup.1734server # [ 12.574365] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1735server # [ 12.587032] systemd[1]: Starting Virtual Console Setup...1736server # [ 12.612768] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1737server # [ 12.613910] systemd[1]: Stopped Virtual Console Setup.1738server # [ 12.623121] systemd[1]: Starting Virtual Console Setup...1739host1 # [ 12.645872] dhcpcd[691]: eth0: soliciting an IPv6 router1740host1 # [ 12.648263] dhcpcd[691]: eth0: Router Advertisement from fe80::21741host1 # [ 12.650127] dhcpcd[691]: eth0: adding address fec0::5054:ff:fe12:3456/641742server # [ 12.662542] systemd-logind[533]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1743host1 # [ 12.651604] dhcpcd[691]: eth0: adding route to fec0::/641744host1 # [ 12.652913] dhcpcd[691]: eth0: adding default route via fe80::21745server # [ 12.735436] systemd-vconsole-setup[779]: Configuration of first virtual console was skipped, ignoring remaining ones.1746server # [ 12.740241] systemd[1]: Finished Virtual Console Setup.1747server # [ 12.807065] dhcpcd[702]: eth0: soliciting a DHCP lease1748server # [ 12.812681] dhcpcd[702]: eth0: offered 10.0.2.15 from 10.0.2.21749server # [ 12.816264] dhcpcd[702]: eth0: probing address 10.0.2.15/241750server # [ 13.263127] dhcpcd[702]: eth0: soliciting an IPv6 router1751server # [ 13.265215] dhcpcd[702]: eth0: Router Advertisement from fe80::21752server # [ 13.266534] dhcpcd[702]: eth0: adding address fec0::5054:ff:fe12:3456/641753server # [ 13.268036] dhcpcd[702]: eth0: adding route to fec0::/641754server # [ 13.269239] dhcpcd[702]: eth0: adding default route via fe80::21755host1 # [ 16.664559] dhcpcd[691]: eth0: leased 10.0.2.15 for 86400 seconds1756host1 # [ 16.664777] dhcpcd[691]: eth0: adding route to 10.0.2.0/241757host1 # [ 16.664850] dhcpcd[691]: eth0: adding default route via 10.0.2.21758host1 # [ 16.766170] systemd[1]: Started DHCP Client.1759host1 # [ 16.768353] systemd[1]: Reached target Network is Online.1760host1 # [ 16.771755] systemd[1]: Starting fetch-ca-root.service...1761host1 # [ 16.818969] fetch-ca-root-start[807]: curl: (7) Failed to connect to server:8443 after 5 ms: Could not connect to server1762host1 # [ 17.822019] fetch-ca-root-start[807]: curl: (7) Failed to connect to server:8443 after 1 ms: Could not connect to server1763server # [ 18.682294] dhcpcd[702]: eth0: leased 10.0.2.15 for 86400 seconds1764server # [ 18.682484] dhcpcd[702]: eth0: adding route to 10.0.2.0/241765server # [ 18.682552] dhcpcd[702]: eth0: adding default route via 10.0.2.21766server # [ 18.788138] systemd[1]: Started DHCP Client.1767server # [ 18.792706] systemd[1]: Reached target Network is Online.1768server # [ 18.800621] systemd[1]: Starting step-ca service...1769host1 # [ 18.824537] fetch-ca-root-start[807]: curl: (7) Failed to connect to server:8443 after 1 ms: Could not connect to server1770server # [ 19.052466] step-ca[898]: badger 2026/09/25 16:50:01 INFO: All 0 tables opened in 0s1771server # [ 19.067128] step-ca[898]: 2026/09/25 16:50:01 Building new tls configuration using step-ca x509 Signer Interface1772server # [ 19.079970] step-ca[898]: 2026/09/25 16:50:01 Starting Smallstep CA/0.30.2 (linux/arm64)1773server # [ 19.081268] step-ca[898]: 2026/09/25 16:50:01 Documentation: https://u.step.sm/docs/ca1774server # [ 19.082343] step-ca[898]: 2026/09/25 16:50:01 Community Discord: https://u.step.sm/discord1775server # [ 19.083449] step-ca[898]: 2026/09/25 16:50:01 Config file: /etc/smallstep/ca.json1776server # [ 19.089615] step-ca[898]: 2026/09/25 16:50:01 The primary server URL is https://server:84431777server # [ 19.090783] step-ca[898]: 2026/09/25 16:50:01 Root certificates are available at https://server:8443/roots.pem1778server # [ 19.093092] step-ca[898]: 2026/09/25 16:50:01 X.509 Root Fingerprint: f3ab259daf9b7725d4d54c27a8aae745036109e4ac083bdd314ffc3bad6e1a441779server # [ 19.094709] step-ca[898]: 2026/09/25 16:50:01 Serving HTTPS on 0.0.0.0:8443 ...1780server # [ 19.095701] systemd[1]: Started step-ca service.1781server # [ 19.104117] systemd[1]: Reached target Multi-User System.1782server # [ 19.105061] systemd[1]: Starting Order (and renew) ACME certificate for server...1783server # [ 19.152288] acme-order-renew-server-start[906]: Waiting to acquire lock in /run/acme/1784server # [ 19.158285] acme-order-renew-server-start[906]: + set -euo pipefail1785server # [ 19.159230] acme-order-renew-server-start[906]: + exec1786server # [ 19.159955] acme-order-renew-server-start[906]: + /nix/store/fxkh6pl0y4nfbhdqdnhfkvsq7pbxq655-flock-0.4.0/bin/flock 111787server # [ 19.163473] acme-order-renew-server-start[914]: ++ find accounts -path '*/keys/*.key' -print -quit1788server # [ 19.170015] acme-order-renew-server-start[906]: + '[' -n '' ']'1789server # [ 19.170941] acme-order-renew-server-start[906]: + exec1790server # [ 19.171655] acme-order-renew-server-start[906]: + '[' -e certificates/server.key ']'1791server # [ 19.173557] acme-order-renew-server-start[906]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server --no-random-sleep --renew-force --ari-disable --force-cert-domains1792server # [ 19.359200] acme-order-renew-server-start[915]: 2026-09-25T16:50:01.956361040Z INFO Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key1793server # [ 19.378753] acme-order-renew-server-start[915]: 2026-09-25T16:50:01.976978660Z INFO Registering the account. email=root@example.org1794server # [ 19.387260] acme-order-renew-server-start[915]: 2026-09-25T16:50:01.985891400Z WARN !!!! HEADS UP !!!!1795server # [ 19.389964] acme-order-renew-server-start[915]: Your account credentials have been saved in your1796server # [ 19.391317] acme-order-renew-server-start[915]: configuration directory at "accounts".1797server # [ 19.392614] acme-order-renew-server-start[915]: You should make a secure backup of this folder now. This1798server # [ 19.394304] acme-order-renew-server-start[915]: configuration directory will also contain private keys1799server # [ 19.395869] acme-order-renew-server-start[915]: generated by lego and certificates obtained from the ACME1800server # [ 19.398168] acme-order-renew-server-start[915]: server. Making regular backups of this folder is ideal.1801server # [ 19.399460] acme-order-renew-server-start[915]: 2026-09-25T16:50:01.987616940Z INFO Obtaining bundled SAN certificate. domains=server1802server # [ 19.469276] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.067170780Z INFO Use solver. domain=server type=http-011803server # [ 19.471763] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.067231840Z INFO http01: Trying to solve HTTP-01. domain=server1804server # [ 19.484095] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.082154500Z INFO The server validated our request. domain=server1805server # [ 19.486766] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.082263820Z INFO Validations succeeded; requesting certificates. domains=server1806server # [ 19.509191] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.103825120Z INFO Server responded with a certificate. domains=server1807server # [ 19.511620] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.103997340Z INFO Writing file. filepath=certificates/server.crt1808server # [ 19.514953] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.104167600Z INFO Writing file. filepath=certificates/server.issuer.crt1809server # [ 19.518932] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.104257260Z INFO Writing file. filepath=certificates/server.key1810server # [ 19.521786] acme-order-renew-server-start[915]: 2026-09-25T16:50:02.104439040Z INFO Writing file. filepath=certificates/server.json1811server # [ 19.525613] acme-order-renew-server-start[906]: + touch out/acme-success1812server # [ 19.527232] acme-order-renew-server-start[906]: + cmp -s certificates/server.crt out/fullchain.pem1813server # [ 19.532079] acme-order-renew-server-start[906]: + touch out/renewed1814server # [ 19.536091] acme-order-renew-server-start[906]: + echo Installing new certificate1815server # [ 19.537360] acme-order-renew-server-start[906]: Installing new certificate1816server # [ 19.538561] acme-order-renew-server-start[906]: + cp -vp certificates/server.crt out/fullchain.pem1817server # [ 19.543297] acme-order-renew-server-start[923]: 'certificates/server.crt' -> 'out/fullchain.pem'1818server # [ 19.546120] acme-order-renew-server-start[906]: + cp -vp certificates/server.key out/key.pem1819server # [ 19.549276] acme-order-renew-server-start[924]: 'certificates/server.key' -> 'out/key.pem'1820server # [ 19.551824] acme-order-renew-server-start[906]: + cp -vp certificates/server.issuer.crt out/chain.pem1821server # [ 19.557810] acme-order-renew-server-start[925]: 'certificates/server.issuer.crt' -> 'out/chain.pem'1822server # [ 19.561987] acme-order-renew-server-start[906]: + ln -sf fullchain.pem out/cert.pem1823server # [ 19.567621] acme-order-renew-server-start[906]: + cat out/key.pem out/fullchain.pem1824server # [ 19.574357] acme-order-renew-server-start[906]: + for fixpath in out certificates1825server # [ 19.578153] acme-order-renew-server-start[906]: + '[' -d out ']'1826server # [ 19.579022] acme-order-renew-server-start[906]: + chmod -R u=rwX,g=rX,o= out1827server # [ 19.582778] acme-order-renew-server-start[906]: + chown -R acme:nix-grpc-daemon out1828server # [ 19.595407] acme-order-renew-server-start[906]: + for fixpath in out certificates1829server # [ 19.597604] acme-order-renew-server-start[906]: + '[' -d certificates ']'1830server # [ 19.598529] acme-order-renew-server-start[906]: + chmod -R u=rwX,g=rX,o= certificates1831server: (finished: waiting for unit step-ca.service, in 19.96 seconds)1832server # [ 19.608199] acme-order-renew-server-start[906]: + chown -R acme:nix-grpc-daemon certificates1833server: waiting for unit nix-grpc-daemon.socket1834server # [ 19.614314] acme-order-renew-server-start[906]: + chmod -R u=rwX,g=,o= accounts/.1835server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.05 seconds)1836server: waiting for TCP port 50051 on localhost1837server # [ 19.686743] systemd[1]: acme-order-renew-server.service: Deactivated successfully.1838server # [ 19.689481] systemd[1]: Finished Order (and renew) ACME certificate for server.1839server # [ 19.692157] systemd[1]: Startup finished in 971ms (kernel) + 4.741s (initrd) + 13.978s (userspace) = 19.691s.1840server # [ 19.693577] systemd[1]: acme-order-renew-server.service: Consumed 215ms CPU time over 591ms wall clock time, 47.2M memory peak, 4K written to disk, 10.3K incoming IP traffic, 8.1K outgoing IP traffic.1841server # [ 19.716951] systemd[1]: Starting Order (and renew) ACME certificate for server...1842server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!1843server: (finished: waiting for TCP port 50051 on localhost, in 0.06 seconds)1844subtest: host1 obtains a certificate via ACME1845host1: waiting for success: /nix/store/ai0jh6nymysikgd4liv2k8iv9kmipcva-openssl-3.6.4-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA'1846host1: waiting for the VM to finish booting1847host1: Guest shell says: b'Spawning backdoor root shell...\n'1848host1: connected to guest root shell1849host1: (connecting took 0.00 seconds)1850host1: (finished: waiting for the VM to finish booting, in 0.00 seconds)1851server # [ 19.769256] acme-order-renew-server-start[955]: Waiting to acquire lock in /run/acme/1852server # [ 19.774942] acme-order-renew-server-start[955]: + set -euo pipefail1853server # [ 19.775850] acme-order-renew-server-start[955]: + exec1854server # [ 19.776821] acme-order-renew-server-start[955]: + /nix/store/fxkh6pl0y4nfbhdqdnhfkvsq7pbxq655-flock-0.4.0/bin/flock 111855server # [ 19.780185] acme-order-renew-server-start[963]: ++ find accounts -path '*/keys/*.key' -print -quit1856server # [ 19.784936] acme-order-renew-server-start[955]: + '[' -n '' ']'1857server # [ 19.785800] acme-order-renew-server-start[955]: + exec1858server # [ 19.786509] acme-order-renew-server-start[955]: + '[' -e certificates/server.key ']'1859server # [ 19.787533] acme-order-renew-server-start[955]: + '[' -e certificates/server.crt ']'1860server # [ 19.789500] acme-order-renew-server-start[964]: ++ find accounts -name root@example.org.key1861server # [ 19.794079] acme-order-renew-server-start[955]: + '[' -n accounts/server_8443/root@example.org/root@example.org.key ']'1862server # [ 19.795564] acme-order-renew-server-start[955]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server --no-random-sleep --force-cert-domains1863server # [ 19.820208] acme-order-renew-server-start[965]: 2026-09-25T16:50:02.416725760Z INFO Renewing certificate cert-name=server1864server # [ 19.827425] acme-order-renew-server-start[965]: 2026-09-25T16:50:02.426042200Z WARN The server does not advertise a renewal info endpoint. cert-name=server error="renewalInfo[get/post]: server does not advertise a renewal info endpoint"1865server # [ 19.832854] acme-order-renew-server-start[965]: 2026-09-25T16:50:02.426099120Z INFO Skip renewal: The certificate expires at 2026-09-26T16:50:01Z, the renewal can be performed in 11h59m28s573912500ns. cert-name=server1866server # [ 19.835353] acme-order-renew-server-start[955]: + touch out/acme-success1867server # [ 19.839631] acme-order-renew-server-start[955]: + cmp -s certificates/server.crt out/fullchain.pem1868server # [ 19.843546] acme-order-renew-server-start[955]: + for fixpath in out certificates1869server # [ 19.847604] acme-order-renew-server-start[955]: + '[' -d out ']'1870server # [ 19.849445] acme-order-renew-server-start[955]: + chmod -R u=rwX,g=rX,o= out1871server # [ 19.851150] acme-order-renew-server-start[955]: + chown -R acme:nix-grpc-daemon out1872host1 # [ 19.842963] systemd[1]: Finished fetch-ca-root.service.1873server # [ 19.856766] acme-order-renew-server-start[955]: + for fixpath in out certificates1874host1 # [ 19.845895] systemd[1]: Reached target Multi-User System.1875server # [ 19.857831] acme-order-renew-server-start[955]: + '[' -d certificates ']'1876server # [ 19.858729] acme-order-renew-server-start[955]: + chmod -R u=rwX,g=rX,o= certificates1877server # [ 19.862361] acme-order-renew-server-start[955]: + chown -R acme:nix-grpc-daemon certificates1878host1 # [ 19.852655] systemd[1]: Starting Order (and renew) ACME certificate for host1...1879server # [ 19.867433] acme-order-renew-server-start[955]: + chmod -R u=rwX,g=,o= accounts/.1880server # [ 19.905218] systemd[1]: acme-order-renew-server.service: Deactivated successfully.1881server # [ 19.907849] systemd[1]: Finished Order (and renew) ACME certificate for server.1882server # [ 19.910301] systemd[1]: acme-order-renew-server.service: Consumed 109ms CPU time over 190ms wall clock time, 7.3M memory peak, 3.3K incoming IP traffic, 2.2K outgoing IP traffic.1883server # [ 19.920624] systemd[1]: Starting Nix worker-protocol over gRPC...1884host1 # [ 19.920871] acme-order-renew-host1-start[818]: Waiting to acquire lock in /run/acme/1885host1 # [ 19.928071] acme-order-renew-host1-start[818]: + set -euo pipefail1886host1 # [ 19.929207] acme-order-renew-host1-start[818]: + exec1887host1 # [ 19.930093] acme-order-renew-host1-start[818]: + /nix/store/fxkh6pl0y4nfbhdqdnhfkvsq7pbxq655-flock-0.4.0/bin/flock 111888host1 # [ 19.934233] acme-order-renew-host1-start[826]: ++ find accounts -path '*/keys/*.key' -print -quit1889host1 # [ 19.940919] acme-order-renew-host1-start[818]: + '[' -n '' ']'1890host1 # [ 19.942027] acme-order-renew-host1-start[818]: + exec1891host1 # [ 19.942849] acme-order-renew-host1-start[818]: + '[' -e certificates/host1.key ']'1892host1 # [ 19.944726] acme-order-renew-host1-start[818]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 --no-random-sleep --renew-force --ari-disable --force-cert-domains1893server # [ 20.029006] nix-grpc-daemon[985]: ts=2026-09-25T16:50:02Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=11894server # [ 20.042830] nix-grpc-daemon[985]: WARNING: All log messages before absl::InitializeLog() is called are written to STDERR1895server # [ 20.046112] nix-grpc-daemon[985]: E0000 00:00:1790355002.641105 985 tls_security_connector.cc:771] TlsServerCertificateWatcher getting identity_cert_error: UNKNOWN:Unable to get latest identity certificates.1896server # [ 20.051292] nix-grpc-daemon[985]: E0000 00:00:1790355002.649717 985 tls_security_connector.cc:767] TlsServerCertificateWatcher getting root_cert_error: UNKNOWN:Unable to get latest root certificates.1897server # [ 20.056713] nix-grpc-daemon[985]: ts=2026-09-25T16:50:02Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket1898server # [ 20.058577] nix-grpc-daemon[985]: ts=2026-09-25T16:50:02Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=01899server # [ 20.060420] nix-grpc-daemon[985]: ts=2026-09-25T16:50:02Z level=info event=unhealthy reason=min_free1900server # [ 20.061645] systemd[1]: Started Nix worker-protocol over gRPC.1901host1 # [ 20.062368] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.661206800Z INFO Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key1902host1 # [ 20.077840] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.677039880Z INFO Registering the account. email=root@example.org1903host1 # [ 20.085664] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.684791220Z WARN !!!! HEADS UP !!!!1904host1 # [ 20.086951] acme-order-renew-host1-start[827]: Your account credentials have been saved in your1905host1 # [ 20.088630] acme-order-renew-host1-start[827]: configuration directory at "accounts".1906host1 # [ 20.089715] acme-order-renew-host1-start[827]: You should make a secure backup of this folder now. This1907host1 # [ 20.090977] acme-order-renew-host1-start[827]: configuration directory will also contain private keys1908host1 # [ 20.092240] acme-order-renew-host1-start[827]: generated by lego and certificates obtained from the ACME1909host1 # [ 20.093547] acme-order-renew-host1-start[827]: server. Making regular backups of this folder is ideal.1910host1 # [ 20.094824] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.687492700Z INFO Obtaining bundled SAN certificate. domains=host11911host1 # [ 20.157214] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.755911460Z INFO Use solver. domain=host1 type=http-011912host1 # [ 20.160605] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.755955760Z INFO http01: Trying to solve HTTP-01. domain=host11913host1 # [ 20.167708] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.766090560Z INFO The server validated our request. domain=host11914host1 # [ 20.170476] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.766200740Z INFO Validations succeeded; requesting certificates. domains=host11915host1 # [ 20.181910] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.780522120Z INFO Server responded with a certificate. domains=host11916host1 # [ 20.188215] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.780686540Z INFO Writing file. filepath=certificates/host1.crt1917host1 # [ 20.190685] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.780844980Z INFO Writing file. filepath=certificates/host1.issuer.crt1918host1 # [ 20.193464] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.780932520Z INFO Writing file. filepath=certificates/host1.key1919host1 # [ 20.195815] acme-order-renew-host1-start[827]: 2026-09-25T16:50:02.781090580Z INFO Writing file. filepath=certificates/host1.json1920host1 # [ 20.198947] acme-order-renew-host1-start[818]: + touch out/acme-success1921host1 # [ 20.205051] acme-order-renew-host1-start[818]: + cmp -s certificates/host1.crt out/fullchain.pem1922host1 # [ 20.210871] acme-order-renew-host1-start[818]: + touch out/renewed1923host1 # [ 20.215921] acme-order-renew-host1-start[818]: + echo Installing new certificate1924host1 # [ 20.217983] acme-order-renew-host1-start[818]: Installing new certificate1925host1 # [ 20.219348] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.crt out/fullchain.pem1926host1 # [ 20.225410] acme-order-renew-host1-start[835]: 'certificates/host1.crt' -> 'out/fullchain.pem'1927host1 # [ 20.227635] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.key out/key.pem1928host1 # [ 20.232488] acme-order-renew-host1-start[836]: 'certificates/host1.key' -> 'out/key.pem'1929host1 # [ 20.234752] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.issuer.crt out/chain.pem1930host1 # [ 20.239319] acme-order-renew-host1-start[837]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'1931host1 # [ 20.241568] acme-order-renew-host1-start[818]: + ln -sf fullchain.pem out/cert.pem1932host1 # [ 20.246199] acme-order-renew-host1-start[818]: + cat out/key.pem out/fullchain.pem1933host1 # [ 20.250815] acme-order-renew-host1-start[818]: + for fixpath in out certificates1934host1 # [ 20.251995] acme-order-renew-host1-start[818]: + '[' -d out ']'1935host1 # [ 20.253309] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=rX,o= out1936host1 # [ 20.257304] acme-order-renew-host1-start[818]: + chown -R acme:acme out1937host1 # [ 20.263120] acme-order-renew-host1-start[818]: + for fixpath in out certificates1938host1 # [ 20.264433] acme-order-renew-host1-start[818]: + '[' -d certificates ']'1939host1 # [ 20.265402] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=rX,o= certificates1940host1 # [ 20.268949] acme-order-renew-host1-start[818]: + chown -R acme:acme certificates1941host1 # [ 20.274055] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=,o= accounts/.1942host1 # [ 20.316473] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.1943host1 # [ 20.318626] systemd[1]: Finished Order (and renew) ACME certificate for host1.1944host1 # [ 20.333015] systemd[1]: Startup finished in 970ms (kernel) + 4.756s (initrd) + 14.605s (userspace) = 20.332s.1945host1 # [ 20.334615] systemd[1]: acme-order-renew-host1.service: Consumed 222ms CPU time over 465ms wall clock time, 46.5M memory peak, 4K written to disk, 10.2K incoming IP traffic, 8.2K outgoing IP traffic.1946host1: (finished: waiting for success: /nix/store/ai0jh6nymysikgd4liv2k8iv9kmipcva-openssl-3.6.4-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA', in 1.14 seconds)1947host1: must succeed: /nix/store/ai0jh6nymysikgd4liv2k8iv9kmipcva-openssl-3.6.4-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1'1948host1: (finished: must succeed: /nix/store/ai0jh6nymysikgd4liv2k8iv9kmipcva-openssl-3.6.4-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1', in 0.05 seconds)1949(finished: subtest: host1 obtains a certificate via ACME, in 1.19 seconds)1950subtest: server builds and signs a path1951server: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths1952server # 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 19 ms (attempt 1/5)1953server # 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 139 ms (attempt 2/5)1954server # 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 312 ms (attempt 3/5)1955server # 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 705 ms (attempt 4/5)1956server # disabling binary cache 'https://cache.nixos.org' for 60 seconds1957server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1958server # this derivation will be built:1959server # /nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv1960server # building '/nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv'...1961server: (finished: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths, in 1.59 seconds)1962server: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1963server # added 1 signatures1964server: (finished: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.11 seconds)1965(finished: subtest: server builds and signs a path, in 1.71 seconds)1966subtest: host1 substitutes the signed path over gRPC (read-only cert)1967host1: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1968host1: (finished: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.02 seconds)1969host1: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1970host1 # 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 4 ms (attempt 1/5)1971host1 # 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 156 ms (attempt 2/5)1972host1 # 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 189 ms (attempt 3/5)1973host1 # 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 670 ms (attempt 4/5)1974host1 # disabling binary cache 'https://cache.nixos.org' for 60 seconds1975host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1976server # [ 23.838501] systemd[1]: Started Nix Daemon.1977server # [ 23.979996] nix-daemon[1021]: accepted connection from pid 985, user nix-grpc-daemon (trusted)1978host1 # this path will be fetched (0.0 KiB download, 0.1 KiB unpacked):1979host1 # /nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc1980host1 # copying path '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' from 'grpc://server:50051'...1981server # [ 24.005907] nix-grpc-daemon[985]: ts=2026-09-25T16:50:06Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:45162 duration_s=0 paths=1 nar_bytes_out=1281982host1 # warning: you did not specify '--add-root'; the result might be removed by the garbage collector1983host1: (finished: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 1.40 seconds)1984host1: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1985host1: (finished: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.02 seconds)1986(finished: subtest: host1 substitutes the signed path over gRPC (read-only cert), in 1.43 seconds)1987subtest: read-only host1 cannot write1988host1: must succeed: echo deny > /root/denyfile1989host1: (finished: must succeed: echo deny > /root/denyfile, in 0.01 seconds)1990host1: 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/denyfile1991server # [ 24.194992] nix-grpc-daemon[985]: ts=2026-09-25T16:50:06Z level=info event=denied method=Connect cn=host1 role=read-only1992host1 # error: gRPC Connect on 'server:50051' failed: role 'read-only' may not call Connect1993host1 # error: cannot open connection to remote store 'grpc://server:50051': error: Nix daemon disconnected unexpectedly (maybe it crashed?)1994host1: (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.14 seconds)1995server: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only'1996server: (finished: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only', in 0.03 seconds)1997(finished: subtest: read-only host1 cannot write, in 0.19 seconds)1998(finished: run the VM test script, in 25.01 seconds)1999test script finished in 25.10s2000cleanup2001kill QemuMachine (pid 47)2002host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2003host1 # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2004host1 # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2005host1 # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2006kill QemuMachine (pid 48)2007server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/3fl7bdkdxk2k4nssy1d1161isbzn6bsr-python3-3.14.7/bin/python3.14)2008server # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2009server # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2010server # [2026-09-25T16:50:07Z INFO virtiofsd] Client disconnected, shutting down2011(finished: cleanup, in 0.40 seconds)2012additionally exposed symbols:2013 host1, server,2014 vlan1,2015 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