vm-test-run-nixos-test-niks3
aarch64-linux.nixos-test-niks3-lix
· build #80
· 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 14)12server # Disk image does not exist, creating the virtualisation disk image...13server: QEMU running (pid 15)14server # Formatting '/build/vm-state-server/tmp.J4ryJPWHbG', fmt=raw size=107374182415builder # Formatting '/build/vm-state-builder/tmp.seq05q7CfJ', fmt=raw size=107374182416server # mke2fs 1.47.4 (6-Mar-2025)17builder # mke2fs 1.47.4 (6-Mar-2025)18server # Discarding device blocks: 0/262144 done19builder # Discarding device blocks: 0/262144 done20server # Creating filesystem with 262144 4k blocks and 65536 inodes21builder # Creating filesystem with 262144 4k blocks and 65536 inodes22server # Filesystem UUID: af7194bc-e268-4a55-a603-27006fa7313323builder # Filesystem UUID: 7cfa278a-2993-41ef-82e5-fbe49450fd5324server # Superblock backups stored on blocks:25builder # Superblock backups stored on blocks:26server # 32768, 98304, 163840, 22937627builder # 32768, 98304, 163840, 22937628server # 29builder # 30server # Allocating group tables: 0/8 done31builder # Allocating group tables: 0/8 done32server # Writing inode tables: 0/8 done33builder # Writing inode tables: 0/8 done34server # Creating journal (8192 blocks): done35builder # Creating journal (8192 blocks): done36server # Writing superblocks and filesystem accounting information: 0/8 done37builder # Writing superblocks and filesystem accounting information: 0/8 done38server # 39builder # 40server # Virtualisation disk image created.41builder # Virtualisation disk image created.42(finished: start all VMs, in 0.47 seconds)43server: waiting for unit postgresql.service44server: waiting for the VM to finish booting45builder # [ 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-virt50server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]51builder # [ 0.000000] efi: UEFI not found.52builder # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT53server # [ 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 202654server # [ 0.000000] KASLR enabled55builder # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]56server # [ 0.000000] random: crng init done57builder # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]58server # [ 0.000000] Machine model: linux,dummy-virt59builder # [ 0.000000] Zone ranges:60server # [ 0.000000] efi: UEFI not found.61builder # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]62server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT63builder # [ 0.000000] DMA32 empty64builder # [ 0.000000] Normal empty65builder # [ 0.000000] Device empty66server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]67builder # [ 0.000000] Movable zone start for each node68server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]69builder # [ 0.000000] Early memory node ranges70server # [ 0.000000] Zone ranges:71builder # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]72server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]73server # [ 0.000000] DMA32 empty74builder # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]75server # [ 0.000000] Normal empty76server # [ 0.000000] Device empty77builder # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000078server # [ 0.000000] Movable zone start for each node79builder # [ 0.000000] psci: probing for conduit method from DT.80server # [ 0.000000] Early memory node ranges81builder # [ 0.000000] psci: PSCIv1.3 detected in firmware.82server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]83builder # [ 0.000000] psci: Using standard PSCI v0.2 function IDs84server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]85builder # [ 0.000000] psci: Trusted OS migration not required86builder # [ 0.000000] psci: SMC Calling Convention v1.187server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000088server # [ 0.000000] psci: probing for conduit method from DT.89builder # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)90server # [ 0.000000] psci: PSCIv1.3 detected in firmware.91builder # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u31129692server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs93builder # [ 0.000000] Detected PIPT I-cache on CPU094server # [ 0.000000] psci: Trusted OS migration not required95server # [ 0.000000] psci: SMC Calling Convention v1.196builder # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)97builder # [ 0.000000] CPU features: detected: GICv3 CPU interface98server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)99builder # [ 0.000000] CPU features: detected: Spectre-v4100server # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296101builder # [ 0.000000] CPU features: detected: Spectre-BHB102server # [ 0.000000] Detected PIPT I-cache on CPU0103builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38104server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)105builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23106server # [ 0.000000] CPU features: detected: GICv3 CPU interface107builder # [ 0.000000] alternatives: applying boot alternatives108server # [ 0.000000] CPU features: detected: Spectre-v4109server # [ 0.000000] CPU features: detected: Spectre-BHB110server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38111server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23112server # [ 0.000000] alternatives: applying boot alternatives113builder # [ 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/xq4mqjzi2ix2w247ap31jlhr51d10avj-nixos-system-builder-test/init regInfo=/nix/store/lxxs2ndxdi25dkx4sm724irq27s4kf5n-closure-info/registration console=ttyAMA0,115200n8 console=tty0114builder # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/lxxs2ndxdi25dkx4sm724irq27s4kf5n-closure-info/registration", will be passed to user space.115builder # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes116server # [ 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/yj2g3xjp9kg18n15fj7jqgy0byxbidgk-nixos-system-server-test/init regInfo=/nix/store/wichd5zxfzr9j3bxay0il5qf3hgrwc55-closure-info/registration console=ttyAMA0,115200n8 console=tty0117builder # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)118builder # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)119server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/wichd5zxfzr9j3bxay0il5qf3hgrwc55-closure-info/registration", will be passed to user space.120builder # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB121builder # [ 0.000000] software IO TLB: area num 1.122server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes123builder # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)124server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)125builder # [ 0.000000] Fallback order for Node 0: 0126server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)127builder # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144128builder # [ 0.000000] Policy zone: DMA129server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB130server # [ 0.000000] software IO TLB: area num 1.131builder # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off132builder # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1133server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)134server # [ 0.000000] Fallback order for Node 0: 0135builder # [ 0.000000] allocated 2097152 bytes of page_ext136builder # [ 0.000000] ftrace: allocating 74702 entries in 292 pages137server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144138server # [ 0.000000] Policy zone: DMA139builder # [ 0.000000] ftrace: allocated 292 pages with 3 groups140builder # [ 0.000000] rcu: Hierarchical RCU implementation.141server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off142builder # [ 0.000000] rcu: RCU event tracing is enabled.143server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1144builder # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.145server # [ 0.000000] allocated 2097152 bytes of page_ext146builder # [ 0.000000] Trampoline variant of Tasks RCU enabled.147server # [ 0.000000] ftrace: allocating 74702 entries in 292 pages148builder # [ 0.000000] Rude variant of Tasks RCU enabled.149server # [ 0.000000] ftrace: allocated 292 pages with 3 groups150builder # [ 0.000000] Tracing variant of Tasks RCU enabled.151server # [ 0.000000] rcu: Hierarchical RCU implementation.152server # [ 0.000000] rcu: RCU event tracing is enabled.153builder # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.154server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.155builder # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1156server # [ 0.000000] Trampoline variant of Tasks RCU enabled.157builder # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.158server # [ 0.000000] Rude variant of Tasks RCU enabled.159server # [ 0.000000] Tracing variant of Tasks RCU enabled.160builder # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.161server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.162builder # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.163server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1164builder # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0165builder # [ 0.000000] GICv3: 256 SPIs implemented166server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.167builder # [ 0.000000] GICv3: 0 Extended SPIs implemented168builder # [ 0.000000] Root IRQ handler: gic_handle_irq169server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.170builder # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI171builder # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0172server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.173builder # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000174server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0175server # [ 0.000000] GICv3: 256 SPIs implemented176builder # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]177server # [ 0.000000] GICv3: 0 Extended SPIs implemented178server # [ 0.000000] Root IRQ handler: gic_handle_irq179builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)180server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI181server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0182builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)183server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000184builder # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000185server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]186builder # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000187server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)188builder # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.189builder # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).190server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)191server # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000192builder # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns193server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000194builder # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns195builder # [ 0.000029] arm-pv: using stolen time PV196server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.197server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).198builder # [ 0.000390] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)199builder # [ 0.000534] Console: colour dummy device 80x25200builder # [ 0.000542] printk: legacy console [tty0] enabled201server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns202server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns203builder # [ 0.000733] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)204server # [ 0.000029] arm-pv: using stolen time PV205builder # [ 0.000739] pid_max: default: 32768 minimum: 301206builder # [ 0.000818] LSM: initializing lsm=capability,landlock,yama,bpf,ima207server # [ 0.000403] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)208builder # [ 0.000958] landlock: Up and running.209server # [ 0.000551] Console: colour dummy device 80x25210builder # [ 0.000961] Yama: becoming mindful.211server # [ 0.000558] printk: legacy console [tty0] enabled212builder # [ 0.001397] LSM support for eBPF active213builder # [ 0.001506] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)214server # [ 0.000733] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)215server # [ 0.000739] pid_max: default: 32768 minimum: 301216builder # [ 0.001526] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)217server # [ 0.000819] LSM: initializing lsm=capability,landlock,yama,bpf,ima218builder # [ 0.002627] cacheinfo: Unable to detect cache hierarchy for CPU 0219server # [ 0.001003] landlock: Up and running.220builder # [ 0.003350] rcu: Hierarchical SRCU implementation.221server # [ 0.001006] Yama: becoming mindful.222builder # [ 0.003354] rcu: Max phase no-delay instances is 1000.223server # [ 0.001439] LSM support for eBPF active224builder # [ 0.004572] fsl-mc MSI: its@8080000 domain created225server # [ 0.001544] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)226builder # [ 0.004661] EFI services will not be available.227builder # [ 0.004745] smp: Bringing up secondary CPUs ...228server # [ 0.001563] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)229builder # [ 0.004752] smp: Brought up 1 node, 1 CPU230builder # [ 0.004755] SMP: Total of 1 processors activated.231server # [ 0.002658] cacheinfo: Unable to detect cache hierarchy for CPU 0232builder # [ 0.004758] CPU: All CPU(s) started at EL1233server # [ 0.003359] rcu: Hierarchical SRCU implementation.234builder # [ 0.004768] CPU features: detected: Branch Target Identification235server # [ 0.003363] rcu: Max phase no-delay instances is 1000.236server # [ 0.004554] fsl-mc MSI: its@8080000 domain created237builder # [ 0.004773] CPU features: detected: ARMv8.4 Translation Table Level238server # [ 0.004643] EFI services will not be available.239server # [ 0.004729] smp: Bringing up secondary CPUs ...240builder # [ 0.004779] CPU features: detected: Instruction cache invalidation not required for I/D coherence241server # [ 0.004736] smp: Brought up 1 node, 1 CPU242server # [ 0.004739] SMP: Total of 1 processors activated.243builder # [ 0.004782] CPU features: detected: Data cache clean to the PoU not required for I/D coherence244server # [ 0.004742] CPU: All CPU(s) started at EL1245builder # [ 0.004786] CPU features: detected: Common not Private translations246server # [ 0.004752] CPU features: detected: Branch Target Identification247builder # [ 0.004788] CPU features: detected: CRC32 instructions248server # [ 0.004757] CPU features: detected: ARMv8.4 Translation Table Level249builder # [ 0.004791] CPU features: detected: Data cache clean to Point of Deep Persistence250server # [ 0.004762] CPU features: detected: Instruction cache invalidation not required for I/D coherence251builder # [ 0.004794] CPU features: detected: Data cache clean to Point of Persistence252builder # [ 0.004797] CPU features: detected: Data independent timing control (DIT)253server # [ 0.004766] CPU features: detected: Data cache clean to the PoU not required for I/D coherence254builder # [ 0.004800] CPU features: detected: E0PD255server # [ 0.004770] CPU features: detected: Common not Private translations256builder # [ 0.004803] CPU features: detected: Enhanced Counter Virtualization257server # [ 0.004773] CPU features: detected: CRC32 instructions258builder # [ 0.004806] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)259server # [ 0.004775] CPU features: detected: Data cache clean to Point of Deep Persistence260builder # [ 0.004809] CPU features: detected: Enhanced Virtualization Traps261server # [ 0.004779] CPU features: detected: Data cache clean to Point of Persistence262builder # [ 0.004812] CPU features: detected: Fine Grained Traps263server # [ 0.004782] CPU features: detected: Data independent timing control (DIT)264builder # [ 0.004816] CPU features: detected: Generic authentication (architected QARMA5 algorithm)265server # [ 0.004785] CPU features: detected: E0PD266builder # [ 0.004820] CPU features: detected: RCpc load-acquire (LDAPR)267server # [ 0.004788] CPU features: detected: Enhanced Counter Virtualization268builder # [ 0.004822] CPU features: detected: LSE atomic instructions269server # [ 0.004791] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)270builder # [ 0.004825] CPU features: detected: Privileged Access Never271builder # [ 0.004828] CPU features: detected: PMUv3272server # [ 0.004794] CPU features: detected: Enhanced Virtualization Traps273builder # [ 0.004831] CPU features: detected: RAS Extension Support274server # [ 0.004797] CPU features: detected: Fine Grained Traps275builder # [ 0.004833] CPU features: detected: RASv1p1 Extension Support276server # [ 0.004801] CPU features: detected: Generic authentication (architected QARMA5 algorithm)277builder # [ 0.004835] CPU features: detected: Random Number Generator278server # [ 0.004805] CPU features: detected: RCpc load-acquire (LDAPR)279builder # [ 0.004838] CPU features: detected: Speculation barrier (SB)280server # [ 0.004807] CPU features: detected: LSE atomic instructions281builder # [ 0.004840] CPU features: detected: Stage-2 Force Write-Back282server # [ 0.004810] CPU features: detected: Privileged Access Never283builder # [ 0.004843] CPU features: detected: TLB range maintenance instructions284server # [ 0.004813] CPU features: detected: PMUv3285server # [ 0.004815] CPU features: detected: RAS Extension Support286builder # [ 0.004847] CPU features: detected: Speculative Store Bypassing Safe (SSBS)287server # [ 0.004818] CPU features: detected: RASv1p1 Extension Support288builder # [ 0.004882] alternatives: applying system-wide alternatives289server # [ 0.004820] CPU features: detected: Random Number Generator290builder # [ 0.007720] CPU features: detected: BBM Level 2 without TLB conflict abort291server # [ 0.004823] CPU features: detected: Speculation barrier (SB)292server # [ 0.004826] CPU features: detected: Stage-2 Force Write-Back293builder # [ 0.007863] Memory: 895076K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)294server # [ 0.004829] CPU features: detected: TLB range maintenance instructions295builder # [ 0.008208] devtmpfs: initialized296server # [ 0.004833] CPU features: detected: Speculative Store Bypassing Safe (SSBS)297builder # [ 0.009902] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns298server # [ 0.004870] alternatives: applying system-wide alternatives299builder # [ 0.009924] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)300server # [ 0.007749] CPU features: detected: BBM Level 2 without TLB conflict abort301builder # [ 0.009944] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).302builder # [ 0.010112] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL303server # [ 0.007947] Memory: 895044K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)304builder # [ 0.010117] 0 pages in range for non-PLT usage305server # [ 0.008270] devtmpfs: initialized306builder # [ 0.010118] 508320 pages in range for PLT usage307builder # [ 0.010244] pinctrl core: initialized pinctrl subsystem308server # [ 0.009915] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns309builder # [ 0.011008] DMI not present or invalid.310builder # [ 0.014115] NET: Registered PF_NETLINK/PF_ROUTE protocol family311server # [ 0.009942] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)312builder # [ 0.016418] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations313server # [ 0.009962] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).314builder # [ 0.016575] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations315server # [ 0.010122] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL316server # [ 0.010127] 0 pages in range for non-PLT usage317builder # [ 0.016732] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations318server # [ 0.010128] 508320 pages in range for PLT usage319builder # [ 0.016752] audit: initializing netlink subsys (disabled)320server # [ 0.010243] pinctrl core: initialized pinctrl subsystem321server # [ 0.010991] DMI not present or invalid.322builder # [ 0.017279] thermal_sys: Registered thermal governor 'fair_share'323server # [ 0.013976] NET: Registered PF_NETLINK/PF_ROUTE protocol family324builder # [ 0.017281] thermal_sys: Registered thermal governor 'bang_bang'325builder # [ 0.017284] thermal_sys: Registered thermal governor 'step_wise'326server # [ 0.016280] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations327builder # [ 0.017287] thermal_sys: Registered thermal governor 'user_space'328server # [ 0.016426] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations329builder # [ 0.017290] thermal_sys: Registered thermal governor 'power_allocator'330server # [ 0.016582] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations331builder # [ 0.017315] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1332server # [ 0.016602] audit: initializing netlink subsys (disabled)333builder # [ 0.017324] cpuidle: using governor ladder334server # [ 0.017160] thermal_sys: Registered thermal governor 'fair_share'335builder # [ 0.017330] cpuidle: using governor menu336server # [ 0.017162] thermal_sys: Registered thermal governor 'bang_bang'337builder # [ 0.017512] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.338server # [ 0.017165] thermal_sys: Registered thermal governor 'step_wise'339builder # [ 0.017526] ASID allocator initialised with 65536 entries340builder # [ 0.018671] Serial: AMBA PL011 UART driver341server # [ 0.017168] thermal_sys: Registered thermal governor 'user_space'342server # [ 0.017171] thermal_sys: Registered thermal governor 'power_allocator'343builder # [ 0.023734] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1344builder # [ 0.023883] printk: console [ttyAMA0] enabled345server # [ 0.017195] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1346server # [ 0.017205] cpuidle: using governor ladder347server # [ 0.017211] cpuidle: using governor menu348server # [ 0.017404] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.349server # [ 0.017418] ASID allocator initialised with 65536 entries350server # [ 0.018518] Serial: AMBA PL011 UART driver351server # [ 0.023527] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1352server # [ 0.023649] printk: console [ttyAMA0] enabled353builder # [ 0.151186] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages354builder # [ 0.151205] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page355builder # [ 0.151210] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages356builder # [ 0.151214] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page357builder # [ 0.151219] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages358server # [ 0.151803] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages359builder # [ 0.151223] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page360server # [ 0.151820] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page361builder # [ 0.151227] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages362server # [ 0.151825] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages363builder # [ 0.151231] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page364server # [ 0.151829] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page365server # [ 0.151833] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages366builder # [ 0.158789] fbcon: Taking over console367server # [ 0.151837] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page368builder # [ 0.158804] ACPI: Interpreter disabled.369server # [ 0.151842] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages370builder # [ 0.160725] iommu: Default domain type: Translated371server # [ 0.151846] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page372builder # [ 0.160736] iommu: DMA domain TLB invalidation policy: strict mode373builder # [ 0.162458] SCSI subsystem initialized374server # [ 0.159562] fbcon: Taking over console375builder # [ 0.163136] usbcore: registered new interface driver usbfs376server # [ 0.159576] ACPI: Interpreter disabled.377builder # [ 0.163168] usbcore: registered new interface driver hub378server # [ 0.161478] iommu: Default domain type: Translated379builder # [ 0.163183] usbcore: registered new device driver usb380builder # [ 0.163429] pps_core: LinuxPPS API ver. 1 registered381server # [ 0.161487] iommu: DMA domain TLB invalidation policy: strict mode382server # [ 0.163215] SCSI subsystem initialized383builder # [ 0.163435] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>384builder # [ 0.163445] PTP clock support registered385server # [ 0.168361] usbcore: registered new interface driver usbfs386server # [ 0.168391] usbcore: registered new interface driver hub387server # [ 0.168413] usbcore: registered new device driver usb388builder # [ 0.173932] EDAC MC: Ver: 3.0.0389server # [ 0.168687] pps_core: LinuxPPS API ver. 1 registered390builder # [ 0.174536] scmi_core: SCMI protocol bus registered391server # [ 0.168693] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>392builder # [ 0.175517] FPGA manager framework393server # [ 0.168702] PTP clock support registered394server # [ 0.168756] EDAC MC: Ver: 3.0.0395builder # [ 0.176531] vgaarb: loaded396server # [ 0.173620] scmi_core: SCMI protocol bus registered397builder # [ 0.177175] clocksource: Switched to clocksource arch_sys_counter398server # [ 0.174595] FPGA manager framework399builder # [ 0.177634] VFS: Disk quotas dquot_6.6.0400server # [ 0.175530] vgaarb: loaded401builder # [ 0.177665] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)402builder # [ 0.180038] netfs: FS-Cache loaded403server # [ 0.176172] clocksource: Switched to clocksource arch_sys_counter404builder # [ 0.180132] pnp: PnP ACPI: disabled405server # [ 0.176625] VFS: Disk quotas dquot_6.6.0406server # [ 0.176656] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)407server # [ 0.179178] netfs: FS-Cache loaded408server # [ 0.179270] pnp: PnP ACPI: disabled409builder # [ 0.186177] NET: Registered PF_INET protocol family410builder # [ 0.186336] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)411server # [ 0.188219] NET: Registered PF_INET protocol family412server # [ 0.188373] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)413builder # [ 0.215628] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)414builder # [ 0.215666] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)415builder # [ 0.215689] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)416builder # [ 0.215733] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)417builder # [ 0.215808] TCP: Hash tables configured (established 8192 bind 8192)418builder # [ 0.215911] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)419builder # [ 0.215962] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)420builder # [ 0.216008] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)421server # [ 0.217196] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)422builder # [ 0.216084] NET: Registered PF_UNIX/PF_LOCAL protocol family423server # [ 0.217234] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)424builder # [ 0.216103] NET: Registered PF_XDP protocol family425builder # [ 0.216120] PCI: CLS 0 bytes, default 64426server # [ 0.217257] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)427builder # [ 0.216358] Trying to unpack rootfs image as initramfs...428server # [ 0.217297] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)429server # [ 0.217372] TCP: Hash tables configured (established 8192 bind 8192)430server # [ 0.217446] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)431server # [ 0.217499] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)432server # [ 0.217546] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)433server # [ 0.217636] NET: Registered PF_UNIX/PF_LOCAL protocol family434server # [ 0.217671] NET: Registered PF_XDP protocol family435server # [ 0.217689] PCI: CLS 0 bytes, default 64436server # [ 0.217929] Trying to unpack rootfs image as initramfs...437builder # [ 0.230928] kvm [1]: HYP mode not available438server # [ 0.234369] kvm [1]: HYP mode not available439builder # [ 0.321695] Initialise system trusted keyrings440builder # [ 0.322476] workingset: timestamp_bits=42 max_order=18 bucket_order=0441builder # [ 0.323737] squashfs: version 4.0 (2009/01/31) Phillip Lougher442builder # [ 0.324534] 9p: Installing v9fs 9p2000 file system support443server # [ 0.324677] Initialise system trusted keyrings444server # [ 0.325441] workingset: timestamp_bits=42 max_order=18 bucket_order=0445server # [ 0.326733] squashfs: version 4.0 (2009/01/31) Phillip Lougher446server # [ 0.327529] 9p: Installing v9fs 9p2000 file system support447builder # [ 0.345092] Key type asymmetric registered448builder # [ 0.345109] Asymmetric key parser 'x509' registered449builder # [ 0.345159] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)450builder # [ 0.353283] io scheduler mq-deadline registered451builder # [ 0.353303] io scheduler kyber registered452server # [ 0.356279] Key type asymmetric registered453server # [ 0.356300] Asymmetric key parser 'x509' registered454server # [ 0.356359] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)455server # [ 0.358554] io scheduler mq-deadline registered456server # [ 0.358566] io scheduler kyber registered457server # [ 0.368314] pl061_gpio 9030000.pl061: PL061 GPIO chip registered458builder # [ 0.365322] pl061_gpio 9030000.pl061: PL061 GPIO chip registered459builder # [ 0.365931] ledtrig-cpu: registered to indicate activity on CPUs460builder # [ 0.366279] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:461server # [ 0.369692] ledtrig-cpu: registered to indicate activity on CPUs462builder # [ 0.366296] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000463server # [ 0.370077] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:464builder # [ 0.366311] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000465server # [ 0.370095] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000466builder # [ 0.366320] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000467server # [ 0.370109] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000468builder # [ 0.366342] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits469server # [ 0.370118] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000470builder # [ 0.366366] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]471server # [ 0.370137] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits472builder # [ 0.366442] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00473server # [ 0.370160] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]474builder # [ 0.366451] pci_bus 0000:00: root bus resource [bus 00-ff]475builder # [ 0.366458] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]476server # [ 0.370235] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00477server # [ 0.370245] pci_bus 0000:00: root bus resource [bus 00-ff]478builder # [ 0.366463] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]479server # [ 0.370251] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]480builder # [ 0.366468] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]481server # [ 0.370256] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]482builder # [ 0.366534] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint483server # [ 0.370261] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]484builder # [ 0.366979] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint485builder # [ 0.367167] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]486server # [ 0.370360] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint487builder # [ 0.367184] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]488server # [ 0.370848] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint489builder # [ 0.367215] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]490server # [ 0.371041] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]491builder # [ 0.367231] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]492server # [ 0.371058] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]493server # [ 0.371088] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]494builder # [ 0.367694] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint495builder # [ 0.367876] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]496server # [ 0.371104] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]497builder # [ 0.367892] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]498server # [ 0.371586] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint499builder # [ 0.367922] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]500server # [ 0.371779] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]501server # [ 0.371795] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]502builder # [ 0.368369] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint503builder # [ 0.368549] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]504server # [ 0.371829] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]505builder # [ 0.368565] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]506builder # [ 0.368595] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]507builder # [ 0.369053] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint508builder # [ 0.369253] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]509builder # [ 0.369270] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]510builder # [ 0.369300] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]511server # [ 0.392290] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint512builder # [ 0.369761] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint513server # [ 0.392479] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]514builder # [ 0.369954] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]515server # [ 0.392495] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]516builder # [ 0.369970] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]517server # [ 0.392524] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]518builder # [ 0.370000] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]519server # [ 0.393002] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint520builder # [ 0.370458] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint521server # [ 0.393185] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]522builder # [ 0.370639] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]523server # [ 0.393201] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]524builder # [ 0.370655] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]525server # [ 0.393230] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]526builder # [ 0.370685] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]527server # [ 0.393689] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint528builder # [ 0.371138] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint529server # [ 0.393874] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]530builder # [ 0.371319] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]531server # [ 0.393890] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]532builder # [ 0.371335] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]533server # [ 0.393920] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]534builder # [ 0.371365] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]535server # [ 0.394373] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint536builder # [ 0.371382] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]537server # [ 0.394564] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]538builder # [ 0.371839] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint539server # [ 0.394580] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]540builder # [ 0.372025] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]541server # [ 0.394610] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]542builder # [ 0.372055] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]543server # [ 0.395064] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint544builder # [ 0.372516] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint545server # [ 0.395248] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]546builder # [ 0.372705] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]547server # [ 0.395263] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]548builder # [ 0.372735] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]549server # [ 0.395293] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]550server # [ 0.395309] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]551builder # [ 0.373127] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint552server # [ 0.395800] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint553server # [ 0.395987] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]554server # [ 0.396017] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]555builder # [ 0.421356] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]556builder # [ 0.421649] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint557builder # [ 0.421922] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]558builder # [ 0.421940] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]559builder # [ 0.421970] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560builder # [ 0.422442] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint561builder # [ 0.422626] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]562builder # [ 0.422643] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]563server # [ 0.424579] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint564builder # [ 0.422673] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]565server # [ 0.424784] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]566builder # [ 0.423264] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned567server # [ 0.424816] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]568builder # [ 0.423277] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned569server # [ 0.425215] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint570builder # [ 0.423283] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned571server # [ 0.425399] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]572builder # [ 0.423330] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned573server # [ 0.425648] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint574builder # [ 0.423380] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned575server # [ 0.425896] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]576builder # [ 0.423427] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned577server # [ 0.425913] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]578server # [ 0.425942] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]579builder # [ 0.423474] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned580builder # [ 0.423521] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned581server # [ 0.426406] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint582server # [ 0.426596] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]583builder # [ 0.423568] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned584server # [ 0.426612] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]585builder # [ 0.423617] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned586server # [ 0.426641] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]587builder # [ 0.423665] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned588server # [ 0.427221] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned589server # [ 0.427232] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned590builder # [ 0.423713] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned591builder # [ 0.423784] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned592server # [ 0.427238] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned593builder # [ 0.423831] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned594server # [ 0.427283] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned595builder # [ 0.423853] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned596server # [ 0.427330] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned597builder # [ 0.423874] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned598server # [ 0.427377] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned599builder # [ 0.423897] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned600builder # [ 0.423919] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned601server # [ 0.427424] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned602builder # [ 0.423941] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned603server # [ 0.427471] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned604builder # [ 0.423967] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned605server # [ 0.427519] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned606builder # [ 0.423989] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned607server # [ 0.427568] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned608builder # [ 0.424012] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned609server # [ 0.427615] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned610builder # [ 0.424034] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned611builder # [ 0.424057] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned612server # [ 0.427662] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned613builder # [ 0.424080] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned614server # [ 0.427721] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned615builder # [ 0.424103] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned616server # [ 0.427767] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned617builder # [ 0.424125] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned618server # [ 0.427789] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned619builder # [ 0.424146] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned620server # [ 0.427810] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned621builder # [ 0.424168] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned622server # [ 0.427832] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned623builder # [ 0.424190] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned624server # [ 0.427853] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned625builder # [ 0.424212] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned626builder # [ 0.424234] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned627server # [ 0.427875] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned628builder # [ 0.424256] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned629server # [ 0.427899] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned630builder # [ 0.424279] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned631server # [ 0.427921] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned632builder # [ 0.424306] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]633server # [ 0.427943] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned634builder # [ 0.424316] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]635server # [ 0.427965] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned636builder # [ 0.424321] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]637server # [ 0.427987] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned638server # [ 0.428009] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned639server # [ 0.428030] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned640server # [ 0.428052] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned641server # [ 0.428073] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned642server # [ 0.428094] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned643server # [ 0.428115] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned644server # [ 0.428137] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned645server # [ 0.428158] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned646builder # [ 0.469565] pci 0000:00:0a.0: enabling device (0000 -> 0002)647server # [ 0.468183] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned648server # [ 0.468207] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned649server # [ 0.468234] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]650server # [ 0.468244] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]651server # [ 0.468249] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]652server # [ 0.469460] pci 0000:00:0a.0: enabling device (0000 -> 0002)653builder # [ 0.490057] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)654builder # [ 0.492137] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)655builder # [ 0.503243] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)656server # [ 0.502163] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)657server # [ 0.505041] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)658server # [ 0.506944] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)659builder # [ 0.509250] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)660builder # [ 0.511171] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)661builder # [ 0.513108] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)662server # [ 0.516733] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)663server # [ 0.518525] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)664builder # [ 0.526532] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)665server # [ 0.520599] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)666builder # [ 0.528611] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)667server # [ 0.522441] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)668builder # [ 0.532253] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)669server # [ 0.532334] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)670builder # [ 0.540251] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)671server # [ 0.534393] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)672server # [ 0.536119] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)673builder # [ 0.546480] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)674server # [ 0.553617] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)675server # [ 0.559572] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled676builder # [ 0.563581] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled677server # [ 0.562117] msm_serial: driver initialized678server # [ 0.562251] SuperH (H)SCI(F) driver initialized679server # [ 0.562303] STM32 USART driver initialized680builder # [ 0.566100] msm_serial: driver initialized681builder # [ 0.566260] SuperH (H)SCI(F) driver initialized682builder # [ 0.566313] STM32 USART driver initialized683builder # [ 0.595968] loop: module loaded684builder # [ 0.596129] virtio_blk virtio5: 1/0/0 default/read/poll queues685builder # [ 0.596822] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)686server # [ 0.596777] loop: module loaded687server # [ 0.596942] virtio_blk virtio5: 1/0/0 default/read/poll queues688server # [ 0.597644] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)689builder # [ 0.601703] megasas: 07.734.00.00-rc1690builder # [ 0.602416] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]691builder # [ 0.604531] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000692builder # [ 0.604555] Intel/Sharp Extended Query Table at 0x0031693server # [ 0.604715] megasas: 07.734.00.00-rc1694server # [ 0.605382] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]695builder # [ 0.614102] Using buffer write method696server # [ 0.607435] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000697server # [ 0.607459] Intel/Sharp Extended Query Table at 0x0031698builder # [ 0.614173] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]699server # [ 0.608899] Using buffer write method700builder # [ 0.616915] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000701builder # [ 0.616937] Intel/Sharp Extended Query Table at 0x0031702server # [ 0.608970] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]703server # [ 0.610597] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000704server # [ 0.610618] Intel/Sharp Extended Query Table at 0x0031705server # [ 0.612123] Using buffer write method706server # [ 0.612146] Concatenating MTD devices:707server # [ 0.612150] (0): "0.flash"708server # [ 0.612154] (1): "0.flash"709server # [ 0.612157] into device "0.flash"710builder # [ 0.630211] Using buffer write method711builder # [ 0.630244] Concatenating MTD devices:712builder # [ 0.630248] (0): "0.flash"713builder # [ 0.630252] (1): "0.flash"714builder # [ 0.630256] into device "0.flash"715server # [ 0.845024] Freeing initrd memory: 25520K716builder # [ 0.849805] Freeing initrd memory: 25520K717server # [ 0.850955] tun: Universal TUN/TAP device driver, 1.6718builder # [ 0.855687] tun: Universal TUN/TAP device driver, 1.6719server # [ 0.854489] thunder_xcv, ver 1.0720server # [ 0.854552] thunder_bgx, ver 1.0721server # [ 0.854573] nicpf, ver 1.0722server # [ 0.855112] e1000: Intel(R) PRO/1000 Network Driver723builder # [ 0.859264] thunder_xcv, ver 1.0724server # [ 0.855119] e1000: Copyright (c) 1999-2006 Intel Corporation.725builder # [ 0.859297] thunder_bgx, ver 1.0726builder # [ 0.859318] nicpf, ver 1.0727server # [ 0.855147] e1000e: Intel(R) PRO/1000 Network Driver728builder # [ 0.859849] e1000: Intel(R) PRO/1000 Network Driver729server # [ 0.855154] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.730builder # [ 0.859856] e1000: Copyright (c) 1999-2006 Intel Corporation.731server # [ 0.855184] igb: Intel(R) Gigabit Ethernet Network Driver732builder # [ 0.859884] e1000e: Intel(R) PRO/1000 Network Driver733server # [ 0.855190] igb: Copyright (c) 2007-2014 Intel Corporation.734builder # [ 0.859891] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.735server # [ 0.855213] igbvf: Intel(R) Gigabit Virtual Function Network Driver736builder # [ 0.859921] igb: Intel(R) Gigabit Ethernet Network Driver737server # [ 0.855219] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.738builder # [ 0.859926] igb: Copyright (c) 2007-2014 Intel Corporation.739server # [ 0.855350] sky2: driver version 1.30740builder # [ 0.859948] igbvf: Intel(R) Gigabit Virtual Function Network Driver741builder # [ 0.859955] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.742server # [ 0.864167] usbcore: registered new interface driver usb-storage743builder # [ 0.860084] sky2: driver version 1.30744server # [ 0.865575] ehci-pci 0000:00:0a.0: EHCI Host Controller745server # [ 0.865604] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1746builder # [ 0.868890] usbcore: registered new interface driver usb-storage747server # [ 0.865827] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000748builder # [ 0.868999] usbcore: registered new interface driver usbserial_generic749builder # [ 0.869013] usbserial: USB Serial support registered for generic750builder # [ 0.869826] ehci-pci 0000:00:0a.0: EHCI Host Controller751server # [ 0.868286] usbcore: registered new interface driver usbserial_generic752builder # [ 0.869851] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1753server # [ 0.868302] usbserial: USB Serial support registered for generic754builder # [ 0.870123] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000755server # [ 0.868893] hv_vmbus: registering driver hyperv_keyboard756server # [ 0.871968] rtc-pl031 9010000.pl031: registered as rtc0757builder # [ 0.875346] hv_vmbus: registering driver hyperv_keyboard758server # [ 0.871994] rtc-pl031 9010000.pl031: setting system clock to 2026-07-08T22:01:17 UTC (1783548077)759builder # [ 0.876803] rtc-pl031 9010000.pl031: registered as rtc0760server # [ 0.874111] i2c_dev: i2c /dev entries driver761builder # [ 0.876829] rtc-pl031 9010000.pl031: setting system clock to 2026-07-08T22:01:17 UTC (1783548077)762builder # [ 0.877114] i2c_dev: i2c /dev entries driver763server # [ 0.877246] sdhci: Secure Digital Host Controller Interface driver764server # [ 0.877254] sdhci: Copyright(c) Pierre Ossman765server # [ 0.877511] Synopsys Designware Multimedia Card Interface Driver766builder # [ 0.882546] sdhci: Secure Digital Host Controller Interface driver767server # [ 0.877864] sdhci-pltfm: SDHCI platform and OF driver helper768builder # [ 0.882566] sdhci: Copyright(c) Pierre Ossman769server # [ 0.879430] hid: raw HID events driver (C) Jiri Kosina770builder # [ 0.882830] Synopsys Designware Multimedia Card Interface Driver771server # [ 0.879652] usbcore: registered new interface driver usbhid772server # [ 0.879658] usbhid: USB HID core driver773builder # [ 0.883186] sdhci-pltfm: SDHCI platform and OF driver helper774builder # [ 0.884832] hid: raw HID events driver (C) Jiri Kosina775server # [ 0.884709] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00776builder # [ 0.885062] usbcore: registered new interface driver usbhid777server # [ 0.885718] hub 1-0:1.0: USB hub found778builder # [ 0.885069] usbhid: USB HID core driver779server # [ 0.886211] hub 1-0:1.0: 6 ports detected780builder # [ 0.889770] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00781builder # [ 0.890069] hub 1-0:1.0: USB hub found782builder # [ 0.890089] hub 1-0:1.0: 6 ports detected783server # [ 0.887589] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available784builder # [ 0.893075] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available785server # [ 0.890165] drop_monitor: Initializing network drop monitor service786server # [ 0.890317] NET: Registered PF_INET6 protocol family787server # [ 0.892254] Segment Routing with IPv6788server # [ 0.892271] In-situ OAM (IOAM) with IPv6789builder # [ 0.895659] drop_monitor: Initializing network drop monitor service790server # [ 0.892317] NET: Registered PF_PACKET protocol family791builder # [ 0.895823] NET: Registered PF_INET6 protocol family792builder # [ 0.897752] Segment Routing with IPv6793builder # [ 0.897779] In-situ OAM (IOAM) with IPv6794builder # [ 0.897810] NET: Registered PF_PACKET protocol family795server # [ 0.894021] 9pnet: Installing 9P2000 support796server # [ 0.896019] Key type dns_resolver registered797builder # [ 0.899466] 9pnet: Installing 9P2000 support798builder # [ 0.902027] Key type dns_resolver registered799server # [ 0.902728] registered taskstats version 1800server # [ 0.902874] Loading compiled-in X.509 certificates801builder # [ 0.908273] registered taskstats version 1802builder # [ 0.908427] Loading compiled-in X.509 certificates803server # [ 0.911252] Demotion targets for Node 0: null804server # [ 0.911347] Key type .fscrypt registered805server # [ 0.911354] Key type fscrypt-provisioning registered806server # [ 0.911438] ima: No TPM chip found, activating TPM-bypass!807builder # [ 0.916725] Demotion targets for Node 0: null808server # [ 0.911456] ima: Allocated hash algorithm: sha1809builder # [ 0.916828] Key type .fscrypt registered810server # [ 0.911475] ima: No architecture policies found811builder # [ 0.916835] Key type fscrypt-provisioning registered812builder # [ 0.916918] ima: No TPM chip found, activating TPM-bypass!813server # [ 0.915522] input: gpio-keys as /devices/platform/gpio-keys/input/input0814builder # [ 0.916936] ima: Allocated hash algorithm: sha1815builder # [ 0.916955] ima: No architecture policies found816builder # [ 0.920952] input: gpio-keys as /devices/platform/gpio-keys/input/input0817server # [ 0.933494] clk: Disabling unused clocks818server # [ 0.933512] PM: genpd: Disabling unused power domains819builder # [ 0.938105] clk: Disabling unused clocks820builder # [ 0.938128] PM: genpd: Disabling unused power domains821server # [ 0.937853] Freeing unused kernel memory: 4736K822server # [ 0.938053] Run /init as init process823builder # [ 0.942479] Freeing unused kernel memory: 4736K824builder # [ 0.942743] Run /init as init process825server # [ 0.954314] systemd[1]: Successfully made /usr/ read-only.826builder # [ 0.959303] systemd[1]: Successfully made /usr/ read-only.827server # [ 1.132252] usb 1-1: new high-speed USB device number 2 using ehci-pci828builder # [ 1.137249] usb 1-1: new high-speed USB device number 2 using ehci-pci829server # [ 1.284376] 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.289264] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1831server # [ 1.290237] 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)832builder # [ 1.295143] 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)833server # [ 1.302789] systemd[1]: Detected virtualization qemu.834builder # [ 1.307641] systemd[1]: Detected virtualization qemu.835server # [ 1.304909] systemd[1]: Detected architecture arm64.836builder # [ 1.309741] systemd[1]: Detected architecture arm64.837server # [ 1.306892] systemd[1]: Running in initrd.838builder # [ 1.311670] systemd[1]: Running in initrd.839server # [ 1.309603] systemd[1]: Initializing machine ID from random generator.840builder # [ 1.314383] systemd[1]: Initializing machine ID from random generator.841server # [ 1.312495] systemd[1]: Hostname set to <server>.842builder # [ 1.317215] systemd[1]: Hostname set to <builder>.843server # [ 1.372493] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0844builder # [ 1.378998] 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.431975] systemd[1]: Queued start job for default target Initrd Default Target.846server # [ 1.436555] systemd[1]: Queued start job for default target Initrd Default Target.847builder # [ 1.443497] systemd[1]: Created slice Slice /system/modprobe.848builder # [ 1.444780] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.849builder # [ 1.446552] systemd[1]: Expecting device /dev/disk/by-label/nixos...850server # [ 1.446354] systemd[1]: Created slice Slice /system/modprobe.851builder # [ 1.446595] systemd[1]: Reached target Path Units.852builder # [ 1.446615] systemd[1]: Reached target Slice Units.853server # [ 1.447631] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.854builder # [ 1.446637] systemd[1]: Reached target Swaps.855builder # [ 1.446659] systemd[1]: Reached target Timer Units.856builder # [ 1.446830] systemd[1]: Listening on D-Bus System Message Bus Socket.857builder # [ 1.447029] systemd[1]: Listening on Journal Socket (/dev/log).858server # [ 1.449159] systemd[1]: Expecting device /dev/disk/by-label/nixos...859builder # [ 1.447217] systemd[1]: Listening on Journal Sockets.860server # [ 1.449194] systemd[1]: Reached target Path Units.861server # [ 1.449215] systemd[1]: Reached target Slice Units.862builder # [ 1.447364] systemd[1]: Listening on udev Control Socket.863server # [ 1.449237] systemd[1]: Reached target Swaps.864builder # [ 1.447490] systemd[1]: Listening on udev Kernel Socket.865server # [ 1.449258] systemd[1]: Reached target Timer Units.866builder # [ 1.447515] systemd[1]: Reached target Socket Units.867server # [ 1.449419] systemd[1]: Listening on D-Bus System Message Bus Socket.868builder # [ 1.459484] systemd[1]: Starting Create List of Static Device Nodes...869server # [ 1.449602] systemd[1]: Listening on Journal Socket (/dev/log).870server # [ 1.449781] systemd[1]: Listening on Journal Sockets.871server # [ 1.449919] systemd[1]: Listening on udev Control Socket.872server # [ 1.450030] systemd[1]: Listening on udev Kernel Socket.873server # [ 1.450053] systemd[1]: Reached target Socket Units.874server # [ 1.461598] systemd[1]: Starting Create List of Static Device Nodes...875builder # [ 1.466466] systemd[1]: Starting Load Kernel Module 9pnet_virtio...876builder # [ 1.467697] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs877server # [ 1.472265] systemd[1]: Starting Load Kernel Module 9pnet_virtio...878builder # [ 1.477366] systemd[1]: Mounting Kernel Configuration File System...879server # [ 1.473491] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs880server # [ 1.476947] systemd[1]: Mounting Kernel Configuration File System...881builder # [ 1.485358] systemd[1]: Starting Journal Service...882server # [ 1.492233] usb 1-2: new high-speed USB device number 3 using ehci-pci883server # [ 1.497106] systemd[1]: Starting Journal Service...884builder # [ 1.501795] usb 1-2: new high-speed USB device number 3 using ehci-pci885builder # [ 1.504605] systemd[1]: Starting Load Kernel Modules...886builder # [ 1.505556] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki887builder # [ 1.514578] systemd[1]: Starting Coldplug All udev Devices...888server # [ 1.516389] systemd[1]: Starting Load Kernel Modules...889server # [ 1.517305] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki890server # [ 1.524432] systemd[1]: Starting Coldplug All udev Devices...891server # [ 1.528272] systemd[1]: Finished Create List of Static Device Nodes.892builder # [ 1.529554] systemd[1]: Finished Create List of Static Device Nodes.893builder # [ 1.530473] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.894server # [ 1.530187] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.895builder # [ 1.530815] systemd[1]: Finished Load Kernel Module 9pnet_virtio.896builder # [ 1.531056] systemd[1]: Mounted Kernel Configuration File System.897server # [ 1.532784] systemd[1]: Finished Load Kernel Module 9pnet_virtio.898server # [ 1.534273] systemd[1]: Mounted Kernel Configuration File System.899builder # [ 1.549498] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...900server # [ 1.548616] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...901builder # [ 1.564808] systemd-journald[73]: Collecting audit messages is disabled.902builder # [ 1.577531] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.903server # [ 1.583862] systemd-journald[73]: Collecting audit messages is disabled.904builder # [ 1.589267] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev905builder # [ 1.591637] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.906server # [ 1.591471] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.907server # [ 1.596780] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.908builder # [ 1.601761] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0909builder # [ 1.601997] [drm] features: -virgl +edid -resource_blob -host_visible910builder # [ 1.602006] [drm] features: -context_init911server # [ 1.601020] systemd[1]: Starting Create Static Device Nodes in /dev...912builder # [ 1.602680] [drm] number of scanouts: 1913builder # [ 1.602698] [drm] number of cap sets: 0914builder # [ 1.609311] systemd[1]: Starting Create Static Device Nodes in /dev...915server # [ 1.612240] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev916server # [ 1.616479] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0917server # [ 1.616711] [drm] features: -virgl +edid -resource_blob -host_visible918server # [ 1.616721] [drm] features: -context_init919server # [ 1.617411] [drm] number of scanouts: 1920server # [ 1.617429] [drm] number of cap sets: 0921builder # [ 1.622273] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic922builder # [ 1.622289] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0923server # [ 1.632603] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic924server # [ 1.632621] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0925builder # [ 1.651465] Console: switching to colour frame buffer device 160x50926builder # [ 1.657921] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device927server # [ 1.658978] 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/input2928server # [ 1.660882] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0929builder # [ 1.665916] systemd[1]: Finished Create Static Device Nodes in /dev.930server # [ 1.664738] systemd[1]: Finished Create Static Device Nodes in /dev.931builder # [ 1.666234] systemd[1]: Reached target Preparation for Local File Systems.932builder # [ 1.666270] systemd[1]: Reached target Local File Systems.933server # [ 1.664925] systemd[1]: Reached target Preparation for Local File Systems.934server # [ 1.664952] systemd[1]: Reached target Local File Systems.935builder # [ 1.673382] systemd[1]: Starting Rule-based Manager for Device Events and Files...936builder # [ 1.673759] 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/input2937builder # [ 1.674292] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0938server # [ 1.672450] Console: switching to colour frame buffer device 160x50939server # [ 1.678803] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device940server # [ 1.679182] systemd[1]: Starting Rule-based Manager for Device Events and Files...941builder # [ 1.708139] systemd[1]: Finished Load Kernel Modules.942builder # [ 1.711111] systemd[1]: Starting Apply Kernel Variables...943server # [ 1.707551] systemd[1]: Finished Load Kernel Modules.944server # [ 1.710574] systemd[1]: Starting Apply Kernel Variables...945builder # [ 1.761785] systemd[1]: Finished Apply Kernel Variables.946server # [ 1.760804] systemd[1]: Finished Apply Kernel Variables.947builder # [ 1.772661] systemd[1]: Started Journal Service.948builder # [ 1.760305] systemd-modules-load[74]: Inserted module 'dm_mod'949builder # [ 1.766080] systemd-modules-load[74]: Module 'virtio_balloon' is built in950builder # [ 1.767158] systemd-modules-load[74]: Module 'virtio_console' is built in951builder # [ 1.773026] systemd-modules-load[74]: Inserted module 'virtio_gpu'952server # [ 1.789779] systemd[1]: Started Journal Service.953builder # [ 1.776002] systemd-modules-load[74]: Module 'virtio_rng' is built in954server # [ 1.775474] systemd-modules-load[74]: Inserted module 'dm_mod'955builder # [ 1.779138] systemd-udevd[80]: Using default interface naming scheme 'v260'.956server # [ 1.780457] systemd-modules-load[74]: Module 'virtio_balloon' is built in957server # [ 1.781568] systemd-modules-load[74]: Module 'virtio_console' is built in958server # [ 1.782639] systemd-modules-load[74]: Inserted module 'virtio_gpu'959server # [ 1.783644] systemd-modules-load[74]: Module 'virtio_rng' is built in960builder # [ 1.788384] systemd[1]: Starting Create System Files and Directories...961server # [ 1.789781] systemd-udevd[80]: Using default interface naming scheme 'v260'.962server # [ 1.800800] systemd[1]: Starting Create System Files and Directories...963builder # [ 1.809789] systemd[1]: Finished Create System Files and Directories.964builder # [ 1.813158] systemd[1]: Started Rule-based Manager for Device Events and Files.965server # [ 1.816164] systemd[1]: Finished Create System Files and Directories.966server # [ 1.827149] systemd[1]: Started Rule-based Manager for Device Events and Files.967builder # [ 1.888120] systemd[1]: Starting Virtual Console Setup...968server # [ 1.907192] systemd[1]: Starting Virtual Console Setup...969builder # [ 1.954841] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.970builder # [ 1.960192] systemd[1]: Finished Virtual Console Setup.971server # [ 1.968450] systemd-vconsole-setup[103]: Configuration of first virtual console was skipped, ignoring remaining ones.972server # [ 1.976269] systemd[1]: Finished Virtual Console Setup.973builder # [ 2.682293] systemd[1]: Finished Coldplug All udev Devices.974builder # [ 2.683969] systemd[1]: Reached target System Initialization.975server # [ 2.685048] systemd[1]: Finished Coldplug All udev Devices.976server # [ 2.685997] systemd[1]: Reached target System Initialization.977builder # [ 2.688693] systemd[1]: Reached target Basic System.978server # [ 2.686841] systemd[1]: Reached target Basic System.979server # [ 2.824620] (udev-worker)[93]: Network interface NamePolicy= disabled on kernel command line.980builder # [ 2.861501] (udev-worker)[102]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.981builder # [ 2.869895] (udev-worker)[102]: Network interface NamePolicy= disabled on kernel command line.982builder # [ 2.878553] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.983server # [ 2.882192] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.984server # [ 2.888262] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.985builder # [ 2.916106] systemd[1]: Found device /dev/disk/by-label/nixos.986builder # [ 2.918110] systemd[1]: Reached target Initrd Root Device.987builder # [ 2.920126] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...988server # [ 2.935312] systemd[1]: Found device /dev/disk/by-label/nixos.989server # [ 2.938313] systemd[1]: Reached target Initrd Root Device.990server # [ 2.940187] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...991builder # [ 2.964750] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks992builder # [ 2.970653] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.993builder # [ 2.979733] systemd[1]: Mounting /sysroot...994server # [ 2.994719] systemd-fsck[112]: nixos: clean, 12/65536 files, 13019/262144 blocks995server # [ 3.000291] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.996server # [ 3.012129] systemd[1]: Mounting /sysroot...997builder # [ 3.045863] EXT4-fs (vda): mounted filesystem 7cfa278a-2993-41ef-82e5-fbe49450fd53 r/w with ordered data mode. Quota mode: none.998builder # [ 3.029582] systemd[1]: Mounted /sysroot.999builder # [ 3.031974] systemd[1]: Reached target Initrd Root File System.1000builder # [ 3.039165] systemd[1]: Mounting /sysroot/nix/.ro-store...1001server # [ 3.055669] EXT4-fs (vda): mounted filesystem af7194bc-e268-4a55-a603-27006fa73133 r/w with ordered data mode. Quota mode: none.1002server # [ 3.045402] systemd[1]: Mounted /sysroot.1003server # [ 3.046105] systemd[1]: Reached target Initrd Root File System.1004server # [ 3.047487] systemd[1]: Starting Mountpoints Configured in the Real Root...1005builder # [ 3.057233] systemd[1]: Mounting /sysroot/nix/.rw-store...1006builder # [ 3.059631] systemd[1]: Mounting /sysroot/run...1007builder # [ 3.070710] systemd[1]: Mounting /sysroot/tmp/shared...1008server # [ 3.072448] systemd-sysroot-fstab-check[120]: /sysroot should be mounted in the initrd, will request daemon-reload.1009server # [ 3.080859] systemd[1]: Reload requested from client PID 120 ('systemd-sysroot') (unit initrd-parse-etc.service)...1010server # [ 3.084957] systemd[1]: Reloading...1011builder # [ 3.092821] systemd[1]: Mounting /sysroot/tmp/xchg...1012builder # [ 3.113202] systemd[1]: Starting Mountpoints Configured in the Real Root...1013builder # [ 3.117979] systemd[1]: Mounted /sysroot/nix/.rw-store.1014builder # [ 3.137835] systemd[1]: Mounted /sysroot/run.1015builder # [ 3.144098] systemd[1]: Mounted /sysroot/nix/.ro-store.1016builder # [ 3.161799] systemd[1]: Mounted /sysroot/tmp/shared.1017builder # [ 3.165264] systemd-sysroot-fstab-check[125]: /sysroot should be mounted in the initrd, will request daemon-reload.1018builder # [ 3.174351] systemd[1]: Starting rw-sysroot-nix-store.service...1019builder # [ 3.176152] systemd[1]: Mounted /sysroot/tmp/xchg.1020builder # [ 3.188926] systemd[1]: Reload requested from client PID 125 ('systemd-sysroot') (unit initrd-parse-etc.service)...1021builder # [ 3.192099] systemd[1]: Reloading...1022server # [ 3.304083] systemd[1]: Reloading finished in 219 ms.1023server # [ 3.316199] systemd-sysroot-fstab-check[120]: Requesting initrd-fs.target/start/replace...1024server # [ 3.319747] systemd-sysroot-fstab-check[120]: Requesting swap.target/start/replace...1025server # [ 3.328929] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1026server # [ 3.333072] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1027server # [ 3.346123] systemd[1]: Finished Mountpoints Configured in the Real Root.1028server # [ 3.347202] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1029server # [ 3.350201] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1030server # [ 3.352680] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1031builder # [ 3.417891] systemd[1]: Reloading finished in 226 ms.1032builder # [ 3.439457] systemd-sysroot-fstab-check[125]: Requesting initrd-fs.target/start/replace...1033builder # [ 3.444134] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1034builder # [ 3.449477] systemd[1]: Finished rw-sysroot-nix-store.service.1035builder # [ 3.451546] systemd-sysroot-fstab-check[125]: Requesting swap.target/start/replace...1036builder # [ 3.459047] systemd[1]: Starting rw-sysroot-nix-store.service...1037builder # [ 3.469068] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1038builder # [ 3.472703] systemd[1]: Finished Mountpoints Configured in the Real Root.1039builder # [ 3.474208] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1040builder # [ 3.488939] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1041builder # [ 3.490022] systemd[1]: Finished rw-sysroot-nix-store.service.1042builder # [ 3.507552] systemd[1]: Mounting /sysroot/nix/store...1043server # [ 3.510445] systemd[1]: Mounting /sysroot/nix/.ro-store...1044server # [ 3.526835] systemd[1]: Mounting /sysroot/nix/.rw-store...1045server # [ 3.530465] systemd[1]: Mounting /sysroot/run...1046builder # [ 3.548459] systemd[1]: Mounted /sysroot/nix/store.1047builder # [ 3.549581] systemd[1]: Reached target Initrd File Systems.1048server # [ 3.549101] systemd[1]: Mounting /sysroot/tmp/shared...1049builder # [ 3.553048] systemd[1]: Starting Find NixOS closure...1050builder # [ 3.565714] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1051server # [ 3.566532] systemd[1]: Mounting /sysroot/tmp/xchg...1052server # [ 3.580897] systemd[1]: Mounted /sysroot/nix/.rw-store.1053builder # [ 3.602614] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1054builder # [ 3.604729] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1055server # [ 3.609470] systemd[1]: Starting rw-sysroot-nix-store.service...1056builder # [ 3.618780] systemd[1]: Finished Find NixOS closure.1057builder # [ 3.620771] systemd[1]: Reached target Initrd Default Target.1058server # [ 3.623241] systemd[1]: Mounted /sysroot/nix/.ro-store.1059builder # [ 3.625691] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1060server # [ 3.626745] systemd[1]: Mounted /sysroot/run.1061server # [ 3.630721] systemd[1]: Mounted /sysroot/tmp/shared.1062server # [ 3.639659] systemd[1]: Mounted /sysroot/tmp/xchg.1063server # [ 3.644698] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1064server # [ 3.648266] systemd[1]: Finished rw-sysroot-nix-store.service.1065builder # [ 3.653836] systemd[1]: Stopped target Initrd Default Target.1066builder # [ 3.657523] systemd[1]: Stopped target Basic System.1067builder # [ 3.660413] systemd[1]: Stopped target Initrd Root Device.1068builder # [ 3.662556] systemd[1]: Stopped target Path Units.1069builder # [ 3.665014] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1070builder # [ 3.668283] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1071builder # [ 3.674175] systemd[1]: Stopped target Slice Units.1072builder # [ 3.676968] systemd[1]: Stopped target Socket Units.1073builder # [ 3.681657] systemd[1]: Stopped target System Initialization.1074builder # [ 3.682751] systemd[1]: Stopped target Swaps.1075builder # [ 3.687705] systemd[1]: Stopped target Timer Units.1076builder # [ 3.689943] systemd[1]: dbus.socket: Deactivated successfully.1077builder # [ 3.690789] systemd[1]: Closed D-Bus System Message Bus Socket.1078builder # [ 3.691612] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1079builder # [ 3.697209] systemd[1]: Stopped Find NixOS closure.1080builder # [ 3.697936] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1081builder # [ 3.698800] systemd[1]: Starting rw-sysroot-nix-store.service...1082builder # [ 3.699629] systemd[1]: systemd-sysctl.service: Deactivated successfully.1083builder # [ 3.708921] systemd[1]: Stopped Apply Kernel Variables.1084builder # [ 3.715919] systemd[1]: systemd-modules-load.service: Deactivated successfully.1085builder # [ 3.718542] systemd[1]: Stopped Load Kernel Modules.1086builder # [ 3.722767] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1087builder # [ 3.728220] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1088builder # [ 3.732174] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1089builder # [ 3.737102] systemd[1]: Stopped Create System Files and Directories.1090builder # [ 3.738467] systemd[1]: Stopped target Local File Systems.1091builder # [ 3.739272] systemd[1]: Stopped target Preparation for Local File Systems.1092builder # [ 3.742408] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1093builder # [ 3.743440] systemd[1]: Stopped Coldplug All udev Devices.1094builder # [ 3.744343] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1095builder # [ 3.745401] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1096builder # [ 3.746424] systemd[1]: Stopped Virtual Console Setup.1097builder # [ 3.747163] systemd[1]: initrd-cleanup.service: Deactivated successfully.1098builder # [ 3.755834] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1099builder # [ 3.756988] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1100builder # [ 3.757994] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1101builder # [ 3.758837] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1102builder # [ 3.759825] systemd[1]: Finished rw-sysroot-nix-store.service.1103builder # [ 3.761569] systemd[1]: systemd-udevd.service: Deactivated successfully.1104builder # [ 3.762500] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1105builder # [ 3.763473] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1106builder # [ 3.764547] systemd[1]: Closed udev Control Socket.1107builder # [ 3.765269] systemd[1]: Starting Cleanup udev Database...1108builder # [ 3.766198] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1109builder # [ 3.767236] systemd[1]: Stopped Create Static Device Nodes in /dev.1110builder # [ 3.772212] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1111builder # [ 3.773416] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1112builder # [ 3.776094] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1113builder # [ 3.780192] systemd[1]: Stopped Create List of Static Device Nodes.1114builder # [ 3.792703] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1115builder # [ 3.795048] systemd[1]: Finished Cleanup udev Database.1116builder # [ 3.796569] systemd[1]: Reached target Switch Root.1117builder # [ 3.800154] systemd[1]: Starting NixOS Activation...1118builder # [ 3.951579] initrd-nixos-activation-start[172]: booting system configuration /nix/store/xq4mqjzi2ix2w247ap31jlhr51d10avj-nixos-system-builder-test1119builder # [ 4.010710] initrd-nixos-activation-start[172]: running activation script...1120server # [ 4.266202] (udev-worker)[95]: mtd0ro: Failed to find and pin callout binary "/nix/store/k2s978i7i26km4cr56fvm64p2q6mpl02-systemd-260.2/lib/udev/mtd_probe": No such file or directory1121server # [ 4.273052] (udev-worker)[95]: 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 directory1122server # [ 4.304458] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1123server # [ 4.308418] systemd[1]: Stopped Virtual Console Setup.1124server # [ 4.309203] systemd[1]: Stopping Virtual Console Setup...1125server # [ 4.312155] systemd[1]: Starting Virtual Console Setup...1126server # [ 4.325961] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1127server # [ 4.328165] systemd[1]: Stopped Virtual Console Setup.1128server # [ 4.331563] systemd[1]: Starting Virtual Console Setup...1129server # [ 4.348580] systemd-vconsole-setup[155]: Configuration of first virtual console was skipped, ignoring remaining ones.1130server # [ 4.352187] systemd[1]: Finished Virtual Console Setup.1131builder # [ 4.399380] initrd-nixos-activation-start[195]: setting up /etc...1132server # [ 4.512599] systemd[1]: Mounting /sysroot/nix/store...1133server # [ 4.569861] systemd[1]: Mounted /sysroot/nix/store.1134server # [ 4.573299] systemd[1]: Reached target Initrd File Systems.1135server # [ 4.578152] systemd[1]: Starting Find NixOS closure...1136server # [ 4.588400] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1137server # [ 4.641639] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1138builder # [ 4.647674] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1139server # [ 4.646130] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1140builder # [ 4.650655] systemd[1]: Finished NixOS Activation.1141builder # [ 4.651837] systemd[1]: Starting Switch Root...1142server # [ 4.656498] systemd[1]: Finished Find NixOS closure.1143server # [ 4.660146] systemd[1]: Reached target Initrd Default Target.1144server # [ 4.664911] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1145builder # [ 4.674709] systemd[1]: Switching root.1146server # [ 4.692753] systemd[1]: Stopped target Initrd Default Target.1147server # [ 4.694615] systemd[1]: Stopped target Basic System.1148server # [ 4.700327] systemd[1]: Stopped target Initrd Root Device.1149server # [ 4.701561] systemd[1]: Stopped target Path Units.1150server # [ 4.702619] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1151server # [ 4.705212] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1152server # [ 4.712311] systemd[1]: Stopped target Slice Units.1153server # [ 4.714235] systemd[1]: Stopped target Socket Units.1154server # [ 4.715182] systemd[1]: Stopped target System Initialization.1155server # [ 4.717040] systemd[1]: Stopped target Swaps.1156server # [ 4.720563] systemd[1]: Stopped target Timer Units.1157server # [ 4.725121] systemd[1]: dbus.socket: Deactivated successfully.1158server # [ 4.727396] systemd[1]: Closed D-Bus System Message Bus Socket.1159builder # [ 4.751456] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1160server # [ 4.733190] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1161server # [ 4.734612] systemd[1]: Stopped Find NixOS closure.1162server # [ 4.735538] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1163server # [ 4.742541] systemd[1]: Starting rw-sysroot-nix-store.service...1164server # [ 4.747910] systemd[1]: systemd-sysctl.service: Deactivated successfully.1165server # [ 4.750227] systemd[1]: Stopped Apply Kernel Variables.1166server # [ 4.751469] systemd[1]: systemd-modules-load.service: Deactivated successfully.1167server # [ 4.755559] systemd[1]: Stopped Load Kernel Modules.1168server # [ 4.756603] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1169server # [ 4.757886] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1170server # [ 4.759109] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1171server # [ 4.768229] systemd[1]: Stopped Create System Files and Directories.1172server # [ 4.772266] systemd[1]: Stopped target Local File Systems.1173server # [ 4.775431] systemd[1]: Stopped target Preparation for Local File Systems.1174server # [ 4.777370] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1175server # [ 4.779787] systemd[1]: Stopped Coldplug All udev Devices.1176server # [ 4.784241] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1177server # [ 4.785331] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1178server # [ 4.786388] systemd[1]: Stopped Virtual Console Setup.1179server # [ 4.787890] systemd[1]: initrd-cleanup.service: Deactivated successfully.1180server # [ 4.789927] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1181server # [ 4.791554] systemd[1]: systemd-udevd.service: Deactivated successfully.1182server # [ 4.792738] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1183server # [ 4.793759] systemd[1]: systemd-udevd.service: Consumed 1.538s CPU time over 3.106s wall clock time, 22.6M memory peak.1184server # [ 4.795323] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1185server # [ 4.796497] systemd[1]: Finished rw-sysroot-nix-store.service.1186server # [ 4.797326] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1187server # [ 4.798336] systemd[1]: Closed udev Control Socket.1188server # [ 4.799053] systemd[1]: Starting Cleanup udev Database...1189server # [ 4.799829] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1190server # [ 4.804217] systemd[1]: Stopped Create Static Device Nodes in /dev.1191server # [ 4.808171] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1192server # [ 4.809469] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1193server # [ 4.810624] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1194server # [ 4.816084] systemd[1]: Stopped Create List of Static Device Nodes.1195server # [ 4.817007] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1196server # [ 4.818029] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1197server # [ 4.846017] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1198server # [ 4.847178] systemd[1]: Finished Cleanup udev Database.1199server # [ 4.851790] systemd[1]: Reached target Switch Root.1200server # [ 4.852989] systemd[1]: Starting NixOS Activation...1201server # [ 5.005342] initrd-nixos-activation-start[180]: booting system configuration /nix/store/yj2g3xjp9kg18n15fj7jqgy0byxbidgk-nixos-system-server-test1202server # [ 5.066003] initrd-nixos-activation-start[180]: running activation script...1203builder # [ 5.303706] 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)1204builder # [ 5.316472] systemd[1]: Detected virtualization qemu.1205builder # [ 5.319629] systemd[1]: Detected architecture arm64.1206builder # [ 5.323369] systemd[1]: Detected first boot.1207builder # [ 5.329617] systemd[1]: Initializing machine ID from random generator.1208server # [ 5.460572] initrd-nixos-activation-start[203]: setting up /etc...1209builder # [ 5.638971] systemd[1]: bpf-restrict-fs: LSM BPF program attached1210server # [ 5.712493] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1211server # [ 5.715249] systemd[1]: Finished NixOS Activation.1212server # [ 5.720297] systemd[1]: Starting Switch Root...1213server # [ 5.738595] systemd[1]: Switching root.1214server # [ 5.805521] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1215builder # [ 5.830311] systemd[1]: Applying preset policy.1216builder # [ 6.329559] systemd[1]: Populated /etc with preset unit settings.1217server # [ 6.353553] 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)1218server # [ 6.366854] systemd[1]: Detected virtualization qemu.1219server # [ 6.366957] systemd[1]: Detected architecture arm64.1220server # [ 6.367129] systemd[1]: Detected first boot.1221server # [ 6.378113] systemd[1]: Initializing machine ID from random generator.1222server # [ 6.697975] systemd[1]: bpf-restrict-fs: LSM BPF program attached1223builder # [ 6.819954] systemd[1]: initrd-switch-root.service: Deactivated successfully.1224builder # [ 6.821541] systemd[1]: Stopped initrd-switch-root.service.1225builder # [ 6.824457] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1226builder # [ 6.827508] systemd[1]: Created slice Slice /system/getty.1227builder # [ 6.829590] systemd[1]: Created slice User and Session Slice.1228builder # [ 6.830855] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1229builder # [ 6.832578] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1230builder # [ 6.834902] systemd[1]: Expecting device /dev/hvc0...1231builder # [ 6.836646] systemd[1]: Expecting device /dev/ttyAMA0...1232builder # [ 6.838567] systemd[1]: Reached target Local Encrypted Volumes.1233builder # [ 6.840419] systemd[1]: Stopped target initrd-fs.target.1234builder # [ 6.842253] systemd[1]: Stopped target initrd-root-fs.target.1235builder # [ 6.844229] systemd[1]: Stopped target initrd-switch-root.target.1236builder # [ 6.846186] systemd[1]: Reached target Virtual Machines and Containers.1237builder # [ 6.848116] systemd[1]: Reached target Path Units.1238builder # [ 6.849903] systemd[1]: Reached target Remote File Systems.1239builder # [ 6.851680] systemd[1]: Reached target Slice Units.1240builder # [ 6.853410] systemd[1]: Reached target Swaps.1241builder # [ 6.857188] systemd[1]: Listening on Query the User Interactively for a Password.1242builder # [ 6.861953] systemd[1]: Listening on Process Core Dump Socket.1243builder # [ 6.865732] systemd[1]: Listening on Credential Encryption/Decryption.1244builder # [ 6.869586] systemd[1]: Listening on Factory Reset Management.1245builder # [ 6.874826] systemd[1]: Starting Journal Log Access Socket...1246builder # [ 6.876808] systemd[1]: Listening on Journal Audit Socket.1247builder # [ 6.880958] systemd[1]: Listening on Console Output Muting Service Socket.1248builder # [ 6.883611] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1249builder # [ 6.886204] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1250builder # [ 6.888653] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1251server # [ 6.890301] systemd[1]: Applying preset policy.1252builder # [ 6.899286] systemd[1]: Listening on Disk Repartitioning Service Socket.1253builder # [ 6.901514] systemd[1]: Listening on udev Control Socket.1254builder # [ 6.903415] systemd[1]: Listening on udev Varlink Socket.1255builder # [ 6.907908] systemd[1]: Mounting Huge Pages File System...1256builder # [ 6.912650] systemd[1]: Mounting POSIX Message Queue File System...1257builder # [ 6.918177] systemd[1]: Mounting Kernel Debug File System...1258builder # [ 6.929132] systemd[1]: Mounting Kernel Trace File System...1259builder # [ 6.943039] systemd[1]: Starting Create List of Static Device Nodes...1260builder # [ 6.953559] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1261builder # [ 6.953925] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1262builder # [ 6.961797] systemd[1]: Mounting Kernel Configuration File System...1263builder # [ 6.964197] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1264builder # [ 6.967720] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1265builder # [ 6.983504] systemd[1]: Starting Load Kernel Module fuse...1266builder # [ 6.986107] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671267builder # [ 6.996418] systemd[1]: Starting Journal Service...1268builder # [ 7.021088] systemd[1]: Starting Load Kernel Modules...1269builder # [ 7.035914] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1270builder # [ 7.046528] systemd[1]: Starting Remount Root and Kernel File Systems...1271builder # [ 7.049756] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1272builder # [ 7.066652] systemd[1]: Starting Coldplug All udev Devices...1273builder # [ 7.069084] systemd[1]: Listening on Journal Log Access Socket.1274builder # [ 7.074766] systemd[1]: Mounted Huge Pages File System.1275builder # [ 7.077460] systemd[1]: Mounted POSIX Message Queue File System.1276builder # [ 7.081548] systemd[1]: Mounted Kernel Debug File System.1277builder # [ 7.083625] systemd[1]: Mounted Kernel Trace File System.1278builder # [ 7.084073] systemd[1]: Mounted Kernel Configuration File System.1279builder # [ 7.134526] systemd[1]: Finished Create List of Static Device Nodes.1280builder # [ 7.141834] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1281builder # [ 7.202618] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1282builder # [ 7.209284] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1283builder # [ 7.217291] EXT4-fs (vda): re-mounted 7cfa278a-2993-41ef-82e5-fbe49450fd53.1284builder # [ 7.226405] systemd[1]: Finished Remount Root and Kernel File Systems.1285builder # [ 7.228716] systemd[1]: Listening on Disk Image Download Service Socket.1286builder # [ 7.230973] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1287builder # [ 7.236911] systemd[1]: Starting Load/Save OS Random Seed...1288builder # [ 7.239088] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1289builder # [ 7.258591] systemd[1]: Finished Load Kernel Modules.1290builder # [ 7.264034] systemd[1]: Starting Firewall...1291builder # [ 7.270355] systemd[1]: Starting Apply Kernel Variables...1292builder # [ 7.286288] systemd-journald[266]: Collecting audit messages is enabled.1293builder # [ 7.304520] fuse: init (API version 7.45)1294builder # [ 7.338454] systemd[1]: Started Journal Service.1295builder # [ 7.325318] systemd[1]: Queued start job for default target Multi-User System.1296builder # [ 7.327380] systemd[1]: systemd-journald.service: Deactivated successfully.1297builder # [ 7.340644] systemd-modules-load[267]: Module 'atkbd' is built in1298builder # [ 7.352665] systemd-modules-load[267]: Module 'loop' is built in1299builder # [ 7.362643] systemd-modules-load[267]: Module 'tun' is built in1300builder # [ 7.371571] systemd[1]: Starting Flush Journal to Persistent Storage...1301builder # [ 7.380785] systemd[1]: modprobe@fuse.service: Deactivated successfully.1302server # [ 7.405655] systemd[1]: Populated /etc with preset unit settings.1303builder # [ 7.392329] systemd[1]: Finished Load Kernel Module fuse.1304builder # [ 7.397235] systemd-oomd[268]: No swap; memory pressure usage will be degraded1305builder # [ 7.407827] systemd[1]: Finished Load/Save OS Random Seed.1306builder # [ 7.417421] systemd[1]: Reached target First Boot Complete.1307builder # [ 7.425689] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1308builder # [ 7.429350] systemd[1]: Finished Apply Kernel Variables.1309builder # [ 7.455465] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1310builder # [ 7.479563] systemd-journald[266]: Received client request to flush runtime journal.1311builder # [ 7.529994] systemd[1]: Starting Create Static Device Nodes in /dev...1312builder # [ 7.535391] systemd[1]: Finished Flush Journal to Persistent Storage.1313builder # [ 7.606256] systemd[1]: Finished Create Static Device Nodes in /dev.1314builder # [ 7.607335] systemd[1]: Reached target Preparation for Local File Systems.1315builder # [ 7.610037] systemd[1]: Starting Rule-based Manager for Device Events and Files...1316builder # [ 7.804140] systemd[1]: Mounting /run/wrappers...1317builder # [ 7.807294] systemd[1]: Mounting FUSE Control File System...1318builder # [ 7.847365] systemd[1]: Mounted FUSE Control File System.1319builder # [ 7.878575] systemd[1]: Mounted /run/wrappers.1320builder # [ 7.880828] systemd[1]: Reached target Local File Systems.1321builder # [ 7.883956] systemd[1]: Listening on Boot Loader Control Service Socket.1322builder # [ 7.889626] systemd[1]: Starting register-nix-paths.service...1323server # [ 7.921249] systemd[1]: initrd-switch-root.service: Deactivated successfully.1324builder # [ 7.904927] systemd[1]: Starting Create SUID/SGID Wrappers...1325server # [ 7.923612] systemd[1]: Stopped initrd-switch-root.service.1326builder # [ 7.908736] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1327server # [ 7.927138] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1328server # [ 7.930708] systemd[1]: Created slice Slice /system/getty.1329builder # [ 7.915201] systemd[1]: Starting Save Transient machine-id to Disk...1330server # [ 7.933259] systemd[1]: Created slice User and Session Slice.1331server # [ 7.935143] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1332builder # [ 7.919743] systemd[1]: Starting Create System Files and Directories...1333server # [ 7.937159] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1334server # [ 7.937555] systemd[1]: Expecting device /dev/hvc0...1335server # [ 7.937801] systemd[1]: Expecting device /dev/ttyAMA0...1336server # [ 7.938043] systemd[1]: Reached target Local Encrypted Volumes.1337server # [ 7.938288] systemd[1]: Stopped target initrd-fs.target.1338server # [ 7.938540] systemd[1]: Stopped target initrd-root-fs.target.1339server # [ 7.938772] systemd[1]: Stopped target initrd-switch-root.target.1340server # [ 7.939006] systemd[1]: Reached target Virtual Machines and Containers.1341server # [ 7.939246] systemd[1]: Reached target Path Units.1342server # [ 7.939479] systemd[1]: Reached target Remote File Systems.1343server # [ 7.939698] systemd[1]: Reached target Slice Units.1344server # [ 7.939916] systemd[1]: Reached target Swaps.1345server # [ 7.951578] systemd[1]: Listening on Query the User Interactively for a Password.1346server # [ 7.956350] systemd[1]: Listening on Process Core Dump Socket.1347server # [ 7.960090] systemd[1]: Listening on Credential Encryption/Decryption.1348server # [ 7.963924] systemd[1]: Listening on Factory Reset Management.1349server # [ 7.969434] systemd[1]: Starting Journal Log Access Socket...1350server # [ 7.972493] systemd[1]: Listening on Journal Audit Socket.1351server # [ 7.977391] systemd[1]: Listening on Console Output Muting Service Socket.1352server # [ 7.980361] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1353server # [ 7.982526] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1354server # [ 7.985023] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1355server # [ 7.995494] systemd[1]: Listening on Disk Repartitioning Service Socket.1356server # [ 7.995927] systemd[1]: Listening on udev Control Socket.1357server # [ 7.997986] systemd[1]: Listening on udev Varlink Socket.1358server # [ 8.002689] systemd[1]: Mounting Huge Pages File System...1359server # [ 8.007852] systemd[1]: Mounting POSIX Message Queue File System...1360server # [ 8.015065] systemd[1]: Mounting Kernel Debug File System...1361server # [ 8.027458] systemd[1]: Mounting Kernel Trace File System...1362server # [ 8.041310] systemd[1]: Starting Create List of Static Device Nodes...1363server # [ 8.048732] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1364builder # [ 8.032760] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1365server # [ 8.052457] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1366server # [ 8.061961] systemd[1]: Mounting Kernel Configuration File System...1367builder # [ 8.048592] systemd[1]: Finished Save Transient machine-id to Disk.1368server # [ 8.065056] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1369server # [ 8.069190] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1370server # [ 8.088518] systemd[1]: Starting Load Kernel Module fuse...1371server # [ 8.090696] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671372server # [ 8.142101] systemd[1]: Starting Journal Service...1373server # [ 8.151612] systemd[1]: Starting Load Kernel Modules...1374server # [ 8.173339] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1375server # [ 8.182072] systemd[1]: Starting Remount Root and Kernel File Systems...1376server # [ 8.182433] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1377server # [ 8.192100] systemd[1]: Starting Coldplug All udev Devices...1378server # [ 8.198621] systemd[1]: Listening on Journal Log Access Socket.1379server # [ 8.201864] systemd[1]: Mounted Huge Pages File System.1380server # [ 8.204516] systemd[1]: Mounted POSIX Message Queue File System.1381server # [ 8.208561] systemd[1]: Mounted Kernel Debug File System.1382builder # [ 8.192119] systemd[1]: Finished Create System Files and Directories.1383server # [ 8.210557] systemd[1]: Mounted Kernel Trace File System.1384server # [ 8.210998] systemd[1]: Mounted Kernel Configuration File System.1385builder # [ 8.202822] systemd[1]: Starting Rebuild Journal Catalog...1386builder # [ 8.209151] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1387server # [ 8.251431] systemd[1]: Finished Create List of Static Device Nodes.1388server # [ 8.257958] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1389server # [ 8.319495] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1390server # [ 8.322049] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1391server # [ 8.340376] EXT4-fs (vda): re-mounted af7194bc-e268-4a55-a603-27006fa73133.1392server # [ 8.361472] systemd[1]: Finished Remount Root and Kernel File Systems.1393server # [ 8.363700] systemd[1]: Listening on Disk Image Download Service Socket.1394builder # [ 8.347536] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1395server # [ 8.364066] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1396server # [ 8.376030] systemd[1]: Starting Load/Save OS Random Seed...1397server # [ 8.376375] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1398server # [ 8.386039] systemd-journald[273]: Collecting audit messages is enabled.1399server # [ 8.397331] fuse: init (API version 7.45)1400builder # [ 8.379202] systemd-udevd[308]: Using default interface naming scheme 'v260'.1401server # [ 8.392710] systemd[1]: Queued start job for default target Multi-User System.1402server # [ 8.413984] systemd[1]: Started Journal Service.1403server # [ 8.404255] systemd[1]: systemd-journald.service: Deactivated successfully.1404builder # [ 8.411270] systemd[1]: Finished Rebuild Journal Catalog.1405builder # [ 8.414280] systemd[1]: Starting Update is Completed...1406server # [ 8.419873] systemd-modules-load[274]: Module 'atkbd' is built in1407server # [ 8.436743] systemd-modules-load[274]: Module 'loop' is built in1408server # [ 8.455165] systemd-modules-load[274]: Inserted module 'tls'1409server # [ 8.472290] systemd-modules-load[274]: Module 'tun' is built in1410server # [ 8.483262] systemd[1]: Starting Flush Journal to Persistent Storage...1411server # [ 8.492608] systemd[1]: Finished Load Kernel Modules.1412server # [ 8.500174] systemd[1]: Starting Firewall...1413server # [ 8.509347] systemd[1]: Starting Apply Kernel Variables...1414builder # [ 8.519806] systemd[1]: Finished Update is Completed.1415server # [ 8.520426] systemd[1]: modprobe@fuse.service: Deactivated successfully.1416server # [ 8.523499] systemd[1]: Finished Load Kernel Module fuse.1417server # [ 8.533547] systemd[1]: Mounting FUSE Control File System...1418server # [ 8.537925] systemd[1]: Mounted FUSE Control File System.1419server # [ 8.563567] systemd-journald[273]: Received client request to flush runtime journal.1420server # [ 8.616470] systemd-oomd[275]: No swap; memory pressure usage will be degraded1421server # [ 8.624367] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1422server # [ 8.629853] systemd[1]: Finished Load/Save OS Random Seed.1423server # [ 8.634502] systemd[1]: Reached target First Boot Complete.1424server # [ 8.640642] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1425server # [ 8.645894] systemd[1]: Starting Create Static Device Nodes in /dev...1426server # [ 8.650287] systemd[1]: Finished Apply Kernel Variables.1427server # [ 8.653073] systemd[1]: Finished Flush Journal to Persistent Storage.1428builder # [ 8.702405] systemd[1]: Started Rule-based Manager for Device Events and Files.1429server # [ 8.718759] systemd[1]: Finished Create Static Device Nodes in /dev.1430server # [ 8.719914] systemd[1]: Reached target Preparation for Local File Systems.1431server # [ 8.724845] systemd[1]: Starting Rule-based Manager for Device Events and Files...1432server # [ 8.846578] systemd-udevd[313]: Using default interface naming scheme 'v260'.1433server # [ 8.906894] systemd[1]: Mounting /run/wrappers...1434server # [ 8.962345] systemd[1]: Mounted /run/wrappers.1435server # [ 8.968365] systemd[1]: Reached target Local File Systems.1436server # [ 8.969724] systemd[1]: Listening on Boot Loader Control Service Socket.1437server # [ 8.976664] systemd[1]: Starting register-nix-paths.service...1438server # [ 8.980604] systemd[1]: Starting Create SUID/SGID Wrappers...1439server # [ 8.982208] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1440server # [ 8.997903] systemd[1]: Starting Save Transient machine-id to Disk...1441server # [ 9.003702] systemd[1]: Starting Create System Files and Directories...1442builder # [ 9.025319] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1443builder # [ 9.026533] systemd[1]: Finished Create SUID/SGID Wrappers.1444server # [ 9.095058] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1445server # [ 9.103094] systemd[1]: Finished Save Transient machine-id to Disk.1446server # [ 9.133376] systemd[1]: Started Rule-based Manager for Device Events and Files.1447builder # [ 9.243014] systemd[1]: Finished register-nix-paths.service.1448server # [ 9.262433] systemd[1]: Finished Create System Files and Directories.1449server # [ 9.265510] systemd[1]: Starting Rebuild Journal Catalog...1450server # [ 9.270502] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1451builder # [ 9.332253] systemd[1]: Finished Firewall.1452server # [ 9.373757] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1453server # [ 9.443913] systemd[1]: Finished Rebuild Journal Catalog.1454server # [ 9.447148] systemd[1]: Starting Update is Completed...1455server # [ 9.541691] systemd[1]: Finished Update is Completed.1456builder # [ 9.752924] systemd[1]: Finished Coldplug All udev Devices.1457builder # [ 9.754631] systemd[1]: Reached target System Initialization.1458builder # [ 9.760642] systemd[1]: Started Discard unused filesystem blocks once a week.1459builder # [ 9.761895] systemd[1]: Started Daily Cleanup of Temporary Directories.1460builder # [ 9.763704] systemd[1]: Reached target Timer Units.1461builder # [ 9.771618] systemd[1]: Listening on D-Bus System Message Bus Socket.1462builder # [ 9.776543] systemd[1]: Starting niks3 auto-upload socket...1463builder # [ 9.777390] systemd[1]: Listening on Nix Daemon Socket.1464builder # [ 9.778174] systemd[1]: Listening on Hostname Service Socket.1465builder # [ 9.779022] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1466builder # [ 9.792087] systemd[1]: Listening on niks3 auto-upload socket.1467builder # [ 9.793100] systemd[1]: Reached target Socket Units.1468builder # [ 9.793885] systemd[1]: Starting D-Bus System Message Bus...1469builder # [ 9.892431] dbus-broker-launch[484]: Looking up NSS user entry for 'systemd-timesync'...1470builder # [ 9.907030] dbus-broker-launch[484]: NSS returned no entry for 'systemd-timesync'1471builder # [ 9.909894] 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"1472server # [ 9.935175] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1473server # [ 9.936932] systemd[1]: Finished Create SUID/SGID Wrappers.1474builder # [ 9.940088] systemd[1]: Started D-Bus System Message Bus.1475builder # [ 9.970567] systemd[1]: Reached target Basic System.1476builder # [ 9.975595] dbus-broker-launch[484]: Ready1477builder # [ 9.979415] systemd[1]: Starting Import lastlog data into lastlog2 database...1478builder # [ 9.988502] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1479builder # [ 9.996728] systemd[1]: Starting Post-Boot Actions...1480builder # [ 10.004296] systemd[1]: Started Reset console on configuration changes.1481builder # [ 10.016210] systemd[1]: Starting resolvconf update...1482builder # [ 10.094786] systemd[1]: Finished Post-Boot Actions.1483server # [ 10.108091] systemd[1]: Finished register-nix-paths.service.1484builder # [ 10.133286] systemd[1]: Started Name Service Cache Daemon (nsncd).1485builder # [ 10.139077] nsncd[487]: Jul 08 22:01:26.776 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1486builder # [ 10.149480] systemd[1]: Reached target Host and Network Name Lookups.1487builder # [ 10.153295] systemd[1]: Reached target User and Group Name Lookups.1488builder # [ 10.160072] systemd[1]: Starting User Login Management...1489builder # [ 10.166617] systemd[1]: Finished Import lastlog data into lastlog2 database.1490builder # [ 10.294281] systemd[1]: Stopped target Host and Network Name Lookups.1491builder # [ 10.301208] systemd[1]: Stopping Host and Network Name Lookups...1492builder # [ 10.312287] systemd[1]: Stopped target User and Group Name Lookups.1493builder # [ 10.315289] systemd[1]: Stopping User and Group Name Lookups...1494builder # [ 10.320730] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1495builder # [ 10.325447] systemd[1]: nscd.service: Deactivated successfully.1496builder # [ 10.333346] systemd-logind[507]: New seat seat0.1497builder # [ 10.338841] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1498builder # [ 10.341210] systemd[1]: Started User Login Management.1499builder # [ 10.345634] systemd[1]: Starting linger-users.service...1500builder # [ 10.348330] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1501server # [ 10.375765] systemd[1]: Finished Firewall.1502builder # [ 10.401386] systemd[1]: linger-users.service: Deactivated successfully.1503builder # [ 10.407281] systemd[1]: Finished linger-users.service.1504builder # [ 10.413154] systemd[1]: Started Name Service Cache Daemon (nsncd).1505builder # [ 10.416950] systemd[1]: Reached target Host and Network Name Lookups.1506builder # [ 10.420393] nsncd[548]: Jul 08 22:01:27.056 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1507builder # [ 10.425746] systemd[1]: Reached target User and Group Name Lookups.1508builder # [ 10.460228] systemd[1]: Finished resolvconf update.1509builder # [ 10.462371] systemd[1]: Reached target Preparation for Network.1510builder # [ 10.467209] systemd[1]: Starting DHCP Client...1511builder # [ 10.470606] systemd[1]: Starting Extra networking commands....1512server # [ 10.571486] systemd[1]: Finished Coldplug All udev Devices.1513server # [ 10.573081] systemd[1]: Reached target System Initialization.1514server # [ 10.573965] systemd[1]: Started Discard unused filesystem blocks once a week.1515server # [ 10.575021] systemd[1]: Started niks3 garbage collection timer.1516server # [ 10.575893] systemd[1]: Started Daily Cleanup of Temporary Directories.1517server # [ 10.580342] systemd[1]: Reached target Timer Units.1518server # [ 10.581261] systemd[1]: Listening on D-Bus System Message Bus Socket.1519server # [ 10.583172] systemd[1]: Listening on niks3 server socket.1520server # [ 10.589658] systemd[1]: Listening on Nix Daemon Socket.1521server # [ 10.596394] systemd[1]: Listening on Hostname Service Socket.1522server # [ 10.597294] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1523server # [ 10.598590] systemd[1]: Reached target Socket Units.1524server # [ 10.599479] systemd[1]: Reached target Basic System.1525server # [ 10.603910] systemd[1]: Starting Import lastlog data into lastlog2 database...1526server # [ 10.610185] systemd[1]: Starting Generate test mTLS certs...1527server # [ 10.618005] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1528server # [ 10.625406] systemd[1]: Starting Post-Boot Actions...1529server # [ 10.632190] systemd[1]: Started Reset console on configuration changes.1530server # [ 10.643377] systemd[1]: Starting resolvconf update...1531server # [ 10.650883] systemd[1]: Starting D-Bus System Message Bus...1532builder # [ 10.686739] dhcpcd[581]: dhcpcd-10.3.2 starting1533builder # [ 10.704573] dhcpcd[614]: dev: loaded udev1534builder # [ 10.711595] dhcpcd[614]: no valid interfaces found1535builder # [ 10.713615] dhcpcd[614]: libudev: received NULL device1536builder # [ 10.716826] dhcpcd[614]: no valid interfaces found1537builder # [ 10.718936] dhcpcd[614]: libudev: received NULL device1538server # [ 10.739331] systemd[1]: Finished Post-Boot Actions.1539builder # [ 10.744431] systemd[1]: Finished Extra networking commands..1540builder # [ 10.746482] systemd[1]: Reached target Network.1541builder # [ 10.749001] systemd[1]: Starting Permit User Sessions...1542server # [ 10.750371] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1543builder # [ 10.801415] systemd[1]: Finished Permit User Sessions.1544server # [ 10.800188] systemd[1]: Started Name Service Cache Daemon (nsncd).1545builder # [ 10.804917] systemd[1]: Started Getty on tty1.1546builder # [ 10.806997] systemd[1]: Reached target Login Prompts.1547server # [ 10.806796] systemd[1]: Reached target Host and Network Name Lookups.1548server # [ 10.816918] nsncd[503]: Jul 08 22:01:27.449 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1549server # [ 10.829727] systemd[1]: Reached target User and Group Name Lookups.1550server # [ 10.834175] systemd[1]: Starting User Login Management...1551server # [ 10.840783] systemd[1]: Finished Import lastlog data into lastlog2 database.1552server # [ 10.888585] niks3-test-certs-start[515]: -----1553server # [ 10.901593] dbus-broker-launch[507]: Looking up NSS user entry for 'systemd-timesync'...1554server # [ 10.928113] dbus-broker-launch[507]: NSS returned no entry for 'systemd-timesync'1555server # [ 10.933256] dbus-broker-launch[507]: Invalid user-name in /nix/store/b2n18m6nii139ip3d50yqq76r3lf29iq-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1556builder # [ 10.967730] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31557server # [ 10.948724] niks3-test-certs-start[544]: -----1558server # [ 10.987408] systemd[1]: Started D-Bus System Message Bus.1559server # [ 11.043444] dbus-broker-launch[507]: Ready1560server # [ 11.058003] systemd[1]: Stopped target Host and Network Name Lookups.1561server # [ 11.073834] systemd[1]: Stopping Host and Network Name Lookups...1562server # [ 11.080865] systemd[1]: Stopped target User and Group Name Lookups.1563server # [ 11.085911] systemd[1]: Stopping User and Group Name Lookups...1564server # [ 11.099815] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1565server # [ 11.106524] systemd-logind[517]: New seat seat0.1566server # [ 11.109247] systemd[1]: nscd.service: Deactivated successfully.1567server # [ 11.112158] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1568server # [ 11.117466] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1569server # [ 11.126168] niks3-test-certs-start[553]: Certificate request self-signature ok1570server # [ 11.130262] niks3-test-certs-start[553]: subject=CN=server1571server # [ 11.136143] systemd[1]: Started User Login Management.1572server # [ 11.141790] systemd[1]: Starting linger-users.service...1573server # [ 11.173604] niks3-test-certs-start[580]: -----1574server # [ 11.187155] systemd[1]: linger-users.service: Deactivated successfully.1575server # [ 11.192773] systemd[1]: Finished linger-users.service.1576server # [ 11.198856] systemd[1]: Started Name Service Cache Daemon (nsncd).1577server # [ 11.202715] nsncd[568]: Jul 08 22:01:27.846 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1578server # [ 11.212368] systemd[1]: Reached target Host and Network Name Lookups.1579server # [ 11.215352] systemd[1]: Reached target User and Group Name Lookups.1580server # [ 11.251157] systemd[1]: Finished resolvconf update.1581server # [ 11.251993] systemd[1]: Reached target Preparation for Network.1582server # [ 11.256399] systemd[1]: Starting DHCP Client...1583server # [ 11.262712] systemd[1]: Starting Extra networking commands....1584server # [ 11.281331] niks3-test-certs-start[585]: Certificate request self-signature ok1585builder # [ 11.288822] systemd[1]: Starting Virtual Console Setup...1586server # [ 11.290396] niks3-test-certs-start[585]: subject=CN=niks3 test client1587builder # [ 11.297697] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1588builder # [ 11.316350] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1589builder # [ 11.318045] systemd[1]: Stopped Virtual Console Setup.1590builder # [ 11.320947] systemd[1]: Starting Virtual Console Setup...1591server # [ 11.326344] systemd[1]: Finished Generate test mTLS certs.1592server # [ 11.370349] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1593server # [ 11.452385] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1594server # [ 11.461388] systemd[1]: Started backdoor.service.1595server # [ 11.527954] dhcpcd[607]: dhcpcd-10.3.2 starting1596server # [ 11.549115] dhcpcd[643]: dev: loaded udev1597server # connecting to host...1598server # [ 11.606291] 8021q: 802.1Q VLAN Support v1.81599server # [ 11.602169] systemd[1]: Finished Extra networking commands..1600server # [ 11.608444] systemd[1]: Reached target Network.1601server # [ 11.617621] systemd[1]: Started Mock OIDC server for testing.1602builder # [ 11.623601] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1603server # [ 11.626005] systemd[1]: Starting Nginx Web Server...1604server # [ 11.642406] systemd[1]: Starting PostgreSQL Server...1605server # [ 11.650223] systemd[1]: Started RustFS S3-compatible object storage.1606builder # [ 11.661844] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1607builder # [ 11.667387] systemd[1]: Started backdoor.service.1608server # [ 11.670156] systemd[1]: Starting Setup RustFS bucket...1609server # [ 11.689304] systemd[1]: Starting Permit User Sessions...1610server # [ 11.720639] cfg80211: Loading compiled-in X.509 certificates for regulatory database1611server: Guest shell says: b'Spawning backdoor root shell...\n'1612server: connected to guest root shell1613server # [ 11.751173] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1614server: (connecting took 12.09 seconds)1615server # [ 11.751648] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1616server: (finished: waiting for the VM to finish booting, in 12.09 seconds)1617server # [ 11.756439] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21618server # [ 11.756773] cfg80211: failed to load regulatory.db1619server # [ 11.748331] dhcpcd[643]: no valid interfaces found1620builder # [ 11.772005] 8021q: 802.1Q VLAN Support v1.81621server # [ 11.753873] dhcpcd[643]: no valid interfaces found1622server # [ 11.761650] dhcpcd[643]: libudev: received NULL device1623server # [ 11.762445] dhcpcd[643]: libudev: received NULL device1624builder # connecting to host...1625server # [ 11.842025] systemd[1]: Finished Permit User Sessions.1626builder # [ 11.863884] cfg80211: Loading compiled-in X.509 certificates for regulatory database1627server # [ 11.853020] systemd[1]: Started Getty on tty1.1628server # [ 11.859283] systemd[1]: Reached target Login Prompts.1629builder # [ 11.873787] (udev-worker)[642]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.[ 11.900227] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1630builder # [ 11.900710] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1631builder # [ 11.905551] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21632builder # [ 11.905875] cfg80211: failed to load regulatory.db1633builder # 1634builder # [ 11.888898] (udev-worker)[642]: Network interface NamePolicy= disabled on kernel command line.1635builder # [ 11.892974] (udev-worker)[636]: Network interface NamePolicy= disabled on kernel command line.1636builder # [ 11.925629] systemd-vconsole-setup[633]: Configuration of first virtual console was skipped, ignoring remaining ones.1637builder # [ 11.931888] systemd[1]: Finished Virtual Console Setup.1638server # [ 12.002680] mock-oidc-server[658]: Mock OIDC Server running1639server # [ 12.003551] mock-oidc-server[658]: OIDC Address: 127.0.0.1:80801640server # [ 12.014389] mock-oidc-server[658]: Issue Address: 127.0.0.1:80811641server # [ 12.017196] mock-oidc-server[658]: Issuer: http://127.0.0.1:8080/oidc1642server # [ 12.023116] mock-oidc-server[658]: JWKS: http://127.0.0.1:8080/oidc/.well-known/jwks.json1643server # [ 12.029953] mock-oidc-server[658]: Discovery: http://127.0.0.1:8080/oidc/.well-known/openid-configuration1644server # [ 12.031267] mock-oidc-server[658]: Issue tokens: http://127.0.0.1:8081/issue?sub=...1645builder # [ 12.050816] systemd[1]: Condition check resulted in Virtio network device being skipped.1646builder # [ 12.057021] systemd[1]: Starting Address configuration of eth1...1647builder # [ 12.166360] 8021q: adding VLAN 0 to HW filter on device eth01648builder # [ 12.150028] dhcpcd[614]: eth0: waiting for carrier1649builder # [ 12.150762] dhcpcd[614]: eth0: carrier acquired1650builder # [ 12.184271] 8021q: adding VLAN 0 to HW filter on device eth11651builder # [ 12.168251] dhcpcd[614]: DUID 00:01:00:01:31:e1:85:38:52:54:00:12:34:561652builder # [ 12.171563] dhcpcd[614]: eth0: IAID 00:12:34:561653builder # [ 12.173133] dhcpcd[614]: eth0: adding address fe80::5054:ff:fe12:34561654builder # [ 12.182410] systemd-logind[507]: Watching system buttons on /dev/input/event0 (gpio-keys)1655builder # [ 12.188265] network-addresses-eth1-start[662]: adding address 192.168.1.1/24... done1656builder # [ 12.203888] network-addresses-eth1-start[662]: adding address 2001:db8:1::1/64... done1657builder # [ 12.224451] systemd[1]: Finished Address configuration of eth1.1658builder # [ 12.305296] mousedev: PS/2 mouse device common for all mice1659server # [ 12.301770] nginx-pre-start[689]: nginx: the configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf syntax is ok1660server # [ 12.307764] nginx-pre-start[689]: nginx: configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf test is successful1661server # [ 12.318871] systemd[1]: Started Nginx Web Server.1662server # [ 12.323283] postgresql-pre-start[692]: The files belonging to this database system will be owned by user "postgres".1663server # [ 12.329429] postgresql-pre-start[692]: This user must also own the server process.1664server # [ 12.335609] postgresql-pre-start[692]: The database cluster will be initialized with locale "en_US.UTF-8".1665server # [ 12.341648] postgresql-pre-start[692]: The default database encoding has accordingly been set to "UTF8".1666server # [ 12.342899] postgresql-pre-start[692]: The default text search configuration will be set to "english".1667server # [ 12.352571] postgresql-pre-start[692]: Data page checksums are disabled.1668server # [ 12.357020] postgresql-pre-start[692]: fixing permissions on existing directory /var/lib/postgresql/17 ... ok1669server # [ 12.363824] postgresql-pre-start[692]: creating subdirectories ... ok1670server # [ 12.371463] postgresql-pre-start[692]: selecting dynamic shared memory implementation ... posix1671builder # [ 12.404971] systemd-logind[507]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1672server # [ 12.412672] (udev-worker)[694]: Network interface NamePolicy= disabled on kernel command line.1673server # [ 12.420465] (udev-worker)[696]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1674server # [ 12.422609] (udev-worker)[696]: Network interface NamePolicy= disabled on kernel command line.1675server # [ 12.573553] postgresql-pre-start[692]: selecting default "max_connections" ... 1001676builder # [ 12.720980] dhcpcd[614]: eth0: soliciting a DHCP lease1677server # [ 12.720733] systemd-logind[517]: Watching system buttons on /dev/input/event0 (gpio-keys)1678builder # [ 12.728585] dhcpcd[614]: eth0: offered 10.0.2.15 from 10.0.2.21679server # [ 12.729332] postgresql-pre-start[692]: selecting default "shared_buffers" ... 128MB1680builder # [ 12.736220] dhcpcd[614]: eth0: probing address 10.0.2.15/241681server # [ 12.786097] systemd[1]: Condition check resulted in Virtio network device being skipped.1682server # [ 12.792178] systemd[1]: Starting Address configuration of eth1...1683server # [ 12.913547] 8021q: adding VLAN 0 to HW filter on device eth01684server # [ 12.899588] dhcpcd[643]: eth0: waiting for carrier1685server # [ 12.902455] dhcpcd[643]: eth0: carrier acquired1686server # [ 12.922460] dhcpcd[643]: DUID 00:01:00:01:31:e1:85:39:52:54:00:12:34:561687server # [ 12.947015] 8021q: adding VLAN 0 to HW filter on device eth11688server # [ 12.926153] dhcpcd[643]: eth0: IAID 00:12:34:561689server # [ 12.932588] dhcpcd[643]: eth0: adding address fe80::5054:ff:fe12:34561690server # [ 12.959976] network-addresses-eth1-start[732]: adding address 192.168.1.2/24... done1691server # [ 12.977637] network-addresses-eth1-start[732]: adding address 2001:db8:1::2/64... done1692server # [ 13.005230] systemd[1]: Finished Address configuration of eth1.1693server # [ 13.043498] rustfs[661]: {"timestamp":"2026-07-08T22:01:29.6875085Z","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)"}1694server # [ 13.189428] mousedev: PS/2 mouse device common for all mice1695server # [ 13.194849] dhcpcd[643]: eth0: soliciting a DHCP lease1696server # [ 13.200534] dhcpcd[643]: eth0: offered 10.0.2.15 from 10.0.2.21697server # [ 13.208224] dhcpcd[643]: eth0: probing address 10.0.2.15/241698server # [ 13.327191] systemd-logind[517]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1699builder # [ 13.476065] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1700builder # [ 13.492181] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1701builder # [ 13.493289] systemd[1]: Stopped Virtual Console Setup.1702builder # [ 13.493989] systemd[1]: Stopping Virtual Console Setup...1703builder # [ 13.497929] systemd[1]: Starting Virtual Console Setup...1704builder # [ 13.523526] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1705builder # [ 13.528153] systemd[1]: Stopped Virtual Console Setup.1706builder # [ 13.530346] systemd[1]: Starting Virtual Console Setup...1707builder # [ 13.559130] systemd-logind[507]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1708builder # [ 13.834981] systemd-vconsole-setup[686]: Configuration of first virtual console was skipped, ignoring remaining ones.1709builder # [ 13.838915] systemd[1]: Finished Virtual Console Setup.1710builder # [ 14.059293] dhcpcd[614]: eth0: soliciting an IPv6 router1711builder # [ 14.062801] dhcpcd[614]: eth0: Router Advertisement from fe80::21712builder # [ 14.065533] dhcpcd[614]: eth0: adding address fec0::5054:ff:fe12:3456/641713builder # [ 14.068360] dhcpcd[614]: eth0: adding route to fec0::/641714builder # [ 14.070587] dhcpcd[614]: eth0: adding default route via fe80::21715server # [ 14.398991] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31716server # [ 14.878987] systemd[1]: Starting Virtual Console Setup...1717server # [ 14.909849] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1718server # [ 14.912406] systemd[1]: Stopped Virtual Console Setup.1719server # [ 14.917160] systemd[1]: Starting Virtual Console Setup...1720server # [ 15.055812] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1721server # [ 15.143316] systemd-logind[517]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1722server # [ 15.148977] dhcpcd[643]: eth0: soliciting an IPv6 router1723server # [ 15.150837] dhcpcd[643]: eth0: Router Advertisement from fe80::21724server # [ 15.152072] dhcpcd[643]: eth0: adding address fec0::5054:ff:fe12:3456/641725server # [ 15.153184] dhcpcd[643]: eth0: adding route to fec0::/641726server # [ 15.154194] dhcpcd[643]: eth0: adding default route via fe80::21727server # [ 15.406908] systemd-vconsole-setup[766]: Configuration of first virtual console was skipped, ignoring remaining ones.1728server # [ 15.412325] systemd[1]: Finished Virtual Console Setup.1729server # [ 15.442330] postgresql-pre-start[692]: selecting default time zone ... UTC1730server # [ 15.446025] postgresql-pre-start[692]: creating configuration files ... ok1731server # [ 15.696129] postgresql-pre-start[692]: running bootstrap script ... ok1732server # [ 16.256865] postgresql-pre-start[692]: performing post-bootstrap initialization ... ok1733server # [ 16.420224] postgresql-pre-start[692]: syncing data to disk ... ok1734server # [ 16.421338] postgresql-pre-start[692]: initdb: warning: enabling "trust" authentication for local connections1735server # [ 16.423776] 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.1736server # [ 16.426347] postgresql-pre-start[692]: Success. You can now start the database server using:1737server # [ 16.427558] postgresql-pre-start[692]: pg_ctl -D /var/lib/postgresql/17 -l logfile start1738server # [ 16.538645] postgres[794]: [794] LOG: starting PostgreSQL 17.10 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit1739server # [ 16.542206] postgres[794]: [794] LOG: listening on IPv6 address "::1", port 54321740server # [ 16.543416] postgres[794]: [794] LOG: listening on IPv4 address "127.0.0.1", port 54321741server # [ 16.546329] postgres[794]: [794] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"1742server # [ 16.556666] postgres[800]: [800] LOG: database system was shut down at 2026-07-08 22:01:32 GMT1743server # [ 16.565355] postgres[794]: [794] LOG: database system is ready to accept connections1744server # [ 16.571039] systemd[1]: Started PostgreSQL Server.1745server # [ 16.575468] systemd[1]: Starting PostgreSQL Setup Scripts...1746server # [ 16.762639] postgresql-setup-start[811]: CREATE DATABASE1747server # [ 16.811885] postgresql-setup-start[816]: CREATE ROLE1748server # [ 16.833652] postgresql-setup-start[818]: ALTER DATABASE1749server # [ 16.840251] systemd[1]: Finished PostgreSQL Setup Scripts.1750server # [ 16.841866] systemd[1]: Reached target PostgreSQL.1751server: (finished: waiting for unit postgresql.service, in 17.75 seconds)1752server: waiting for unit rustfs.service1753server: (finished: waiting for unit rustfs.service, in 0.09 seconds)1754server: waiting for unit rustfs-setup.service1755server # [ 17.919687] dhcpcd[643]: eth0: leased 10.0.2.15 for 86400 seconds1756server # [ 17.924078] dhcpcd[643]: eth0: adding route to 10.0.2.0/241757server # [ 17.927223] dhcpcd[643]: eth0: adding default route via 10.0.2.21758server # [ 18.089834] systemd[1]: Started DHCP Client.1759builder # [ 18.107426] dhcpcd[614]: eth0: leased 10.0.2.15 for 86400 seconds1760builder # [ 18.111080] dhcpcd[614]: eth0: adding route to 10.0.2.0/241761builder # [ 18.114440] dhcpcd[614]: eth0: adding default route via 10.0.2.21762builder # [ 18.267362] systemd[1]: Started DHCP Client.1763builder # [ 18.269581] systemd[1]: Reached target Multi-User System.1764builder # [ 18.270516] systemd[1]: Startup finished in 926ms (kernel) + 3.903s (initrd) + 13.439s (userspace) = 18.269s.1765server # [ 27.315887] rustfs-setup-start[923]: mb s3://niks3-test1766server # [ 27.321096] systemd[1]: Finished Setup RustFS bucket.1767server # [ 27.326695] systemd[1]: Starting niks3 server...1768server # [ 27.497736] postgres[935]: [935] ERROR: relation "goose_db_version" does not exist at character 361769server # [ 27.499014] postgres[935]: [935] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1770server # [ 27.530993] niks3-server[930]: 2026/07/08 22:01:44 OK 20241026095416_initial_model.sql (18.77ms)1771server # [ 27.544421] niks3-server[930]: 2026/07/08 22:01:44 OK 20251210153512_drop_unused_gin_index.sql (3.39ms)1772server # [ 27.547549] niks3-server[930]: 2026/07/08 22:01:44 OK 20251218171726_add_pins.sql (3.65ms)1773server # [ 27.549463] niks3-server[930]: 2026/07/08 22:01:44 OK 20260628120000_add_object_size_and_stats.sql (4.4ms)1774server # [ 27.551159] niks3-server[930]: 2026/07/08 22:01:44 goose: successfully migrated database to version: 202606281200001775server # [ 27.553051] niks3-server[930]: 2026/07/08 22:01:44 OK 1_commit_pending_closure.sql (4.98ms)1776server # [ 27.554527] niks3-server[930]: 2026/07/08 22:01:44 OK 2_object_stats_trigger.sql (3.68ms)1777server # [ 27.556540] niks3-server[930]: 2026/07/08 22:01:44 goose: up to current file version: 21778server # [ 27.572692] niks3-server[930]: 2026/07/08 22:01:44 INFO OIDC provider initialized name=test1779server # [ 27.573994] niks3-server[930]: 2026/07/08 22:01:44 INFO OIDC authentication enabled config=/nix/store/2za6kyy80mq2xh1w4ydfs7gg8psbv5g3-niks3-oidc.json1780server # [ 27.576568] niks3-server[930]: 2026/07/08 22:01:44 INFO Loaded signing key name=niks3-test-1 path=/nix/store/1cz670ydszbfkf0naknmhg579xvlcyr7-niks3-signing-key1781server # [ 27.601989] rustfs[661]: {"timestamp":"2026-07-08T22:01:44.24973456Z","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)"}1782server # [ 27.608647] niks3-server[930]: 2026/07/08 22:01:44 INFO Created nix-cache-info in bucket bucket=niks3-test1783server # [ 27.610786] niks3-server[930]: 2026/07/08 22:01:44 INFO Using socket-activated listener address=0.0.0.0:57511784server # [ 27.614640] niks3-server[930]: 2026/07/08 22:01:44 INFO systemd watchdog enabled interval=15s1785server # [ 27.615767] niks3-server[930]: 2026/07/08 22:01:44 INFO Starting HTTP server address=0.0.0.0:57511786server # [ 27.617156] systemd[1]: Started niks3 server.1787server # [ 27.617781] systemd[1]: Reached target Multi-User System.1788server # [ 27.618525] systemd[1]: Startup finished in 922ms (kernel) + 4.957s (initrd) + 21.733s (userspace) = 27.614s.1789server: (finished: waiting for unit rustfs-setup.service, in 10.86 seconds)1790server: waiting for unit mock-oidc.service1791server: (finished: waiting for unit mock-oidc.service, in 0.10 seconds)1792server: waiting for unit niks3.service1793server: (finished: waiting for unit niks3.service, in 0.08 seconds)1794server: waiting for TCP port 5751 on localhost1795server # Connection to localhost (127.0.0.1) 5751 port [tcp/*] succeeded!1796server: (finished: waiting for TCP port 5751 on localhost, in 0.06 seconds)1797server: waiting for TCP port 8080 on localhost1798server # Connection to localhost (127.0.0.1) 8080 port [tcp/http-alt] succeeded!1799server: (finished: waiting for TCP port 8080 on localhost, in 0.04 seconds)1800server: waiting for TCP port 9000 on localhost1801server # Connection to localhost (127.0.0.1) 9000 port [tcp/cslistener] succeeded!1802server: (finished: waiting for TCP port 9000 on localhost, in 0.03 seconds)1803server: must succeed: mkdir -p /tmp/test-config1804server: (finished: must succeed: mkdir -p /tmp/test-config, in 0.03 seconds)1805server: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token1806server: (finished: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token, in 0.01 seconds)1807server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31808server # [ 28.904134] systemd[1]: Created slice Slice /system/nix-daemon.1809server # [ 28.908889] systemd[1]: Started Nix Daemon instance (PID 980/UID 0).1810server # [ 28.994157] nix-daemon[982]: remote pid 980 is unknown user (trusted)1811server # [ 29.015168] systemd[1]: nix-daemon@0-1-980_981-0.service: Deactivated successfully.1812server # [ 29.030351] niks3-server[930]: 2026/07/08 22:01:45 INFO Received uploads request method=POST path=/api/pending_closures1813server # time=2026-07-08T22:01:45.695Z level=INFO msg="Uploading 5 paths to server (0 already cached)"1814server # time=2026-07-08T22:01:45.697Z level=INFO msg="Uploading 020cvdgp5va6j1mdz75s2nzfz25k37v2-libunistring-1.4.2 (2.0MB)"1815server # time=2026-07-08T22:01:45.699Z level=INFO msg="Uploading qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3 (287.5KB)"1816server # time=2026-07-08T22:01:45.703Z level=INFO msg="Uploading jp8avbmpfcdnm0axwrzyk072nmq9cr0d-glibc-2.42-67 (44.4MB)"1817server # time=2026-07-08T22:01:45.705Z level=INFO msg="Uploading fqhxni8jcvyf5id4rvg9x2y00qx1963d-libidn2-2.3.8 (366.1KB)"1818server # time=2026-07-08T22:01:45.705Z level=INFO msg="Uploading wp59zwnmv6h2glrrb9rd7siprz1mxn6r-xgcc-15.2.0-libgcc (150.1KB)"1819server # [ 30.758330] niks3-server[930]: 2026/07/08 22:01:47 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1820server # [ 30.774090] niks3-server[930]: 2026/07/08 22:01:47 INFO Completed multipart upload object_key=nar/0n9jhh8wlbk6hqhzsklzl8vbv6xab1d7yi91hr9z948fzw5s80jd.nar.zst upload_id=ODZhMTY3NDUtYjU4Zi00YzFjLWJmNWMtMzBlM2IxMWUzMWRmLmMzYzMyNzQ4LWUyZTktNDI0Zi04YmM4LWNjZDM3N2M5ZWIzZXgxNzgzNTQ4MTA1NjkxODQ3NzYw parts=11821server # time=2026-07-08T22:01:47.430Z level=INFO msg="Uploading 5 narinfos"1822server # [ 30.783993] niks3-server[930]: 2026/07/08 22:01:47 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1823server # [ 30.788204] niks3-server[930]: 2026/07/08 22:01:47 INFO Signed narinfos id=1 count=51824server # [ 30.797420] niks3-server[930]: 2026/07/08 22:01:47 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1825server # time=2026-07-08T22:01:47.452Z level=INFO msg="Upload complete. (1.965s)"1826server # [ 30.805046] niks3-server[930]: 2026/07/08 22:01:47 INFO Completed upload id=11827server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 2.12 seconds)1828server: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token1829server: (finished: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token, in 0.02 seconds)1830server: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31831server # [ 30.977282] systemd[1]: Started Nix Daemon instance (PID 1006/UID 0).1832server # [ 31.059281] nix-daemon[1008]: remote pid 1006 is unknown user (trusted)1833server # [ 31.075971] systemd[1]: nix-daemon@1-2-1006_1007-0.service: Deactivated successfully.1834server # [ 31.084523] niks3-server[930]: 2026/07/08 22:01:47 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]1835server # time=2026-07-08T22:01:47.735Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1836server: (finished: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.26 seconds)1837server: waiting for unit nginx.service1838server: (finished: waiting for unit nginx.service, in 0.06 seconds)1839server: waiting for TCP port 443 on localhost1840server # Connection to localhost (::1) 443 port [tcp/https] succeeded!1841server: (finished: waiting for TCP port 443 on localhost, in 0.03 seconds)1842server: must succeed: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.31843server # time=2026-07-08T22:01:47.919Z 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.pem1844server # [ 31.338856] systemd[1]: Started Nix Daemon instance (PID 1035/UID 0).1845server # [ 31.416768] nix-daemon[1037]: remote pid 1035 is unknown user (trusted)1846server # [ 31.436495] systemd[1]: nix-daemon@2-3-1035_1036-0.service: Deactivated successfully.1847server # [ 31.453991] niks3-server[930]: 2026/07/08 22:01:48 INFO Received uploads request method=POST path=/api/pending_closures1848server # time=2026-07-08T22:01:48.106Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1849server # [ 31.460251] niks3-server[930]: 2026/07/08 22:01:48 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1850server # [ 31.463444] niks3-server[930]: 2026/07/08 22:01:48 INFO Completed upload id=21851server # time=2026-07-08T22:01:48.112Z level=INFO msg="Upload complete. (188ms)"1852server: (finished: must succeed: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.28 seconds)1853server: must fail: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.31854server # time=2026-07-08T22:01:48.136Z 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)"1855server: (finished: must fail: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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)1856server: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.31857server # time=2026-07-08T22:01:48.219Z level=INFO msg="Configuring client TLS" cert="" key="" ca=/etc/niks3-test-certs/ca.pem1858server # [ 31.632792] systemd[1]: Started Nix Daemon instance (PID 1061/UID 0).1859server # [ 31.714825] nix-daemon[1063]: remote pid 1061 is unknown user (trusted)1860server # [ 31.738475] systemd[1]: nix-daemon@3-4-1061_1062-0.service: Deactivated successfully.1861server # [ 31.752900] niks3-server[930]: 2026/07/08 22:01:48 INFO Received uploads request method=POST path=/api/pending_closures1862server # time=2026-07-08T22:01:48.404Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1863server # [ 31.759383] niks3-server[930]: 2026/07/08 22:01:48 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete1864server # time=2026-07-08T22:01:48.410Z level=INFO msg="Upload complete. (189ms)"1865server # [ 31.764271] niks3-server[930]: 2026/07/08 22:01:48 INFO Completed upload id=31866server: (finished: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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)1867server: 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'1868server # -----1869server: (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.04 seconds)1870server: 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.pem1871server # Certificate request self-signature ok1872server # subject=CN=other client1873server: (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)1874server: must fail: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.31875server # time=2026-07-08T22:01:48.593Z 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.pem1876server # [ 32.008347] systemd[1]: Started Nix Daemon instance (PID 1091/UID 0).1877server # [ 32.089554] nix-daemon[1093]: remote pid 1091 is unknown user (trusted)1878server # [ 32.106953] systemd[1]: nix-daemon@4-5-1091_1092-0.service: Deactivated successfully.1879server # [ 32.116337] niks3-server[930]: 2026/07/08 22:01:48 WARN mTLS auth: subject not in bound subjects subject="CN=other client"1880server # time=2026-07-08T22:01:48.766Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1881server: (finished: must fail: /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-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.26 seconds)1882server: must succeed: mkdir -p /tmp/test-store1883server: (finished: must succeed: mkdir -p /tmp/test-store, in 0.02 seconds)1884server: must succeed: 1885 export AWS_ACCESS_KEY_ID=rustfsadmin1886export AWS_SECRET_ACCESS_KEY=rustfsadmin1887 nix copy --from 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.318881889server: (finished: must succeed: 1890 export AWS_ACCESS_KEY_ID=rustfsadmin1891export AWS_SECRET_ACCESS_KEY=rustfsadmin1892 nix copy --from 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31893, in 0.74 seconds)1894server: must succeed: 1895cat > /tmp/test-drv.nix << 'EOF'1896derivation {1897 name = "test-build-log";1898 system = builtins.currentSystem;1899 builder = "/bin/sh";1900 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1901}1902EOF19031904server: (finished: must succeed: 1905cat > /tmp/test-drv.nix << 'EOF'1906derivation {1907 name = "test-build-log";1908 system = builtins.currentSystem;1909 builder = "/bin/sh";1910 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1911}1912EOF1913, in 0.03 seconds)1914server: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix1915server # warning: Nix search path entry '/nix/var/nix/profiles/per-user/root/channels' does not exist, ignoring1916server # [ 33.011501] systemd[1]: Started Nix Daemon instance (PID 1135/UID 0).1917server # [ 33.092289] nix-daemon[1139]: remote pid 1135 is unknown user (trusted)1918server # this derivation will be built:1919server # /nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv1920server # building '/nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv'...1921server # test-build-log> test build log output1922server: (finished: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix, in 0.32 seconds)1923server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1924server # [ 33.245557] systemd[1]: nix-daemon@5-6-1135_1136-0.service: Deactivated successfully.1925server # [ 33.393704] systemd[1]: Started Nix Daemon instance (PID 1166/UID 0).1926server # [ 33.475845] nix-daemon[1168]: remote pid 1166 is unknown user (trusted)1927server # [ 33.493001] systemd[1]: nix-daemon@6-7-1166_1167-0.service: Deactivated successfully.1928server # [ 33.502056] niks3-server[930]: 2026/07/08 22:01:50 INFO Received uploads request method=POST path=/api/pending_closures1929server # time=2026-07-08T22:01:50.154Z level=INFO msg="Uploading 1 paths to server (0 already cached)"1930server # time=2026-07-08T22:01:50.155Z level=INFO msg="Uploading z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log (128B)"1931server # time=2026-07-08T22:01:50.167Z level=INFO msg="Uploading 1 narinfos"1932server # [ 33.520148] niks3-server[930]: 2026/07/08 22:01:50 INFO Received sign narinfos request method=POST path=/api/pending_closures/4/sign1933server # [ 33.521759] niks3-server[930]: 2026/07/08 22:01:50 INFO Signed narinfos id=4 count=11934server # [ 33.525860] niks3-server[930]: 2026/07/08 22:01:50 INFO Received complete upload request method=POST path=/api/pending_closures/4/complete1935server # time=2026-07-08T22:01:50.176Z level=INFO msg="Upload complete. (198ms)"1936server # [ 33.529227] niks3-server[930]: 2026/07/08 22:01:50 INFO Completed upload id=41937server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/qlvr9s99yzzmygirzyfzr0ds4jdc0r6w-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log, in 0.29 seconds)1938server: must succeed: 1939 export AWS_ACCESS_KEY_ID=rustfsadmin1940export AWS_SECRET_ACCESS_KEY=rustfsadmin1941 nix log --store 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log19421943server: (finished: must succeed: 1944 export AWS_ACCESS_KEY_ID=rustfsadmin1945export AWS_SECRET_ACCESS_KEY=rustfsadmin1946 nix log --store 's3://niks3-test?endpoint=http://server:9000®ion=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1947, in 0.19 seconds)1948server: must succeed: readlink /etc/niks3-test/symlink-wrapper1949server: (finished: must succeed: readlink /etc/niks3-test/symlink-wrapper, in 0.03 seconds)1950server: must succeed: readlink /etc/static/niks3-test/symlink-wrapper1951server: (finished: must succeed: readlink /etc/static/niks3-test/symlink-wrapper, in 0.03 seconds)1952server # [ 33.971869] systemd[1]: Started Nix Daemon instance (PID 1205/UID 0).1953server # [ 34.051727] nix-daemon[1207]: remote pid 1205 is unknown user (trusted)1954server # [ 34.068399] systemd[1]: nix-daemon@7-8-1205_1206-0.service: Deactivated successfully.1955server # [ 34.162364] systemd[1]: Started Nix Daemon instance (PID 1216/UID 0).1956server # [ 34.243231] nix-daemon[1218]: remote pid 1216 is unknown user (trusted)1957server # [ 34.258677] systemd[1]: nix-daemon@8-9-1216_1217-0.service: Deactivated successfully.1958server: must succeed: test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper1959server: output: 1960!!! Traceback (most recent call last):1961!!! File "<string>", line 110, in <module>1962!!! server.succeed(f"test -L {symlink_wrapper}")1963!!! 1964!!! RequestedAssertionFailed: command `test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper` failed (exit code 1)1965cleanup1966kill QemuMachine (pid 14)1967builder # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)1968kill QemuMachine (pid 15)1969server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)1970(finished: cleanup, in 0.48 seconds)1971additionally exposed symbols:1972 builder, server,1973 vlan1,1974 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_ssh1975Hello store path: /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31976Test output path: /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1977Symlink wrapper store path: /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper1978/etc/niks3-test/:1979total 81980drwxr-xr-x 2 root root 4096 Jul 8 22:01 .1981drwxr-xr-x 23 root root 4096 Jul 8 22:01 ..1982lrwxrwxrwx 1 root root 38 Jul 8 22:01 symlink-wrapper -> /etc/static/niks3-test/symlink-wrapper19831984/etc/static/niks3-test/:1985total 101986dr-xr-xr-x 2 root root 3 Jan 1 1970 .1987dr-xr-xr-x 19 root root 59 Jan 1 1970 ..1988lrwxrwxrwx 1 root root 59 Jan 1 1970 symlink-wrapper -> /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper19891990lrwxrwxrwx 1 root root 59 Jan 1 1970 /etc/static/niks3-test/symlink-wrapper -> /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper1991-r-xr-xr-x 1 root root 41 Jan 1 1970 /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper19921993/nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper19941995/nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper19961997unknown-deriver19981999pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper2000