nixbot

builds

failed vm-test-run-nixos-test-niks3 aarch64-linux.nixos-test-niks3 · build #77 · 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 vm10server # Disk image does not exist, creating the virtualisation disk image...11server: QEMU running (pid 15)12server # Formatting '/build/vm-state-server/tmp.PUY71vaRdR', fmt=raw size=107374182413builder # Disk image does not exist, creating the virtualisation disk image...14builder: QEMU running (pid 14)15builder # Formatting '/build/vm-state-builder/tmp.VpiuUc085S', fmt=raw size=107374182416server # mke2fs 1.47.4 (6-Mar-2025)17builder # mke2fs 1.47.4 (6-Mar-2025)18(finished: start all VMs, in 0.50 seconds)19builder # Discarding device blocks: 0/262144 done20server: waiting for unit postgresql.service21builder # Creating filesystem with 262144 4k blocks and 65536 inodes22server: waiting for the VM to finish booting23builder # Filesystem UUID: 20685400-4068-4548-913e-8819e6a3395d24server # Discarding device blocks: 0/262144 done25builder # Superblock backups stored on blocks:26server # Creating filesystem with 262144 4k blocks and 65536 inodes27builder # 32768, 98304, 163840, 22937628server # Filesystem UUID: 22f7b375-794b-469d-b19f-0439c88ba76f29builder # 30server # Superblock backups stored on blocks:31builder # Allocating group tables: 0/8 done32server # 32768, 98304, 163840, 22937633builder # Writing inode tables: 0/8 done34server # 35builder # Creating journal (8192 blocks): done36server # Allocating group tables: 0/8 done37builder # Writing superblocks and filesystem accounting information: 0/8 done38server # Writing inode tables: 0/8 done39builder # 40server # Creating journal (8192 blocks): done41builder # Virtualisation disk image created.42server # Writing superblocks and filesystem accounting information: 0/8 done43server # 44server # Virtualisation disk image created.45server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]46server # [ 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 202647server # [ 0.000000] KASLR enabled48server # [ 0.000000] random: crng init done49server # [ 0.000000] Machine model: linux,dummy-virt50server # [ 0.000000] efi: UEFI not found.51server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT52server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]53server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]54server # [ 0.000000] Zone ranges:55server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]56server # [ 0.000000] DMA32 empty57server # [ 0.000000] Normal empty58server # [ 0.000000] Device empty59server # [ 0.000000] Movable zone start for each node60server # [ 0.000000] Early memory node ranges61server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]62server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]63server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc0000064server # [ 0.000000] psci: probing for conduit method from DT.65server # [ 0.000000] psci: PSCIv1.3 detected in firmware.66server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs67server # [ 0.000000] psci: Trusted OS migration not required68server # [ 0.000000] psci: SMC Calling Convention v1.169server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)70server # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u31129671server # [ 0.000000] Detected PIPT I-cache on CPU072server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)73server # [ 0.000000] CPU features: detected: GICv3 CPU interface74server # [ 0.000000] CPU features: detected: Spectre-v475server # [ 0.000000] CPU features: detected: Spectre-BHB76builder # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]77server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_3878server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_2379server # [ 0.000000] alternatives: applying boot alternatives80builder # [ 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 202681builder # [ 0.000000] KASLR enabled82builder # [ 0.000000] random: crng init done83builder # [ 0.000000] Machine model: linux,dummy-virt84builder # [ 0.000000] efi: UEFI not found.85builder # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT86builder # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]87server # [ 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/3hc881fqznlhbpznnlw69v3q462r4f67-nixos-system-server-test/init regInfo=/nix/store/3p9jmdsg7scpjlsl2yvzf94pap79v5xi-closure-info/registration console=ttyAMA0,115200n8 console=tty088builder # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]89builder # [ 0.000000] Zone ranges:90builder # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]91builder # [ 0.000000] DMA32 empty92builder # [ 0.000000] Normal empty93server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/3p9jmdsg7scpjlsl2yvzf94pap79v5xi-closure-info/registration", will be passed to user space.94server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes95builder # [ 0.000000] Device empty96builder # [ 0.000000] Movable zone start for each node97builder # [ 0.000000] Early memory node ranges98builder # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]99server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)100builder # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]101server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)102builder # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000103server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB104builder # [ 0.000000] psci: probing for conduit method from DT.105server # [ 0.000000] software IO TLB: area num 1.106builder # [ 0.000000] psci: PSCIv1.3 detected in firmware.107server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)108builder # [ 0.000000] psci: Using standard PSCI v0.2 function IDs109server # [ 0.000000] Fallback order for Node 0: 0110builder # [ 0.000000] psci: Trusted OS migration not required111builder # [ 0.000000] psci: SMC Calling Convention v1.1112server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144113server # [ 0.000000] Policy zone: DMA114builder # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)115server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off116builder # [ 0.000000] percpu: Embedded 76 pages/cpu s186392 r8192 d116712 u311296117server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1118builder # [ 0.000000] Detected PIPT I-cache on CPU0119server # [ 0.000000] allocated 2097152 bytes of page_ext120builder # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)121server # [ 0.000000] ftrace: allocating 74702 entries in 292 pages122builder # [ 0.000000] CPU features: detected: GICv3 CPU interface123server # [ 0.000000] ftrace: allocated 292 pages with 3 groups124builder # [ 0.000000] CPU features: detected: Spectre-v4125server # [ 0.000000] rcu: Hierarchical RCU implementation.126builder # [ 0.000000] CPU features: detected: Spectre-BHB127server # [ 0.000000] rcu: RCU event tracing is enabled.128builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38129server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.130server # [ 0.000000] Trampoline variant of Tasks RCU enabled.131builder # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23132server # [ 0.000000] Rude variant of Tasks RCU enabled.133builder # [ 0.000000] alternatives: applying boot alternatives134server # [ 0.000000] Tracing variant of Tasks RCU enabled.135server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.136server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1137server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.138builder # [ 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/ixgzzz7ydqh9j9fm8pp3xvl3frxbc9yx-nixos-system-builder-test/init regInfo=/nix/store/4viiy77yw5ldzx3i3c6xwf5xlagnbxmy-closure-info/registration console=ttyAMA0,115200n8 console=tty0139server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.140server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.141server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0142server # [ 0.000000] GICv3: 256 SPIs implemented143builder # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/4viiy77yw5ldzx3i3c6xwf5xlagnbxmy-closure-info/registration", will be passed to user space.144server # [ 0.000000] GICv3: 0 Extended SPIs implemented145server # [ 0.000000] Root IRQ handler: gic_handle_irq146builder # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes147server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI148server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0149builder # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)150server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000151builder # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)152server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]153builder # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB154builder # [ 0.000000] software IO TLB: area num 1.155server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)156builder # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)157server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)158builder # [ 0.000000] Fallback order for Node 0: 0159server # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000160builder # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144161builder # [ 0.000000] Policy zone: DMA162server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000163builder # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off164server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.165builder # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1166server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).167builder # [ 0.000000] allocated 2097152 bytes of page_ext168builder # [ 0.000000] ftrace: allocating 74702 entries in 292 pages169server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns170builder # [ 0.000000] ftrace: allocated 292 pages with 3 groups171builder # [ 0.000000] rcu: Hierarchical RCU implementation.172server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns173builder # [ 0.000000] rcu: RCU event tracing is enabled.174server # [ 0.000033] arm-pv: using stolen time PV175builder # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.176server # [ 0.000447] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)177builder # [ 0.000000] Trampoline variant of Tasks RCU enabled.178server # [ 0.000556] Console: colour dummy device 80x25179builder # [ 0.000000] Rude variant of Tasks RCU enabled.180server # [ 0.000564] printk: legacy console [tty0] enabled181builder # [ 0.000000] Tracing variant of Tasks RCU enabled.182builder # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.183server # [ 0.000756] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)184server # [ 0.000763] pid_max: default: 32768 minimum: 301185builder # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1186server # [ 0.000860] LSM: initializing lsm=capability,landlock,yama,bpf,ima187builder # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.188server # [ 0.001054] landlock: Up and running.189server # [ 0.001057] Yama: becoming mindful.190server # [ 0.001549] LSM support for eBPF active191builder # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.192server # [ 0.001657] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)193builder # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.194server # [ 0.001682] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)195builder # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0196builder # [ 0.000000] GICv3: 256 SPIs implemented197server # [ 0.002727] cacheinfo: Unable to detect cache hierarchy for CPU 0198builder # [ 0.000000] GICv3: 0 Extended SPIs implemented199server # [ 0.003450] rcu: Hierarchical SRCU implementation.200builder # [ 0.000000] Root IRQ handler: gic_handle_irq201server # [ 0.003454] rcu: Max phase no-delay instances is 1000.202builder # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI203server # [ 0.004671] fsl-mc MSI: its@8080000 domain created204builder # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0205server # [ 0.004762] EFI services will not be available.206server # [ 0.004851] smp: Bringing up secondary CPUs ...207builder # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000208server # [ 0.004859] smp: Brought up 1 node, 1 CPU209builder # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]210server # [ 0.004862] SMP: Total of 1 processors activated.211server # [ 0.004865] CPU: All CPU(s) started at EL1212builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)213server # [ 0.004875] CPU features: detected: Branch Target Identification214server # [ 0.004880] CPU features: detected: ARMv8.4 Translation Table Level215builder # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)216builder # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000217server # [ 0.004886] CPU features: detected: Instruction cache invalidation not required for I/D coherence218builder # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000219server # [ 0.004889] CPU features: detected: Data cache clean to the PoU not required for I/D coherence220builder # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.221server # [ 0.004893] CPU features: detected: Common not Private translations222builder # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).223server # [ 0.004896] CPU features: detected: CRC32 instructions224server # [ 0.004899] CPU features: detected: Data cache clean to Point of Deep Persistence225builder # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns226server # [ 0.004902] CPU features: detected: Data cache clean to Point of Persistence227builder # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns228server # [ 0.004906] CPU features: detected: Data independent timing control (DIT)229builder # [ 0.000030] arm-pv: using stolen time PV230server # [ 0.004909] CPU features: detected: E0PD231server # [ 0.004911] CPU features: detected: Enhanced Counter Virtualization232builder # [ 0.000401] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)233builder # [ 0.000589] Console: colour dummy device 80x25234server # [ 0.004914] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)235builder # [ 0.000596] printk: legacy console [tty0] enabled236server # [ 0.004918] CPU features: detected: Enhanced Virtualization Traps237server # [ 0.004921] CPU features: detected: Fine Grained Traps238builder # [ 0.000780] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)239builder # [ 0.000787] pid_max: default: 32768 minimum: 301240server # [ 0.004924] CPU features: detected: Generic authentication (architected QARMA5 algorithm)241builder # [ 0.000867] LSM: initializing lsm=capability,landlock,yama,bpf,ima242server # [ 0.004929] CPU features: detected: RCpc load-acquire (LDAPR)243builder # [ 0.000998] landlock: Up and running.244server # [ 0.004931] CPU features: detected: LSE atomic instructions245builder # [ 0.001000] Yama: becoming mindful.246builder # [ 0.001451] LSM support for eBPF active247server # [ 0.004934] CPU features: detected: Privileged Access Never248server # [ 0.004937] CPU features: detected: PMUv3249builder # [ 0.001563] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)250server # [ 0.004940] CPU features: detected: RAS Extension Support251builder # [ 0.001583] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)252server # [ 0.004942] CPU features: detected: RASv1p1 Extension Support253builder # [ 0.002644] cacheinfo: Unable to detect cache hierarchy for CPU 0254server # [ 0.004945] CPU features: detected: Random Number Generator255builder # [ 0.003382] rcu: Hierarchical SRCU implementation.256server # [ 0.004947] CPU features: detected: Speculation barrier (SB)257builder # [ 0.003387] rcu: Max phase no-delay instances is 1000.258server # [ 0.004950] CPU features: detected: Stage-2 Force Write-Back259builder # [ 0.004593] fsl-mc MSI: its@8080000 domain created260server # [ 0.004953] CPU features: detected: TLB range maintenance instructions261builder # [ 0.004682] EFI services will not be available.262builder # [ 0.004752] smp: Bringing up secondary CPUs ...263server # [ 0.004958] CPU features: detected: Speculative Store Bypassing Safe (SSBS)264builder # [ 0.004760] smp: Brought up 1 node, 1 CPU265server # [ 0.004996] alternatives: applying system-wide alternatives266builder # [ 0.004763] SMP: Total of 1 processors activated.267builder # [ 0.004766] CPU: All CPU(s) started at EL1268server # [ 0.007902] CPU features: detected: BBM Level 2 without TLB conflict abort269builder # [ 0.004777] CPU features: detected: Branch Target Identification270builder # [ 0.004782] CPU features: detected: ARMv8.4 Translation Table Level271builder # [ 0.004788] CPU features: detected: Instruction cache invalidation not required for I/D coherence272builder # [ 0.004792] CPU features: detected: Data cache clean to the PoU not required for I/D coherence273builder # [ 0.004795] CPU features: detected: Common not Private translations274builder # [ 0.004799] CPU features: detected: CRC32 instructions275builder # [ 0.004802] CPU features: detected: Data cache clean to Point of Deep Persistence276builder # [ 0.004805] CPU features: detected: Data cache clean to Point of Persistence277builder # [ 0.004808] CPU features: detected: Data independent timing control (DIT)278builder # [ 0.004811] CPU features: detected: E0PD279builder # [ 0.004814] CPU features: detected: Enhanced Counter Virtualization280server # [ 0.008134] Memory: 895084K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)281builder # [ 0.004817] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)282server # [ 0.008483] devtmpfs: initialized283builder # [ 0.004821] CPU features: detected: Enhanced Virtualization Traps284builder # [ 0.004824] CPU features: detected: Fine Grained Traps285server # [ 0.010408] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns286builder # [ 0.004828] CPU features: detected: Generic authentication (architected QARMA5 algorithm)287server # [ 0.010432] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)288builder # [ 0.004833] CPU features: detected: RCpc load-acquire (LDAPR)289server # [ 0.010452] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).290builder # [ 0.004836] CPU features: detected: LSE atomic instructions291server # [ 0.010648] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL292builder # [ 0.004838] CPU features: detected: Privileged Access Never293server # [ 0.010653] 0 pages in range for non-PLT usage294builder # [ 0.004841] CPU features: detected: PMUv3295server # [ 0.010654] 508320 pages in range for PLT usage296builder # [ 0.004844] CPU features: detected: RAS Extension Support297server # [ 0.010758] pinctrl core: initialized pinctrl subsystem298builder # [ 0.004847] CPU features: detected: RASv1p1 Extension Support299server # [ 0.011524] DMI not present or invalid.300builder # [ 0.004849] CPU features: detected: Random Number Generator301server # [ 0.014612] NET: Registered PF_NETLINK/PF_ROUTE protocol family302builder # [ 0.004852] CPU features: detected: Speculation barrier (SB)303server # [ 0.016867] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations304builder # [ 0.004854] CPU features: detected: Stage-2 Force Write-Back305server # [ 0.017007] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations306builder # [ 0.004858] CPU features: detected: TLB range maintenance instructions307server # [ 0.017168] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations308builder # [ 0.004863] CPU features: detected: Speculative Store Bypassing Safe (SSBS)309server # [ 0.017188] audit: initializing netlink subsys (disabled)310builder # [ 0.004898] alternatives: applying system-wide alternatives311server # [ 0.017754] thermal_sys: Registered thermal governor 'fair_share'312builder # [ 0.007882] CPU features: detected: BBM Level 2 without TLB conflict abort313server # [ 0.017756] thermal_sys: Registered thermal governor 'bang_bang'314server # [ 0.017760] thermal_sys: Registered thermal governor 'step_wise'315server # [ 0.017763] thermal_sys: Registered thermal governor 'user_space'316builder # [ 0.008087] Memory: 895044K/1048576K available (24384K kernel code, 7086K rwdata, 26324K rodata, 4736K init, 1102K bss, 112248K reserved, 32768K cma-reserved)317builder # [ 0.008439] devtmpfs: initialized318server # [ 0.017765] thermal_sys: Registered thermal governor 'power_allocator'319builder # [ 0.010093] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns320server # [ 0.017808] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1321server # [ 0.017816] cpuidle: using governor ladder322builder # [ 0.010118] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)323server # [ 0.017822] cpuidle: using governor menu324server # [ 0.018015] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.325builder # [ 0.010138] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).326server # [ 0.018031] ASID allocator initialised with 65536 entries327builder # [ 0.010325] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL328server # [ 0.019181] Serial: AMBA PL011 UART driver329builder # [ 0.010329] 0 pages in range for non-PLT usage330builder # [ 0.010330] 508320 pages in range for PLT usage331server # [ 0.024350] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1332builder # [ 0.010437] pinctrl core: initialized pinctrl subsystem333server # [ 0.024472] printk: console [ttyAMA0] enabled334builder # [ 0.011218] DMI not present or invalid.335builder # [ 0.014342] NET: Registered PF_NETLINK/PF_ROUTE protocol family336server # [ 0.151778] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages337builder # [ 0.016639] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations338server # [ 0.151799] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page339builder # [ 0.016779] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations340server # [ 0.151804] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages341server # [ 0.151808] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page342builder # [ 0.016937] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations343builder # [ 0.016957] audit: initializing netlink subsys (disabled)344server # [ 0.151813] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages345server # [ 0.151817] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page346builder # [ 0.017494] thermal_sys: Registered thermal governor 'fair_share'347builder # [ 0.017496] thermal_sys: Registered thermal governor 'bang_bang'348server # [ 0.151822] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages349builder # [ 0.017500] thermal_sys: Registered thermal governor 'step_wise'350server # [ 0.151826] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page351builder # [ 0.017502] thermal_sys: Registered thermal governor 'user_space'352builder # [ 0.017505] thermal_sys: Registered thermal governor 'power_allocator'353server # [ 0.159533] fbcon: Taking over console354builder # [ 0.017540] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1355server # [ 0.159547] ACPI: Interpreter disabled.356server # [ 0.161417] iommu: Default domain type: Translated357server # [ 0.161428] iommu: DMA domain TLB invalidation policy: strict mode358server # [ 0.163178] SCSI subsystem initialized359builder # [ 0.017550] cpuidle: using governor ladder360builder # [ 0.017556] cpuidle: using governor menu361builder # [ 0.017762] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.362builder # [ 0.017778] ASID allocator initialised with 65536 entries363server # [ 0.170502] usbcore: registered new interface driver usbfs364builder # [ 0.018956] Serial: AMBA PL011 UART driver365server # [ 0.170538] usbcore: registered new interface driver hub366server # [ 0.170553] usbcore: registered new device driver usb367builder # [ 0.024049] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1368server # [ 0.170808] pps_core: LinuxPPS API ver. 1 registered369builder # [ 0.024217] printk: console [ttyAMA0] enabled370server # [ 0.170814] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>371builder # [ 0.154152] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages372server # [ 0.170824] PTP clock support registered373server # [ 0.170871] EDAC MC: Ver: 3.0.0374builder # [ 0.154176] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page375server # [ 0.175780] scmi_core: SCMI protocol bus registered376builder # [ 0.154182] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages377server # [ 0.176757] FPGA manager framework378builder # [ 0.154186] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page379server # [ 0.177694] vgaarb: loaded380builder # [ 0.154190] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages381builder # [ 0.154194] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page382server # [ 0.178369] clocksource: Switched to clocksource arch_sys_counter383server # [ 0.178869] VFS: Disk quotas dquot_6.6.0384builder # [ 0.154199] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages385builder # [ 0.154203] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page386server # [ 0.178896] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)387server # [ 0.181304] netfs: FS-Cache loaded388server # [ 0.181399] pnp: PnP ACPI: disabled389builder # [ 0.162146] fbcon: Taking over console390builder # [ 0.162163] ACPI: Interpreter disabled.391builder # [ 0.164065] iommu: Default domain type: Translated392builder # [ 0.164078] iommu: DMA domain TLB invalidation policy: strict mode393builder # [ 0.165956] SCSI subsystem initialized394server # [ 0.187537] NET: Registered PF_INET protocol family395server # [ 0.187718] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)396builder # [ 0.173116] usbcore: registered new interface driver usbfs397builder # [ 0.173149] usbcore: registered new interface driver hub398builder # [ 0.173165] usbcore: registered new device driver usb399builder # [ 0.173447] pps_core: LinuxPPS API ver. 1 registered400builder # [ 0.173453] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>401builder # [ 0.173465] PTP clock support registered402builder # [ 0.173515] EDAC MC: Ver: 3.0.0403builder # [ 0.178517] scmi_core: SCMI protocol bus registered404builder # [ 0.179512] FPGA manager framework405builder # [ 0.180523] vgaarb: loaded406builder # [ 0.181181] clocksource: Switched to clocksource arch_sys_counter407builder # [ 0.181690] VFS: Disk quotas dquot_6.6.0408builder # [ 0.181722] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)409builder # [ 0.184147] netfs: FS-Cache loaded410builder # [ 0.184261] pnp: PnP ACPI: disabled411builder # [ 0.190451] NET: Registered PF_INET protocol family412builder # [ 0.190673] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)413server # [ 0.217462] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)414server # [ 0.217506] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)415server # [ 0.217532] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)416server # [ 0.217573] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)417server # [ 0.217648] TCP: Hash tables configured (established 8192 bind 8192)418server # [ 0.217729] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)419server # [ 0.217758] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)420server # [ 0.217834] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)421server # [ 0.217913] NET: Registered PF_UNIX/PF_LOCAL protocol family422server # [ 0.217964] NET: Registered PF_XDP protocol family423server # [ 0.217983] PCI: CLS 0 bytes, default 64424server # [ 0.218236] Trying to unpack rootfs image as initramfs...425server # [ 0.236366] kvm [1]: HYP mode not available426builder # [ 0.220598] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)427builder # [ 0.220652] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)428builder # [ 0.220678] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)429builder # [ 0.220720] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)430builder # [ 0.220796] TCP: Hash tables configured (established 8192 bind 8192)431builder # [ 0.220886] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)432builder # [ 0.220930] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)433builder # [ 0.220979] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)434builder # [ 0.221105] NET: Registered PF_UNIX/PF_LOCAL protocol family435builder # [ 0.221131] NET: Registered PF_XDP protocol family436builder # [ 0.221149] PCI: CLS 0 bytes, default 64437builder # [ 0.221285] Trying to unpack rootfs image as initramfs...438builder # [ 0.239554] kvm [1]: HYP mode not available439server # [ 0.330963] Initialise system trusted keyrings440server # [ 0.331751] workingset: timestamp_bits=42 max_order=18 bucket_order=0441server # [ 0.333107] squashfs: version 4.0 (2009/01/31) Phillip Lougher442server # [ 0.333910] 9p: Installing v9fs 9p2000 file system support443builder # [ 0.338014] Initialise system trusted keyrings444builder # [ 0.338802] workingset: timestamp_bits=42 max_order=18 bucket_order=0445builder # [ 0.340123] squashfs: version 4.0 (2009/01/31) Phillip Lougher446builder # [ 0.340931] 9p: Installing v9fs 9p2000 file system support447server # [ 0.362617] Key type asymmetric registered448server # [ 0.362645] Asymmetric key parser 'x509' registered449server # [ 0.362713] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)450server # [ 0.364911] io scheduler mq-deadline registered451server # [ 0.364922] io scheduler kyber registered452server # [ 0.378536] pl061_gpio 9030000.pl061: PL061 GPIO chip registered453server # [ 0.379170] ledtrig-cpu: registered to indicate activity on CPUs454server # [ 0.379532] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:455server # [ 0.379551] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000456builder # [ 0.369670] Key type asymmetric registered457server # [ 0.379567] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000458builder # [ 0.369699] Asymmetric key parser 'x509' registered459builder # [ 0.369816] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)460server # [ 0.379576] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000461builder # [ 0.372020] io scheduler mq-deadline registered462builder # [ 0.372032] io scheduler kyber registered463server # [ 0.379598] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits464server # [ 0.379624] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]465server # [ 0.379723] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00466server # [ 0.379733] pci_bus 0000:00: root bus resource [bus 00-ff]467server # [ 0.379740] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]468server # [ 0.379745] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]469server # [ 0.379751] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]470server # [ 0.379841] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint471server # [ 0.380293] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint472server # [ 0.380484] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]473server # [ 0.380500] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]474server # [ 0.380532] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]475builder # [ 0.381325] pl061_gpio 9030000.pl061: PL061 GPIO chip registered476server # [ 0.380549] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]477server # [ 0.381009] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint478server # [ 0.381193] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]479server # [ 0.381210] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]480builder # [ 0.382744] ledtrig-cpu: registered to indicate activity on CPUs481server # [ 0.381239] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]482builder # [ 0.383133] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:483server # [ 0.381700] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint484builder # [ 0.383151] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000485server # [ 0.381911] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]486server # [ 0.381927] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]487builder # [ 0.383166] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000488server # [ 0.381957] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]489builder # [ 0.383174] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000490server # [ 0.382432] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint491builder # [ 0.383196] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits492server # [ 0.382618] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]493server # [ 0.382634] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]494builder # [ 0.383220] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]495server # [ 0.382666] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]496builder # [ 0.383311] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00497builder # [ 0.383320] pci_bus 0000:00: root bus resource [bus 00-ff]498server # [ 0.383144] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint499builder # [ 0.383326] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]500server # [ 0.383330] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]501server # [ 0.383346] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]502builder # [ 0.383331] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]503server # [ 0.383376] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]504builder # [ 0.383337] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]505server # [ 0.383883] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint506builder # [ 0.383400] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint507server # [ 0.384073] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]508builder # [ 0.383858] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint509server # [ 0.384090] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]510builder # [ 0.384050] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]511server # [ 0.384120] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]512builder # [ 0.384067] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]513server # [ 0.384576] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint514builder # [ 0.384097] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]515server # [ 0.384764] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]516builder # [ 0.384114] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]517server # [ 0.384781] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]518builder # [ 0.384592] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint519server # [ 0.384811] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]520builder # [ 0.384780] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]521server # [ 0.384828] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]522builder # [ 0.384796] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]523server # [ 0.385290] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint524builder # [ 0.384826] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]525server # [ 0.385479] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]526server # [ 0.385509] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]527server # [ 0.385982] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint528server # [ 0.386174] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]529server # [ 0.386204] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]530builder # [ 0.405440] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint531builder # [ 0.405635] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]532builder # [ 0.405651] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]533builder # [ 0.405682] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]534builder # [ 0.406162] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint535builder # [ 0.406349] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]536builder # [ 0.406365] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]537builder # [ 0.406395] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]538builder # [ 0.406875] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint539builder # [ 0.407066] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]540builder # [ 0.407082] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]541builder # [ 0.407112] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]542server # [ 0.434715] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint543server # [ 0.434918] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]544builder # [ 0.407580] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint545builder # [ 0.407769] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]546server # [ 0.435191] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint547builder # [ 0.407786] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]548server # [ 0.435489] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]549server # [ 0.435507] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]550builder # [ 0.407818] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]551server # [ 0.435537] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]552builder # [ 0.408288] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint553builder # [ 0.408479] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]554server # [ 0.436008] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint555builder # [ 0.408495] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]556server # [ 0.436195] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]557server # [ 0.436212] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]558builder # [ 0.408525] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]559server # [ 0.436242] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]560builder # [ 0.408541] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]561server # [ 0.436834] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned562builder # [ 0.409025] pci 0000:00:08.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint563server # [ 0.436847] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned564server # [ 0.436853] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned565server # [ 0.436900] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned566server # [ 0.436947] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned567server # [ 0.436995] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned568server # [ 0.437042] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned569server # [ 0.437090] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned570server # [ 0.437139] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned571server # [ 0.437187] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned572server # [ 0.437235] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned573builder # [ 0.433269] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]574server # [ 0.437283] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned575builder # [ 0.433314] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]576server # [ 0.437353] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned577builder # [ 0.433867] pci 0000:00:09.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint578server # [ 0.437400] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned579builder # [ 0.434070] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]580server # [ 0.437421] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned581builder # [ 0.434100] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]582server # [ 0.437443] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned583builder # [ 0.434514] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint584server # [ 0.437464] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned585builder # [ 0.434722] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]586server # [ 0.437486] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned587builder # [ 0.434974] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint588server # [ 0.437508] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned589builder # [ 0.435265] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]590server # [ 0.437533] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned591builder # [ 0.435283] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]592server # [ 0.437555] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned593builder # [ 0.435313] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]594server # [ 0.437578] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned595builder # [ 0.435782] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint596server # [ 0.437600] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned597builder # [ 0.435971] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]598server # [ 0.437623] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned599builder # [ 0.435987] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]600server # [ 0.437646] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned601builder # [ 0.436019] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]602server # [ 0.437667] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned603builder # [ 0.436621] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned604server # [ 0.437689] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned605builder # [ 0.436633] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned606server # [ 0.437711] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned607builder # [ 0.436639] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned608server # [ 0.437732] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned609server # [ 0.437754] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned610builder # [ 0.436684] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned611server # [ 0.437795] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned612builder # [ 0.436733] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned613server # [ 0.437818] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned614builder # [ 0.436781] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned615server # [ 0.437840] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned616server # [ 0.437863] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned617builder # [ 0.436829] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned618server # [ 0.437889] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]619builder # [ 0.436877] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned620server # [ 0.437899] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]621server # [ 0.437904] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]622builder # [ 0.436926] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned623builder # [ 0.436976] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned624builder # [ 0.437024] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned625builder # [ 0.437071] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned626server # [ 0.479783] pci 0000:00:0a.0: enabling device (0000 -> 0002)627builder # [ 0.437144] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned628builder # [ 0.469270] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned629builder # [ 0.469310] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned630builder # [ 0.469333] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned631builder # [ 0.469356] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned632builder # [ 0.469379] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned633builder # [ 0.469402] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned634builder # [ 0.469428] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned635builder # [ 0.469452] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned636builder # [ 0.469475] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned637builder # [ 0.469498] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned638builder # [ 0.469522] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned639builder # [ 0.469545] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned640builder # [ 0.469567] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned641builder # [ 0.469588] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned642builder # [ 0.469610] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned643builder # [ 0.469631] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned644builder # [ 0.469653] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned645server # [ 0.504408] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)646builder # [ 0.469674] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned647builder # [ 0.469696] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned648builder # [ 0.469718] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned649builder # [ 0.469761] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned650builder # [ 0.469793] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]651builder # [ 0.469803] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]652builder # [ 0.469808] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]653builder # [ 0.471016] pci 0000:00:0a.0: enabling device (0000 -> 0002)654server # [ 0.510645] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)655server # [ 0.513018] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)656server # [ 0.523006] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)657server # [ 0.525036] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)658builder # [ 0.506792] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)659server # [ 0.534929] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)660server # [ 0.538152] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)661server # [ 0.540298] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)662builder # [ 0.525326] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)663builder # [ 0.527314] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)664server # [ 0.550565] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)665builder # [ 0.529431] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)666server # [ 0.552442] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)667builder # [ 0.531545] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)668builder # [ 0.541796] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)669builder # [ 0.543919] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)670server # [ 0.562593] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)671server # [ 0.575707] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled672builder # [ 0.554033] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)673builder # [ 0.556668] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)674builder # [ 0.560424] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)675server # [ 0.578475] msm_serial: driver initialized676server # [ 0.578662] SuperH (H)SCI(F) driver initialized677server # [ 0.578716] STM32 USART driver initialized678builder # [ 0.568966] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)679builder # [ 0.586515] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled680builder # [ 0.589127] msm_serial: driver initialized681builder # [ 0.589848] SuperH (H)SCI(F) driver initialized682builder # [ 0.589906] STM32 USART driver initialized683server # [ 0.612731] loop: module loaded684server # [ 0.612941] virtio_blk virtio5: 1/0/0 default/read/poll queues685server # [ 0.613747] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)686server # [ 0.619022] megasas: 07.734.00.00-rc1687server # [ 0.619767] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]688server # [ 0.632070] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000689server # [ 0.632127] Intel/Sharp Extended Query Table at 0x0031690server # [ 0.633785] Using buffer write method691server # [ 0.633904] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]692builder # [ 0.624140] loop: module loaded693server # [ 0.643547] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000694builder # [ 0.624351] virtio_blk virtio5: 1/0/0 default/read/poll queues695server # [ 0.643597] Intel/Sharp Extended Query Table at 0x0031696server # [ 0.645032] Using buffer write method697builder # [ 0.625134] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)698server # [ 0.645080] Concatenating MTD devices:699server # [ 0.645084] (0): "0.flash"700server # [ 0.645089] (1): "0.flash"701server # [ 0.645093] into device "0.flash"702builder # [ 0.629868] megasas: 07.734.00.00-rc1703builder # [ 0.630598] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]704builder # [ 0.632834] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000705builder # [ 0.632876] Intel/Sharp Extended Query Table at 0x0031706builder # [ 0.642245] Using buffer write method707builder # [ 0.642344] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]708builder # [ 0.653223] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000709builder # [ 0.653262] Intel/Sharp Extended Query Table at 0x0031710builder # [ 0.654822] Using buffer write method711builder # [ 0.654867] Concatenating MTD devices:712builder # [ 0.654872] (0): "0.flash"713builder # [ 0.654876] (1): "0.flash"714builder # [ 0.654880] into device "0.flash"715server # [ 0.879223] Freeing initrd memory: 25520K716server # [ 0.885400] tun: Universal TUN/TAP device driver, 1.6717server # [ 0.889181] thunder_xcv, ver 1.0718server # [ 0.889230] thunder_bgx, ver 1.0719server # [ 0.889252] nicpf, ver 1.0720server # [ 0.889825] e1000: Intel(R) PRO/1000 Network Driver721server # [ 0.889832] e1000: Copyright (c) 1999-2006 Intel Corporation.722server # [ 0.889862] e1000e: Intel(R) PRO/1000 Network Driver723server # [ 0.889869] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.724server # [ 0.889899] igb: Intel(R) Gigabit Ethernet Network Driver725server # [ 0.889904] igb: Copyright (c) 2007-2014 Intel Corporation.726server # [ 0.889925] igbvf: Intel(R) Gigabit Virtual Function Network Driver727server # [ 0.889932] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.728server # [ 0.890066] sky2: driver version 1.30729server # [ 0.899003] usbcore: registered new interface driver usb-storage730server # [ 0.899135] usbcore: registered new interface driver usbserial_generic731server # [ 0.899149] usbserial: USB Serial support registered for generic732server # [ 0.899735] hv_vmbus: registering driver hyperv_keyboard733server # [ 0.901057] ehci-pci 0000:00:0a.0: EHCI Host Controller734server # [ 0.901091] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1735server # [ 0.901320] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000736builder # [ 0.885426] Freeing initrd memory: 25520K737server # [ 0.906946] rtc-pl031 9010000.pl031: registered as rtc0738server # [ 0.906975] rtc-pl031 9010000.pl031: setting system clock to 2026-07-07T08:16:40 UTC (1783412200)739server # [ 0.907331] i2c_dev: i2c /dev entries driver740server # [ 0.910445] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00741builder # [ 0.891595] tun: Universal TUN/TAP device driver, 1.6742server # [ 0.910772] hub 1-0:1.0: USB hub found743server # [ 0.910827] hub 1-0:1.0: 6 ports detected744builder # [ 0.895465] thunder_xcv, ver 1.0745builder # [ 0.895510] thunder_bgx, ver 1.0746builder # [ 0.895534] nicpf, ver 1.0747builder # [ 0.896077] e1000: Intel(R) PRO/1000 Network Driver748server # [ 0.914889] sdhci: Secure Digital Host Controller Interface driver749server # [ 0.914900] sdhci: Copyright(c) Pierre Ossman750builder # [ 0.896084] e1000: Copyright (c) 1999-2006 Intel Corporation.751builder # [ 0.896116] e1000e: Intel(R) PRO/1000 Network Driver752server # [ 0.915164] Synopsys Designware Multimedia Card Interface Driver753builder # [ 0.896124] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.754server # [ 0.915523] sdhci-pltfm: SDHCI platform and OF driver helper755server # [ 0.917229] hid: raw HID events driver (C) Jiri Kosina756builder # [ 0.896156] igb: Intel(R) Gigabit Ethernet Network Driver757server # [ 0.917469] usbcore: registered new interface driver usbhid758builder # [ 0.896161] igb: Copyright (c) 2007-2014 Intel Corporation.759server # [ 0.917476] usbhid: USB HID core driver760builder # [ 0.896184] igbvf: Intel(R) Gigabit Virtual Function Network Driver761builder # [ 0.896191] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.762builder # [ 0.896323] sky2: driver version 1.30763server # [ 0.923275] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available764builder # [ 0.905949] ehci-pci 0000:00:0a.0: EHCI Host Controller765server # [ 0.924771] drop_monitor: Initializing network drop monitor service766server # [ 0.924963] NET: Registered PF_INET6 protocol family767builder # [ 0.905987] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1768builder # [ 0.906208] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000769server # [ 0.928140] Segment Routing with IPv6770server # [ 0.928164] In-situ OAM (IOAM) with IPv6771server # [ 0.928193] NET: Registered PF_PACKET protocol family772builder # [ 0.908824] usbcore: registered new interface driver usb-storage773server # [ 0.929967] 9pnet: Installing 9P2000 support774builder # [ 0.908919] usbcore: registered new interface driver usbserial_generic775builder # [ 0.908933] usbserial: USB Serial support registered for generic776builder # [ 0.912376] hv_vmbus: registering driver hyperv_keyboard777server # [ 0.932860] Key type dns_resolver registered778builder # [ 0.914068] rtc-pl031 9010000.pl031: registered as rtc0779builder # [ 0.914097] rtc-pl031 9010000.pl031: setting system clock to 2026-07-07T08:16:40 UTC (1783412200)780builder # [ 0.914399] i2c_dev: i2c /dev entries driver781builder # [ 0.917607] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00782builder # [ 0.918665] hub 1-0:1.0: USB hub found783builder # [ 0.919177] hub 1-0:1.0: 6 ports detected784server # [ 0.939462] registered taskstats version 1785server # [ 0.939628] Loading compiled-in X.509 certificates786builder # [ 0.921972] sdhci: Secure Digital Host Controller Interface driver787builder # [ 0.921983] sdhci: Copyright(c) Pierre Ossman788builder # [ 0.922239] Synopsys Designware Multimedia Card Interface Driver789builder # [ 0.922597] sdhci-pltfm: SDHCI platform and OF driver helper790builder # [ 0.924227] hid: raw HID events driver (C) Jiri Kosina791server # [ 0.948037] Demotion targets for Node 0: null792builder # [ 0.924474] usbcore: registered new interface driver usbhid793server # [ 0.948149] Key type .fscrypt registered794builder # [ 0.924480] usbhid: USB HID core driver795server # [ 0.948155] Key type fscrypt-provisioning registered796server # [ 0.948253] ima: No TPM chip found, activating TPM-bypass!797server # [ 0.948272] ima: Allocated hash algorithm: sha1798server # [ 0.948293] ima: No architecture policies found799builder # [ 0.930290] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available800server # [ 0.952511] input: gpio-keys as /devices/platform/gpio-keys/input/input0801builder # [ 0.931730] drop_monitor: Initializing network drop monitor service802builder # [ 0.931877] NET: Registered PF_INET6 protocol family803builder # [ 0.935092] Segment Routing with IPv6804builder # [ 0.935113] In-situ OAM (IOAM) with IPv6805builder # [ 0.935153] NET: Registered PF_PACKET protocol family806builder # [ 0.936854] 9pnet: Installing 9P2000 support807builder # [ 0.939727] Key type dns_resolver registered808builder # [ 0.946399] registered taskstats version 1809builder # [ 0.946566] Loading compiled-in X.509 certificates810server # [ 0.970036] clk: Disabling unused clocks811server # [ 0.970062] PM: genpd: Disabling unused power domains812server # [ 0.974480] Freeing unused kernel memory: 4736K813server # [ 0.974660] Run /init as init process814builder # [ 0.954861] Demotion targets for Node 0: null815builder # [ 0.954991] Key type .fscrypt registered816builder # [ 0.954998] Key type fscrypt-provisioning registered817builder # [ 0.955119] ima: No TPM chip found, activating TPM-bypass!818builder # [ 0.955138] ima: Allocated hash algorithm: sha1819builder # [ 0.955165] ima: No architecture policies found820builder # [ 0.959493] input: gpio-keys as /devices/platform/gpio-keys/input/input0821server # [ 0.992626] systemd[1]: Successfully made /usr/ read-only.822builder # [ 0.977663] clk: Disabling unused clocks823builder # [ 0.977695] PM: genpd: Disabling unused power domains824builder # [ 0.982231] Freeing unused kernel memory: 4736K825builder # [ 0.982447] Run /init as init process826builder # [ 0.999681] systemd[1]: Successfully made /usr/ read-only.827server # [ 1.158448] usb 1-1: new high-speed USB device number 2 using ehci-pci828builder # [ 1.165262] usb 1-1: new high-speed USB device number 2 using ehci-pci829server # [ 1.314915] 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/input1830server # [ 1.327989] systemd[1]: systemd 260.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)831server # [ 1.340744] systemd[1]: Detected virtualization qemu.832builder # [ 1.317878] 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/input1833server # [ 1.343039] systemd[1]: Detected architecture arm64.834server # [ 1.345141] systemd[1]: Running in initrd.835server # [ 1.348042] systemd[1]: Initializing machine ID from random generator.836server # [ 1.351099] systemd[1]: Hostname set to <server>.837builder # [ 1.334657] 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)838builder # [ 1.347576] systemd[1]: Detected virtualization qemu.839builder # [ 1.349816] systemd[1]: Detected architecture arm64.840builder # [ 1.351842] systemd[1]: Running in initrd.841builder # [ 1.354809] systemd[1]: Initializing machine ID from random generator.842builder # [ 1.357980] systemd[1]: Hostname set to <builder>.843server # [ 1.398795] 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.401605] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0845server # [ 1.468700] systemd[1]: Queued start job for default target Initrd Default Target.846server # [ 1.476306] systemd[1]: Created slice Slice /system/modprobe.847server # [ 1.477337] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.848server # [ 1.478621] systemd[1]: Expecting device /dev/disk/by-label/nixos...849server # [ 1.479705] systemd[1]: Reached target Path Units.850server # [ 1.480479] systemd[1]: Reached target Slice Units.851server # [ 1.481279] systemd[1]: Reached target Swaps.852server # [ 1.481995] systemd[1]: Reached target Timer Units.853server # [ 1.482969] systemd[1]: Listening on D-Bus System Message Bus Socket.854server # [ 1.484141] systemd[1]: Listening on Journal Socket (/dev/log).855server # [ 1.485243] systemd[1]: Listening on Journal Sockets.856server # [ 1.486202] systemd[1]: Listening on udev Control Socket.857server # [ 1.487275] systemd[1]: Listening on udev Kernel Socket.858server # [ 1.488118] systemd[1]: Reached target Socket Units.859server # [ 1.490454] systemd[1]: Starting Create List of Static Device Nodes...860server # [ 1.498639] systemd[1]: Starting Load Kernel Module 9pnet_virtio...861server # [ 1.499765] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs862server # [ 1.505685] systemd[1]: Mounting Kernel Configuration File System...863builder # [ 1.486908] systemd[1]: Queued start job for default target Initrd Default Target.864builder # [ 1.495516] systemd[1]: Created slice Slice /system/modprobe.865server # [ 1.516477] systemd[1]: Starting Journal Service...866builder # [ 1.496848] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.867builder # [ 1.498427] systemd[1]: Expecting device /dev/disk/by-label/nixos...868builder # [ 1.498468] systemd[1]: Reached target Path Units.869builder # [ 1.498490] systemd[1]: Reached target Slice Units.870builder # [ 1.498510] systemd[1]: Reached target Swaps.871builder # [ 1.498529] systemd[1]: Reached target Timer Units.872builder # [ 1.498715] systemd[1]: Listening on D-Bus System Message Bus Socket.873builder # [ 1.498899] systemd[1]: Listening on Journal Socket (/dev/log).874builder # [ 1.499094] systemd[1]: Listening on Journal Sockets.875builder # [ 1.499234] systemd[1]: Listening on udev Control Socket.876builder # [ 1.499359] systemd[1]: Listening on udev Kernel Socket.877builder # [ 1.499382] systemd[1]: Reached target Socket Units.878server # [ 1.526456] usb 1-2: new high-speed USB device number 3 using ehci-pci879builder # [ 1.511088] systemd[1]: Starting Create List of Static Device Nodes...880builder # [ 1.518296] systemd[1]: Starting Load Kernel Module 9pnet_virtio...881server # [ 1.539563] systemd[1]: Starting Load Kernel Modules...882builder # [ 1.519593] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs883server # [ 1.541249] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki884builder # [ 1.529303] usb 1-2: new high-speed USB device number 3 using ehci-pci885builder # [ 1.532335] systemd[1]: Mounting Kernel Configuration File System...886server # [ 1.558613] systemd[1]: Starting Coldplug All udev Devices...887builder # [ 1.541346] systemd[1]: Starting Journal Service...888server # [ 1.567175] systemd[1]: Finished Create List of Static Device Nodes.889server # [ 1.569056] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.890server # [ 1.572204] systemd-journald[73]: Collecting audit messages is disabled.891server # [ 1.578713] systemd[1]: Finished Load Kernel Module 9pnet_virtio.892server # [ 1.579128] systemd[1]: Mounted Kernel Configuration File System.893builder # [ 1.561460] systemd[1]: Starting Load Kernel Modules...894builder # [ 1.562345] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki895server # [ 1.590837] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...896builder # [ 1.575272] systemd[1]: Starting Coldplug All udev Devices...897builder # [ 1.593537] systemd[1]: Finished Create List of Static Device Nodes.898builder # [ 1.594558] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.899builder # [ 1.594869] systemd[1]: Finished Load Kernel Module 9pnet_virtio.900builder # [ 1.595108] systemd[1]: Mounted Kernel Configuration File System.901server # [ 1.617858] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.902server # [ 1.630459] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev903builder # [ 1.605614] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...904server # [ 1.638266] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0905server # [ 1.651290] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.906builder # [ 1.634141] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.907server # [ 1.654742] [drm] features: -virgl +edid -resource_blob -host_visible908server # [ 1.654760] [drm] features: -context_init909server # [ 1.655558] [drm] number of scanouts: 1910server # [ 1.655576] [drm] number of cap sets: 0911builder # [ 1.643880] systemd-journald[73]: Collecting audit messages is disabled.912server # [ 1.662762] systemd[1]: Starting Create Static Device Nodes in /dev...913server # [ 1.667881] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic914server # [ 1.667901] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0915builder # [ 1.657277] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev916builder # [ 1.661815] [drm] pci: virtio-gpu-pci detected at 0000:00:08.0917builder # [ 1.662057] [drm] features: -virgl +edid -resource_blob -host_visible918builder # [ 1.662066] [drm] features: -context_init919builder # [ 1.662922] [drm] number of scanouts: 1920builder # [ 1.662942] [drm] number of cap sets: 0921server # [ 1.690539] Console: switching to colour frame buffer device 160x50922builder # [ 1.677869] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.923builder # [ 1.680618] systemd[1]: Starting Create Static Device Nodes in /dev...924builder # [ 1.685663] virtio-pci 0000:00:08.0: [drm] Registered 1 planes with drm panic925builder # [ 1.685685] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:08.0 on minor 0926server # [ 1.712860] 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/input2927server # [ 1.712997] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0928server # [ 1.727043] systemd[1]: Finished Create Static Device Nodes in /dev.929server # [ 1.728337] systemd[1]: Reached target Preparation for Local File Systems.930server # [ 1.730478] systemd[1]: Reached target Local File Systems.931builder # [ 1.709510] 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/input2932builder # [ 1.709680] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0933server # [ 1.733103] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device934server # [ 1.739714] systemd[1]: Starting Rule-based Manager for Device Events and Files...935server # [ 1.750950] systemd[1]: Finished Load Kernel Modules.936builder # [ 1.729861] Console: switching to colour frame buffer device 160x50937builder # [ 1.745336] systemd[1]: Finished Create Static Device Nodes in /dev.938builder # [ 1.745751] systemd[1]: Reached target Preparation for Local File Systems.939builder # [ 1.745777] systemd[1]: Reached target Local File Systems.940builder # [ 1.753596] systemd[1]: Starting Rule-based Manager for Device Events and Files...941server # [ 1.778712] systemd[1]: Starting Apply Kernel Variables...942builder # [ 1.761628] virtio-pci 0000:00:08.0: [drm] fb0: virtio_gpudrmfb frame buffer device943server # [ 1.794597] systemd[1]: Started Journal Service.944builder # [ 1.777489] systemd[1]: Finished Load Kernel Modules.945server # [ 1.796348] systemd-modules-load[74]: Inserted module 'dm_mod'946server # [ 1.797706] systemd-modules-load[74]: Module 'virtio_balloon' is built in947server # [ 1.798784] systemd-modules-load[74]: Module 'virtio_console' is built in948server # [ 1.799931] systemd-modules-load[74]: Inserted module 'virtio_gpu'949builder # [ 1.793745] systemd[1]: Starting Apply Kernel Variables...950server # [ 1.809839] systemd-modules-load[74]: Module 'virtio_rng' is built in951server # [ 1.817957] systemd[1]: Starting Create System Files and Directories...952server # [ 1.820405] systemd[1]: Finished Apply Kernel Variables.953server # [ 1.834672] systemd-udevd[81]: Using default interface naming scheme 'v260'.954server # [ 1.845557] systemd[1]: Finished Create System Files and Directories.955builder # [ 1.848781] systemd[1]: Started Journal Service.956builder # [ 1.848343] systemd-modules-load[74]: Inserted module 'dm_mod'957builder # [ 1.849682] systemd-modules-load[74]: Module 'virtio_balloon' is built in958builder # [ 1.850858] systemd-modules-load[74]: Module 'virtio_console' is built in959server # [ 1.878258] systemd[1]: Started Rule-based Manager for Device Events and Files.960builder # [ 1.851986] systemd-modules-load[74]: Inserted module 'virtio_gpu'961builder # [ 1.863212] systemd-modules-load[74]: Module 'virtio_rng' is built in962builder # [ 1.865435] systemd[1]: Starting Create System Files and Directories...963builder # [ 1.873062] systemd-udevd[80]: Using default interface naming scheme 'v260'.964builder # [ 1.876807] systemd[1]: Finished Apply Kernel Variables.965builder # [ 1.906670] systemd[1]: Finished Create System Files and Directories.966builder # [ 1.913058] systemd[1]: Started Rule-based Manager for Device Events and Files.967server # [ 1.945220] systemd[1]: Starting Virtual Console Setup...968builder # [ 1.996762] systemd[1]: Starting Virtual Console Setup...969server # [ 2.029996] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.970server # [ 2.031981] systemd[1]: Finished Virtual Console Setup.971builder # [ 2.077102] systemd-vconsole-setup[104]: Configuration of first virtual console was skipped, ignoring remaining ones.972builder # [ 2.080776] systemd[1]: Finished Virtual Console Setup.973server # [ 2.767158] systemd[1]: Finished Coldplug All udev Devices.974server # [ 2.768611] systemd[1]: Reached target System Initialization.975server # [ 2.772687] systemd[1]: Reached target Basic System.976builder # [ 2.789770] systemd[1]: Finished Coldplug All udev Devices.977builder # [ 2.790714] systemd[1]: Reached target System Initialization.978builder # [ 2.791546] systemd[1]: Reached target Basic System.979server # [ 2.979561] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.980builder # [ 2.962081] (udev-worker)[98]: Network interface NamePolicy= disabled on kernel command line.981server # [ 2.993315] (udev-worker)[103]: Network interface NamePolicy= disabled on kernel command line.982server # [ 3.000386] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.983builder # [ 2.991241] (udev-worker)[97]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.984builder # [ 2.996250] (udev-worker)[97]: Network interface NamePolicy= disabled on kernel command line.985server # [ 3.038317] systemd[1]: Found device /dev/disk/by-label/nixos.986server # [ 3.040972] systemd[1]: Reached target Initrd Root Device.987server # [ 3.044066] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...988builder # [ 3.029640] systemd[1]: Found device /dev/disk/by-label/nixos.989builder # [ 3.032468] systemd[1]: Reached target Initrd Root Device.990builder # [ 3.034441] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...991server # [ 3.097893] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks992server # [ 3.104146] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.993server # [ 3.106495] systemd[1]: Mounting /sysroot...994builder # [ 3.089763] systemd-fsck[113]: nixos: clean, 12/65536 files, 13019/262144 blocks995builder # [ 3.096787] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.996builder # [ 3.104332] systemd[1]: Mounting /sysroot...997server # [ 3.155964] EXT4-fs (vda): mounted filesystem 22f7b375-794b-469d-b19f-0439c88ba76f r/w with ordered data mode. Quota mode: none.998server # [ 3.147927] systemd[1]: Mounted /sysroot.999server # [ 3.150605] systemd[1]: Reached target Initrd Root File System.1000server # [ 3.155533] systemd[1]: Starting Mountpoints Configured in the Real Root...1001builder # [ 3.161042] EXT4-fs (vda): mounted filesystem 20685400-4068-4548-913e-8819e6a3395d r/w with ordered data mode. Quota mode: none.1002builder # [ 3.149278] systemd[1]: Mounted /sysroot.1003builder # [ 3.151178] systemd[1]: Reached target Initrd Root File System.1004builder # [ 3.155082] systemd[1]: Starting Mountpoints Configured in the Real Root...1005server # [ 3.190818] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.1006server # [ 3.204048] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...1007server # [ 3.208130] systemd[1]: Reloading...1008builder # [ 3.184796] systemd-sysroot-fstab-check[121]: /sysroot should be mounted in the initrd, will request daemon-reload.1009builder # [ 3.188656] systemd[1]: Reload requested from client PID 121 ('systemd-sysroot') (unit initrd-parse-etc.service)...1010builder # [ 3.194052] systemd[1]: Reloading...1011server # [ 3.441792] systemd[1]: Reloading finished in 237 ms.1012builder # [ 3.425756] systemd[1]: Reloading finished in 232 ms.1013server # [ 3.456938] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1014server # [ 3.460992] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1015builder # [ 3.440088] systemd-sysroot-fstab-check[121]: Requesting initrd-fs.target/start/replace...1016server # [ 3.469053] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1017builder # [ 3.446734] systemd-sysroot-fstab-check[121]: Requesting swap.target/start/replace...1018server # [ 3.472938] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1019builder # [ 3.454131] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1020server # [ 3.477510] systemd[1]: Finished Mountpoints Configured in the Real Root.1021server # [ 3.479277] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1022builder # [ 3.456986] systemd[1]: initrd-parse-etc.service: Deactivated successfully.1023builder # [ 3.465049] systemd[1]: Finished Mountpoints Configured in the Real Root.1024builder # [ 3.466112] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.1025server # [ 3.502788] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1026server # [ 3.504503] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1027builder # [ 3.491774] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1028builder # [ 3.493193] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1029server # [ 3.551505] systemd[1]: Mounting /sysroot/nix/.ro-store...1030server # [ 3.565735] systemd[1]: Mounting /sysroot/nix/.rw-store...1031server # [ 3.581604] systemd[1]: Mounting /sysroot/run...1032server # [ 3.597460] systemd[1]: Mounting /sysroot/tmp/shared...1033builder # [ 3.576290] systemd[1]: Mounting /sysroot/nix/.ro-store...1034builder # [ 3.596308] systemd[1]: Mounting /sysroot/nix/.rw-store...1035builder # [ 3.601165] systemd[1]: Mounting /sysroot/run...1036server # [ 3.627481] systemd[1]: Mounting /sysroot/tmp/xchg...1037server # [ 3.630640] systemd[1]: Mounted /sysroot/nix/.rw-store.1038builder # [ 3.617393] systemd[1]: Mounting /sysroot/tmp/shared...1039server # [ 3.651547] systemd[1]: Mounted /sysroot/nix/.ro-store.1040server # [ 3.668380] systemd[1]: Mounted /sysroot/run.1041builder # [ 3.648437] systemd[1]: Mounting /sysroot/tmp/xchg...1042server # [ 3.680277] systemd[1]: Mounted /sysroot/tmp/shared.1043server # [ 3.694253] systemd[1]: Starting rw-sysroot-nix-store.service...1044server # [ 3.703079] systemd[1]: Mounted /sysroot/tmp/xchg.1045builder # [ 3.685901] systemd[1]: Mounted /sysroot/nix/.ro-store.1046builder # [ 3.695863] systemd[1]: Mounted /sysroot/nix/.rw-store.1047builder # [ 3.703296] systemd[1]: Mounted /sysroot/run.1048server # [ 3.725922] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1049server # [ 3.727469] systemd[1]: Finished rw-sysroot-nix-store.service.1050builder # [ 3.710154] systemd[1]: Mounted /sysroot/tmp/shared.1051builder # [ 3.731669] systemd[1]: Starting rw-sysroot-nix-store.service...1052builder # [ 3.737620] systemd[1]: Mounted /sysroot/tmp/xchg.1053builder # [ 3.763830] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1054builder # [ 3.765409] systemd[1]: Finished rw-sysroot-nix-store.service.1055builder # [ 4.469102] (udev-worker)[94]: mtd0ro: Failed to find and pin callout binary "/nix/store/k2s978i7i26km4cr56fvm64p2q6mpl02-systemd-260.2/lib/udev/mtd_probe": No such file or directory1056builder # [ 4.476961] (udev-worker)[94]: 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 directory1057builder # [ 4.508233] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1058builder # [ 4.512200] systemd[1]: Stopped Virtual Console Setup.1059builder # [ 4.513374] systemd[1]: Stopping Virtual Console Setup...1060builder # [ 4.516205] systemd[1]: Starting Virtual Console Setup...1061server # [ 4.542356] (udev-worker)[96]: mtd0ro: Failed to find and pin callout binary "/nix/store/k2s978i7i26km4cr56fvm64p2q6mpl02-systemd-260.2/lib/udev/mtd_probe": No such file or directory1062builder # [ 4.525082] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1063builder # [ 4.528183] systemd[1]: Stopped Virtual Console Setup.1064server # [ 4.548780] (udev-worker)[96]: 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 directory1065builder # [ 4.532475] systemd[1]: Starting Virtual Console Setup...1066server # [ 4.560473] systemd[1]: Mounting /sysroot/nix/store...1067builder # [ 4.559922] systemd-vconsole-setup[156]: Configuration of first virtual console was skipped, ignoring remaining ones.1068builder # [ 4.563536] systemd[1]: Finished Virtual Console Setup.1069server # [ 4.597083] systemd[1]: Mounted /sysroot/nix/store.1070builder # [ 4.574591] systemd[1]: Mounting /sysroot/nix/store...1071server # [ 4.600632] systemd[1]: Reached target Initrd File Systems.1072server # [ 4.604195] systemd[1]: Starting Find NixOS closure...1073server # [ 4.612386] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1074builder # [ 4.600450] systemd[1]: Mounted /sysroot/nix/store.1075builder # [ 4.601977] systemd[1]: Reached target Initrd File Systems.1076builder # [ 4.604466] systemd[1]: Starting Find NixOS closure...1077builder # [ 4.611789] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...1078server # [ 4.637748] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1079server # [ 4.640762] systemd[1]: Stopped Virtual Console Setup.1080server # [ 4.641798] systemd[1]: Stopping Virtual Console Setup...1081server # [ 4.648626] systemd[1]: Starting Virtual Console Setup...1082server # [ 4.655579] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1083builder # [ 4.636209] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.1084server # [ 4.660246] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1085builder # [ 4.637878] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.1086builder # [ 4.648392] systemd[1]: Finished Find NixOS closure.1087builder # [ 4.650337] systemd[1]: Reached target Initrd Default Target.1088builder # [ 4.651628] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1089server # [ 4.679276] systemd[1]: Finished Find NixOS closure.1090server # [ 4.680195] systemd[1]: Reached target Initrd Default Target.1091server # [ 4.688346] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...1092builder # [ 4.674741] systemd[1]: Stopped target Initrd Default Target.1093builder # [ 4.676140] systemd[1]: Stopped target Basic System.1094server # [ 4.699422] systemd-vconsole-setup[161]: Configuration of first virtual console was skipped, ignoring remaining ones.1095builder # [ 4.679952] systemd[1]: Stopped target Initrd Root Device.1096builder # [ 4.680917] systemd[1]: Stopped target Path Units.1097builder # [ 4.681605] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1098server # [ 4.704748] systemd[1]: Finished Virtual Console Setup.1099builder # [ 4.682650] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1100builder # [ 4.683710] systemd[1]: Stopped target Slice Units.1101builder # [ 4.688221] systemd[1]: Stopped target Socket Units.1102builder # [ 4.688984] systemd[1]: Stopped target System Initialization.1103builder # [ 4.690240] systemd[1]: Stopped target Swaps.1104builder # [ 4.691802] systemd[1]: Stopped target Timer Units.1105server # [ 4.715097] systemd[1]: Stopped target Initrd Default Target.1106server # [ 4.716586] systemd[1]: Stopped target Basic System.1107builder # [ 4.695987] systemd[1]: dbus.socket: Deactivated successfully.1108server # [ 4.720432] systemd[1]: Stopped target Initrd Root Device.1109server # [ 4.721314] systemd[1]: Stopped target Path Units.1110builder # [ 4.698431] systemd[1]: Closed D-Bus System Message Bus Socket.1111server # [ 4.722053] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.1112builder # [ 4.700639] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1113server # [ 4.724129] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.1114server # [ 4.728174] systemd[1]: Stopped target Slice Units.1115builder # [ 4.705930] systemd[1]: Stopped Find NixOS closure.1116server # [ 4.728985] systemd[1]: Stopped target Socket Units.1117server # [ 4.729729] systemd[1]: Stopped target System Initialization.1118builder # [ 4.708186] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1119server # [ 4.731293] systemd[1]: Stopped target Swaps.1120server # [ 4.733141] systemd[1]: Stopped target Timer Units.1121builder # [ 4.712206] systemd[1]: Starting rw-sysroot-nix-store.service...1122server # [ 4.736153] systemd[1]: dbus.socket: Deactivated successfully.1123builder # [ 4.714814] systemd[1]: systemd-sysctl.service: Deactivated successfully.1124builder # [ 4.715958] systemd[1]: Stopped Apply Kernel Variables.1125builder # [ 4.717630] systemd[1]: systemd-modules-load.service: Deactivated successfully.1126server # [ 4.741040] systemd[1]: Closed D-Bus System Message Bus Socket.1127server # [ 4.742708] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.1128builder # [ 4.721751] systemd[1]: Stopped Load Kernel Modules.1129builder # [ 4.724096] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1130server # [ 4.748960] systemd[1]: Stopped Find NixOS closure.1131builder # [ 4.725810] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1132builder # [ 4.726933] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1133builder # [ 4.727956] systemd[1]: Stopped Create System Files and Directories.1134server # [ 4.752206] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1135server # [ 4.753143] systemd[1]: Starting rw-sysroot-nix-store.service...1136server # [ 4.755222] systemd[1]: systemd-sysctl.service: Deactivated successfully.1137server # [ 4.757765] systemd[1]: Stopped Apply Kernel Variables.1138builder # [ 4.736669] systemd[1]: Stopped target Local File Systems.1139builder # [ 4.737509] systemd[1]: Stopped target Preparation for Local File Systems.1140builder # [ 4.738586] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1141server # [ 4.761608] systemd[1]: systemd-modules-load.service: Deactivated successfully.1142builder # [ 4.739670] systemd[1]: Stopped Coldplug All udev Devices.1143server # [ 4.762818] systemd[1]: Stopped Load Kernel Modules.1144server # [ 4.765278] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.1145server # [ 4.767423] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.1146builder # [ 4.746876] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1147builder # [ 4.751473] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1148builder # [ 4.752864] systemd[1]: Stopped Virtual Console Setup.1149builder # [ 4.753595] systemd[1]: initrd-cleanup.service: Deactivated successfully.1150server # [ 4.777387] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.1151builder # [ 4.755286] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1152server # [ 4.779857] systemd[1]: Stopped Create System Files and Directories.1153builder # [ 4.757429] systemd[1]: systemd-udevd.service: Deactivated successfully.1154builder # [ 4.759601] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1155builder # [ 4.761026] systemd[1]: systemd-udevd.service: Consumed 1.608s CPU time over 2.996s wall clock time, 23.1M memory peak.1156server # [ 4.784786] systemd[1]: Stopped target Local File Systems.1157builder # [ 4.762472] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1158builder # [ 4.763483] systemd[1]: Closed udev Control Socket.1159server # [ 4.786212] systemd[1]: Stopped target Preparation for Local File Systems.1160builder # [ 4.764431] systemd[1]: Starting Cleanup udev Database...1161builder # [ 4.765223] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1162server # [ 4.788278] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.1163builder # [ 4.766301] systemd[1]: Stopped Create Static Device Nodes in /dev.1164builder # [ 4.767177] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1165server # [ 4.792257] systemd[1]: Stopped Coldplug All udev Devices.1166server # [ 4.793132] systemd[1]: Stopping Rule-based Manager for Device Events and Files...1167builder # [ 4.770569] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1168server # [ 4.794835] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1169builder # [ 4.773445] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1170server # [ 4.796791] systemd[1]: Stopped Virtual Console Setup.1171builder # [ 4.776270] systemd[1]: Stopped Create List of Static Device Nodes.1172server # [ 4.799201] systemd[1]: systemd-udevd.service: Deactivated successfully.1173builder # [ 4.777363] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1174server # [ 4.801071] systemd[1]: Stopped Rule-based Manager for Device Events and Files.1175server # [ 4.802203] systemd[1]: systemd-udevd.service: Consumed 1.692s CPU time over 3.041s wall clock time, 22.9M memory peak.1176builder # [ 4.780218] systemd[1]: Finished rw-sysroot-nix-store.service.1177server # [ 4.803696] systemd[1]: initrd-cleanup.service: Deactivated successfully.1178server # [ 4.804818] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.1179server # [ 4.805760] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1180server # [ 4.806785] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1181builder # [ 4.784143] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1182server # [ 4.807671] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.1183builder # [ 4.785200] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1184server # [ 4.812228] systemd[1]: Closed udev Control Socket.1185server # [ 4.816345] systemd[1]: Starting Cleanup udev Database...1186server # [ 4.817323] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.1187server # [ 4.818523] systemd[1]: Stopped Create Static Device Nodes in /dev.1188server # [ 4.820200] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.1189server # [ 4.824143] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.1190server # [ 4.825208] systemd[1]: kmod-static-nodes.service: Deactivated successfully.1191server # [ 4.828203] systemd[1]: Stopped Create List of Static Device Nodes.1192server # [ 4.829135] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.1193server # [ 4.832310] systemd[1]: Finished rw-sysroot-nix-store.service.1194builder # [ 4.815252] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1195builder # [ 4.816870] systemd[1]: Finished Cleanup udev Database.1196builder # [ 4.818122] systemd[1]: Reached target Switch Root.1197builder # [ 4.820292] systemd[1]: Starting NixOS Activation...1198server # [ 4.858565] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.1199server # [ 4.864731] systemd[1]: Finished Cleanup udev Database.1200server # [ 4.865561] systemd[1]: Reached target Switch Root.1201server # [ 4.866289] systemd[1]: Starting NixOS Activation...1202builder # [ 4.980680] initrd-nixos-activation-start[182]: booting system configuration /nix/store/ixgzzz7ydqh9j9fm8pp3xvl3frxbc9yx-nixos-system-builder-test1203server # [ 5.020696] initrd-nixos-activation-start[181]: booting system configuration /nix/store/3hc881fqznlhbpznnlw69v3q462r4f67-nixos-system-server-test1204builder # [ 5.043575] initrd-nixos-activation-start[182]: running activation script...1205server # [ 5.080451] initrd-nixos-activation-start[181]: running activation script...1206builder # [ 5.448278] initrd-nixos-activation-start[205]: setting up /etc...1207server # [ 5.489021] initrd-nixos-activation-start[204]: setting up /etc...1208server # [ 5.549772] systemd[1]: sysroot-run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully.1209builder # [ 5.723077] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1210builder # [ 5.726505] systemd[1]: Finished NixOS Activation.1211builder # [ 5.727785] systemd[1]: Starting Switch Root...1212server # [ 5.760957] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.1213server # [ 5.763867] systemd[1]: Finished NixOS Activation.1214server # [ 5.765232] systemd[1]: Starting Switch Root...1215builder # [ 5.747193] systemd[1]: Switching root.1216server # [ 5.786908] systemd[1]: Switching root.1217builder # [ 5.815640] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1218server # [ 5.853134] systemd-journald[73]: Received SIGTERM from PID 1 (systemd).1219builder # [ 6.363559] 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)1220builder # [ 6.375820] systemd[1]: Detected virtualization qemu.1221builder # [ 6.379711] systemd[1]: Detected architecture arm64.1222builder # [ 6.381888] systemd[1]: Detected first boot.1223builder # [ 6.388411] systemd[1]: Initializing machine ID from random generator.1224server # [ 6.410401] 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)1225server # [ 6.422736] systemd[1]: Detected virtualization qemu.1226server # [ 6.425887] systemd[1]: Detected architecture arm64.1227server # [ 6.428997] systemd[1]: Detected first boot.1228server # [ 6.436419] systemd[1]: Initializing machine ID from random generator.1229builder # [ 6.713010] systemd[1]: bpf-restrict-fs: LSM BPF program attached1230server # [ 6.746501] systemd[1]: bpf-restrict-fs: LSM BPF program attached1231builder # [ 6.924802] systemd[1]: Applying preset policy.1232server # [ 6.948596] systemd[1]: Applying preset policy.1233builder # [ 7.426947] systemd[1]: Populated /etc with preset unit settings.1234server # [ 7.460814] systemd[1]: Populated /etc with preset unit settings.1235builder # [ 7.926945] systemd[1]: initrd-switch-root.service: Deactivated successfully.1236builder # [ 7.928297] systemd[1]: Stopped initrd-switch-root.service.1237builder # [ 7.931759] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1238builder # [ 7.935166] systemd[1]: Created slice Slice /system/getty.1239builder # [ 7.937799] systemd[1]: Created slice User and Session Slice.1240builder # [ 7.939062] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1241builder # [ 7.940826] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1242builder # [ 7.942659] systemd[1]: Expecting device /dev/hvc0...1243builder # [ 7.944037] systemd[1]: Expecting device /dev/ttyAMA0...1244builder # [ 7.945573] systemd[1]: Reached target Local Encrypted Volumes.1245builder # [ 7.947110] systemd[1]: Stopped target initrd-fs.target.1246builder # [ 7.948563] systemd[1]: Stopped target initrd-root-fs.target.1247builder # [ 7.950182] systemd[1]: Stopped target initrd-switch-root.target.1248server # [ 7.971313] systemd[1]: initrd-switch-root.service: Deactivated successfully.1249builder # [ 7.951728] systemd[1]: Reached target Virtual Machines and Containers.1250server # [ 7.972669] systemd[1]: Stopped initrd-switch-root.service.1251builder # [ 7.953449] systemd[1]: Reached target Path Units.1252builder # [ 7.955545] systemd[1]: Reached target Remote File Systems.1253server # [ 7.975986] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.1254builder # [ 7.957437] systemd[1]: Reached target Slice Units.1255builder # [ 7.959179] systemd[1]: Reached target Swaps.1256server # [ 7.979353] systemd[1]: Created slice Slice /system/getty.1257server # [ 7.982071] systemd[1]: Created slice User and Session Slice.1258builder # [ 7.963162] systemd[1]: Listening on Query the User Interactively for a Password.1259server # [ 7.984206] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.1260server # [ 7.986550] systemd[1]: Started Forward Password Requests to Wall Directory Watch.1261builder # [ 7.968015] systemd[1]: Listening on Process Core Dump Socket.1262server # [ 7.988674] systemd[1]: Expecting device /dev/hvc0...1263server # [ 7.990537] systemd[1]: Expecting device /dev/ttyAMA0...1264builder # [ 7.971991] systemd[1]: Listening on Credential Encryption/Decryption.1265server # [ 7.992354] systemd[1]: Reached target Local Encrypted Volumes.1266server # [ 7.994240] systemd[1]: Stopped target initrd-fs.target.1267builder # [ 7.975994] systemd[1]: Listening on Factory Reset Management.1268server # [ 7.996067] systemd[1]: Stopped target initrd-root-fs.target.1269server # [ 7.997907] systemd[1]: Stopped target initrd-switch-root.target.1270server # [ 7.999898] systemd[1]: Reached target Virtual Machines and Containers.1271builder # [ 7.981152] systemd[1]: Starting Journal Log Access Socket...1272server # [ 8.001871] systemd[1]: Reached target Path Units.1273builder # [ 7.983190] systemd[1]: Listening on Journal Audit Socket.1274server # [ 8.003668] systemd[1]: Reached target Remote File Systems.1275server # [ 8.005450] systemd[1]: Reached target Slice Units.1276server # [ 8.007265] systemd[1]: Reached target Swaps.1277builder # [ 7.988526] systemd[1]: Listening on Console Output Muting Service Socket.1278builder # [ 7.990911] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1279server # [ 8.011566] systemd[1]: Listening on Query the User Interactively for a Password.1280builder # [ 7.993063] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1281builder # [ 7.995438] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1282server # [ 8.016277] systemd[1]: Listening on Process Core Dump Socket.1283server # [ 8.020157] systemd[1]: Listening on Credential Encryption/Decryption.1284server # [ 8.024171] systemd[1]: Listening on Factory Reset Management.1285builder # [ 8.005558] systemd[1]: Listening on Disk Repartitioning Service Socket.1286builder # [ 8.007745] systemd[1]: Listening on udev Control Socket.1287server # [ 8.029579] systemd[1]: Starting Journal Log Access Socket...1288builder # [ 8.009815] systemd[1]: Listening on udev Varlink Socket.1289server # [ 8.032583] systemd[1]: Listening on Journal Audit Socket.1290builder # [ 8.014427] systemd[1]: Mounting Huge Pages File System...1291server # [ 8.036923] systemd[1]: Listening on Console Output Muting Service Socket.1292builder # [ 8.019310] systemd[1]: Mounting POSIX Message Queue File System...1293server # [ 8.039462] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.1294server # [ 8.041871] systemd[1]: TPM PCR Measurements skipped, unmet condition check ConditionSecurity=measured-uki1295server # [ 8.044460] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki1296builder # [ 8.026680] systemd[1]: Mounting Kernel Debug File System...1297server # [ 8.055334] systemd[1]: Listening on Disk Repartitioning Service Socket.1298builder # [ 8.035956] systemd[1]: Mounting Kernel Trace File System...1299server # [ 8.056748] systemd[1]: Listening on udev Control Socket.1300server # [ 8.058301] systemd[1]: Listening on udev Varlink Socket.1301server # [ 8.062537] systemd[1]: Mounting Huge Pages File System...1302server # [ 8.067603] systemd[1]: Mounting POSIX Message Queue File System...1303builder # [ 8.052238] systemd[1]: Starting Create List of Static Device Nodes...1304server # [ 8.075850] systemd[1]: Mounting Kernel Debug File System...1305builder # [ 8.058644] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1306builder # [ 8.060213] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1307server # [ 8.082239] systemd[1]: Mounting Kernel Trace File System...1308builder # [ 8.070066] systemd[1]: Mounting Kernel Configuration File System...1309builder # [ 8.071376] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1310builder # [ 8.074879] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1311server # [ 8.096560] systemd[1]: Starting Create List of Static Device Nodes...1312builder # [ 8.083967] systemd[1]: Starting Load Kernel Module fuse...1313builder # [ 8.085310] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671314server # [ 8.115754] systemd[1]: Starting Load Kernel Module 9pnet_virtio...1315server # [ 8.117654] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1316server # [ 8.127133] systemd[1]: Mounting Kernel Configuration File System...1317server # [ 8.128798] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm1318server # [ 8.131169] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore1319builder # [ 8.151951] systemd[1]: Starting Journal Service...1320server # [ 8.197685] systemd[1]: Starting Load Kernel Module fuse...1321server # [ 8.203766] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc671322builder # [ 8.194626] systemd[1]: Starting Load Kernel Modules...1323builder # [ 8.216629] fuse: init (API version 7.45)1324server # [ 8.240011] systemd[1]: Starting Journal Service...1325builder # [ 8.224480] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1326server # [ 8.256739] systemd[1]: Starting Load Kernel Modules...1327server # [ 8.266922] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...1328builder # [ 8.249276] systemd[1]: Starting Remount Root and Kernel File Systems...1329builder # [ 8.249706] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1330builder # [ 8.271882] systemd[1]: Starting Coldplug All udev Devices...1331server # [ 8.299455] systemd[1]: Starting Remount Root and Kernel File Systems...1332server # [ 8.301998] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1333builder # [ 8.287542] systemd[1]: Listening on Journal Log Access Socket.1334builder # [ 8.291216] systemd-journald[275]: Collecting audit messages is enabled.1335builder # [ 8.282328] systemd[1]: Queued start job for default target Multi-User System.1336builder # [ 8.286690] systemd[1]: systemd-journald.service: Deactivated successfully.1337server # [ 8.328886] fuse: init (API version 7.45)1338builder # [ 8.311429] systemd[1]: Started Journal Service.1339server # [ 8.332174] systemd[1]: Starting Coldplug All udev Devices...1340builder # [ 8.300269] systemd-modules-load[276]: Module 'atkbd' is built in1341builder # [ 8.304297] systemd-modules-load[276]: Module 'loop' is built in1342server # [ 8.338609] systemd-journald[274]: Collecting audit messages is enabled.1343builder # [ 8.307641] systemd[1]: Mounted Huge Pages File System.1344builder # [ 8.311889] systemd[1]: Mounted POSIX Message Queue File System.1345builder # [ 8.315895] systemd[1]: Mounted Kernel Debug File System.1346server # [ 8.342659] systemd[1]: Queued start job for default target Multi-User System.1347builder # [ 8.321370] systemd[1]: Mounted Kernel Trace File System.1348server # [ 8.344228] systemd[1]: systemd-journald.service: Deactivated successfully.1349builder # [ 8.325315] systemd[1]: Finished Create List of Static Device Nodes.1350server # [ 8.368741] systemd[1]: Started Journal Service.1351builder # [ 8.332836] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1352server # [ 8.360917] systemd[1]: Listening on Journal Log Access Socket.1353builder # [ 8.338651] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1354server # [ 8.365498] systemd[1]: Mounted Huge Pages File System.1355server # [ 8.369569] systemd[1]: Mounted POSIX Message Queue File System.1356builder # [ 8.343794] systemd[1]: Mounted Kernel Configuration File System.1357builder # [ 8.352321] systemd[1]: modprobe@fuse.service: Deactivated successfully.1358builder # [ 8.353316] systemd[1]: Finished Load Kernel Module fuse.1359builder # [ 8.354085] systemd[1]: Finished Load Kernel Modules.1360server # [ 8.376990] systemd[1]: Mounted Kernel Debug File System.1361server # [ 8.382380] systemd[1]: Mounted Kernel Trace File System.1362server # [ 8.391860] systemd[1]: Finished Create List of Static Device Nodes.1363builder # [ 8.386328] EXT4-fs (vda): re-mounted 20685400-4068-4548-913e-8819e6a3395d.1364server # [ 8.396181] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.1365builder # [ 8.374141] systemd[1]: Mounting FUSE Control File System...1366builder # [ 8.377972] systemd[1]: Starting Firewall...1367server # [ 8.405784] systemd-modules-load[275]: Module 'atkbd' is built in1368builder # [ 8.386347] systemd[1]: Starting Apply Kernel Variables...1369server # [ 8.411983] systemd[1]: Finished Load Kernel Module 9pnet_virtio.1370builder # [ 8.395423] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1371server # [ 8.415861] systemd-modules-load[275]: Module 'loop' is built in1372server # [ 8.424707] systemd[1]: Mounted Kernel Configuration File System.1373server # [ 8.428331] systemd[1]: modprobe@fuse.service: Deactivated successfully.1374server # [ 8.436370] systemd[1]: Finished Load Kernel Module fuse.1375builder # [ 8.411428] systemd[1]: Finished Remount Root and Kernel File Systems.1376server # [ 8.440784] systemd-modules-load[275]: Inserted module 'tls'1377server # [ 8.447462] systemd[1]: Finished Load Kernel Modules.1378server # [ 8.466513] EXT4-fs (vda): re-mounted 22f7b375-794b-469d-b19f-0439c88ba76f.1379server # [ 8.455281] systemd[1]: Mounting FUSE Control File System...1380server # [ 8.460231] systemd[1]: Starting Firewall...1381builder # [ 8.440091] systemd-oomd[277]: No swap; memory pressure usage will be degraded1382builder # [ 8.445259] systemd[1]: Listening on Disk Image Download Service Socket.1383server # [ 8.468523] systemd[1]: Starting Apply Kernel Variables...1384builder # [ 8.464357] systemd[1]: Starting Flush Journal to Persistent Storage...1385builder # [ 8.468903] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1386server # [ 8.500945] systemd-oomd[277]: No swap; memory pressure usage will be degraded1387builder # [ 8.480206] systemd[1]: Starting Load/Save OS Random Seed...1388server # [ 8.504608] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...1389builder # [ 8.484418] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1390server # [ 8.512080] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1391builder # [ 8.496108] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.1392server # [ 8.533834] systemd[1]: Finished Remount Root and Kernel File Systems.1393server # [ 8.550194] systemd[1]: Listening on Disk Image Download Service Socket.1394server # [ 8.566938] systemd[1]: Starting Flush Journal to Persistent Storage...1395server # [ 8.571913] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore1396server # [ 8.583589] systemd[1]: Starting Load/Save OS Random Seed...1397server # [ 8.589740] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki1398builder # [ 8.575870] systemd[1]: Mounted FUSE Control File System.1399builder # [ 8.587869] systemd[1]: Finished Apply Kernel Variables.1400server # [ 8.628147] systemd[1]: Finished Apply Kernel Variables.1401builder # [ 8.625761] systemd-journald[275]: Received client request to flush runtime journal.1402server # [ 8.644412] systemd[1]: Mounted FUSE Control File System.1403server # [ 8.695815] systemd-journald[274]: Received client request to flush runtime journal.1404builder # [ 8.682909] systemd[1]: Finished Load/Save OS Random Seed.1405builder # [ 8.692675] systemd[1]: Reached target First Boot Complete.1406builder # [ 8.696196] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1407builder # [ 8.699097] systemd[1]: Starting Create Static Device Nodes in /dev...1408builder # [ 8.703516] systemd[1]: Finished Flush Journal to Persistent Storage.1409server # [ 8.760993] systemd[1]: Finished Load/Save OS Random Seed.1410server # [ 8.763942] systemd[1]: Reached target First Boot Complete.1411server # [ 8.769260] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.1412server # [ 8.773110] systemd[1]: Starting Create Static Device Nodes in /dev...1413server # [ 8.777392] systemd[1]: Finished Flush Journal to Persistent Storage.1414builder # [ 8.777688] systemd[1]: Finished Create Static Device Nodes in /dev.1415builder # [ 8.779390] systemd[1]: Reached target Preparation for Local File Systems.1416builder # [ 8.786044] systemd[1]: Starting Rule-based Manager for Device Events and Files...1417server # [ 8.881184] systemd[1]: Finished Create Static Device Nodes in /dev.1418server # [ 8.883928] systemd[1]: Reached target Preparation for Local File Systems.1419server # [ 8.890343] systemd[1]: Starting Rule-based Manager for Device Events and Files...1420builder # [ 8.895397] systemd-udevd[318]: Using default interface naming scheme 'v260'.1421builder # [ 8.919004] systemd[1]: Mounting /run/wrappers...1422server # [ 8.965193] systemd[1]: Mounting /run/wrappers...1423builder # [ 8.982365] systemd[1]: Mounted /run/wrappers.1424server # [ 9.005636] systemd-udevd[321]: Using default interface naming scheme 'v260'.1425builder # [ 8.985258] systemd[1]: Reached target Local File Systems.1426builder # [ 8.992354] systemd[1]: Listening on Boot Loader Control Service Socket.1427builder # [ 8.998780] systemd[1]: Starting register-nix-paths.service...1428builder # [ 9.007494] systemd[1]: Starting Create SUID/SGID Wrappers...1429builder # [ 9.010615] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1430server # [ 9.037399] systemd[1]: Mounted /run/wrappers.1431server # [ 9.039017] systemd[1]: Reached target Local File Systems.1432server # [ 9.043784] systemd[1]: Listening on Boot Loader Control Service Socket.1433builder # [ 9.019292] systemd[1]: Starting Save Transient machine-id to Disk...1434server # [ 9.050657] systemd[1]: Starting register-nix-paths.service...1435server # [ 9.054442] systemd[1]: Starting Create SUID/SGID Wrappers...1436server # [ 9.055922] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.1437server # [ 9.064369] systemd[1]: Starting Save Transient machine-id to Disk...1438builder # [ 9.039221] systemd[1]: Starting Create System Files and Directories...1439server # [ 9.077624] systemd[1]: Starting Create System Files and Directories...1440builder # [ 9.173198] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1441builder # [ 9.190045] systemd[1]: Finished Save Transient machine-id to Disk.1442server # [ 9.219827] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.1443server # [ 9.234216] systemd[1]: Finished Save Transient machine-id to Disk.1444builder # [ 9.237373] systemd[1]: Started Rule-based Manager for Device Events and Files.1445server # [ 9.308944] systemd[1]: Started Rule-based Manager for Device Events and Files.1446builder # [ 9.320594] systemd[1]: Finished Create System Files and Directories.1447server # [ 9.348732] systemd[1]: Finished Create System Files and Directories.1448builder # [ 9.328790] systemd[1]: Starting Rebuild Journal Catalog...1449server # [ 9.355971] systemd[1]: Starting Rebuild Journal Catalog...1450server # [ 9.363375] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1451builder # [ 9.350884] systemd[1]: Starting Record System Boot/Shutdown in UTMP...1452builder # [ 9.478582] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1453server # [ 9.525809] systemd[1]: Finished Record System Boot/Shutdown in UTMP.1454builder # [ 9.541252] systemd[1]: Finished Rebuild Journal Catalog.1455server # [ 9.564117] systemd[1]: Finished Rebuild Journal Catalog.1456builder # [ 9.554279] systemd[1]: Starting Update is Completed...1457server # [ 9.578408] systemd[1]: Starting Update is Completed...1458server # [ 9.653670] systemd[1]: Finished Update is Completed.1459builder # [ 9.647675] systemd[1]: Finished Update is Completed.1460server # [ 10.066592] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1461server # [ 10.067872] systemd[1]: Finished Create SUID/SGID Wrappers.1462builder # [ 10.053092] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.1463builder # [ 10.055581] systemd[1]: Finished Create SUID/SGID Wrappers.1464builder # [ 10.253569] systemd[1]: Finished register-nix-paths.service.1465server # [ 10.323495] systemd[1]: Finished register-nix-paths.service.1466builder # [ 10.465313] systemd[1]: Finished Firewall.1467server # [ 10.649304] systemd[1]: Finished Firewall.1468builder # [ 10.649648] systemd[1]: Finished Coldplug All udev Devices.1469builder # [ 10.652370] systemd[1]: Reached target System Initialization.1470builder # [ 10.653306] systemd[1]: Started Discard unused filesystem blocks once a week.1471builder # [ 10.655785] systemd[1]: Started Daily Cleanup of Temporary Directories.1472builder # [ 10.661135] systemd[1]: Reached target Timer Units.1473builder # [ 10.662783] systemd[1]: Listening on D-Bus System Message Bus Socket.1474builder # [ 10.664731] systemd[1]: Starting niks3 auto-upload socket...1475builder # [ 10.669562] systemd[1]: Listening on Nix Daemon Socket.1476builder # [ 10.670500] systemd[1]: Listening on Hostname Service Socket.1477builder # [ 10.671404] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1478builder # [ 10.677221] systemd[1]: Starting D-Bus System Message Bus...1479builder # [ 10.678507] systemd[1]: Listening on niks3 auto-upload socket.1480builder # [ 10.681039] systemd[1]: Reached target Socket Units.1481builder # [ 10.716912] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1482server # [ 10.765538] systemd[1]: Finished Coldplug All udev Devices.1483server # [ 10.766718] systemd[1]: Reached target System Initialization.1484server # [ 10.767597] systemd[1]: Started Discard unused filesystem blocks once a week.1485server # [ 10.770484] systemd[1]: Started niks3 garbage collection timer.1486server # [ 10.772549] systemd[1]: Started Daily Cleanup of Temporary Directories.1487server # [ 10.776251] systemd[1]: Reached target Timer Units.1488server # [ 10.777011] systemd[1]: Listening on D-Bus System Message Bus Socket.1489server # [ 10.782557] systemd[1]: Listening on niks3 server socket.1490server # [ 10.783475] systemd[1]: Listening on Nix Daemon Socket.1491server # [ 10.788637] systemd[1]: Listening on Hostname Service Socket.1492server # [ 10.789479] systemd[1]: Listening on Virtual Machine and Container Registration Service Socket.1493server # [ 10.790636] systemd[1]: Reached target Socket Units.1494server # [ 10.791375] systemd[1]: Reached target Basic System.1495server # [ 10.795234] systemd[1]: Starting Import lastlog data into lastlog2 database...1496server # [ 10.800725] systemd[1]: Starting Generate test mTLS certs...1497server # [ 10.804746] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1498builder # [ 10.789217] dbus-broker-launch[492]: Looking up NSS user entry for 'systemd-timesync'...1499server # [ 10.815729] systemd[1]: Starting Post-Boot Actions...1500builder # [ 10.802695] dbus-broker-launch[492]: NSS returned no entry for 'systemd-timesync'1501server # [ 10.826253] systemd[1]: Started Reset console on configuration changes.1502builder # [ 10.804268] dbus-broker-launch[492]: Invalid user-name in /nix/store/s1vb1xr0657f3bdwv3b8r1y8i0n7zy53-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1503server # [ 10.852336] systemd[1]: Starting resolvconf update...1504builder # [ 10.836297] systemd[1]: Started D-Bus System Message Bus.1505builder # [ 10.859614] dbus-broker-launch[492]: Ready1506builder # [ 10.864192] systemd[1]: Reached target Basic System.1507builder # [ 10.868460] systemd[1]: Starting Import lastlog data into lastlog2 database...1508builder # [ 10.874696] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1509server # [ 10.909366] systemd[1]: Starting D-Bus System Message Bus...1510builder # [ 10.888225] systemd[1]: Starting Post-Boot Actions...1511server # [ 10.917845] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs1512builder # [ 10.897727] systemd[1]: Started Reset console on configuration changes.1513builder # [ 10.925631] systemd[1]: Starting resolvconf update...1514server # [ 10.983592] systemd[1]: Finished Post-Boot Actions.1515server # [ 11.001032] niks3-test-certs-start[512]: -----1516server # [ 11.013138] systemd[1]: Started Name Service Cache Daemon (nsncd).1517server # [ 11.022732] systemd[1]: Reached target Host and Network Name Lookups.1518server # [ 11.027028] nsncd[503]: Jul 07 08:16:50.621 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1519builder # [ 11.010944] systemd[1]: Finished Post-Boot Actions.1520server # [ 11.042384] systemd[1]: Reached target User and Group Name Lookups.1521server # [ 11.048672] systemd[1]: Starting User Login Management...1522server # [ 11.066576] niks3-test-certs-start[527]: -----1523builder # [ 11.046699] systemd[1]: Finished Import lastlog data into lastlog2 database.1524server # [ 11.074902] systemd[1]: Finished Import lastlog data into lastlog2 database.1525builder # [ 11.052972] systemd[1]: Started Name Service Cache Daemon (nsncd).1526builder # [ 11.057092] nsncd[495]: Jul 07 08:16:50.657 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1527builder # [ 11.066033] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1528builder # [ 11.074322] systemd[1]: Reached target Host and Network Name Lookups.1529builder # [ 11.075450] systemd[1]: Reached target User and Group Name Lookups.1530builder # [ 11.081502] systemd[1]: Starting User Login Management...1531builder # [ 11.098440] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1532builder # [ 11.113182] systemd[1]: Started backdoor.service.1533server # [ 11.172977] dbus-broker-launch[508]: Looking up NSS user entry for 'systemd-timesync'...1534server # [ 11.195604] dbus-broker-launch[508]: NSS returned no entry for 'systemd-timesync'1535server # [ 11.202382] dbus-broker-launch[508]: Invalid user-name in /nix/store/764rlaazvvbm40f8svnia19nqh8mw3w4-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"1536server # [ 11.237189] systemd[1]: Started D-Bus System Message Bus.1537server # [ 11.245580] niks3-test-certs-start[532]: Certificate request self-signature ok1538server # [ 11.251566] niks3-test-certs-start[532]: subject=CN=server1539builder # connecting to host...1540server # [ 11.269981] systemd-logind[526]: New seat seat0.1541builder # [ 11.258442] systemd-logind[517]: New seat seat0.1542builder # [ 11.267061] systemd[1]: Started User Login Management.1543server # [ 11.292903] niks3-test-certs-start[565]: -----1544server # [ 11.297127] dbus-broker-launch[508]: Ready1545server # [ 11.301587] systemd[1]: Started User Login Management.1546builder # [ 11.278755] systemd[1]: Starting linger-users.service...1547server # [ 11.311287] systemd[1]: Stopped target Host and Network Name Lookups.1548server # [ 11.317036] systemd[1]: Stopping Host and Network Name Lookups...1549server # [ 11.317930] systemd[1]: Stopped target User and Group Name Lookups.1550server # [ 11.318823] systemd[1]: Stopping User and Group Name Lookups...1551server # [ 11.330332] systemd[1]: Starting linger-users.service...1552server # [ 11.333797] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1553builder # [ 11.304347] systemd[1]: Stopped target Host and Network Name Lookups.1554builder # [ 11.317507] systemd[1]: Stopping Host and Network Name Lookups...1555builder # [ 11.318365] systemd[1]: Stopped target User and Group Name Lookups.1556builder # [ 11.319226] systemd[1]: Stopping User and Group Name Lookups...1557server # [ 11.343575] systemd[1]: nscd.service: Deactivated successfully.1558server # [ 11.345099] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1559builder # [ 11.327711] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...1560builder # [ 11.332488] systemd[1]: nscd.service: Deactivated successfully.1561builder # [ 11.337336] systemd[1]: Stopped Name Service Cache Daemon (nsncd).1562builder # [ 11.342956] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1563server # [ 11.381192] systemd[1]: Starting Name Service Cache Daemon (nsncd)...1564server # [ 11.406038] niks3-test-certs-start[566]: Certificate request self-signature ok1565builder # [ 11.383895] systemd[1]: linger-users.service: Deactivated successfully.1566builder # [ 11.388426] systemd[1]: Finished linger-users.service.1567server # [ 11.416277] niks3-test-certs-start[566]: subject=CN=niks3 test client1568server # [ 11.439959] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.1569builder # [ 11.424931] nsncd[562]: Jul 07 08:16:51.026 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1570builder # [ 11.432551] systemd[1]: Started Name Service Cache Daemon (nsncd).1571builder # [ 11.434166] systemd[1]: Reached target Host and Network Name Lookups.1572server # [ 11.457343] systemd[1]: linger-users.service: Deactivated successfully.1573builder # [ 11.436888] systemd[1]: Reached target User and Group Name Lookups.1574server # [ 11.462218] systemd[1]: Finished linger-users.service.1575server # [ 11.467431] systemd[1]: Finished Generate test mTLS certs.1576builder # [ 11.469426] systemd[1]: Finished resolvconf update.1577builder # [ 11.474194] systemd[1]: Reached target Preparation for Network.1578server # [ 11.497274] systemd[1]: Finished resolvconf update.1579server # [ 11.501292] systemd[1]: Reached target Preparation for Network.1580builder # [ 11.480355] systemd[1]: Starting DHCP Client...1581server # [ 11.509389] nsncd[576]: Jul 07 08:16:51.116 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"1582builder # [ 11.488001] systemd[1]: Starting Extra networking commands....1583server # [ 11.516553] systemd[1]: Starting DHCP Client...1584server # [ 11.520123] systemd[1]: Starting Extra networking commands....1585server # [ 11.524172] systemd[1]: Started Name Service Cache Daemon (nsncd).1586server # [ 11.526364] systemd[1]: Reached target Host and Network Name Lookups.1587server # [ 11.532227] systemd[1]: Reached target User and Group Name Lookups.1588builder # [ 11.514771] (udev-worker)[362]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1589builder # [ 11.520991] (udev-worker)[362]: Network interface NamePolicy= disabled on kernel command line.1590builder # [ 11.542526] (udev-worker)[368]: Network interface NamePolicy= disabled on kernel command line.1591server # [ 11.568174] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.1592server # [ 11.578977] systemd[1]: Started backdoor.service.1593server # connecting to host...1594server: Guest shell says: b'Spawning backdoor root shell...\n'1595server: connected to guest root shell1596builder # [ 11.727582] dhcpcd[597]: dhcpcd-10.3.2 starting1597server: (connecting took 12.08 seconds)1598server: (finished: waiting for the VM to finish booting, in 12.08 seconds)1599builder # [ 11.743596] dhcpcd[630]: dev: loaded udev1600server # [ 11.795347] dhcpcd[609]: dhcpcd-10.3.2 starting1601builder # [ 11.803229] 8021q: 802.1Q VLAN Support v1.81602server # [ 11.816929] dhcpcd[649]: dev: loaded udev1603builder # [ 11.801280] systemd[1]: Finished Extra networking commands..1604builder # [ 11.805103] systemd[1]: Reached target Network.1605builder # [ 11.811957] systemd[1]: Starting Permit User Sessions...1606builder # [ 11.839507] systemd-logind[517]: Watching system buttons on /dev/input/event0 (gpio-keys)1607server # [ 11.882674] 8021q: 802.1Q VLAN Support v1.81608builder # [ 11.882453] systemd[1]: Finished Permit User Sessions.1609builder # [ 11.903621] systemd[1]: Started Getty on tty1.1610builder # [ 11.904478] systemd[1]: Reached target Login Prompts.1611builder # [ 11.925587] cfg80211: Loading compiled-in X.509 certificates for regulatory database1612builder # [ 11.916233] systemd[1]: Condition check resulted in Virtio network device being skipped.1613server # [ 11.950303] systemd[1]: Finished Extra networking commands..1614builder # [ 11.929967] systemd[1]: Starting Address configuration of eth1...1615server # [ 11.978718] systemd[1]: Reached target Network.1616builder # [ 11.979822] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1617builder # [ 11.980308] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1618server # [ 11.988859] systemd[1]: Started Mock OIDC server for testing.1619builder # [ 11.985469] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21620builder # [ 11.985780] cfg80211: failed to load regulatory.db1621server # [ 12.009169] cfg80211: Loading compiled-in X.509 certificates for regulatory database1622server # [ 12.007398] systemd[1]: Starting Nginx Web Server...1623server # [ 12.033934] (udev-worker)[368]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.1624server # [ 12.041974] (udev-worker)[368]: Network interface NamePolicy= disabled on kernel command line.1625server # [ 12.047865] systemd[1]: Starting PostgreSQL Server...1626server # [ 12.065924] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'1627server # [ 12.055362] (udev-worker)[360]: Network interface NamePolicy= disabled on kernel command line.1628server # [ 12.070961] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'1629server # [ 12.075976] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -21630builder # [ 12.055923] 8021q: adding VLAN 0 to HW filter on device eth11631server # [ 12.076295] cfg80211: failed to load regulatory.db1632builder # [ 12.060764] network-addresses-eth1-start[648]: adding address 192.168.1.1/24... done1633server # [ 12.085013] systemd[1]: Started RustFS S3-compatible object storage.1634builder # [ 12.080902] 8021q: adding VLAN 0 to HW filter on device eth01635builder # [ 12.067276] dhcpcd[630]: eth0: waiting for carrier1636builder # [ 12.071610] dhcpcd[630]: eth0: waiting for carrier1637builder # [ 12.074071] dhcpcd[630]: eth0: carrier acquired1638builder # [ 12.086814] network-addresses-eth1-start[648]: adding address 2001:db8:1::1/64... done1639builder # [ 12.089490] dhcpcd[630]: DUID 00:01:00:01:31:df:72:73:52:54:00:12:34:561640builder # [ 12.091992] dhcpcd[630]: eth0: IAID 00:12:34:561641builder # [ 12.094601] dhcpcd[630]: eth0: adding address fe80::5054:ff:fe12:34561642server # [ 12.123777] systemd[1]: Starting Setup RustFS bucket...1643server # [ 12.133648] systemd[1]: Starting Permit User Sessions...1644builder # [ 12.112454] systemd[1]: Finished Address configuration of eth1.1645server # [ 12.201453] 8021q: adding VLAN 0 to HW filter on device eth01646server # [ 12.196091] dhcpcd[649]: eth0: waiting for carrier1647server # [ 12.204698] dhcpcd[649]: eth0: waiting for carrier1648server # [ 12.205462] dhcpcd[649]: eth0: carrier acquired1649builder # [ 12.209265] mousedev: PS/2 mouse device common for all mice1650server # [ 12.221618] systemd[1]: Condition check resulted in Virtio network device being skipped.1651server # [ 12.239220] systemd[1]: Starting Address configuration of eth1...1652builder # [ 12.225479] systemd-logind[517]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1653server # [ 12.263435] dhcpcd[649]: DUID 00:01:00:01:31:df:72:73:52:54:00:12:34:561654server # [ 12.270213] dhcpcd[649]: eth0: IAID 00:12:34:561655server # [ 12.278858] systemd[1]: Finished Permit User Sessions.1656server # [ 12.279653] dhcpcd[649]: eth0: adding address fe80::5054:ff:fe12:34561657server # [ 12.305896] systemd[1]: Started Getty on tty1.1658server # [ 12.311749] systemd[1]: Reached target Login Prompts.1659server # [ 12.423412] mock-oidc-server[662]: Mock OIDC Server running1660server # [ 12.429511] mock-oidc-server[662]: OIDC Address: 127.0.0.1:80801661server # [ 12.430386] mock-oidc-server[662]: Issue Address: 127.0.0.1:80811662server # [ 12.438459] mock-oidc-server[662]: Issuer: http://127.0.0.1:8080/oidc1663server # [ 12.443487] mock-oidc-server[662]: JWKS: http://127.0.0.1:8080/oidc/.well-known/jwks.json1664server # [ 12.454517] mock-oidc-server[662]: Discovery: http://127.0.0.1:8080/oidc/.well-known/openid-configuration1665server # [ 12.455856] mock-oidc-server[662]: Issue tokens: http://127.0.0.1:8081/issue?sub=...1666server # [ 12.480230] 8021q: adding VLAN 0 to HW filter on device eth11667server # [ 12.506896] network-addresses-eth1-start[694]: adding address 192.168.1.2/24... done1668server # [ 12.536144] network-addresses-eth1-start[694]: adding address 2001:db8:1::2/64... done1669server # [ 12.577617] systemd[1]: Finished Address configuration of eth1.1670builder # [ 12.589923] dhcpcd[630]: eth0: soliciting a DHCP lease1671builder # [ 12.596520] dhcpcd[630]: eth0: offered 10.0.2.15 from 10.0.2.21672builder # [ 12.604229] dhcpcd[630]: eth0: probing address 10.0.2.15/241673server # [ 12.681299] postgresql-pre-start[711]: The files belonging to this database system will be owned by user "postgres".1674server # [ 12.682740] postgresql-pre-start[711]: This user must also own the server process.1675server # [ 12.699681] postgresql-pre-start[711]: The database cluster will be initialized with locale "en_US.UTF-8".1676server # [ 12.703943] postgresql-pre-start[711]: The default database encoding has accordingly been set to "UTF8".1677server # [ 12.707276] postgresql-pre-start[711]: The default text search configuration will be set to "english".1678server # [ 12.716171] postgresql-pre-start[711]: Data page checksums are disabled.1679server # [ 12.724843] postgresql-pre-start[711]: fixing permissions on existing directory /var/lib/postgresql/17 ... ok1680server # [ 12.726185] postgresql-pre-start[711]: creating subdirectories ... ok1681server # [ 12.727036] postgresql-pre-start[711]: selecting dynamic shared memory implementation ... posix1682server # [ 12.739201] nginx-pre-start[708]: nginx: the configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf syntax is ok1683server # [ 12.746270] nginx-pre-start[708]: nginx: configuration file /nix/store/q2qwgbfznnzrr87lhic3cd6hyk8rk12a-nginx.conf test is successful1684server # [ 12.755448] systemd[1]: Started Nginx Web Server.1685server # [ 12.774766] systemd-logind[526]: Watching system buttons on /dev/input/event0 (gpio-keys)1686server # [ 12.930285] postgresql-pre-start[711]: selecting default "max_connections" ... 1001687builder # [ 13.020514] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31688server # [ 13.095953] postgresql-pre-start[711]: selecting default "shared_buffers" ... 128MB1689server # [ 13.224113] mousedev: PS/2 mouse device common for all mice1690builder # [ 13.314857] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1691builder # [ 13.348773] systemd[1]: Starting Virtual Console Setup...1692builder # [ 13.376427] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1693builder # [ 13.381244] systemd[1]: Stopped Virtual Console Setup.1694builder # [ 13.390190] systemd[1]: Starting Virtual Console Setup...1695server # [ 13.420320] rustfs[671]: {"timestamp":"2026-07-07T08:16:53.02568774Z","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)"}1696builder # [ 13.417841] dhcpcd[630]: eth0: soliciting an IPv6 router1697builder # [ 13.419314] dhcpcd[630]: eth0: Router Advertisement from fe80::21698builder # [ 13.420884] dhcpcd[630]: eth0: adding address fec0::5054:ff:fe12:3456/641699builder # [ 13.423573] dhcpcd[630]: eth0: adding route to fec0::/641700builder # [ 13.428165] dhcpcd[630]: eth0: adding default route via fe80::21701builder # [ 13.429268] systemd-logind[517]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1702server # [ 13.540975] systemd-logind[526]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard)1703builder # [ 13.790389] systemd-vconsole-setup[685]: Configuration of first virtual console was skipped, ignoring remaining ones.1704builder # [ 13.794691] systemd[1]: Finished Virtual Console Setup.1705server # [ 14.154127] dhcpcd[649]: eth0: soliciting a DHCP lease1706server # [ 14.160508] dhcpcd[649]: eth0: offered 10.0.2.15 from 10.0.2.21707server # [ 14.168227] dhcpcd[649]: eth0: probing address 10.0.2.15/241708server # [ 14.334575] dhcpcd[649]: eth0: soliciting an IPv6 router1709server # [ 14.336837] dhcpcd[649]: eth0: Router Advertisement from fe80::21710server # [ 14.339051] dhcpcd[649]: eth0: adding address fec0::5054:ff:fe12:3456/641711server # [ 14.341389] dhcpcd[649]: eth0: adding route to fec0::/641712server # [ 14.343240] dhcpcd[649]: eth0: adding default route via fe80::21713server # [ 14.638529] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:09.0/virtio8/input/input31714server # [ 15.038300] systemd[1]: Starting Virtual Console Setup...1715server # [ 15.234348] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.1716server # [ 15.243732] systemd[1]: Stopped Virtual Console Setup.1717server # [ 15.256391] systemd[1]: Starting Virtual Console Setup...1718server # [ 15.294660] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.1719server # [ 15.467672] systemd-logind[526]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)1720server # [ 15.724556] systemd-vconsole-setup[780]: Configuration of first virtual console was skipped, ignoring remaining ones.1721server # [ 15.730417] systemd[1]: Finished Virtual Console Setup.1722server # [ 15.779483] postgresql-pre-start[711]: selecting default time zone ... UTC1723server # [ 15.783044] postgresql-pre-start[711]: creating configuration files ... ok1724server # [ 16.043597] postgresql-pre-start[711]: running bootstrap script ... ok1725server # [ 16.644190] postgresql-pre-start[711]: performing post-bootstrap initialization ... ok1726server # [ 16.777022] postgresql-pre-start[711]: syncing data to disk ... ok1727server # [ 16.778035] postgresql-pre-start[711]: initdb: warning: enabling "trust" authentication for local connections1728server # [ 16.779725] postgresql-pre-start[711]: 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.1729server # [ 16.782017] postgresql-pre-start[711]: Success. You can now start the database server using:1730server # [ 16.783295] postgresql-pre-start[711]: pg_ctl -D /var/lib/postgresql/17 -l logfile start1731server # [ 16.896459] postgres[803]: [803] LOG: starting PostgreSQL 17.10 on aarch64-unknown-linux-gnu, compiled by clang version 21.1.8, 64-bit1732server # [ 16.900232] postgres[803]: [803] LOG: listening on IPv6 address "::1", port 54321733server # [ 16.901430] postgres[803]: [803] LOG: listening on IPv4 address "127.0.0.1", port 54321734server # [ 16.903389] postgres[803]: [803] LOG: listening on Unix socket "/run/postgresql/.s.PGSQL.5432"1735server # [ 16.912682] postgres[809]: [809] LOG: database system was shut down at 2026-07-07 08:16:56 GMT1736server # [ 16.922055] postgres[803]: [803] LOG: database system is ready to accept connections1737server # [ 16.927494] systemd[1]: Started PostgreSQL Server.1738server # [ 16.932444] systemd[1]: Starting PostgreSQL Setup Scripts...1739server # [ 17.129706] postgresql-setup-start[820]: CREATE DATABASE1740server # [ 17.185752] postgresql-setup-start[825]: CREATE ROLE1741server # [ 17.211117] postgresql-setup-start[827]: ALTER DATABASE1742server # [ 17.218873] systemd[1]: Finished PostgreSQL Setup Scripts.1743server # [ 17.220991] systemd[1]: Reached target PostgreSQL.1744server: (finished: waiting for unit postgresql.service, in 17.91 seconds)1745server: waiting for unit rustfs.service1746server: (finished: waiting for unit rustfs.service, in 0.07 seconds)1747server: waiting for unit rustfs-setup.service1748builder # [ 17.853223] dhcpcd[630]: eth0: leased 10.0.2.15 for 86400 seconds1749builder # [ 17.857288] dhcpcd[630]: eth0: adding route to 10.0.2.0/241750builder # [ 17.857483] dhcpcd[630]: eth0: adding default route via 10.0.2.21751builder # [ 18.012614] systemd[1]: Started DHCP Client.1752builder # [ 18.016232] systemd[1]: Reached target Multi-User System.1753builder # [ 18.017083] systemd[1]: Startup finished in 970ms (kernel) + 4.923s (initrd) + 12.121s (userspace) = 18.015s.1754server # [ 19.799598] dhcpcd[649]: eth0: leased 10.0.2.15 for 86400 seconds1755server # [ 19.803153] dhcpcd[649]: eth0: adding route to 10.0.2.0/241756server # [ 19.806321] dhcpcd[649]: eth0: adding default route via 10.0.2.21757server # [ 19.996143] systemd[1]: Started DHCP Client.1758server # [ 28.570373] rustfs-setup-start[928]: mb s3://niks3-test1759server # [ 28.578722] systemd[1]: Finished Setup RustFS bucket.1760server # [ 28.588975] systemd[1]: Starting niks3 server...1761server: (finished: waiting for unit rustfs-setup.service, in 10.93 seconds)1762server: waiting for unit mock-oidc.service1763server: (finished: waiting for unit mock-oidc.service, in 0.10 seconds)1764server: waiting for unit niks3.service1765server # [ 28.847500] postgres[955]: [955] ERROR: relation "goose_db_version" does not exist at character 361766server # [ 28.849180] postgres[955]: [955] STATEMENT: SELECT version_id, is_applied from goose_db_version ORDER BY id DESC1767server # [ 28.881683] niks3-server[940]: 2026/07/07 08:17:08 OK 20241026095416_initial_model.sql (19.91ms)1768server # [ 28.893665] niks3-server[940]: 2026/07/07 08:17:08 OK 20251210153512_drop_unused_gin_index.sql (3.75ms)1769server # [ 28.896565] niks3-server[940]: 2026/07/07 08:17:08 OK 20251218171726_add_pins.sql (4.28ms)1770server # [ 28.898192] niks3-server[940]: 2026/07/07 08:17:08 OK 20260628120000_add_object_size_and_stats.sql (6.12ms)1771server # [ 28.900705] niks3-server[940]: 2026/07/07 08:17:08 goose: successfully migrated database to version: 202606281200001772server # [ 28.902835] niks3-server[940]: 2026/07/07 08:17:08 OK 1_commit_pending_closure.sql (7.11ms)1773server # [ 28.905597] niks3-server[940]: 2026/07/07 08:17:08 OK 2_object_stats_trigger.sql (2.61ms)1774server # [ 28.906969] niks3-server[940]: 2026/07/07 08:17:08 goose: up to current file version: 21775server # [ 28.922883] niks3-server[940]: 2026/07/07 08:17:08 INFO OIDC provider initialized name=test1776server # [ 28.924449] niks3-server[940]: 2026/07/07 08:17:08 INFO OIDC authentication enabled config=/nix/store/2za6kyy80mq2xh1w4ydfs7gg8psbv5g3-niks3-oidc.json1777server # [ 28.926941] niks3-server[940]: 2026/07/07 08:17:08 INFO Loaded signing key name=niks3-test-1 path=/nix/store/1cz670ydszbfkf0naknmhg579xvlcyr7-niks3-signing-key1778server # [ 28.955958] rustfs[671]: {"timestamp":"2026-07-07T08:17:08.56286034Z","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)"}1779server # [ 28.963092] niks3-server[940]: 2026/07/07 08:17:08 INFO Created nix-cache-info in bucket bucket=niks3-test1780server # [ 28.966593] niks3-server[940]: 2026/07/07 08:17:08 INFO Using socket-activated listener address=0.0.0.0:57511781server # [ 28.967949] niks3-server[940]: 2026/07/07 08:17:08 INFO systemd watchdog enabled interval=15s1782server # [ 28.970328] niks3-server[940]: 2026/07/07 08:17:08 INFO Starting HTTP server address=0.0.0.0:57511783server # [ 28.971599] systemd[1]: Started niks3 server.1784server # [ 28.972314] systemd[1]: Reached target Multi-User System.1785server # [ 28.973069] systemd[1]: Startup finished in 965ms (kernel) + 4.973s (initrd) + 23.031s (userspace) = 28.970s.1786server: (finished: waiting for unit niks3.service, in 1.17 seconds)1787server: waiting for TCP port 5751 on localhost1788server # Connection to localhost (127.0.0.1) 5751 port [tcp/*] succeeded!1789server: (finished: waiting for TCP port 5751 on localhost, in 0.07 seconds)1790server: waiting for TCP port 8080 on localhost1791server # Connection to localhost (127.0.0.1) 8080 port [tcp/http-alt] succeeded!1792server: (finished: waiting for TCP port 8080 on localhost, in 0.04 seconds)1793server: waiting for TCP port 9000 on localhost1794server # Connection to localhost (127.0.0.1) 9000 port [tcp/cslistener] succeeded!1795server: (finished: waiting for TCP port 9000 on localhost, in 0.04 seconds)1796server: must succeed: mkdir -p /tmp/test-config1797server: (finished: must succeed: mkdir -p /tmp/test-config, in 0.03 seconds)1798server: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token1799server: (finished: must succeed: echo -n 'test-token-that-is-at-least-36-characters-long' > /tmp/test-config/auth-token, in 0.02 seconds)1800server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31801server # [ 30.317839] niks3-server[940]: 2026/07/07 08:17:09 INFO Received uploads request method=POST path=/api/pending_closures1802server # time=2026-07-07T08:17:09.942Z level=INFO msg="Uploading 5 paths to server (0 already cached)"1803server # time=2026-07-07T08:17:09.944Z level=INFO msg="Uploading fqhxni8jcvyf5id4rvg9x2y00qx1963d-libidn2-2.3.8 (366.1KB)"1804server # time=2026-07-07T08:17:09.946Z level=INFO msg="Uploading 020cvdgp5va6j1mdz75s2nzfz25k37v2-libunistring-1.4.2 (2.0MB)"1805server # time=2026-07-07T08:17:09.950Z level=INFO msg="Uploading jp8avbmpfcdnm0axwrzyk072nmq9cr0d-glibc-2.42-67 (44.4MB)"1806server # time=2026-07-07T08:17:09.953Z level=INFO msg="Uploading wp59zwnmv6h2glrrb9rd7siprz1mxn6r-xgcc-15.2.0-libgcc (150.1KB)"1807server # time=2026-07-07T08:17:09.954Z level=INFO msg="Uploading qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3 (287.5KB)"1808server # [ 32.098029] niks3-server[940]: 2026/07/07 08:17:11 INFO Received complete multipart upload request method=POST path=/api/multipart/complete1809server # [ 32.114539] niks3-server[940]: 2026/07/07 08:17:11 INFO Completed multipart upload object_key=nar/0n9jhh8wlbk6hqhzsklzl8vbv6xab1d7yi91hr9z948fzw5s80jd.nar.zst upload_id=ZWFhZjIyMjktMDM5NC00NGI0LWE1YTQtOWY5NjU1NzBkNmEwLmQ2YWIyYjM0LWRiYTEtNDNiZS05ZGQzLTJhMTg4ZjEwNjNhNXgxNzgzNDEyMjI5OTM4OTYzMTYw parts=11810server # time=2026-07-07T08:17:11.730Z level=INFO msg="Uploading 5 narinfos"1811server # [ 32.124441] niks3-server[940]: 2026/07/07 08:17:11 INFO Received sign narinfos request method=POST path=/api/pending_closures/1/sign1812server # [ 32.126258] niks3-server[940]: 2026/07/07 08:17:11 INFO Signed narinfos id=1 count=51813server # [ 32.138192] niks3-server[940]: 2026/07/07 08:17:11 INFO Received complete upload request method=POST path=/api/pending_closures/1/complete1814server # time=2026-07-07T08:17:11.752Z level=INFO msg="Upload complete. (1.916s)"1815server # [ 32.145856] niks3-server[940]: 2026/07/07 08:17:11 INFO Completed upload id=11816server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 2.08 seconds)1817server: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token1818server: (finished: must succeed: echo -n 'invalid-token' > /tmp/test-config/invalid-token, in 0.02 seconds)1819server: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31820server # [ 32.350376] niks3-server[940]: 2026/07/07 08:17:11 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]1821server # time=2026-07-07T08:17:11.961Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1822server: (finished: must fail: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/invalid-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3, in 0.19 seconds)1823server: waiting for unit nginx.service1824server: (finished: waiting for unit nginx.service, in 0.06 seconds)1825server: waiting for TCP port 443 on localhost1826server # Connection to localhost (::1) 443 port [tcp/https] succeeded!1827server: (finished: waiting for TCP port 443 on localhost, in 0.03 seconds)1828server: must succeed: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.31829server # time=2026-07-07T08:17:12.159Z 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.pem1830server # [ 32.649121] niks3-server[940]: 2026/07/07 08:17:12 INFO Received uploads request method=POST path=/api/pending_closures1831server # time=2026-07-07T08:17:12.261Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1832server # [ 32.655741] niks3-server[940]: 2026/07/07 08:17:12 INFO Received complete upload request method=POST path=/api/pending_closures/2/complete1833server # time=2026-07-07T08:17:12.266Z level=INFO msg="Upload complete. (102ms)"1834server # [ 32.660074] niks3-server[940]: 2026/07/07 08:17:12 INFO Completed upload id=21835server: (finished: must succeed: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.21 seconds)1836server: must fail: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.31837server # time=2026-07-07T08:17:12.293Z 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)"1838server: (finished: must fail: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.03 seconds)1839server: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.31840server # time=2026-07-07T08:17:12.397Z level=INFO msg="Configuring client TLS" cert="" key="" ca=/etc/niks3-test-certs/ca.pem1841server # [ 32.872656] niks3-server[940]: 2026/07/07 08:17:12 INFO Received uploads request method=POST path=/api/pending_closures1842server # time=2026-07-07T08:17:12.487Z level=INFO msg="Uploading 0 paths to server (5 already cached)"1843server # [ 32.883453] niks3-server[940]: 2026/07/07 08:17:12 INFO Received complete upload request method=POST path=/api/pending_closures/3/complete1844server # time=2026-07-07T08:17:12.494Z level=INFO msg="Upload complete. (95ms)"1845server # [ 32.888095] niks3-server[940]: 2026/07/07 08:17:12 INFO Completed upload id=31846server: (finished: must succeed: NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.20 seconds)1847server: 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'1848server # -----1849server: (finished: must succeed: cd /etc/niks3-test-certs && /nix/store/y2wn0af8r6l6r44r407091nbzgy7aw8z-openssl-3.6.2-bin/bin/openssl req -newkey ec -pkeyopt ec_paramgen_curve:prime256v1 -nodes -keyout other.key -out other.csr -subj '/CN=other client', in 0.03 seconds)1850server: 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.pem1851server # Certificate request self-signature ok1852server # subject=CN=other client1853server: (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)1854server: must fail: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.31855server # time=2026-07-07T08:17:12.673Z 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.pem1856server # [ 33.151786] niks3-server[940]: 2026/07/07 08:17:12 WARN mTLS auth: subject not in bound subjects subject="CN=other client"1857server # time=2026-07-07T08:17:12.762Z level=ERROR msg="Fatal error" error="pushing paths: creating pending closures: creating pending closure: server returned 401: Unauthorized\n"1858server: (finished: must fail: /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-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.19 seconds)1859server: must succeed: mkdir -p /tmp/test-store1860server: (finished: must succeed: mkdir -p /tmp/test-store, in 0.03 seconds)1861server: must succeed: 1862 export AWS_ACCESS_KEY_ID=rustfsadmin1863export AWS_SECRET_ACCESS_KEY=rustfsadmin1864 nix copy --from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.318651866server # copying 5 paths...1867server # copying path '/nix/store/020cvdgp5va6j1mdz75s2nzfz25k37v2-libunistring-1.4.2' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1868server # copying path '/nix/store/fqhxni8jcvyf5id4rvg9x2y00qx1963d-libidn2-2.3.8' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1869server # copying path '/nix/store/wp59zwnmv6h2glrrb9rd7siprz1mxn6r-xgcc-15.2.0-libgcc' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1870server # copying path '/nix/store/jp8avbmpfcdnm0axwrzyk072nmq9cr0d-glibc-2.42-67' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1871server # copying path '/nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.3' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1872server: (finished: must succeed: 1873 export AWS_ACCESS_KEY_ID=rustfsadmin1874export AWS_SECRET_ACCESS_KEY=rustfsadmin1875 nix copy --from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' --to /tmp/test-store /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.31876, in 0.51 seconds)1877server: must succeed: 1878cat > /tmp/test-drv.nix << 'EOF'1879derivation {1880 name = "test-build-log";1881 system = builtins.currentSystem;1882 builder = "/bin/sh";1883 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1884}1885EOF18861887server: (finished: must succeed: 1888cat > /tmp/test-drv.nix << 'EOF'1889derivation {1890 name = "test-build-log";1891 system = builtins.currentSystem;1892 builder = "/bin/sh";1893 args = [ "-c" "echo 'test build log output'; echo 'hello world' > $out" ];1894}1895EOF1896, in 0.03 seconds)1897server: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix1898server # this derivation will be built:1899server # /nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv1900server # building '/nix/store/04bylz4wv9mr41hs78kv5ygm2d5xg9k9-test-build-log.drv'...1901server # test-build-log> test build log output1902server: (finished: must succeed: nix-build --log-format bar-with-logs /tmp/test-drv.nix, in 0.23 seconds)1903server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1904server # [ 34.156292] niks3-server[940]: 2026/07/07 08:17:13 INFO Received uploads request method=POST path=/api/pending_closures1905server # time=2026-07-07T08:17:13.777Z level=INFO msg="Uploading 1 paths to server (0 already cached)"1906server # time=2026-07-07T08:17:13.778Z level=INFO msg="Uploading z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log (128B)"1907server # [ 34.183535] niks3-server[940]: 2026/07/07 08:17:13 INFO Received sign narinfos request method=POST path=/api/pending_closures/4/sign1908server # time=2026-07-07T08:17:13.792Z level=INFO msg="Uploading 1 narinfos"1909server # [ 34.186912] niks3-server[940]: 2026/07/07 08:17:13 INFO Signed narinfos id=4 count=11910server # [ 34.190863] niks3-server[940]: 2026/07/07 08:17:13 INFO Received complete upload request method=POST path=/api/pending_closures/4/complete1911server # time=2026-07-07T08:17:13.800Z level=INFO msg="Upload complete. (118ms)"1912server # [ 34.194181] niks3-server[940]: 2026/07/07 08:17:13 INFO Completed upload id=41913server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log, in 0.24 seconds)1914server: must succeed: 1915 export AWS_ACCESS_KEY_ID=rustfsadmin1916export AWS_SECRET_ACCESS_KEY=rustfsadmin1917 nix log --store 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log19181919server # got build log for '/nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'1920server: (finished: must succeed: 1921 export AWS_ACCESS_KEY_ID=rustfsadmin1922export AWS_SECRET_ACCESS_KEY=rustfsadmin1923 nix log --store 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log1924, in 0.16 seconds)1925server: must succeed: 1926cat > /tmp/ca-test.nix << 'EOF'1927derivation {1928 name = "ca-test";1929 system = builtins.currentSystem;1930 builder = "/bin/sh";1931 args = [ "-c" "echo 'Hello from CA derivation' > $out" ];1932 __contentAddressed = true;1933 outputHashMode = "recursive";1934 outputHashAlgo = "sha256";1935}1936EOF19371938server: (finished: must succeed: 1939cat > /tmp/ca-test.nix << 'EOF'1940derivation {1941 name = "ca-test";1942 system = builtins.currentSystem;1943 builder = "/bin/sh";1944 args = [ "-c" "echo 'Hello from CA derivation' > $out" ];1945 __contentAddressed = true;1946 outputHashMode = "recursive";1947 outputHashAlgo = "sha256";1948}1949EOF1950, in 0.03 seconds)1951server: must succeed: nix-build --log-format bar-with-logs /tmp/ca-test.nix --no-out-link1952server # this derivation will be built:1953server # /nix/store/8j226mdc8yhan5fv0s31bbzx0iiny3pa-ca-test.drv1954server # building '/nix/store/8j226mdc8yhan5fv0s31bbzx0iiny3pa-ca-test.drv'...1955server: (finished: must succeed: nix-build --log-format bar-with-logs /tmp/ca-test.nix --no-out-link, in 0.20 seconds)1956server: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test1957server # [ 34.829826] niks3-server[940]: 2026/07/07 08:17:14 INFO Received uploads request method=POST path=/api/pending_closures1958server # time=2026-07-07T08:17:14.440Z level=INFO msg="Uploading 1 paths to server (0 already cached)"1959server # time=2026-07-07T08:17:14.442Z level=INFO msg="Uploading 5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test (144B)"1960server # [ 34.845320] niks3-server[940]: 2026/07/07 08:17:14 INFO Received sign narinfos request method=POST path=/api/pending_closures/5/sign1961server # time=2026-07-07T08:17:14.454Z level=INFO msg="Uploading 1 narinfos"1962server # [ 34.848502] niks3-server[940]: 2026/07/07 08:17:14 INFO Signed narinfos id=5 count=11963server # [ 34.852441] niks3-server[940]: 2026/07/07 08:17:14 INFO Received complete upload request method=POST path=/api/pending_closures/5/complete1964server # time=2026-07-07T08:17:14.461Z level=INFO msg="Upload complete. (175ms)"1965server # [ 34.855592] niks3-server[940]: 2026/07/07 08:17:14 INFO Completed upload id=51966server: (finished: must succeed: NIKS3_SERVER_URL=http://server:5751 NIKS3_AUTH_TOKEN_FILE=/tmp/test-config/auth-token /nix/store/xpvqkjf5qfnwa90538299wai62qi10kb-niks3-1.7.0/bin/niks3 push /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test, in 0.28 seconds)1967server: must succeed: mkdir -p /tmp/chroot-store1968server: (finished: must succeed: mkdir -p /tmp/chroot-store, in 0.03 seconds)1969server: must succeed: 1970 export AWS_ACCESS_KEY_ID=rustfsadmin1971export AWS_SECRET_ACCESS_KEY=rustfsadmin1972 nix copy --from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' --to /tmp/chroot-store /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test19731974server # copying 1 paths...1975server # copying path '/nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test' from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1'...1976server: (finished: must succeed: 1977 export AWS_ACCESS_KEY_ID=rustfsadmin1978export AWS_SECRET_ACCESS_KEY=rustfsadmin1979 nix copy --from 's3://niks3-test?endpoint=http://server:9000&region=us-east-1' --to /tmp/chroot-store /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test1980, in 0.18 seconds)1981server: must succeed: nix --store /tmp/chroot-store store cat /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test1982server: (finished: must succeed: nix --store /tmp/chroot-store store cat /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test, in 0.09 seconds)1983server: must succeed: nix --store /tmp/chroot-store realisation info /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test1984server: (finished: must succeed: nix --store /tmp/chroot-store realisation info /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test, in 0.09 seconds)1985server: must succeed: readlink /etc/niks3-test/symlink-wrapper1986server: (finished: must succeed: readlink /etc/niks3-test/symlink-wrapper, in 0.03 seconds)1987server: must succeed: readlink /etc/static/niks3-test/symlink-wrapper1988server: (finished: must succeed: readlink /etc/static/niks3-test/symlink-wrapper, in 0.03 seconds)1989server: must succeed: test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper1990server: output: 1991!!! Traceback (most recent call last):1992!!! File "<string>", line 139, in <module>1993!!! server.succeed(f"test -L {symlink_wrapper}")1994!!! 1995!!! RequestedAssertionFailed: command `test -L /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper` failed (exit code 1)1996cleanup1997kill QemuMachine (pid 14)1998builder # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)1999kill QemuMachine (pid 15)2000server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/smwd56pl54f0pcjdspgh5vnf20c8xwsc-python3-3.13.13/bin/python3.13)2001(finished: cleanup, in 0.48 seconds)2002additionally exposed symbols:2003 builder, server,2004 vlan1,2005 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_ssh2006Hello store path: /nix/store/qpp9968dpkv1c755nk13mrkrzpsvah18-hello-2.12.32007Test output path: /nix/store/z57vvdhnnry9vypazxb33pyi7hsaz71i-test-build-log2008CA derivation output path: /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test2009Realisation info in chroot store: /nix/store/5v8l1dc99hcg2ss10dgkivlhwbkpppjh-ca-test20102011Symlink wrapper store path: /nix/store/pvdx502yvdpvia8734qkyzlwik5fyglv-symlink-wrapper