vm-test-run-nix-grpc-store-acme-substituter
checks.aarch64-linux.acme-vm
· build #237
· 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 # Disk image does not exist, creating the virtualisation disk image...11server: QEMU running (pid 48)12host1 # Disk image does not exist, creating the virtualisation disk image...13host1: QEMU running (pid 47)14host1 # Formatting '/build/vm-state-host1/tmp.XkLB71r9YL', fmt=raw size=107374182415server # Formatting '/build/vm-state-server/tmp.ByHxNLn758', fmt=raw size=107374182416host1 # mke2fs 1.47.4 (6-Mar-2025)17server # mke2fs 1.47.4 (6-Mar-2025)18host1 # Discarding device blocks: 0/262144 done19server # Discarding device blocks: 0/262144 done20host1 # Creating filesystem with 262144 4k blocks and 65536 inodes21server # Creating filesystem with 262144 4k blocks and 65536 inodes22host1 # Filesystem UUID: c970a448-5f3e-456b-a368-ce11def994d023server # Filesystem UUID: d3e8a63a-9a91-4ace-8398-67c7af8e388224host1 # Superblock backups stored on blocks:25server # Superblock backups stored on blocks:26host1 # 32768, 98304, 163840, 22937627server # 32768, 98304, 163840, 22937628host1 # 29server # 30host1 # Allocating group tables: 0/8 done31server # Allocating group tables: 0/8 done32host1 # Writing inode tables: 0/8 done33server # Writing inode tables: 0/8 done34host1 # Creating journal (8192 blocks): done35server # Creating journal (8192 blocks): done36host1 # Writing superblocks and filesystem accounting information: 0/8 done37server # Writing superblocks and filesystem accounting information: 0/8 done38host1 # 39server # 40host1 # Virtualisation disk image created.41server # Virtualisation disk image created.42(finished: start all VMs, in 0.44 seconds)43server: waiting for unit step-ca.service44server: waiting for the VM to finish booting45server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]46server # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 202647server # [ 0.000000] KASLR enabled48server # [ 0.000000] random: crng init done49server # [ 0.000000] Machine model: linux,dummy-virt50server # [ 0.000000] efi: UEFI not found.51server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT52server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]53server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]54server # [ 0.000000] Zone ranges:55server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]56server # [ 0.000000] DMA32 empty57server # [ 0.000000] Normal empty58server # [ 0.000000] Device empty59server # [ 0.000000] Movable zone start for each node60server # [ 0.000000] Early memory node ranges61server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]62server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]63server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc0000064server # [ 0.000000] psci: probing for conduit method from DT.65server # [ 0.000000] psci: PSCIv1.3 detected in firmware.66server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs67server # [ 0.000000] psci: Trusted OS migration not required68server # [ 0.000000] psci: SMC Calling Convention v1.169server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)70server # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u31129671server # [ 0.000000] Detected PIPT I-cache on CPU072host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]73server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)74server # [ 0.000000] CPU features: detected: GICv3 CPU interface75server # [ 0.000000] CPU features: detected: Spectre-v476host1 # [ 0.000000] Linux version 6.18.50 (nixbld@localhost) (gcc (GCC) 15.3.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Mon Sep 7 15:23:00 UTC 202677server # [ 0.000000] CPU features: detected: Spectre-BHB78host1 # [ 0.000000] KASLR enabled79host1 # [ 0.000000] random: crng init done80server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3881host1 # [ 0.000000] Machine model: linux,dummy-virt82host1 # [ 0.000000] efi: UEFI not found.83server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2384server # [ 0.000000] alternatives: applying boot alternatives85host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT86host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]87host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]88host1 # [ 0.000000] Zone ranges:89host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]90host1 # [ 0.000000] DMA32 empty91host1 # [ 0.000000] Normal empty92server # [ 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/h1861zlyvppzb3fjhkmr6k12yzf86d76-nixos-system-server-test/init regInfo=/nix/store/4bf1v351wg8ijqfwa8p19d124wahy886-closure-info/registration console=ttyAMA0,115200n8 console=tty093host1 # [ 0.000000] Device empty94host1 # [ 0.000000] Movable zone start for each node95host1 # [ 0.000000] Early memory node ranges96server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/4bf1v351wg8ijqfwa8p19d124wahy886-closure-info/registration", will be passed to user space.97host1 # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]98server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes99host1 # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]100host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000101server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)102host1 # [ 0.000000] psci: probing for conduit method from DT.103server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)104host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware.105host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs106server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB107server # [ 0.000000] software IO TLB: area num 1.108host1 # [ 0.000000] psci: Trusted OS migration not required109host1 # [ 0.000000] psci: SMC Calling Convention v1.1110server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)111server # [ 0.000000] Fallback order for Node 0: 0112host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)113server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288114host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186648 r8192 d116456 u311296115server # [ 0.000000] Policy zone: DMA116host1 # [ 0.000000] Detected PIPT I-cache on CPU0117server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off118host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)119server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1120host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface121server # [ 0.000000] allocated 4194304 bytes of page_ext122host1 # [ 0.000000] CPU features: detected: Spectre-v4123server # [ 0.000000] ftrace: allocating 74885 entries in 294 pages124host1 # [ 0.000000] CPU features: detected: Spectre-BHB125server # [ 0.000000] ftrace: allocated 294 pages with 4 groups126host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38127server # [ 0.000000] rcu: Hierarchical RCU implementation.128host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23129server # [ 0.000000] rcu: RCU event tracing is enabled.130host1 # [ 0.000000] alternatives: applying boot alternatives131server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.132server # [ 0.000000] Trampoline variant of Tasks RCU enabled.133server # [ 0.000000] Rude variant of Tasks RCU enabled.134server # [ 0.000000] Tracing variant of Tasks RCU enabled.135server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.136server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1137host1 # [ 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/4n1fgkqk6zyk5l7f2lshpdj03kywbdb8-nixos-system-host1-test/init regInfo=/nix/store/y3b0myjdfbp2qb8n0rcpyvdifv6lxdx8-closure-info/registration console=ttyAMA0,115200n8 console=tty0138server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.139host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/y3b0myjdfbp2qb8n0rcpyvdifv6lxdx8-closure-info/registration", will be passed to user space.140server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.141host1 # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes142server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.143host1 # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)144server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0145server # [ 0.000000] GICv3: 256 SPIs implemented146host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)147server # [ 0.000000] GICv3: 0 Extended SPIs implemented148host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB149server # [ 0.000000] Root IRQ handler: gic_handle_irq150host1 # [ 0.000000] software IO TLB: area num 1.151server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI152server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0153host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)154host1 # [ 0.000000] Fallback order for Node 0: 0155server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000156server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]157host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288158host1 # [ 0.000000] Policy zone: DMA159server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44af0000 (indirect, esz 8, psz 64K, shr 1)160host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off161host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1162server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44b00000 (flat, esz 8, psz 64K, shr 1)163host1 # [ 0.000000] allocated 4194304 bytes of page_ext164server # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000165host1 # [ 0.000000] ftrace: allocating 74885 entries in 294 pages166host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups167server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000168host1 # [ 0.000000] rcu: Hierarchical RCU implementation.169server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.170host1 # [ 0.000000] rcu: RCU event tracing is enabled.171host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.172server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns173host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled.174server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).175host1 # [ 0.000000] Rude variant of Tasks RCU enabled.176host1 # [ 0.000000] Tracing variant of Tasks RCU enabled.177server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns178host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.179server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns180host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1181server # [ 0.000033] arm-pv: using stolen time PV182host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.183server # [ 0.000467] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)184server # [ 0.000624] Console: colour dummy device 80x25185host1 # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.186server # [ 0.000633] printk: legacy console [tty0] enabled187host1 # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.188server # [ 0.000829] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)189host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0190server # [ 0.000837] pid_max: default: 32768 minimum: 301191host1 # [ 0.000000] GICv3: 256 SPIs implemented192server # [ 0.000911] LSM: initializing lsm=capability,landlock,yama,bpf,ima193host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented194server # [ 0.001098] landlock: Up and running.195host1 # [ 0.000000] Root IRQ handler: gic_handle_irq196server # [ 0.001101] Yama: becoming mindful.197host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI198server # [ 0.001603] LSM support for eBPF active199host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0200server # [ 0.001769] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)201host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000202host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]203server # [ 0.001803] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)204server # [ 0.003002] cacheinfo: Unable to detect cache hierarchy for CPU 0205host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1)206server # [ 0.003732] rcu: Hierarchical SRCU implementation.207server # [ 0.003735] rcu: Max phase no-delay instances is 1000.208host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1)209server # [ 0.004982] fsl-mc MSI: its@8080000 domain created210server # [ 0.005069] EFI services will not be available.211host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b00000212server # [ 0.005149] smp: Bringing up secondary CPUs ...213host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000214server # [ 0.005157] smp: Brought up 1 node, 1 CPU215server # [ 0.005160] SMP: Total of 1 processors activated.216host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.217server # [ 0.005163] CPU: All CPU(s) started at EL1218server # [ 0.005177] CPU features: detected: Branch Target Identification219host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns220server # [ 0.005182] CPU features: detected: ARMv8.4 Translation Table Level221host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).222server # [ 0.005186] CPU features: detected: Instruction cache invalidation not required for I/D coherence223host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns224server # [ 0.005189] CPU features: detected: Data cache clean to the PoU not required for I/D coherence225host1 # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns226server # [ 0.005193] CPU features: detected: Common not Private translations227host1 # [ 0.000032] arm-pv: using stolen time PV228server # [ 0.005196] CPU features: detected: CRC32 instructions229host1 # [ 0.000440] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)230host1 # [ 0.000640] Console: colour dummy device 80x25231server # [ 0.005198] CPU features: detected: Data cache clean to Point of Deep Persistence232host1 # [ 0.000648] printk: legacy console [tty0] enabled233server # [ 0.005202] CPU features: detected: Data cache clean to Point of Persistence234host1 # [ 0.000842] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)235server # [ 0.005205] CPU features: detected: Data independent timing control (DIT)236host1 # [ 0.000849] pid_max: default: 32768 minimum: 301237server # [ 0.005209] CPU features: detected: E0PD238host1 # [ 0.000929] LSM: initializing lsm=capability,landlock,yama,bpf,ima239server # [ 0.005211] CPU features: detected: Enhanced Counter Virtualization240host1 # [ 0.001073] landlock: Up and running.241host1 # [ 0.001076] Yama: becoming mindful.242server # [ 0.005214] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)243host1 # [ 0.001541] LSM support for eBPF active244server # [ 0.005217] CPU features: detected: Enhanced Virtualization Traps245host1 # [ 0.001711] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)246server # [ 0.005220] CPU features: detected: Fine Grained Traps247host1 # [ 0.001744] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)248server # [ 0.005224] CPU features: detected: Generic authentication (architected QARMA5 algorithm)249host1 # [ 0.002870] cacheinfo: Unable to detect cache hierarchy for CPU 0250server # [ 0.005228] CPU features: detected: RCpc load-acquire (LDAPR)251host1 # [ 0.003579] rcu: Hierarchical SRCU implementation.252server # [ 0.005231] CPU features: detected: LSE atomic instructions253host1 # [ 0.003583] rcu: Max phase no-delay instances is 1000.254server # [ 0.005234] CPU features: detected: Privileged Access Never255host1 # [ 0.005061] fsl-mc MSI: its@8080000 domain created256server # [ 0.005237] CPU features: detected: PMUv3257host1 # [ 0.005151] EFI services will not be available.258server # [ 0.005240] CPU features: detected: RAS Extension Support259host1 # [ 0.005218] smp: Bringing up secondary CPUs ...260host1 # [ 0.005227] smp: Brought up 1 node, 1 CPU261server # [ 0.005242] CPU features: detected: RASv1p1 Extension Support262host1 # [ 0.005231] SMP: Total of 1 processors activated.263server # [ 0.005245] CPU features: detected: Random Number Generator264host1 # [ 0.005233] CPU: All CPU(s) started at EL1265server # [ 0.005248] CPU features: detected: Speculation barrier (SB)266host1 # [ 0.005248] CPU features: detected: Branch Target Identification267server # [ 0.005250] CPU features: detected: Stage-2 Force Write-Back268host1 # [ 0.005253] CPU features: detected: ARMv8.4 Translation Table Level269server # [ 0.005253] CPU features: detected: TLB range maintenance instructions270host1 # [ 0.005256] CPU features: detected: Instruction cache invalidation not required for I/D coherence271server # [ 0.005258] CPU features: detected: Speculative Store Bypassing Safe (SSBS)272server # [ 0.005297] alternatives: applying system-wide alternatives273host1 # [ 0.005260] CPU features: detected: Data cache clean to the PoU not required for I/D coherence274server # [ 0.008353] CPU features: detected: BBM Level 2 without TLB conflict abort275host1 # [ 0.005264] CPU features: detected: Common not Private translations276host1 # [ 0.005267] CPU features: detected: CRC32 instructions277server # [ 0.008527] Memory: 1921628K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131956K reserved, 32768K cma-reserved)278server # [ 0.009024] devtmpfs: initialized279host1 # [ 0.005270] CPU features: detected: Data cache clean to Point of Deep Persistence280server # [ 0.011030] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)281host1 # [ 0.005273] CPU features: detected: Data cache clean to Point of Persistence282server # [ 0.011053] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).283host1 # [ 0.005276] CPU features: detected: Data independent timing control (DIT)284host1 # [ 0.005279] CPU features: detected: E0PD285server # [ 0.011235] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL286server # [ 0.011240] 0 pages in range for non-PLT usage287host1 # [ 0.005282] CPU features: detected: Enhanced Counter Virtualization288server # [ 0.011241] 508288 pages in range for PLT usage289host1 # [ 0.005285] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)290server # [ 0.011356] pinctrl core: initialized pinctrl subsystem291server # [ 0.012427] DMI not present or invalid.292host1 # [ 0.005288] CPU features: detected: Enhanced Virtualization Traps293server # [ 0.015485] NET: Registered PF_NETLINK/PF_ROUTE protocol family294host1 # [ 0.005291] CPU features: detected: Fine Grained Traps295server # [ 0.017802] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations296host1 # [ 0.005295] CPU features: detected: Generic authentication (architected QARMA5 algorithm)297host1 # [ 0.005300] CPU features: detected: RCpc load-acquire (LDAPR)298server # [ 0.017991] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations299host1 # [ 0.005303] CPU features: detected: LSE atomic instructions300server # [ 0.018193] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations301host1 # [ 0.005306] CPU features: detected: Privileged Access Never302server # [ 0.018215] audit: initializing netlink subsys (disabled)303host1 # [ 0.005308] CPU features: detected: PMUv3304server # [ 0.018815] thermal_sys: Registered thermal governor 'fair_share'305host1 # [ 0.005311] CPU features: detected: RAS Extension Support306server # [ 0.018817] thermal_sys: Registered thermal governor 'bang_bang'307host1 # [ 0.005314] CPU features: detected: RASv1p1 Extension Support308host1 # [ 0.005316] CPU features: detected: Random Number Generator309server # [ 0.018821] thermal_sys: Registered thermal governor 'step_wise'310host1 # [ 0.005319] CPU features: detected: Speculation barrier (SB)311server # [ 0.018824] thermal_sys: Registered thermal governor 'user_space'312host1 # [ 0.005322] CPU features: detected: Stage-2 Force Write-Back313server # [ 0.018829] thermal_sys: Registered thermal governor 'power_allocator'314host1 # [ 0.005325] CPU features: detected: TLB range maintenance instructions315server # [ 0.018861] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1316server # [ 0.018869] cpuidle: using governor ladder317host1 # [ 0.005330] CPU features: detected: Speculative Store Bypassing Safe (SSBS)318server # [ 0.018875] cpuidle: using governor menu319host1 # [ 0.005369] alternatives: applying system-wide alternatives320server # [ 0.019072] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.321host1 # [ 0.008459] CPU features: detected: BBM Level 2 without TLB conflict abort322server # [ 0.019089] ASID allocator initialised with 65536 entries323server # [ 0.020282] Serial: AMBA PL011 UART driver324host1 # [ 0.008685] Memory: 1921592K/2097152K available (24448K kernel code, 7090K rwdata, 26348K rodata, 4736K init, 1107K bss, 131976K reserved, 32768K cma-reserved)325server # [ 0.025455] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1326host1 # [ 0.009173] devtmpfs: initialized327server # [ 0.025622] printk: console [ttyAMA0] enabled328host1 # [ 0.011124] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)329host1 # [ 0.011148] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).330host1 # [ 0.011361] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL331host1 # [ 0.011366] 0 pages in range for non-PLT usage332host1 # [ 0.011367] 508288 pages in range for PLT usage333host1 # [ 0.011470] pinctrl core: initialized pinctrl subsystem334host1 # [ 0.012340] DMI not present or invalid.335host1 # [ 0.015532] NET: Registered PF_NETLINK/PF_ROUTE protocol family336host1 # [ 0.017879] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations337host1 # [ 0.018079] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations338host1 # [ 0.018282] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations339host1 # [ 0.018304] audit: initializing netlink subsys (disabled)340server # [ 0.150895] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages341host1 # [ 0.018878] thermal_sys: Registered thermal governor 'fair_share'342server # [ 0.150913] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page343host1 # [ 0.018880] thermal_sys: Registered thermal governor 'bang_bang'344server # [ 0.150919] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages345host1 # [ 0.018884] thermal_sys: Registered thermal governor 'step_wise'346server # [ 0.150923] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page347host1 # [ 0.018886] thermal_sys: Registered thermal governor 'user_space'348server # [ 0.150928] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages349host1 # [ 0.018894] thermal_sys: Registered thermal governor 'power_allocator'350server # [ 0.150932] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page351host1 # [ 0.018918] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1352server # [ 0.150936] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages353host1 # [ 0.018927] cpuidle: using governor ladder354server # [ 0.150940] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page355host1 # [ 0.018933] cpuidle: using governor menu356host1 # [ 0.019125] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.357host1 # [ 0.019148] ASID allocator initialised with 65536 entries358host1 # [ 0.020343] Serial: AMBA PL011 UART driver359server # [ 0.158662] fbcon: Taking over console360server # [ 0.158679] ACPI: Interpreter disabled.361host1 # [ 0.025516] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1362server # [ 0.160601] iommu: Default domain type: Translated363host1 # [ 0.025682] printk: console [ttyAMA0] enabled364server # [ 0.160611] iommu: DMA domain TLB invalidation policy: strict mode365server # [ 0.162401] SCSI subsystem initialized366server # [ 0.163074] usbcore: registered new interface driver usbfs367server # [ 0.163107] usbcore: registered new interface driver hub368server # [ 0.163125] usbcore: registered new device driver usb369server # [ 0.165306] pps_core: LinuxPPS API ver. 1 registered370server # [ 0.165316] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>371server # [ 0.165327] PTP clock support registered372server # [ 0.165382] EDAC MC: Ver: 3.0.0373host1 # [ 0.151773] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages374host1 # [ 0.151795] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page375host1 # [ 0.151800] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages376host1 # [ 0.151804] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page377host1 # [ 0.151809] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages378host1 # [ 0.151813] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page379host1 # [ 0.151817] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages380host1 # [ 0.151821] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page381server # [ 0.175824] scmi_core: SCMI protocol bus registered382server # [ 0.176828] FPGA manager framework383host1 # [ 0.159687] fbcon: Taking over console384server # [ 0.177804] vgaarb: loaded385host1 # [ 0.159705] ACPI: Interpreter disabled.386server # [ 0.178455] clocksource: Switched to clocksource arch_sys_counter387server # [ 0.182119] VFS: Disk quotas dquot_6.6.0388server # [ 0.182174] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)389server # [ 0.183901] netfs: FS-Cache loaded390server # [ 0.184038] pnp: PnP ACPI: disabled391host1 # [ 0.168234] iommu: Default domain type: Translated392host1 # [ 0.168245] iommu: DMA domain TLB invalidation policy: strict mode393host1 # [ 0.168616] SCSI subsystem initialized394host1 # [ 0.170712] usbcore: registered new interface driver usbfs395host1 # [ 0.170746] usbcore: registered new interface driver hub396host1 # [ 0.170764] usbcore: registered new device driver usb397server # [ 0.188091] NET: Registered PF_INET protocol family398host1 # [ 0.171023] pps_core: LinuxPPS API ver. 1 registered399server # [ 0.188371] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)400host1 # [ 0.171030] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>401host1 # [ 0.171040] PTP clock support registered402host1 # [ 0.171096] EDAC MC: Ver: 3.0.0403host1 # [ 0.175938] scmi_core: SCMI protocol bus registered404host1 # [ 0.176973] FPGA manager framework405host1 # [ 0.177955] vgaarb: loaded406host1 # [ 0.178634] clocksource: Switched to clocksource arch_sys_counter407host1 # [ 0.183237] VFS: Disk quotas dquot_6.6.0408host1 # [ 0.183296] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)409host1 # [ 0.184997] netfs: FS-Cache loaded410host1 # [ 0.185123] pnp: PnP ACPI: disabled411host1 # [ 0.189380] NET: Registered PF_INET protocol family412host1 # [ 0.189654] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)413server # [ 0.217492] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)414server # [ 0.217539] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)415server # [ 0.217585] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)416server # [ 0.217661] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)417server # [ 0.217803] TCP: Hash tables configured (established 16384 bind 16384)418server # [ 0.217886] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)419server # [ 0.217920] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)420server # [ 0.217960] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)421server # [ 0.218048] NET: Registered PF_UNIX/PF_LOCAL protocol family422server # [ 0.218096] NET: Registered PF_XDP protocol family423server # [ 0.218117] PCI: CLS 0 bytes, default 64424server # [ 0.218372] Trying to unpack rootfs image as initramfs...425server # [ 0.236174] kvm [1]: HYP mode not available426host1 # [ 0.219438] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)427host1 # [ 0.219489] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)428host1 # [ 0.219518] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)429host1 # [ 0.219590] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)430host1 # [ 0.219734] TCP: Hash tables configured (established 16384 bind 16384)431host1 # [ 0.219834] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)432host1 # [ 0.219871] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)433host1 # [ 0.219910] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)434host1 # [ 0.220018] NET: Registered PF_UNIX/PF_LOCAL protocol family435host1 # [ 0.220057] NET: Registered PF_XDP protocol family436host1 # [ 0.220079] PCI: CLS 0 bytes, default 64437host1 # [ 0.220364] Trying to unpack rootfs image as initramfs...438host1 # [ 0.236566] kvm [1]: HYP mode not available439server # [ 0.331010] Initialise system trusted keyrings440server # [ 0.331766] workingset: timestamp_bits=42 max_order=19 bucket_order=0441server # [ 0.333101] squashfs: version 4.0 (2009/01/31) Phillip Lougher442server # [ 0.333922] 9p: Installing v9fs 9p2000 file system support443host1 # [ 0.331198] Initialise system trusted keyrings444host1 # [ 0.331956] workingset: timestamp_bits=42 max_order=19 bucket_order=0445host1 # [ 0.333275] squashfs: version 4.0 (2009/01/31) Phillip Lougher446host1 # [ 0.334065] 9p: Installing v9fs 9p2000 file system support447server # [ 0.362592] Key type asymmetric registered448server # [ 0.362620] Asymmetric key parser 'x509' registered449server # [ 0.362711] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)450server # [ 0.364869] io scheduler mq-deadline registered451server # [ 0.364880] io scheduler kyber registered452server # [ 0.374623] pl061_gpio 9030000.pl061: PL061 GPIO chip registered453server # [ 0.376040] ledtrig-cpu: registered to indicate activity on CPUs454server # [ 0.376454] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:455host1 # [ 0.362744] Key type asymmetric registered456server # [ 0.376472] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000457host1 # [ 0.362772] Asymmetric key parser 'x509' registered458server # [ 0.376484] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000459host1 # [ 0.362858] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)460host1 # [ 0.365163] io scheduler mq-deadline registered461server # [ 0.376493] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000462host1 # [ 0.365173] io scheduler kyber registered463server # [ 0.376519] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits464server # [ 0.376545] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]465server # [ 0.376627] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00466server # [ 0.376637] pci_bus 0000:00: root bus resource [bus 00-ff]467server # [ 0.376644] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]468server # [ 0.376649] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]469server # [ 0.376655] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]470server # [ 0.376759] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint471server # [ 0.377195] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint472server # [ 0.377383] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]473server # [ 0.377399] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]474host1 # [ 0.374772] pl061_gpio 9030000.pl061: PL061 GPIO chip registered475server # [ 0.377429] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]476server # [ 0.377445] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]477server # [ 0.377922] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint478server # [ 0.378106] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]479host1 # [ 0.376211] ledtrig-cpu: registered to indicate activity on CPUs480server # [ 0.378122] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]481host1 # [ 0.376605] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:482server # [ 0.378151] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]483host1 # [ 0.376624] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000484host1 # [ 0.376651] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000485host1 # [ 0.376659] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000486host1 # [ 0.376681] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits487host1 # [ 0.376713] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]488host1 # [ 0.376790] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00489host1 # [ 0.376800] pci_bus 0000:00: root bus resource [bus 00-ff]490host1 # [ 0.376806] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]491host1 # [ 0.376812] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]492host1 # [ 0.376817] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]493host1 # [ 0.376880] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint494host1 # [ 0.377324] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint495host1 # [ 0.377518] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]496host1 # [ 0.377535] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]497server # [ 0.402674] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint498host1 # [ 0.377565] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]499server # [ 0.402873] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]500host1 # [ 0.377582] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]501server # [ 0.402889] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]502host1 # [ 0.378040] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint503server # [ 0.402927] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]504host1 # [ 0.378225] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]505server # [ 0.403393] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint506host1 # [ 0.378242] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]507server # [ 0.403576] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]508host1 # [ 0.378273] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]509server # [ 0.403592] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]510server # [ 0.403621] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]511host1 # [ 0.398364] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint512host1 # [ 0.398552] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]513server # [ 0.404079] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint514host1 # [ 0.398568] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]515server # [ 0.404264] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]516host1 # [ 0.398598] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]517server # [ 0.404280] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]518server # [ 0.404309] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]519server # [ 0.404768] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint520server # [ 0.404953] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]521server # [ 0.404969] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]522server # [ 0.404999] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]523server # [ 0.405451] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint524server # [ 0.405649] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]525server # [ 0.405665] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]526server # [ 0.405694] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]527server # [ 0.405711] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]528server # [ 0.406206] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint529server # [ 0.406395] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]530host1 # [ 0.407154] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint531host1 # [ 0.407360] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]532server # [ 0.406425] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]533host1 # [ 0.407377] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]534server # [ 0.406906] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint535host1 # [ 0.407408] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]536server # [ 0.407096] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]537host1 # [ 0.407871] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint538server # [ 0.407126] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]539host1 # [ 0.408056] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]540server # [ 0.407525] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint541host1 # [ 0.408072] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]542server # [ 0.407709] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]543host1 # [ 0.408103] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]544server # [ 0.407960] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint545host1 # [ 0.408585] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint546server # [ 0.408259] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]547host1 # [ 0.408769] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]548server # [ 0.408276] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]549host1 # [ 0.408785] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]550server # [ 0.408306] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]551host1 # [ 0.408815] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]552server # [ 0.408761] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint553host1 # [ 0.409305] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint554server # [ 0.408946] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]555host1 # [ 0.409490] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]556server # [ 0.408962] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]557host1 # [ 0.409505] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]558server # [ 0.408991] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559host1 # [ 0.409535] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560server # [ 0.409587] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned561host1 # [ 0.409551] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]562server # [ 0.409599] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned563host1 # [ 0.410022] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint564server # [ 0.409606] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned565host1 # [ 0.410209] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]566server # [ 0.409652] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned567host1 # [ 0.410240] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]568server # [ 0.409699] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned569server # [ 0.409745] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned570server # [ 0.409792] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned571server # [ 0.409840] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned572server # [ 0.409887] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned573host1 # [ 0.426932] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint574host1 # [ 0.427123] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]575server # [ 0.409933] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned576host1 # [ 0.427153] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]577server # [ 0.409981] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned578host1 # [ 0.427550] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint579server # [ 0.410030] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned580host1 # [ 0.427732] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]581server # [ 0.410103] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned582host1 # [ 0.427994] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint583server # [ 0.410149] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned584host1 # [ 0.428302] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]585server # [ 0.410171] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned586host1 # [ 0.428319] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]587server # [ 0.410192] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned588host1 # [ 0.428349] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]589server # [ 0.410214] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned590host1 # [ 0.428808] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint591server # [ 0.410236] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned592host1 # [ 0.428993] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]593server # [ 0.410261] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned594host1 # [ 0.429009] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]595server # [ 0.410283] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned596host1 # [ 0.429038] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]597server # [ 0.410305] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned598host1 # [ 0.429624] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned599server # [ 0.410327] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned600host1 # [ 0.429636] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned601server # [ 0.410349] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned602host1 # [ 0.429642] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned603server # [ 0.410371] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned604host1 # [ 0.429687] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned605server # [ 0.410393] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned606server # [ 0.410415] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned607host1 # [ 0.429735] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned608server # [ 0.410436] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned609host1 # [ 0.429782] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned610host1 # [ 0.429828] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned611host1 # [ 0.429876] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned612host1 # [ 0.429923] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned613host1 # [ 0.429969] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned614host1 # [ 0.430016] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned615host1 # [ 0.430063] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned616host1 # [ 0.430136] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned617host1 # [ 0.430182] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned618host1 # [ 0.430203] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned619host1 # [ 0.430225] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned620server # [ 0.470478] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned621host1 # [ 0.430247] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned622server # [ 0.470522] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned623host1 # [ 0.430269] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned624server # [ 0.470544] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned625host1 # [ 0.430294] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned626server # [ 0.470566] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned627host1 # [ 0.430316] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned628server # [ 0.470589] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned629server # [ 0.470612] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned630host1 # [ 0.430338] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned631server # [ 0.470634] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned632host1 # [ 0.430361] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned633server # [ 0.470664] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]634host1 # [ 0.430383] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned635server # [ 0.470674] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]636host1 # [ 0.430406] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned637server # [ 0.470678] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]638host1 # [ 0.430428] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned639server # [ 0.471842] pci 0000:00:0a.0: enabling device (0000 -> 0002)640host1 # [ 0.430450] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned641host1 # [ 0.430471] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned642host1 # [ 0.430493] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned643host1 # [ 0.430515] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned644host1 # [ 0.430536] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned645host1 # [ 0.430558] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned646host1 # [ 0.430580] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned647host1 # [ 0.430602] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned648host1 # [ 0.430625] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned649host1 # [ 0.478704] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]650host1 # [ 0.478724] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]651host1 # [ 0.478729] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]652host1 # [ 0.479892] pci 0000:00:0a.0: enabling device (0000 -> 0002)653server # [ 0.504971] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)654server # [ 0.508217] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)655server # [ 0.510244] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)656server # [ 0.519954] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)657server # [ 0.522004] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)658host1 # [ 0.502961] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)659host1 # [ 0.505240] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)660server # [ 0.533823] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)661host1 # [ 0.516556] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)662host1 # [ 0.518613] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)663server # [ 0.543808] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)664host1 # [ 0.528398] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)665server # [ 0.548810] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)666server # [ 0.551099] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)667server # [ 0.552932] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)668host1 # [ 0.534835] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)669host1 # [ 0.537007] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)670server # [ 0.563739] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)671host1 # [ 0.547200] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)672host1 # [ 0.549502] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)673server # [ 0.579736] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled674server # [ 0.582408] msm_serial: driver initialized675host1 # [ 0.559344] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)676host1 # [ 0.562140] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)677server # [ 0.583134] SuperH (H)SCI(F) driver initialized678server # [ 0.583190] STM32 USART driver initialized679host1 # [ 0.575911] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled680host1 # [ 0.578693] msm_serial: driver initialized681host1 # [ 0.578849] SuperH (H)SCI(F) driver initialized682host1 # [ 0.578902] STM32 USART driver initialized683server # [ 0.613747] loop: module loaded684server # [ 0.613968] virtio_blk virtio5: 1/0/0 default/read/poll queues685server # [ 0.616049] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)686host1 # [ 0.612968] loop: module loaded687host1 # [ 0.613186] virtio_blk virtio5: 1/0/0 default/read/poll queues688host1 # [ 0.614007] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)689server # [ 0.627283] megasas: 07.734.00.00-rc1690server # [ 0.628110] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]691server # [ 0.630177] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000692server # [ 0.630220] Intel/Sharp Extended Query Table at 0x0031693server # [ 0.632050] Using buffer write method694server # [ 0.632143] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]695server # [ 0.634016] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000696host1 # [ 0.619319] megasas: 07.734.00.00-rc1697server # [ 0.634054] Intel/Sharp Extended Query Table at 0x0031698host1 # [ 0.620008] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]699server # [ 0.654407] Using buffer write method700server # [ 0.655140] Concatenating MTD devices:701server # [ 0.655146] (0): "0.flash"702server # [ 0.655151] (1): "0.flash"703server # [ 0.655154] into device "0.flash"704host1 # [ 0.639980] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000705host1 # [ 0.640022] Intel/Sharp Extended Query Table at 0x0031706host1 # [ 0.641734] Using buffer write method707host1 # [ 0.641811] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]708host1 # [ 0.647030] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000709host1 # [ 0.647052] Intel/Sharp Extended Query Table at 0x0031710host1 # [ 0.648793] Using buffer write method711host1 # [ 0.648819] Concatenating MTD devices:712host1 # [ 0.648824] (0): "0.flash"713host1 # [ 0.648828] (1): "0.flash"714host1 # [ 0.648831] into device "0.flash"715server # [ 0.911078] Freeing initrd memory: 26140K716server # [ 0.917258] tun: Universal TUN/TAP device driver, 1.6717server # [ 0.920994] thunder_xcv, ver 1.0718server # [ 0.921036] thunder_bgx, ver 1.0719server # [ 0.921059] nicpf, ver 1.0720server # [ 0.921616] e1000: Intel(R) PRO/1000 Network Driver721host1 # [ 0.906725] Freeing initrd memory: 26160K722server # [ 0.921622] e1000: Copyright (c) 1999-2006 Intel Corporation.723server # [ 0.921647] e1000e: Intel(R) PRO/1000 Network Driver724server # [ 0.921655] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.725server # [ 0.921684] igb: Intel(R) Gigabit Ethernet Network Driver726server # [ 0.921690] igb: Copyright (c) 2007-2014 Intel Corporation.727server # [ 0.921712] igbvf: Intel(R) Gigabit Virtual Function Network Driver728server # [ 0.921718] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.729server # [ 0.921853] sky2: driver version 1.30730host1 # [ 0.912793] tun: Universal TUN/TAP device driver, 1.6731server # [ 0.931191] ehci-pci 0000:00:0a.0: EHCI Host Controller732server # [ 0.931223] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1733server # [ 0.931505] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000734server # [ 0.934062] usbcore: registered new interface driver usb-storage735server # [ 0.934191] usbcore: registered new interface driver usbserial_generic736server # [ 0.934206] usbserial: USB Serial support registered for generic737host1 # [ 0.916507] thunder_xcv, ver 1.0738host1 # [ 0.916553] thunder_bgx, ver 1.0739host1 # [ 0.916578] nicpf, ver 1.0740server # [ 0.937078] hv_vmbus: registering driver hyperv_keyboard741host1 # [ 0.917121] e1000: Intel(R) PRO/1000 Network Driver742host1 # [ 0.917129] e1000: Copyright (c) 1999-2006 Intel Corporation.743host1 # [ 0.917154] e1000e: Intel(R) PRO/1000 Network Driver744server # [ 0.938641] rtc-pl031 9010000.pl031: registered as rtc0745host1 # [ 0.917163] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.746server # [ 0.938666] rtc-pl031 9010000.pl031: setting system clock to 2026-09-20T08:16:51 UTC (1789892211)747host1 # [ 0.917194] igb: Intel(R) Gigabit Ethernet Network Driver748server # [ 0.938964] i2c_dev: i2c /dev entries driver749host1 # [ 0.917200] igb: Copyright (c) 2007-2014 Intel Corporation.750host1 # [ 0.917227] igbvf: Intel(R) Gigabit Virtual Function Network Driver751host1 # [ 0.917233] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.752host1 # [ 0.917366] sky2: driver version 1.30753host1 # [ 0.919360] ehci-pci 0000:00:0a.0: EHCI Host Controller754host1 # [ 0.919392] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1755host1 # [ 0.919553] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000756server # [ 0.943972] sdhci: Secure Digital Host Controller Interface driver757server # [ 0.943981] sdhci: Copyright(c) Pierre Ossman758server # [ 0.944245] Synopsys Designware Multimedia Card Interface Driver759host1 # [ 0.929479] usbcore: registered new interface driver usb-storage760server # [ 0.944607] sdhci-pltfm: SDHCI platform and OF driver helper761host1 # [ 0.929575] usbcore: registered new interface driver usbserial_generic762server # [ 0.946274] hid: raw HID events driver (C) Jiri Kosina763host1 # [ 0.929590] usbserial: USB Serial support registered for generic764server # [ 0.946492] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00765server # [ 0.946786] hub 1-0:1.0: USB hub found766host1 # [ 0.930173] hv_vmbus: registering driver hyperv_keyboard767server # [ 0.946805] hub 1-0:1.0: 6 ports detected768host1 # [ 0.930685] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00769host1 # [ 0.930999] hub 1-0:1.0: USB hub found770host1 # [ 0.931030] hub 1-0:1.0: 6 ports detected771server # [ 0.952348] usbcore: registered new interface driver usbhid772server # [ 0.952359] usbhid: USB HID core driver773host1 # [ 0.936472] rtc-pl031 9010000.pl031: registered as rtc0774host1 # [ 0.936500] rtc-pl031 9010000.pl031: setting system clock to 2026-09-20T08:16:51 UTC (1789892211)775host1 # [ 0.936826] i2c_dev: i2c /dev entries driver776server # [ 0.954644] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available777server # [ 0.956152] drop_monitor: Initializing network drop monitor service778server # [ 0.956301] NET: Registered PF_INET6 protocol family779server # [ 0.959321] Segment Routing with IPv6780server # [ 0.959338] In-situ OAM (IOAM) with IPv6781host1 # [ 0.941755] sdhci: Secure Digital Host Controller Interface driver782server # [ 0.959365] NET: Registered PF_PACKET protocol family783host1 # [ 0.941774] sdhci: Copyright(c) Pierre Ossman784host1 # [ 0.942040] Synopsys Designware Multimedia Card Interface Driver785host1 # [ 0.942408] sdhci-pltfm: SDHCI platform and OF driver helper786server # [ 0.961000] 9pnet: Installing 9P2000 support787host1 # [ 0.946868] hid: raw HID events driver (C) Jiri Kosina788host1 # [ 0.947122] usbcore: registered new interface driver usbhid789server # [ 0.963828] Key type dns_resolver registered790host1 # [ 0.947129] usbhid: USB HID core driver791host1 # [ 0.950037] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available792server # [ 0.970277] registered taskstats version 1793host1 # [ 0.952671] drop_monitor: Initializing network drop monitor service794server # [ 0.970445] Loading compiled-in X.509 certificates795host1 # [ 0.952861] NET: Registered PF_INET6 protocol family796host1 # [ 0.954978] Segment Routing with IPv6797host1 # [ 0.954998] In-situ OAM (IOAM) with IPv6798host1 # [ 0.955026] NET: Registered PF_PACKET protocol family799host1 # [ 0.956655] 9pnet: Installing 9P2000 support800server # [ 0.979180] Demotion targets for Node 0: null801host1 # [ 0.959339] Key type dns_resolver registered802server # [ 0.979285] Key type .fscrypt registered803server # [ 0.979292] Key type fscrypt-provisioning registered804server # [ 0.979389] ima: No TPM chip found, activating TPM-bypass!805server # [ 0.979409] ima: Allocated hash algorithm: sha1806server # [ 0.979434] ima: No architecture policies found807server # [ 0.983485] input: gpio-keys as /devices/platform/gpio-keys/input/input0808host1 # [ 0.965809] registered taskstats version 1809host1 # [ 0.965960] Loading compiled-in X.509 certificates810host1 # [ 0.974447] Demotion targets for Node 0: null811host1 # [ 0.974557] Key type .fscrypt registered812host1 # [ 0.974564] Key type fscrypt-provisioning registered813host1 # [ 0.976472] ima: No TPM chip found, activating TPM-bypass!814host1 # [ 0.976497] ima: Allocated hash algorithm: sha1815host1 # [ 0.976520] ima: No architecture policies found816host1 # [ 0.978966] input: gpio-keys as /devices/platform/gpio-keys/input/input0817server # [ 1.001165] clk: Disabling unused clocks818server # [ 1.001198] PM: genpd: Disabling unused power domains819server # [ 1.005475] Freeing unused kernel memory: 4736K820server # [ 1.005687] Run /init as init process821host1 # [ 0.997467] clk: Disabling unused clocks822host1 # [ 0.997501] PM: genpd: Disabling unused power domains823host1 # [ 1.001794] Freeing unused kernel memory: 4736K824host1 # [ 1.002014] Run /init as init process825server # [ 1.020758] systemd[1]: Successfully made /usr/ read-only.826host1 # [ 1.016996] systemd[1]: Successfully made /usr/ read-only.827host1 # [ 1.178726] usb 1-1: new high-speed USB device number 2 using ehci-pci828server # [ 1.198546] usb 1-1: new high-speed USB device number 2 using ehci-pci829server # [ 1.348311] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1830host1 # [ 1.331017] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1831server # [ 1.355685] 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)832server # [ 1.368229] systemd[1]: Detected virtualization qemu.833server # [ 1.368339] systemd[1]: Detected architecture arm64.834host1 # [ 1.351655] 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)835host1 # [ 1.357071] systemd[1]: Detected virtualization qemu.836server # [ 1.368365] systemd[1]: Running in initrd.837host1 # [ 1.358033] systemd[1]: Detected architecture arm64.838host1 # [ 1.358922] systemd[1]: Running in initrd.839server # [ 1.369315] systemd[1]: Initializing machine ID from random generator.840host1 # [ 1.360201] systemd[1]: Initializing machine ID from random generator.841host1 # [ 1.361463] systemd[1]: Hostname set to <host1>.842server # [ 1.369642] systemd[1]: Hostname set to <server>.843host1 # [ 1.410848] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0844server # [ 1.434790] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0845host1 # [ 1.530697] usb 1-2: new high-speed USB device number 3 using ehci-pci846server # [ 1.558556] usb 1-2: new high-speed USB device number 3 using ehci-pci847host1 # [ 1.626868] systemd[1]: bpf-restrict-fs: LSM BPF program attached848server # [ 1.663354] systemd[1]: bpf-restrict-fs: LSM BPF program attached849host1 # [ 1.689602] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2850host1 # [ 1.689781] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0851server # [ 1.712220] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2852server # [ 1.714068] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0853server # [ 1.726065] systemd[1]: Queued start job for default target Initrd Default Target.854host1 # [ 1.710104] systemd[1]: Queued start job for default target Initrd Default Target.855server # [ 1.736412] systemd[1]: Created slice Slice /system/modprobe.856server # [ 1.737417] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.857server # [ 1.738516] systemd[1]: Expecting device /dev/disk/by-label/nixos...858host1 # [ 1.721126] systemd[1]: Created slice Slice /system/modprobe.859server # [ 1.739346] systemd[1]: Reached target Path Units.860server # [ 1.739972] systemd[1]: Reached target Slice Units.861host1 # [ 1.722323] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.862server # [ 1.740685] systemd[1]: Reached target Swaps.863server # [ 1.741264] systemd[1]: Reached target Timer Units.864server # [ 1.742094] systemd[1]: Listening on D-Bus System Message Bus Socket.865server # [ 1.743096] systemd[1]: Listening on Journal Socket (/dev/log).866host1 # [ 1.723738] systemd[1]: Expecting device /dev/disk/by-label/nixos...867server # [ 1.744065] systemd[1]: Listening on Journal Sockets.868host1 # [ 1.723782] systemd[1]: Reached target Path Units.869server # [ 1.744841] systemd[1]: Listening on udev Control Socket.870host1 # [ 1.723805] systemd[1]: Reached target Slice Units.871server # [ 1.745656] systemd[1]: Listening on udev Kernel Socket.872host1 # [ 1.723826] systemd[1]: Reached target Swaps.873server # [ 1.746351] systemd[1]: Reached target Socket Units.874host1 # [ 1.723848] systemd[1]: Reached target Timer Units.875host1 # [ 1.724053] systemd[1]: Listening on D-Bus System Message Bus Socket.876host1 # [ 1.724231] systemd[1]: Listening on Journal Socket (/dev/log).877server # [ 1.748454] systemd[1]: Starting Create List of Static Device Nodes...878host1 # [ 1.724377] systemd[1]: Listening on Journal Sockets.879host1 # [ 1.724508] systemd[1]: Listening on udev Control Socket.880host1 # [ 1.724627] systemd[1]: Listening on udev Kernel Socket.881host1 # [ 1.724650] systemd[1]: Reached target Socket Units.882host1 # [ 1.735318] systemd[1]: Starting Create List of Static Device Nodes...883server # [ 1.757914] systemd[1]: Starting Load Kernel Module 9pnet_virtio...884server # [ 1.759020] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs885host1 # [ 1.742809] systemd[1]: Starting Load Kernel Module 9pnet_virtio...886host1 # [ 1.743922] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs887host1 # [ 1.750329] systemd[1]: Mounting Kernel Configuration File System...888server # [ 1.767813] systemd[1]: Mounting Kernel Configuration File System...889server # [ 1.786731] systemd[1]: Starting Journal Service...890host1 # [ 1.766839] systemd[1]: Starting Journal Service...891server # [ 1.788942] systemd[1]: Starting Load Kernel Modules...892server # [ 1.789785] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os893host1 # [ 1.779467] systemd[1]: Starting Load Kernel Modules...894host1 # [ 1.780441] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os895server # [ 1.803469] systemd[1]: Starting Coldplug All udev Devices...896host1 # [ 1.791031] systemd[1]: Starting Coldplug All udev Devices...897server # [ 1.822655] systemd[1]: Finished Create List of Static Device Nodes.898server # [ 1.823535] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.899server # [ 1.823833] systemd[1]: Finished Load Kernel Module 9pnet_virtio.900server # [ 1.824070] systemd[1]: Mounted Kernel Configuration File System.901host1 # [ 1.811213] systemd[1]: Finished Create List of Static Device Nodes.902host1 # [ 1.812404] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.903host1 # [ 1.812710] systemd[1]: Finished Load Kernel Module 9pnet_virtio.904server # [ 1.842846] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...905host1 # [ 1.839473] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.906host1 # [ 1.849074] systemd-journald[73]: Collecting audit messages is disabled.907server # [ 1.875366] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.908host1 # [ 1.858713] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev909host1 # [ 1.860920] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...910server # [ 1.878270] systemd-journald[73]: Collecting audit messages is disabled.911server # [ 1.878980] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.912server # [ 1.882312] systemd[1]: Starting Create Static Device Nodes in /dev...913host1 # [ 1.866603] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0914host1 # [ 1.875118] systemd[1]: Mounted Kernel Configuration File System.915server # [ 1.894951] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev916host1 # [ 1.878906] [drm] features: -virgl +edid -resource_blob -host_visible917host1 # [ 1.878922] [drm] features: -context_init918host1 # [ 1.879747] [drm] number of scanouts: 1919host1 # [ 1.879767] [drm] number of cap sets: 0920server # [ 1.906496] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0921server # [ 1.906730] [drm] features: -virgl +edid -resource_blob -host_visible922server # [ 1.906740] [drm] features: -context_init923server # [ 1.907504] [drm] number of scanouts: 1924server # [ 1.907523] [drm] number of cap sets: 0925host1 # [ 1.890982] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic926host1 # [ 1.891004] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0927server # [ 1.926495] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic928server # [ 1.926524] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0929host1 # [ 1.919297] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.930host1 # [ 1.921719] systemd[1]: Starting Create Static Device Nodes in /dev...931server # [ 1.939210] systemd[1]: Finished Create Static Device Nodes in /dev.932server # [ 1.939618] systemd[1]: Reached target Preparation for Local File Systems.933server # [ 1.939648] systemd[1]: Reached target Local File Systems.934server # [ 1.946844] systemd[1]: Starting Rule-based Manager for Device Events and Files...935host1 # [ 1.926848] Console: switching to colour frame buffer device 160x50936server # [ 1.965404] Console: switching to colour frame buffer device 160x50937server # [ 1.972150] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device938host1 # [ 1.955271] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device939host1 # [ 1.967282] systemd[1]: Finished Create Static Device Nodes in /dev.940host1 # [ 1.967497] systemd[1]: Reached target Preparation for Local File Systems.941host1 # [ 1.967532] systemd[1]: Reached target Local File Systems.942host1 # [ 1.975034] systemd[1]: Starting Rule-based Manager for Device Events and Files...943server # [ 2.007166] systemd[1]: Finished Load Kernel Modules.944host1 # [ 1.999257] systemd[1]: Finished Load Kernel Modules.945host1 # [ 2.002751] systemd[1]: Starting Apply Kernel Variables...946server # [ 2.018844] systemd[1]: Starting Apply Kernel Variables...947host1 # [ 2.042883] systemd[1]: Started Journal Service.948host1 # [ 2.027815] systemd-modules-load[74]: Inserted module 'dm_mod'949server # [ 2.061981] systemd[1]: Started Journal Service.950host1 # [ 2.029058] systemd-modules-load[74]: Module 'virtio_balloon' is built in951host1 # [ 2.037949] systemd-modules-load[74]: Module 'virtio_console' is built in952server # [ 2.059728] systemd-modules-load[74]: Inserted module 'dm_mod'953server # [ 2.061151] systemd-modules-load[74]: Module 'virtio_balloon' is built in954host1 # [ 2.044343] systemd-modules-load[74]: Inserted module 'virtio_gpu'955server # [ 2.062279] systemd-modules-load[74]: Module 'virtio_console' is built in956server # [ 2.063413] systemd-modules-load[74]: Inserted module 'virtio_gpu'957host1 # [ 2.048324] systemd-modules-load[74]: Module 'virtio_rng' is built in958host1 # [ 2.050648] systemd[1]: Starting Create System Files and Directories...959server # [ 2.068335] systemd-modules-load[74]: Module 'virtio_rng' is built in960server # [ 2.069694] systemd-udevd[81]: Using default interface naming scheme 'v261'.961host1 # [ 2.060422] systemd[1]: Finished Apply Kernel Variables.962server # [ 2.078763] systemd[1]: Starting Create System Files and Directories...963server # [ 2.088548] systemd[1]: Finished Apply Kernel Variables.964server # [ 2.098552] systemd[1]: Finished Create System Files and Directories.965host1 # [ 2.091582] systemd-udevd[80]: Using default interface naming scheme 'v261'.966host1 # [ 2.096296] systemd[1]: Finished Create System Files and Directories.967server # [ 2.117494] systemd[1]: Started Rule-based Manager for Device Events and Files.968host1 # [ 2.122737] systemd[1]: Started Rule-based Manager for Device Events and Files.969server # [ 2.175937] systemd[1]: Starting Virtual Console Setup...970host1 # [ 2.187428] systemd[1]: Starting Virtual Console Setup...971server # [ 2.228529] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.972server # [ 2.232069] systemd[1]: Finished Virtual Console Setup.973host1 # [ 2.244499] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.974host1 # [ 2.248187] systemd[1]: Finished Virtual Console Setup.975server # [ 2.832880] systemd[1]: Finished Coldplug All udev Devices.976server # [ 2.834587] systemd[1]: Reached target System Initialization.977server # [ 2.835551] systemd[1]: Reached target Basic System.978host1 # [ 2.846507] systemd[1]: Finished Coldplug All udev Devices.979host1 # [ 2.847534] systemd[1]: Reached target System Initialization.980host1 # [ 2.848526] systemd[1]: Reached target Basic System.981server # [ 3.000464] (udev-worker)[108]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.982server # [ 3.005236] (udev-worker)[108]: Network interface NamePolicy= disabled on kernel command line.983server # [ 3.022596] (udev-worker)[94]: Network interface NamePolicy= disabled on kernel command line.984host1 # [ 3.039919] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.985host1 # [ 3.044896] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.986host1 # [ 3.048592] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.987server # [ 3.119163] systemd[1]: Found device /dev/disk/by-label/nixos.988server # [ 3.124247] systemd[1]: Reached target Initrd Root Device.989server # [ 3.127785] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...990host1 # [ 3.121573] systemd[1]: Found device /dev/disk/by-label/nixos.991host1 # [ 3.130405] systemd[1]: Reached target Initrd Root Device.992host1 # [ 3.135315] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...993server # [ 3.175007] systemd-fsck[117]: nixos: clean, 12/65536 files, 13019/262144 blocks994server # [ 3.180940] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.995server # [ 3.184797] systemd[1]: Mounting /sysroot...996host1 # [ 3.186453] systemd-fsck[116]: nixos: clean, 12/65536 files, 13019/262144 blocks997host1 # [ 3.196203] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.998host1 # [ 3.200276] systemd[1]: Mounting /sysroot...999server # [ 3.241091] EXT4-fs (vda): mounted filesystem d3e8a63a-9a91-4ace-8398-67c7af8e3882 r/w with ordered data mode. Quota mode: none.1000server # [ 3.228983] systemd[1]: Mounted /sysroot.1001server # [ 3.232405] systemd[1]: Reached target Initrd Root File System.1002server # [ 3.236212] systemd[1]: Starting Mountpoints Configured in the Real Root...1003host1 # [ 3.258822] EXT4-fs (vda): mounted filesystem c970a448-5f3e-456b-a368-ce11def994d0 r/w with ordered data mode. Quota mode: none.1004host1 # [ 3.246456] systemd[1]: Mounted /sysroot.1005host1 # [ 3.249036] systemd[1]: Reached target Initrd Root File System.1006server # [ 3.266213] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.1007host1 # [ 3.252750] systemd[1]: Starting Mountpoints Configured in the Real Root...1008server # [ 3.270629] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1009server # [ 3.276232] systemd[1]: Reloading...1010host1 # [ 3.283473] systemd-sysroot-fstab-check[124]: /sysroot should be mounted in the initrd, will request daemon-reload.1011host1 # [ 3.287909] systemd[1]: Reload requested from client PID 124 ('systemd-sysroot') (unit initrd-parse-etc.service)...1012host1 # [ 3.293309] systemd[1]: Reloading...1013server # [ 3.488947] systemd[1]: Reloading finished in 214 ms.1014server # [ 3.525951] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1015host1 # [ 3.509598] systemd[1]: Reloading finished in 218 ms.1016server # [ 3.532223] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1017server # [ 3.534522] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1018server # [ 3.542926] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019server # [ 3.546216] systemd[1]: Finished Mountpoints Configured in the Real Root.1020server # [ 3.549177] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1021host1 # [ 3.542167] systemd-sysroot-fstab-check[124]: Requesting initrd-fs.target/start/replace...1022host1 # [ 3.548355] systemd-sysroot-fstab-check[124]: Requesting swap.target/start/replace...1023server # [ 3.568582] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1024host1 # [ 3.552736] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1025server # [ 3.571803] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1026host1 # [ 3.558502] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1027host1 # [ 3.567360] systemd[1]: Finished Mountpoints Configured in the Real Root.1028host1 # [ 3.569765] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1029host1 # [ 3.584773] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1030host1 # [ 3.587831] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1031host1 # [ 3.779459] systemd[1]: Mounting /sysroot/nix/.ro-store...1032host1 # [ 3.795761] systemd[1]: Mounting /sysroot/nix/.rw-store...1033server # [ 3.815914] systemd[1]: Mounting /sysroot/nix/.ro-store...1034host1 # [ 3.802336] systemd[1]: Mounting /sysroot/run...1035server # [ 3.820256] systemd[1]: Mounting /sysroot/nix/.rw-store...1036server # [ 3.824435] systemd[1]: Mounting /sysroot/run...1037server # [ 3.850223] systemd[1]: Mounting /sysroot/tmp/shared...1038host1 # [ 3.835313] systemd[1]: Mounting /sysroot/tmp/shared...1039host1 # [ 3.842967] systemd[1]: Mounting /sysroot/tmp/xchg...1040host1 # [ 3.859652] systemd[1]: Mounted /sysroot/nix/.rw-store.1041server # [ 3.888314] systemd[1]: Mounting /sysroot/tmp/xchg...1042host1 # [ 3.886154] systemd[1]: Starting rw-sysroot-nix-store.service...1043host1 # [ 3.890629] systemd[1]: Mounted /sysroot/nix/.ro-store.1044server # [ 3.913812] systemd[1]: Mounted /sysroot/nix/.rw-store.1045server # [ 3.930903] systemd[1]: Mounted /sysroot/run.1046server # [ 3.934230] systemd[1]: Mounted /sysroot/nix/.ro-store.1047host1 # [ 3.925880] systemd[1]: Mounted /sysroot/run.1048server # [ 3.949720] systemd[1]: Mounted /sysroot/tmp/shared.1049server # [ 3.964316] systemd[1]: Starting rw-sysroot-nix-store.service...1050host1 # [ 3.949207] systemd[1]: Mounted /sysroot/tmp/shared.1051server # [ 3.969950] systemd[1]: Mounted /sysroot/tmp/xchg.1052host1 # [ 3.954555] systemd[1]: Mounted /sysroot/tmp/xchg.1053host1 # [ 3.957750] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1054host1 # [ 3.960838] systemd[1]: Finished rw-sysroot-nix-store.service.1055server # [ 3.993230] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1056server # [ 3.994648] systemd[1]: Finished rw-sysroot-nix-store.service.1057server # [ 4.444759] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1058server # [ 4.450143] (udev-worker)[93]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1059server # [ 4.484707] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1060host1 # [ 4.467127] (udev-worker)[93]: mtd0ro: Failed to find and pin callout binary "/nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/mtd_probe": No such file or directory1061server # [ 4.487098] systemd[1]: Stopped Virtual Console Setup.1062server # [ 4.492166] systemd[1]: Stopping Virtual Console Setup...1063server # [ 4.493046] systemd[1]: Starting Virtual Console Setup...1064host1 # [ 4.474439] (udev-worker)[93]: mtd0ro: /nix/store/awq6qdiyxlvdp21km39qj020fcshgkia-systemd-261.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1065host1 # [ 4.490854] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1066host1 # [ 4.495100] systemd[1]: Stopped Virtual Console Setup.1067host1 # [ 4.497883] systemd[1]: Stopping Virtual Console Setup...1068host1 # [ 4.498737] systemd[1]: Starting Virtual Console Setup...1069server # [ 4.517207] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones.1070server # [ 4.520576] systemd[1]: Finished Virtual Console Setup.1071host1 # [ 4.514085] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1072host1 # [ 4.516161] systemd[1]: Stopped Virtual Console Setup.1073host1 # [ 4.520227] systemd[1]: Starting Virtual Console Setup...1074host1 # [ 4.539076] systemd-vconsole-setup[159]: Configuration of first virtual console was skipped, ignoring remaining ones.1075host1 # [ 4.542573] systemd[1]: Finished Virtual Console Setup.1076host1 # [ 4.779902] systemd[1]: Mounting /sysroot/nix/store...1077server # [ 4.811693] systemd[1]: Mounting /sysroot/nix/store...1078host1 # [ 4.842678] systemd[1]: Mounted /sysroot/nix/store.1079host1 # [ 4.846234] systemd[1]: Reached target Initrd File Systems.1080host1 # [ 4.851933] systemd[1]: Starting Find NixOS closure...1081server # [ 4.877418] systemd[1]: Mounted /sysroot/nix/store.1082server # [ 4.883433] systemd[1]: Reached target Initrd File Systems.1083host1 # [ 4.865652] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1084server # [ 4.886517] systemd[1]: Starting Find NixOS closure...1085server # [ 4.900446] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1086host1 # [ 4.916699] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1087host1 # [ 4.923602] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1088server # [ 4.946602] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1089server # [ 4.950831] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1090host1 # [ 4.934825] systemd[1]: Finished Find NixOS closure.1091host1 # [ 4.937810] systemd[1]: Reached target Initrd Default Target.1092host1 # [ 4.939412] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1093server # [ 4.966738] systemd[1]: Finished Find NixOS closure.1094server # [ 4.969908] systemd[1]: Reached target Initrd Default Target.1095server # [ 4.971783] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1096host1 # [ 4.970758] systemd[1]: Stopped target Initrd Default Target.1097host1 # [ 4.972711] systemd[1]: Stopped target Basic System.1098host1 # [ 4.976520] systemd[1]: Stopped target Initrd Root Device.1099host1 # [ 4.977695] systemd[1]: Stopped target Path Units.1100host1 # [ 4.980225] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1101host1 # [ 4.982651] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1102server # [ 5.002564] systemd[1]: Stopped target Initrd Default Target.1103host1 # [ 4.985906] systemd[1]: Stopped target Slice Units.1104server # [ 5.005597] systemd[1]: Stopped target Basic System.1105host1 # [ 4.988168] systemd[1]: Stopped target Socket Units.1106server # [ 5.007292] systemd[1]: Stopped target Initrd Root Device.1107host1 # [ 4.992170] systemd[1]: Stopped target System Initialization.1108host1 # [ 4.993260] systemd[1]: Stopped target Swaps.1109host1 # [ 4.994060] systemd[1]: Stopped target Timer Units.1110server # [ 5.011629] systemd[1]: Stopped target Path Units.1111host1 # [ 4.995142] systemd[1]: dbus.socket: Deactivated successfully.1112server # [ 5.012646] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1113server # [ 5.013991] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1114server # [ 5.015323] systemd[1]: Stopped target Slice Units.1115host1 # [ 5.000073] systemd[1]: Closed D-Bus System Message Bus Socket.1116host1 # [ 5.001098] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1117host1 # [ 5.002293] systemd[1]: Stopped Find NixOS closure.1118server # [ 5.020249] systemd[1]: Stopped target Socket Units.1119host1 # [ 5.003064] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1120server # [ 5.021152] systemd[1]: Stopped target System Initialization.1121server # [ 5.024137] systemd[1]: Stopped target Swaps.1122server # [ 5.024978] systemd[1]: Stopped target Timer Units.1123server # [ 5.026489] systemd[1]: dbus.socket: Deactivated successfully.1124host1 # [ 5.011690] systemd[1]: Starting rw-sysroot-nix-store.service...1125server # [ 5.030362] systemd[1]: Closed D-Bus System Message Bus Socket.1126server # [ 5.031495] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1127server # [ 5.035579] systemd[1]: Stopped Find NixOS closure.1128host1 # [ 5.020378] systemd[1]: systemd-sysctl.service: Deactivated successfully.1129host1 # [ 5.021396] systemd[1]: Stopped Apply Kernel Variables.1130host1 # [ 5.022330] systemd[1]: systemd-modules-load.service: Deactivated successfully.1131server # [ 5.040289] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1132host1 # [ 5.023428] systemd[1]: Stopped Load Kernel Modules.1133server # [ 5.041250] systemd[1]: Starting rw-sysroot-nix-store.service...1134server # [ 5.042254] systemd[1]: systemd-sysctl.service: Deactivated successfully.1135server # [ 5.043235] systemd[1]: Stopped Apply Kernel Variables.1136server # [ 5.043999] systemd[1]: systemd-modules-load.service: Deactivated successfully.1137host1 # [ 5.041163] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1138host1 # [ 5.042369] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1139host1 # [ 5.043443] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1140server # [ 5.062353] systemd[1]: Stopped Load Kernel Modules.1141server # [ 5.066218] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1142host1 # [ 5.049350] systemd[1]: Stopped Create System Files and Directories.1143host1 # [ 5.052160] systemd[1]: Stopped target Local File Systems.1144server # [ 5.070365] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1145host1 # [ 5.053261] systemd[1]: Stopped target Preparation for Local File Systems.1146host1 # [ 5.056693] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1147server # [ 5.074671] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1148host1 # [ 5.058087] systemd[1]: Stopped Coldplug All udev Devices.1149host1 # [ 5.059998] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1150host1 # [ 5.062175] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1151server # [ 5.080810] systemd[1]: Stopped Create System Files and Directories.1152server # [ 5.082901] systemd[1]: Stopped target Local File Systems.1153host1 # [ 5.067230] systemd[1]: Stopped Virtual Console Setup.1154server # [ 5.084776] systemd[1]: Stopped target Preparation for Local File Systems.1155host1 # [ 5.068119] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1156host1 # [ 5.069149] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1157server # [ 5.087160] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1158host1 # [ 5.070047] systemd[1]: initrd-cleanup.service: Deactivated successfully.1159host1 # [ 5.070978] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1160server # [ 5.089787] systemd[1]: Stopped Coldplug All udev Devices.1161host1 # [ 5.071905] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1162host1 # [ 5.073236] systemd[1]: Finished rw-sysroot-nix-store.service.1163host1 # [ 5.074101] systemd[1]: systemd-udevd.service: Deactivated successfully.1164server # [ 5.092244] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1165host1 # [ 5.075028] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1166server # [ 5.093327] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1167host1 # [ 5.076135] systemd[1]: systemd-udevd.service: Consumed 1.481s CPU time over 3.094s wall clock time, 27.1M memory peak.1168server # [ 5.095307] systemd[1]: Stopped Virtual Console Setup.1169host1 # [ 5.077583] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1170host1 # [ 5.078591] systemd[1]: Closed udev Control Socket.1171host1 # [ 5.079298] systemd[1]: Starting Cleanup udev Database...1172server # [ 5.100640] systemd[1]: initrd-cleanup.service: Deactivated successfully.1173server # [ 5.101594] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1174server # [ 5.102494] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1175server # [ 5.103523] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1176server # [ 5.104494] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1177server # [ 5.105476] systemd[1]: Finished rw-sysroot-nix-store.service.1178host1 # [ 5.088268] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1179server # [ 5.106302] systemd[1]: systemd-udevd.service: Deactivated successfully.1180host1 # [ 5.089513] systemd[1]: Stopped Create Static Device Nodes in /dev.1181server # [ 5.107239] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1182host1 # [ 5.092462] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1183server # [ 5.112211] systemd[1]: systemd-udevd.service: Consumed 1.478s CPU time over 3.161s wall clock time, 27.2M memory peak.1184host1 # [ 5.096173] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1185host1 # [ 5.097195] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1186host1 # [ 5.098168] systemd[1]: Stopped Create List of Static Device Nodes.1187server # [ 5.116330] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1188server # [ 5.120179] systemd[1]: Closed udev Control Socket.1189server # [ 5.120974] systemd[1]: Starting Cleanup udev Database...1190server # [ 5.121781] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1191server # [ 5.124132] systemd[1]: Stopped Create Static Device Nodes in /dev.1192server # [ 5.125027] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1193server # [ 5.128221] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1194server # [ 5.132202] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1195server # [ 5.133191] systemd[1]: Stopped Create List of Static Device Nodes.1196host1 # [ 5.127014] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1197host1 # [ 5.132400] systemd[1]: Finished Cleanup udev Database.1198host1 # [ 5.133195] systemd[1]: Reached target Switch Root.1199host1 # [ 5.133909] systemd[1]: Starting NixOS Activation...1200server # [ 5.156993] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1201server # [ 5.159963] systemd[1]: Finished Cleanup udev Database.1202server # [ 5.161257] systemd[1]: Reached target Switch Root.1203server # [ 5.162419] systemd[1]: Starting NixOS Activation...1204host1 # [ 5.300276] initrd-nixos-activation-start[184]: booting system configuration /nix/store/4n1fgkqk6zyk5l7f2lshpdj03kywbdb8-nixos-system-host1-test1205server # [ 5.328889] initrd-nixos-activation-start[184]: booting system configuration /nix/store/h1861zlyvppzb3fjhkmr6k12yzf86d76-nixos-system-server-test1206host1 # [ 5.369240] initrd-nixos-activation-start[184]: running activation script...1207server # [ 5.396410] initrd-nixos-activation-start[184]: running activation script...1208server # [ 5.826816] initrd-nixos-activation-start[207]: setting up /etc...1209host1 # [ 5.810496] initrd-nixos-activation-start[207]: setting up /etc...1210host1 # [ 6.079804] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1211server # [ 6.097650] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1212server # [ 6.100164] systemd[1]: Finished NixOS Activation.1213host1 # [ 6.082853] systemd[1]: Finished NixOS Activation.1214server # [ 6.104216] systemd[1]: Starting Switch Root...1215host1 # [ 6.088275] systemd[1]: Starting Switch Root...1216server # [ 6.119939] systemd[1]: Switching root.1217host1 # [ 6.108221] systemd[1]: Switching root.1218host1 # [ 6.293923] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1219server # [ 6.313899] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1220host1 # [ 6.909683] 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)1221server # [ 6.931759] 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)1222host1 # [ 6.922358] systemd[1]: Detected virtualization qemu.1223host1 # [ 6.926658] systemd[1]: Detected architecture arm64.1224server # [ 6.944060] systemd[1]: Detected virtualization qemu.1225host1 # [ 6.928782] systemd[1]: Detected first boot.1226server # [ 6.947281] systemd[1]: Detected architecture arm64.1227server # [ 6.951782] systemd[1]: Detected first boot.1228host1 # [ 6.936016] systemd[1]: Initializing machine ID from random generator.1229server # [ 6.959713] systemd[1]: Initializing machine ID from random generator.1230server # [ 7.252935] systemd[1]: bpf-restrict-fs: LSM BPF program attached1231host1 # [ 7.277906] systemd[1]: bpf-restrict-fs: LSM BPF program attached1232server # [ 7.434862] systemd[1]: Applying preset policy.1233host1 # [ 7.469071] systemd[1]: Applying preset policy.1234server # [ 7.953094] systemd[1]: Populated /etc with preset unit settings.1235host1 # [ 7.984451] systemd[1]: Populated /etc with preset unit settings.1236server # [ 8.486816] systemd[1]: initrd-switch-root.service: Deactivated successfully.1237server # [ 8.488140] systemd[1]: Stopped initrd-switch-root.service.1238server # [ 8.491555] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1239server # [ 8.495838] systemd[1]: Created slice Slice /system/getty.1240host1 # [ 8.478953] systemd[1]: initrd-switch-root.service: Deactivated successfully.1241server # [ 8.497555] systemd[1]: Created slice User and Session Slice.1242host1 # [ 8.480328] systemd[1]: Stopped initrd-switch-root.service.1243server # [ 8.498728] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1244server # [ 8.500430] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1245host1 # [ 8.483726] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1246server # [ 8.502265] systemd[1]: Expecting device /dev/hvc0...1247server # [ 8.504603] systemd[1]: Expecting device /dev/ttyAMA0...1248server # [ 8.505649] systemd[1]: Reached target Local Encrypted Volumes.1249host1 # [ 8.487679] systemd[1]: Created slice Slice /system/getty.1250server # [ 8.506846] systemd[1]: Stopped target initrd-fs.target.1251host1 # [ 8.490277] systemd[1]: Created slice User and Session Slice.1252server # [ 8.508357] systemd[1]: Stopped target initrd-root-fs.target.1253host1 # [ 8.492649] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1254server # [ 8.509958] systemd[1]: Stopped target initrd-switch-root.target.1255server # [ 8.512545] systemd[1]: Reached target Virtual Machines and Containers.1256host1 # [ 8.495098] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1257server # [ 8.513768] systemd[1]: Reached target Path Units.1258host1 # [ 8.497337] systemd[1]: Expecting device /dev/hvc0...1259server # [ 8.515933] systemd[1]: Reached target Remote File Systems.1260host1 # [ 8.499289] systemd[1]: Expecting device /dev/ttyAMA0...1261server # [ 8.516986] systemd[1]: Reached target Slice Units.1262server # [ 8.519308] systemd[1]: Reached target Swaps.1263host1 # [ 8.501211] systemd[1]: Reached target Local Encrypted Volumes.1264host1 # [ 8.503212] systemd[1]: Stopped target initrd-fs.target.1265host1 # [ 8.505136] systemd[1]: Stopped target initrd-root-fs.target.1266server # [ 8.523349] systemd[1]: Listening on Query the User Interactively for a Password.1267host1 # [ 8.507133] systemd[1]: Stopped target initrd-switch-root.target.1268host1 # [ 8.509144] systemd[1]: Reached target Virtual Machines and Containers.1269server # [ 8.528144] systemd[1]: Listening on Process Core Dump Socket.1270host1 # [ 8.511258] systemd[1]: Reached target Path Units.1271host1 # [ 8.513123] systemd[1]: Reached target Remote File Systems.1272server # [ 8.532215] systemd[1]: Listening on Credential Encryption/Decryption.1273host1 # [ 8.515101] systemd[1]: Reached target Slice Units.1274host1 # [ 8.516110] systemd[1]: Reached target Swaps.1275server # [ 8.536293] systemd[1]: Listening on Factory Reset Management.1276host1 # [ 8.521161] systemd[1]: Listening on Query the User Interactively for a Password.1277server # [ 8.537549] systemd[1]: Listening on Hostname Service Socket.1278host1 # [ 8.526566] systemd[1]: Listening on Process Core Dump Socket.1279server # [ 8.544050] systemd[1]: Starting Journal Log Access Socket...1280server # [ 8.547154] systemd[1]: Listening on Journal Audit Socket.1281host1 # [ 8.530815] systemd[1]: Listening on Credential Encryption/Decryption.1282host1 # [ 8.534906] systemd[1]: Listening on Factory Reset Management.1283server # [ 8.551649] systemd[1]: Listening on Console Output Muting Service Socket.1284host1 # [ 8.536167] systemd[1]: Listening on Hostname Service Socket.1285server # [ 8.554109] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1286server # [ 8.556376] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1287host1 # [ 8.542106] systemd[1]: Starting Journal Log Access Socket...1288server # [ 8.559187] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1289host1 # [ 8.544327] systemd[1]: Listening on Journal Audit Socket.1290host1 # [ 8.548692] systemd[1]: Listening on Console Output Muting Service Socket.1291host1 # [ 8.550210] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1292host1 # [ 8.552915] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1293server # [ 8.570696] systemd[1]: Listening on Disk Repartitioning Service Socket.1294server # [ 8.573079] systemd[1]: Listening on udev Control Socket.1295host1 # [ 8.555698] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1296server # [ 8.575338] systemd[1]: Listening on udev Varlink Socket.1297server # [ 8.580712] systemd[1]: Mounting Huge Pages File System...1298host1 # [ 8.567792] systemd[1]: Listening on Disk Repartitioning Service Socket.1299server # [ 8.586461] systemd[1]: Mounting POSIX Message Queue File System...1300host1 # [ 8.570250] systemd[1]: Listening on udev Control Socket.1301host1 # [ 8.572575] systemd[1]: Listening on udev Varlink Socket.1302server # [ 8.593828] systemd[1]: Mounting Kernel Debug File System...1303host1 # [ 8.577701] systemd[1]: Mounting Huge Pages File System...1304host1 # [ 8.583141] systemd[1]: Mounting POSIX Message Queue File System...1305server # [ 8.606499] systemd[1]: Mounting Kernel Trace File System...1306host1 # [ 8.593150] systemd[1]: Mounting Kernel Debug File System...1307server # [ 8.619689] systemd[1]: Starting Create List of Static Device Nodes...1308host1 # [ 8.605083] systemd[1]: Mounting Kernel Trace File System...1309host1 # [ 8.618030] systemd[1]: Starting Create List of Static Device Nodes...1310server # [ 8.639342] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1311server # [ 8.642106] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1312host1 # [ 8.631658] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1313server # [ 8.653858] systemd[1]: Mounting Kernel Configuration File System...1314host1 # [ 8.636978] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1315server # [ 8.656900] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1316server # [ 8.662694] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1317host1 # [ 8.653330] systemd[1]: Mounting Kernel Configuration File System...1318server # [ 8.672392] systemd[1]: Starting Load Kernel Module fuse...1319host1 # [ 8.656369] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1320server # [ 8.675595] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671321host1 # [ 8.660221] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1322server # [ 8.700704] systemd[1]: Starting Journal Service...1323host1 # [ 8.732785] systemd[1]: Starting Load Kernel Module fuse...1324host1 # [ 8.734337] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671325server # [ 8.760329] systemd[1]: Starting Load Kernel Modules...1326server # [ 8.789995] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1327host1 # [ 8.783356] systemd[1]: Starting Journal Service...1328server # [ 8.801162] systemd[1]: Starting Remount Root and Kernel File Systems...1329server # [ 8.804063] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1330host1 # [ 8.798363] systemd[1]: Starting Load Kernel Modules...1331server # [ 8.819245] systemd[1]: Starting Coldplug All udev Devices...1332server # [ 8.825003] systemd[1]: Listening on Journal Log Access Socket.1333server # [ 8.830030] systemd[1]: Mounted Huge Pages File System.1334server # [ 8.833445] systemd[1]: Mounted POSIX Message Queue File System.1335server # [ 8.836129] systemd[1]: Mounted Kernel Debug File System.1336host1 # [ 8.820025] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1337host1 # [ 8.825625] fuse: init (API version 7.45)1338server # [ 8.842255] systemd[1]: Mounted Kernel Trace File System.1339server # [ 8.843016] systemd[1]: Mounted Kernel Configuration File System.1340host1 # [ 8.835928] systemd[1]: Starting Remount Root and Kernel File Systems...1341host1 # [ 8.840273] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1342server # [ 8.884351] systemd[1]: Finished Create List of Static Device Nodes.1343host1 # [ 8.867730] systemd[1]: Starting Coldplug All udev Devices...1344server # [ 8.894846] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1345host1 # [ 8.912512] systemd-journald[278]: Collecting audit messages is enabled.1346host1 # [ 8.915996] systemd[1]: Listening on Journal Log Access Socket.1347host1 # [ 8.923682] systemd[1]: Mounted Huge Pages File System.1348host1 # [ 8.933551] systemd[1]: Mounted POSIX Message Queue File System.1349host1 # [ 8.934071] systemd[1]: Mounted Kernel Debug File System.1350host1 # [ 8.934479] systemd[1]: Mounted Kernel Trace File System.1351host1 # [ 8.940358] systemd[1]: Finished Create List of Static Device Nodes.1352host1 # [ 8.946457] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1353host1 # [ 8.960097] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1354host1 # [ 8.960794] systemd[1]: Mounted Kernel Configuration File System.1355host1 # [ 8.961395] systemd[1]: modprobe@fuse.service: Deactivated successfully.1356host1 # [ 8.961932] systemd[1]: Finished Load Kernel Module fuse.1357host1 # [ 8.950404] systemd[1]: Queued start job for default target Multi-User System.1358host1 # [ 8.953035] systemd[1]: systemd-journald.service: Deactivated successfully.1359host1 # [ 8.954464] systemd-modules-load[279]: Module 'atkbd' is built in1360server # [ 8.987361] systemd[1]: Finished Load Kernel Modules.1361host1 # [ 8.955480] systemd-modules-load[279]: Module 'loop' is built in1362server # [ 8.994762] systemd[1]: Starting Firewall...1363host1 # [ 8.980942] systemd[1]: Mounting FUSE Control File System...1364host1 # [ 8.983446] EXT4-fs (vda): re-mounted c970a448-5f3e-456b-a368-ce11def994d0.1365server # [ 9.004286] systemd[1]: Starting Apply Kernel Variables...1366host1 # [ 9.002918] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1367server # [ 9.027360] EXT4-fs (vda): re-mounted d3e8a63a-9a91-4ace-8398-67c7af8e3882.1368server # [ 9.035391] systemd-journald[278]: Collecting audit messages is enabled.1369host1 # [ 9.021078] systemd[1]: Started Journal Service.1370server # [ 9.039833] systemd[1]: Finished Remount Root and Kernel File Systems.1371server # [ 9.042659] systemd[1]: Listening on Disk Image Download Service Socket.1372server # [ 9.045032] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1373host1 # [ 9.015401] systemd[1]: Finished Load Kernel Modules.1374host1 # [ 9.025315] systemd[1]: Finished Remount Root and Kernel File Systems.1375host1 # [ 9.029203] systemd-oomd[280]: No swap; memory pressure usage will be degraded1376server # [ 9.068685] systemd[1]: Starting Load/Save OS Random Seed...1377server # [ 9.069110] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1378host1 # [ 9.040635] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1379server # [ 9.080481] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1380server # [ 9.083642] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1381host1 # [ 9.072402] systemd[1]: Listening on Disk Image Download Service Socket.1382host1 # [ 9.080848] systemd[1]: Starting Firewall...1383server # [ 9.114357] systemd[1]: Started Journal Service.1384host1 # [ 9.091022] systemd[1]: Starting Flush Journal to Persistent Storage...1385host1 # [ 9.093467] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1386server # [ 9.116571] systemd[1]: Queued start job for default target Multi-User System.1387server # [ 9.148441] fuse: init (API version 7.45)1388server # [ 9.133046] systemd[1]: systemd-journald.service: Deactivated successfully.1389server # [ 9.144887] systemd-modules-load[279]: Module 'atkbd' is built in1390host1 # [ 9.134043] systemd[1]: Starting Load/Save OS Random Seed...1391server # [ 9.151767] systemd-modules-load[279]: Module 'loop' is built in1392server # [ 9.161845] systemd[1]: Starting Flush Journal to Persistent Storage...1393host1 # [ 9.166350] systemd[1]: Starting Apply Kernel Variables...1394server # [ 9.185075] systemd-oomd[280]: No swap; memory pressure usage will be degraded1395host1 # [ 9.168179] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1396host1 # [ 9.174318] systemd[1]: Mounted FUSE Control File System.1397server # [ 9.201100] systemd[1]: modprobe@fuse.service: Deactivated successfully.1398host1 # [ 9.179147] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1399host1 # [ 9.209151] systemd-journald[278]: Received client request to flush runtime journal.1400server # [ 9.210132] systemd[1]: Finished Load Kernel Module fuse.1401server # [ 9.215813] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1402server # [ 9.227082] systemd[1]: Finished Load/Save OS Random Seed.1403server # [ 9.234449] systemd[1]: Reached target First Boot Complete.1404server # [ 9.272365] systemd-journald[278]: Received client request to flush runtime journal.1405host1 # [ 9.300422] systemd[1]: Starting Create Static Device Nodes in /dev...1406host1 # [ 9.308363] systemd[1]: Finished Load/Save OS Random Seed.1407server # [ 9.336100] systemd[1]: Finished Apply Kernel Variables.1408host1 # [ 9.315321] systemd[1]: Reached target First Boot Complete.1409host1 # [ 9.320904] systemd[1]: Finished Flush Journal to Persistent Storage.1410server # [ 9.343145] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1411server # [ 9.347576] systemd[1]: Starting Create Static Device Nodes in /dev...1412server # [ 9.354686] systemd[1]: Finished Flush Journal to Persistent Storage.1413host1 # [ 9.360627] systemd[1]: Finished Apply Kernel Variables.1414host1 # [ 9.387231] systemd[1]: Finished Create Static Device Nodes in /dev.1415host1 # [ 9.393704] systemd[1]: Reached target Preparation for Local File Systems.1416host1 # [ 9.398074] systemd[1]: Starting Rule-based Manager for Device Events and Files...1417server # [ 9.444118] systemd[1]: Finished Create Static Device Nodes in /dev.1418server # [ 9.448169] systemd[1]: Reached target Preparation for Local File Systems.1419server # [ 9.450955] systemd[1]: Starting Rule-based Manager for Device Events and Files...1420server # [ 9.476141] systemd[1]: Mounting /run/wrappers...1421host1 # [ 9.475004] systemd[1]: Mounting /run/wrappers...1422server # [ 9.492705] systemd[1]: Mounting FUSE Control File System...1423server # [ 9.524418] systemd[1]: Mounted FUSE Control File System.1424host1 # [ 9.535362] systemd[1]: Mounted /run/wrappers.1425host1 # [ 9.538329] systemd[1]: Reached target Local File Systems.1426host1 # [ 9.544129] systemd-udevd[316]: Using default interface naming scheme 'v261'.1427host1 # [ 9.550793] systemd[1]: Listening on Boot Loader Control Service Socket.1428server # [ 9.571145] systemd[1]: Mounted /run/wrappers.1429server # [ 9.572499] systemd[1]: Reached target Local File Systems.1430host1 # [ 9.554993] systemd[1]: Starting register-nix-paths.service...1431server # [ 9.579079] systemd[1]: Listening on Boot Loader Control Service Socket.1432server # [ 9.585395] systemd[1]: Starting register-nix-paths.service...1433server # [ 9.590365] systemd[1]: Starting Create SUID/SGID Wrappers...1434host1 # [ 9.573791] systemd[1]: Starting Create SUID/SGID Wrappers...1435host1 # [ 9.576434] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1436server # [ 9.603157] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1437host1 # [ 9.588562] systemd[1]: Starting Save Transient machine-id to Disk...1438server # [ 9.614650] systemd[1]: Starting Save Transient machine-id to Disk...1439server # [ 9.620231] systemd[1]: Starting Create System Files and Directories...1440host1 # [ 9.631308] systemd[1]: Starting Create System Files and Directories...1441server # [ 9.676538] systemd-udevd[318]: Using default interface naming scheme 'v261'.1442server # [ 9.710723] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1443server # [ 9.720501] systemd[1]: Finished Save Transient machine-id to Disk.1444host1 # [ 9.753964] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1445host1 # [ 9.763905] systemd[1]: Finished Save Transient machine-id to Disk.1446server # [ 9.847047] systemd[1]: Finished Create System Files and Directories.1447host1 # [ 9.833880] systemd[1]: Started Rule-based Manager for Device Events and Files.1448server # [ 9.855298] systemd[1]: Starting Rebuild Journal Catalog...1449server # [ 9.859140] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1450host1 # [ 9.879933] systemd[1]: Finished Create System Files and Directories.1451host1 # [ 9.900760] systemd[1]: Starting Rebuild Journal Catalog...1452host1 # [ 9.925635] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1453server # [ 9.975744] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1454server # [ 9.998949] systemd[1]: Started Rule-based Manager for Device Events and Files.1455host1 # [ 10.015625] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1456server # [ 10.095498] systemd[1]: Finished Rebuild Journal Catalog.1457server # [ 10.102876] systemd[1]: Starting Update is Completed...1458host1 # [ 10.108956] systemd[1]: Finished Rebuild Journal Catalog.1459host1 # [ 10.126017] systemd[1]: Starting Update is Completed...1460server # [ 10.198014] systemd[1]: Finished Update is Completed.1461host1 # [ 10.203644] systemd[1]: Finished Update is Completed.1462server # [ 10.653477] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1463server # [ 10.656144] systemd[1]: Finished Create SUID/SGID Wrappers.1464host1 # [ 10.688207] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1465host1 # [ 10.691645] systemd[1]: Finished Create SUID/SGID Wrappers.1466host1 # [ 11.233405] systemd[1]: Finished Coldplug All udev Devices.1467host1 # [ 11.346702] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1468server # [ 11.378027] systemd[1]: Finished Firewall.1469host1 # [ 11.367270] systemd[1]: Finished Firewall.1470server # [ 11.399947] systemd[1]: Finished Coldplug All udev Devices.1471server # [ 11.467010] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1472host1 # [ 11.538669] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1473host1 # [ 11.617554] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1474host1 # [ 11.639584] systemd[1]: Finished register-nix-paths.service.1475host1 # [ 11.642572] systemd[1]: Reached target System Initialization.1476host1 # [ 11.646825] systemd[1]: Started Renew ACME Certificate for host1.1477host1 # [ 11.649732] systemd[1]: Started Discard unused filesystem blocks once a week.1478host1 # [ 11.651424] systemd[1]: Started Daily Cleanup of Temporary Directories.1479host1 # [ 11.656373] systemd[1]: Reached target Timer Units.1480server # [ 11.673487] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1481host1 # [ 11.657133] systemd[1]: Listening on D-Bus System Message Bus Socket.1482host1 # [ 11.658057] systemd[1]: Listening on Nix Daemon Socket.1483host1 # [ 11.658809] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1484host1 # [ 11.659990] systemd[1]: Reached target Socket Units.1485host1 # [ 11.668338] systemd[1]: Reached target Basic System.1486host1 # [ 11.671422] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1487host1 # [ 11.677832] systemd[1]: Started backdoor.service.1488host1 # [ 11.686390] systemd[1]: Starting Import lastlog data into lastlog2 database...1489host1 # [ 11.704115] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1490server # [ 11.736254] systemd[1]: Finished register-nix-paths.service.1491server # [ 11.738783] systemd[1]: Reached target System Initialization.1492server # [ 11.740819] systemd[1]: Started Renew ACME Certificate for server.1493server # [ 11.743361] systemd[1]: Started Discard unused filesystem blocks once a week.1494server # [ 11.746442] systemd[1]: Started Daily Cleanup of Temporary Directories.1495host1 # [ 11.736767] systemd[1]: Starting Post-Boot Actions...1496server # [ 11.751325] systemd[1]: Reached target Timer Units.1497server # [ 11.756327] systemd[1]: Listening on D-Bus System Message Bus Socket.1498server # [ 11.762259] systemd[1]: Listening on Nix Daemon Socket.1499server # [ 11.763139] systemd[1]: Listening on Nix worker-protocol over gRPC.1500server # [ 11.772255] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1501host1 # [ 11.766268] systemd[1]: Started Reset console on configuration changes.1502server # [ 11.789396] systemd[1]: Reached target Socket Units.1503server # [ 11.793854] systemd[1]: Reached target Basic System.1504server # [ 11.801126] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1505server # [ 11.813217] systemd[1]: Starting Import lastlog data into lastlog2 database...1506host1 # [ 11.801104] systemd[1]: Starting resolvconf update...1507server # [ 11.828554] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1508server # [ 11.840856] systemd[1]: Starting Post-Boot Actions...1509server # [ 11.860510] systemd[1]: Started Reset console on configuration changes.1510host1 # connecting to host...1511host1 # [ 11.848812] acme-setup-privileged[502]: + set -euo pipefail1512host1 # [ 11.849738] acme-setup-privileged[502]: + cd /var/lib/acme1513host1 # [ 11.850646] acme-setup-privileged[502]: + chmod -R u=rwX,g=,o= .lego/accounts1514server # [ 11.872675] systemd[1]: Starting resolvconf update...1515server # [ 11.880521] systemd[1]: Starting step-ca-pki.service...1516host1 # [ 11.870661] acme-setup-privileged[502]: + chown -R acme .lego/accounts1517server # [ 11.899715] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1518host1 # [ 11.892116] nsncd[505]: Sep 20 08:17:02.467 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1519server # [ 11.916163] systemd[1]: Started backdoor.service.1520host1 # [ 11.903890] acme-setup-privileged[502]: + for fixpath in host1 .lego/host11521host1 # [ 11.906934] acme-setup-privileged[502]: + '[' -d host1 ']'1522server # [ 11.927754] systemd[1]: Starting D-Bus System Message Bus...1523host1 # [ 11.912202] acme-setup-privileged[502]: + for fixpath in host1 .lego/host11524host1 # [ 11.916913] acme-setup-privileged[502]: + '[' -d .lego/host1 ']'1525host1 # [ 11.921568] systemd[1]: Started Name Service Cache Daemon (nsncd).1526host1 # [ 11.929471] systemd[1]: Finished Post-Boot Actions.1527server # [ 11.970784] systemd[1]: Finished Post-Boot Actions.1528host1 # [ 11.980223] systemd[1]: Reached target Host and Network Name Lookups.1529host1 # [ 11.982362] systemd[1]: Reached target User and Group Name Lookups.1530server # [ 12.000266] acme-setup-privileged[506]: + set -euo pipefail1531server # [ 12.009331] acme-setup-privileged[506]: + cd /var/lib/acme1532host1 # [ 11.996762] systemd[1]: Starting D-Bus System Message Bus...1533server # [ 12.015967] acme-setup-privileged[506]: + chmod -R u=rwX,g=,o= .lego/accounts1534host1 # [ 12.021216] systemd[1]: Starting User Login Management...1535server # [ 12.031240] acme-setup-privileged[506]: + chown -R acme .lego/accounts1536host1 # [ 12.023078] systemd[1]: Finished Import lastlog data into lastlog2 database.1537server # [ 12.052793] nsncd[508]: Sep 20 08:17:02.627 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1538server # [ 12.073178] systemd[1]: Started Name Service Cache Daemon (nsncd).1539server # [ 12.083142] acme-setup-privileged[506]: + for fixpath in server .lego/server1540server # [ 12.097535] acme-setup-privileged[506]: + '[' -d server ']'1541server # connecting to host...1542server # [ 12.103356] acme-setup-privileged[506]: + for fixpath in server .lego/server1543server # [ 12.111402] acme-setup-privileged[506]: + '[' -d .lego/server ']'1544server # [ 12.120655] systemd[1]: Reached target Host and Network Name Lookups.1545server # [ 12.130294] systemd[1]: Reached target User and Group Name Lookups.1546server # [ 12.138611] systemd[1]: Starting User Login Management...1547server # [ 12.145472] systemd[1]: Finished Import lastlog data into lastlog2 database.1548server: Guest shell says: b'Spawning backdoor root shell...\n'1549server: connected to guest root shell1550server: (connecting took 12.56 seconds)1551server: (finished: waiting for the VM to finish booting, in 12.56 seconds)1552host1 # [ 12.214520] acme-setup-start[533]: + set -euo pipefail1553host1 # [ 12.215350] acme-setup-start[533]: + test -e ca/key.pem1554host1 # [ 12.224097] acme-setup-start[533]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1555server # [ 12.251064] dbus-broker-launch[518]: Looking up NSS user entry for 'systemd-timesync'...1556server # [ 12.258242] dbus-broker-launch[518]: NSS returned no entry for 'systemd-timesync'1557server # [ 12.259327] dbus-broker-launch[518]: Invalid user-name in /nix/store/gvyyjgzkykgkdyrbr192yz9972s0sqq0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1558host1 # [ 12.246209] dbus-broker-launch[539]: Looking up NSS user entry for 'systemd-timesync'...1559host1 # [ 12.254458] dbus-broker-launch[539]: NSS returned no entry for 'systemd-timesync'1560host1 # [ 12.261595] dbus-broker-launch[539]: Invalid user-name in /nix/store/vbp0wjh4964al3ar1y5dzizpgih0kf2v-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1561host1 # [ 12.277382] systemd-logind[540]: New seat seat0.1562host1 # [ 12.283909] systemd[1]: Started User Login Management.1563server # [ 12.306158] systemd[1]: Started D-Bus System Message Bus.1564host1 # [ 12.292640] systemd[1]: Starting linger-users.service...1565host1 # [ 12.309485] systemd[1]: Started D-Bus System Message Bus.1566host1 # [ 12.330159] systemd[1]: Stopped target Host and Network Name Lookups.1567host1 # [ 12.334320] systemd[1]: Stopping Host and Network Name Lookups...1568host1 # [ 12.335280] systemd[1]: Stopped target User and Group Name Lookups.1569host1 # [ 12.348950] systemd[1]: Stopping User and Group Name Lookups...1570host1 # [ 12.357535] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1571host1 # [ 12.358519] systemd[1]: nscd.service: Deactivated successfully.1572host1 # [ 12.359353] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1573host1 # [ 12.378483] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1574server # [ 12.398264] dbus-broker-launch[518]: Ready1575host1 # [ 12.386568] dbus-broker-launch[539]: Ready1576server # [ 12.411342] systemd-logind[534]: New seat seat0.1577host1 # [ 12.407118] systemd[1]: Starting Ensure certificate for host1...1578server # [ 12.432278] systemd[1]: Started User Login Management.1579host1 # [ 12.416242] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1580host1 # [ 12.417245] systemd[1]: linger-users.service: Deactivated successfully.1581host1 # [ 12.424314] systemd[1]: Finished linger-users.service.1582server # [ 12.443405] systemd[1]: Starting linger-users.service...1583host1 # [ 12.439103] systemd-logind[540]: Watching system buttons on /dev/input/event0 (gpio-keys)1584server # [ 12.462457] acme-setup-start[544]: + set -euo pipefail1585server # [ 12.463279] acme-setup-start[544]: + test -e ca/key.pem1586host1 # [ 12.446608] (udev-worker)[459]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1587host1 # [ 12.455102] (udev-worker)[459]: Network interface NamePolicy= disabled on kernel command line.1588host1 # [ 12.460401] (udev-worker)[462]: Network interface NamePolicy= disabled on kernel command line.1589server # [ 12.478950] acme-setup-start[544]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1590server # [ 12.494109] systemd[1]: Stopped target Host and Network Name Lookups.1591server # [ 12.503393] systemd[1]: Stopping Host and Network Name Lookups...1592server # [ 12.512769] systemd[1]: Stopped target User and Group Name Lookups.1593server # [ 12.513662] systemd[1]: Stopping User and Group Name Lookups...1594server # [ 12.514505] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1595server # [ 12.515387] systemd[1]: nscd.service: Deactivated successfully.1596server # [ 12.540154] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1597server # [ 12.541103] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1598host1 # [ 12.529838] systemd[1]: Finished resolvconf update.1599host1 # [ 12.533332] systemd[1]: Reached target Preparation for Network.1600host1 # [ 12.548679] nsncd[603]: Sep 20 08:17:03.128 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1601host1 # [ 12.557251] systemd[1]: Starting DHCP Client...1602server # [ 12.588658] systemd[1]: linger-users.service: Deactivated successfully.1603server # [ 12.589688] systemd[1]: Finished linger-users.service.1604host1 # [ 12.576628] systemd[1]: Starting Extra networking commands....1605host1 # [ 12.577591] systemd[1]: Started Name Service Cache Daemon (nsncd).1606host1 # [ 12.599500] acme-host1-start[601]: Waiting to acquire lock in /run/acme/1607host1 # [ 12.607417] systemd[1]: Reached target Host and Network Name Lookups.1608host1 # [ 12.612952] systemd[1]: Reached target User and Group Name Lookups.1609host1 # [ 12.631909] acme-host1-start[601]: + '[' -e out/acme-success ']'1610host1 # [ 12.635943] acme-host1-start[601]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=1611server # [ 12.664094] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1612server # [ 12.673905] systemd[1]: Starting Ensure certificate for server...1613server # [ 12.680616] nsncd[611]: Sep 20 08:17:03.249 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1614server # [ 12.682617] systemd[1]: Started Name Service Cache Daemon (nsncd).1615server # [ 12.683492] systemd[1]: Reached target Host and Network Name Lookups.1616host1 # [ 12.683310] acme-host1-start[640]: + cd host11617host1 # [ 12.684888] acme-host1-start[640]: + cp -vp cert.pem ../out/cert.pem1618server # [ 12.699747] systemd[1]: Reached target User and Group Name Lookups.1619host1 # [ 12.701692] acme-host1-start[641]: 'cert.pem' -> '../out/cert.pem'1620host1 # [ 12.705975] acme-host1-start[640]: + cp -vp key.pem ../out/key.pem1621host1 # [ 12.718443] acme-host1-start[640]: 'key.pem' -> '../out/key.pem'1622server # [ 12.735856] systemd[1]: Finished resolvconf update.1623server # [ 12.742795] systemd[1]: Reached target Preparation for Network.1624host1 # [ 12.723323] systemd[1]: Condition check resulted in Virtio network device being skipped.1625host1 # [ 12.728883] acme-host1-start[601]: + cat out/cert.pem ca/cert.pem1626server # [ 12.748547] systemd[1]: Starting DHCP Client...1627server # [ 12.753007] systemd[1]: Starting Extra networking commands....1628host1 # [ 12.740949] acme-host1-start[601]: + cp ca/cert.pem out/chain.pem1629host1 # [ 12.747000] systemd[1]: Starting Address configuration of eth1...1630host1 # [ 12.758702] acme-host1-start[601]: + cat out/key.pem out/fullchain.pem1631host1 # [ 12.771221] acme-host1-start[601]: + for fixpath in out certificates1632host1 # [ 12.776574] acme-host1-start[601]: + '[' -d out ']'1633host1 # [ 12.777719] acme-host1-start[601]: + chmod -R u=rwX,g=rX,o= out1634host1 # [ 12.792833] acme-host1-start[601]: + chown -R acme:acme out1635host1 # [ 12.818519] acme-host1-start[601]: + for fixpath in out certificates1636host1 # [ 12.821329] acme-host1-start[601]: + '[' -d certificates ']'1637host1 # [ 12.829285] systemd[1]: Finished Ensure certificate for host1.1638server # [ 12.883253] acme-server-start[630]: Waiting to acquire lock in /run/acme/1639server # [ 12.919585] acme-server-start[630]: + '[' -e out/acme-success ']'1640server # [ 12.924874] acme-server-start[630]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=1641host1 # [ 12.936370] dhcpcd[643]: dhcpcd-10.3.2 starting1642host1 # [ 12.954430] dhcpcd[704]: dev: loaded udev1643host1 # [ 12.960423] network-addresses-eth1-start[646]: adding address 192.168.1.1/24... done1644server # [ 12.983199] acme-server-start[674]: + cd server1645server # [ 12.986553] acme-server-start[674]: + cp -vp cert.pem ../out/cert.pem1646host1 # [ 12.983424] network-addresses-eth1-start[646]: adding address 2001:db8:1::1/64... done1647server # [ 13.003847] acme-server-start[678]: 'cert.pem' -> '../out/cert.pem'1648server # [ 13.011678] acme-server-start[674]: + cp -vp key.pem ../out/key.pem1649server # [ 13.023012] acme-server-start[674]: 'key.pem' -> '../out/key.pem'1650server # [ 13.027523] acme-server-start[630]: + cat out/cert.pem ca/cert.pem1651host1 # [ 13.037578] 8021q: 802.1Q VLAN Support v1.81652host1 # [ 13.037992] 8021q: adding VLAN 0 to HW filter on device eth11653host1 # [ 13.023757] systemd[1]: Finished Address configuration of eth1.1654host1 # [ 13.028637] systemd[1]: Finished Extra networking commands..1655host1 # [ 13.029594] systemd[1]: Reached target Network.1656host1 # [ 13.040463] systemd[1]: Starting Permit User Sessions...1657server # [ 13.061309] acme-server-start[630]: + cp ca/cert.pem out/chain.pem1658server # [ 13.075662] (udev-worker)[654]: Network interface NamePolicy= disabled on kernel command line.1659server # [ 13.092207] acme-server-start[630]: + cat out/key.pem out/fullchain.pem1660server # [ 13.113713] acme-server-start[630]: + for fixpath in out certificates1661server # [ 13.114820] acme-server-start[630]: + '[' -d out ']'1662server # [ 13.115617] acme-server-start[630]: + chmod -R u=rwX,g=rX,o= out1663server # [ 13.133200] step-ca-pki-start[530]: Your certificate has been saved in root_ca.crt.1664server # [ 13.134398] step-ca-pki-start[530]: Your private key has been saved in root_ca.key.1665host1 # [ 13.117061] systemd[1]: Finished Permit User Sessions.1666host1 # [ 13.129564] systemd[1]: Started Getty on tty1.1667server # [ 13.148627] acme-server-start[630]: + chown -R acme:nix-grpc-daemon out1668host1 # [ 13.134544] systemd[1]: Reached target Login Prompts.1669server # [ 13.163252] (udev-worker)[655]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1670host1 # [ 13.190926] cfg80211: Loading compiled-in X.509 certificates for regulatory database1671server # [ 13.203234] acme-server-start[630]: + for fixpath in out certificates1672server # [ 13.205683] acme-server-start[630]: + '[' -d certificates ']'1673server # [ 13.207114] dhcpcd[653]: dhcpcd-10.3.2 starting1674server # [ 13.219734] systemd[1]: Finished Ensure certificate for server.1675server # [ 13.225353] (udev-worker)[655]: Network interface NamePolicy= disabled on kernel command line.1676host1 # [ 13.227459] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1677host1 # [ 13.227997] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1678host1 # [ 13.233358] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21679host1 # [ 13.233710] cfg80211: failed to load regulatory.db1680server # [ 13.236774] dhcpcd[719]: dev: loaded udev1681host1 # [ 13.252013] mousedev: PS/2 mouse device common for all mice1682server # [ 13.295096] 8021q: 802.1Q VLAN Support v1.81683host1 # [ 13.321265] 8021q: adding VLAN 0 to HW filter on device eth01684host1 # [ 13.306046] dhcpcd[704]: eth0: waiting for carrier1685host1 # [ 13.306941] dhcpcd[704]: eth0: carrier acquired1686host1 # [ 13.322787] dhcpcd[704]: DUID 00:01:00:01:32:42:52:ff:52:54:00:12:34:561687host1 # [ 13.324179] dhcpcd[704]: eth0: IAID 00:12:34:561688host1 # [ 13.324896] dhcpcd[704]: eth0: adding address fe80::5054:ff:fe12:34561689server # [ 13.344916] step-ca-pki-start[707]: Your certificate has been saved in intermediate_ca.crt.1690server # [ 13.358896] step-ca-pki-start[707]: Your private key has been saved in intermediate_ca.key.1691server # [ 13.395600] cfg80211: Loading compiled-in X.509 certificates for regulatory database1692server # [ 13.397509] systemd[1]: Finished Extra networking commands..1693server # [ 13.404409] systemd[1]: Reached target Network.1694server # [ 13.405231] systemd[1]: Starting Permit User Sessions...1695server # [ 13.437942] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1696server # [ 13.438536] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1697server # [ 13.443763] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21698server # [ 13.444103] cfg80211: failed to load regulatory.db1699server # [ 13.445920] systemd[1]: Finished step-ca-pki.service.1700host1 # [ 13.433891] systemd-logind[540]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1701server # [ 13.491214] systemd[1]: Finished Permit User Sessions.1702server # [ 13.495534] systemd[1]: Started Getty on tty1.1703server # [ 13.499013] systemd[1]: Reached target Login Prompts.1704server # [ 13.559584] 8021q: adding VLAN 0 to HW filter on device eth01705server # [ 13.543887] dhcpcd[719]: eth0: waiting for carrier1706server # [ 13.545908] dhcpcd[719]: libudev: received NULL device1707server # [ 13.548116] dhcpcd[719]: libudev: received NULL device1708server # [ 13.550591] dhcpcd[719]: eth0: carrier acquired1709server # [ 13.563983] dhcpcd[719]: DUID 00:01:00:01:32:42:53:00:52:54:00:12:34:561710server # [ 13.567061] dhcpcd[719]: eth0: IAID 00:12:34:561711server # [ 13.567817] dhcpcd[719]: eth0: adding address fe80::5054:ff:fe12:34561712server # [ 13.595026] dhcpcd[719]: eth0: IAID 00:12:34:561713server # [ 13.614792] systemd-logind[534]: Watching system buttons on /dev/input/event0 (gpio-keys)1714server # [ 13.628267] systemd[1]: Condition check resulted in Virtio network device being skipped.1715server # [ 13.634387] systemd[1]: Starting Address configuration of eth1...1716server # [ 13.769209] 8021q: adding VLAN 0 to HW filter on device eth11717server # [ 13.779389] network-addresses-eth1-start[758]: adding address 192.168.1.2/24... done1718server # [ 13.801727] network-addresses-eth1-start[758]: adding address 2001:db8:1::2/64... done1719server # [ 13.825280] systemd[1]: Finished Address configuration of eth1.1720server # [ 13.862702] mousedev: PS/2 mouse device common for all mice1721server # [ 13.873772] systemd-logind[534]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1722host1 # [ 14.058432] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31723host1 # [ 14.233580] dhcpcd[704]: eth0: soliciting a DHCP lease1724host1 # [ 14.240694] dhcpcd[704]: eth0: offered 10.0.2.15 from 10.0.2.21725host1 # [ 14.248433] dhcpcd[704]: eth0: probing address 10.0.2.15/241726host1 # [ 14.308944] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1727host1 # [ 14.352536] systemd[1]: Starting Virtual Console Setup...1728host1 # [ 14.387361] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1729host1 # [ 14.392971] systemd[1]: Stopped Virtual Console Setup.1730host1 # [ 14.399518] systemd[1]: Starting Virtual Console Setup...1731host1 # [ 14.414047] systemd-logind[540]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1732server # [ 14.576919] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31733host1 # [ 14.815929] systemd-vconsole-setup[748]: Configuration of first virtual console was skipped, ignoring remaining ones.1734host1 # [ 14.820645] systemd[1]: Finished Virtual Console Setup.1735server # [ 14.963223] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1736server # [ 14.977394] systemd[1]: Starting Virtual Console Setup...1737server # [ 15.004332] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1738server # [ 15.008497] systemd[1]: Stopped Virtual Console Setup.1739server # [ 15.011627] systemd[1]: Starting Virtual Console Setup...1740server # [ 15.059281] systemd-logind[534]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1741server # [ 15.068474] dhcpcd[719]: eth0: soliciting a DHCP lease1742server # [ 15.076617] dhcpcd[719]: eth0: offered 10.0.2.15 from 10.0.2.21743server # [ 15.084275] dhcpcd[719]: eth0: probing address 10.0.2.15/241744server # [ 15.452919] systemd-vconsole-setup[793]: Configuration of first virtual console was skipped, ignoring remaining ones.1745server # [ 15.456846] systemd[1]: Finished Virtual Console Setup.1746server # [ 15.531721] dhcpcd[719]: eth0: soliciting an IPv6 router1747server # [ 15.533359] dhcpcd[719]: eth0: Router Advertisement from fe80::21748server # [ 15.534216] dhcpcd[719]: eth0: adding address fec0::5054:ff:fe12:3456/641749server # [ 15.535145] dhcpcd[719]: eth0: adding route to fec0::/641750server # [ 15.535875] dhcpcd[719]: eth0: adding default route via fe80::21751host1 # [ 16.031199] dhcpcd[704]: eth0: soliciting an IPv6 router1752host1 # [ 16.034874] dhcpcd[704]: eth0: Router Advertisement from fe80::21753host1 # [ 16.037713] dhcpcd[704]: eth0: adding address fec0::5054:ff:fe12:3456/641754host1 # [ 16.040517] dhcpcd[704]: eth0: adding route to fec0::/641755host1 # [ 16.042712] dhcpcd[704]: eth0: adding default route via fe80::21756host1 # [ 19.336874] dhcpcd[704]: eth0: leased 10.0.2.15 for 86400 seconds1757host1 # [ 19.340229] dhcpcd[704]: eth0: adding route to 10.0.2.0/241758host1 # [ 19.342637] dhcpcd[704]: eth0: adding default route via 10.0.2.21759host1 # [ 19.496619] systemd[1]: Started DHCP Client.1760host1 # [ 19.499356] systemd[1]: Reached target Network is Online.1761host1 # [ 19.503995] systemd[1]: Starting fetch-ca-root.service...1762host1 # [ 19.586250] fetch-ca-root-start[813]: curl: (7) Failed to connect to server:8443 after 12 ms: Could not connect to server1763server # [ 20.290593] dhcpcd[719]: eth0: leased 10.0.2.15 for 86400 seconds1764server # [ 20.294950] dhcpcd[719]: eth0: adding route to 10.0.2.0/241765server # [ 20.297939] dhcpcd[719]: eth0: adding default route via 10.0.2.21766server # [ 20.498095] systemd[1]: Started DHCP Client.1767server # [ 20.500857] systemd[1]: Reached target Network is Online.1768server # [ 20.508179] systemd[1]: Starting step-ca service...1769host1 # [ 20.590857] fetch-ca-root-start[813]: curl: (7) Failed to connect to server:8443 after 1 ms: Could not connect to server1770server # [ 20.953002] step-ca[903]: badger 2026/09/20 08:17:11 INFO: All 0 tables opened in 0s1771server # [ 20.978952] step-ca[903]: 2026/09/20 08:17:11 Building new tls configuration using step-ca x509 Signer Interface1772server # [ 20.999744] step-ca[903]: 2026/09/20 08:17:11 Starting Smallstep CA/0.30.2 (linux/arm64)1773server # [ 21.001081] step-ca[903]: 2026/09/20 08:17:11 Documentation: https://u.step.sm/docs/ca1774server # [ 21.002235] step-ca[903]: 2026/09/20 08:17:11 Community Discord: https://u.step.sm/discord1775server # [ 21.003425] step-ca[903]: 2026/09/20 08:17:11 Config file: /etc/smallstep/ca.json1776server # [ 21.004818] step-ca[903]: 2026/09/20 08:17:11 The primary server URL is https://server:84431777server # [ 21.006036] step-ca[903]: 2026/09/20 08:17:11 Root certificates are available at https://server:8443/roots.pem1778server # [ 21.007476] step-ca[903]: 2026/09/20 08:17:11 X.509 Root Fingerprint: 4a3e8de32a39294adc26c6c1576ed1087d001a8fa2e67584d9234903026e328f1779server # [ 21.011560] systemd[1]: Started step-ca service.1780server # [ 21.015785] systemd[1]: Reached target Multi-User System.1781server # [ 21.020353] systemd[1]: Starting Order (and renew) ACME certificate for server...1782server # [ 21.029300] step-ca[903]: 2026/09/20 08:17:11 Serving HTTPS on 0.0.0.0:8443 ...1783server # [ 21.095989] acme-order-renew-server-start[909]: Waiting to acquire lock in /run/acme/1784server # [ 21.108100] acme-order-renew-server-start[909]: + set -euo pipefail1785server # [ 21.109074] acme-order-renew-server-start[909]: + echo 95dbbf40517986466fee1786server # [ 21.110129] acme-order-renew-server-start[909]: + cmp -s domainhash.txt certificates/domainhash.txt1787server # [ 21.119356] acme-order-renew-server-start[909]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server run1788server # [ 21.440003] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 No key found for account root@example.org. Generating a P256 key.1789server # [ 21.444621] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key1790server # [ 21.482291] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] acme: Registering account for root@example.org1791server # [ 21.498822] acme-order-renew-server-start[919]: !!!! HEADS UP !!!!1792server # [ 21.499855] acme-order-renew-server-start[919]: Your account credentials have been saved in your1793server # [ 21.501416] acme-order-renew-server-start[919]: configuration directory at "accounts".1794server # [ 21.503467] acme-order-renew-server-start[919]: You should make a secure backup of this folder now. This1795server # [ 21.505144] acme-order-renew-server-start[919]: configuration directory will also contain private keys1796server # [ 21.506439] acme-order-renew-server-start[919]: generated by lego and certificates obtained from the ACME1797server # [ 21.507748] acme-order-renew-server-start[919]: server. Making regular backups of this folder is ideal.1798server # [ 21.509804] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] acme: Obtaining bundled SAN certificate1799server: (finished: waiting for unit step-ca.service, in 21.93 seconds)1800server: waiting for unit nix-grpc-daemon.socket1801server # [ 21.588719] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] AuthURL: https://server:8443/acme/acme/authz/4dLp1gCjW8zMFhFXocXsufScC6NkZITI1802server # [ 21.590669] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] acme: Could not find solver for: tls-alpn-011803server # [ 21.593119] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] acme: use http-01 solver1804server # [ 21.595654] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] acme: Trying to solve HTTP-011805server # [ 21.606736] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] Served key authentication1806server # [ 21.611772] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] The server validated our request1807server # [ 21.614647] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] acme: Validations succeeded; requesting certificates1808server # [ 21.644391] acme-order-renew-server-start[919]: 2026/09/20 08:17:12 [INFO] [server] Server responded with a certificate.1809server # [ 21.650033] acme-order-renew-server-start[909]: + mv domainhash.txt certificates/1810server # [ 21.658450] acme-order-renew-server-start[909]: + touch out/acme-success1811host1 # [ 21.640951] systemd[1]: Finished fetch-ca-root.service.1812host1 # [ 21.647024] systemd[1]: Reached target Multi-User System.1813server # [ 21.667205] acme-order-renew-server-start[909]: + cmp -s certificates/server.crt out/fullchain.pem1814server # [ 21.672592] acme-order-renew-server-start[909]: + touch out/renewed1815host1 # [ 21.658185] systemd[1]: Starting Order (and renew) ACME certificate for host1...1816server # [ 21.684274] acme-order-renew-server-start[909]: + echo Installing new certificate1817server # [ 21.686665] acme-order-renew-server-start[909]: Installing new certificate1818server # [ 21.687965] acme-order-renew-server-start[909]: + cp -vp certificates/server.crt out/fullchain.pem1819server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.11 seconds)1820server: waiting for TCP port 50051 on localhost1821server # [ 21.696387] acme-order-renew-server-start[936]: 'certificates/server.crt' -> 'out/fullchain.pem'1822server # [ 21.698536] acme-order-renew-server-start[909]: + cp -vp certificates/server.key out/key.pem1823server # [ 21.707327] acme-order-renew-server-start[939]: 'certificates/server.key' -> 'out/key.pem'1824server # [ 21.711367] acme-order-renew-server-start[909]: + cp -vp certificates/server.issuer.crt out/chain.pem1825server # [ 21.720500] acme-order-renew-server-start[941]: 'certificates/server.issuer.crt' -> 'out/chain.pem'1826server # [ 21.722477] acme-order-renew-server-start[909]: + ln -sf fullchain.pem out/cert.pem1827server # [ 21.731873] acme-order-renew-server-start[909]: + cat out/key.pem out/fullchain.pem1828server # [ 21.742449] acme-order-renew-server-start[909]: + for fixpath in out certificates1829server # [ 21.743729] acme-order-renew-server-start[909]: + '[' -d out ']'1830server # [ 21.745188] acme-order-renew-server-start[909]: + chmod -R u=rwX,g=rX,o= out1831server # [ 21.753103] acme-order-renew-server-start[909]: + chown -R acme:nix-grpc-daemon out1832server # [ 21.763703] acme-order-renew-server-start[909]: + for fixpath in out certificates1833server # [ 21.765093] acme-order-renew-server-start[909]: + '[' -d certificates ']'1834server # [ 21.766198] acme-order-renew-server-start[909]: + chmod -R u=rwX,g=rX,o= certificates1835server # [ 21.773251] acme-order-renew-server-start[909]: + chown -R acme:nix-grpc-daemon certificates1836server # [ 21.783956] acme-order-renew-server-start[909]: + chmod -R u=rwX,g=,o= accounts/.1837host1 # [ 21.767809] acme-order-renew-host1-start[818]: Waiting to acquire lock in /run/acme/1838server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!1839host1 # [ 21.781733] acme-order-renew-host1-start[818]: + set -euo pipefail1840host1 # [ 21.782902] acme-order-renew-host1-start[818]: + echo 76ccde284609af0e376b1841host1 # [ 21.783948] acme-order-renew-host1-start[818]: + cmp -s domainhash.txt certificates/domainhash.txt1842server: (finished: waiting for TCP port 50051 on localhost, in 0.11 seconds)1843subtest: host1 obtains a certificate via ACME1844host1: waiting for success: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA'1845host1: waiting for the VM to finish booting1846host1: Guest shell says: b'Spawning backdoor root shell...\n'1847host1: connected to guest root shell1848host1: (connecting took 0.00 seconds)1849host1: (finished: waiting for the VM to finish booting, in 0.00 seconds)1850host1 # [ 21.796704] acme-order-renew-host1-start[818]: + lego --accept-tos --path . --email root@example.org --http --http.port :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 run1851server # [ 21.856764] systemd[1]: acme-order-renew-server.service: Deactivated successfully.1852server # [ 21.859597] systemd[1]: Finished Order (and renew) ACME certificate for server.1853server # [ 21.862235] systemd[1]: acme-order-renew-server.service: Consumed 223ms CPU time over 838ms wall clock time, 33.4M memory peak, 10.2K incoming IP traffic, 8.2K outgoing IP traffic.1854server # [ 21.870056] systemd[1]: Starting Nix worker-protocol over gRPC...1855server # [ 22.086776] nix-grpc-daemon[960]: ts=2026-09-20T08:17:12Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=11856server # [ 22.137748] nix-grpc-daemon[960]: ts=2026-09-20T08:17:12Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket1857server # [ 22.140852] nix-grpc-daemon[960]: ts=2026-09-20T08:17:12Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=01858server # [ 22.144515] nix-grpc-daemon[960]: ts=2026-09-20T08:17:12Z level=info event=unhealthy reason=min_free1859server # [ 22.145931] systemd[1]: Started Nix worker-protocol over gRPC.1860server # [ 22.146927] systemd[1]: Startup finished in 991ms (kernel) + 5.436s (initrd) + 15.715s (userspace) = 22.143s.1861host1 # [ 22.145022] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 No key found for account root@example.org. Generating a P256 key.1862host1 # [ 22.149593] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 Saved key to accounts/server_8443/root@example.org/keys/root@example.org.key1863host1 # [ 22.179510] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] acme: Registering account for root@example.org1864host1 # [ 22.192760] acme-order-renew-host1-start[829]: !!!! HEADS UP !!!!1865host1 # [ 22.194313] acme-order-renew-host1-start[829]: Your account credentials have been saved in your1866host1 # [ 22.195485] acme-order-renew-host1-start[829]: configuration directory at "accounts".1867host1 # [ 22.196579] acme-order-renew-host1-start[829]: You should make a secure backup of this folder now. This1868host1 # [ 22.197777] acme-order-renew-host1-start[829]: configuration directory will also contain private keys1869host1 # [ 22.198929] acme-order-renew-host1-start[829]: generated by lego and certificates obtained from the ACME1870host1 # [ 22.200156] acme-order-renew-host1-start[829]: server. Making regular backups of this folder is ideal.1871host1 # [ 22.201360] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] acme: Obtaining bundled SAN certificate1872host1 # [ 22.269624] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] AuthURL: https://server:8443/acme/acme/authz/eIgEUXFtgqjWz935mPKYuWL27uUlJpyJ1873host1 # [ 22.274368] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] acme: Could not find solver for: tls-alpn-011874host1 # [ 22.277192] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] acme: use http-01 solver1875host1 # [ 22.280291] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] acme: Trying to solve HTTP-011876host1 # [ 22.283891] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] Served key authentication1877host1 # [ 22.290886] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] The server validated our request1878host1 # [ 22.293682] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] acme: Validations succeeded; requesting certificates1879host1 # [ 22.310700] acme-order-renew-host1-start[829]: 2026/09/20 08:17:12 [INFO] [host1] Server responded with a certificate.1880host1 # [ 22.319281] acme-order-renew-host1-start[818]: + mv domainhash.txt certificates/1881host1 # [ 22.331555] acme-order-renew-host1-start[818]: + touch out/acme-success1882host1 # [ 22.342884] acme-order-renew-host1-start[818]: + cmp -s certificates/host1.crt out/fullchain.pem1883host1 # [ 22.350258] acme-order-renew-host1-start[818]: + touch out/renewed1884host1 # [ 22.358597] acme-order-renew-host1-start[818]: + echo Installing new certificate1885host1 # [ 22.360574] acme-order-renew-host1-start[818]: Installing new certificate1886host1 # [ 22.362078] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.crt out/fullchain.pem1887host1 # [ 22.370210] acme-order-renew-host1-start[841]: 'certificates/host1.crt' -> 'out/fullchain.pem'1888host1 # [ 22.372763] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.key out/key.pem1889host1 # [ 22.380199] acme-order-renew-host1-start[842]: 'certificates/host1.key' -> 'out/key.pem'1890host1 # [ 22.382442] acme-order-renew-host1-start[818]: + cp -vp certificates/host1.issuer.crt out/chain.pem1891host1 # [ 22.389766] acme-order-renew-host1-start[843]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'1892host1 # [ 22.391886] acme-order-renew-host1-start[818]: + ln -sf fullchain.pem out/cert.pem1893host1 # [ 22.400302] acme-order-renew-host1-start[818]: + cat out/key.pem out/fullchain.pem1894host1 # [ 22.408884] acme-order-renew-host1-start[818]: + for fixpath in out certificates1895host1 # [ 22.410294] acme-order-renew-host1-start[818]: + '[' -d out ']'1896host1 # [ 22.411415] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=rX,o= out1897host1 # [ 22.418042] acme-order-renew-host1-start[818]: + chown -R acme:acme out1898host1 # [ 22.428103] acme-order-renew-host1-start[818]: + for fixpath in out certificates1899host1 # [ 22.429299] acme-order-renew-host1-start[818]: + '[' -d certificates ']'1900host1 # [ 22.430313] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=rX,o= certificates1901host1 # [ 22.437460] acme-order-renew-host1-start[818]: + chown -R acme:acme certificates1902host1 # [ 22.446114] acme-order-renew-host1-start[818]: + chmod -R u=rwX,g=,o= accounts/.1903host1 # [ 22.507056] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.1904host1 # [ 22.508877] systemd[1]: Finished Order (and renew) ACME certificate for host1.1905host1 # [ 22.511395] systemd[1]: Startup finished in 988ms (kernel) + 5.423s (initrd) + 16.098s (userspace) = 22.510s.1906host1 # [ 22.514558] systemd[1]: acme-order-renew-host1.service: Consumed 262ms CPU time over 850ms wall clock time, 33.4M memory peak, 10.4K incoming IP traffic, 8.3K outgoing IP traffic.1907host1: (finished: waiting for success: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject -issuer | grep -q 'Test Intermediate CA', in 1.22 seconds)1908host1: must succeed: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1'1909host1: (finished: must succeed: /nix/store/9ibakafsh3z4y7q3nvs44mz5vwhh67ch-openssl-3.6.3-bin/bin/openssl x509 -in /var/lib/acme/host1/cert.pem -noout -subject | grep -q 'CN *= *host1', in 0.07 seconds)1910(finished: subtest: host1 obtains a certificate via ACME, in 1.28 seconds)1911subtest: server builds and signs a path1912server: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths1913server # 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 23 ms (attempt 1/5)1914server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 91 ms (attempt 2/5)1915server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 164 ms (attempt 3/5)1916server # 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 528 ms (attempt 4/5)1917server # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1918server # this derivation will be built:1919server # /nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv1920server # building '/nix/store/kkr1m31ja6qn4sc39z93j6w6mmkx0az9-hello-grpc.drv'...1921server: (finished: must succeed: nix build --impure -f /etc/hello.nix --no-link --print-out-paths, in 1.52 seconds)1922server: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1923server # added 1 signatures1924server: (finished: must succeed: nix store sign -k /etc/cache-key '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.21 seconds)1925(finished: subtest: server builds and signs a path, in 1.73 seconds)1926subtest: host1 substitutes the signed path over gRPC (read-only cert)1927host1: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1928host1: (finished: must fail: test -e '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.04 seconds)1929host1: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1930host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 59 ms (attempt 1/5)1931host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 25 ms (attempt 2/5)1932host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org; retrying in 380 ms (attempt 3/5)1933host1 # 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 787 ms (attempt 4/5)1934host1 # warning: unable to download 'https://cache.nixos.org/nix-cache-info': Could not resolve hostname (6) Could not resolve host: cache.nixos.org1935server # [ 26.418496] systemd[1]: Started Nix Daemon.1936server # [ 26.693711] nix-daemon[993]: accepted connection from pid 960, user nix-grpc-daemon (trusted)1937host1 # this path will be fetched (0.0 KiB download, 0.1 KiB unpacked):1938host1 # /nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc1939host1 # copying path '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc' from 'grpc://server:50051'...1940server # [ 26.741069] nix-grpc-daemon[960]: ts=2026-09-20T08:17:17Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:40282 duration_s=0 paths=1 nar_bytes_out=1281941host1 # warning: you did not specify '--add-root'; the result might be removed by the garbage collector1942host1: (finished: must succeed: nix-store -r '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 1.99 seconds)1943host1: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc'1944host1: (finished: must succeed: grep -q hello-over-grpc '/nix/store/yp0zv0nbwik9d6wqgsrajwwqb1fsfd0p-hello-grpc', in 0.04 seconds)1945(finished: subtest: host1 substitutes the signed path over gRPC (read-only cert), in 2.06 seconds)1946subtest: read-only host1 cannot write1947host1: must succeed: echo deny > /root/denyfile1948host1: (finished: must succeed: echo deny > /root/denyfile, in 0.02 seconds)1949host1: 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/denyfile1950server # [ 27.101043] nix-grpc-daemon[960]: ts=2026-09-20T08:17:17Z level=info event=denied method=Connect cn=host1 role=read-only1951host1 # error: gRPC Connect on 'server:50051' failed: role 'read-only' may not call Connect1952host1 # error: cannot open connection to remote store 'grpc://server:50051': error: Nix daemon disconnected unexpectedly (maybe it crashed?)1953host1: (finished: must fail: nix store add --store 'grpc://server:50051?ca-cert=/run/root_ca.crt&client-cert=/var/lib/acme/host1/cert.pem&client-key=/var/lib/acme/host1/key.pem' /root/denyfile, in 0.24 seconds)1954server: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only'1955server: (finished: must succeed: journalctl -u nix-grpc-daemon.service | grep -q 'event=denied .*cn=host1 role=read-only', in 0.06 seconds)1956(finished: subtest: read-only host1 cannot write, in 0.32 seconds)1957(finished: run the VM test script, in 27.99 seconds)1958test script finished in 28.12s1959cleanup1960kill QemuMachine (pid 47)1961host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1962kill QemuMachine (pid 48)1963server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/lfh101cfjj8p8npcari9hk0lbqi33yvh-python3-3.14.7/bin/python3.14)1964(finished: cleanup, in 0.42 seconds)1965additionally exposed symbols:1966 host1, server,1967 vlan1,1968 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