vm-test-run-nix-grpc-store-acme-substituter
checks.aarch64-linux.acme-vm
· build #745
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.01 seconds)5start vhost-device-vsock6(finished: start vhost-device-vsock, in 0.00 seconds)7Test will time out and terminate in 600.0 seconds8run the VM test script9start all VMs10host1: starting vm11server: starting vm12host1 # Disk image does not exist, creating the virtualisation disk image...13host1: QEMU running (pid 52)14host1 # Formatting '/build/vm-state-host1/tmp.Fpjr6kIArU', fmt=raw size=107374182415host1 # mke2fs 1.47.4 (6-Mar-2025)16host1 # Discarding device blocks: 0/262144 done17host1 # Creating filesystem with 262144 4k blocks and 65536 inodes18host1 # Filesystem UUID: 32656be3-988c-4f06-8510-6b57f7a9750f19host1 # Superblock backups stored on blocks:20host1 # 32768, 98304, 163840, 22937621host1 # 22host1 # Allocating group tables: 0/8 done23host1 # Writing inode tables: 0/8 done24host1 # Creating journal (8192 blocks): done25host1 # Writing superblocks and filesystem accounting information: 0/8 done26host1 # 27host1 # Virtualisation disk image created.28host1 # Starting virtiofs daemons...29host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)30host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether31host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...32host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)33host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether34host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)35host1 # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether36host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...37host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...38host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests39host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests40host1 # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests41host1 # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]42host1 # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @179172517243host1 # [ 0.000000] KASLR enabled44host1 # [ 0.000000] random: crng init done45host1 # [ 0.000000] Machine model: linux,dummy-virt46host1 # [ 0.000000] efi: UEFI not found.47host1 # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT48host1 # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]49host1 # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]50host1 # [ 0.000000] Zone ranges:51host1 # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]52host1 # [ 0.000000] DMA32 empty53host1 # [ 0.000000] Normal empty54host1 # [ 0.000000] Device empty55host1 # [ 0.000000] Movable zone start for each node56host1 # [ 0.000000] Early memory node ranges57host1 # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]58host1 # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]59host1 # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc0000060host1 # [ 0.000000] psci: probing for conduit method from DT.61host1 # [ 0.000000] psci: PSCIv1.3 detected in firmware.62host1 # [ 0.000000] psci: Using standard PSCI v0.2 function IDs63host1 # [ 0.000000] psci: Trusted OS migration not required64host1 # [ 0.000000] psci: SMC Calling Convention v1.165host1 # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)66host1 # [ 0.000000] percpu: Embedded 76 pages/cpu s186904 r8192 d116200 u31129667host1 # [ 0.000000] Detected PIPT I-cache on CPU068host1 # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)69host1 # [ 0.000000] CPU features: detected: GICv3 CPU interface70host1 # [ 0.000000] CPU features: detected: Spectre-v471host1 # [ 0.000000] CPU features: detected: Spectre-BHB72host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3873host1 # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2374host1 # [ 0.000000] alternatives: applying boot alternatives75host1 # [ 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/wm093l7n9mqnj6q4ih5jg6abc8zkl2xj-nixos-system-host1-test/init regInfo=/nix/.ro-store/0q0jylvlx8kci9r03jwgl80m0i49fsmg-closure-info/registration console=ttyAMA0,115200n8 console=tty076host1 # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/0q0jylvlx8kci9r03jwgl80m0i49fsmg-closure-info/registration", will be passed to user space.77host1 # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes78host1 # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)79host1 # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)80host1 # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB81host1 # [ 0.000000] software IO TLB: area num 1.82host1 # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)83host1 # [ 0.000000] Fallback order for Node 0: 084host1 # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 52428885host1 # [ 0.000000] Policy zone: DMA86host1 # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off87host1 # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=188host1 # [ 0.000000] allocated 4194304 bytes of page_ext89host1 # [ 0.000000] ftrace: allocating 75049 entries in 294 pages90host1 # [ 0.000000] ftrace: allocated 294 pages with 4 groups91host1 # [ 0.000000] rcu: Hierarchical RCU implementation.92host1 # [ 0.000000] rcu: RCU event tracing is enabled.93host1 # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.94host1 # [ 0.000000] Trampoline variant of Tasks RCU enabled.95host1 # [ 0.000000] Rude variant of Tasks RCU enabled.96host1 # [ 0.000000] Tracing variant of Tasks RCU enabled.97host1 # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.98host1 # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=199host1 # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.100host1 # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.101host1 # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.102host1 # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0103host1 # [ 0.000000] GICv3: 256 SPIs implemented104host1 # [ 0.000000] GICv3: 0 Extended SPIs implemented105host1 # [ 0.000000] Root IRQ handler: gic_handle_irq106host1 # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI107host1 # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0108host1 # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000109host1 # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]110host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1)111host1 # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1)112host1 # [ 0.000000] GICv3: using LPI property table @0x0000000044b10000113host1 # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b20000114host1 # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.115host1 # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns116host1 # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).117host1 # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns118host1 # [ 0.000001] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns119host1 # [ 0.000056] arm-pv: using stolen time PV120host1 # [ 0.000780] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)121host1 # [ 0.001079] Console: colour dummy device 80x25122host1 # [ 0.001097] printk: legacy console [tty0] enabled123host1 # [ 0.001400] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)124host1 # [ 0.001408] pid_max: default: 32768 minimum: 301125host1 # [ 0.001556] LSM: initializing lsm=capability,landlock,yama,bpf,ima126host1 # [ 0.001762] landlock: Up and running.127host1 # [ 0.001769] Yama: becoming mindful.128host1 # [ 0.002554] LSM support for eBPF active129host1 # [ 0.002837] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)130host1 # [ 0.002918] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)131host1 # [ 0.006586] rcu: Hierarchical SRCU implementation.132host1 # [ 0.006596] rcu: Max phase no-delay instances is 1000.133host1 # [ 0.008460] fsl-mc MSI: its@8080000 domain created134host1 # [ 0.008625] EFI services will not be available.135host1 # [ 0.008728] smp: Bringing up secondary CPUs ...136host1 # [ 0.008763] smp: Brought up 1 node, 1 CPU137host1 # [ 0.008768] SMP: Total of 1 processors activated.138host1 # [ 0.008771] CPU: All CPU(s) started at EL1139host1 # [ 0.008792] CPU features: detected: Branch Target Identification140host1 # [ 0.008804] CPU features: detected: ARMv8.4 Translation Table Level141host1 # [ 0.008809] CPU features: detected: Instruction cache invalidation not required for I/D coherence142host1 # [ 0.008813] CPU features: detected: Data cache clean to the PoU not required for I/D coherence143host1 # [ 0.008848] CPU features: detected: Common not Private translations144host1 # [ 0.008854] CPU features: detected: CRC32 instructions145host1 # [ 0.008862] CPU features: detected: Data cache clean to Point of Deep Persistence146host1 # [ 0.008871] CPU features: detected: Data cache clean to Point of Persistence147host1 # [ 0.008874] CPU features: detected: Data independent timing control (DIT)148host1 # [ 0.008877] CPU features: detected: E0PD149host1 # [ 0.008880] CPU features: detected: Enhanced Counter Virtualization150host1 # [ 0.008883] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)151host1 # [ 0.008886] CPU features: detected: Enhanced Virtualization Traps152host1 # [ 0.008889] CPU features: detected: Fine Grained Traps153host1 # [ 0.008893] CPU features: detected: Generic authentication (architected QARMA5 algorithm)154host1 # [ 0.008899] CPU features: detected: RCpc load-acquire (LDAPR)155host1 # [ 0.008905] CPU features: detected: LSE atomic instructions156host1 # [ 0.008913] CPU features: detected: Privileged Access Never157host1 # [ 0.008921] CPU features: detected: PMUv3158host1 # [ 0.008924] CPU features: detected: RAS Extension Support159host1 # [ 0.008932] CPU features: detected: RASv1p1 Extension Support160host1 # [ 0.008945] CPU features: detected: Random Number Generator161host1 # [ 0.008952] CPU features: detected: Speculation barrier (SB)162host1 # [ 0.008954] CPU features: detected: Stage-2 Force Write-Back163host1 # [ 0.008957] CPU features: detected: TLB range maintenance instructions164host1 # [ 0.008962] CPU features: detected: Speculative Store Bypassing Safe (SSBS)165host1 # [ 0.009039] alternatives: applying system-wide alternatives166host1 # [ 0.016778] CPU features: detected: BBM Level 2 without TLB conflict abort167host1 # [ 0.017161] Memory: 1920400K/2097152K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 133164K reserved, 32768K cma-reserved)168host1 # [ 0.018805] devtmpfs: initialized169host1 # [ 0.024003] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)170host1 # [ 0.024053] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).171host1 # [ 0.024335] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL172host1 # [ 0.024345] 0 pages in range for non-PLT usage173host1 # [ 0.024362] 508192 pages in range for PLT usage174host1 # [ 0.025721] pinctrl core: initialized pinctrl subsystem175host1 # [ 0.027900] DMI not present or invalid.176host1 # [ 0.034226] NET: Registered PF_NETLINK/PF_ROUTE protocol family177host1 # [ 0.040306] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations178host1 # [ 0.040541] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations179host1 # [ 0.040779] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations180host1 # [ 0.040850] audit: initializing netlink subsys (disabled)181host1 # [ 0.041791] audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1182host1 # [ 0.043627] thermal_sys: Registered thermal governor 'fair_share'183host1 # [ 0.043630] thermal_sys: Registered thermal governor 'bang_bang'184host1 # [ 0.043635] thermal_sys: Registered thermal governor 'step_wise'185host1 # [ 0.043638] thermal_sys: Registered thermal governor 'user_space'186host1 # [ 0.043640] thermal_sys: Registered thermal governor 'power_allocator'187host1 # [ 0.043832] cpuidle: using governor ladder188host1 # [ 0.043853] cpuidle: using governor menu189host1 # [ 0.046292] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.190host1 # [ 0.046323] ASID allocator initialised with 65536 entries191host1 # [ 0.053801] Serial: AMBA PL011 UART driver192host1 # [ 0.064045] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1193host1 # [ 0.064309] printk: console [ttyAMA0] enabled194host1 # [ 0.210583] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages195host1 # [ 0.210604] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page196host1 # [ 0.210608] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages197host1 # [ 0.210611] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page198host1 # [ 0.210613] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages199host1 # [ 0.210616] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page200host1 # [ 0.210619] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages201host1 # [ 0.210622] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page202host1 # [ 0.221199] fbcon: Taking over console203host1 # [ 0.221214] ACPI: Interpreter disabled.204host1 # [ 0.230797] iommu: Default domain type: Translated205host1 # [ 0.230805] iommu: DMA domain TLB invalidation policy: strict mode206host1 # [ 0.231246] SCSI subsystem initialized207host1 # [ 0.231526] usbcore: registered new interface driver usbfs208host1 # [ 0.231562] usbcore: registered new interface driver hub209host1 # [ 0.231580] usbcore: registered new device driver usb210host1 # [ 0.231950] pps_core: LinuxPPS API ver. 1 registered211host1 # [ 0.231955] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>212host1 # [ 0.231964] PTP clock support registered213host1 # [ 0.232028] EDAC MC: Ver: 3.0.0214host1 # [ 0.232220] scmi_core: SCMI protocol bus registered215host1 # [ 0.232733] FPGA manager framework216host1 # [ 0.233871] vgaarb: loaded217host1 # [ 0.241746] clocksource: Switched to clocksource arch_sys_counter218host1 # [ 0.248509] VFS: Disk quotas dquot_6.6.0219host1 # [ 0.248577] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)220host1 # [ 0.249308] netfs: FS-Cache loaded221host1 # [ 0.249580] pnp: PnP ACPI: disabled222host1 # [ 0.257087] NET: Registered PF_INET protocol family223host1 # [ 0.257442] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)224host1 # [ 0.297271] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)225host1 # [ 0.297333] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)226host1 # [ 0.297378] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)227host1 # [ 0.297469] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)228host1 # [ 0.297624] TCP: Hash tables configured (established 16384 bind 16384)229host1 # [ 0.297825] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)230host1 # [ 0.297870] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)231host1 # [ 0.297923] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)232host1 # [ 0.298074] NET: Registered PF_UNIX/PF_LOCAL protocol family233host1 # [ 0.298131] NET: Registered PF_XDP protocol family234host1 # [ 0.298156] PCI: CLS 0 bytes, default 64235host1 # [ 0.307895] Trying to unpack rootfs image as initramfs...236host1 # [ 0.318257] kvm [1]: HYP mode not available237host1 # [ 0.415059] Initialise system trusted keyrings238host1 # [ 0.415190] workingset: timestamp_bits=42 max_order=19 bucket_order=0239host1 # [ 0.415640] squashfs: version 4.0 (2009/01/31) Phillip Lougher240host1 # [ 0.415722] 9p: Installing v9fs 9p2000 file system support241host1 # [ 0.443799] Key type asymmetric registered242host1 # [ 0.443820] Asymmetric key parser 'x509' registered243host1 # [ 0.443898] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)244host1 # [ 0.444045] io scheduler mq-deadline registered245host1 # [ 0.444051] io scheduler kyber registered246host1 # [ 0.456887] pl061_gpio 9030000.pl061: PL061 GPIO chip registered247host1 # [ 0.457498] ledtrig-cpu: registered to indicate activity on CPUs248host1 # [ 0.457953] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:249host1 # [ 0.457969] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000250host1 # [ 0.457987] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000251host1 # [ 0.457994] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000252host1 # [ 0.458017] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits253host1 # [ 0.458040] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]254host1 # [ 0.458129] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00255host1 # [ 0.458140] pci_bus 0000:00: root bus resource [bus 00-ff]256host1 # [ 0.458147] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]257host1 # [ 0.458151] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]258host1 # [ 0.458155] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]259host1 # [ 0.478348] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint260host1 # [ 0.478899] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint261host1 # [ 0.479087] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]262host1 # [ 0.479099] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]263host1 # [ 0.479126] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]264host1 # [ 0.479137] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]265host1 # [ 0.479902] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint266host1 # [ 0.480087] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]267host1 # [ 0.480098] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]268host1 # [ 0.480124] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]269host1 # [ 0.480616] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint270host1 # [ 0.480799] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]271host1 # [ 0.480810] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]272host1 # [ 0.480836] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]273host1 # [ 0.481301] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint274host1 # [ 0.481484] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]275host1 # [ 0.481496] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]276host1 # [ 0.481521] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]277host1 # [ 0.481533] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]278host1 # [ 0.482002] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint279host1 # [ 0.482189] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]280host1 # [ 0.482240] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]281host1 # [ 0.482716] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint282host1 # [ 0.482903] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]283host1 # [ 0.482929] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]284host1 # [ 0.483330] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint285host1 # [ 0.483512] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]286host1 # [ 0.483805] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint287host1 # [ 0.483994] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]288host1 # [ 0.484020] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]289host1 # [ 0.484505] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint290host1 # [ 0.484692] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]291host1 # [ 0.484718] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]292host1 # [ 0.485189] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint293host1 # [ 0.485378] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]294host1 # [ 0.485404] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]295host1 # [ 0.485909] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint296host1 # [ 0.486214] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]297host1 # [ 0.486227] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]298host1 # [ 0.486253] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]299host1 # [ 0.486725] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint300host1 # [ 0.486911] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]301host1 # [ 0.486922] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]302host1 # [ 0.486947] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]303host1 # [ 0.487410] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint304host1 # [ 0.487597] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]305host1 # [ 0.487623] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]306host1 # [ 0.488705] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned307host1 # [ 0.488712] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned308host1 # [ 0.488716] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned309host1 # [ 0.488759] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned310host1 # [ 0.488802] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned311host1 # [ 0.488845] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned312host1 # [ 0.488887] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned313host1 # [ 0.488933] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned314host1 # [ 0.488977] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned315host1 # [ 0.489030] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned316host1 # [ 0.489073] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned317host1 # [ 0.489120] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned318host1 # [ 0.489194] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned319host1 # [ 0.489237] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned320host1 # [ 0.489278] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned321host1 # [ 0.489301] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned322host1 # [ 0.489319] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned323host1 # [ 0.489339] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned324host1 # [ 0.489356] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned325host1 # [ 0.489373] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned326host1 # [ 0.489391] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned327host1 # [ 0.489409] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned328host1 # [ 0.489426] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned329host1 # [ 0.489447] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned330host1 # [ 0.489465] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned331host1 # [ 0.489483] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned332host1 # [ 0.489505] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned333host1 # [ 0.489522] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned334host1 # [ 0.489539] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned335host1 # [ 0.489556] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned336host1 # [ 0.489573] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned337host1 # [ 0.489590] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned338host1 # [ 0.489607] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned339host1 # [ 0.489628] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]340host1 # [ 0.489634] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]341host1 # [ 0.489637] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]342host1 # [ 0.566584] pci 0000:00:07.0: enabling device (0000 -> 0002)343host1 # [ 0.625662] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)344server: QEMU running (pid 55)345server # Disk image does not exist, creating the virtualisation disk image...346server # Formatting '/build/vm-state-server/tmp.th3mCoWEEy', fmt=raw size=1073741824347server # mke2fs 1.47.4 (6-Mar-2025)348server # Discarding device blocks: 0/262144 done349server # Creating filesystem with 262144 4k blocks and 65536 inodes350(finished: start all VMs, in 6.08 seconds)351server # Filesystem UUID: 86dc2d0d-a22f-4d13-8c51-9b88819f46ae352server: waiting for unit step-ca.service353server # Superblock backups stored on blocks:354server: waiting for the VM to finish booting355server # 32768, 98304, 163840, 229376356server # 357server # Allocating group tables: 0/8 done358server # Writing inode tables: 0/8 done359server # Creating journal (8192 blocks): done360server # Writing superblocks and filesystem accounting information: 0/8 done361server # 362server # Virtualisation disk image created.363server # Starting virtiofs daemons...364server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)365server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether366server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)367server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether368server # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...369server # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...370server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] Failed to open file handle for the root node: Operation not permitted (os error 1)371server # [2026-10-28T10:56:00Z WARN virtiofsd::passthrough] File handles do not appear safe to use, disabling file handles altogether372server # [2026-10-28T10:56:00Z INFO virtiofsd] Waiting for vhost-user socket connection...373server # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests374server # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests375server # [2026-10-28T10:56:00Z INFO virtiofsd] Client connected, servicing requests376host1 # [ 0.728213] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)377host1 # [ 1.585104] Freeing initrd memory: 26964K378server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]379server # [ 0.000000] Linux version 6.18.56 (nixbld@localhost) (gcc (GCC) 16.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT @1791725172380server # [ 0.000000] KASLR enabled381server # [ 0.000000] random: crng init done382server # [ 0.000000] Machine model: linux,dummy-virt383server # [ 0.000000] efi: UEFI not found.384server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT385server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff]386server # [ 0.000000] NODE_DATA(0) allocated [mem 0xbfdec700-0xbfdefe7f]387server # [ 0.000000] Zone ranges:388server # [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff]389server # [ 0.000000] DMA32 empty390server # [ 0.000000] Normal empty391server # [ 0.000000] Device empty392server # [ 0.000000] Movable zone start for each node393server # [ 0.000000] Early memory node ranges394server # [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff]395server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff]396server # [ 0.000000] cma: Reserved 32 MiB at 0x00000000bbc00000397server # [ 0.000000] psci: probing for conduit method from DT.398server # [ 0.000000] psci: PSCIv1.3 detected in firmware.399server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs400server # [ 0.000000] psci: Trusted OS migration not required401server # [ 0.000000] psci: SMC Calling Convention v1.1402server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)403server # [ 0.000000] percpu: Embedded 76 pages/cpu s186904 r8192 d116200 u311296404server # [ 0.000000] Detected PIPT I-cache on CPU0405server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)406server # [ 0.000000] CPU features: detected: GICv3 CPU interface407server # [ 0.000000] CPU features: detected: Spectre-v4408server # [ 0.000000] CPU features: detected: Spectre-BHB409server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38410server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23411server # [ 0.000000] alternatives: applying boot alternatives412server # [ 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/ixz3yb62d5vf47hjf3rgyp4mn591chyg-nixos-system-server-test/init regInfo=/nix/.ro-store/6hrmkcq5d7i61zys5935b3w7b71qdgjl-closure-info/registration console=ttyAMA0,115200n8 console=tty0413server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/.ro-store/6hrmkcq5d7i61zys5935b3w7b71qdgjl-closure-info/registration", will be passed to user space.414server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes415server # [ 0.000000] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)416server # [ 0.000000] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)417server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 2MB418server # [ 0.000000] software IO TLB: area num 1.419server # [ 0.000000] software IO TLB: mapped [mem 0x00000000bb800000-0x00000000bba00000] (2MB)420server # [ 0.000000] Fallback order for Node 0: 0421server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 524288422server # [ 0.000000] Policy zone: DMA423server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off424server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1425server # [ 0.000000] allocated 4194304 bytes of page_ext426server # [ 0.000000] ftrace: allocating 75049 entries in 294 pages427server # [ 0.000000] ftrace: allocated 294 pages with 4 groups428server # [ 0.000000] rcu: Hierarchical RCU implementation.429server # [ 0.000000] rcu: RCU event tracing is enabled.430server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1.431server # [ 0.000000] Trampoline variant of Tasks RCU enabled.432server # [ 0.000000] Rude variant of Tasks RCU enabled.433server # [ 0.000000] Tracing variant of Tasks RCU enabled.434server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.435server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1436server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.437server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.438server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.439server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0440server # [ 0.000000] GICv3: 256 SPIs implemented441server # [ 0.000000] GICv3: 0 Extended SPIs implemented442server # [ 0.000000] Root IRQ handler: gic_handle_irq443server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI444server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0445server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000446server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]447server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ae0000 (indirect, esz 8, psz 64K, shr 1)448server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44af0000 (flat, esz 8, psz 64K, shr 1)449server # [ 0.000000] GICv3: using LPI property table @0x0000000044b00000450server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044b10000451server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.452server # [ 0.000000] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns453server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).454server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns455server # [ 0.000001] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns456server # [ 0.000043] arm-pv: using stolen time PV457server # [ 0.000567] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)458server # [ 0.000819] Console: colour dummy device 80x25459server # [ 0.000829] printk: legacy console [tty0] enabled460server # [ 0.001110] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)461server # [ 0.001124] pid_max: default: 32768 minimum: 301462server # [ 0.001232] LSM: initializing lsm=capability,landlock,yama,bpf,ima463server # [ 0.001493] landlock: Up and running.464server # [ 0.001503] Yama: becoming mindful.465server # [ 0.002130] LSM support for eBPF active466server # [ 0.002404] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)467server # [ 0.002496] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear)468server # [ 0.005537] rcu: Hierarchical SRCU implementation.469server # [ 0.005545] rcu: Max phase no-delay instances is 1000.470server # [ 0.007245] fsl-mc MSI: its@8080000 domain created471server # [ 0.007395] EFI services will not be available.472server # [ 0.007507] smp: Bringing up secondary CPUs ...473server # [ 0.007517] smp: Brought up 1 node, 1 CPU474server # [ 0.007521] SMP: Total of 1 processors activated.475server # [ 0.007524] CPU: All CPU(s) started at EL1476server # [ 0.007554] CPU features: detected: Branch Target Identification477server # [ 0.007561] CPU features: detected: ARMv8.4 Translation Table Level478server # [ 0.007564] CPU features: detected: Instruction cache invalidation not required for I/D coherence479server # [ 0.007568] CPU features: detected: Data cache clean to the PoU not required for I/D coherence480server # [ 0.007574] CPU features: detected: Common not Private translations481server # [ 0.007577] CPU features: detected: CRC32 instructions482server # [ 0.007580] CPU features: detected: Data cache clean to Point of Deep Persistence483server # [ 0.007583] CPU features: detected: Data cache clean to Point of Persistence484server # [ 0.007587] CPU features: detected: Data independent timing control (DIT)485server # [ 0.007590] CPU features: detected: E0PD486server # [ 0.007592] CPU features: detected: Enhanced Counter Virtualization487server # [ 0.007595] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)488server # [ 0.007599] CPU features: detected: Enhanced Virtualization Traps489server # [ 0.007601] CPU features: detected: Fine Grained Traps490server # [ 0.007604] CPU features: detected: Generic authentication (architected QARMA5 algorithm)491server # [ 0.007609] CPU features: detected: RCpc load-acquire (LDAPR)492server # [ 0.007612] CPU features: detected: LSE atomic instructions493server # [ 0.007615] CPU features: detected: Privileged Access Never494server # [ 0.007618] CPU features: detected: PMUv3495server # [ 0.007620] CPU features: detected: RAS Extension Support496server # [ 0.007623] CPU features: detected: RASv1p1 Extension Support497server # [ 0.007625] CPU features: detected: Random Number Generator498server # [ 0.007630] CPU features: detected: Speculation barrier (SB)499server # [ 0.007633] CPU features: detected: Stage-2 Force Write-Back500server # [ 0.007636] CPU features: detected: TLB range maintenance instructions501server # [ 0.007640] CPU features: detected: Speculative Store Bypassing Safe (SSBS)502server # [ 0.007688] alternatives: applying system-wide alternatives503server # [ 0.013467] CPU features: detected: BBM Level 2 without TLB conflict abort504server # [ 0.013762] Memory: 1920392K/2097152K available (24512K kernel code, 7102K rwdata, 26572K rodata, 4736K init, 1184K bss, 133196K reserved, 32768K cma-reserved)505server # [ 0.015131] devtmpfs: initialized506server # [ 0.017916] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)507server # [ 0.017958] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).508server # [ 0.018205] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL509server # [ 0.018211] 0 pages in range for non-PLT usage510server # [ 0.018217] 508192 pages in range for PLT usage511server # [ 0.018348] pinctrl core: initialized pinctrl subsystem512server # [ 0.019478] DMI not present or invalid.513server # [ 0.024618] NET: Registered PF_NETLINK/PF_ROUTE protocol family514server # [ 0.029972] DMA: preallocated 256 KiB GFP_KERNEL pool for atomic allocations515server # [ 0.030176] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations516server # [ 0.030455] DMA: preallocated 256 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations517server # [ 0.030496] audit: initializing netlink subsys (disabled)518server # [ 0.031362] thermal_sys: Registered thermal governor 'fair_share'519server # [ 0.031365] thermal_sys: Registered thermal governor 'bang_bang'520server # [ 0.031369] thermal_sys: Registered thermal governor 'step_wise'521server # [ 0.031372] thermal_sys: Registered thermal governor 'user_space'522server # [ 0.031375] thermal_sys: Registered thermal governor 'power_allocator'523server # [ 0.031427] audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1524server # [ 0.031439] cpuidle: using governor ladder525server # [ 0.031446] cpuidle: using governor menu526server # [ 0.031675] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.527server # [ 0.031711] ASID allocator initialised with 65536 entries528server # [ 0.033190] Serial: AMBA PL011 UART driver529server # [ 0.041255] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1530server # [ 0.041420] printk: console [ttyAMA0] enabled531server # [ 0.185789] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages532server # [ 0.185825] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page533server # [ 0.185831] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages534server # [ 0.185834] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page535server # [ 0.185837] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages536server # [ 0.185839] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page537server # [ 0.185842] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages538server # [ 0.185845] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page539server # [ 0.208345] fbcon: Taking over console540server # [ 0.208377] ACPI: Interpreter disabled.541server # [ 0.237490] iommu: Default domain type: Translated542server # [ 0.237514] iommu: DMA domain TLB invalidation policy: strict mode543server # [ 0.238469] SCSI subsystem initialized544server # [ 0.244633] usbcore: registered new interface driver usbfs545server # [ 0.244674] usbcore: registered new interface driver hub546server # [ 0.244694] usbcore: registered new device driver usb547server # [ 0.245379] pps_core: LinuxPPS API ver. 1 registered548server # [ 0.245384] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>549server # [ 0.245402] PTP clock support registered550server # [ 0.253221] EDAC MC: Ver: 3.0.0551server # [ 0.257978] scmi_core: SCMI protocol bus registered552server # [ 0.267552] FPGA manager framework553host1 # [ 1.587020] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)554host1 # [ 1.589435] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)555host1 # [ 1.920250] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)556server # [ 0.269409] vgaarb: loaded557server # [ 0.270026] clocksource: Switched to clocksource arch_sys_counter558server # [ 0.271492] VFS: Disk quotas dquot_6.6.0559server # [ 0.271536] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)560server # [ 0.279328] netfs: FS-Cache loaded561server # [ 0.279505] pnp: PnP ACPI: disabled562server # [ 0.285093] NET: Registered PF_INET protocol family563server # [ 0.285409] IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear)564host1 # [ 1.924010] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)565host1 # [ 1.926029] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)566host1 # [ 1.940802] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)567host1 # [ 1.943614] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)568host1 # [ 1.945972] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)569host1 # [ 1.950448] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)570host1 # [ 1.957711] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)571host1 # [ 1.964331] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled572server # [ 0.317392] tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear)573server # [ 0.317428] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)574server # [ 0.317451] TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear)575host1 # [ 1.967421] msm_serial: driver initialized576host1 # [ 1.967588] SuperH (H)SCI(F) driver initialized577server # [ 0.317520] TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear)578host1 # [ 1.967659] STM32 USART driver initialized579server # [ 0.317660] TCP: Hash tables configured (established 16384 bind 16384)580server # [ 0.317756] MPTCP token hash table entries: 2048 (order: 4, 49152 bytes, linear)581server # [ 0.317792] UDP hash table entries: 1024 (order: 4, 65536 bytes, linear)582server # [ 0.317827] UDP-Lite hash table entries: 1024 (order: 4, 65536 bytes, linear)583server # [ 0.317944] NET: Registered PF_UNIX/PF_LOCAL protocol family584server # [ 0.317973] NET: Registered PF_XDP protocol family585server # [ 0.317992] PCI: CLS 0 bytes, default 64586server # [ 0.328007] Trying to unpack rootfs image as initramfs...587host1 # [ 1.985553] loop: module loaded588host1 # [ 1.985728] virtio_blk virtio2: 1/0/0 default/read/poll queues589host1 # [ 1.987722] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)590server # [ 0.331105] kvm [1]: HYP mode not available591host1 # [ 1.991482] megasas: 07.734.00.00-rc1592host1 # [ 1.992246] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]593host1 # [ 1.999573] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000594host1 # [ 1.999602] Intel/Sharp Extended Query Table at 0x0031595host1 # [ 2.004627] Using buffer write method596host1 # [ 2.004668] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]597host1 # [ 2.007818] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000598host1 # [ 2.007848] Intel/Sharp Extended Query Table at 0x0031599host1 # [ 2.016772] Using buffer write method600host1 # [ 2.016788] Concatenating MTD devices:601host1 # [ 2.016791] (0): "0.flash"602host1 # [ 2.016793] (1): "0.flash"603host1 # [ 2.016795] into device "0.flash"604host1 # [ 2.025976] tun: Universal TUN/TAP device driver, 1.6605host1 # [ 2.030335] thunder_xcv, ver 1.0606host1 # [ 2.030373] thunder_bgx, ver 1.0607host1 # [ 2.030394] nicpf, ver 1.0608host1 # [ 2.031058] e1000: Intel(R) PRO/1000 Network Driver609host1 # [ 2.031064] e1000: Copyright (c) 1999-2006 Intel Corporation.610host1 # [ 2.031101] e1000e: Intel(R) PRO/1000 Network Driver611host1 # [ 2.031107] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.612host1 # [ 2.031145] igb: Intel(R) Gigabit Ethernet Network Driver613host1 # [ 2.031152] igb: Copyright (c) 2007-2014 Intel Corporation.614host1 # [ 2.031180] igbvf: Intel(R) Gigabit Virtual Function Network Driver615host1 # [ 2.031187] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.616host1 # [ 2.031343] sky2: driver version 1.30617host1 # [ 2.033190] usbcore: registered new interface driver usb-storage618host1 # [ 2.033307] usbcore: registered new interface driver usbserial_generic619host1 # [ 2.033326] usbserial: USB Serial support registered for generic620host1 # [ 2.034028] hv_vmbus: registering driver hyperv_keyboard621host1 # [ 2.034946] ehci-pci 0000:00:07.0: EHCI Host Controller622host1 # [ 2.034975] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1623host1 # [ 2.035231] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000624host1 # [ 2.048364] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00625host1 # [ 2.048856] hub 1-0:1.0: USB hub found626host1 # [ 2.048878] hub 1-0:1.0: 6 ports detected627host1 # [ 2.052020] rtc-pl031 9010000.pl031: registered as rtc0628host1 # [ 2.052049] rtc-pl031 9010000.pl031: setting system clock to 2026-10-28T10:56:06 UTC (1793184966)629host1 # [ 2.052466] i2c_dev: i2c /dev entries driver630host1 # [ 2.058462] sdhci: Secure Digital Host Controller Interface driver631host1 # [ 2.058468] sdhci: Copyright(c) Pierre Ossman632host1 # [ 2.058783] Synopsys Designware Multimedia Card Interface Driver633host1 # [ 2.059227] sdhci-pltfm: SDHCI platform and OF driver helper634host1 # [ 2.061087] hid: raw HID events driver (C) Jiri Kosina635host1 # [ 2.061369] usbcore: registered new interface driver usbhid636host1 # [ 2.061373] usbhid: USB HID core driver637host1 # [ 2.067436] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available638host1 # [ 2.069348] drop_monitor: Initializing network drop monitor service639host1 # [ 2.069600] NET: Registered PF_INET6 protocol family640host1 # [ 2.073112] Segment Routing with IPv6641host1 # [ 2.073125] In-situ OAM (IOAM) with IPv6642host1 # [ 2.073171] NET: Registered PF_PACKET protocol family643host1 # [ 2.073253] 9pnet: Installing 9P2000 support644host1 # [ 2.073306] Key type dns_resolver registered645server # [ 0.426411] Initialise system trusted keyrings646server # [ 0.426594] workingset: timestamp_bits=42 max_order=19 bucket_order=0647server # [ 0.427079] squashfs: version 4.0 (2009/01/31) Phillip Lougher648server # [ 0.427160] 9p: Installing v9fs 9p2000 file system support649host1 # [ 2.082304] registered taskstats version 1650host1 # [ 2.082539] Loading compiled-in X.509 certificates651host1 # [ 2.092310] Demotion targets for Node 0: null652host1 # [ 2.092539] Key type .fscrypt registered653host1 # [ 2.092543] Key type fscrypt-provisioning registered654host1 # [ 2.092675] ima: No TPM chip found, activating TPM-bypass!655host1 # [ 2.092704] ima: Allocated hash algorithm: sha1656host1 # [ 2.092737] ima: No architecture policies found657host1 # [ 2.093461] input: gpio-keys as /devices/platform/gpio-keys/input/input0658server # [ 0.455399] Key type asymmetric registered659server # [ 0.455422] Asymmetric key parser 'x509' registered660server # [ 0.455495] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)661server # [ 0.455664] io scheduler mq-deadline registered662server # [ 0.455669] io scheduler kyber registered663host1 # [ 2.117801] clk: Disabling unused clocks664host1 # [ 2.117836] PM: genpd: Disabling unused power domains665server # [ 0.472582] pl061_gpio 9030000.pl061: PL061 GPIO chip registered666server # [ 0.473196] ledtrig-cpu: registered to indicate activity on CPUs667server # [ 0.473621] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:668host1 # [ 2.124057] Freeing unused kernel memory: 4736K669server # [ 0.473642] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000670host1 # [ 2.124504] Run /init as init process671server # [ 0.473656] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000672server # [ 0.473663] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000673server # [ 0.473704] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits674server # [ 0.473735] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]675server # [ 0.473825] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00676server # [ 0.473835] pci_bus 0000:00: root bus resource [bus 00-ff]677server # [ 0.473840] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]678server # [ 0.473843] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]679server # [ 0.473846] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]680server # [ 0.473911] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint681server # [ 0.487727] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint682server # [ 0.487917] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]683server # [ 0.487930] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]684server # [ 0.487956] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]685server # [ 0.487968] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]686server # [ 0.488453] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint687server # [ 0.488641] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]688server # [ 0.488653] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]689server # [ 0.488679] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]690host1 # [ 2.145021] systemd[1]: Successfully made /usr/ read-only.691server # [ 0.489165] pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint692server # [ 0.489351] pci 0000:00:03.0: BAR 0 [io 0x0000-0x007f]693server # [ 0.489363] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]694server # [ 0.489389] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]695server # [ 0.489874] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint696server # [ 0.510121] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]697server # [ 0.510141] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]698server # [ 0.510168] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]699server # [ 0.510180] pci 0000:00:04.0: ROM [mem 0x00000000-0x0003ffff pref]700server # [ 0.510715] pci 0000:00:05.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint701server # [ 0.510912] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]702server # [ 0.510938] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]703server # [ 0.511479] pci 0000:00:06.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint704server # [ 0.511674] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]705server # [ 0.511700] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]706server # [ 0.512107] pci 0000:00:07.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint707server # [ 0.512291] pci 0000:00:07.0: BAR 0 [mem 0x00000000-0x00000fff]708server # [ 0.512550] pci 0000:00:08.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint709server # [ 0.512741] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]710server # [ 0.512767] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]711server # [ 0.513250] pci 0000:00:09.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint712server # [ 0.513440] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]713server # [ 0.513466] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]714server # [ 0.513937] pci 0000:00:0a.0: [1af4:105a] type 00 class 0x018000 conventional PCI endpoint715server # [ 0.531051] pci 0000:00:0a.0: BAR 1 [mem 0x00000000-0x00000fff]716server # [ 0.531082] pci 0000:00:0a.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]717server # [ 0.531590] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint718server # [ 0.531897] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]719server # [ 0.531909] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]720server # [ 0.531935] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]721server # [ 0.532426] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint722server # [ 0.532625] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]723server # [ 0.532636] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]724server # [ 0.532664] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]725server # [ 0.533159] pci 0000:00:0d.0: [1af4:1053] type 00 class 0x078000 conventional PCI endpoint726server # [ 0.533365] pci 0000:00:0d.0: BAR 1 [mem 0x00000000-0x00000fff]727server # [ 0.533391] pci 0000:00:0d.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]728server # [ 0.534018] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned729server # [ 0.534024] pci 0000:00:04.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned730server # [ 0.554090] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned731server # [ 0.554169] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned732server # [ 0.554216] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned733server # [ 0.554263] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned734server # [ 0.554309] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned735server # [ 0.554358] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned736server # [ 0.554403] pci 0000:00:08.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned737server # [ 0.554449] pci 0000:00:09.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned738server # [ 0.554497] pci 0000:00:0a.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned739server # [ 0.554543] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned740server # [ 0.554636] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned741server # [ 0.554682] pci 0000:00:0d.0: BAR 4 [mem 0x800002c000-0x800002ffff 64bit pref]: assigned742server # [ 0.554727] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned743server # [ 0.554746] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned744server # [ 0.554763] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned745server # [ 0.554781] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned746server # [ 0.554799] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned747server # [ 0.554817] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned748server # [ 0.554835] pci 0000:00:07.0: BAR 0 [mem 0x10086000-0x10086fff]: assigned749server # [ 0.554855] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned750server # [ 0.554873] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned751server # [ 0.554891] pci 0000:00:0a.0: BAR 1 [mem 0x10089000-0x10089fff]: assigned752server # [ 0.554910] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned753server # [ 0.554928] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned754server # [ 0.554947] pci 0000:00:0d.0: BAR 1 [mem 0x1008c000-0x1008cfff]: assigned755server # [ 0.554965] pci 0000:00:03.0: BAR 0 [io 0x1000-0x107f]: assigned756server # [ 0.555056] pci 0000:00:0b.0: BAR 0 [io 0x1080-0x10bf]: assigned757server # [ 0.555074] pci 0000:00:01.0: BAR 0 [io 0x10c0-0x10df]: assigned758server # [ 0.555092] pci 0000:00:02.0: BAR 0 [io 0x10e0-0x10ff]: assigned759server # [ 0.555110] pci 0000:00:04.0: BAR 0 [io 0x1100-0x111f]: assigned760server # [ 0.555128] pci 0000:00:0c.0: BAR 0 [io 0x1120-0x113f]: assigned761server # [ 0.555154] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]762server # [ 0.555159] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]763server # [ 0.555162] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]764server # [ 0.556036] pci 0000:00:07.0: enabling device (0000 -> 0002)765server # [ 0.610697] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)766host1 # [ 2.294261] usb 1-1: new high-speed USB device number 2 using ehci-pci767host1 # [ 2.443998] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1768host1 # [ 2.479105] systemd[1]: systemd 261.3 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)769host1 # [ 2.479132] systemd[1]: Detected virtualization qemu.770host1 # [ 2.479182] systemd[1]: Detected architecture arm64.771host1 # [ 2.479191] systemd[1]: Running in initrd.772host1 # [ 2.479792] systemd[1]: Initializing machine ID from random generator.773host1 # [ 2.479988] systemd[1]: Hostname set to <host1>.774host1 # [ 2.542490] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0775host1 # [ 2.632947] systemd[1]: bpf-restrict-fs: LSM BPF program attached776host1 # [ 2.662275] usb 1-2: new high-speed USB device number 3 using ehci-pci777host1 # [ 2.700250] systemd[1]: Queued start job for default target Initrd Default Target.778host1 # [ 2.708854] systemd[1]: Created slice Slice /system/modprobe.779host1 # [ 2.709070] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.780host1 # [ 2.709116] systemd[1]: Expecting device /dev/disk/by-label/nixos...781host1 # [ 2.709143] systemd[1]: Reached target Path Units.782host1 # [ 2.709157] systemd[1]: Reached target Slice Units.783host1 # [ 2.709172] systemd[1]: Reached target Swaps.784host1 # [ 2.709186] systemd[1]: Reached target Timer Units.785host1 # [ 2.709370] systemd[1]: Listening on D-Bus System Message Bus Socket.786host1 # [ 2.709587] systemd[1]: Listening on Journal Socket (/dev/log).787host1 # [ 2.709741] systemd[1]: Listening on Journal Sockets.788host1 # [ 2.709863] systemd[1]: Listening on udev Control Socket.789host1 # [ 2.709929] systemd[1]: Listening on udev Kernel Socket.790host1 # [ 2.709943] systemd[1]: Reached target Socket Units.791host1 # [ 2.720959] systemd[1]: Starting Create List of Static Device Nodes...792host1 # [ 2.721028] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs793host1 # [ 2.730355] systemd[1]: Mounting Kernel Configuration File System...794host1 # [ 2.738373] systemd[1]: Starting Journal Service...795host1 # [ 2.743024] systemd[1]: Starting Load Kernel Modules...796host1 # [ 2.743125] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os797host1 # [ 2.774970] systemd[1]: Starting Coldplug All udev Devices...798host1 # [ 2.778420] systemd[1]: Finished Create List of Static Device Nodes.799host1 # [ 2.814047] systemd-journald[70]: Collecting audit messages is disabled.800host1 # [ 2.816678] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...801host1 # [ 2.830286] systemd[1]: Mounted Kernel Configuration File System.802host1 # [ 2.838720] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2803host1 # [ 2.838896] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0804host1 # [ 2.855488] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.805host1 # [ 2.874318] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev806host1 # [ 2.887088] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.807host1 # [ 2.896744] systemd[1]: Starting Create Static Device Nodes in /dev...808host1 # [ 2.900975] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0809host1 # [ 2.901216] [drm] features: -virgl +edid -resource_blob -host_visible810host1 # [ 2.901219] [drm] features: -context_init811host1 # [ 2.901950] [drm] number of scanouts: 1812host1 # [ 2.901961] [drm] number of cap sets: 0813host1 # [ 2.914889] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic814host1 # [ 2.914900] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0815host1 # [ 2.947533] Console: switching to colour frame buffer device 160x50816host1 # [ 2.966885] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device817host1 # [ 2.998404] NET: Registered PF_VSOCK protocol family818host1 # [ 3.017059] systemd[1]: Finished Create Static Device Nodes in /dev.819host1 # [ 3.017341] systemd[1]: Reached target Preparation for Local File Systems.820host1 # [ 3.017373] systemd[1]: Reached target Local File Systems.821host1 # [ 3.031998] systemd[1]: Starting Rule-based Manager for Device Events and Files...822host1 # [ 3.062630] systemd[1]: Finished Load Kernel Modules.823host1 # [ 3.064470] systemd[1]: Starting Apply Kernel Variables...824host1 # [ 3.089280] systemd[1]: Started Journal Service.825host1 # [ 3.076378] systemd-modules-load[71]: Inserted module 'dm_mod'826host1 # [ 3.077739] systemd-modules-load[71]: Module 'virtio_balloon' is built in827host1 # [ 3.078883] systemd-modules-load[71]: Module 'virtio_console' is built in828host1 # [ 3.079974] systemd-modules-load[71]: Inserted module 'virtio_gpu'829host1 # [ 3.093068] systemd-modules-load[71]: Module 'virtio_rng' is built in830host1 # [ 3.095107] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'831host1 # [ 3.108531] systemd[1]: Starting Create System Files and Directories...832host1 # [ 3.120309] systemd[1]: Finished Apply Kernel Variables.833host1 # [ 3.121491] systemd-udevd[77]: Using default interface naming scheme 'v261'.834host1 # [ 3.133132] systemd[1]: Finished Create System Files and Directories.835host1 # [ 3.164146] systemd[1]: Started Rule-based Manager for Device Events and Files.836host1 # [ 3.232916] systemd[1]: Starting Virtual Console Setup...837server # [ 0.631649] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)838server # [ 1.678959] Freeing initrd memory: 26996K839server # [ 1.681525] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)840host1 # [ 3.301926] systemd-vconsole-setup[105]: Configuration of first virtual console was skipped, ignoring remaining ones.841host1 # [ 3.312506] systemd[1]: Finished Virtual Console Setup.842server # [ 1.684669] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)843server # [ 2.286600] virtio-pci 0000:00:05.0: enabling device (0000 -> 0002)844server # [ 2.289112] virtio-pci 0000:00:06.0: enabling device (0000 -> 0002)845server # [ 2.292563] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)846server # [ 2.295734] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)847server # [ 2.300905] virtio-pci 0000:00:0a.0: enabling device (0000 -> 0002)848server # [ 2.303607] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)849server # [ 2.305993] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)850server # [ 2.315042] virtio-pci 0000:00:0d.0: enabling device (0000 -> 0002)851server # [ 2.321334] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled852server # [ 2.324171] msm_serial: driver initialized853server # [ 2.324321] SuperH (H)SCI(F) driver initialized854server # [ 2.324388] STM32 USART driver initialized855server # [ 2.342398] loop: module loaded856server # [ 2.342571] virtio_blk virtio2: 1/0/0 default/read/poll queues857server # [ 2.343388] virtio_blk virtio2: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)858server # [ 2.345325] megasas: 07.734.00.00-rc1859server # [ 2.348810] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]860server # [ 2.353927] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000861server # [ 2.353984] Intel/Sharp Extended Query Table at 0x0031862server # [ 2.357815] Using buffer write method863server # [ 2.357856] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]864server # [ 2.364467] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000865server # [ 2.364484] Intel/Sharp Extended Query Table at 0x0031866server # [ 2.367966] Using buffer write method867server # [ 2.367980] Concatenating MTD devices:868server # [ 2.367982] (0): "0.flash"869server # [ 2.367985] (1): "0.flash"870server # [ 2.367987] into device "0.flash"871server # [ 2.376486] tun: Universal TUN/TAP device driver, 1.6872server # [ 2.380376] thunder_xcv, ver 1.0873server # [ 2.380407] thunder_bgx, ver 1.0874server # [ 2.380427] nicpf, ver 1.0875server # [ 2.381063] e1000: Intel(R) PRO/1000 Network Driver876server # [ 2.381068] e1000: Copyright (c) 1999-2006 Intel Corporation.877server # [ 2.381100] e1000e: Intel(R) PRO/1000 Network Driver878server # [ 2.381106] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.879server # [ 2.381142] igb: Intel(R) Gigabit Ethernet Network Driver880server # [ 2.381148] igb: Copyright (c) 2007-2014 Intel Corporation.881server # [ 2.381172] igbvf: Intel(R) Gigabit Virtual Function Network Driver882server # [ 2.381180] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.883server # [ 2.381325] sky2: driver version 1.30884server # [ 2.391404] usbcore: registered new interface driver usb-storage885server # [ 2.391553] usbcore: registered new interface driver usbserial_generic886server # [ 2.391576] usbserial: USB Serial support registered for generic887server # [ 2.392234] hv_vmbus: registering driver hyperv_keyboard888server # [ 2.393534] ehci-pci 0000:00:07.0: EHCI Host Controller889server # [ 2.393557] ehci-pci 0000:00:07.0: new USB bus registered, assigned bus number 1890server # [ 2.393754] ehci-pci 0000:00:07.0: irq 16, io mem 0x10086000891server # [ 2.399478] rtc-pl031 9010000.pl031: registered as rtc0892server # [ 2.399504] rtc-pl031 9010000.pl031: setting system clock to 2026-10-28T10:56:08 UTC (1793184968)893server # [ 2.399868] i2c_dev: i2c /dev entries driver894server # [ 2.402081] ehci-pci 0000:00:07.0: USB 2.0 started, EHCI 1.00895server # [ 2.402859] hub 1-0:1.0: USB hub found896server # [ 2.402920] hub 1-0:1.0: 6 ports detected897server # [ 2.409282] sdhci: Secure Digital Host Controller Interface driver898server # [ 2.409287] sdhci: Copyright(c) Pierre Ossman899server # [ 2.409598] Synopsys Designware Multimedia Card Interface Driver900server # [ 2.410020] sdhci-pltfm: SDHCI platform and OF driver helper901server # [ 2.414863] hid: raw HID events driver (C) Jiri Kosina902server # [ 2.415138] usbcore: registered new interface driver usbhid903server # [ 2.415142] usbhid: USB HID core driver904server # [ 2.416439] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available905server # [ 2.421134] drop_monitor: Initializing network drop monitor service906server # [ 2.422952] NET: Registered PF_INET6 protocol family907server # [ 2.423583] Segment Routing with IPv6908server # [ 2.423598] In-situ OAM (IOAM) with IPv6909server # [ 2.423644] NET: Registered PF_PACKET protocol family910server # [ 2.423713] 9pnet: Installing 9P2000 support911server # [ 2.423757] Key type dns_resolver registered912server # [ 2.434844] registered taskstats version 1913server # [ 2.435092] Loading compiled-in X.509 certificates914server # [ 2.446177] Demotion targets for Node 0: null915server # [ 2.446290] Key type .fscrypt registered916server # [ 2.446294] Key type fscrypt-provisioning registered917server # [ 2.446425] ima: No TPM chip found, activating TPM-bypass!918server # [ 2.446446] ima: Allocated hash algorithm: sha1919server # [ 2.446480] ima: No architecture policies found920server # [ 2.447133] input: gpio-keys as /devices/platform/gpio-keys/input/input0921server # [ 2.469055] clk: Disabling unused clocks922server # [ 2.469076] PM: genpd: Disabling unused power domains923host1 # [ 4.089310] systemd[1]: Finished Coldplug All udev Devices.924host1 # [ 4.090378] systemd[1]: Reached target System Initialization.925host1 # [ 4.091452] systemd[1]: Reached target Basic System.926server # [ 2.475201] Freeing unused kernel memory: 4736K927server # [ 2.475505] Run /init as init process928server # [ 2.493027] systemd[1]: Successfully made /usr/ read-only.929server # [ 2.650091] usb 1-1: new high-speed USB device number 2 using ehci-pci930host1 # [ 4.278495] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.931host1 # [ 4.305144] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.932host1 # [ 4.312188] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.933server # [ 2.801864] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1934host1 # [ 4.436607] systemd[1]: Found device /dev/disk/by-label/nixos.935host1 # [ 4.439976] systemd[1]: Reached target Initrd Root Device.936host1 # [ 4.441907] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...937server # [ 2.827221] systemd[1]: systemd 261.3 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)938server # [ 2.827246] systemd[1]: Detected virtualization qemu.939server # [ 2.827296] systemd[1]: Detected architecture arm64.940server # [ 2.827305] systemd[1]: Running in initrd.941server # [ 2.827865] systemd[1]: Initializing machine ID from random generator.942server # [ 2.828034] systemd[1]: Hostname set to <server>.943host1 # [ 4.495232] systemd-fsck[114]: nixos: clean, 12/65536 files, 13019/262144 blocks944host1 # [ 4.500604] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.945host1 # [ 4.504886] systemd[1]: Mounting /sysroot...946server # [ 2.894266] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:07.0-1/input0947host1 # [ 4.574511] EXT4-fs (vda): mounted filesystem 32656be3-988c-4f06-8510-6b57f7a9750f r/w with ordered data mode. Quota mode: none.948host1 # [ 4.548104] systemd[1]: Mounted /sysroot.949host1 # [ 4.549616] systemd[1]: Reached target Initrd Root File System.950host1 # [ 4.553572] systemd[1]: Starting Mountpoints Configured in the Real Root...951host1 # [ 4.589295] systemd-sysroot-fstab-check[122]: /sysroot should be mounted in the initrd, will request daemon-reload.952server # [ 2.974612] systemd[1]: bpf-restrict-fs: LSM BPF program attached953host1 # [ 4.596462] systemd[1]: Reload requested from client PID 122 ('systemd-sysroot') (unit initrd-parse-etc.service)...954host1 # [ 4.601178] systemd[1]: Reloading...955server # [ 3.014137] usb 1-2: new high-speed USB device number 3 using ehci-pci956server # [ 3.038189] systemd[1]: Queued start job for default target Initrd Default Target.957server # [ 3.048227] systemd[1]: Created slice Slice /system/modprobe.958server # [ 3.048410] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.959server # [ 3.048438] systemd[1]: Expecting device /dev/disk/by-label/nixos...960server # [ 3.048459] systemd[1]: Reached target Path Units.961server # [ 3.048473] systemd[1]: Reached target Slice Units.962server # [ 3.048485] systemd[1]: Reached target Swaps.963server # [ 3.048497] systemd[1]: Reached target Timer Units.964server # [ 3.048633] systemd[1]: Listening on D-Bus System Message Bus Socket.965server # [ 3.048791] systemd[1]: Listening on Journal Socket (/dev/log).966server # [ 3.048910] systemd[1]: Listening on Journal Sockets.967server # [ 3.049018] systemd[1]: Listening on udev Control Socket.968server # [ 3.049957] systemd[1]: Listening on udev Kernel Socket.969server # [ 3.049974] systemd[1]: Reached target Socket Units.970server # [ 3.060964] systemd[1]: Starting Create List of Static Device Nodes...971server # [ 3.061293] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs972server # [ 3.066703] systemd[1]: Mounting Kernel Configuration File System...973server # [ 3.078426] systemd[1]: Starting Journal Service...974server # [ 3.098205] systemd[1]: Starting Load Kernel Modules...975server # [ 3.098321] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os976server # [ 3.118507] systemd[1]: Starting Coldplug All udev Devices...977server # [ 3.132451] systemd-journald[70]: Collecting audit messages is disabled.978server # [ 3.158154] systemd[1]: Finished Create List of Static Device Nodes.979server # [ 3.159121] systemd[1]: Mounted Kernel Configuration File System.980server # [ 3.165584] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...981server # [ 3.189433] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:07.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2982server # [ 3.189583] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:07.0-2/input0983server # [ 3.210798] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.984server # [ 3.223053] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.985server # [ 3.224659] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev986server # [ 3.230525] systemd[1]: Starting Create Static Device Nodes in /dev...987host1 # [ 4.854386] systemd[1]: Reloading finished in 258 ms.988server # [ 3.245103] [drm] pci: virtio-gpu-pci detected at 0000:00:05.0989server # [ 3.245996] [drm] features: -virgl +edid -resource_blob -host_visible990server # [ 3.245999] [drm] features: -context_init991server # [ 3.258702] [drm] number of scanouts: 1992server # [ 3.258716] [drm] number of cap sets: 0993server # [ 3.259641] virtio-pci 0000:00:05.0: [drm] Registered 1 planes with drm panic994server # [ 3.259648] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:05.0 on minor 0995host1 # [ 4.891456] systemd-sysroot-fstab-check[122]: Requesting initrd-fs.target/start/replace...996host1 # [ 4.896061] systemd-sysroot-fstab-check[122]: Requesting swap.target/start/replace...997host1 # [ 4.907866] systemd[1]: Mounting /sysroot/nix/.ro-store...998host1 # [ 4.920719] systemd[1]: Mounting /sysroot/nix/.rw-store...999server # [ 3.302425] Console: switching to colour frame buffer device 160x501000host1 # [ 4.930775] systemd[1]: Mounting /sysroot/run...1001server # [ 3.323010] systemd[1]: Finished Create Static Device Nodes in /dev.1002server # [ 3.323702] systemd[1]: Reached target Preparation for Local File Systems.1003server # [ 3.323731] systemd[1]: Reached target Local File Systems.1004server # [ 3.330882] virtio-pci 0000:00:05.0: [drm] fb0: virtio_gpudrmfb frame buffer device1005server # [ 3.332154] systemd[1]: Starting Rule-based Manager for Device Events and Files...1006host1 # [ 4.959567] systemd[1]: Mounting /sysroot/tmp/shared...1007server # [ 3.358764] NET: Registered PF_VSOCK protocol family1008server # [ 3.340699] systemd-modules-load[71]: Inserted module 'dm_mod'1009server # [ 3.380033] systemd[1]: Started Journal Service.1010host1 # [ 4.999541] systemd[1]: Mounting /sysroot/tmp/xchg...1011host1 # [ 5.000656] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1012server # [ 3.352376] systemd-modules-load[71]: Module 'virtio_balloon' is built in1013server # [ 3.353742] systemd-modules-load[71]: Module 'virtio_console' is built in1014server # [ 3.354903] systemd-modules-load[71]: Inserted module 'virtio_gpu'1015server # [ 3.355907] systemd-modules-load[71]: Module 'virtio_rng' is built in1016host1 # [ 5.019609] systemd[1]: Finished Mountpoints Configured in the Real Root.1017host1 # [ 5.020856] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1018server # [ 3.368393] systemd[1]: Starting Create System Files and Directories...1019server # [ 3.370525] systemd-modules-load[71]: Inserted module 'vmw_vsock_virtio_transport'1020host1 # [ 5.066444] fuse: init (API version 7.45)1021server # [ 3.383413] systemd[1]: Finished Load Kernel Modules.1022host1 # [ 5.078549] virtiofs virtio6: discovered new tag: nix-store1023host1 # [ 5.079484] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1024server # [ 3.400442] systemd[1]: Starting Apply Kernel Variables...1025host1 # [ 5.096424] virtiofs virtio7: discovered new tag: shared1026host1 # [ 5.097259] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1027host1 # [ 5.105773] virtiofs virtio8: discovered new tag: xchg1028host1 # [ 5.073797] systemd[1]: Mounted /sysroot/nix/.rw-store.1029host1 # [ 5.115668] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1030server # [ 3.434042] systemd-udevd[77]: Using default interface naming scheme 'v261'.1031host1 # [ 5.088873] systemd[1]: Mounted /sysroot/run.1032server # [ 3.438360] systemd[1]: Finished Create System Files and Directories.1033server # [ 3.458218] systemd[1]: Finished Apply Kernel Variables.1034host1 # [ 5.114145] systemd[1]: Starting rw-sysroot-nix-store.service...1035host1 # [ 5.117206] systemd[1]: Mounted /sysroot/nix/.ro-store.1036host1 # [ 5.119379] systemd[1]: Mounted /sysroot/tmp/shared.1037host1 # [ 5.121928] systemd[1]: Mounted /sysroot/tmp/xchg.1038server # [ 3.478452] systemd[1]: Started Rule-based Manager for Device Events and Files.1039host1 # [ 5.152594] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1040host1 # [ 5.155519] systemd[1]: Finished rw-sysroot-nix-store.service.1041host1 # [ 5.160374] systemd[1]: Mounting /sysroot/nix/store...1042server # [ 3.553417] systemd[1]: Starting Virtual Console Setup...1043host1 # [ 5.215024] systemd[1]: Mounted /sysroot/nix/store.1044host1 # [ 5.217142] systemd[1]: Reached target Initrd File Systems.1045host1 # [ 5.219928] systemd[1]: Starting Find NixOS closure...1046host1 # [ 5.230267] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1047host1 # [ 5.268333] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1048host1 # [ 5.283732] systemd[1]: Finished Find NixOS closure.1049host1 # [ 5.286759] systemd[1]: Reached target Initrd Default Target.1050host1 # [ 5.294896] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1051server # [ 3.646450] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.1052server # [ 3.648504] systemd[1]: Finished Virtual Console Setup.1053host1 # [ 5.328089] systemd[1]: Stopped target Initrd Default Target.1054host1 # [ 5.331717] systemd[1]: Stopped target Basic System.1055host1 # [ 5.336232] systemd[1]: Stopped target Initrd Root Device.1056host1 # [ 5.337072] systemd[1]: Stopped target Path Units.1057host1 # [ 5.337768] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1058host1 # [ 5.338942] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1059host1 # [ 5.345417] systemd[1]: Stopped target Slice Units.1060host1 # [ 5.348793] systemd[1]: Stopped target Socket Units.1061host1 # [ 5.350951] systemd[1]: Stopped target System Initialization.1062host1 # [ 5.356773] systemd[1]: Stopped target Swaps.1063host1 # [ 5.358575] systemd[1]: Stopped target Timer Units.1064host1 # [ 5.359359] systemd[1]: dbus.socket: Deactivated successfully.1065host1 # [ 5.361423] systemd[1]: Closed D-Bus System Message Bus Socket.1066host1 # [ 5.364333] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1067host1 # [ 5.368262] systemd[1]: Stopped Find NixOS closure.1068host1 # [ 5.371306] systemd[1]: Starting rw-sysroot-nix-store.service...1069host1 # [ 5.376311] systemd[1]: systemd-sysctl.service: Deactivated successfully.1070host1 # [ 5.377953] systemd[1]: Stopped Apply Kernel Variables.1071host1 # [ 5.380601] systemd[1]: systemd-modules-load.service: Deactivated successfully.1072host1 # [ 5.383001] systemd[1]: Stopped Load Kernel Modules.1073host1 # [ 5.391305] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1074host1 # [ 5.393451] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1075host1 # [ 5.399831] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1076host1 # [ 5.404379] systemd[1]: Stopped Create System Files and Directories.1077host1 # [ 5.406648] systemd[1]: Stopped target Local File Systems.1078host1 # [ 5.408495] systemd[1]: Stopped target Preparation for Local File Systems.1079host1 # [ 5.410525] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1080host1 # [ 5.416403] systemd[1]: Stopped Coldplug All udev Devices.1081host1 # [ 5.417282] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1082host1 # [ 5.418427] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1083host1 # [ 5.419477] systemd[1]: Stopped Virtual Console Setup.1084host1 # [ 5.424269] systemd[1]: initrd-cleanup.service: Deactivated successfully.1085host1 # [ 5.425257] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1086host1 # [ 5.426275] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1087host1 # [ 5.427317] systemd[1]: Finished rw-sysroot-nix-store.service.1088host1 # [ 5.445231] systemd[1]: systemd-udevd.service: Deactivated successfully.1089host1 # [ 5.446651] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1090host1 # [ 5.452525] systemd[1]: systemd-udevd.service: Consumed 1.056s CPU time over 2.445s wall clock time, 19.5M memory peak.1091host1 # [ 5.454081] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1092host1 # [ 5.455152] systemd[1]: Closed udev Control Socket.1093host1 # [ 5.455897] systemd[1]: Starting Cleanup udev Database...1094host1 # [ 5.457450] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1095host1 # [ 5.458674] systemd[1]: Stopped Create Static Device Nodes in /dev.1096host1 # [ 5.459601] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1097host1 # [ 5.464234] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1098host1 # [ 5.465344] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1099host1 # [ 5.467723] systemd[1]: Stopped Create List of Static Device Nodes.1100host1 # [ 5.493736] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1101host1 # [ 5.494920] systemd[1]: Finished Cleanup udev Database.1102host1 # [ 5.500137] systemd[1]: Reached target Switch Root.1103host1 # [ 5.501059] systemd[1]: Starting NixOS Activation...1104host1 # [ 5.579658] initrd-nixos-activation-start[171]: booting system configuration /nix/store/wm093l7n9mqnj6q4ih5jg6abc8zkl2xj-nixos-system-host1-test1105host1 # [ 5.613797] initrd-nixos-activation-start[171]: running activation script...1106host1 # [ 5.919946] initrd-nixos-activation-start[194]: setting up /etc...1107server # [ 4.438597] systemd[1]: Finished Coldplug All udev Devices.1108server # [ 4.440333] systemd[1]: Reached target System Initialization.1109server # [ 4.444653] systemd[1]: Reached target Basic System.1110host1 # [ 6.101602] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1111host1 # [ 6.104204] systemd[1]: Finished NixOS Activation.1112host1 # [ 6.106040] systemd[1]: Starting Switch Root...1113host1 # [ 6.125077] systemd[1]: Switching root.1114host1 # [ 6.328806] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).1115server # [ 4.682451] (udev-worker)[95]: Network interface NamePolicy= disabled on kernel command line.1116server # [ 4.692687] (udev-worker)[99]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1117server # [ 4.695536] (udev-worker)[99]: Network interface NamePolicy= disabled on kernel command line.1118server # [ 4.832323] systemd[1]: Found device /dev/disk/by-label/nixos.1119server # [ 4.835605] systemd[1]: Reached target Initrd Root Device.1120server # [ 4.844102] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...1121server # [ 4.892425] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks1122server # [ 4.898860] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.1123server # [ 4.903900] systemd[1]: Mounting /sysroot...1124server # [ 4.990457] EXT4-fs (vda): mounted filesystem 86dc2d0d-a22f-4d13-8c51-9b88819f46ae r/w with ordered data mode. Quota mode: none.1125server # [ 4.959559] systemd[1]: Mounted /sysroot.1126server # [ 4.961747] systemd[1]: Reached target Initrd Root File System.1127server # [ 4.966895] systemd[1]: Starting Mountpoints Configured in the Real Root...1128server # [ 4.999244] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.1129server # [ 5.002832] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...1130server # [ 5.009655] systemd[1]: Reloading...1131host1 # [ 6.832716] systemd[1]: systemd 261.3 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)1132host1 # [ 6.832791] systemd[1]: Detected virtualization qemu.1133host1 # [ 6.832842] systemd[1]: Detected architecture arm64.1134host1 # [ 6.832965] systemd[1]: Detected first boot.1135host1 # [ 6.844642] systemd[1]: Initializing machine ID from random generator.1136server # [ 5.227905] systemd[1]: Reloading finished in 218 ms.1137server # [ 5.262947] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1138server # [ 5.268211] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1139server # [ 5.273293] systemd[1]: Mounting /sysroot/nix/.ro-store...1140server # [ 5.291138] systemd[1]: Mounting /sysroot/nix/.rw-store...1141host1 # [ 6.979567] systemd[1]: bpf-restrict-fs: LSM BPF program attached1142server # [ 5.295944] systemd[1]: Mounting /sysroot/run...1143server # [ 5.329868] systemd[1]: Mounting /sysroot/tmp/shared...1144server # [ 5.333620] systemd[1]: Mounting /sysroot/tmp/xchg...1145server # [ 5.349555] systemd[1]: Mounted /sysroot/nix/.rw-store.1146server # [ 5.419161] fuse: init (API version 7.45)1147server # [ 5.389947] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1148server # [ 5.436865] virtiofs virtio6: discovered new tag: nix-store1149server # [ 5.437695] virtiofs virtio6: virtio_fs_setup_dax: No cache capability1150server # [ 5.452299] virtiofs virtio7: discovered new tag: shared1151server # [ 5.453091] virtiofs virtio7: virtio_fs_setup_dax: No cache capability1152server # [ 5.420055] systemd[1]: Finished Mountpoints Configured in the Real Root.1153server # [ 5.422053] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1154server # [ 5.462990] virtiofs virtio8: discovered new tag: xchg1155server # [ 5.463769] virtiofs virtio8: virtio_fs_setup_dax: No cache capability1156server # [ 5.438952] systemd[1]: Mounted /sysroot/run.1157server # [ 5.444078] systemd[1]: Mounted /sysroot/tmp/shared.1158host1 # [ 7.130945] systemd[1]: Applying preset policy.1159server # [ 5.453164] systemd[1]: Mounted /sysroot/nix/.ro-store.1160server # [ 5.455181] systemd[1]: Mounted /sysroot/tmp/xchg.1161server # [ 5.466029] systemd[1]: Starting rw-sysroot-nix-store.service...1162server # [ 5.492824] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1163server # [ 5.494279] systemd[1]: Finished rw-sysroot-nix-store.service.1164host1 # [ 7.348623] systemd[1]: Populated /etc with preset unit settings.1165host1 # [ 7.577145] systemd[1]: initrd-switch-root.service: Deactivated successfully.1166host1 # [ 7.577918] systemd[1]: Stopped initrd-switch-root.service.1167host1 # [ 7.583364] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1168host1 # [ 7.584855] systemd[1]: Created slice Slice /system/getty.1169host1 # [ 7.586103] systemd[1]: Created slice User and Session Slice.1170host1 # [ 7.589904] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1171host1 # [ 7.591477] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1172host1 # [ 7.591954] systemd[1]: Expecting device /dev/hvc0...1173host1 # [ 7.592475] systemd[1]: Expecting device /dev/ttyAMA0...1174host1 # [ 7.593011] systemd[1]: Reached target Local Encrypted Volumes.1175host1 # [ 7.593536] systemd[1]: Stopped target initrd-fs.target.1176host1 # [ 7.594051] systemd[1]: Stopped target initrd-root-fs.target.1177host1 # [ 7.599546] systemd[1]: Stopped target initrd-switch-root.target.1178host1 # [ 7.599935] systemd[1]: Reached target Virtual Machines and Containers.1179host1 # [ 7.600627] systemd[1]: Reached target Path Units.1180host1 # [ 7.601122] systemd[1]: Reached target Remote File Systems.1181host1 # [ 7.601578] systemd[1]: Reached target Slice Units.1182host1 # [ 7.602047] systemd[1]: Reached target Swaps.1183host1 # [ 7.608831] systemd[1]: Listening on Query the User Interactively for a Password.1184host1 # [ 7.611900] systemd[1]: Listening on Process Core Dump Socket.1185host1 # [ 7.613348] systemd[1]: Listening on Credential Encryption/Decryption.1186host1 # [ 7.616866] systemd[1]: Listening on Factory Reset Management.1187host1 # [ 7.617366] systemd[1]: Listening on Hostname Service Socket.1188host1 # [ 7.623204] systemd[1]: Starting Journal Log Access Socket...1189host1 # [ 7.624194] systemd[1]: Listening on Journal Audit Socket.1190host1 # [ 7.628170] systemd[1]: Listening on Console Output Muting Service Socket.1191host1 # [ 7.628913] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1192host1 # [ 7.629414] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1193host1 # [ 7.629825] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1194host1 # [ 7.640122] systemd[1]: Listening on Disk Repartitioning Service Socket.1195host1 # [ 7.640714] systemd[1]: Listening on udev Control Socket.1196host1 # [ 7.641225] systemd[1]: Listening on udev Varlink Socket.1197host1 # [ 7.646520] systemd[1]: Mounting Huge Pages File System...1198host1 # [ 7.649562] systemd[1]: Mounting POSIX Message Queue File System...1199host1 # [ 7.666454] systemd[1]: Mounting Kernel Debug File System...1200host1 # [ 7.674820] systemd[1]: Mounting Kernel Trace File System...1201host1 # [ 7.688707] systemd[1]: Starting Create List of Static Device Nodes...1202host1 # [ 7.691748] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1203host1 # [ 7.706298] systemd[1]: Mounting Kernel Configuration File System...1204host1 # [ 7.711166] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1205host1 # [ 7.716081] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1206host1 # [ 7.716552] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1207host1 # [ 7.748693] systemd[1]: Mounting FUSE Control File System...1208host1 # [ 7.749140] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671209host1 # [ 7.784659] systemd[1]: Starting Journal Service...1210host1 # [ 7.800521] systemd[1]: Starting Load Kernel Modules...1211host1 # [ 7.823290] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1212server # [ 6.149308] (udev-worker)[99]: mtd0ro: Failed to find and pin callout binary "/nix/store/8w0qabyr98chcmr4y9hh6h6l26albldx-systemd-261.3/lib/udev/mtd_probe": No such file or directory1213host1 # [ 7.834789] systemd[1]: Starting Remount Root and Kernel File Systems...1214host1 # [ 7.835162] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1215server # [ 6.160705] (udev-worker)[99]: mtd0ro: /etc/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1216host1 # [ 7.858587] systemd[1]: Starting Coldplug All udev Devices...1217host1 # [ 7.861925] systemd[1]: Listening on Journal Log Access Socket.1218server # [ 6.179848] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1219server # [ 6.185757] systemd[1]: Stopped Virtual Console Setup.1220server # [ 6.186561] systemd[1]: Stopping Virtual Console Setup...1221server # [ 6.191985] systemd[1]: Starting Virtual Console Setup...1222host1 # [ 7.878344] systemd-journald[265]: Collecting audit messages is enabled.1223host1 # [ 7.885299] systemd[1]: Mounted Huge Pages File System.1224host1 # [ 7.885789] systemd[1]: Mounted POSIX Message Queue File System.1225host1 # [ 7.886179] systemd[1]: Mounted Kernel Debug File System.1226server # [ 6.207780] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1227server # [ 6.209887] systemd[1]: Stopped Virtual Console Setup.1228host1 # [ 7.862182] systemd[1]: Queued start job for default target Multi-User System.1229host1 # [ 7.896746] systemd[1]: Started Journal Service.1230server # [ 6.214405] systemd[1]: Starting Virtual Console Setup...1231host1 # [ 7.868595] systemd[1]: systemd-journald.service: Deactivated successfully.1232host1 # [ 7.870041] systemd-modules-load[266]: Module 'atkbd' is built in1233host1 # [ 7.871123] systemd-modules-load[266]: Module 'loop' is built in1234host1 # [ 7.875263] systemd[1]: Mounted Kernel Trace File System.1235host1 # [ 7.878403] systemd[1]: Finished Create List of Static Device Nodes.1236host1 # [ 7.879495] systemd[1]: Finished Load Kernel Modules.1237server # [ 6.242061] systemd-vconsole-setup[160]: Configuration of first virtual console was skipped, ignoring remaining ones.1238server # [ 6.245570] systemd[1]: Finished Virtual Console Setup.1239server # [ 6.268246] systemd[1]: Mounting /sysroot/nix/store...1240host1 # [ 7.929670] systemd[1]: Starting Firewall...1241host1 # [ 7.934547] systemd[1]: Starting Apply Kernel Variables...1242host1 # [ 7.942805] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1243server # [ 6.301733] systemd[1]: Mounted /sysroot/nix/store.1244server # [ 6.304127] systemd[1]: Reached target Initrd File Systems.1245server # [ 6.306047] systemd[1]: Starting Find NixOS closure...1246server # [ 6.315282] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1247host1 # [ 7.973684] systemd[1]: Mounted Kernel Configuration File System.1248server # [ 6.340141] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1249server # [ 6.342157] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1250server # [ 6.352214] systemd[1]: Finished Find NixOS closure.1251server # [ 6.354747] systemd[1]: Reached target Initrd Default Target.1252host1 # [ 8.038664] EXT4-fs (vda): re-mounted 32656be3-988c-4f06-8510-6b57f7a9750f.1253server # [ 6.359829] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1254host1 # [ 8.025906] systemd[1]: Finished Remount Root and Kernel File Systems.1255server # [ 6.380731] systemd[1]: Stopped target Initrd Default Target.1256host1 # [ 8.034046] systemd[1]: Listening on Disk Image Download Service Socket.1257server # [ 6.382048] systemd[1]: Stopped target Basic System.1258server # [ 6.384345] systemd[1]: Stopped target Initrd Root Device.1259server # [ 6.385223] systemd[1]: Stopped target Path Units.1260server # [ 6.387868] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1261server # [ 6.389523] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1262server # [ 6.392394] systemd[1]: Stopped target Slice Units.1263server # [ 6.396170] systemd[1]: Stopped target Socket Units.1264server # [ 6.397098] systemd[1]: Stopped target System Initialization.1265server # [ 6.397931] systemd[1]: Stopped target Swaps.1266server # [ 6.398588] systemd[1]: Stopped target Timer Units.1267host1 # [ 8.052175] systemd-oomd[267]: No swap; memory pressure usage will be degraded1268server # [ 6.405729] systemd[1]: dbus.socket: Deactivated successfully.1269server # [ 6.407696] systemd[1]: Closed D-Bus System Message Bus Socket.1270server # [ 6.409378] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1271server # [ 6.412658] systemd[1]: Stopped Find NixOS closure.1272host1 # [ 8.066479] systemd[1]: Starting Flush Journal to Persistent Storage...1273server # [ 6.415072] systemd[1]: Starting rw-sysroot-nix-store.service...1274host1 # [ 8.067525] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1275server # [ 6.419254] systemd[1]: systemd-sysctl.service: Deactivated successfully.1276server # [ 6.420398] systemd[1]: Stopped Apply Kernel Variables.1277host1 # [ 8.077499] systemd[1]: Starting Load/Save OS Random Seed...1278host1 # [ 8.078382] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1279host1 # [ 8.079606] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1280server # [ 6.426493] systemd[1]: systemd-modules-load.service: Deactivated successfully.1281server # [ 6.429120] systemd[1]: Stopped Load Kernel Modules.1282server # [ 6.430160] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1283server # [ 6.435587] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1284server # [ 6.439033] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1285server # [ 6.442801] systemd[1]: Stopped Create System Files and Directories.1286server # [ 6.443726] systemd[1]: Stopped target Local File Systems.1287server # [ 6.445729] systemd[1]: Stopped target Preparation for Local File Systems.1288server # [ 6.448299] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1289server # [ 6.451690] systemd[1]: Stopped Coldplug All udev Devices.1290server # [ 6.452786] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1291server # [ 6.453990] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1292server # [ 6.455032] systemd[1]: Stopped Virtual Console Setup.1293server # [ 6.455777] systemd[1]: initrd-cleanup.service: Deactivated successfully.1294server # [ 6.456921] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1295server # [ 6.457853] systemd[1]: systemd-udevd.service: Deactivated successfully.1296server # [ 6.458785] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1297server # [ 6.459795] systemd[1]: systemd-udevd.service: Consumed 1.662s CPU time over 3.138s wall clock time, 26.1M memory peak.1298server # [ 6.464230] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1299server # [ 6.466522] systemd[1]: Finished rw-sysroot-nix-store.service.1300server # [ 6.468430] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1301server # [ 6.472195] systemd[1]: Closed udev Control Socket.1302server # [ 6.473002] systemd[1]: Starting Cleanup udev Database...1303server # [ 6.476188] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1304server # [ 6.477364] systemd[1]: Stopped Create Static Device Nodes in /dev.1305server # [ 6.478236] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1306host1 # [ 8.131651] systemd[1]: Finished Apply Kernel Variables.1307server # [ 6.484256] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1308server # [ 6.485362] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1309server # [ 6.486337] systemd[1]: Stopped Create List of Static Device Nodes.1310host1 # [ 8.139780] systemd[1]: Mounted FUSE Control File System.1311host1 # [ 8.195515] systemd-journald[265]: Received client request to flush runtime journal.1312server # [ 6.511850] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1313server # [ 6.515482] systemd[1]: Finished Cleanup udev Database.1314server # [ 6.516654] systemd[1]: Reached target Switch Root.1315server # [ 6.520279] systemd[1]: Starting NixOS Activation...1316host1 # [ 8.248652] systemd[1]: Finished Load/Save OS Random Seed.1317host1 # [ 8.249647] systemd[1]: Reached target First Boot Complete.1318server # [ 6.596793] initrd-nixos-activation-start[183]: booting system configuration /nix/store/ixz3yb62d5vf47hjf3rgyp4mn591chyg-nixos-system-server-test1319host1 # [ 8.262611] systemd[1]: Finished Flush Journal to Persistent Storage.1320host1 # [ 8.263647] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1321host1 # [ 8.268778] systemd[1]: Starting Create Static Device Nodes in /dev...1322server # [ 6.628154] initrd-nixos-activation-start[183]: running activation script...1323host1 # [ 8.373924] systemd[1]: Finished Create Static Device Nodes in /dev.1324host1 # [ 8.374998] systemd[1]: Reached target Preparation for Local File Systems.1325host1 # [ 8.381610] systemd[1]: Starting Rule-based Manager for Device Events and Files...1326server # [ 6.860565] initrd-nixos-activation-start[206]: setting up /etc...1327host1 # [ 8.552913] systemd[1]: Mounting /run/wrappers...1328server # [ 6.985000] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1329server # [ 6.987511] systemd[1]: Finished NixOS Activation.1330server # [ 6.988769] systemd[1]: Starting Switch Root...1331host1 # [ 8.656948] systemd[1]: Mounted /run/wrappers.1332host1 # [ 8.657799] systemd[1]: Reached target Local File Systems.1333host1 # [ 8.664231] systemd[1]: Listening on Boot Loader Control Service Socket.1334server # [ 7.011477] systemd[1]: Switching root.1335host1 # [ 8.672072] systemd[1]: Starting register-nix-paths.service...1336host1 # [ 8.678982] systemd[1]: Starting Create SUID/SGID Wrappers...1337host1 # [ 8.679993] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1338host1 # [ 8.693952] systemd[1]: Starting Save Transient machine-id to Disk...1339host1 # [ 8.705311] systemd[1]: Starting Create System Files and Directories...1340server # [ 7.215875] systemd-journald[70]: Received SIGTERM from PID 1 (systemd).1341host1 # [ 8.834590] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1342host1 # [ 8.849454] systemd[1]: Finished Save Transient machine-id to Disk.1343host1 # [ 8.878339] systemd-udevd[307]: Using default interface naming scheme 'v261'.1344host1 # [ 8.977813] systemd[1]: Finished Create System Files and Directories.1345host1 # [ 8.991862] systemd[1]: Starting Rebuild Journal Catalog...1346host1 # [ 9.007572] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1347host1 # [ 9.168079] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1348host1 # [ 9.178330] systemd[1]: Started Rule-based Manager for Device Events and Files.1349host1 # [ 9.200985] systemd[1]: Finished Rebuild Journal Catalog.1350host1 # [ 9.220409] systemd[1]: Starting Update is Completed...1351server # [ 7.714416] systemd[1]: systemd 261.3 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)1352server # [ 7.714475] systemd[1]: Detected virtualization qemu.1353server # [ 7.714529] systemd[1]: Detected architecture arm64.1354server # [ 7.714643] systemd[1]: Detected first boot.1355server # [ 7.717011] systemd[1]: Initializing machine ID from random generator.1356host1 # [ 9.348696] systemd[1]: Finished Update is Completed.1357server # [ 7.868039] systemd[1]: bpf-restrict-fs: LSM BPF program attached1358server # [ 8.046467] systemd[1]: Applying preset policy.1359server # [ 8.313869] systemd[1]: Populated /etc with preset unit settings.1360host1 # [ 10.078683] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1361server # [ 8.562240] systemd[1]: initrd-switch-root.service: Deactivated successfully.1362server # [ 8.563080] systemd[1]: Stopped initrd-switch-root.service.1363server # [ 8.566020] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1364server # [ 8.571788] systemd[1]: Created slice Slice /system/getty.1365server # [ 8.573110] systemd[1]: Created slice User and Session Slice.1366server # [ 8.573652] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1367server # [ 8.577318] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1368server # [ 8.577748] systemd[1]: Expecting device /dev/hvc0...1369server # [ 8.580668] systemd[1]: Expecting device /dev/ttyAMA0...1370server # [ 8.581056] systemd[1]: Reached target Local Encrypted Volumes.1371server # [ 8.581720] systemd[1]: Stopped target initrd-fs.target.1372server # [ 8.585029] systemd[1]: Stopped target initrd-root-fs.target.1373server # [ 8.585412] systemd[1]: Stopped target initrd-switch-root.target.1374server # [ 8.588270] systemd[1]: Reached target Virtual Machines and Containers.1375server # [ 8.588633] systemd[1]: Reached target Path Units.1376server # [ 8.588959] systemd[1]: Reached target Remote File Systems.1377server # [ 8.589203] systemd[1]: Reached target Slice Units.1378server # [ 8.589427] systemd[1]: Reached target Swaps.1379server # [ 8.595187] systemd[1]: Listening on Query the User Interactively for a Password.1380server # [ 8.597172] systemd[1]: Listening on Process Core Dump Socket.1381server # [ 8.600436] systemd[1]: Listening on Credential Encryption/Decryption.1382server # [ 8.603080] systemd[1]: Listening on Factory Reset Management.1383server # [ 8.603481] systemd[1]: Listening on Hostname Service Socket.1384server # [ 8.608115] systemd[1]: Starting Journal Log Access Socket...1385server # [ 8.609799] systemd[1]: Listening on Journal Audit Socket.1386server # [ 8.616286] systemd[1]: Listening on Console Output Muting Service Socket.1387server # [ 8.616966] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1388server # [ 8.617939] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-os1389server # [ 8.623018] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1390server # [ 8.629468] systemd[1]: Listening on Disk Repartitioning Service Socket.1391server # [ 8.631452] systemd[1]: Listening on udev Control Socket.1392server # [ 8.631949] systemd[1]: Listening on udev Varlink Socket.1393server # [ 8.637279] systemd[1]: Mounting Huge Pages File System...1394server # [ 8.642646] systemd[1]: Mounting POSIX Message Queue File System...1395server # [ 8.658172] systemd[1]: Mounting Kernel Debug File System...1396server # [ 8.671554] systemd[1]: Mounting Kernel Trace File System...1397server # [ 8.690352] systemd[1]: Starting Create List of Static Device Nodes...1398server # [ 8.690763] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1399server # [ 8.705074] systemd[1]: Mounting Kernel Configuration File System...1400server # [ 8.705467] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1401server # [ 8.705729] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1402server # [ 8.705980] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1403server # [ 8.730734] systemd[1]: Mounting FUSE Control File System...1404server # [ 8.731258] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671405server # [ 8.775459] systemd[1]: Starting Journal Service...1406server # [ 8.797886] systemd[1]: Starting Load Kernel Modules...1407server # [ 8.823220] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1408server # [ 8.834238] systemd[1]: Starting Remount Root and Kernel File Systems...1409server # [ 8.834626] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1410server # [ 8.842772] systemd[1]: Starting Coldplug All udev Devices...1411server # [ 8.845495] systemd[1]: Listening on Journal Log Access Socket.1412server # [ 8.845919] systemd[1]: Mounted Huge Pages File System.1413server # [ 8.854470] systemd[1]: Mounted POSIX Message Queue File System.1414server # [ 8.855003] systemd[1]: Mounted Kernel Debug File System.1415server # [ 8.855483] systemd[1]: Mounted Kernel Trace File System.1416server # [ 8.856231] systemd[1]: Mounted Kernel Configuration File System.1417server # [ 8.870988] systemd[1]: Mounted FUSE Control File System.1418server # [ 8.913457] systemd[1]: Finished Create List of Static Device Nodes.1419server # [ 8.919259] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1420server # [ 8.985895] systemd[1]: Finished Load Kernel Modules.1421server # [ 8.989997] EXT4-fs (vda): re-mounted 86dc2d0d-a22f-4d13-8c51-9b88819f46ae.1422server # [ 8.993683] systemd[1]: Starting Firewall...1423server # [ 9.001706] systemd[1]: Starting Apply Kernel Variables...1424server # [ 9.010319] systemd[1]: Finished Remount Root and Kernel File Systems.1425server # [ 9.011042] systemd[1]: Listening on Disk Image Download Service Socket.1426server # [ 9.011422] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1427server # [ 9.026258] systemd[1]: Starting Load/Save OS Random Seed...1428server # [ 9.027017] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-os1429server # [ 9.046771] systemd-journald[276]: Collecting audit messages is enabled.1430host1 # [ 10.080701] systemd[1]: Finished Create SUID/SGID Wrappers.1431host1 # [ 10.705155] systemd[1]: Finished Coldplug All udev Devices.1432server # [ 9.164886] systemd[1]: Started Journal Service.1433server # [ 9.136069] systemd[1]: Queued start job for default target Multi-User System.1434server # [ 9.137371] systemd[1]: systemd-journald.service: Deactivated successfully.1435server # [ 9.150383] systemd-modules-load[277]: Module 'atkbd' is built in1436server # [ 9.162971] systemd-modules-load[277]: Module 'loop' is built in1437server # [ 9.174599] systemd-oomd[278]: No swap; memory pressure usage will be degraded1438server # [ 9.182502] systemd[1]: Starting Flush Journal to Persistent Storage...1439server # [ 9.193713] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1440server # [ 9.202261] systemd[1]: Finished Load/Save OS Random Seed.1441server # [ 9.211670] systemd[1]: Reached target First Boot Complete.1442server # [ 9.218308] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1443server # [ 9.227525] systemd[1]: Finished Apply Kernel Variables.1444server # [ 9.232350] systemd[1]: Starting Create Static Device Nodes in /dev...1445server # [ 9.307129] systemd-journald[276]: Received client request to flush runtime journal.1446server # [ 9.369490] systemd[1]: Finished Flush Journal to Persistent Storage.1447server # [ 9.391304] systemd[1]: Finished Create Static Device Nodes in /dev.1448server # [ 9.392539] systemd[1]: Reached target Preparation for Local File Systems.1449server # [ 9.396568] systemd[1]: Starting Rule-based Manager for Device Events and Files...1450host1 # [ 11.051588] systemd[1]: Finished register-nix-paths.service.1451host1 # [ 11.054531] systemd[1]: Reached target System Initialization.1452host1 # [ 11.055432] systemd[1]: Started Renew ACME Certificate for host1.1453host1 # [ 11.061934] systemd[1]: Started Discard unused filesystem blocks once a week.1454host1 # [ 11.063061] systemd[1]: Started Daily Cleanup of Temporary Directories.1455host1 # [ 11.070342] systemd[1]: Reached target Timer Units.1456host1 # [ 11.071228] systemd[1]: Listening on D-Bus System Message Bus Socket.1457host1 # [ 11.078318] systemd[1]: Listening on Nix Daemon Socket.1458host1 # [ 11.079668] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1459host1 # [ 11.089449] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...1460host1 # [ 11.090859] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1461host1 # [ 11.104209] systemd[1]: Starting D-Bus System Message Bus...1462host1 # [ 11.152127] systemd[1]: Finished Firewall.1463server # [ 9.529844] systemd[1]: Mounting /run/wrappers...1464host1 # [ 11.187448] systemd-ssh-issue[484]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.1465host1 # [ 11.197942] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).1466host1 # [ 11.199362] systemd[1]: Reached target Socket Units.1467server # [ 9.550349] systemd-udevd[314]: Using default interface naming scheme 'v261'.1468server # [ 9.613147] systemd[1]: Mounted /run/wrappers.1469server # [ 9.614039] systemd[1]: Reached target Local File Systems.1470server # [ 9.624198] systemd[1]: Listening on Boot Loader Control Service Socket.1471server # [ 9.632792] systemd[1]: Starting register-nix-paths.service...1472host1 # [ 11.295077] dbus-broker-launch[486]: Looking up NSS user entry for 'systemd-timesync'...1473server # [ 9.642469] systemd[1]: Starting Create SUID/SGID Wrappers...1474server # [ 9.643459] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1475host1 # [ 11.308228] dbus-broker-launch[486]: NSS returned no entry for 'systemd-timesync'1476host1 # [ 11.310687] dbus-broker-launch[486]: Invalid user-name in /nix/store/x22q42php31hda5209nhwlyhgg3zcjz4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1477server # [ 9.671424] systemd[1]: Starting Save Transient machine-id to Disk...1478server # [ 9.685522] systemd[1]: Starting Create System Files and Directories...1479host1 # [ 11.368140] systemd[1]: Started D-Bus System Message Bus.1480host1 # [ 11.372553] systemd[1]: Reached target Basic System.1481host1 # [ 11.387147] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1482host1 # [ 11.405111] systemd[1]: Starting Import lastlog data into lastlog2 database...1483host1 # [ 11.412125] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1484host1 # [ 11.440929] dbus-broker-launch[486]: Ready1485host1 # [ 11.454319] systemd[1]: Starting Post-Boot Actions...1486server # [ 9.851068] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1487host1 # [ 11.506367] systemd[1]: Started Reset console on configuration changes.1488server # [ 9.859023] systemd[1]: Finished Save Transient machine-id to Disk.1489host1 # [ 11.555397] systemd[1]: Starting resolvconf update...1490server # [ 9.921909] systemd[1]: Started Rule-based Manager for Device Events and Files.1491host1 # [ 11.591070] systemd[1]: Starting SSH Host Keys Generation...1492host1 # [ 11.621155] acme-setup-privileged[491]: + set -euo pipefail1493host1 # [ 11.622182] acme-setup-privileged[491]: + cd /var/lib/acme1494host1 # [ 11.622972] acme-setup-privileged[491]: + chmod -R u=rwX,g=,o= .lego/accounts1495host1 # [ 11.645849] acme-setup-privileged[491]: + chown -R acme .lego/accounts1496server # [ 9.997381] systemd[1]: Finished Create System Files and Directories.1497server # [ 10.005861] systemd[1]: Starting Rebuild Journal Catalog...1498host1 # [ 11.666893] systemd[1]: Started Name Service Cache Daemon (nsncd).1499server # [ 10.017470] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1500host1 # [ 11.709836] nsncd[493]: Oct 28 10:56:16.139 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1501host1 # [ 11.727687] systemd[1]: Reached target Host and Network Name Lookups.1502host1 # [ 11.734405] acme-setup-privileged[491]: + for fixpath in host1 .lego/host11503host1 # [ 11.735441] acme-setup-privileged[491]: + '[' -d host1 ']'1504host1 # [ 11.746516] acme-setup-privileged[491]: + for fixpath in host1 .lego/host11505host1 # [ 11.747512] acme-setup-privileged[491]: + '[' -d .lego/host1 ']'1506host1 # [ 11.758708] systemd[1]: Reached target User and Group Name Lookups.1507host1 # [ 11.759705] systemd[1]: Starting User Login Management...1508host1 # [ 11.774491] systemd[1]: Finished Post-Boot Actions.1509server # [ 10.122741] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1510host1 # [ 11.780739] systemd[1]: Finished Import lastlog data into lastlog2 database.1511server # [ 10.184760] systemd[1]: Finished Rebuild Journal Catalog.1512server # [ 10.188619] systemd[1]: Starting Update is Completed...1513server # [ 10.269577] systemd[1]: Finished Update is Completed.1514host1 # [ 12.028235] acme-setup-start[521]: + set -euo pipefail1515host1 # [ 12.043824] acme-setup-start[521]: + test -e ca/key.pem1516host1 # [ 12.044902] acme-setup-start[521]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1517host1 # [ 12.046645] systemd-logind[519]: New seat seat0.1518host1 # [ 12.047441] systemd[1]: Started User Login Management.1519host1 # [ 12.060230] systemd[1]: Starting linger-users.service...1520host1 # [ 12.111684] systemd[1]: Stopped target Host and Network Name Lookups.1521host1 # [ 12.116205] systemd[1]: Stopping Host and Network Name Lookups...1522host1 # [ 12.117135] systemd[1]: Stopped target User and Group Name Lookups.1523host1 # [ 12.118061] systemd[1]: Stopping User and Group Name Lookups...1524host1 # [ 12.118921] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1525host1 # [ 12.141042] systemd[1]: nscd.service: Deactivated successfully.1526host1 # [ 12.142128] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1527host1 # [ 12.172356] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1528host1 # [ 12.182855] systemd[1]: linger-users.service: Deactivated successfully.1529host1 # [ 12.189937] systemd[1]: Finished linger-users.service.1530host1 # [ 12.202337] systemd[1]: Starting Ensure certificate for host1...1531host1 # [ 12.207029] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1532host1 # [ 12.342566] systemd[1]: Started Name Service Cache Daemon (nsncd).1533host1 # [ 12.343644] systemd[1]: Reached target Host and Network Name Lookups.1534host1 # [ 12.359822] systemd[1]: Reached target User and Group Name Lookups.1535host1 # [ 12.368545] nsncd[595]: Oct 28 10:56:16.827 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1536host1 # [ 12.370705] systemd[1]: Finished resolvconf update.1537host1 # [ 12.371443] systemd[1]: Reached target Preparation for Network.1538host1 # [ 12.384299] systemd[1]: Starting DHCP Client...1539host1 # [ 12.391457] systemd[1]: Starting Extra networking commands....1540server # [ 10.753901] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1541server # [ 10.756342] systemd[1]: Finished Create SUID/SGID Wrappers.1542host1 # [ 12.426515] acme-host1-start[593]: Waiting to acquire lock in /run/acme/1543host1 # [ 12.486839] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input31544host1 # [ 12.465470] acme-host1-start[593]: + '[' -e out/acme-success ']'1545host1 # [ 12.466541] acme-host1-start[593]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=host1 --ip-addresses=1546host1 # [ 12.523705] acme-host1-start[642]: + cd host11547host1 # [ 12.536322] acme-host1-start[642]: + cp -vp cert.pem ../out/cert.pem1548host1 # [ 12.544472] acme-host1-start[644]: 'cert.pem' -> '../out/cert.pem'1549host1 # [ 12.560193] acme-host1-start[642]: + cp -vp key.pem ../out/key.pem1550host1 # [ 12.565319] acme-host1-start[642]: 'key.pem' -> '../out/key.pem'1551host1 # [ 12.572211] acme-host1-start[593]: + cat out/cert.pem ca/cert.pem1552host1 # [ 12.588941] acme-host1-start[593]: + cp ca/cert.pem out/chain.pem1553host1 # [ 12.604738] acme-host1-start[593]: + cat out/key.pem out/fullchain.pem1554host1 # [ 12.622679] acme-host1-start[593]: + for fixpath in out certificates1555host1 # [ 12.623687] acme-host1-start[593]: + '[' -d out ']'1556host1 # [ 12.634274] acme-host1-start[593]: + chmod -R u=rwX,g=rX,o= out1557host1 # [ 12.652248] acme-host1-start[593]: + chown -R acme:acme out1558host1 # [ 12.686369] acme-host1-start[593]: + for fixpath in out certificates1559host1 # [ 12.687401] acme-host1-start[593]: + '[' -d certificates ']'1560host1 # [ 12.705016] systemd[1]: Finished Ensure certificate for host1.1561host1 # [ 12.783526] dhcpcd[645]: dhcpcd-10.3.2 starting1562host1 # [ 12.810137] dhcpcd[682]: dev: loaded udev1563host1 # [ 12.810895] dhcpcd[682]: no valid interfaces found1564host1 # [ 12.811667] dhcpcd[682]: no valid interfaces found1565host1 # [ 12.820771] dhcpcd[682]: libudev: received NULL device1566host1 # [ 12.821714] dhcpcd[682]: libudev: received NULL device1567server # [ 11.211089] systemd[1]: Finished Firewall.1568server # [ 11.401063] systemd[1]: Finished Coldplug All udev Devices.1569server # [ 11.467625] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1570host1 # [ 13.136538] systemd[1]: Finished Extra networking commands..1571host1 # [ 13.143161] systemd[1]: Reached target Network.1572host1 # [ 13.152141] systemd[1]: Starting Permit User Sessions...1573server # [ 11.502319] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse1574server # [ 11.564990] systemd[1]: Finished register-nix-paths.service.1575server # [ 11.566146] systemd[1]: Reached target System Initialization.1576server # [ 11.567042] systemd[1]: Started Renew ACME Certificate for server.1577server # [ 11.569065] systemd[1]: Started Discard unused filesystem blocks once a week.1578server # [ 11.571401] systemd[1]: Started Daily Cleanup of Temporary Directories.1579server # [ 11.575369] systemd[1]: Reached target Timer Units.1580server # [ 11.578205] systemd[1]: Listening on D-Bus System Message Bus Socket.1581server # [ 11.579169] systemd[1]: Listening on Nix Daemon Socket.1582server # [ 11.579962] systemd[1]: Listening on Nix worker-protocol over gRPC.1583server # [ 11.585414] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local).1584server # [ 11.594187] systemd[1]: Starting OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK)...1585server # [ 11.603745] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1586server # [ 11.607017] systemd[1]: Starting D-Bus System Message Bus...1587host1 # [ 13.294355] systemd[1]: Finished Permit User Sessions.1588server # [ 11.645325] systemd-ssh-issue[502]: Options --make-vsock/--rm-vsock have been replaced by make-vsock/rm-vsock verbs.1589server # [ 11.653478] systemd[1]: Listening on OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK).1590host1 # [ 13.309732] systemd[1]: Started Getty on tty1.1591host1 # [ 13.310564] systemd[1]: Reached target Login Prompts.1592server # [ 11.657761] systemd[1]: Reached target Socket Units.1593server # [ 11.683089] dbus-broker-launch[503]: Looking up NSS user entry for 'systemd-timesync'...1594server # [ 11.687909] dbus-broker-launch[503]: NSS returned no entry for 'systemd-timesync'1595server # [ 11.692065] dbus-broker-launch[503]: Invalid user-name in /nix/store/5rbqnlcwa36b5kh8szwyp1z2glsjs0km-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1596server # [ 11.702640] systemd[1]: Started D-Bus System Message Bus.1597server # [ 11.708338] systemd[1]: Reached target Basic System.1598host1 # [ 13.366983] systemd[1]: Starting Virtual Console Setup...1599server # [ 11.720738] systemd[1]: Starting Set up the ACME certificate renewal infrastructure...1600host1 # [ 13.384750] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1601server # [ 11.733300] systemd[1]: Starting Import lastlog data into lastlog2 database...1602server # [ 11.752184] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1603server # [ 11.760280] systemd[1]: Starting Post-Boot Actions...1604server # [ 11.765061] systemd[1]: Started Reset console on configuration changes.1605server # [ 11.773503] systemd[1]: Starting resolvconf update...1606server # [ 11.785192] systemd[1]: Starting SSH Host Keys Generation...1607host1 # [ 13.443844] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1608host1 # [ 13.446292] systemd[1]: Stopped Virtual Console Setup.1609host1 # [ 13.451594] systemd[1]: Starting Virtual Console Setup...1610server # [ 11.798728] systemd[1]: Starting step-ca-pki.service...1611server # [ 11.833708] dbus-broker-launch[503]: Ready1612server # [ 11.896150] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1613server # [ 11.914217] systemd[1]: Finished Post-Boot Actions.1614server # [ 11.949330] systemd[1]: Started Name Service Cache Daemon (nsncd).1615server # [ 11.960891] systemd[1]: Reached target Host and Network Name Lookups.1616server # [ 11.971913] acme-setup-privileged[506]: + set -euo pipefail1617server # [ 11.980948] acme-setup-privileged[506]: + cd /var/lib/acme1618server # [ 11.990666] acme-setup-privileged[506]: + chmod -R u=rwX,g=,o= .lego/accounts1619server # [ 11.999946] systemd[1]: Reached target User and Group Name Lookups.1620server # [ 12.010334] nsncd[508]: Oct 28 10:56:18.112 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1621host1 # [ 13.681082] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1622server # [ 12.033803] acme-setup-privileged[506]: + chown -R acme .lego/accounts1623server # [ 12.041736] acme-setup-privileged[506]: + for fixpath in server .lego/server1624server # [ 12.047062] acme-setup-privileged[506]: + '[' -d server ']'1625server # [ 12.054779] acme-setup-privileged[506]: + for fixpath in server .lego/server1626server # [ 12.063513] acme-setup-privileged[506]: + '[' -d .lego/server ']'1627server # [ 12.069730] systemd[1]: Starting User Login Management...1628server # [ 12.080767] systemd[1]: Finished Import lastlog data into lastlog2 database.1629host1 # [ 13.763527] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1630host1 # [ 13.771455] systemd[1]: Started backdoor.service.1631server # [ 12.141269] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1632server # [ 12.149338] systemd[1]: Started backdoor.service.1633host1 # connecting to host...1634server # [ 12.291687] systemd-logind[539]: New seat seat0.1635server # [ 12.308741] systemd[1]: Started User Login Management.1636server # [ 12.316522] systemd[1]: Starting linger-users.service...1637host1 # [ 14.010268] 8021q: 802.1Q VLAN Support v1.81638server # connecting to host...1639host1 # [ 13.991628] (udev-worker)[607]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1640host1 # [ 14.003314] (udev-worker)[611]: Network interface NamePolicy= disabled on kernel command line.1641host1 # [ 14.010738] (udev-worker)[607]: Network interface NamePolicy= disabled on kernel command line.1642server # [ 12.380759] acme-setup-start[545]: + set -euo pipefail1643server # [ 12.381638] acme-setup-start[545]: + test -e ca/key.pem1644server # [ 12.382365] acme-setup-start[545]: + minica --ca-key ca/key.pem --ca-cert ca/cert.pem --domains selfsigned.local1645server # [ 12.419502] systemd[1]: Stopped target Host and Network Name Lookups.1646server: Guest shell says: b'Spawning backdoor root shell...\n'1647server # [ 12.430620] systemd[1]: Stopping Host and Network Name Lookups...1648server # [ 12.431510] systemd[1]: Stopped target User and Group Name Lookups.1649server # [ 12.447752] systemd[1]: Stopping User and Group Name Lookups...1650server # [ 12.458455] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1651server # [ 12.465150] systemd[1]: nscd.service: Deactivated successfully.1652server: connected to guest root shell1653server: (connecting took 12.83 seconds)1654server: (finished: waiting for the VM to finish booting, in 12.83 seconds)1655server # [ 12.465977] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1656server # [ 12.483085] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1657host1 # [ 14.174822] cfg80211: Loading compiled-in X.509 certificates for regulatory database1658server # [ 12.498883] systemd[1]: linger-users.service: Deactivated successfully.1659server # [ 12.509253] systemd[1]: Finished linger-users.service.1660host1 # [ 14.219662] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1661host1 # [ 14.220154] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1662host1 # [ 14.221096] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21663host1 # [ 14.221408] cfg80211: failed to load regulatory.db1664server # [ 12.574443] systemd[1]: Finished Set up the ACME certificate renewal infrastructure.1665server # [ 12.585254] systemd[1]: Starting Ensure certificate for server...1666server # [ 12.619339] systemd[1]: Started Name Service Cache Daemon (nsncd).1667server # [ 12.632669] nsncd[609]: Oct 28 10:56:18.756 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1668server # [ 12.634684] systemd[1]: Reached target Host and Network Name Lookups.1669server # [ 12.635572] systemd[1]: Reached target User and Group Name Lookups.1670server # [ 12.673573] (udev-worker)[359]: Network interface NamePolicy= disabled on kernel command line.1671server # [ 12.693477] systemd[1]: Finished resolvconf update.1672server # [ 12.702562] systemd[1]: Reached target Preparation for Network.1673server # [ 12.703463] systemd[1]: Starting DHCP Client...1674server # [ 12.716721] systemd[1]: Starting Extra networking commands....1675server # [ 12.735659] (udev-worker)[358]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1676host1 # [ 14.398940] sshd-keygen-start[539]: Generating public/private rsa key pair.1677host1 # [ 14.401387] sshd-keygen-start[539]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1678host1 # [ 14.402658] sshd-keygen-start[539]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1679host1 # [ 14.403879] sshd-keygen-start[539]: The key fingerprint is:1680server # [ 12.756221] (udev-worker)[358]: Network interface NamePolicy= disabled on kernel command line.1681host1 # [ 14.412309] sshd-keygen-start[539]: SHA256:QbKoJVbr4k+uxV/5w89m5sIdurMeJT2FCHTEs9qwNTM root@host11682host1 # [ 14.413548] sshd-keygen-start[539]: The key's randomart image is:1683host1 # [ 14.414443] sshd-keygen-start[539]: +---[RSA 4096]----+1684host1 # [ 14.415160] sshd-keygen-start[539]: | . ..+oo |1685host1 # [ 14.415876] sshd-keygen-start[539]: | . o + oo. . |1686host1 # [ 14.425634] sshd-keygen-start[539]: | o + . . .o. . |1687host1 # [ 14.426428] sshd-keygen-start[539]: | . = ..E. . |1688host1 # [ 14.427144] sshd-keygen-start[539]: | o . S*.++ |1689host1 # [ 14.427861] sshd-keygen-start[539]: | . o o..o.. |1690host1 # [ 14.436784] sshd-keygen-start[539]: | . + oo.o . |1691host1 # [ 14.437599] sshd-keygen-start[539]: | = . . .Bo= |1692host1 # [ 14.438389] sshd-keygen-start[539]: | ..o . .=%+ |1693host1 # [ 14.439155] sshd-keygen-start[539]: +----[SHA256]-----+1694host1 # [ 14.465452] sshd-keygen-start[732]: Generating public/private ed25519 key pair.1695host1 # [ 14.466684] sshd-keygen-start[732]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1696host1 # [ 14.467906] sshd-keygen-start[732]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1697host1 # [ 14.479847] sshd-keygen-start[732]: The key fingerprint is:1698host1 # [ 14.481633] sshd-keygen-start[732]: SHA256:6a1enOhk2v1CxbxLJjBMmUcKyzc2neQZLRczkSRmqjI root@host11699host1 # [ 14.482850] sshd-keygen-start[732]: The key's randomart image is:1700host1 # [ 14.483682] sshd-keygen-start[732]: +--[ED25519 256]--+1701host1 # [ 14.492803] sshd-keygen-start[732]: | . +Bo*+ |1702host1 # [ 14.493623] sshd-keygen-start[732]: | . o+Oo=+o |1703host1 # [ 14.494363] sshd-keygen-start[732]: | ooB.== |1704host1 # [ 14.495092] sshd-keygen-start[732]: | +++ + |1705host1 # [ 14.495810] sshd-keygen-start[732]: | E . So . . |1706host1 # [ 14.501932] sshd-keygen-start[732]: | o . +o.+ |1707host1 # [ 14.502763] sshd-keygen-start[732]: | =.=+ . |1708host1 # [ 14.503473] sshd-keygen-start[732]: | * +. . |1709host1 # [ 14.507090] sshd-keygen-start[732]: | ..= .o. |1710host1 # [ 14.507851] sshd-keygen-start[732]: +----[SHA256]-----+1711host1 # [ 14.515492] systemd-logind[519]: Watching system buttons on /dev/input/event0 (gpio-keys)1712host1 # [ 14.521963] systemd[1]: sshd-keygen.service: Deactivated successfully.1713host1 # [ 14.523021] systemd[1]: Finished SSH Host Keys Generation.1714host1 # [ 14.523818] systemd[1]: Starting SSH Daemon...1715server # [ 12.875387] step-ca-pki-start[538]: Your certificate has been saved in root_ca.crt.1716server # [ 12.885419] step-ca-pki-start[538]: Your private key has been saved in root_ca.key.1717host1 # [ 14.566196] sshd[734]: Server listening on 0.0.0.0 port 22.1718host1 # [ 14.567086] systemd[1]: Started SSH Daemon.1719host1 # [ 14.567717] sshd[734]: Server listening on :: port 22.1720server # [ 12.940554] acme-server-start[631]: Waiting to acquire lock in /run/acme/1721host1 # [ 14.622665] systemd[1]: Condition check resulted in Virtio network device being skipped.1722server # [ 12.970274] acme-server-start[631]: + '[' -e out/acme-success ']'1723server # [ 12.971250] acme-server-start[631]: + minica --ca-cert=ca/cert.pem --ca-key=ca/key.pem --domains=server --ip-addresses=1724host1 # [ 14.631061] systemd[1]: Starting Address configuration of eth1...1725server # [ 12.992942] systemd[1]: Condition check resulted in Virtio network device being skipped.1726server # [ 12.994163] systemd[1]: Starting Address configuration of eth1...1727host1 # [ 14.692898] mousedev: PS/2 mouse device common for all mice1728host1 # [ 14.709159] 8021q: adding VLAN 0 to HW filter on device eth01729host1 # [ 14.678981] dhcpcd[682]: eth0: waiting for carrier1730host1 # [ 14.679779] dhcpcd[682]: eth0: carrier acquired1731host1 # [ 14.700401] dhcpcd[682]: DUID 00:01:00:01:32:74:91:53:52:54:00:12:34:561732host1 # [ 14.701438] dhcpcd[682]: eth0: IAID 00:12:34:561733host1 # [ 14.702207] dhcpcd[682]: eth0: adding address fe80::5054:ff:fe12:34561734host1 # [ 14.726146] systemd-vconsole-setup[709]: Configuration of first virtual console was skipped, ignoring remaining ones.1735host1 # [ 14.767450] 8021q: adding VLAN 0 to HW filter on device eth11736host1 # [ 14.738878] systemd[1]: Finished Virtual Console Setup.1737server # [ 13.100733] acme-server-start[695]: + cd server1738server # [ 13.101545] acme-server-start[695]: + cp -vp cert.pem ../out/cert.pem1739host1 # [ 14.762131] network-addresses-eth1-start[738]: adding address 192.168.1.1/24... done1740server # [ 13.118319] step-ca-pki-start[661]: Your certificate has been saved in intermediate_ca.crt.1741host1 # [ 14.780769] network-addresses-eth1-start[738]: adding address 2001:db8:1::1/64... done1742server # [ 13.129320] step-ca-pki-start[661]: Your private key has been saved in intermediate_ca.key.1743server # [ 13.130659] acme-server-start[697]: 'cert.pem' -> '../out/cert.pem'1744server # [ 13.131516] acme-server-start[695]: + cp -vp key.pem ../out/key.pem1745host1 # [ 14.803263] systemd[1]: Finished Address configuration of eth1.1746server # [ 13.153358] acme-server-start[695]: 'key.pem' -> '../out/key.pem'1747server # [ 13.154285] acme-server-start[631]: + cat out/cert.pem ca/cert.pem1748server # [ 13.173906] acme-server-start[631]: + cp ca/cert.pem out/chain.pem1749server # [ 13.195392] systemd[1]: Finished step-ca-pki.service.1750server # [ 13.200478] acme-server-start[631]: + cat out/key.pem out/fullchain.pem1751server # [ 13.213277] acme-server-start[631]: + for fixpath in out certificates1752server # [ 13.220915] acme-server-start[631]: + '[' -d out ']'1753host1 # [ 14.873685] systemd-logind[519]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1754server # [ 13.221723] acme-server-start[631]: + chmod -R u=rwX,g=rX,o= out1755server # [ 13.233242] dhcpcd[665]: dhcpcd-10.3.2 starting1756server # [ 13.234008] acme-server-start[631]: + chown -R acme:nix-grpc-daemon out1757server # [ 13.259966] network-addresses-eth1-start[677]: adding address 192.168.1.2/24... done1758server # [ 13.272507] dhcpcd[737]: dev: loaded udev1759server # [ 13.273270] systemd[1]: Finished Ensure certificate for server.1760server # [ 13.274109] acme-server-start[631]: + for fixpath in out certificates1761server # [ 13.274982] acme-server-start[631]: + '[' -d certificates ']'1762server # [ 13.331113] 8021q: 802.1Q VLAN Support v1.81763server # [ 13.332196] 8021q: adding VLAN 0 to HW filter on device eth11764server # [ 13.307841] network-addresses-eth1-start[677]: adding address 2001:db8:1::2/64... done1765server # [ 13.396124] systemd[1]: Finished Address configuration of eth1.1766server # [ 13.444114] cfg80211: Loading compiled-in X.509 certificates for regulatory database1767server # [ 13.454881] systemd[1]: Finished Extra networking commands..1768server # [ 13.455806] systemd[1]: Reached target Network.1769server # [ 13.494810] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1770server # [ 13.495331] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1771server # [ 13.496263] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21772server # [ 13.496576] cfg80211: failed to load regulatory.db1773server # [ 13.471826] systemd[1]: Starting Permit User Sessions...1774server # [ 13.538478] systemd[1]: Finished Permit User Sessions.1775server # [ 13.543461] systemd[1]: Started Getty on tty1.1776server # [ 13.549462] systemd[1]: Reached target Login Prompts.1777server # [ 13.633019] 8021q: adding VLAN 0 to HW filter on device eth01778server # [ 13.599242] dhcpcd[737]: eth0: waiting for carrier1779server # [ 13.601408] dhcpcd[737]: libudev: received NULL device1780server # [ 13.604713] dhcpcd[737]: libudev: received NULL device1781server # [ 13.605672] dhcpcd[737]: eth0: carrier acquired1782server # [ 13.618841] dhcpcd[737]: DUID 00:01:00:01:32:74:91:53:52:54:00:12:34:561783server # [ 13.619829] dhcpcd[737]: eth0: IAID 00:12:34:561784server # [ 13.625167] dhcpcd[737]: eth0: adding address fe80::5054:ff:fe12:34561785server # [ 13.710532] dhcpcd[737]: eth0: soliciting a DHCP lease1786server # [ 13.718594] dhcpcd[737]: eth0: offered 10.0.2.15 from 10.0.2.21787server # [ 13.721125] dhcpcd[737]: eth0: probing address 10.0.2.15/241788server # [ 13.848212] systemd-logind[539]: Watching system buttons on /dev/input/event0 (gpio-keys)1789server # [ 14.227160] mousedev: PS/2 mouse device common for all mice1790host1 # [ 15.986409] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1791host1 # [ 15.996385] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1792host1 # [ 16.003858] systemd[1]: Stopped Virtual Console Setup.1793host1 # [ 16.005048] systemd[1]: Stopping Virtual Console Setup...1794host1 # [ 16.007255] systemd[1]: Starting Virtual Console Setup...1795host1 # [ 16.037281] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1796host1 # [ 16.040723] systemd[1]: Stopped Virtual Console Setup.1797host1 # [ 16.045380] systemd[1]: Starting Virtual Console Setup...1798server # [ 14.395354] systemd-logind[539]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1799host1 # [ 16.065993] systemd-logind[519]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1800host1 # [ 16.147800] systemd-vconsole-setup[775]: Configuration of first virtual console was skipped, ignoring remaining ones.1801host1 # [ 16.151865] systemd[1]: Finished Virtual Console Setup.1802host1 # [ 16.633983] dhcpcd[682]: eth0: soliciting a DHCP lease1803host1 # [ 16.636752] dhcpcd[682]: eth0: offered 10.0.2.15 from 10.0.2.21804host1 # [ 16.644219] dhcpcd[682]: eth0: probing address 10.0.2.15/241805server # [ 15.577058] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:06.0/virtio5/input/input31806server # [ 15.603391] dhcpcd[737]: eth0: soliciting an IPv6 router1807server # [ 15.604660] dhcpcd[737]: eth0: Router Advertisement from fe80::21808server # [ 15.605599] dhcpcd[737]: eth0: adding address fec0::5054:ff:fe12:3456/641809server # [ 15.608059] dhcpcd[737]: eth0: adding route to fec0::/641810server # [ 15.608854] dhcpcd[737]: eth0: adding default route via fe80::21811host1 # [ 17.392570] dhcpcd[682]: eth0: soliciting an IPv6 router1812host1 # [ 17.394717] dhcpcd[682]: eth0: Router Advertisement from fe80::21813host1 # [ 17.397468] dhcpcd[682]: eth0: adding address fec0::5054:ff:fe12:3456/641814host1 # [ 17.399088] dhcpcd[682]: eth0: adding route to fec0::/641815host1 # [ 17.400381] dhcpcd[682]: eth0: adding default route via fe80::21816server # [ 16.316933] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1817server # [ 16.346192] systemd[1]: Starting Virtual Console Setup...1818server # [ 16.377877] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1819server # [ 16.379040] systemd[1]: Stopped Virtual Console Setup.1820server # [ 16.384517] systemd[1]: Starting Virtual Console Setup...1821server # [ 16.501248] systemd-logind[539]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1822server # [ 16.629076] systemd-vconsole-setup[824]: Configuration of first virtual console was skipped, ignoring remaining ones.1823server # [ 16.640151] systemd[1]: Finished Virtual Console Setup.1824server # [ 17.073224] sshd-keygen-start[557]: Generating public/private rsa key pair.1825server # [ 17.074329] sshd-keygen-start[557]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key1826server # [ 17.075548] sshd-keygen-start[557]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub1827server # [ 17.077680] sshd-keygen-start[557]: The key fingerprint is:1828server # [ 17.078480] sshd-keygen-start[557]: SHA256:pBpHZ3tVwzY38LKZJn8pCGKbxWKOQFpbmFVKThWoh+c root@server1829server # [ 17.079690] sshd-keygen-start[557]: The key's randomart image is:1830server # [ 17.080765] sshd-keygen-start[557]: +---[RSA 4096]----+1831server # [ 17.083364] sshd-keygen-start[557]: | +++. o+ |1832server # [ 17.084744] sshd-keygen-start[557]: | B.. .=o.|1833server # [ 17.086533] sshd-keygen-start[557]: | =o+. + .o +.|1834server # [ 17.087262] sshd-keygen-start[557]: | +oo+ =.. . = |1835server # [ 17.087988] sshd-keygen-start[557]: | . o= o=S+.. = |1836server # [ 17.089959] sshd-keygen-start[557]: | .E= *.. = .|1837server # [ 17.093149] sshd-keygen-start[557]: | .. + . o o |1838server # [ 17.093957] sshd-keygen-start[557]: | o |1839server # [ 17.094692] sshd-keygen-start[557]: | |1840server # [ 17.095424] sshd-keygen-start[557]: +----[SHA256]-----+1841server # [ 17.114953] sshd-keygen-start[837]: Generating public/private ed25519 key pair.1842server # [ 17.116629] sshd-keygen-start[837]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key1843server # [ 17.118021] sshd-keygen-start[837]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub1844server # [ 17.119272] sshd-keygen-start[837]: The key fingerprint is:1845server # [ 17.120370] sshd-keygen-start[837]: SHA256:lBlh6X2vIvLabMOoMUUj189rIUvY4J125ThU3S113rQ root@server1846server # [ 17.132603] sshd-keygen-start[837]: The key's randomart image is:1847server # [ 17.133587] sshd-keygen-start[837]: +--[ED25519 256]--+1848server # [ 17.134321] sshd-keygen-start[837]: | +o .. o=|1849server # [ 17.135048] sshd-keygen-start[837]: | o.+ . oo*|1850server # [ 17.135780] sshd-keygen-start[837]: | . =.=.. . Eo|1851server # [ 17.139152] sshd-keygen-start[837]: | = B.=.+. |1852server # [ 17.139933] sshd-keygen-start[837]: | + S B... |1853server # [ 17.140966] sshd-keygen-start[837]: | . o + + . |1854server # [ 17.141747] sshd-keygen-start[837]: | o o. o . |1855server # [ 17.142487] sshd-keygen-start[837]: | ooo=.. . |1856server # [ 17.143217] sshd-keygen-start[837]: | ...=+o . |1857server # [ 17.143963] sshd-keygen-start[837]: +----[SHA256]-----+1858server # [ 17.144979] systemd[1]: sshd-keygen.service: Deactivated successfully.1859server # [ 17.145938] systemd[1]: Finished SSH Host Keys Generation.1860server # [ 17.146729] systemd[1]: sshd-keygen.service: Consumed 2.052s CPU time over 5.356s wall clock time, 3.2M memory peak.1861server # [ 17.149874] systemd[1]: Starting SSH Daemon...1862server # [ 17.175574] sshd[839]: Server listening on 0.0.0.0 port 22.1863server # [ 17.176762] systemd[1]: Started SSH Daemon.1864server # [ 17.177481] sshd[839]: Server listening on :: port 22.1865server # [ 19.326444] dhcpcd[737]: eth0: leased 10.0.2.15 for 86400 seconds1866server # [ 19.328728] dhcpcd[737]: eth0: adding route to 10.0.2.0/241867server # [ 19.330069] dhcpcd[737]: eth0: adding default route via 10.0.2.21868server # [ 19.435762] systemd[1]: Started DHCP Client.1869server # [ 19.440544] systemd[1]: Reached target Network is Online.1870server # [ 19.443395] systemd[1]: Starting step-ca service...1871host1 # [ 21.379772] dhcpcd[682]: eth0: leased 10.0.2.15 for 86400 seconds1872host1 # [ 21.381839] dhcpcd[682]: eth0: adding route to 10.0.2.0/241873host1 # [ 21.383202] dhcpcd[682]: eth0: adding default route via 10.0.2.21874server # [ 19.749561] step-ca[913]: badger 2026/10/28 10:56:25 INFO: All 0 tables opened in 0s1875server # [ 19.764069] step-ca[913]: 2026/10/28 10:56:25 Building new tls configuration using step-ca x509 Signer Interface1876server # [ 19.777883] step-ca[913]: 2026/10/28 10:56:25 Starting Smallstep CA/0.30.2 (linux/arm64)1877server # [ 19.779057] step-ca[913]: 2026/10/28 10:56:25 Documentation: https://u.step.sm/docs/ca1878server # [ 19.780298] step-ca[913]: 2026/10/28 10:56:25 Community Discord: https://u.step.sm/discord1879server # [ 19.787772] step-ca[913]: 2026/10/28 10:56:25 Config file: /etc/smallstep/ca.json1880server # [ 19.791377] step-ca[913]: 2026/10/28 10:56:25 The primary server URL is https://server:84431881server # [ 19.796153] step-ca[913]: 2026/10/28 10:56:25 Root certificates are available at https://server:8443/roots.pem1882server # [ 19.797604] step-ca[913]: 2026/10/28 10:56:25 X.509 Root Fingerprint: ccfb08b08ef97bc36d905ad48055c9c5967fee6e36d093a26e7987a6bc4d81681883server # [ 19.799171] step-ca[913]: 2026/10/28 10:56:25 Serving HTTPS on 0.0.0.0:8443 ...1884server # [ 19.803255] systemd[1]: Started step-ca service.1885server # [ 19.803992] systemd[1]: Reached target Multi-User System.1886server # [ 19.807231] systemd[1]: Starting Order (and renew) ACME certificate for server...1887host1 # [ 21.493553] systemd[1]: Started DHCP Client.1888host1 # [ 21.495684] systemd[1]: Reached target Network is Online.1889host1 # [ 21.499769] systemd[1]: Starting fetch-ca-root.service...1890server # [ 19.854898] acme-order-renew-server-start[924]: Waiting to acquire lock in /run/acme/1891server # [ 19.861460] acme-order-renew-server-start[924]: + set -euo pipefail1892server # [ 19.862379] acme-order-renew-server-start[924]: + exec1893server # [ 19.863097] acme-order-renew-server-start[924]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 111894server # [ 19.866618] acme-order-renew-server-start[933]: ++ find accounts -path '*/keys/*.key' -print -quit1895server # [ 19.873356] acme-order-renew-server-start[924]: + '[' -n '' ']'1896server # [ 19.874231] acme-order-renew-server-start[924]: + exec1897server # [ 19.874949] acme-order-renew-server-start[924]: + '[' -e certificates/server.key ']'1898server # [ 19.875976] acme-order-renew-server-start[924]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server --no-random-sleep --renew-force --ari-disable --force-cert-domains1899host1 # [ 21.563407] systemd[1]: Finished fetch-ca-root.service.1900host1 # [ 21.565649] systemd[1]: Reached target Multi-User System.1901host1 # [ 21.570698] systemd[1]: Starting Order (and renew) ACME certificate for host1...1902host1 # [ 21.626144] acme-order-renew-host1-start[844]: Waiting to acquire lock in /run/acme/1903host1 # [ 21.632917] acme-order-renew-host1-start[844]: + set -euo pipefail1904host1 # [ 21.633869] acme-order-renew-host1-start[844]: + exec1905host1 # [ 21.634699] acme-order-renew-host1-start[844]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 111906host1 # [ 21.638313] acme-order-renew-host1-start[852]: ++ find accounts -path '*/keys/*.key' -print -quit1907host1 # [ 21.644815] acme-order-renew-host1-start[844]: + '[' -n '' ']'1908host1 # [ 21.645694] acme-order-renew-host1-start[844]: + exec1909host1 # [ 21.646410] acme-order-renew-host1-start[844]: + '[' -e certificates/host1.key ']'1910host1 # [ 21.647410] acme-order-renew-host1-start[844]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d host1 --no-random-sleep --renew-force --ari-disable --force-cert-domains1911server # [ 20.108099] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.245229220Z INFO Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key1912server # [ 20.122030] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.260437880Z INFO Registering the account. email=root@example.org1913host1 # [ 21.781216] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.262795180Z INFO Private key saved. filepath=accounts/server_8443/root@example.org/root@example.org.key1914host1 # [ 21.792662] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.274745180Z INFO Registering the account. email=root@example.org1915host1 # [ 21.952269] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.434252060Z WARN !!!! HEADS UP !!!!1916server # [ 20.299136] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.436573960Z WARN !!!! HEADS UP !!!!1917host1 # [ 21.954451] acme-order-renew-host1-start[853]: Your account credentials have been saved in your1918server # [ 20.302140] acme-order-renew-server-start[934]: Your account credentials have been saved in your1919host1 # [ 21.957593] acme-order-renew-host1-start[853]: configuration directory at "accounts".1920server # [ 20.304227] acme-order-renew-server-start[934]: configuration directory at "accounts".1921host1 # [ 21.959463] acme-order-renew-host1-start[853]: You should make a secure backup of this folder now. This1922server # [ 20.306972] acme-order-renew-server-start[934]: You should make a secure backup of this folder now. This1923host1 # [ 21.961579] acme-order-renew-host1-start[853]: configuration directory will also contain private keys1924server # [ 20.309332] acme-order-renew-server-start[934]: configuration directory will also contain private keys1925host1 # [ 21.963582] acme-order-renew-host1-start[853]: generated by lego and certificates obtained from the ACME1926server # [ 20.311786] acme-order-renew-server-start[934]: generated by lego and certificates obtained from the ACME1927host1 # [ 21.965645] acme-order-renew-host1-start[853]: server. Making regular backups of this folder is ideal.1928server # [ 20.314120] acme-order-renew-server-start[934]: server. Making regular backups of this folder is ideal.1929host1 # [ 21.967601] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.438729660Z INFO Obtaining bundled SAN certificate. domains=host11930server # [ 20.316859] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.436858380Z INFO Obtaining bundled SAN certificate. domains=server1931server # [ 20.396307] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.533845960Z INFO Use solver. domain=server type=http-011932host1 # [ 22.049771] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.530524820Z INFO Use solver. domain=host1 type=http-011933server # [ 20.398939] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.533909400Z INFO http01: Trying to solve HTTP-01. domain=server1934host1 # [ 22.052864] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.530597820Z INFO http01: Trying to solve HTTP-01. domain=host11935server # [ 20.419253] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.556711380Z INFO The server validated our request. domain=server1936server # [ 20.422843] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.556860320Z INFO Validations succeeded; requesting certificates. domains=server1937host1 # [ 22.081309] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.562355700Z INFO The server validated our request. domain=host11938host1 # [ 22.083948] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.562488460Z INFO Validations succeeded; requesting certificates. domains=host11939server # [ 20.457025] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.590317680Z INFO Server responded with a certificate. domains=server1940server # [ 20.459647] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.590453380Z INFO Writing file. filepath=certificates/server.crt1941server # [ 20.468958] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.590785480Z INFO Writing file. filepath=certificates/server.issuer.crt1942host1 # [ 22.126979] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.608308060Z INFO Server responded with a certificate. domains=host11943server # [ 20.474078] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.590898020Z INFO Writing file. filepath=certificates/server.key1944server # [ 20.477148] acme-order-renew-server-start[934]: 2026-10-28T10:56:26.591102420Z INFO Writing file. filepath=certificates/server.json1945server # [ 20.479310] acme-order-renew-server-start[924]: + touch out/acme-success1946host1 # [ 22.133670] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.608437120Z INFO Writing file. filepath=certificates/host1.crt1947host1 # [ 22.136639] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.608635140Z INFO Writing file. filepath=certificates/host1.issuer.crt1948server # [ 20.484769] acme-order-renew-server-start[924]: + cmp -s certificates/server.crt out/fullchain.pem1949server # [ 20.486789] acme-order-renew-server-start[924]: + touch out/renewed1950host1 # [ 22.139257] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.608735920Z INFO Writing file. filepath=certificates/host1.key1951server # [ 20.489729] acme-order-renew-server-start[924]: + echo Installing new certificate1952host1 # [ 22.141803] acme-order-renew-host1-start[853]: 2026-10-28T10:56:26.608940120Z INFO Writing file. filepath=certificates/host1.json1953server # [ 20.491113] acme-order-renew-server-start[924]: Installing new certificate1954host1 # [ 22.144969] acme-order-renew-host1-start[844]: + touch out/acme-success1955server # [ 20.492465] acme-order-renew-server-start[924]: + cp -vp certificates/server.crt out/fullchain.pem1956server # [ 20.497813] acme-order-renew-server-start[944]: 'certificates/server.crt' -> 'out/fullchain.pem'1957host1 # [ 22.151327] acme-order-renew-host1-start[844]: + cmp -s certificates/host1.crt out/fullchain.pem1958server # [ 20.499859] acme-order-renew-server-start[924]: + cp -vp certificates/server.key out/key.pem1959server # [ 20.504433] acme-order-renew-server-start[945]: 'certificates/server.key' -> 'out/key.pem'1960host1 # [ 22.157830] acme-order-renew-host1-start[844]: + touch out/renewed1961server # [ 20.506499] acme-order-renew-server-start[924]: + cp -vp certificates/server.issuer.crt out/chain.pem1962host1 # [ 22.163147] acme-order-renew-host1-start[844]: + echo Installing new certificate1963server # [ 20.510908] acme-order-renew-server-start[946]: 'certificates/server.issuer.crt' -> 'out/chain.pem'1964host1 # [ 22.165177] acme-order-renew-host1-start[844]: Installing new certificate1965server # [ 20.512867] acme-order-renew-server-start[924]: + ln -sf fullchain.pem out/cert.pem1966host1 # [ 22.166663] acme-order-renew-host1-start[844]: + cp -vp certificates/host1.crt out/fullchain.pem1967server # [ 20.517238] acme-order-renew-server-start[924]: + cat out/key.pem out/fullchain.pem1968host1 # [ 22.173398] acme-order-renew-host1-start[860]: 'certificates/host1.crt' -> 'out/fullchain.pem'1969server # [ 20.521639] acme-order-renew-server-start[924]: + for fixpath in out certificates1970server # [ 20.522734] acme-order-renew-server-start[924]: + '[' -d out ']'1971host1 # [ 22.176063] acme-order-renew-host1-start[844]: + cp -vp certificates/host1.key out/key.pem1972server # [ 20.523581] acme-order-renew-server-start[924]: + chmod -R u=rwX,g=rX,o= out1973server # [ 20.527585] acme-order-renew-server-start[924]: + chown -R acme:nix-grpc-daemon out1974host1 # [ 22.181730] acme-order-renew-host1-start[861]: 'certificates/host1.key' -> 'out/key.pem'1975host1 # [ 22.184432] acme-order-renew-host1-start[844]: + cp -vp certificates/host1.issuer.crt out/chain.pem1976server # [ 20.533519] acme-order-renew-server-start[924]: + for fixpath in out certificates1977server # [ 20.534587] acme-order-renew-server-start[924]: + '[' -d certificates ']'1978server # [ 20.535506] acme-order-renew-server-start[924]: + chmod -R u=rwX,g=rX,o= certificates1979host1 # [ 22.189709] acme-order-renew-host1-start[862]: 'certificates/host1.issuer.crt' -> 'out/chain.pem'1980host1 # [ 22.192243] acme-order-renew-host1-start[844]: + ln -sf fullchain.pem out/cert.pem1981server # [ 20.539295] acme-order-renew-server-start[924]: + chown -R acme:nix-grpc-daemon certificates1982host1 # [ 22.197447] acme-order-renew-host1-start[844]: + cat out/key.pem out/fullchain.pem1983server # [ 20.544738] acme-order-renew-server-start[924]: + chmod -R u=rwX,g=,o= accounts/.1984host1 # [ 22.202791] acme-order-renew-host1-start[844]: + for fixpath in out certificates1985host1 # [ 22.204304] acme-order-renew-host1-start[844]: + '[' -d out ']'1986host1 # [ 22.205317] acme-order-renew-host1-start[844]: + chmod -R u=rwX,g=rX,o= out1987host1 # [ 22.209905] acme-order-renew-host1-start[844]: + chown -R acme:acme out1988host1 # [ 22.216566] acme-order-renew-host1-start[844]: + for fixpath in out certificates1989host1 # [ 22.217775] acme-order-renew-host1-start[844]: + '[' -d certificates ']'1990host1 # [ 22.218837] acme-order-renew-host1-start[844]: + chmod -R u=rwX,g=rX,o= certificates1991host1 # [ 22.222864] acme-order-renew-host1-start[844]: + chown -R acme:acme certificates1992host1 # [ 22.228587] acme-order-renew-host1-start[844]: + chmod -R u=rwX,g=,o= accounts/.1993server # [ 20.590486] systemd[1]: acme-order-renew-server.service: Deactivated successfully.1994server # [ 20.591628] systemd[1]: Finished Order (and renew) ACME certificate for server.1995server # [ 20.604271] systemd[1]: Startup finished in 2.442s (kernel) + 4.814s (initrd) + 13.346s (userspace) = 20.604s.1996server # [ 20.608112] systemd[1]: acme-order-renew-server.service: Consumed 228ms CPU time over 799ms wall clock time, 56.6M memory peak, 4K written to disk, 10.4K incoming IP traffic, 8.1K outgoing IP traffic.1997host1 # [ 22.270858] systemd[1]: acme-order-renew-host1.service: Deactivated successfully.1998host1 # [ 22.272874] systemd[1]: Finished Order (and renew) ACME certificate for host1.1999host1 # [ 22.275386] systemd[1]: Startup finished in 2.096s (kernel) + 4.282s (initrd) + 15.894s (userspace) = 22.274s.2000host1 # [ 22.278302] systemd[1]: acme-order-renew-host1.service: Consumed 227ms CPU time over 701ms wall clock time, 54.6M memory peak, 4K written to disk, 10.5K incoming IP traffic, 8.2K outgoing IP traffic.2001server: (finished: waiting for unit step-ca.service, in 21.00 seconds)2002server: waiting for unit nix-grpc-daemon.socket2003server: (finished: waiting for unit nix-grpc-daemon.socket, in 0.03 seconds)2004server: waiting for TCP port 50051 on localhost2005server # [ 20.696198] systemd[1]: Starting Order (and renew) ACME certificate for server...2006server # Connection to localhost (127.0.0.1) 50051 port [tcp/*] succeeded!2007server: (finished: waiting for TCP port 50051 on localhost, in 0.04 seconds)20082009running 4 tests2010server # [ 20.751734] acme-order-renew-server-start[976]: Waiting to acquire lock in /run/acme/2011server # [ 20.758975] acme-order-renew-server-start[976]: + set -euo pipefail2012server # [ 20.759968] acme-order-renew-server-start[976]: + exec2013server # [ 20.760996] acme-order-renew-server-start[976]: + /nix/store/vf2h24m5aa7phb4v1kbc2qd9r41jdfqv-flock-0.4.0/bin/flock 112014server # [ 20.765341] acme-order-renew-server-start[984]: ++ find accounts -path '*/keys/*.key' -print -quit2015server # [ 20.771048] acme-order-renew-server-start[976]: + '[' -n '' ']'2016server # [ 20.771977] acme-order-renew-server-start[976]: + exec2017server # [ 20.773098] acme-order-renew-server-start[976]: + '[' -e certificates/server.key ']'2018server # [ 20.774333] acme-order-renew-server-start[976]: + '[' -e certificates/server.crt ']'2019server # [ 20.776624] acme-order-renew-server-start[985]: ++ find accounts -name root@example.org.key2020server # [ 20.782438] acme-order-renew-server-start[976]: + '[' -n accounts/server_8443/root@example.org/root@example.org.key ']'2021server # [ 20.783981] acme-order-renew-server-start[976]: + lego run --accept-tos --path . --email root@example.org --http --http.address :80 --server https://server:8443/acme/acme/directory --key-type ec256 -d server --no-random-sleep --force-cert-domains2022server # [ 20.820590] acme-order-renew-server-start[986]: 2026-10-28T10:56:26.957421540Z INFO Renewing certificate cert-name=server2023server # [ 20.830058] acme-order-renew-server-start[986]: 2026-10-28T10:56:26.968443460Z WARN The server does not advertise a renewal info endpoint. cert-name=server error="renewalInfo[get/post]: server does not advertise a renewal info endpoint"2024server # [ 20.836690] acme-order-renew-server-start[986]: 2026-10-28T10:56:26.971593860Z INFO Skip renewal: The certificate expires at 2026-10-29T10:56:26Z, the renewal can be performed in 11h59m29s28442760ns. cert-name=server2025server # [ 20.840098] acme-order-renew-server-start[976]: + touch out/acme-success2026server # [ 20.846088] acme-order-renew-server-start[976]: + cmp -s certificates/server.crt out/fullchain.pem2027server # [ 20.849845] acme-order-renew-server-start[976]: + for fixpath in out certificates2028server # [ 20.850953] acme-order-renew-server-start[976]: + '[' -d out ']'2029server # [ 20.851811] acme-order-renew-server-start[976]: + chmod -R u=rwX,g=rX,o= out2030server # [ 20.856732] acme-order-renew-server-start[976]: + chown -R acme:nix-grpc-daemon out2031server # [ 20.864424] acme-order-renew-server-start[976]: + for fixpath in out certificates2032server # [ 20.865580] acme-order-renew-server-start[976]: + '[' -d certificates ']'2033server # [ 20.866588] acme-order-renew-server-start[976]: + chmod -R u=rwX,g=rX,o= certificates2034server # [ 20.871720] acme-order-renew-server-start[976]: + chown -R acme:nix-grpc-daemon certificates2035server # [ 20.880385] acme-order-renew-server-start[976]: + chmod -R u=rwX,g=,o= accounts/.2036server # [ 20.931874] systemd[1]: acme-order-renew-server.service: Deactivated successfully.2037server # [ 20.936072] systemd[1]: Finished Order (and renew) ACME certificate for server.2038server # [ 20.937193] systemd[1]: acme-order-renew-server.service: Consumed 146ms CPU time over 239ms wall clock time, 15.8M memory peak, 3.3K incoming IP traffic, 2.2K outgoing IP traffic.2039server # [ 20.947187] systemd[1]: Starting Nix worker-protocol over gRPC...2040server # [ 21.134519] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:27Z level=info event=roles builder=1 scheduler=1 scheduler_addr="" advertise=0.0.0.0:50051 niks3="" max_jobs=12041server # [ 21.156063] nix-grpc-daemon[1007]: WARNING: All log messages before absl::InitializeLog() is called are written to STDERR2042server # [ 21.159717] nix-grpc-daemon[1007]: E0000 00:00:1793184987.293941 1007 tls_security_connector.cc:771] TlsServerCertificateWatcher getting identity_cert_error: UNKNOWN:Unable to get latest identity certificates.2043server # [ 21.165350] nix-grpc-daemon[1007]: E0000 00:00:1793184987.303535 1007 tls_security_connector.cc:767] TlsServerCertificateWatcher getting root_cert_error: UNKNOWN:Unable to get latest root certificates.2044server # [ 21.169093] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:27Z level=info event=startup listen=systemd proxy_socket=/nix/var/nix/daemon-socket/socket2045server # [ 21.175440] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:27Z level=info event=worker_hello addr=0.0.0.0:50051 systems=aarch64-linux max_jobs=1 running=02046server # [ 21.177439] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:27Z level=info event=unhealthy reason=min_free2047server # [ 21.178747] systemd[1]: Started Nix worker-protocol over gRPC.2048host1 # [ 24.084982] systemd[1]: Created slice Slice /system/sshd-vsock.2049host1 # [ 24.088162] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2050host1 # [ 24.094996] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).2051host1 # [ 24.194119] sshd-session[880]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2052host1 # [ 24.200183] sshd-session[880]: Accepted none for root from UNKNOWN port 65535 ssh22053host1 # [ 24.208577] sshd-session[880]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2054host1 # [ 24.240201] systemd[1]: Created slice Slice /user/0.2055host1 # [ 24.244096] systemd[1]: Starting User Runtime Directory /run/user/0...2056host1 # [ 24.275898] systemd-logind[519]: New session '1' of user 'root' with class 'user' and type 'tty'.2057host1 # [ 24.284904] systemd[1]: Finished User Runtime Directory /run/user/0.2058host1 # [ 24.290352] systemd[1]: Starting User Manager for UID 0...2059host1 # [ 24.313457] (systemd)[890]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)2060host1 # [ 24.319374] systemd-logind[519]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.2061host1 # [ 24.407573] systemd[890]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2062host1 # [ 24.545792] systemd[890]: Queued start job for default target Main User Target.2063host1 # [ 24.552935] systemd[890]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2064host1 # [ 24.556818] systemd[890]: Created slice User Application Slice.2065host1 # [ 24.557781] systemd[890]: Started Daily Cleanup of User's Temporary Directories.2066host1 # [ 24.558812] systemd[890]: Reached target Paths.2067host1 # [ 24.559473] systemd[890]: Reached target Timers.2068host1 # [ 24.563497] systemd[890]: Starting D-Bus User Message Bus Socket...2069host1 # [ 24.565679] systemd[890]: Starting Create User Files and Directories...2070host1 # [ 24.608776] systemd[890]: Finished Create User Files and Directories.2071host1 # [ 24.629449] systemd[890]: Listening on D-Bus User Message Bus Socket.2072host1 # [ 24.634027] systemd[890]: Reached target Sockets.2073host1 # [ 24.634786] systemd[890]: Reached target Basic System.2074host1 # [ 24.635533] systemd[890]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system2075host1 # [ 24.637036] systemd[890]: Reached target Main User Target.2076host1 # [ 24.637821] systemd[890]: Startup finished in 296ms.2077host1 # [ 24.638581] systemd[1]: Started User Manager for UID 0.2078host1 # [ 24.641188] systemd[1]: Started Session 1 of User root.2079host1 # [ 24.657318] sshd-session[903]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2080host1 # [ 24.659640] sshd-session[903]: Disconnected from user root UNKNOWN port 655352081host1 # [ 24.661264] sshd-session[880]: pam_unix(sshd:session): session closed for user root2082host1 # [ 24.665887] systemd[1]: sshd-vsock@0-1-3:22-2:0.service: Deactivated successfully.2083host1 # [ 24.669221] systemd[1]: session-1.scope: Deactivated successfully.2084host1 # [ 24.672775] systemd-logind[519]: Session 1 logged out. Waiting for processes to exit.2085host1 # [ 24.682324] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2086host1 # [ 24.683571] systemd-logind[519]: Removed session 1.2087server # [ 23.030284] systemd[1]: Created slice Slice /system/sshd-vsock.2088host1 # [ 24.687513] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).2089server # [ 23.034502] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2090host1 # [ 24.690491] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).2091server # [ 23.040568] systemd[1]: Started SSH per-connection Daemon (vsock:2:0).2092server # [ 23.155279] sshd-session[1020]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2093host1 # [ 24.815662] sshd-session[909]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2094server # [ 23.164135] sshd-session[1020]: Accepted none for root from UNKNOWN port 65535 ssh22095host1 # [ 24.821284] sshd-session[908]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2096server # [ 23.172979] sshd-session[1020]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2097host1 # [ 24.827693] sshd-session[909]: Accepted none for root from UNKNOWN port 65535 ssh22098host1 # [ 24.833461] sshd-session[908]: Accepted none for root from UNKNOWN port 65535 ssh22099host1 # [ 24.841723] sshd-session[909]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2100server # [ 23.190262] systemd[1]: Created slice Slice /user/0.2101host1 # [ 24.846408] sshd-session[908]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2102server # [ 23.193852] systemd[1]: Starting User Runtime Directory /run/user/0...2103host1 # [ 24.853707] systemd-logind[519]: New session '3' of user 'root' with class 'user' and type 'tty'.2104server # [ 23.206708] systemd-logind[539]: New session '1' of user 'root' with class 'user' and type 'tty'.2105host1 # [ 24.864367] systemd[1]: Started Session 3 of User root.2106host1 # [ 24.870709] systemd-logind[519]: New session '4' of user 'root' with class 'user' and type 'tty'.2107host1 # [ 24.876505] systemd[1]: Started Session 4 of User root.2108server # [ 23.234613] systemd[1]: Finished User Runtime Directory /run/user/0.2109server # [ 23.242064] systemd[1]: Starting User Manager for UID 0...2110server # [ 23.266924] (systemd)[1028]: pam_unix(systemd-user:session): session opened for user root(uid=0) by (uid=0)2111server # [ 23.276710] systemd-logind[539]: New session '2' of user 'root' with class 'manager-early' and type 'unspecified'.2112host1 # [ 24.958425] sshd-session[920]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2113host1 # [ 24.961545] sshd-session[921]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2114host1 # [ 24.962874] sshd-session[921]: Disconnected from user root UNKNOWN port 655352115host1 # [ 24.963853] sshd-session[920]: Disconnected from user root UNKNOWN port 655352116host1 # [ 24.965865] sshd-session[909]: pam_unix(sshd:session): session closed for user root2117host1 # [ 24.966947] sshd-session[908]: pam_unix(sshd:session): session closed for user root2118host1 # [ 24.972212] systemd[1]: sshd-vsock@2-3-3:22-2:2.service: Deactivated successfully.2119host1 # [ 24.975938] systemd[1]: sshd-vsock@1-2-3:22-2:1.service: Deactivated successfully.2120host1 # [ 24.980920] systemd[1]: session-4.scope: Deactivated successfully.2121host1 # [ 24.984611] systemd[1]: session-3.scope: Deactivated successfully.2122host1 # [ 24.987224] systemd-logind[519]: Session 3 logged out. Waiting for processes to exit.2123host1 # [ 24.989690] systemd-logind[519]: Removed session 3.2124host1 # [ 24.991958] systemd-logind[519]: Session 4 logged out. Waiting for processes to exit.2125host1 # [ 24.993525] systemd-logind[519]: Removed session 4.2126server # [ 23.387673] systemd[1028]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2127server # [ 23.526668] systemd[1028]: Queued start job for default target Main User Target.2128server # [ 23.533042] systemd[1028]: Failed to adjust io pressure threshold, ignoring: Device or resource busy2129server # [ 23.535647] systemd[1028]: Created slice User Application Slice.2130server # [ 23.537996] systemd[1028]: Started Daily Cleanup of User's Temporary Directories.2131server # [ 23.539101] systemd[1028]: Reached target Paths.2132server # [ 23.539775] systemd[1028]: Reached target Timers.2133server # [ 23.542634] systemd[1028]: Starting D-Bus User Message Bus Socket...2134server # [ 23.545023] systemd[1028]: Starting Create User Files and Directories...2135server # [ 23.582577] systemd[1028]: Finished Create User Files and Directories.2136server # [ 23.596412] systemd[1028]: Listening on D-Bus User Message Bus Socket.2137server # [ 23.599648] systemd[1028]: Reached target Sockets.2138server # [ 23.601579] systemd[1028]: Reached target Basic System.2139server # [ 23.602417] systemd[1028]: Run user-specific NixOS activation skipped, unmet condition check ConditionUser=!@system2140server # [ 23.603850] systemd[1028]: Reached target Main User Target.2141server # [ 23.607112] systemd[1028]: Startup finished in 295ms.2142server # [ 23.607890] systemd[1]: Started User Manager for UID 0.2143server # [ 23.610509] systemd[1]: Started Session 1 of User root.2144server # [ 23.623459] sshd-session[1042]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2145server # [ 23.626337] sshd-session[1042]: Disconnected from user root UNKNOWN port 655352146server # [ 23.627371] sshd-session[1020]: pam_unix(sshd:session): session closed for user root2147server # [ 23.631077] systemd[1]: sshd-vsock@0-1-4:22-2:0.service: Deactivated successfully.2148server # [ 23.635177] systemd[1]: session-1.scope: Deactivated successfully.2149server # [ 23.638859] systemd-logind[539]: Session 1 logged out. Waiting for processes to exit.2150server # [ 23.641160] systemd-logind[539]: Removed session 1.2151server # [ 23.727048] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2152host1 # [ 25.383610] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2153server # [ 23.734499] systemd[1]: Started SSH per-connection Daemon (vsock:2:1).2154host1 # [ 25.392326] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).2155host1 # [ 25.396730] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).2156server # [ 23.827220] sshd-session[1047]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2157server # [ 23.835941] sshd-session[1047]: Accepted none for root from UNKNOWN port 65535 ssh22158server # [ 23.844657] sshd-session[1047]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2159server # [ 23.852625] systemd-logind[539]: New session '3' of user 'root' with class 'user' and type 'tty'.2160server # [ 23.860421] systemd[1]: Started Session 3 of User root.2161host1 # [ 25.543720] sshd-session[931]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2162host1 # [ 25.549069] sshd-session[930]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2163host1 # [ 25.557223] sshd-session[931]: Accepted none for root from UNKNOWN port 65535 ssh22164host1 # [ 25.560284] sshd-session[930]: Accepted none for root from UNKNOWN port 65535 ssh22165host1 # [ 25.571672] sshd-session[930]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2166host1 # [ 25.575662] sshd-session[931]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2167host1 # [ 25.585138] systemd-logind[519]: New session '5' of user 'root' with class 'user' and type 'tty'.2168host1 # [ 25.588410] systemd[1]: Started Session 5 of User root.2169host1 # [ 25.596100] systemd-logind[519]: New session '6' of user 'root' with class 'user' and type 'tty'.2170host1 # [ 25.600295] systemd[1]: Started Session 6 of User root.2171host1 # [ 25.682342] sshd-session[942]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2172host1 # [ 25.685265] sshd-session[942]: Disconnected from user root UNKNOWN port 655352173host1 # [ 25.686605] sshd-session[930]: pam_unix(sshd:session): session closed for user root2174host1 # [ 25.691152] sshd-session[944]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2175host1 # [ 25.694492] sshd-session[944]: Disconnected from user root UNKNOWN port 655352176host1 # [ 25.695514] sshd-session[931]: pam_unix(sshd:session): session closed for user root2177host1 # [ 25.699088] systemd[1]: sshd-vsock@3-4-3:22-2:3.service: Deactivated successfully.2178host1 # [ 25.702283] systemd[1]: session-5.scope: Deactivated successfully.2179host1 # [ 25.706372] systemd-logind[519]: Session 5 logged out. Waiting for processes to exit.2180host1 # [ 25.709888] systemd[1]: sshd-vsock@4-5-3:22-2:4.service: Deactivated successfully.2181host1 # [ 25.713371] systemd[1]: session-6.scope: Deactivated successfully.2182host1 # [ 25.717225] systemd-logind[519]: Removed session 5.2183host1 # [ 25.718707] systemd-logind[519]: Session 6 logged out. Waiting for processes to exit.2184host1 # [ 25.721276] systemd-logind[519]: Removed session 6.2185test acme::host1_obtains_a_certificate_via_acme ... ok2186host1 # [ 25.788886] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2187host1 # [ 25.795600] systemd[1]: Started SSH per-connection Daemon (vsock:2:5).2188host1 # [ 25.885244] sshd-session[952]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2189host1 # [ 25.893412] sshd-session[952]: Accepted none for root from UNKNOWN port 65535 ssh22190host1 # [ 25.901389] sshd-session[952]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2191host1 # [ 25.911260] systemd-logind[519]: New session '7' of user 'root' with class 'user' and type 'tty'.2192host1 # [ 25.916781] systemd[1]: Started Session 7 of User root.2193host1 # [ 25.938676] sshd-session[958]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2194host1 # [ 25.941038] sshd-session[958]: Disconnected from user root UNKNOWN port 655352195host1 # [ 25.942405] sshd-session[952]: pam_unix(sshd:session): session closed for user root2196host1 # [ 25.946811] systemd[1]: sshd-vsock@5-6-3:22-2:5.service: Deactivated successfully.2197host1 # [ 25.951244] systemd[1]: session-7.scope: Deactivated successfully.2198host1 # [ 25.955104] systemd-logind[519]: Session 7 logged out. Waiting for processes to exit.2199host1 # [ 25.957591] systemd-logind[519]: Removed session 7.2200host1 # [ 25.983415] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2201host1 # [ 25.989527] systemd[1]: Started SSH per-connection Daemon (vsock:2:6).2202host1 # [ 26.071608] sshd-session[963]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2203host1 # [ 26.079003] sshd-session[963]: Accepted none for root from UNKNOWN port 65535 ssh22204host1 # [ 26.086380] sshd-session[963]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2205host1 # [ 26.095379] systemd-logind[519]: New session '8' of user 'root' with class 'user' and type 'tty'.2206host1 # [ 26.100401] systemd[1]: Started Session 8 of User root.2207server # [ 24.622036] systemd[1]: Started Nix Daemon.2208server # [ 24.805513] sshd-session[1053]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2209server # [ 24.806876] sshd-session[1053]: Disconnected from user root UNKNOWN port 655352210server # [ 24.809176] sshd-session[1047]: pam_unix(sshd:session): session closed for user root2211server # [ 24.847582] systemd[1]: sshd-vsock@1-2-4:22-2:1.service: Deactivated successfully.2212server # [ 24.852906] systemd[1]: session-3.scope: Deactivated successfully.2213server # [ 24.853839] systemd[1]: session-3.scope: Consumed 333ms CPU time over 986ms wall clock time, 47.5M memory peak, 1.4K outgoing IP traffic.2214server # [ 24.855535] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2215server # [ 24.869504] systemd-logind[539]: Session 3 logged out. Waiting for processes to exit.2216server # [ 24.870647] systemd[1]: Started SSH per-connection Daemon (vsock:2:2).2217server # [ 24.871559] systemd-logind[539]: Removed session 3.2218server # [ 24.904542] nix-daemon[1064]: accepted connection from pid 1007, user nix-grpc-daemon (trusted)2219server # [ 24.922869] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:31Z level=info event=denied method=Connect cn=host1 role=read-only2220host1 # [ 26.612393] sshd-session[969]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2221host1 # [ 26.615226] sshd-session[969]: Disconnected from user root UNKNOWN port 655352222host1 # [ 26.617283] sshd-session[963]: pam_unix(sshd:session): session closed for user root2223server # [ 24.966624] sshd-session[1075]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2224host1 # [ 26.623667] systemd[1]: sshd-vsock@6-7-3:22-2:6.service: Deactivated successfully.2225server # [ 24.972192] sshd-session[1075]: Accepted none for root from UNKNOWN port 65535 ssh22226host1 # [ 26.630832] systemd[1]: session-8.scope: Deactivated successfully.2227server # [ 24.979967] sshd-session[1075]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2228host1 # [ 26.633210] systemd[1]: session-8.scope: Consumed 165ms CPU time over 532ms wall clock time, 37.1M memory peak, 5.2K incoming IP traffic, 4K outgoing IP traffic.2229server # [ 24.988130] systemd-logind[539]: New session '4' of user 'root' with class 'user' and type 'tty'.2230host1 # [ 26.641886] systemd-logind[519]: Session 8 logged out. Waiting for processes to exit.2231host1 # [ 26.643723] systemd-logind[519]: Removed session 8.2232server # [ 24.994781] systemd[1]: Started Session 4 of User root.2233server # [ 25.041747] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2234server # [ 25.047492] systemd[1]: Started SSH per-connection Daemon (vsock:2:3).2235server # [ 25.202532] sshd-session[1083]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2236server # [ 25.203909] sshd-session[1083]: Disconnected from user root UNKNOWN port 655352237server # [ 25.206299] sshd-session[1075]: pam_unix(sshd:session): session closed for user root2238server # [ 25.211671] systemd[1]: sshd-vsock@2-3-4:22-2:2.service: Deactivated successfully.2239server # [ 25.217469] systemd[1]: session-4.scope: Deactivated successfully.2240server # [ 25.222081] systemd-logind[539]: Session 4 logged out. Waiting for processes to exit.2241server # [ 25.225977] systemd-logind[539]: Removed session 4.2242server # [ 25.233239] sshd-session[1086]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2243server # [ 25.241770] sshd-session[1086]: Accepted none for root from UNKNOWN port 65535 ssh22244server # [ 25.251562] sshd-session[1086]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2245server # [ 25.261299] systemd-logind[539]: New session '5' of user 'root' with class 'user' and type 'tty'.2246server # [ 25.273187] systemd[1]: Started Session 5 of User root.2247server # [ 25.297290] sshd-session[1096]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2248server # [ 25.299877] sshd-session[1096]: Disconnected from user root UNKNOWN port 655352249server # [ 25.301570] sshd-session[1086]: pam_unix(sshd:session): session closed for user root2250test acme::a_read_only_host_cannot_write ... ok2251server # [ 25.312383] systemd[1]: sshd-vsock@3-4-4:22-2:3.service: Deactivated successfully.2252server # [ 25.314616] systemd[1]: session-5.scope: Deactivated successfully.2253server # [ 25.320251] systemd-logind[539]: Session 5 logged out. Waiting for processes to exit.2254server # [ 25.325485] systemd-logind[539]: Removed session 5.2255host1 # [ 27.057637] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2256server # [ 25.405219] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2257host1 # [ 27.064801] systemd[1]: Started SSH per-connection Daemon (vsock:2:7).2258server # [ 25.413541] systemd[1]: Started SSH per-connection Daemon (vsock:2:4).2259host1 # [ 27.154527] sshd-session[984]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2260server # [ 25.505865] sshd-session[1101]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2261host1 # [ 27.163793] sshd-session[984]: Accepted none for root from UNKNOWN port 65535 ssh22262server # [ 25.514079] sshd-session[1101]: Accepted none for root from UNKNOWN port 65535 ssh22263host1 # [ 27.172379] sshd-session[984]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2264server # [ 25.522483] sshd-session[1101]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2265host1 # [ 27.182594] systemd-logind[519]: New session '9' of user 'root' with class 'user' and type 'tty'.2266server # [ 25.530524] systemd-logind[539]: New session '6' of user 'root' with class 'user' and type 'tty'.2267host1 # [ 27.188950] systemd[1]: Started Session 9 of User root.2268server # [ 25.537240] systemd[1]: Started Session 6 of User root.2269host1 # [ 27.206160] sshd-session[990]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2270host1 # [ 27.208593] sshd-session[990]: Disconnected from user root UNKNOWN port 655352271host1 # [ 27.210474] sshd-session[984]: pam_unix(sshd:session): session closed for user root2272host1 # [ 27.214395] systemd[1]: sshd-vsock@7-8-3:22-2:7.service: Deactivated successfully.2273host1 # [ 27.219063] systemd[1]: session-9.scope: Deactivated successfully.2274host1 # [ 27.223106] systemd-logind[519]: Session 9 logged out. Waiting for processes to exit.2275host1 # [ 27.225405] systemd-logind[519]: Removed session 9.2276host1 # [ 27.287556] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2277host1 # [ 27.295455] systemd[1]: Started SSH per-connection Daemon (vsock:2:8).2278server # [ 25.664533] sshd-session[1107]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2279server # [ 25.665894] sshd-session[1107]: Disconnected from user root UNKNOWN port 655352280server # [ 25.667693] sshd-session[1101]: pam_unix(sshd:session): session closed for user root2281server # [ 25.671912] systemd[1]: sshd-vsock@4-5-4:22-2:4.service: Deactivated successfully.2282server # [ 25.676508] systemd[1]: session-6.scope: Deactivated successfully.2283server # [ 25.679991] systemd-logind[539]: Session 6 logged out. Waiting for processes to exit.2284server # [ 25.682554] systemd-logind[539]: Removed session 6.2285test acme::server_builds_and_signs_a_path ... ok2286host1 # [ 27.399836] sshd-session[995]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2287host1 # [ 27.411495] sshd-session[995]: Accepted none for root from UNKNOWN port 65535 ssh22288host1 # [ 27.425662] sshd-session[995]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2289host1 # [ 27.432888] systemd-logind[519]: New session '10' of user 'root' with class 'user' and type 'tty'.2290host1 # [ 27.440430] systemd[1]: Started Session 10 of User root.2291server # [ 26.660530] nix-grpc-daemon[1007]: ts=2026-10-28T10:56:32Z level=info event=rpc method=FetchNars cn=host1 peer=ipv4:192.168.1.1:54158 duration_s=0 paths=1 nar_bytes_out=1282292host1 # [ 28.347788] sshd-session[1002]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2293host1 # [ 28.351271] sshd-session[1002]: Disconnected from user root UNKNOWN port 655352294host1 # [ 28.353661] sshd-session[995]: pam_unix(sshd:session): session closed for user root2295host1 # [ 28.360785] systemd[1]: sshd-vsock@8-9-3:22-2:8.service: Deactivated successfully.2296host1 # [ 28.367874] systemd[1]: session-10.scope: Deactivated successfully.2297host1 # [ 28.370413] systemd[1]: session-10.scope: Consumed 177ms CPU time over 929ms wall clock time, 42.6M memory peak, 10.1K incoming IP traffic, 9.2K outgoing IP traffic.2298host1 # [ 28.377998] systemd-logind[519]: Session 10 logged out. Waiting for processes to exit.2299host1 # [ 28.379423] systemd-logind[519]: Removed session 10.2300host1 # [ 28.392162] systemd[1]: SSH Host Keys Generation skipped, no trigger condition checks were met.2301host1 # [ 28.398564] systemd[1]: Started SSH per-connection Daemon (vsock:2:9).2302host1 # [ 28.487068] sshd-session[1022]: pam_unix(sshd:auth): user [root] has blank password; authenticated without it2303host1 # [ 28.494507] sshd-session[1022]: Accepted none for root from UNKNOWN port 65535 ssh22304host1 # [ 28.502984] sshd-session[1022]: pam_unix(sshd:session): session opened for user root(uid=0) by (uid=0)2305host1 # [ 28.512157] systemd-logind[519]: New session '11' of user 'root' with class 'user' and type 'tty'.2306host1 # [ 28.520438] systemd[1]: Started Session 11 of User root.2307host1 # [ 28.543462] sshd-session[1028]: Received disconnect from UNKNOWN port 65535:11: disconnected by user2308host1 # [ 28.545056] sshd-session[1028]: Disconnected from user root UNKNOWN port 655352309host1 # [ 28.546549] sshd-session[1022]: pam_unix(sshd:session): session closed for user root2310host1 # [ 28.550485] systemd[1]: sshd-vsock@9-10-3:22-2:9.service: Deactivated successfully.2311host1 # [ 28.555956] systemd[1]: session-11.scope: Deactivated successfully.2312host1 # [ 28.559986] systemd-logind[519]: Session 11 logged out. Waiting for processes to exit.2313host1 # [ 28.562640] systemd-logind[519]: Removed session 11.2314test acme::host1_substitutes_the_signed_path_with_a_read_only_cert ... ok23152316test result: ok. 4 passed; 0 failed; 0 ignored; 0 measured; 54 filtered out; finished in 6.21s23172318(finished: run the VM test script, in 33.38 seconds)2319test script finished in 33.51s2320cleanup2321kill QemuMachine (pid 52)2322host1 # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2323host1 # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2324host1 # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2325host1 # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2326kill QemuMachine (pid 55)2327server # qemu-system-aarch64: terminating on signal 15 from pid 39 (/nix/store/81ag9nxz1flw3xjkv1vvqg8y2ipx2ins-python3-3.14.7/bin/python3.14)2328server # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2329server # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2330server # [2026-10-28T10:56:33Z INFO virtiofsd] Client disconnected, shutting down2331(finished: cleanup, in 0.46 seconds)2332SSH backdoor enabled, the machines can be accessed like this:2333Note: this requires systemd-ssh-proxy(1) to be enabled (default on NixOS 25.05 and newer).2334 host1: ssh -o User=root vsock-mux//build/tmptqnwa8k7/host1_host.socket2335 server: ssh -o User=root vsock-mux//build/tmptqnwa8k7/server_host.socket2336additionally exposed symbols:2337 host1, server,2338 vlan1,2339 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