vm-test-run-nixos-test-niks3
aarch64-linux.nixos-test-niks3-lix
· build #78
· raw
1tribuchet: building on eliza2Machine state will be reset. To keep it, pass --keep-machine-state3start all VLans4(finished: start all VLans, in 0.00 seconds)5Test will time out and terminate in 3600 seconds6run the VM test script7start all VMs8builder: starting vm9server: starting vm10builder # Disk image does not exist, creating the virtualisation disk image...11builder: QEMU running (pid 15)12builder # Formatting '/build/vm-state-builder/tmp.NrnzfBySzA', fmt=raw size=107374182413builder # mke2fs 1.47.4 (6-Mar-2025)14builder # Discarding device blocks: 0/262144 done15builder # Creating filesystem with 262144 4k blocks and 65536 inodes16builder # Filesystem UUID: 25612b7c-0147-44bf-ab1e-170633e4199617builder # Superblock backups stored on blocks:18builder # 32768, 98304, 163840, 22937619builder # 20builder # Allocating group tables: 0/8 done21builder # Writing inode tables: 0/8 done22builder # Creating journal (8192 blocks): done23builder # Writing superblocks and filesystem accounting information: 0/8 done24builder # 25builder # Virtualisation disk image created.26server: QEMU running (pid 14)27server # Disk image does not exist, creating the virtualisation disk image...28server # Formatting '/build/vm-state-server/tmp.hMjurpHpYI', fmt=raw size=107374182429server # mke2fs 1.47.4 (6-Mar-2025)30server # Discarding device blocks: 0/262144 done31(finished: start all VMs, in 0.52 seconds)32server # Creating filesystem with 262144 4k blocks and 65536 inodes33server: waiting for unit postgresql.service34server # Filesystem UUID: 4bbfb231-5630-4a95-ad3b-cda5a030c16735server: waiting for the VM to finish booting36server # Superblock backups stored on blocks:37server # 32768, 98304, 163840, 22937638server # 39server # Allocating group tables: 0/8 done40server # Writing inode tables: 0/8 done41server # Creating journal (8192 blocks): done42server # Writing superblocks and filesystem accounting information: 0/8 done43server # 44server # Virtualisation disk image created.45builder # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]46builder # [ 0.000000] Linux version 6.18.37 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Jun 27 10:06:50 UTC 202647builder # [ 0.000000] KASLR enabled48builder # [ 0.000000] random: crng init done49builder # [ 0.000000] Machine model: linux,dummy-virt50builder # [ 0.000000] efi: UEFI not found.51builder # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT52builder # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]53builder # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]54builder # [ 0.000000] Zone ranges:55builder # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]56builder # [ 0.000000] DMA32 empty57builder # [ 0.000000] Normal empty58builder # [ 0.000000] Device empty59builder # [ 0.000000] Movable zone start for each node60builder # [ 0.000000] Early memory node ranges61builder # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]62builder # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]63builder # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000064builder # [ 0.000000] psci: probing for conduit method from DT.65builder # [ 0.000000] psci: PSCIv1.3 detected in firmware.66builder # [ 0.000000] psci: Using standard PSCI v0.2 function IDs67builder # [ 0.000000] psci: Trusted OS migration not required68builder # [ 0.000000] psci: SMC Calling Convention v1.169builder # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)70builder # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u31129671builder # [ 0.000000] Detected PIPT I-cache on CPU072builder # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)73builder # [ 0.000000] CPU features: detected: GICv3 CPU interface74builder # [ 0.000000] CPU features: detected: Spectre-v475builder # [ 0.000000] CPU features: detected: Spectre-BHB76builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3877builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2378builder # [ 0.000000] alternatives: applying boot alternatives79builder # [ 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/x42dqidsd2n71lx3g4ydihgmkxrs1v5l-nixos-system-builder-test/init regInfo=/nix/store/6vvmxc9pmxhb2wxcdf38mj8sqrr5g15d-closure-info/registration console=ttyAMA0,115200n8 console=tty080builder # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/6vvmxc9pmxhb2wxcdf38mj8sqrr5g15d-closure-info/registration", will be passed to user space.81builder # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes82builder # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)83builder # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)84builder # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB85builder # [ 0.000000] software IO TLB: area num 1.86builder # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)87builder # [ 0.000000] Fallback order for Node 0: 088builder # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 26214489builder # [ 0.000000] Policy zone: DMA90builder # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off91server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]92builder # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=193builder # [ 0.000000] allocated 2097152 bytes of page_ext94builder # [ 0.000000] ftrace: allocating 74702 entries in 292 pages95server # [ 0.000000] Linux version 6.18.37 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Sat Jun 27 10:06:50 UTC 202696server # [ 0.000000] KASLR enabled97builder # [ 0.000000] ftrace: allocated 292 pages with 3 groups98server # [ 0.000000] random: crng init done99builder # [ 0.000000] rcu: Hierarchical RCU implementation.100server # [ 0.000000] Machine model: linux,dummy-virt101builder # [ 0.000000] rcu: RCU event tracing is enabled.102server # [ 0.000000] efi: UEFI not found.103builder # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.104server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT105builder # [ 0.000000] Trampoline variant of Tasks RCU enabled.106server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]107builder # [ 0.000000] Rude variant of Tasks RCU enabled.108builder # [ 0.000000] Tracing variant of Tasks RCU enabled.109server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]110server # [ 0.000000] Zone ranges:111builder # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.112server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]113server # [ 0.000000] DMA32 empty114builder # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1115server # [ 0.000000] Normal empty116server # [ 0.000000] Device empty117server # [ 0.000000] Movable zone start for each node118builder # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.119server # [ 0.000000] Early memory node ranges120builder # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.121server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]122server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]123builder # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.124server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000125builder # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0126builder # [ 0.000000] GICv3: 256 SPIs implemented127server # [ 0.000000] psci: probing for conduit method from DT.128builder # [ 0.000000] GICv3: 0 Extended SPIs implemented129server # [ 0.000000] psci: PSCIv1.3 detected in firmware.130builder # [ 0.000000] Root IRQ handler: gic_handle_irq131server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs132builder # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI133server # [ 0.000000] psci: Trusted OS migration not required134builder # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0135server # [ 0.000000] psci: SMC Calling Convention v1.1136builder # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000137server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)138builder # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]139server # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296140builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)141server # [ 0.000000] Detected PIPT I-cache on CPU0142server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)143builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)144server # [ 0.000000] CPU features: detected: GICv3 CPU interface145builder # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000146server # [ 0.000000] CPU features: detected: Spectre-v4147builder # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000148server # [ 0.000000] CPU features: detected: Spectre-BHB149builder # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.150server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38151builder # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).152server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23153server # [ 0.000000] alternatives: applying boot alternatives154builder # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns155builder # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns156builder # [ 0.000031] arm-pv: using stolen time PV157builder # [ 0.000444] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)158builder # [ 0.000635] Console: colour dummy device 80x25159server # [ 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/f5ckqn8y27dcnd2sizyif0s1akffmjvb-nixos-system-server-test/init regInfo=/nix/store/91vqs3gdgqwwxc3bc6k27qd0rqnhkm2g-closure-info/registration console=ttyAMA0,115200n8 console=tty0160builder # [ 0.000643] printk: legacy console [tty0] enabled161builder # [ 0.000831] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)162server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/91vqs3gdgqwwxc3bc6k27qd0rqnhkm2g-closure-info/registration", will be passed to user space.163builder # [ 0.000838] pid_max: default: 32768 minimum: 301164server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes165builder # [ 0.000931] LSM: initializing lsm=capability,landlock,yama,bpf,ima166builder # [ 0.001117] landlock: Up and running.167server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)168builder # [ 0.001120] Yama: becoming mindful.169builder # [ 0.001590] LSM support for eBPF active170server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)171builder # [ 0.001690] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)172server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB173server # [ 0.000000] software IO TLB: area num 1.174builder # [ 0.001710] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)175server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)176builder # [ 0.002782] cacheinfo: Unable to detect cache hierarchy for CPU 0177server # [ 0.000000] Fallback order for Node 0: 0178builder # [ 0.003522] rcu: Hierarchical SRCU implementation.179server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144180builder # [ 0.003527] rcu: Max phase no-delay instances is 1000.181server # [ 0.000000] Policy zone: DMA182builder # [ 0.004768] fsl-mc MSI: its@8080000 domain created183builder # [ 0.004860] EFI services will not be available.184server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off185builder # [ 0.004928] smp: Bringing up secondary CPUs ...186server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1187builder # [ 0.004936] smp: Brought up 1 node, 1 CPU188server # [ 0.000000] allocated 2097152 bytes of page_ext189builder # [ 0.004939] SMP: Total of 1 processors activated.190server # [ 0.000000] ftrace: allocating 74702 entries in 292 pages191builder # [ 0.004942] CPU: All CPU(s) started at EL1192server # [ 0.000000] ftrace: allocated 292 pages with 3 groups193builder # [ 0.004953] CPU features: detected: Branch Target Identification194server # [ 0.000000] rcu: Hierarchical RCU implementation.195builder # [ 0.004958] CPU features: detected: ARMv8.4 Translation Table Level196server # [ 0.000000] rcu: RCU event tracing is enabled.197builder # [ 0.004964] CPU features: detected: Instruction cache invalidation not required for I/D coherence198server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.199server # [ 0.000000] Trampoline variant of Tasks RCU enabled.200builder # [ 0.004967] CPU features: detected: Data cache clean to the PoU not required for I/D coherence201server # [ 0.000000] Rude variant of Tasks RCU enabled.202builder # [ 0.004971] CPU features: detected: Common not Private translations203server # [ 0.000000] Tracing variant of Tasks RCU enabled.204builder # [ 0.004974] CPU features: detected: CRC32 instructions205server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.206builder # [ 0.004977] CPU features: detected: Data cache clean to Point of Deep Persistence207server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1208builder # [ 0.004981] CPU features: detected: Data cache clean to Point of Persistence209server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.210builder # [ 0.004984] CPU features: detected: Data independent timing control (DIT)211builder # [ 0.004987] CPU features: detected: E0PD212server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.213builder # [ 0.004990] CPU features: detected: Enhanced Counter Virtualization214server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.215builder # [ 0.004993] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)216server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0217builder # [ 0.004997] CPU features: detected: Enhanced Virtualization Traps218server # [ 0.000000] GICv3: 256 SPIs implemented219builder # [ 0.005000] CPU features: detected: Fine Grained Traps220server # [ 0.000000] GICv3: 0 Extended SPIs implemented221server # [ 0.000000] Root IRQ handler: gic_handle_irq222builder # [ 0.005004] CPU features: detected: Generic authentication (architected QARMA5 algorithm)223server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI224builder # [ 0.005010] CPU features: detected: RCpc load-acquire (LDAPR)225server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0226builder # [ 0.005013] CPU features: detected: LSE atomic instructions227server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000228builder # [ 0.005016] CPU features: detected: Privileged Access Never229server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]230builder # [ 0.005019] CPU features: detected: PMUv3231builder # [ 0.005021] CPU features: detected: RAS Extension Support232server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)233builder # [ 0.005024] CPU features: detected: RASv1p1 Extension Support234builder # [ 0.005027] CPU features: detected: Random Number Generator235server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)236builder # [ 0.005029] CPU features: detected: Speculation barrier (SB)237server # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000238builder # [ 0.005032] CPU features: detected: Stage-2 Force Write-Back239server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000240builder # [ 0.005035] CPU features: detected: TLB range maintenance instructions241server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.242builder # [ 0.005041] CPU features: detected: Speculative Store Bypassing Safe (SSBS)243server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).244builder # [ 0.005080] alternatives: applying system-wide alternatives245builder # [ 0.008086] CPU features: detected: BBM Level 2 without TLB conflict abort246server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns247server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns248builder # [ 0.008309] Memory: 895036K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)249server # [ 0.000033] arm-pv: using stolen time PV250builder # [ 0.008663] devtmpfs: initialized251server # [ 0.000413] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)252server # [ 0.000586] Console: colour dummy device 80x25253builder # [ 0.010383] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns254server # [ 0.000593] printk: legacy console [tty0] enabled255builder # [ 0.010409] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)256builder # [ 0.010431] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).257server # [ 0.000771] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)258server # [ 0.000778] pid_max: default: 32768 minimum: 301259builder # [ 0.010605] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL260builder # [ 0.010610] 0 pages in range for non-PLT usage261server # [ 0.000864] LSM: initializing lsm=capability,landlock,yama,bpf,ima262server # [ 0.001004] landlock: Up and running.263builder # [ 0.010611] 508320 pages in range for PLT usage264server # [ 0.001007] Yama: becoming mindful.265builder # [ 0.010719] pinctrl core: initialized pinctrl subsystem266server # [ 0.001441] LSM support for eBPF active267builder # [ 0.011555] DMI not present or invalid.268server # [ 0.001538] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)269builder # [ 0.014874] NET: Registered PF_NETLINK/PF_ROUTE protocol family270builder # [ 0.017149] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations271server # [ 0.001557] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)272server # [ 0.002625] cacheinfo: Unable to detect cache hierarchy for CPU 0273builder # [ 0.017303] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations274server # [ 0.003346] rcu: Hierarchical SRCU implementation.275server # [ 0.003350] rcu: Max phase no-delay instances is 1000.276server # [ 0.004552] fsl-mc MSI: its@8080000 domain created277server # [ 0.004638] EFI services will not be available.278server # [ 0.004726] smp: Bringing up secondary CPUs ...279server # [ 0.004734] smp: Brought up 1 node, 1 CPU280server # [ 0.004737] SMP: Total of 1 processors activated.281server # [ 0.004740] CPU: All CPU(s) started at EL1282server # [ 0.004750] CPU features: detected: Branch Target Identification283server # [ 0.004755] CPU features: detected: ARMv8.4 Translation Table Level284server # [ 0.004760] CPU features: detected: Instruction cache invalidation not required for I/D coherence285server # [ 0.004764] CPU features: detected: Data cache clean to the PoU not required for I/D coherence286server # [ 0.004767] CPU features: detected: Common not Private translations287builder # [ 0.017464] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations288server # [ 0.004770] CPU features: detected: CRC32 instructions289builder # [ 0.017489] audit: initializing netlink subsys (disabled)290builder # [ 0.018066] thermal_sys: Registered thermal governor 'fair_share'291server # [ 0.004773] CPU features: detected: Data cache clean to Point of Deep Persistence292builder # [ 0.018068] thermal_sys: Registered thermal governor 'bang_bang'293server # [ 0.004776] CPU features: detected: Data cache clean to Point of Persistence294builder # [ 0.018072] thermal_sys: Registered thermal governor 'step_wise'295server # [ 0.004779] CPU features: detected: Data independent timing control (DIT)296builder # [ 0.018075] thermal_sys: Registered thermal governor 'user_space'297server # [ 0.004782] CPU features: detected: E0PD298builder # [ 0.018078] thermal_sys: Registered thermal governor 'power_allocator'299server # [ 0.004785] CPU features: detected: Enhanced Counter Virtualization300builder # [ 0.018105] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1301server # [ 0.004788] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)302builder # [ 0.018114] cpuidle: using governor ladder303server # [ 0.004791] CPU features: detected: Enhanced Virtualization Traps304builder # [ 0.018120] cpuidle: using governor menu305server # [ 0.004794] CPU features: detected: Fine Grained Traps306builder # [ 0.018319] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.307builder # [ 0.018335] ASID allocator initialised with 65536 entries308server # [ 0.004797] CPU features: detected: Generic authentication (architected QARMA5 algorithm)309builder # [ 0.019540] Serial: AMBA PL011 UART driver310server # [ 0.004802] CPU features: detected: RCpc load-acquire (LDAPR)311server # [ 0.004805] CPU features: detected: LSE atomic instructions312builder # [ 0.024814] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1313builder # [ 0.024937] printk: console [ttyAMA0] enabled314server # [ 0.004808] CPU features: detected: Privileged Access Never315server # [ 0.004810] CPU features: detected: PMUv3316server # [ 0.004813] CPU features: detected: RAS Extension Support317builder # [ 0.149885] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages318server # [ 0.004815] CPU features: detected: RASv1p1 Extension Support319builder # [ 0.149905] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page320server # [ 0.004818] CPU features: detected: Random Number Generator321builder # [ 0.149911] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages322builder # [ 0.149915] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page323server # [ 0.004820] CPU features: detected: Speculation barrier (SB)324builder # [ 0.149920] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages325server # [ 0.004823] CPU features: detected: Stage-2 Force Write-Back326builder # [ 0.149924] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page327server # [ 0.004826] CPU features: detected: TLB range maintenance instructions328builder # [ 0.149928] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages329server # [ 0.004830] CPU features: detected: Speculative Store Bypassing Safe (SSBS)330builder # [ 0.149933] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page331server # [ 0.004865] alternatives: applying system-wide alternatives332server # [ 0.007733] CPU features: detected: BBM Level 2 without TLB conflict abort333builder # [ 0.157459] fbcon: Taking over console334builder # [ 0.157472] ACPI: Interpreter disabled.335server # [ 0.007917] Memory: 895048K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)336server # [ 0.008256] devtmpfs: initialized337builder # [ 0.159311] iommu: Default domain type: Translated338builder # [ 0.159321] iommu: DMA domain TLB invalidation policy: strict mode339server # [ 0.009892] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns340builder # [ 0.161046] SCSI subsystem initialized341server # [ 0.009914] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)342server # [ 0.009934] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).343server # [ 0.010118] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL344server # [ 0.010122] 0 pages in range for non-PLT usage345server # [ 0.010123] 508320 pages in range for PLT usage346server # [ 0.010239] pinctrl core: initialized pinctrl subsystem347server # [ 0.011057] DMI not present or invalid.348server # [ 0.014075] NET: Registered PF_NETLINK/PF_ROUTE protocol family349server # [ 0.016568] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations350server # [ 0.016725] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations351builder # [ 0.168116] usbcore: registered new interface driver usbfs352server # [ 0.016882] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations353builder # [ 0.168154] usbcore: registered new interface driver hub354server # [ 0.016903] audit: initializing netlink subsys (disabled)355builder # [ 0.168176] usbcore: registered new device driver usb356server # [ 0.017409] thermal_sys: Registered thermal governor 'fair_share'357builder # [ 0.168418] pps_core: LinuxPPS API ver. 1 registered358server # [ 0.017410] thermal_sys: Registered thermal governor 'bang_bang'359server # [ 0.017414] thermal_sys: Registered thermal governor 'step_wise'360builder # [ 0.168424] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>361builder # [ 0.168434] PTP clock support registered362server # [ 0.017416] thermal_sys: Registered thermal governor 'user_space'363builder # [ 0.168480] EDAC MC: Ver: 3.0.0364server # [ 0.017419] thermal_sys: Registered thermal governor 'power_allocator'365builder # [ 0.173212] scmi_core: SCMI protocol bus registered366server # [ 0.017443] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1367builder # [ 0.174189] FPGA manager framework368server # [ 0.017453] cpuidle: using governor ladder369builder # [ 0.175119] vgaarb: loaded370server # [ 0.017458] cpuidle: using governor menu371server # [ 0.017651] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.372builder # [ 0.175740] clocksource: Switched to clocksource arch_sys_counter373server # [ 0.017666] ASID allocator initialised with 65536 entries374builder # [ 0.176168] VFS: Disk quotas dquot_6.6.0375server # [ 0.018774] Serial: AMBA PL011 UART driver376builder # [ 0.176193] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)377server # [ 0.023916] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1378builder # [ 0.178552] netfs: FS-Cache loaded379server # [ 0.024072] printk: console [ttyAMA0] enabled380builder # [ 0.178673] pnp: PnP ACPI: disabled381server # [ 0.151072] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages382builder # [ 0.184683] NET: Registered PF_INET protocol family383server # [ 0.151090] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page384builder # [ 0.184837] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)385server # [ 0.151095] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages386server # [ 0.151099] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page387server # [ 0.151104] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages388server # [ 0.151108] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page389server # [ 0.151112] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages390server # [ 0.151116] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page391server # [ 0.158795] fbcon: Taking over console392server # [ 0.158809] ACPI: Interpreter disabled.393server # [ 0.160670] iommu: Default domain type: Translated394server # [ 0.160680] iommu: DMA domain TLB invalidation policy: strict mode395server # [ 0.162384] SCSI subsystem initialized396server # [ 0.167643] usbcore: registered new interface driver usbfs397server # [ 0.167673] usbcore: registered new interface driver hub398server # [ 0.167689] usbcore: registered new device driver usb399server # [ 0.167932] pps_core: LinuxPPS API ver. 1 registered400server # [ 0.167938] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>401server # [ 0.167947] PTP clock support registered402server # [ 0.167999] EDAC MC: Ver: 3.0.0403server # [ 0.172755] scmi_core: SCMI protocol bus registered404server # [ 0.173730] FPGA manager framework405server # [ 0.174686] vgaarb: loaded406server # [ 0.175328] clocksource: Switched to clocksource arch_sys_counter407server # [ 0.175761] VFS: Disk quotas dquot_6.6.0408server # [ 0.175793] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)409server # [ 0.178257] netfs: FS-Cache loaded410server # [ 0.178364] pnp: PnP ACPI: disabled411builder # [ 0.213546] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)412builder # [ 0.213585] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)413builder # [ 0.213609] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)414builder # [ 0.213653] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)415server # [ 0.186928] NET: Registered PF_INET protocol family416builder # [ 0.213729] TCP: Hash tables configured (established 8192 bind 8192)417server # [ 0.187083] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)418builder # [ 0.213802] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)419builder # [ 0.213853] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)420builder # [ 0.213900] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)421builder # [ 0.214011] NET: Registered PF_UNIX/PF_LOCAL protocol family422builder # [ 0.214032] NET: Registered PF_XDP protocol family423builder # [ 0.214048] PCI: CLS 0 bytes, default 64424builder # [ 0.214277] Trying to unpack rootfs image as initramfs...425builder # [ 0.229463] kvm [1]: HYP mode not available426server # [ 0.216018] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)427server # [ 0.216057] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)428server # [ 0.216079] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)429server # [ 0.216124] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)430server # [ 0.216200] TCP: Hash tables configured (established 8192 bind 8192)431server # [ 0.216296] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)432server # [ 0.216362] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)433server # [ 0.216409] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)434server # [ 0.216486] NET: Registered PF_UNIX/PF_LOCAL protocol family435server # [ 0.216520] NET: Registered PF_XDP protocol family436server # [ 0.216539] PCI: CLS 0 bytes, default 64437server # [ 0.226009] Trying to unpack rootfs image as initramfs...438server # [ 0.232043] kvm [1]: HYP mode not available439builder # [ 0.320242] Initialise system trusted keyrings440builder # [ 0.320974] workingset: timestamp_bits=42 max_order=18 bucket_order=0441builder # [ 0.322266] squashfs: version 4.0 (2009/01/31) Phillip Lougher442builder # [ 0.323049] 9p: Installing v9fs 9p2000 file system support443builder # [ 0.343620] Key type asymmetric registered444builder # [ 0.343635] Asymmetric key parser 'x509' registered445builder # [ 0.343696] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)446builder # [ 0.351810] io scheduler mq-deadline registered447builder # [ 0.351831] io scheduler kyber registered448server # [ 0.317223] Initialise system trusted keyrings449server # [ 0.317971] workingset: timestamp_bits=42 max_order=18 bucket_order=0450server # [ 0.323720] squashfs: version 4.0 (2009/01/31) Phillip Lougher451builder # [ 0.359910] pl061_gpio 9030000.pl061: PL061 GPIO chip registered452server # [ 0.324545] 9p: Installing v9fs 9p2000 file system support453builder # [ 0.361266] ledtrig-cpu: registered to indicate activity on CPUs454builder # [ 0.361637] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:455builder # [ 0.361653] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000456builder # [ 0.361668] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000457builder # [ 0.361677] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000458builder # [ 0.361698] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits459builder # [ 0.361720] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]460builder # [ 0.361794] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00461builder # [ 0.361804] pci_bus 0000:00: root bus resource [bus 00-ff]462builder # [ 0.361810] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]463builder # [ 0.361816] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]464builder # [ 0.361821] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]465builder # [ 0.361875] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint466builder # [ 0.362310] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint467builder # [ 0.362493] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]468builder # [ 0.362509] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]469builder # [ 0.362539] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]470builder # [ 0.362556] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]471builder # [ 0.362996] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint472builder # [ 0.363188] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]473builder # [ 0.363204] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]474builder # [ 0.363233] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475builder # [ 0.363689] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint476server # [ 0.348428] Key type asymmetric registered477server # [ 0.348445] Asymmetric key parser 'x509' registered478server # [ 0.348494] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)479server # [ 0.350622] io scheduler mq-deadline registered480server # [ 0.350633] io scheduler kyber registered481builder # [ 0.391950] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]482builder # [ 0.391980] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]483builder # [ 0.392010] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]484builder # [ 0.392508] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint485builder # [ 0.392692] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]486builder # [ 0.392709] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]487builder # [ 0.392738] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]488builder # [ 0.393190] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint489builder # [ 0.393377] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]490builder # [ 0.393393] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]491server # [ 0.363475] pl061_gpio 9030000.pl061: PL061 GPIO chip registered492builder # [ 0.393423] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]493server # [ 0.364079] ledtrig-cpu: registered to indicate activity on CPUs494builder # [ 0.393876] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint495server # [ 0.364420] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:496builder # [ 0.394056] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]497builder # [ 0.394072] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]498server # [ 0.364436] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000499builder # [ 0.394102] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]500server # [ 0.364463] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000501builder # [ 0.394576] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint502server # [ 0.364472] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000503builder # [ 0.394761] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]504builder # [ 0.394778] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]505server # [ 0.364502] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits506builder # [ 0.394809] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]507server # [ 0.364525] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]508builder # [ 0.394826] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]509server # [ 0.364606] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00510builder # [ 0.395291] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint511server # [ 0.364616] pci_bus 0000:00: root bus resource [bus 00-ff]512builder # [ 0.395477] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]513server # [ 0.364622] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]514builder # [ 0.395506] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]515server # [ 0.364628] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]516builder # [ 0.395972] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint517server # [ 0.364633] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]518builder # [ 0.396157] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]519server # [ 0.364717] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint520builder # [ 0.396186] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]521server # [ 0.365161] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint522builder # [ 0.396569] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint523server # [ 0.365355] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]524builder # [ 0.396748] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]525server # [ 0.365372] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]526builder # [ 0.397006] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint527server # [ 0.365402] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]528builder # [ 0.397284] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]529server # [ 0.365419] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]530builder # [ 0.397303] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]531server # [ 0.365880] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint532builder # [ 0.397333] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]533server # [ 0.366067] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]534builder # [ 0.397795] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint535server # [ 0.366083] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]536builder # [ 0.397975] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]537server # [ 0.366113] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]538builder # [ 0.397991] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]539server # [ 0.366576] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint540builder # [ 0.398021] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]541server # [ 0.366761] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]542builder # [ 0.398582] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned543server # [ 0.366777] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]544builder # [ 0.398594] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned545server # [ 0.366807] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]546builder # [ 0.398601] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned547server # [ 0.367294] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint548builder # [ 0.398645] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned549server # [ 0.367499] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]550server # [ 0.367515] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]551builder # [ 0.398692] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned552server # [ 0.367545] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]553builder # [ 0.398738] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned554server # [ 0.368012] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint555builder # [ 0.398784] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned556server # [ 0.368200] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]557builder # [ 0.398830] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned558server # [ 0.368217] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]559builder # [ 0.398877] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned560server # [ 0.368247] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]561builder # [ 0.398923] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned562server # [ 0.368714] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint563server # [ 0.368901] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]564builder # [ 0.398969] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned565server # [ 0.368917] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]566builder # [ 0.399025] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned567server # [ 0.368947] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]568builder # [ 0.399091] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned569server # [ 0.369409] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint570builder # [ 0.399136] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned571server # [ 0.369595] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]572builder # [ 0.399158] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned573server # [ 0.369611] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]574builder # [ 0.399180] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned575server # [ 0.369641] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]576builder # [ 0.399202] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned577server # [ 0.369657] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]578builder # [ 0.399224] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned579server # [ 0.370117] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint580builder # [ 0.399246] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned581server # [ 0.370306] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]582builder # [ 0.399270] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned583server # [ 0.370336] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]584builder # [ 0.399293] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned585server # [ 0.370792] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint586builder # [ 0.399315] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned587server # [ 0.370989] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]588builder # [ 0.399337] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned589server # [ 0.371019] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]590builder # [ 0.399360] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned591builder # [ 0.399383] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned592builder # [ 0.399404] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned593builder # [ 0.399426] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned594builder # [ 0.399448] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned595builder # [ 0.399469] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned596builder # [ 0.399491] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned597builder # [ 0.399513] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned598builder # [ 0.399535] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned599builder # [ 0.399557] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned600builder # [ 0.399579] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned601builder # [ 0.399606] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]602builder # [ 0.399616] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]603server # [ 0.419514] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint604builder # [ 0.399621] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]605server # [ 0.419718] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]606server # [ 0.419975] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint607server # [ 0.420259] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]608server # [ 0.420276] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]609server # [ 0.420306] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]610server # [ 0.420770] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint611server # [ 0.420955] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]612server # [ 0.420971] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]613builder # [ 0.464878] pci 0000:00:0a.0: enabling device (0000 -> 0002)614server # [ 0.421001] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]615server # [ 0.421589] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned616server # [ 0.421601] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned617server # [ 0.421606] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned618server # [ 0.421653] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned619server # [ 0.421700] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned620server # [ 0.421748] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned621server # [ 0.421795] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned622server # [ 0.421843] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned623server # [ 0.421891] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned624server # [ 0.421940] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned625server # [ 0.421988] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned626server # [ 0.422037] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned627server # [ 0.422096] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned628server # [ 0.422142] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned629server # [ 0.422163] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned630server # [ 0.422185] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned631server # [ 0.422207] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned632server # [ 0.422229] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned633server # [ 0.422251] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned634server # [ 0.422277] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned635server # [ 0.422299] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned636server # [ 0.422322] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned637server # [ 0.422344] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned638builder # [ 0.485174] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)639builder # [ 0.487284] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)640server # [ 0.422367] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned641server # [ 0.422389] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned642server # [ 0.422411] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned643server # [ 0.422433] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned644server # [ 0.422455] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned645server # [ 0.422476] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned646server # [ 0.422502] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned647server # [ 0.422524] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned648server # [ 0.422546] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned649server # [ 0.422568] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned650server # [ 0.422591] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned651server # [ 0.422617] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]652server # [ 0.422627] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]653server # [ 0.422632] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]654builder # [ 0.498171] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)655server # [ 0.467869] pci 0000:00:0a.0: enabling device (0000 -> 0002)656builder # [ 0.507944] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)657builder # [ 0.511725] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)658builder # [ 0.513661] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)659builder # [ 0.515580] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)660server # [ 0.487751] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)661server # [ 0.489842] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)662builder # [ 0.533151] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)663builder # [ 0.535525] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)664server # [ 0.499553] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)665builder # [ 0.538879] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)666server # [ 0.502013] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)667builder # [ 0.541829] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)668server # [ 0.512311] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)669server # [ 0.514302] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)670builder # [ 0.554512] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled671server # [ 0.517949] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)672builder # [ 0.556998] msm_serial: driver initialized673builder # [ 0.557126] SuperH (H)SCI(F) driver initialized674builder # [ 0.557179] STM32 USART driver initialized675server # [ 0.524454] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)676server # [ 0.535505] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)677server # [ 0.539067] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)678server # [ 0.541421] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)679builder # [ 0.590650] loop: module loaded680builder # [ 0.590837] virtio_blk virtio5: 1/0/0 default/read/poll queues681builder # [ 0.591601] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)682server # [ 0.560844] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled683server # [ 0.563417] msm_serial: driver initialized684builder # [ 0.596310] megasas: 07.734.00.00-rc1685server # [ 0.563551] SuperH (H)SCI(F) driver initialized686builder # [ 0.596953] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]687server # [ 0.563602] STM32 USART driver initialized688builder # [ 0.620832] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689builder # [ 0.620863] Intel/Sharp Extended Query Table at 0x0031690builder # [ 0.622439] Using buffer write method691builder # [ 0.622497] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]692server # [ 0.590257] loop: module loaded693server # [ 0.590417] virtio_blk virtio5: 1/0/0 default/read/poll queues694server # [ 0.591174] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)695builder # [ 0.627450] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000696builder # [ 0.627473] Intel/Sharp Extended Query Table at 0x0031697builder # [ 0.629105] Using buffer write method698builder # [ 0.629136] Concatenating MTD devices:699builder # [ 0.629140] (0): "0.flash"700builder # [ 0.629145] (1): "0.flash"701builder # [ 0.629148] into device "0.flash"702server # [ 0.603877] megasas: 07.734.00.00-rc1703server # [ 0.604526] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]704server # [ 0.606351] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000705server # [ 0.606376] Intel/Sharp Extended Query Table at 0x0031706server # [ 0.608096] Using buffer write method707server # [ 0.608150] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]708server # [ 0.609952] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000709server # [ 0.609974] Intel/Sharp Extended Query Table at 0x0031710server # [ 0.627354] Using buffer write method711server # [ 0.627380] Concatenating MTD devices:712server # [ 0.627384] (0): "0.flash"713server # [ 0.627388] (1): "0.flash"714server # [ 0.627392] into device "0.flash"715builder # [ 0.840385] Freeing initrd memory: 25520K716builder # [ 0.846374] tun: Universal TUN/TAP device driver, 1.6717builder # [ 0.850188] thunder_xcv, ver 1.0718builder # [ 0.850234] thunder_bgx, ver 1.0719builder # [ 0.850258] nicpf, ver 1.0720builder # [ 0.850816] e1000: Intel(R) PRO/1000 Network Driver721builder # [ 0.850823] e1000: Copyright (c) 1999-2006 Intel Corporation.722builder # [ 0.850871] e1000e: Intel(R) PRO/1000 Network Driver723builder # [ 0.850878] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.724builder # [ 0.850911] igb: Intel(R) Gigabit Ethernet Network Driver725builder # [ 0.850917] igb: Copyright (c) 2007-2014 Intel Corporation.726builder # [ 0.850942] igbvf: Intel(R) Gigabit Virtual Function Network Driver727builder # [ 0.850948] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.728builder # [ 0.851106] sky2: driver version 1.30729builder # [ 0.859721] usbcore: registered new interface driver usb-storage730builder # [ 0.860470] ehci-pci 0000:00:0a.0: EHCI Host Controller731builder # [ 0.860496] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1732builder # [ 0.860765] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000733builder # [ 0.863940] usbcore: registered new interface driver usbserial_generic734builder # [ 0.863958] usbserial: USB Serial support registered for generic735builder # [ 0.864617] hv_vmbus: registering driver hyperv_keyboard736builder # [ 0.867662] rtc-pl031 9010000.pl031: registered as rtc0737builder # [ 0.867690] rtc-pl031 9010000.pl031: setting system clock to 2026-07-07T08:16:58 UTC (1783412218)738builder # [ 0.869777] i2c_dev: i2c /dev entries driver739server # [ 0.839505] Freeing initrd memory: 25520K740builder # [ 0.872931] sdhci: Secure Digital Host Controller Interface driver741builder # [ 0.872941] sdhci: Copyright(c) Pierre Ossman742builder # [ 0.873201] Synopsys Designware Multimedia Card Interface Driver743builder # [ 0.873555] sdhci-pltfm: SDHCI platform and OF driver helper744builder # [ 0.875166] hid: raw HID events driver (C) Jiri Kosina745builder # [ 0.875398] usbcore: registered new interface driver usbhid746builder # [ 0.875405] usbhid: USB HID core driver747builder # [ 0.880252] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00748builder # [ 0.880559] hub 1-0:1.0: USB hub found749server # [ 0.845360] tun: Universal TUN/TAP device driver, 1.6750builder # [ 0.880579] hub 1-0:1.0: 6 ports detected751builder # [ 0.883376] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available752builder # [ 0.885958] drop_monitor: Initializing network drop monitor service753builder # [ 0.886141] NET: Registered PF_INET6 protocol family754server # [ 0.849072] thunder_xcv, ver 1.0755builder # [ 0.888105] Segment Routing with IPv6756server # [ 0.849114] thunder_bgx, ver 1.0757builder # [ 0.888124] In-situ OAM (IOAM) with IPv6758server # [ 0.849138] nicpf, ver 1.0759builder # [ 0.888163] NET: Registered PF_PACKET protocol family760server # [ 0.849658] e1000: Intel(R) PRO/1000 Network Driver761server # [ 0.849665] e1000: Copyright (c) 1999-2006 Intel Corporation.762server # [ 0.849694] e1000e: Intel(R) PRO/1000 Network Driver763server # [ 0.849702] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.764builder # [ 0.889830] 9pnet: Installing 9P2000 support765server # [ 0.849733] igb: Intel(R) Gigabit Ethernet Network Driver766server # [ 0.849739] igb: Copyright (c) 2007-2014 Intel Corporation.767server # [ 0.849761] igbvf: Intel(R) Gigabit Virtual Function Network Driver768server # [ 0.849768] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.769server # [ 0.849898] sky2: driver version 1.30770server # [ 0.851923] ehci-pci 0000:00:0a.0: EHCI Host Controller771builder # [ 0.892539] Key type dns_resolver registered772server # [ 0.851948] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1773server # [ 0.852105] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000774server # [ 0.861667] usbcore: registered new interface driver usb-storage775builder # [ 0.898948] registered taskstats version 1776server # [ 0.861719] usbcore: registered new interface driver usbserial_generic777builder # [ 0.899184] Loading compiled-in X.509 certificates778server # [ 0.861733] usbserial: USB Serial support registered for generic779server # [ 0.862292] hv_vmbus: registering driver hyperv_keyboard780server # [ 0.865844] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00781server # [ 0.866164] hub 1-0:1.0: USB hub found782server # [ 0.866183] hub 1-0:1.0: 6 ports detected783server # [ 0.868548] rtc-pl031 9010000.pl031: registered as rtc0784server # [ 0.868575] rtc-pl031 9010000.pl031: setting system clock to 2026-07-07T08:16:58 UTC (1783412218)785server # [ 0.868874] i2c_dev: i2c /dev entries driver786builder # [ 0.907854] Demotion targets for Node 0: null787builder # [ 0.907967] Key type .fscrypt registered788builder # [ 0.907973] Key type fscrypt-provisioning registered789builder # [ 0.908062] ima: No TPM chip found, activating TPM-bypass!790builder # [ 0.908081] ima: Allocated hash algorithm: sha1791builder # [ 0.908101] ima: No architecture policies found792server # [ 0.873683] sdhci: Secure Digital Host Controller Interface driver793server # [ 0.873692] sdhci: Copyright(c) Pierre Ossman794builder # [ 0.912242] input: gpio-keys as /devices/platform/gpio-keys/input/input0795server # [ 0.873942] Synopsys Designware Multimedia Card Interface Driver796server # [ 0.874289] sdhci-pltfm: SDHCI platform and OF driver helper797server # [ 0.878613] hid: raw HID events driver (C) Jiri Kosina798server # [ 0.878855] usbcore: registered new interface driver usbhid799server # [ 0.878862] usbhid: USB HID core driver800server # [ 0.881783] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available801server # [ 0.883218] drop_monitor: Initializing network drop monitor service802server # [ 0.883399] NET: Registered PF_INET6 protocol family803server # [ 0.886426] Segment Routing with IPv6804server # [ 0.886444] In-situ OAM (IOAM) with IPv6805server # [ 0.886472] NET: Registered PF_PACKET protocol family806server # [ 0.888382] 9pnet: Installing 9P2000 support807server # [ 0.890495] Key type dns_resolver registered808builder # [ 0.929423] clk: Disabling unused clocks809builder # [ 0.929446] PM: genpd: Disabling unused power domains810builder # [ 0.933795] Freeing unused kernel memory: 4736K811builder # [ 0.934005] Run /init as init process812server # [ 0.897424] registered taskstats version 1813server # [ 0.897578] Loading compiled-in X.509 certificates814server # [ 0.905840] Demotion targets for Node 0: null815server # [ 0.905939] Key type .fscrypt registered816server # [ 0.905946] Key type fscrypt-provisioning registered817server # [ 0.906044] ima: No TPM chip found, activating TPM-bypass!818server # [ 0.906064] ima: Allocated hash algorithm: sha1819server # [ 0.906085] ima: No architecture policies found820server # [ 0.910179] input: gpio-keys as /devices/platform/gpio-keys/input/input0821builder # [ 0.949968] systemd[1]: Successfully made /usr/ read-only.822server # [ 0.927932] clk: Disabling unused clocks823server # [ 0.927957] PM: genpd: Disabling unused power domains824server # [ 0.932343] Freeing unused kernel memory: 4736K825server # [ 0.932537] Run /init as init process826server # [ 0.949579] systemd[1]: Successfully made /usr/ read-only.827builder # [ 1.131823] usb 1-1: new high-speed USB device number 2 using ehci-pci828server # [ 1.111411] usb 1-1: new high-speed USB device number 2 using ehci-pci829builder # [ 1.284084] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1830builder # [ 1.290107] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)831server # [ 1.263712] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1832builder # [ 1.302451] systemd[1]: Detected virtualization qemu.833builder # [ 1.302537] systemd[1]: Detected architecture arm64.834builder # [ 1.302563] systemd[1]: Running in initrd.835builder # [ 1.303589] systemd[1]: Initializing machine ID from random generator.836builder # [ 1.311933] systemd[1]: Hostname set to <builder>.837server # [ 1.284496] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)838server # [ 1.296736] systemd[1]: Detected virtualization qemu.839server # [ 1.298744] systemd[1]: Detected architecture arm64.840server # [ 1.300744] systemd[1]: Running in initrd.841server # [ 1.303516] systemd[1]: Initializing machine ID from random generator.842server # [ 1.306339] systemd[1]: Hostname set to <server>.843builder # [ 1.376115] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0844server # [ 1.347717] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0845builder # [ 1.425583] systemd[1]: Queued start job for default target Initrd Default Target.846builder # [ 1.433685] systemd[1]: Created slice Slice /system/modprobe.847builder # [ 1.434778] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.848builder # [ 1.436094] systemd[1]: Expecting device /dev/disk/by-label/nixos...849builder # [ 1.436126] systemd[1]: Reached target Path Units.850builder # [ 1.436146] systemd[1]: Reached target Slice Units.851builder # [ 1.436164] systemd[1]: Reached target Swaps.852builder # [ 1.436184] systemd[1]: Reached target Timer Units.853builder # [ 1.436331] systemd[1]: Listening on D-Bus System Message Bus Socket.854builder # [ 1.436495] systemd[1]: Listening on Journal Socket (/dev/log).855builder # [ 1.436651] systemd[1]: Listening on Journal Sockets.856builder # [ 1.436768] systemd[1]: Listening on udev Control Socket.857builder # [ 1.436887] systemd[1]: Listening on udev Kernel Socket.858builder # [ 1.436907] systemd[1]: Reached target Socket Units.859builder # [ 1.447322] systemd[1]: Starting Create List of Static Device Nodes...860builder # [ 1.455915] systemd[1]: Starting Load Kernel Module 9pnet_virtio...861builder # [ 1.456990] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs862builder # [ 1.463912] systemd[1]: Mounting Kernel Configuration File System...863server # [ 1.427976] systemd[1]: Queued start job for default target Initrd Default Target.864builder # [ 1.473359] systemd[1]: Starting Journal Service...865server # [ 1.439097] systemd[1]: Created slice Slice /system/modprobe.866server # [ 1.440444] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.867server # [ 1.441818] systemd[1]: Expecting device /dev/disk/by-label/nixos...868server # [ 1.442936] systemd[1]: Reached target Path Units.869server # [ 1.443868] systemd[1]: Reached target Slice Units.870server # [ 1.443894] systemd[1]: Reached target Swaps.871server # [ 1.443917] systemd[1]: Reached target Timer Units.872server # [ 1.444079] systemd[1]: Listening on D-Bus System Message Bus Socket.873server # [ 1.444260] systemd[1]: Listening on Journal Socket (/dev/log).874server # [ 1.444433] systemd[1]: Listening on Journal Sockets.875server # [ 1.444565] systemd[1]: Listening on udev Control Socket.876server # [ 1.444671] systemd[1]: Listening on udev Kernel Socket.877server # [ 1.444693] systemd[1]: Reached target Socket Units.878server # [ 1.454171] systemd[1]: Starting Create List of Static Device Nodes...879builder # [ 1.493807] systemd[1]: Starting Load Kernel Modules...880builder # [ 1.495242] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki881server # [ 1.463536] systemd[1]: Starting Load Kernel Module 9pnet_virtio...882builder # [ 1.499822] usb 1-2: new high-speed USB device number 3 using ehci-pci883server # [ 1.464743] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs884builder # [ 1.501270] systemd[1]: Starting Coldplug All udev Devices...885server # [ 1.471415] usb 1-2: new high-speed USB device number 3 using ehci-pci886server # [ 1.472946] systemd[1]: Mounting Kernel Configuration File System...887builder # [ 1.515977] systemd[1]: Finished Create List of Static Device Nodes.888builder # [ 1.517037] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.889builder # [ 1.522128] systemd-journald[73]: Collecting audit messages is disabled.890builder # [ 1.527996] systemd[1]: Finished Load Kernel Module 9pnet_virtio.891builder # [ 1.528337] systemd[1]: Mounted Kernel Configuration File System.892builder # [ 1.531089] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...893server # [ 1.499650] systemd[1]: Starting Journal Service...894server # [ 1.508791] systemd[1]: Starting Load Kernel Modules...895server # [ 1.509771] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki896server # [ 1.515576] systemd[1]: Starting Coldplug All udev Devices...897builder # [ 1.549079] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.898builder # [ 1.569691] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev899builder # [ 1.576420] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.900server # [ 1.539460] systemd[1]: Finished Create List of Static Device Nodes.901server # [ 1.540590] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.902server # [ 1.540932] systemd[1]: Finished Load Kernel Module 9pnet_virtio.903server # [ 1.541171] systemd[1]: Mounted Kernel Configuration File System.904server # [ 1.547865] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...905builder # [ 1.586252] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0906builder # [ 1.586490] [drm] features: -virgl +edid -resource_blob -host_visible907builder # [ 1.586501] [drm] features: -context_init908builder # [ 1.587213] [drm] number of scanouts: 1909builder # [ 1.587230] [drm] number of cap sets: 0910builder # [ 1.590870] systemd[1]: Starting Create Static Device Nodes in /dev...911builder # [ 1.604121] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic912builder # [ 1.604136] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0913server # [ 1.576212] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.914server # [ 1.584112] systemd-journald[73]: Collecting audit messages is disabled.915server # [ 1.591487] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev916builder # [ 1.623985] Console: switching to colour frame buffer device 160x50917server # [ 1.599434] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0918server # [ 1.599679] [drm] features: -virgl +edid -resource_blob -host_visible919server # [ 1.599689] [drm] features: -context_init920server # [ 1.600380] [drm] number of scanouts: 1921server # [ 1.600398] [drm] number of cap sets: 0922server # [ 1.612323] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.923builder # [ 1.648496] systemd[1]: Finished Create Static Device Nodes in /dev.924builder # [ 1.648699] systemd[1]: Reached target Preparation for Local File Systems.925server # [ 1.614775] systemd[1]: Starting Create Static Device Nodes in /dev...926builder # [ 1.648724] systemd[1]: Reached target Local File Systems.927builder # [ 1.652848] systemd[1]: Starting Rule-based Manager for Device Events and Files...928builder # [ 1.660740] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device929server # [ 1.625273] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic930builder # [ 1.665711] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2931server # [ 1.625288] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0932builder # [ 1.665858] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0933server # [ 1.641408] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2934server # [ 1.643448] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0935builder # [ 1.681618] systemd[1]: Finished Load Kernel Modules.936builder # [ 1.684608] systemd[1]: Starting Apply Kernel Variables...937server # [ 1.656753] Console: switching to colour frame buffer device 160x50938server # [ 1.679474] systemd[1]: Finished Create Static Device Nodes in /dev.939server # [ 1.679667] systemd[1]: Reached target Preparation for Local File Systems.940server # [ 1.679693] systemd[1]: Reached target Local File Systems.941server # [ 1.683471] systemd[1]: Starting Rule-based Manager for Device Events and Files...942server # [ 1.688117] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device943builder # [ 1.727175] systemd[1]: Finished Apply Kernel Variables.944builder # [ 1.744732] systemd[1]: Started Journal Service.945builder # [ 1.731912] systemd-modules-load[74]: Inserted module 'dm_mod'946builder # [ 1.733095] systemd-modules-load[74]: Module 'virtio_balloon' is built in947server # [ 1.714390] systemd[1]: Finished Load Kernel Modules.948builder # [ 1.740295] systemd-modules-load[74]: Module 'virtio_console' is built in949server # [ 1.719675] systemd[1]: Starting Apply Kernel Variables...950builder # [ 1.743284] systemd-modules-load[74]: Inserted module 'virtio_gpu'951builder # [ 1.752303] systemd-modules-load[74]: Module 'virtio_rng' is built in952builder # [ 1.753373] systemd[1]: Starting Create System Files and Directories...953builder # [ 1.754668] systemd-udevd[81]: Using default interface naming scheme 'v260'.954builder # [ 1.784727] systemd[1]: Finished Create System Files and Directories.955server # [ 1.776030] systemd[1]: Finished Apply Kernel Variables.956builder # [ 1.800976] systemd[1]: Started Rule-based Manager for Device Events and Files.957server # [ 1.782596] systemd[1]: Started Journal Service.958server # [ 1.776313] systemd-modules-load[74]: Inserted module 'dm_mod'959server # [ 1.777550] systemd-modules-load[74]: Module 'virtio_balloon' is built in960server # [ 1.779467] systemd-modules-load[74]: Module 'virtio_console' is built in961server # [ 1.785895] systemd-modules-load[74]: Inserted module 'virtio_gpu'962server # [ 1.786938] systemd-modules-load[74]: Module 'virtio_rng' is built in963server # [ 1.791137] systemd-udevd[80]: Using default interface naming scheme 'v260'.964server # [ 1.799849] systemd[1]: Starting Create System Files and Directories...965server # [ 1.817536] systemd[1]: Finished Create System Files and Directories.966server # [ 1.828756] systemd[1]: Started Rule-based Manager for Device Events and Files.967builder # [ 1.872168] systemd[1]: Starting Virtual Console Setup...968server # [ 1.904121] systemd[1]: Starting Virtual Console Setup...969builder # [ 1.944493] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.970builder # [ 1.947827] systemd[1]: Finished Virtual Console Setup.971server # [ 1.969299] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.972server # [ 1.972734] systemd[1]: Finished Virtual Console Setup.973builder # [ 2.686156] systemd[1]: Finished Coldplug All udev Devices.974builder # [ 2.687104] systemd[1]: Reached target System Initialization.975builder # [ 2.688148] systemd[1]: Reached target Basic System.976server # [ 2.669529] systemd[1]: Finished Coldplug All udev Devices.977server # [ 2.670478] systemd[1]: Reached target System Initialization.978server # [ 2.672101] systemd[1]: Reached target Basic System.979builder # [ 2.871540] (udev-worker)[101]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.980builder # [ 2.881170] (udev-worker)[101]: Network interface NamePolicy= disabled on kernel command line.981builder # [ 2.885716] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.982server # [ 2.845386] (udev-worker)[98]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.983server # [ 2.848428] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.984server # [ 2.861188] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.985builder # [ 2.910585] systemd[1]: Found device /dev/disk/by-label/nixos.986builder # [ 2.913335] systemd[1]: Reached target Initrd Root Device.987builder # [ 2.915366] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...988server # [ 2.905188] systemd[1]: Found device /dev/disk/by-label/nixos.989server # [ 2.908142] systemd[1]: Reached target Initrd Root Device.990server # [ 2.911849] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...991builder # [ 2.958754] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks992builder # [ 2.963455] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.993builder # [ 2.975607] systemd[1]: Mounting /sysroot...994server # [ 2.958499] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks995builder # [ 3.013343] EXT4-fs (vda): mounted filesystem 25612b7c-0147-44bf-ab1e-170633e41996 r/w with ordered data mode. Quota mode: none.996builder # [ 3.002485] systemd[1]: Mounted /sysroot.997builder # [ 3.004101] systemd[1]: Reached target Initrd Root File System.998server # [ 2.968124] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.999builder # [ 3.008145] systemd[1]: Starting Mountpoints Configured in the Real Root...1000server # [ 2.972234] systemd[1]: Mounting /sysroot...1001builder # [ 3.038978] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.1002builder # [ 3.047813] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...1003server # [ 3.029404] EXT4-fs (vda): mounted filesystem 4bbfb231-5630-4a95-ad3b-cda5a030c167 r/w with ordered data mode. Quota mode: none.1004builder # [ 3.052776] systemd[1]: Reloading...1005server # [ 3.017323] systemd[1]: Mounted /sysroot.1006server # [ 3.018791] systemd[1]: Reached target Initrd Root File System.1007server # [ 3.022244] systemd[1]: Starting Mountpoints Configured in the Real Root...1008server # [ 3.051500] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.1009server # [ 3.056403] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...1010server # [ 3.061036] systemd[1]: Reloading...1011builder # [ 3.268077] systemd[1]: Reloading finished in 216 ms.1012builder # [ 3.284613] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1013builder # [ 3.288067] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1014builder # [ 3.293143] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1015builder # [ 3.296145] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1016builder # [ 3.299952] systemd[1]: Finished Mountpoints Configured in the Real Root.1017builder # [ 3.302394] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1018server # [ 3.280124] systemd[1]: Reloading finished in 220 ms.1019builder # [ 3.325830] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1020builder # [ 3.327230] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1021server # [ 3.297071] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1022server # [ 3.299822] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1023server # [ 3.307842] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1024server # [ 3.322045] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1025server # [ 3.324123] systemd[1]: Finished Mountpoints Configured in the Real Root.1026server # [ 3.330373] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1027server # [ 3.335479] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1028server # [ 3.336667] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1029builder # [ 3.490137] systemd[1]: Mounting /sysroot/nix/.ro-store...1030builder # [ 3.506746] systemd[1]: Mounting /sysroot/nix/.rw-store...1031builder # [ 3.510613] systemd[1]: Mounting /sysroot/run...1032builder # [ 3.530298] systemd[1]: Mounting /sysroot/tmp/shared...1033builder # [ 3.542957] systemd[1]: Mounting /sysroot/tmp/xchg...1034server # [ 3.509591] systemd[1]: Mounting /sysroot/nix/.ro-store...1035server # [ 3.526615] systemd[1]: Mounting /sysroot/nix/.rw-store...1036server # [ 3.530205] systemd[1]: Mounting /sysroot/run...1037builder # [ 3.574851] systemd[1]: Mounted /sysroot/nix/.ro-store.1038builder # [ 3.581563] systemd[1]: Mounted /sysroot/nix/.rw-store.1039builder # [ 3.584196] systemd[1]: Mounted /sysroot/run.1040server # [ 3.553439] systemd[1]: Mounting /sysroot/tmp/shared...1041builder # [ 3.599877] systemd[1]: Starting rw-sysroot-nix-store.service...1042builder # [ 3.603968] systemd[1]: Mounted /sysroot/tmp/shared.1043builder # [ 3.610686] systemd[1]: Mounted /sysroot/tmp/xchg.1044server # [ 3.576917] systemd[1]: Mounting /sysroot/tmp/xchg...1045server # [ 3.580777] systemd[1]: Mounted /sysroot/nix/.rw-store.1046builder # [ 3.628115] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1047builder # [ 3.629295] systemd[1]: Finished rw-sysroot-nix-store.service.1048builder # [ 3.632319] systemd[1]: Mounting /sysroot/nix/store...1049server # [ 3.615290] systemd[1]: Mounted /sysroot/nix/.ro-store.1050server # [ 3.617718] systemd[1]: Mounted /sysroot/run.1051server # [ 3.627418] systemd[1]: Starting rw-sysroot-nix-store.service...1052builder # [ 3.670609] systemd[1]: Mounted /sysroot/nix/store.1053server # [ 3.632424] systemd[1]: Mounted /sysroot/tmp/xchg.1054builder # [ 3.672830] systemd[1]: Reached target Initrd File Systems.1055builder # [ 3.676127] systemd[1]: Starting Find NixOS closure...1056server # [ 3.641874] systemd[1]: Mounted /sysroot/tmp/shared.1057builder # [ 3.684998] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1058server # [ 3.661711] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1059server # [ 3.662799] systemd[1]: Finished rw-sysroot-nix-store.service.1060builder # [ 3.718885] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1061builder # [ 3.736087] systemd[1]: Finished Find NixOS closure.1062builder # [ 3.738792] systemd[1]: Reached target Initrd Default Target.1063builder # [ 3.743997] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1064builder # [ 3.771049] systemd[1]: Stopped target Initrd Default Target.1065builder # [ 3.772557] systemd[1]: Stopped target Basic System.1066builder # [ 3.776980] systemd[1]: Stopped target Initrd Root Device.1067builder # [ 3.777836] systemd[1]: Stopped target Path Units.1068builder # [ 3.779687] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1069builder # [ 3.782666] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1070builder # [ 3.788130] systemd[1]: Stopped target Slice Units.1071builder # [ 3.789674] systemd[1]: Stopped target Socket Units.1072builder # [ 3.791177] systemd[1]: Stopped target System Initialization.1073builder # [ 3.793216] systemd[1]: Stopped target Swaps.1074builder # [ 3.794694] systemd[1]: Stopped target Timer Units.1075builder # [ 3.797580] systemd[1]: dbus.socket: Deactivated successfully.1076builder # [ 3.800266] systemd[1]: Closed D-Bus System Message Bus Socket.1077builder # [ 3.804830] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1078builder # [ 3.807060] systemd[1]: Stopped Find NixOS closure.1079builder # [ 3.809168] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1080builder # [ 3.813600] systemd[1]: Starting rw-sysroot-nix-store.service...1081builder # [ 3.815049] systemd[1]: systemd-sysctl.service: Deactivated successfully.1082builder # [ 3.820130] systemd[1]: Stopped Apply Kernel Variables.1083builder # [ 3.820954] systemd[1]: systemd-modules-load.service: Deactivated successfully.1084builder # [ 3.828546] systemd[1]: Stopped Load Kernel Modules.1085builder # [ 3.831646] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1086builder # [ 3.839836] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1087builder # [ 3.842234] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1088builder # [ 3.843369] systemd[1]: Stopped Create System Files and Directories.1089builder # [ 3.848293] systemd[1]: Stopped target Local File Systems.1090builder # [ 3.853152] systemd[1]: Stopped target Preparation for Local File Systems.1091builder # [ 3.854470] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1092builder # [ 3.855474] systemd[1]: Stopped Coldplug All udev Devices.1093builder # [ 3.860250] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1094builder # [ 3.861298] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1095builder # [ 3.862319] systemd[1]: Stopped Virtual Console Setup.1096builder # [ 3.864166] systemd[1]: initrd-cleanup.service: Deactivated successfully.1097builder # [ 3.866757] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1098builder # [ 3.867683] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1099builder # [ 3.870544] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1100builder # [ 3.871430] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1101builder # [ 3.872508] systemd[1]: Finished rw-sysroot-nix-store.service.1102builder # [ 3.879762] systemd[1]: systemd-udevd.service: Deactivated successfully.1103builder # [ 3.884214] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1104builder # [ 3.885239] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1105builder # [ 3.886225] systemd[1]: Closed udev Control Socket.1106builder # [ 3.887700] systemd[1]: Starting Cleanup udev Database...1107builder # [ 3.889412] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1108builder # [ 3.890486] systemd[1]: Stopped Create Static Device Nodes in /dev.1109builder # [ 3.891538] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1110builder # [ 3.892839] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1111builder # [ 3.893811] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1112builder # [ 3.894757] systemd[1]: Stopped Create List of Static Device Nodes.1113builder # [ 3.918639] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1114builder # [ 3.922225] systemd[1]: Finished Cleanup udev Database.1115builder # [ 3.923041] systemd[1]: Reached target Switch Root.1116builder # [ 3.927974] systemd[1]: Starting NixOS Activation...1117builder # [ 4.085988] initrd-nixos-activation-start[173]: booting system configuration /nix/store/x42dqidsd2n71lx3g4ydihgmkxrs1v5l-nixos-system-builder-test1118builder # [ 4.146952] initrd-nixos-activation-start[173]: running activation script...1119server # [ 4.267024] (udev-worker)[97]: mtd0ro: Failed to find and pin callout binary "/nix/store/k2s978i7i26km4cr56fvm64p2q6mpl02-systemd-260.2/lib/udev/mtd_probe": No such file or directory1120server # [ 4.273600] (udev-worker)[97]: mtd0ro: /nix/store/k2s978i7i26km4cr56fvm64p2q6mpl02-systemd-260.2/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory1121server # [ 4.304392] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1122server # [ 4.308831] systemd[1]: Stopped Virtual Console Setup.1123server # [ 4.309663] systemd[1]: Stopping Virtual Console Setup...1124server # [ 4.310449] systemd[1]: Starting Virtual Console Setup...1125server # [ 4.339865] systemd-vconsole-setup[154]: Configuration of first virtual console was skipped, ignoring remaining ones.1126server # [ 4.343711] systemd[1]: Finished Virtual Console Setup.1127server # [ 4.511889] systemd[1]: Mounting /sysroot/nix/store...1128builder # [ 4.556776] initrd-nixos-activation-start[196]: setting up /etc...1129server # [ 4.573803] systemd[1]: Mounted /sysroot/nix/store.1130server # [ 4.577247] systemd[1]: Reached target Initrd File Systems.1131server # [ 4.582219] systemd[1]: Starting Find NixOS closure...1132server # [ 4.592386] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1133server # [ 4.640368] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1134server # [ 4.645230] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1135server # [ 4.662692] systemd[1]: Finished Find NixOS closure.1136server # [ 4.666421] systemd[1]: Reached target Initrd Default Target.1137server # [ 4.668730] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1138server # [ 4.702495] systemd[1]: Stopped target Initrd Default Target.1139server # [ 4.704673] systemd[1]: Stopped target Basic System.1140server # [ 4.708475] systemd[1]: Stopped target Initrd Root Device.1141server # [ 4.709773] systemd[1]: Stopped target Path Units.1142server # [ 4.711646] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1143server # [ 4.715273] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1144server # [ 4.720235] systemd[1]: Stopped target Slice Units.1145server # [ 4.721235] systemd[1]: Stopped target Socket Units.1146server # [ 4.722221] systemd[1]: Stopped target System Initialization.1147server # [ 4.723327] systemd[1]: Stopped target Swaps.1148server # [ 4.728260] systemd[1]: Stopped target Timer Units.1149server # [ 4.729213] systemd[1]: dbus.socket: Deactivated successfully.1150server # [ 4.732120] systemd[1]: Closed D-Bus System Message Bus Socket.1151server # [ 4.733767] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1152server # [ 4.738626] systemd[1]: Stopped Find NixOS closure.1153server # [ 4.740501] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1154server # [ 4.745215] systemd[1]: Starting rw-sysroot-nix-store.service...1155server # [ 4.746950] systemd[1]: systemd-sysctl.service: Deactivated successfully.1156server # [ 4.752610] systemd[1]: Stopped Apply Kernel Variables.1157server # [ 4.756522] systemd[1]: systemd-modules-load.service: Deactivated successfully.1158server # [ 4.758786] systemd[1]: Stopped Load Kernel Modules.1159server # [ 4.759600] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1160builder # [ 4.805474] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1161builder # [ 4.808118] systemd[1]: Finished NixOS Activation.1162server # [ 4.771281] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1163builder # [ 4.812184] systemd[1]: Starting Switch Root...1164server # [ 4.773579] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1165server # [ 4.776508] systemd[1]: Stopped Create System Files and Directories.1166server # [ 4.779408] systemd[1]: Stopped target Local File Systems.1167server # [ 4.780897] systemd[1]: Stopped target Preparation for Local File Systems.1168server # [ 4.783801] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1169server # [ 4.785681] systemd[1]: Stopped Coldplug All udev Devices.1170builder # [ 4.825606] systemd[1]: Switching root.1171server # [ 4.788234] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1172server # [ 4.790111] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1173server # [ 4.792160] systemd[1]: Stopped Virtual Console Setup.1174server # [ 4.793930] systemd[1]: initrd-cleanup.service: Deactivated successfully.1175server # [ 4.795415] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1176server # [ 4.796590] systemd[1]: systemd-udevd.service: Deactivated successfully.1177server # [ 4.797532] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1178server # [ 4.798542] systemd[1]: systemd-udevd.service: Consumed 1.551s CPU time over 3.111s wall clock time, 22.9M memory peak.1179server # [ 4.799969] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1180server # [ 4.801147] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1181server # [ 4.802007] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1182server # [ 4.803009] systemd[1]: Finished rw-sysroot-nix-store.service.1183server # [ 4.803851] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1184server # [ 4.812183] systemd[1]: Closed udev Control Socket.1185server # [ 4.812950] systemd[1]: Starting Cleanup udev Database...1186server # [ 4.813982] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1187server # [ 4.815090] systemd[1]: Stopped Create Static Device Nodes in /dev.1188server # [ 4.820183] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1189server # [ 4.821344] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1190server # [ 4.822352] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1191server # [ 4.823329] systemd[1]: Stopped Create List of Static Device Nodes.1192builder # [ 4.889809] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1193server # [ 4.850291] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1194server # [ 4.853396] systemd[1]: Finished Cleanup udev Database.1195server # [ 4.854212] systemd[1]: Reached target Switch Root.1196server # [ 4.856123] systemd[1]: Starting NixOS Activation...1197server # [ 5.018012] initrd-nixos-activation-start[179]: booting system configuration /nix/store/f5ckqn8y27dcnd2sizyif0s1akffmjvb-nixos-system-server-test1198server # [ 5.080358] initrd-nixos-activation-start[179]: running activation script...1199builder # [ 5.457355] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1200builder # [ 5.470235] systemd[1]: Detected virtualization qemu.1201builder # [ 5.473312] systemd[1]: Detected architecture arm64.1202builder # [ 5.477081] systemd[1]: Detected first boot.1203builder # [ 5.483941] systemd[1]: Initializing machine ID from random generator.1204server # [ 5.482753] initrd-nixos-activation-start[202]: setting up /etc...1205server # [ 5.740834] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1206server # [ 5.743234] systemd[1]: Finished NixOS Activation.1207server # [ 5.748159] systemd[1]: Starting Switch Root...1208builder # [ 5.807531] systemd[1]: bpf-restrict-fs: LSM BPF program attached1209server # [ 5.766384] systemd[1]: Switching root.1210server # [ 5.829197] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1211builder # [ 6.009825] systemd[1]: Applying preset policy.1212server # [ 6.386831] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)1213server # [ 6.399660] systemd[1]: Detected virtualization qemu.1214server # [ 6.403311] systemd[1]: Detected architecture arm64.1215server # [ 6.405439] systemd[1]: Detected first boot.1216server # [ 6.411910] systemd[1]: Initializing machine ID from random generator.1217builder # [ 6.503526] systemd[1]: Populated /etc with preset unit settings.1218server # [ 6.739723] systemd[1]: bpf-restrict-fs: LSM BPF program attached1219server # [ 6.941069] systemd[1]: Applying preset policy.1220builder # [ 6.982874] systemd[1]: initrd-switch-root.service: Deactivated successfully.1221builder # [ 6.984448] systemd[1]: Stopped initrd-switch-root.service.1222builder # [ 6.986294] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1223builder # [ 6.990063] systemd[1]: Created slice Slice /system/getty.1224builder # [ 6.993151] systemd[1]: Created slice User and Session Slice.1225builder # [ 6.995254] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1226builder # [ 6.997641] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1227builder # [ 6.999815] systemd[1]: Expecting device /dev/hvc0...1228builder # [ 7.001579] systemd[1]: Expecting device /dev/ttyAMA0...1229builder # [ 7.003365] systemd[1]: Reached target Local Encrypted Volumes.1230builder # [ 7.005322] systemd[1]: Stopped target initrd-fs.target.1231builder # [ 7.007117] systemd[1]: Stopped target initrd-root-fs.target.1232builder # [ 7.009068] systemd[1]: Stopped target initrd-switch-root.target.1233builder # [ 7.010202] systemd[1]: Reached target Virtual Machines and Containers.1234builder # [ 7.011859] systemd[1]: Reached target Path Units.1235builder # [ 7.013906] systemd[1]: Reached target Remote File Systems.1236builder # [ 7.015726] systemd[1]: Reached target Slice Units.1237builder # [ 7.017461] systemd[1]: Reached target Swaps.1238builder # [ 7.021512] systemd[1]: Listening on Query the User Interactively for a Password.1239builder # [ 7.026285] systemd[1]: Listening on Process Core Dump Socket.1240builder # [ 7.030315] systemd[1]: Listening on Credential Encryption/Decryption.1241builder # [ 7.034238] systemd[1]: Listening on Factory Reset Management.1242builder # [ 7.040218] systemd[1]: Starting Journal Log Access Socket...1243builder # [ 7.042551] systemd[1]: Listening on Journal Audit Socket.1244builder # [ 7.046669] systemd[1]: Listening on Console Output Muting Service Socket.1245builder # [ 7.049058] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1246builder # [ 7.051394] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1247builder # [ 7.053904] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1248builder # [ 7.064882] systemd[1]: Listening on Disk Repartitioning Service Socket.1249builder # [ 7.066245] systemd[1]: Listening on udev Control Socket.1250builder # [ 7.067810] systemd[1]: Listening on udev Varlink Socket.1251builder # [ 7.071916] systemd[1]: Mounting Huge Pages File System...1252builder # [ 7.076597] systemd[1]: Mounting POSIX Message Queue File System...1253builder # [ 7.083883] systemd[1]: Mounting Kernel Debug File System...1254builder # [ 7.088472] systemd[1]: Mounting Kernel Trace File System...1255builder # [ 7.109876] systemd[1]: Starting Create List of Static Device Nodes...1256builder # [ 7.117861] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1257builder # [ 7.119556] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1258builder # [ 7.129210] systemd[1]: Mounting Kernel Configuration File System...1259builder # [ 7.132125] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1260builder # [ 7.136251] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1261builder # [ 7.154258] systemd[1]: Starting Load Kernel Module fuse...1262builder # [ 7.154631] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671263builder # [ 7.168089] systemd[1]: Starting Journal Service...1264builder # [ 7.217071] systemd[1]: Starting Load Kernel Modules...1265builder # [ 7.238327] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1266builder # [ 7.249567] systemd[1]: Starting Remount Root and Kernel File Systems...1267builder # [ 7.252578] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1268builder # [ 7.262290] systemd[1]: Starting Coldplug All udev Devices...1269builder # [ 7.269516] systemd[1]: Listening on Journal Log Access Socket.1270builder # [ 7.274850] systemd[1]: Mounted Huge Pages File System.1271builder # [ 7.275438] systemd[1]: Mounted POSIX Message Queue File System.1272builder # [ 7.278292] systemd[1]: Mounted Kernel Debug File System.1273builder # [ 7.278796] systemd[1]: Mounted Kernel Trace File System.1274builder # [ 7.279228] systemd[1]: Mounted Kernel Configuration File System.1275builder # [ 7.335896] systemd[1]: Finished Create List of Static Device Nodes.1276builder # [ 7.344446] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1277builder # [ 7.395581] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1278builder # [ 7.398138] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1279builder # [ 7.400897] EXT4-fs (vda): re-mounted 25612b7c-0147-44bf-ab1e-170633e41996.1280builder # [ 7.417933] systemd[1]: Finished Remount Root and Kernel File Systems.1281builder # [ 7.419693] systemd[1]: Listening on Disk Image Download Service Socket.1282builder # [ 7.422661] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1283builder # [ 7.436519] systemd[1]: Starting Load/Save OS Random Seed...1284builder # [ 7.436851] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1285builder # [ 7.445014] systemd[1]: Finished Load Kernel Modules.1286builder # [ 7.450405] systemd-journald[267]: Collecting audit messages is enabled.1287builder # [ 7.457209] systemd[1]: Starting Firewall...1288builder # [ 7.466611] systemd[1]: Starting Apply Kernel Variables...1289builder # [ 7.476074] systemd[1]: Started Journal Service.1290builder # [ 7.465978] systemd[1]: Queued start job for default target Multi-User System.1291builder # [ 7.467394] systemd[1]: systemd-journald.service: Deactivated successfully.[ 7.489576] fuse: init (API version 7.45)1292server # [ 7.456351] systemd[1]: Populated /etc with preset unit settings.1293builder # 1294builder # [ 7.485184] systemd-modules-load[268]: Module 'atkbd' is built in1295builder # [ 7.494556] systemd-modules-load[268]: Module 'loop' is built in1296builder # [ 7.507717] systemd-modules-load[268]: Module 'tun' is built in1297builder # [ 7.513100] systemd[1]: Starting Flush Journal to Persistent Storage...1298builder # [ 7.530255] systemd[1]: modprobe@fuse.service: Deactivated successfully.1299builder # [ 7.542303] systemd[1]: Finished Load Kernel Module fuse.1300builder # [ 7.576161] systemd-oomd[269]: No swap; memory pressure usage will be degraded1301builder # [ 7.584085] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1302builder # [ 7.589841] systemd[1]: Finished Load/Save OS Random Seed.1303builder # [ 7.591334] systemd[1]: Reached target First Boot Complete.1304builder # [ 7.626562] systemd-journald[267]: Received client request to flush runtime journal.1305builder # [ 7.695535] systemd[1]: Finished Apply Kernel Variables.1306builder # [ 7.705105] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1307builder # [ 7.710042] systemd[1]: Starting Create Static Device Nodes in /dev...1308builder # [ 7.714864] systemd[1]: Finished Flush Journal to Persistent Storage.1309builder # [ 7.798454] systemd[1]: Finished Create Static Device Nodes in /dev.1310builder # [ 7.799492] systemd[1]: Reached target Preparation for Local File Systems.1311builder # [ 7.802818] systemd[1]: Starting Rule-based Manager for Device Events and Files...1312builder # [ 7.973728] systemd[1]: Mounting /run/wrappers...1313builder # [ 7.978661] systemd[1]: Mounting FUSE Control File System...1314server # [ 7.965251] systemd[1]: initrd-switch-root.service: Deactivated successfully.1315server # [ 7.966573] systemd[1]: Stopped initrd-switch-root.service.1316server # [ 7.970049] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1317server # [ 7.973741] systemd[1]: Created slice Slice /system/getty.1318server # [ 7.975878] systemd[1]: Created slice User and Session Slice.1319server # [ 7.977130] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1320server # [ 7.978985] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1321server # [ 7.981019] systemd[1]: Expecting device /dev/hvc0...1322server # [ 7.982467] systemd[1]: Expecting device /dev/ttyAMA0...1323server # [ 7.984126] systemd[1]: Reached target Local Encrypted Volumes.1324server # [ 7.985719] systemd[1]: Stopped target initrd-fs.target.1325server # [ 7.987260] systemd[1]: Stopped target initrd-root-fs.target.1326server # [ 7.988854] systemd[1]: Stopped target initrd-switch-root.target.1327server # [ 7.990463] systemd[1]: Reached target Virtual Machines and Containers.1328server # [ 7.992262] systemd[1]: Reached target Path Units.1329server # [ 7.994427] systemd[1]: Reached target Remote File Systems.1330server # [ 7.995557] systemd[1]: Reached target Slice Units.1331server # [ 7.997738] systemd[1]: Reached target Swaps.1332builder # [ 8.021050] systemd[1]: Mounted FUSE Control File System.1333server # [ 8.001512] systemd[1]: Listening on Query the User Interactively for a Password.1334server # [ 8.006122] systemd[1]: Listening on Process Core Dump Socket.1335server # [ 8.009909] systemd[1]: Listening on Credential Encryption/Decryption.1336server # [ 8.013668] systemd[1]: Listening on Factory Reset Management.1337server # [ 8.018953] systemd[1]: Starting Journal Log Access Socket...1338server # [ 8.021028] systemd[1]: Listening on Journal Audit Socket.1339server # [ 8.025675] systemd[1]: Listening on Console Output Muting Service Socket.1340server # [ 8.027284] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1341builder # [ 8.050255] systemd[1]: Mounted /run/wrappers.1342server # [ 8.029719] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1343server # [ 8.032296] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1344builder # [ 8.051291] systemd[1]: Reached target Local File Systems.1345builder # [ 8.060496] systemd[1]: Listening on Boot Loader Control Service Socket.1346server # [ 8.042206] systemd[1]: Listening on Disk Repartitioning Service Socket.1347server # [ 8.042647] systemd[1]: Listening on udev Control Socket.1348server # [ 8.043012] systemd[1]: Listening on udev Varlink Socket.1349builder # [ 8.066423] systemd[1]: Starting register-nix-paths.service...1350server # [ 8.048626] systemd[1]: Mounting Huge Pages File System...1351builder # [ 8.070624] systemd[1]: Starting Create SUID/SGID Wrappers...1352builder # [ 8.071594] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1353server # [ 8.052885] systemd[1]: Mounting POSIX Message Queue File System...1354builder # [ 8.081517] systemd[1]: Starting Save Transient machine-id to Disk...1355server # [ 8.060470] systemd[1]: Mounting Kernel Debug File System...1356server # [ 8.069723] systemd[1]: Mounting Kernel Trace File System...1357builder # [ 8.097034] systemd[1]: Starting Create System Files and Directories...1358server # [ 8.088548] systemd[1]: Starting Create List of Static Device Nodes...1359server # [ 8.102078] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1360server # [ 8.104929] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1361server # [ 8.117791] systemd[1]: Mounting Kernel Configuration File System...1362server # [ 8.120487] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1363server # [ 8.124450] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1364server # [ 8.136492] systemd[1]: Starting Load Kernel Module fuse...1365server # [ 8.136908] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671366server # [ 8.167256] systemd[1]: Starting Journal Service...1367builder # [ 8.196930] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1368server # [ 8.184716] systemd[1]: Starting Load Kernel Modules...1369builder # [ 8.203713] systemd[1]: Finished Save Transient machine-id to Disk.1370server # [ 8.202190] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1371server # [ 8.214714] systemd[1]: Starting Remount Root and Kernel File Systems...1372server # [ 8.217294] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1373server # [ 8.228915] systemd[1]: Starting Coldplug All udev Devices...1374server # [ 8.233625] systemd[1]: Listening on Journal Log Access Socket.1375server # [ 8.237633] systemd[1]: Mounted Huge Pages File System.1376server # [ 8.242249] systemd[1]: Mounted POSIX Message Queue File System.1377server # [ 8.242730] systemd[1]: Mounted Kernel Debug File System.1378server # [ 8.243158] systemd[1]: Mounted Kernel Trace File System.1379server # [ 8.246705] systemd[1]: Mounted Kernel Configuration File System.1380server # [ 8.280519] systemd[1]: Finished Create List of Static Device Nodes.1381server # [ 8.287055] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1382server # [ 8.345144] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1383server # [ 8.348525] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1384builder # [ 8.382822] systemd[1]: Finished Create System Files and Directories.1385builder # [ 8.386799] systemd[1]: Starting Rebuild Journal Catalog...1386builder # [ 8.395735] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1387server # [ 8.380587] EXT4-fs (vda): re-mounted 4bbfb231-5630-4a95-ad3b-cda5a030c167.1388server # [ 8.391593] systemd-journald[272]: Collecting audit messages is enabled.1389server # [ 8.400172] systemd[1]: Finished Remount Root and Kernel File Systems.1390builder # [ 8.422727] systemd-udevd[308]: Using default interface naming scheme 'v260'.1391server # [ 8.402650] systemd[1]: Listening on Disk Image Download Service Socket.1392server # [ 8.387470] systemd[1]: Queued start job for default target Multi-User System.1393server # [ 8.408052] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1394server # [ 8.420543] fuse: init (API version 7.45)1395server # [ 8.424298] systemd[1]: Starting Load/Save OS Random Seed...1396server # [ 8.426564] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1397server # [ 8.410336] systemd[1]: systemd-journald.service: Deactivated successfully.1398server # [ 8.430854] systemd[1]: Started Journal Service.1399server # [ 8.428645] systemd-modules-load[273]: Module 'atkbd' is built in1400server # [ 8.438032] systemd-modules-load[273]: Module 'loop' is built in1401server # [ 8.449023] systemd-modules-load[273]: Inserted module 'tls'1402server # [ 8.460352] systemd-modules-load[273]: Module 'tun' is built in1403builder # [ 8.507510] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1404server # [ 8.478128] systemd[1]: Starting Flush Journal to Persistent Storage...1405server # [ 8.484803] systemd[1]: Finished Load Kernel Modules.1406server # [ 8.492894] systemd[1]: Starting Firewall...1407server # [ 8.503046] systemd[1]: Starting Apply Kernel Variables...1408server # [ 8.514202] systemd[1]: modprobe@fuse.service: Deactivated successfully.1409server # [ 8.518587] systemd[1]: Finished Load Kernel Module fuse.1410server # [ 8.531199] systemd-oomd[274]: No swap; memory pressure usage will be degraded1411server # [ 8.544234] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1412server # [ 8.569924] systemd-journald[272]: Received client request to flush runtime journal.1413builder # [ 8.629791] systemd[1]: Finished Rebuild Journal Catalog.1414builder # [ 8.640878] systemd[1]: Starting Update is Completed...1415server # [ 8.619080] systemd[1]: Finished Load/Save OS Random Seed.1416server # [ 8.629242] systemd[1]: Reached target First Boot Complete.1417server # [ 8.634736] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1418server # [ 8.642748] systemd[1]: Starting Create Static Device Nodes in /dev...1419server # [ 8.647792] systemd[1]: Finished Flush Journal to Persistent Storage.1420server # [ 8.652885] systemd[1]: Finished Apply Kernel Variables.1421builder # [ 8.746059] systemd[1]: Finished Update is Completed.1422builder # [ 8.757605] systemd[1]: Started Rule-based Manager for Device Events and Files.1423server # [ 8.747599] systemd[1]: Finished Create Static Device Nodes in /dev.1424server # [ 8.749001] systemd[1]: Reached target Preparation for Local File Systems.1425server # [ 8.751478] systemd[1]: Starting Rule-based Manager for Device Events and Files...1426server # [ 8.868913] systemd-udevd[310]: Using default interface naming scheme 'v260'.1427server # [ 8.952162] systemd[1]: Mounting /run/wrappers...1428server # [ 8.955653] systemd[1]: Mounting FUSE Control File System...1429server # [ 8.993481] systemd[1]: Mounted FUSE Control File System.1430server # [ 9.034624] systemd[1]: Mounted /run/wrappers.1431server # [ 9.039071] systemd[1]: Reached target Local File Systems.1432server # [ 9.044525] systemd[1]: Listening on Boot Loader Control Service Socket.1433server # [ 9.047903] systemd[1]: Starting register-nix-paths.service...1434server # [ 9.052476] systemd[1]: Starting Create SUID/SGID Wrappers...1435server # [ 9.073243] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1436server # [ 9.080569] systemd[1]: Starting Save Transient machine-id to Disk...1437server # [ 9.086391] systemd[1]: Starting Create System Files and Directories...1438server # [ 9.154286] systemd[1]: Started Rule-based Manager for Device Events and Files.1439server # [ 9.179908] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1440builder # [ 9.226489] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1441server # [ 9.189176] systemd[1]: Finished Save Transient machine-id to Disk.1442builder # [ 9.232250] systemd[1]: Finished Create SUID/SGID Wrappers.1443server # [ 9.328126] systemd[1]: Finished Create System Files and Directories.1444server # [ 9.337099] systemd[1]: Starting Rebuild Journal Catalog...1445server # [ 9.342234] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1446builder # [ 9.461590] systemd[1]: Finished register-nix-paths.service.1447server # [ 9.443945] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1448builder # [ 9.553297] systemd[1]: Finished Firewall.1449server # [ 9.528106] systemd[1]: Finished Rebuild Journal Catalog.1450server # [ 9.537295] systemd[1]: Starting Update is Completed...1451server # [ 9.640608] systemd[1]: Finished Update is Completed.1452builder # [ 9.949793] systemd[1]: Finished Coldplug All udev Devices.1453builder # [ 9.951624] systemd[1]: Reached target System Initialization.1454builder # [ 9.952779] systemd[1]: Started Discard unused filesystem blocks once a week.1455builder # [ 9.955329] systemd[1]: Started Daily Cleanup of Temporary Directories.1456builder # [ 9.961183] systemd[1]: Reached target Timer Units.1457builder # [ 9.967286] systemd[1]: Listening on D-Bus System Message Bus Socket.1458builder # [ 9.970084] systemd[1]: Starting niks3 auto-upload socket...1459builder # [ 9.973633] systemd[1]: Listening on Nix Daemon Socket.1460builder # [ 9.975324] systemd[1]: Listening on Hostname Service Socket.1461builder # [ 9.980450] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1462builder # [ 9.981873] systemd[1]: Starting D-Bus System Message Bus...1463builder # [ 9.983114] systemd[1]: Listening on niks3 auto-upload socket.1464builder # [ 9.992269] systemd[1]: Reached target Socket Units.1465server # [ 10.043523] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1466builder # [ 10.089658] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'...1467server # [ 10.051602] systemd[1]: Finished Create SUID/SGID Wrappers.1468builder # [ 10.104498] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync'1469builder # [ 10.107228] dbus-broker-launch[484]: Invalid user-name in /nix/store/4mzz1dahk3p5fp5rs73xzcsbfhp1jax0-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1470builder # [ 10.137687] systemd[1]: Started D-Bus System Message Bus.1471builder # [ 10.165915] systemd[1]: Reached target Basic System.1472builder # [ 10.172271] dbus-broker-launch[484]: Ready1473builder # [ 10.174873] systemd[1]: Starting Import lastlog data into lastlog2 database...1474builder # [ 10.180184] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1475builder # [ 10.189074] systemd[1]: Starting Post-Boot Actions...1476builder # [ 10.193408] systemd[1]: Started Reset console on configuration changes.1477builder # [ 10.205572] systemd[1]: Starting resolvconf update...1478server # [ 10.197796] systemd[1]: Finished register-nix-paths.service.1479builder # [ 10.289162] systemd[1]: Finished Post-Boot Actions.1480builder # [ 10.340510] systemd[1]: Started Name Service Cache Daemon (nsncd).1481builder # [ 10.348220] nsncd[487]: Jul 07 08:17:07.988 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1482builder # [ 10.356698] systemd[1]: Reached target Host and Network Name Lookups.1483builder # [ 10.363987] systemd[1]: Reached target User and Group Name Lookups.1484builder # [ 10.369290] systemd[1]: Starting User Login Management...1485builder # [ 10.373101] systemd[1]: Finished Import lastlog data into lastlog2 database.1486builder # [ 10.476596] systemd[1]: Stopped target Host and Network Name Lookups.1487builder # [ 10.485176] systemd[1]: Stopping Host and Network Name Lookups...1488builder # [ 10.488272] systemd[1]: Stopped target User and Group Name Lookups.1489builder # [ 10.499301] systemd[1]: Stopping User and Group Name Lookups...1490builder # [ 10.504686] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1491builder # [ 10.509832] systemd[1]: nscd.service: Deactivated successfully.1492builder # [ 10.523176] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1493builder # [ 10.527518] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1494server # [ 10.488332] systemd[1]: Finished Firewall.1495builder # [ 10.535683] systemd-logind[499]: New seat seat0.1496builder # [ 10.538421] systemd[1]: Started User Login Management.1497builder # [ 10.541898] systemd[1]: Starting linger-users.service...1498builder # [ 10.598533] systemd[1]: Started Name Service Cache Daemon (nsncd).1499builder # [ 10.604299] systemd[1]: Reached target Host and Network Name Lookups.1500builder # [ 10.607672] nsncd[547]: Jul 07 08:17:08.248 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1501builder # [ 10.613446] systemd[1]: Reached target User and Group Name Lookups.1502builder # [ 10.616904] systemd[1]: linger-users.service: Deactivated successfully.1503builder # [ 10.619601] systemd[1]: Finished linger-users.service.1504builder # [ 10.644624] systemd[1]: Finished resolvconf update.1505builder # [ 10.646735] systemd[1]: Reached target Preparation for Network.1506builder # [ 10.651006] systemd[1]: Starting DHCP Client...1507builder # [ 10.654882] systemd[1]: Starting Extra networking commands....1508server # [ 10.648679] systemd[1]: Finished Coldplug All udev Devices.1509server # [ 10.649828] systemd[1]: Reached target System Initialization.1510server # [ 10.650694] systemd[1]: Started Discard unused filesystem blocks once a week.1511server # [ 10.651726] systemd[1]: Started niks3 garbage collection timer.1512server # [ 10.656327] systemd[1]: Started Daily Cleanup of Temporary Directories.1513server # [ 10.657325] systemd[1]: Reached target Timer Units.1514server # [ 10.658692] systemd[1]: Listening on D-Bus System Message Bus Socket.1515server # [ 10.660084] systemd[1]: Listening on niks3 server socket.1516server # [ 10.669946] systemd[1]: Listening on Nix Daemon Socket.1517server # [ 10.672309] systemd[1]: Listening on Hostname Service Socket.1518server # [ 10.677725] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1519server # [ 10.684510] systemd[1]: Reached target Socket Units.1520server # [ 10.685787] systemd[1]: Reached target Basic System.1521server # [ 10.688474] systemd[1]: Starting Import lastlog data into lastlog2 database...1522server # [ 10.702465] systemd[1]: Starting Generate test mTLS certs...1523server # [ 10.708489] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1524server # [ 10.718885] systemd[1]: Starting Post-Boot Actions...1525server # [ 10.732771] systemd[1]: Started Reset console on configuration changes.1526server # [ 10.739334] systemd[1]: Starting resolvconf update...1527server # [ 10.749349] systemd[1]: Starting D-Bus System Message Bus...1528server # [ 10.819610] systemd[1]: Finished Post-Boot Actions.1529builder # [ 10.891454] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31530builder # [ 10.884520] dhcpcd[581]: dhcpcd-10.3.2 starting1531builder # [ 10.901090] dhcpcd[616]: dev: loaded udev1532server # [ 10.865124] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1533builder # [ 10.907790] dhcpcd[616]: no valid interfaces found1534builder # [ 10.909384] dhcpcd[616]: no valid interfaces found1535server # [ 10.882999] systemd[1]: Started Name Service Cache Daemon (nsncd).1536server # [ 10.891123] nsncd[502]: Jul 07 08:17:08.533 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1537builder # [ 10.934258] systemd[1]: Finished Extra networking commands..1538builder # [ 10.936349] systemd[1]: Reached target Network.1539builder # [ 10.939514] systemd[1]: Starting Permit User Sessions...1540server # [ 10.905167] systemd[1]: Reached target Host and Network Name Lookups.1541server # [ 10.911841] systemd[1]: Reached target User and Group Name Lookups.1542server # [ 10.916838] systemd[1]: Starting User Login Management...1543server # [ 10.921398] systemd[1]: Finished Import lastlog data into lastlog2 database.1544builder # [ 10.996792] systemd[1]: Finished Permit User Sessions.1545builder # [ 11.001228] systemd[1]: Started Getty on tty1.1546builder # [ 11.002591] systemd[1]: Reached target Login Prompts.1547server # [ 10.973329] niks3-test-certs-start[514]: -----1548server # [ 10.993657] dbus-broker-launch[506]: Looking up NSS user entry for 'systemd-timesync'...1549server # [ 11.015887] dbus-broker-launch[506]: NSS returned no entry for 'systemd-timesync'1550server # [ 11.023592] dbus-broker-launch[506]: Invalid user-name in /nix/store/vjb6hhwmhx6vbfrhb8qzdrx1wyz50kpf-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1551server # [ 11.037274] niks3-test-certs-start[544]: -----1552server # [ 11.075899] systemd[1]: Started D-Bus System Message Bus.1553server # [ 11.130751] systemd-logind[516]: New seat seat0.1554server # [ 11.136397] dbus-broker-launch[506]: Ready1555server # [ 11.143225] systemd[1]: Started User Login Management.1556server # [ 11.151289] systemd[1]: Starting linger-users.service...1557server # [ 11.163677] systemd[1]: Stopped target Host and Network Name Lookups.1558server # [ 11.173056] systemd[1]: Stopping Host and Network Name Lookups...1559server # [ 11.184536] systemd[1]: Stopped target User and Group Name Lookups.1560server # [ 11.190341] systemd[1]: Stopping User and Group Name Lookups...1561server # [ 11.193440] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1562server # [ 11.197166] systemd[1]: nscd.service: Deactivated successfully.1563server # [ 11.202112] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1564server # [ 11.207429] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1565server # [ 11.218300] niks3-test-certs-start[553]: Certificate request self-signature ok1566server # [ 11.221887] niks3-test-certs-start[553]: subject=CN=server1567builder # [ 11.274439] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1568builder # [ 11.283674] systemd[1]: Starting Virtual Console Setup...1569server # [ 11.265607] systemd[1]: linger-users.service: Deactivated successfully.1570builder # [ 11.307978] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1571builder # [ 11.311976] systemd[1]: Stopped Virtual Console Setup.1572server # [ 11.273587] systemd[1]: Finished linger-users.service.1573builder # [ 11.314016] systemd[1]: Starting Virtual Console Setup...1574server # [ 11.276868] niks3-test-certs-start[578]: -----1575server # [ 11.299768] nsncd[568]: Jul 07 08:17:08.948 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1576server # [ 11.309182] systemd[1]: Started Name Service Cache Daemon (nsncd).1577server # [ 11.312948] systemd[1]: Reached target Host and Network Name Lookups.1578server # [ 11.317182] systemd[1]: Reached target User and Group Name Lookups.1579server # [ 11.351934] systemd[1]: Finished resolvconf update.1580server # [ 11.359276] systemd[1]: Reached target Preparation for Network.1581server # [ 11.363602] systemd[1]: Starting DHCP Client...1582server # [ 11.365755] systemd[1]: Starting Extra networking commands....1583server # [ 11.380521] niks3-test-certs-start[583]: Certificate request self-signature ok1584server # [ 11.382717] niks3-test-certs-start[583]: subject=CN=niks3 test client1585server # [ 11.417174] systemd[1]: Finished Generate test mTLS certs.1586server # [ 11.488001] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1587builder # [ 11.595506] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1588server # [ 11.573847] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1589server # [ 11.578769] systemd[1]: Started backdoor.service.1590builder # [ 11.658463] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1591builder # [ 11.663263] systemd[1]: Started backdoor.service.1592server # [ 11.627198] dhcpcd[606]: dhcpcd-10.3.2 starting1593server # [ 11.648107] dhcpcd[642]: dev: loaded udev1594builder # [ 11.737168] 8021q: 802.1Q VLAN Support v1.81595server # [ 11.702767] 8021q: 802.1Q VLAN Support v1.81596server # [ 11.697930] systemd[1]: Finished Extra networking commands..1597server # [ 11.711274] systemd[1]: Reached target Network.1598server # [ 11.717134] systemd[1]: Started Mock OIDC server for testing.1599server # [ 11.732127] systemd[1]: Starting Nginx Web Server...1600builder # [ 11.776502] (udev-worker)[638]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1601server # connecting to host...1602builder # [ 11.789922] (udev-worker)[638]: Network interface NamePolicy= disabled on kernel command line.1603server # [ 11.762080] systemd[1]: Starting PostgreSQL Server...1604server # [ 11.762903] systemd[1]: Started RustFS S3-compatible object storage.1605server # [ 11.763821] systemd[1]: Starting Setup RustFS bucket...1606builder # [ 11.825820] cfg80211: Loading compiled-in X.509 certificates for regulatory database1607builder # [ 11.823833] (udev-worker)[636]: Network interface NamePolicy= disabled on kernel command line.1608builder # connecting to host...1609server # [ 11.809562] cfg80211: Loading compiled-in X.509 certificates for regulatory database1610server # [ 11.804376] systemd[1]: Starting Permit User Sessions...1611builder # [ 11.862291] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1612builder # [ 11.862798] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1613builder # [ 11.867723] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21614builder # [ 11.869271] cfg80211: failed to load regulatory.db1615server # [ 11.846289] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1616server # [ 11.846784] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1617server # [ 11.852230] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21618server # [ 11.852569] cfg80211: failed to load regulatory.db1619server # [ 11.844435] dhcpcd[642]: no valid interfaces found1620server # [ 11.849006] dhcpcd[642]: no valid interfaces found1621server # [ 11.849924] dhcpcd[642]: libudev: received NULL device1622server # [ 11.850646] dhcpcd[642]: libudev: received NULL device1623server: Guest shell says: b'Spawning backdoor root shell...\n'1624server: connected to guest root shell1625builder # [ 11.920306] systemd-vconsole-setup[633]: Configuration of first virtual console was skipped, ignoring remaining ones.1626server: (connecting took 12.25 seconds)1627builder # [ 11.926618] systemd[1]: Finished Virtual Console Setup.1628server: (finished: waiting for the VM to finish booting, in 12.25 seconds)1629server # [ 11.946707] systemd[1]: Finished Permit User Sessions.1630server # [ 11.956565] systemd[1]: Started Getty on tty1.1631server # [ 11.957305] systemd[1]: Reached target Login Prompts.1632builder # [ 12.012375] systemd[1]: Condition check resulted in Virtio network device being skipped.1633builder # [ 12.016792] systemd[1]: Starting Address configuration of eth1...1634builder # [ 12.123944] 8021q: adding VLAN 0 to HW filter on device eth01635builder # [ 12.112406] dhcpcd[616]: eth0: waiting for carrier1636builder # [ 12.115505] dhcpcd[616]: eth0: carrier acquired1637builder # [ 12.140183] 8021q: adding VLAN 0 to HW filter on device eth11638server # [ 12.088537] mock-oidc-server[655]: Mock OIDC Server running1639builder # [ 12.133275] dhcpcd[616]: DUID 00:01:00:01:31:df:72:85:52:54:00:12:34:561640server # [ 12.094985] mock-oidc-server[655]: OIDC Address: 127.0.0.1:80801641builder # [ 12.135328] dhcpcd[616]: eth0: IAID 00:12:34:561642builder # [ 12.136812] dhcpcd[616]: eth0: adding address fe80::5054:ff:fe12:34561643server # [ 12.101222] mock-oidc-server[655]: Issue Address: 127.0.0.1:80811644server # [ 12.105618] mock-oidc-server[655]: Issuer: http://127.0.0.1:8080/oidc1645builder # [ 12.147743] network-addresses-eth1-start[662]: adding address 192.168.1.1/24... done1646server # [ 12.108281] mock-oidc-server[655]: JWKS: http://127.0.0.1:8080/oidc/.well-known/jwks.json1647server # [ 12.111883] mock-oidc-server[655]: Discovery: http://127.0.0.1:8080/oidc/.well-known/openid-configuration1648server # [ 12.116311] mock-oidc-server[655]: Issue tokens: http://127.0.0.1:8081/issue?sub=...1649builder # [ 12.163986] network-addresses-eth1-start[662]: adding address 2001:db8:1::1/64... done1650builder # [ 12.185338] systemd[1]: Finished Address configuration of eth1.1651builder # [ 12.190717] systemd-logind[499]: Watching system buttons on /dev/input/event0 (gpio-keys)1652builder # [ 12.291236] mousedev: PS/2 mouse device common for all mice1653builder # [ 12.304095] systemd-logind[499]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1654server # [ 12.405065] nginx-pre-start[688]: nginx: the configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf syntax is ok1655server # [ 12.406993] postgresql-pre-start[692]: The files belonging to this database system will be owned by user "postgres".1656server # [ 12.418132] postgresql-pre-start[692]: This user must also own the server process.1657server # [ 12.424003] nginx-pre-start[688]: nginx: configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf test is successful1658server # [ 12.431551] systemd[1]: Started Nginx Web Server.1659server # [ 12.437849] postgresql-pre-start[692]: The database cluster will be initialized with locale "en_US.UTF-8".1660server # [ 12.439113] postgresql-pre-start[692]: The default database encoding has accordingly been set to "UTF8".1661server # [ 12.445436] postgresql-pre-start[692]: The default text search configuration will be set to "english".1662server # [ 12.451323] postgresql-pre-start[692]: Data page checksums are disabled.1663server # [ 12.461530] postgresql-pre-start[692]: fixing permissions on existing directory /var/lib/postgresql/17 ... ok1664server # [ 12.462858] postgresql-pre-start[692]: creating subdirectories ... ok1665server # [ 12.463728] postgresql-pre-start[692]: selecting dynamic shared memory implementation ... posix1666server # [ 12.518140] (udev-worker)[695]: Network interface NamePolicy= disabled on kernel command line.1667server # [ 12.519628] (udev-worker)[693]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1668server # [ 12.533731] (udev-worker)[693]: Network interface NamePolicy= disabled on kernel command line.1669server # [ 12.675500] postgresql-pre-start[692]: selecting default "max_connections" ... 1001670server # [ 12.841671] postgresql-pre-start[692]: selecting default "shared_buffers" ... 128MB1671server # [ 12.898281] systemd[1]: Condition check resulted in Virtio network device being skipped.1672server # [ 12.906820] systemd-logind[516]: Watching system buttons on /dev/input/event0 (gpio-keys)1673server # [ 12.916584] systemd[1]: Starting Address configuration of eth1...1674server # [ 13.033312] 8021q: adding VLAN 0 to HW filter on device eth01675server # [ 13.020091] dhcpcd[642]: eth0: waiting for carrier1676server # [ 13.022548] dhcpcd[642]: eth0: carrier acquired1677server # [ 13.059733] 8021q: adding VLAN 0 to HW filter on device eth11678server # [ 13.045363] dhcpcd[642]: DUID 00:01:00:01:31:df:72:86:52:54:00:12:34:561679server # [ 13.047976] dhcpcd[642]: eth0: IAID 00:12:34:561680server # [ 13.051690] dhcpcd[642]: eth0: adding address fe80::5054:ff:fe12:34561681server # [ 13.070021] network-addresses-eth1-start[729]: adding address 192.168.1.2/24... done1682server # [ 13.089106] network-addresses-eth1-start[729]: adding address 2001:db8:1::2/64... done1683server # [ 13.117232] systemd[1]: Finished Address configuration of eth1.1684server # [ 13.170662] rustfs[658]: {"timestamp":"2026-07-07T08:17:10.81941032Z","level":"ERROR","fields":{"message":"list_path_raw: revjob err VolumeNotFound"},"target":"rustfs_ecstore::cache_value::metacache_set","filename":"crates/ecstore/src/cache_value/metacache_set.rs","line_number":486,"threadName":"rustfs-worker","threadId":"ThreadId(3)"}1685server # [ 13.319454] mousedev: PS/2 mouse device common for all mice1686server # [ 13.391313] systemd-logind[516]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1687builder # [ 13.440986] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1688builder # [ 13.454446] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1689builder # [ 13.455567] systemd[1]: Stopped Virtual Console Setup.1690builder # [ 13.459504] systemd[1]: Stopping Virtual Console Setup...1691builder # [ 13.462714] systemd[1]: Starting Virtual Console Setup...1692builder # [ 13.489684] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1693builder # [ 13.490750] systemd[1]: Stopped Virtual Console Setup.1694builder # [ 13.497838] systemd[1]: Starting Virtual Console Setup...1695builder # [ 13.523626] systemd-logind[499]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1696builder # [ 13.640554] dhcpcd[616]: eth0: soliciting a DHCP lease1697builder # [ 13.648777] dhcpcd[616]: eth0: offered 10.0.2.15 from 10.0.2.21698builder # [ 13.656195] dhcpcd[616]: eth0: probing address 10.0.2.15/241699builder # [ 13.808551] systemd-vconsole-setup[686]: Configuration of first virtual console was skipped, ignoring remaining ones.1700builder # [ 13.813450] systemd[1]: Finished Virtual Console Setup.1701server # [ 14.084183] dhcpcd[642]: eth0: soliciting a DHCP lease1702server # [ 14.088933] dhcpcd[642]: eth0: offered 10.0.2.15 from 10.0.2.21703server # [ 14.096259] dhcpcd[642]: eth0: probing address 10.0.2.15/241704builder # [ 14.160485] dhcpcd[616]: eth0: soliciting an IPv6 router1705builder # [ 14.164064] dhcpcd[616]: eth0: Router Advertisement from fe80::21706builder # [ 14.166612] dhcpcd[616]: eth0: adding address fec0::5054:ff:fe12:3456/641707builder # [ 14.169449] dhcpcd[616]: eth0: adding route to fec0::/641708builder # [ 14.171817] dhcpcd[616]: eth0: adding default route via fe80::21709server # [ 14.545965] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31710server # [ 15.198337] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1711server # [ 15.223159] systemd[1]: Starting Virtual Console Setup...1712server # [ 15.249947] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1713server # [ 15.251199] systemd[1]: Stopped Virtual Console Setup.1714server # [ 15.255428] systemd[1]: Starting Virtual Console Setup...1715server # [ 15.335135] systemd-logind[516]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1716server # [ 15.567805] postgresql-pre-start[692]: selecting default time zone ... UTC1717server # [ 15.572329] postgresql-pre-start[692]: creating configuration files ... ok1718server # [ 15.725459] dhcpcd[642]: eth0: soliciting an IPv6 router1719server # [ 15.726906] dhcpcd[642]: eth0: Router Advertisement from fe80::21720server # [ 15.728932] dhcpcd[642]: eth0: adding address fec0::5054:ff:fe12:3456/641721server # [ 15.731222] dhcpcd[642]: eth0: adding route to fec0::/641722server # [ 15.733771] dhcpcd[642]: eth0: adding default route via fe80::21723server # [ 15.764178] systemd-vconsole-setup[776]: Configuration of first virtual console was skipped, ignoring remaining ones.1724server # [ 15.770419] systemd[1]: Finished Virtual Console Setup.1725server # [ 15.877671] postgresql-pre-start[692]: running bootstrap script ... ok1726server # [ 16.435250] postgresql-pre-start[692]: performing post-bootstrap initialization ... ok1727server # [ 16.603085] postgresql-pre-start[692]: syncing data to disk ... ok1728server # [ 16.604106] postgresql-pre-start[692]: initdb: warning: enabling "trust" authentication for local connections1729server # [ 16.605486] postgresql-pre-start[692]: initdb: hint: You can change this by editing pg_hba.conf or using the option -A, or --auth-local and --auth-host, the next time you run initdb.1730server # [ 16.607654] postgresql-pre-start[692]: Success. You can now start the database server using:1731server # [ 16.608998] postgresql-pre-start[692]: pg_ctl -D /var/lib/postgresql/17 -l logfile start1732server # [ 16.723033] postgres[794]: [794] LOG: starting PostgreSQL 17.10 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit1733server # [ 16.726593] postgres[794]: [794] LOG: listening on IPv6 address "::1", port 54321734server # [ 16.727791] postgres[794]: [794] LOG: listening on IPv4 address "127.0.0.1", port 54321735server # [ 16.729699] postgres[794]: [794] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"1736server # [ 16.740557] postgres[800]: [800] LOG: database system was shut down at 2026-07-07 08:17:14 GMT1737server # [ 16.749240] postgres[794]: [794] LOG: database system is ready to accept connections1738server # [ 16.756361] systemd[1]: Started PostgreSQL Server.1739server # [ 16.759344] systemd[1]: Starting PostgreSQL Setup Scripts...1740server # [ 16.943914] postgresql-setup-start[811]: CREATE DATABASE1741server # [ 16.993099] postgresql-setup-start[816]: CREATE ROLE1742server # [ 17.018556] postgresql-setup-start[818]: ALTER DATABASE1743server # [ 17.029357] systemd[1]: Finished PostgreSQL Setup Scripts.1744server # [ 17.031255] systemd[1]: Reached target PostgreSQL.1745server: (finished: waiting for unit postgresql.service, in 17.90 seconds)1746server: waiting for unit rustfs.service1747server: (finished: waiting for unit rustfs.service, in 0.10 seconds)1748server: waiting for unit rustfs-setup.service1749builder # [ 18.487189] dhcpcd[616]: eth0: leased 10.0.2.15 for 86400 seconds1750builder # [ 18.491590] dhcpcd[616]: eth0: adding route to 10.0.2.0/241751builder # [ 18.494712] dhcpcd[616]: eth0: adding default route via 10.0.2.21752builder # [ 18.633021] systemd[1]: Started DHCP Client.1753builder # [ 18.634490] systemd[1]: Reached target Multi-User System.1754builder # [ 18.635815] systemd[1]: Startup finished in 923ms (kernel) + 4.049s (initrd) + 13.662s (userspace) = 18.635s.1755server # [ 18.834907] dhcpcd[642]: eth0: leased 10.0.2.15 for 86400 seconds1756server # [ 18.840232] dhcpcd[642]: eth0: adding route to 10.0.2.0/241757server # [ 18.842011] dhcpcd[642]: eth0: adding default route via 10.0.2.21758server # [ 18.963908] systemd[1]: Started DHCP Client.1759server # [ 27.253043] rustfs-setup-start[919]: mb s3://niks3-test1760server # [ 27.260182] systemd[1]: Finished Setup RustFS bucket.1761server # [ 27.267261] systemd[1]: Starting niks3 server...1762server: (finished: waiting for unit rustfs-setup.service, in 9.74 seconds)1763server: waiting for unit mock-oidc.service1764server # [ 27.494225] postgres[939]: [939] ERROR: relation "goose_db_version" does not exist at character 361765server # [ 27.498560] postgres[939]: [939] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1766server: (finished: waiting for unit mock-oidc.service, in 0.08 seconds)1767server: waiting for unit niks3.service1768server # [ 27.543838] niks3-server[926]: 2026/07/07 08:17:25 OK 20241026095416_initial_model.sql (27.03ms)1769server # [ 27.560912] niks3-server[926]: 2026/07/07 08:17:25 OK 20251210153512_drop_unused_gin_index.sql (4.49ms)1770server # [ 27.564147] niks3-server[926]: 2026/07/07 08:17:25 OK 20251218171726_add_pins.sql (5.46ms)1771server # [ 27.565333] niks3-server[926]: 2026/07/07 08:17:25 OK 20260628120000_add_object_size_and_stats.sql (4.95ms)1772server # [ 27.566644] niks3-server[926]: 2026/07/07 08:17:25 goose: successfully migrated database to version: 202606281200001773server # [ 27.572326] niks3-server[926]: 2026/07/07 08:17:25 OK 1_commit_pending_closure.sql (5.15ms)1774server # [ 27.574057] niks3-server[926]: 2026/07/07 08:17:25 OK 2_object_stats_trigger.sql (9.98ms)1775server # [ 27.577434] niks3-server[926]: 2026/07/07 08:17:25 goose: up to current file version: 21776server # [ 27.596076] niks3-server[926]: 2026/07/07 08:17:25 INFO OIDC provider initialized name=test1777server # [ 27.597469] niks3-server[926]: 2026/07/07 08:17:25 INFO OIDC authentication enabled config=/nix/store/2za6kyy80mq2xh1w4ydfs7gg8psbv5g3-niks3-oidc.json1778server # [ 27.600690] niks3-server[926]: 2026/07/07 08:17:25 INFO Loaded signing key name=niks3-test-1 path=/nix/store/1cz670ydszbfkf0naknmhg579xvlcyr7-niks3-signing-key1779server # [ 27.632550] rustfs[658]: {"timestamp":"2026-07-07T08:17:25.28255134Z","level":"ERROR","fields":{"message":"system path read failed","path_kind":"data_usage","operation":"read_primary","reason":"config_not_found","object":"buckets/.usage.json","error":"Config not found"},"target":"rustfs_ecstore::data_usage","filename":"crates/ecstore/src/data_usage.rs","line_number":126,"threadName":"rustfs-worker","threadId":"ThreadId(3)"}1780server # [ 27.638641] niks3-server[926]: 2026/07/07 08:17:25 INFO Created nix-cache-info in bucket bucket=niks3-test1781server # [ 27.640854] niks3-server[926]: 2026/07/07 08:17:25 INFO Using socket-activated listener address=0.0.0.0:57511782server # [ 27.644356] niks3-server[926]: 2026/07/07 08:17:25 INFO systemd watchdog enabled interval=15s1783server # [ 27.645537] niks3-server[926]: 2026/07/07 08:17:25 INFO Starting HTTP server address=0.0.0.0:57511784server # [ 27.646715] systemd[1]: Started niks3 server.1785server # [ 27.647360] systemd[1]: Reached target Multi-User System.1786server # [ 27.648160] systemd[1]: Startup finished in 918ms (kernel) + 4.986s (initrd) + 21.738s (userspace) = 27.643s.1787server: (finished: waiting for unit niks3.service, in 1.19 seconds)1788server: waiting for TCP port 5751 on localhost1789server # Connection to localhost (127.0.0.1) 5751 port [tcp/*] succeeded!1790server: (finished: waiting for TCP port 5751 on localhost, in 0.07 seconds)1791server: waiting for TCP port 8080 on localhost1792server # Connection to localhost (127.0.0.1) 8080 port [tcp/http-alt] succeeded!1793server: (finished: waiting for TCP port 8080 on localhost, in 0.04 seconds)1794server: waiting for TCP port 9000 on localhost1795server # Connection to localhost (127.0.0.1) 9000 port [tcp/cslistener] succeeded!1796server: (finished: waiting for TCP port 9000 on localhost, in 0.04 seconds)1797server: must succeed: mkdir -p /tmp/test-config1798server: (finished: must succeed: mkdir -p /tmp/test-config, in 0.03 seconds)1799server: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token1800server: (finished: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token, in 0.02 seconds)1801server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31802server # [ 29.101413] systemd[1]: Created slice Slice /system/nix-daemon.1803server # [ 29.106054] systemd[1]: Started Nix Daemon instance (PID 981/UID 0).1804server # [ 29.190689] nix-daemon[983]: remote pid 981 is unknown user (trusted)1805server # [ 29.211998] systemd[1]: nix-daemon@0-1-981_982-0.service: Deactivated successfully.1806server # [ 29.227545] niks3-server[926]: 2026/07/07 08:17:26 INFO Received uploads request method=POST path=/api/pending_closures1807server # time=2026-07-07T08:17:26.896Z level=INFO msg="Uploading 5 paths to server (0 already cached)"1808server # time=2026-07-07T08:17:26.897Z level=INFO msg="Uploading jp8avbmpfcdnm0axwrzyk072nmq9cr0d-glibc-2.42-67 (44.4MB)"1809server # time=2026-07-07T08:17:26.900Z level=INFO msg="Uploading wp59zwnmv6h2glrrb9rd7siprz1mxn6r-xgcc-15.2.0-libgcc (150.1KB)"1810server # time=2026-07-07T08:17:26.903Z level=INFO msg="Uploading qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3 (287.5KB)"1811server # time=2026-07-07T08:17:26.905Z level=INFO msg="Uploading 020cvdgp5va6j1mdz75s2nzfz25k37v2-libunistring-1.4.2 (2.0MB)"1812server # time=2026-07-07T08:17:26.907Z level=INFO msg="Uploading fqhxni8jcvyf5id4rvg9x2y00qx1963d-libidn2-2.3.8 (366.1KB)"1813server # [ 30.929411] niks3-server[926]: 2026/07/07 08:17:28 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1814server # [ 30.943132] niks3-server[926]: 2026/07/07 08:17:28 INFO Completed multipart upload object_key=nar/0n9jhh8wlbk6hqhzsklzl8vbv6xab1d7yi91hr9z948fzw5s80jd.nar.zst upload_id=ZDJjYmIxZjQtNTNmMC00M2EzLWExM2QtYjM5ZjUwZGIzNmVhLjhjODczZmM1LTViMzMtNDllZi05MzJmLTQ3OWVlYmJjOTYxNXgxNzgzNDEyMjQ2ODkyMDQwNjQw parts=11815server # [ 30.951992] niks3-server[926]: 2026/07/07 08:17:28 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1816server # [ 30.955897] niks3-server[926]: 2026/07/07 08:17:28 INFO Signed narinfos id=1 count=51817server # time=2026-07-07T08:17:28.608Z level=INFO msg="Uploading 5 narinfos"1818server # [ 30.969184] niks3-server[926]: 2026/07/07 08:17:28 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1819server # time=2026-07-07T08:17:28.626Z level=INFO msg="Upload complete. (1.942s)"1820server # [ 30.977055] niks3-server[926]: 2026/07/07 08:17:28 INFO Completed upload id=11821server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 2.10 seconds)1822server: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token1823server: (finished: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token, in 0.02 seconds)1824server: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31825server # [ 31.148897] systemd[1]: Started Nix Daemon instance (PID 1008/UID 0).1826server # [ 31.228900] nix-daemon[1010]: remote pid 1008 is unknown user (trusted)1827server # [ 31.247403] systemd[1]: nix-daemon@1-2-1008_1009-0.service: Deactivated successfully.1828server # [ 31.253401] niks3-server[926]: 2026/07/07 08:17:28 WARN Authentication failed token_preview=invalid-token token_length=13 oidc_error="no provider could verify the token (signature or issuer mismatch)" oidc_provider="" tried_providers=[test]1829server # time=2026-07-07T08:17:28.907Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1830server: (finished: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.26 seconds)1831server: waiting for unit nginx.service1832server: (finished: waiting for unit nginx.service, in 0.06 seconds)1833server: waiting for TCP port 443 on localhost1834server # Connection to localhost (::1) 443 port [tcp/https] succeeded!1835server: (finished: waiting for TCP port 443 on localhost, in 0.03 seconds)1836server: must succeed: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem --client-cert /etc/niks3-test-certs/client.pem --client-key /etc/niks3-test-certs/client.key /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31837server # time=2026-07-07T08:17:29.084Z level=INFO msg="Configuring client TLS" cert=/etc/niks3-test-certs/client.pem key=/etc/niks3-test-certs/client.key ca=/etc/niks3-test-certs/ca.pem1838server # [ 31.497712] systemd[1]: Started Nix Daemon instance (PID 1035/UID 0).1839server # [ 31.574834] nix-daemon[1037]: remote pid 1035 is unknown user (trusted)1840server # [ 31.590959] systemd[1]: nix-daemon@2-3-1035_1036-0.service: Deactivated successfully.1841server # [ 31.610603] niks3-server[926]: 2026/07/07 08:17:29 INFO Received uploads request method=POST path=/api/pending_closures1842server # time=2026-07-07T08:17:29.265Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1843server # [ 31.617516] niks3-server[926]: 2026/07/07 08:17:29 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1844server # [ 31.619745] niks3-server[926]: 2026/07/07 08:17:29 INFO Completed upload id=21845server # time=2026-07-07T08:17:29.271Z level=INFO msg="Upload complete. (183ms)"1846server: (finished: must succeed: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem --client-cert /etc/niks3-test-certs/client.pem --client-key /etc/niks3-test-certs/client.key /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.27 seconds)1847server: must fail: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31848server # time=2026-07-07T08:17:29.296Z level=ERROR msg="Fatal error" error="auth token is required (use --auth-token-path, --auth-token-script, NIKS3_AUTH_TOKEN_FILE, or $XDG_CONFIG_HOME/niks3/auth-token)"1849server: (finished: must fail: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.02 seconds)1850server: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31851server # time=2026-07-07T08:17:29.385Z level=INFO msg="Configuring client TLS" cert="" key="" ca=/etc/niks3-test-certs/ca.pem1852server # [ 31.819601] systemd[1]: Started Nix Daemon instance (PID 1062/UID 0).1853server # [ 31.891896] nix-daemon[1065]: remote pid 1062 is unknown user (trusted)1854server # [ 31.907714] systemd[1]: nix-daemon@3-4-1062_1063-0.service: Deactivated successfully.1855server # [ 31.917914] niks3-server[926]: 2026/07/07 08:17:29 INFO Received uploads request method=POST path=/api/pending_closures1856server # time=2026-07-07T08:17:29.572Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1857server # [ 31.924978] niks3-server[926]: 2026/07/07 08:17:29 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete1858server # [ 31.927356] niks3-server[926]: 2026/07/07 08:17:29 INFO Completed upload id=31859server # time=2026-07-07T08:17:29.579Z level=INFO msg="Upload complete. (192ms)"1860server: (finished: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.28 seconds)1861server: must succeed: cd /etc/niks3-test-certs && /nix/store/y2wn0af8r6l6r44r407091nbzgy7aw8z-openssl-3.6.2-bin/bin/openssl req -newkey ec -pkeyopt ec_paramgen_curve:prime256v1 -nodes -keyout other.key -out other.csr -subj '/CN=other client'1862server # -----1863server: (finished: must succeed: cd /etc/niks3-test-certs && /nix/store/y2wn0af8r6l6r44r407091nbzgy7aw8z-openssl-3.6.2-bin/bin/openssl req -newkey ec -pkeyopt ec_paramgen_curve:prime256v1 -nodes -keyout other.key -out other.csr -subj '/CN=other client', in 0.03 seconds)1864server: must succeed: cd /etc/niks3-test-certs && /nix/store/y2wn0af8r6l6r44r407091nbzgy7aw8z-openssl-3.6.2-bin/bin/openssl x509 -req -in other.csr -CA ca.pem -CAkey ca.key -CAcreateserial -days 1 -out other.pem1865server # Certificate request self-signature ok1866server # subject=CN=other client1867server: (finished: must succeed: cd /etc/niks3-test-certs && /nix/store/y2wn0af8r6l6r44r407091nbzgy7aw8z-openssl-3.6.2-bin/bin/openssl x509 -req -in other.csr -CA ca.pem -CAkey ca.key -CAcreateserial -days 1 -out other.pem, in 0.05 seconds)1868server: must fail: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem --client-cert /etc/niks3-test-certs/other.pem --client-key /etc/niks3-test-certs/other.key /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31869server # time=2026-07-07T08:17:29.735Z level=INFO msg="Configuring client TLS" cert=/etc/niks3-test-certs/other.pem key=/etc/niks3-test-certs/other.key ca=/etc/niks3-test-certs/ca.pem1870server # [ 32.146695] systemd[1]: Started Nix Daemon instance (PID 1091/UID 0).1871server # [ 32.222530] nix-daemon[1093]: remote pid 1091 is unknown user (trusted)1872server # [ 32.240352] systemd[1]: nix-daemon@4-5-1091_1092-0.service: Deactivated successfully.1873server # [ 32.251350] niks3-server[926]: 2026/07/07 08:17:29 WARN mTLS auth: subject not in bound subjects subject="CN=other client"1874server # time=2026-07-07T08:17:29.904Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1875server: (finished: must fail: /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push --server-url https://server --ca-cert /etc/niks3-test-certs/ca.pem --client-cert /etc/niks3-test-certs/other.pem --client-key /etc/niks3-test-certs/other.key /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.25 seconds)1876server: must succeed: mkdir -p /tmp/test-store1877server: (finished: must succeed: mkdir -p /tmp/test-store, in 0.02 seconds)1878server: must succeed: 1879 export AWS_ACCESS_KEY_ID=rustfsadmin1880export AWS_SECRET_ACCESS_KEY=rustfsadmin1881 nix copy --from 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.318821883server: (finished: must succeed: 1884 export AWS_ACCESS_KEY_ID=rustfsadmin1885export AWS_SECRET_ACCESS_KEY=rustfsadmin1886 nix copy --from 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31887, in 0.74 seconds)1888server: must succeed: 1889cat > /tmp/test-drv.nix << 'EOF'1890derivation {1891 name = "test-build-log";1892 system = builtins.currentSystem;1893 builder = "/bin/sh";1894 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1895}1896EOF18971898server: (finished: must succeed: 1899cat > /tmp/test-drv.nix << 'EOF'1900derivation {1901 name = "test-build-log";1902 system = builtins.currentSystem;1903 builder = "/bin/sh";1904 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1905}1906EOF1907, in 0.03 seconds)1908server: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix1909server # warning: Nix search path entry '/nix/var/nix/profiles/per-user/root/channels' does not exist, ignoring1910server # [ 33.144092] systemd[1]: Started Nix Daemon instance (PID 1136/UID 0).1911server # [ 33.225098] nix-daemon[1140]: remote pid 1136 is unknown user (trusted)1912server # this derivation will be built:1913server # /nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv1914server # building '/nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv'...1915server # test-build-log> test build log output1916server: (finished: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix, in 0.32 seconds)1917server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1918server # [ 33.370017] systemd[1]: nix-daemon@5-6-1136_1137-0.service: Deactivated successfully.1919server # [ 33.511967] systemd[1]: Started Nix Daemon instance (PID 1167/UID 0).1920server # [ 33.587273] nix-daemon[1169]: remote pid 1167 is unknown user (trusted)1921server # [ 33.602572] systemd[1]: nix-daemon@6-7-1167_1168-0.service: Deactivated successfully.1922server # [ 33.610515] niks3-server[926]: 2026/07/07 08:17:31 INFO Received uploads request method=POST path=/api/pending_closures1923server # time=2026-07-07T08:17:31.265Z level=INFO msg="Uploading 1 paths to server (0 already cached)"1924server # time=2026-07-07T08:17:31.266Z level=INFO msg="Uploading z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log (128B)"1925server # time=2026-07-07T08:17:31.277Z level=INFO msg="Uploading 1 narinfos"1926server # [ 33.628111] niks3-server[926]: 2026/07/07 08:17:31 INFO Received sign narinfos request method=POST path=/api/pending_closures/4/sign1927server # [ 33.629692] niks3-server[926]: 2026/07/07 08:17:31 INFO Signed narinfos id=4 count=11928server # [ 33.634207] niks3-server[926]: 2026/07/07 08:17:31 INFO Received complete upload request method=POST path=/api/pending_closures/4/complete1929server # time=2026-07-07T08:17:31.287Z level=INFO msg="Upload complete. (186ms)"1930server # [ 33.637507] niks3-server[926]: 2026/07/07 08:17:31 INFO Completed upload id=41931server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/rsidmbhxnx31gj6g7inkb07kkv9bbjab-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log, in 0.27 seconds)1932server: must succeed: 1933 export AWS_ACCESS_KEY_ID=rustfsadmin1934export AWS_SECRET_ACCESS_KEY=rustfsadmin1935 nix log --store 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log19361937server: (finished: must succeed: 1938 export AWS_ACCESS_KEY_ID=rustfsadmin1939export AWS_SECRET_ACCESS_KEY=rustfsadmin1940 nix log --store 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1941, in 0.18 seconds)1942server: must succeed: readlink /etc/niks3-test/symlink-wrapper1943server: (finished: must succeed: readlink /etc/niks3-test/symlink-wrapper, in 0.03 seconds)1944server: must succeed: readlink /etc/static/niks3-test/symlink-wrapper1945server: (finished: must succeed: readlink /etc/static/niks3-test/symlink-wrapper, in 0.03 seconds)1946server: must succeed: test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper1947server: output: 1948!!! Traceback (most recent call last):1949!!! File "<string>", line 101, in <module>1950!!! server.succeed(f"test -L {symlink_wrapper}")1951!!! 1952!!! RequestedAssertionFailed: command `test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper` failed (exit code 1)1953cleanup1954kill QemuMachine (pid 15)1955builder # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)1956kill QemuMachine (pid 14)1957server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)1958(finished: cleanup, in 0.46 seconds)1959additionally exposed symbols:1960 builder, server,1961 vlan1,1962 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_ssh1963Hello store path: /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31964Test output path: /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1965Symlink wrapper store path: /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper