these 16 derivations will be built: /nix/store/vxhr74ww14ppcxsa95kc14hs11q17387-system-path.drv /nix/store/hk26m60bfmlg3mb68ibmlhimiv53ygzi-dbus-1.drv /nix/store/m7wzq2fi89rv5x7rpw04z84czs7divjv-X-Restart-Triggers-dbus-broker.drv /nix/store/sjc9hzys0awx4s7w36w1blp3lyp8yd8a-unit-dbus-broker.service.drv /nix/store/pmw04i2lyrm6ywxlsk651hixmpmm66vz-system-units.drv /nix/store/sagbd06z834n1k6ih9afy2has5p7dms2-unit-dbus-broker.service.drv /nix/store/pwj965l9504km4wjvk0irhibci6vx7mm-user-units.drv /nix/store/k952mnhi28gjb87wik9bzy3cqz0k0dsw-etc.drv /nix/store/agfi443sm47vafiw3imxacy1n05z0b11-activate.drv /nix/store/33i7rwj80pjqnyxi9jrqr63hn7gxq71s-nixos-system-server-test.drv /nix/store/3lww410hs630xdbd6l9g28gaiq9lzlxm-closure-info.drv /nix/store/cyfbr4hy7zgshqi4gcykwlhf8vidphqa-run-nixos-vm.drv /nix/store/ddg7xask44ajf5jlp5yxji34ihm7b1y7-nixos-vm.drv /nix/store/fx1hrg2m399v6vj50yvvkg7dl7mq0s8a-driverConfiguration.json.drv /nix/store/15g0700kgq7xhv02zy75gljk9hkbrfy4-nixos-test-driver-docker.drv /nix/store/b3d5wy7k37ivbspk2bhm8alrwy9s6687-vm-test-run-docker.drv building '/nix/store/vxhr74ww14ppcxsa95kc14hs11q17387-system-path.drv' system-path> tribuchet: building on eliza system-path> structuredAttrs is enabled system-path> created 6805 symlinks in user environment system-path> install-info: warning: no info dir entry in `/nix/store/lwsgwjdrin5hplqwrqm04hzn79wiih09-system-path/share/info/notes.info' building '/nix/store/hk26m60bfmlg3mb68ibmlhimiv53ygzi-dbus-1.drv' dbus-1> tribuchet: building on eliza building '/nix/store/m7wzq2fi89rv5x7rpw04z84czs7divjv-X-Restart-Triggers-dbus-broker.drv' X-Restart-Triggers-dbus-broker> tribuchet: building on eliza building '/nix/store/sagbd06z834n1k6ih9afy2has5p7dms2-unit-dbus-broker.service.drv' building '/nix/store/sjc9hzys0awx4s7w36w1blp3lyp8yd8a-unit-dbus-broker.service.drv' unit-dbus-broker.service> tribuchet: building on eliza unit-dbus-broker.service> tribuchet: building on eliza building '/nix/store/pmw04i2lyrm6ywxlsk651hixmpmm66vz-system-units.drv' building '/nix/store/pwj965l9504km4wjvk0irhibci6vx7mm-user-units.drv' system-units> tribuchet: building on eliza user-units> tribuchet: building on eliza building '/nix/store/k952mnhi28gjb87wik9bzy3cqz0k0dsw-etc.drv' etc> tribuchet: building on eliza building '/nix/store/agfi443sm47vafiw3imxacy1n05z0b11-activate.drv' activate> tribuchet: building on eliza building '/nix/store/33i7rwj80pjqnyxi9jrqr63hn7gxq71s-nixos-system-server-test.drv' nixos-system-server-test> tribuchet: building on eliza building '/nix/store/3lww410hs630xdbd6l9g28gaiq9lzlxm-closure-info.drv' closure-info> tribuchet: building on eliza closure-info> structuredAttrs is enabled building '/nix/store/cyfbr4hy7zgshqi4gcykwlhf8vidphqa-run-nixos-vm.drv' run-nixos-vm> tribuchet: building on eliza building '/nix/store/ddg7xask44ajf5jlp5yxji34ihm7b1y7-nixos-vm.drv' nixos-vm> tribuchet: building on eliza building '/nix/store/fx1hrg2m399v6vj50yvvkg7dl7mq0s8a-driverConfiguration.json.drv' driverConfiguration.json> tribuchet: building on eliza building '/nix/store/15g0700kgq7xhv02zy75gljk9hkbrfy4-nixos-test-driver-docker.drv' nixos-test-driver-docker> tribuchet: building on eliza nixos-test-driver-docker> Running type check (enable/disable: config.skipTypeCheck) nixos-test-driver-docker> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck nixos-test-driver-docker> All checks passed! nixos-test-driver-docker> Linting test script (enable/disable: config.skipLint) nixos-test-driver-docker> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint nixos-test-driver-docker> All checks passed! Failed to find a machine for remote build! derivation: b3d5wy7k37ivbspk2bhm8alrwy9s6687-vm-test-run-docker.drv required (system, features): (aarch64-linux, [kvm, nixos-test]) 1 available machines: (systems, maxjobs, supportedFeatures, mandatoryFeatures) ([aarch64-darwin, x86_64-darwin], 8, [big-parallel, recursive-nix], []) building '/nix/store/b3d5wy7k37ivbspk2bhm8alrwy9s6687-vm-test-run-docker.drv' vm-test-run-docker> tribuchet: building on eliza vm-test-run-docker> Machine state will be reset. To keep it, pass --keep-machine-state vm-test-run-docker> start all VLans vm-test-run-docker> (finished: start all VLans, in 0.00 seconds) vm-test-run-docker> Test will time out and terminate in 3600 seconds vm-test-run-docker> run the VM test script vm-test-run-docker> start all VMs vm-test-run-docker> server: starting vm vm-test-run-docker> server: QEMU running (pid 13) vm-test-run-docker> server # Disk image does not exist, creating the virtualisation disk image... vm-test-run-docker> server # Formatting '/build/vm-state-server/tmp.qwEOhbrNce', fmt=raw size=1073741824 vm-test-run-docker> server # mke2fs 1.47.3 (8-Jul-2025) vm-test-run-docker> server # Discarding device blocks: 0/262144 done vm-test-run-docker> (finished: start all VMs, in 0.46 seconds) vm-test-run-docker> server # Creating filesystem with 262144 4k blocks and 65536 inodes vm-test-run-docker> server: waiting for unit docker-busybox.service vm-test-run-docker> server # Filesystem UUID: 695c54f7-d253-4c0a-90b3-675bd5090905 vm-test-run-docker> server: waiting for the VM to finish booting vm-test-run-docker> server # Superblock backups stored on blocks: vm-test-run-docker> server # 32768, 98304, 163840, 229376 vm-test-run-docker> server # vm-test-run-docker> server # Allocating group tables: 0/8 done vm-test-run-docker> server # Writing inode tables: 0/8 done vm-test-run-docker> server # Creating journal (8192 blocks): done vm-test-run-docker> server # Writing superblocks and filesystem accounting information: 0/8 done vm-test-run-docker> server # vm-test-run-docker> server # Virtualisation disk image created. vm-test-run-docker> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40] vm-test-run-docker> server # [ 0.000000] Linux version 6.18.31 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri May 15 12:52:18 UTC 2026 vm-test-run-docker> server # [ 0.000000] KASLR enabled vm-test-run-docker> server # [ 0.000000] random: crng init done vm-test-run-docker> server # [ 0.000000] Machine model: linux,dummy-virt vm-test-run-docker> server # [ 0.000000] efi: UEFI not found. vm-test-run-docker> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT vm-test-run-docker> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-docker> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf] vm-test-run-docker> server # [ 0.000000] Zone ranges: vm-test-run-docker> server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-docker> server # [ 0.000000] DMA32 empty vm-test-run-docker> server # [ 0.000000] Normal empty vm-test-run-docker> server # [ 0.000000] Device empty vm-test-run-docker> server # [ 0.000000] Movable zone start for each node vm-test-run-docker> server # [ 0.000000] Early memory node ranges vm-test-run-docker> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-docker> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff] vm-test-run-docker> server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000 vm-test-run-docker> server # [ 0.000000] psci: probing for conduit method from DT. vm-test-run-docker> server # [ 0.000000] psci: PSCIv1.3 detected in firmware. vm-test-run-docker> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs vm-test-run-docker> server # [ 0.000000] psci: Trusted OS migration not required vm-test-run-docker> server # [ 0.000000] psci: SMC Calling Convention v1.1 vm-test-run-docker> server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) vm-test-run-docker> server # [ 0.000000] percpu: Embedded 76 pages/cpu s185880 r8192 d117224 u311296 vm-test-run-docker> server # [ 0.000000] Detected PIPT I-cache on CPU0 vm-test-run-docker> server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm) vm-test-run-docker> server # [ 0.000000] CPU features: detected: GICv3 CPU interface vm-test-run-docker> server # [ 0.000000] CPU features: detected: Spectre-v4 vm-test-run-docker> server # [ 0.000000] CPU features: detected: Spectre-BHB vm-test-run-docker> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38 vm-test-run-docker> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23 vm-test-run-docker> server # [ 0.000000] alternatives: applying boot alternatives vm-test-run-docker> server # [ 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/2fndakxhm11kq8wkp0v4macadsw7dmw4-nixos-system-server-test/init regInfo=/nix/store/d5lwabw6sgpddd1p27mc4489zc0qbky8-closure-info/registration console=ttyAMA0,115200n8 console=tty0 vm-test-run-docker> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/d5lwabw6sgpddd1p27mc4489zc0qbky8-closure-info/registration", will be passed to user space. vm-test-run-docker> server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes vm-test-run-docker> server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) vm-test-run-docker> server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) vm-test-run-docker> server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB vm-test-run-docker> server # [ 0.000000] software IO TLB: area num 1. vm-test-run-docker> server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB) vm-test-run-docker> server # [ 0.000000] Fallback order for Node 0: 0 vm-test-run-docker> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144 vm-test-run-docker> server # [ 0.000000] Policy zone: DMA vm-test-run-docker> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off vm-test-run-docker> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 vm-test-run-docker> server # [ 0.000000] allocated 2097152 bytes of page_ext vm-test-run-docker> server # [ 0.000000] ftrace: allocating 74663 entries in 292 pages vm-test-run-docker> server # [ 0.000000] ftrace: allocated 292 pages with 3 groups vm-test-run-docker> server # [ 0.000000] rcu: Hierarchical RCU implementation. vm-test-run-docker> server # [ 0.000000] rcu: RCU event tracing is enabled. vm-test-run-docker> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. vm-test-run-docker> server # [ 0.000000] Trampoline variant of Tasks RCU enabled. vm-test-run-docker> server # [ 0.000000] Rude variant of Tasks RCU enabled. vm-test-run-docker> server # [ 0.000000] Tracing variant of Tasks RCU enabled. vm-test-run-docker> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. vm-test-run-docker> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 vm-test-run-docker> server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-docker> server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-docker> server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. vm-test-run-docker> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 vm-test-run-docker> server # [ 0.000000] GICv3: 256 SPIs implemented vm-test-run-docker> server # [ 0.000000] GICv3: 0 Extended SPIs implemented vm-test-run-docker> server # [ 0.000000] Root IRQ handler: gic_handle_irq vm-test-run-docker> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI vm-test-run-docker> server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0 vm-test-run-docker> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 vm-test-run-docker> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff] vm-test-run-docker> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1) vm-test-run-docker> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1) vm-test-run-docker> server # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000 vm-test-run-docker> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000 vm-test-run-docker> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention. vm-test-run-docker> server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt). vm-test-run-docker> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns vm-test-run-docker> server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns vm-test-run-docker> server # [ 0.000031] arm-pv: using stolen time PV vm-test-run-docker> server # [ 0.000411] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) vm-test-run-docker> server # [ 0.000553] Console: colour dummy device 80x25 vm-test-run-docker> server # [ 0.000560] printk: legacy console [tty0] enabled vm-test-run-docker> server # [ 0.000764] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000) vm-test-run-docker> server # [ 0.000771] pid_max: default: 32768 minimum: 301 vm-test-run-docker> server # [ 0.000858] LSM: initializing lsm=capability,landlock,yama,bpf,ima vm-test-run-docker> server # [ 0.001012] landlock: Up and running. vm-test-run-docker> server # [ 0.001015] Yama: becoming mindful. vm-test-run-docker> server # [ 0.001468] LSM support for eBPF active vm-test-run-docker> server # [ 0.001579] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-docker> server # [ 0.001597] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) vm-test-run-docker> server # [ 0.002660] cacheinfo: Unable to detect cache hierarchy for CPU 0 vm-test-run-docker> server # [ 0.003354] rcu: Hierarchical SRCU implementation. vm-test-run-docker> server # [ 0.003357] rcu: Max phase no-delay instances is 1000. vm-test-run-docker> server # [ 0.004494] fsl-mc MSI: its@8080000 domain created vm-test-run-docker> server # [ 0.004597] EFI services will not be available. vm-test-run-docker> server # [ 0.004660] smp: Bringing up secondary CPUs ... vm-test-run-docker> server # [ 0.004668] smp: Brought up 1 node, 1 CPU vm-test-run-docker> server # [ 0.004671] SMP: Total of 1 processors activated. vm-test-run-docker> server # [ 0.004674] CPU: All CPU(s) started at EL1 vm-test-run-docker> server # [ 0.004684] CPU features: detected: Branch Target Identification vm-test-run-docker> server # [ 0.004692] CPU features: detected: ARMv8.4 Translation Table Level vm-test-run-docker> server # [ 0.004695] CPU features: detected: Instruction cache invalidation not required for I/D coherence vm-test-run-docker> server # [ 0.004698] CPU features: detected: Data cache clean to the PoU not required for I/D coherence vm-test-run-docker> server # [ 0.004702] CPU features: detected: Common not Private translations vm-test-run-docker> server # [ 0.004705] CPU features: detected: CRC32 instructions vm-test-run-docker> server # [ 0.004708] CPU features: detected: Data cache clean to Point of Deep Persistence vm-test-run-docker> server # [ 0.004711] CPU features: detected: Data cache clean to Point of Persistence vm-test-run-docker> server # [ 0.004714] CPU features: detected: Data independent timing control (DIT) vm-test-run-docker> server # [ 0.004717] CPU features: detected: E0PD vm-test-run-docker> server # [ 0.004720] CPU features: detected: Enhanced Counter Virtualization vm-test-run-docker> server # [ 0.004723] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF) vm-test-run-docker> server # [ 0.004747] CPU features: detected: Enhanced Virtualization Traps vm-test-run-docker> server # [ 0.004750] CPU features: detected: Fine Grained Traps vm-test-run-docker> server # [ 0.004753] CPU features: detected: Generic authentication (architected QARMA5 algorithm) vm-test-run-docker> server # [ 0.004758] CPU features: detected: RCpc load-acquire (LDAPR) vm-test-run-docker> server # [ 0.004761] CPU features: detected: LSE atomic instructions vm-test-run-docker> server # [ 0.004764] CPU features: detected: Privileged Access Never vm-test-run-docker> server # [ 0.004767] CPU features: detected: PMUv3 vm-test-run-docker> server # [ 0.004769] CPU features: detected: RAS Extension Support vm-test-run-docker> server # [ 0.004772] CPU features: detected: RASv1p1 Extension Support vm-test-run-docker> server # [ 0.004775] CPU features: detected: Random Number Generator vm-test-run-docker> server # [ 0.004778] CPU features: detected: Speculation barrier (SB) vm-test-run-docker> server # [ 0.004780] CPU features: detected: Stage-2 Force Write-Back vm-test-run-docker> server # [ 0.004783] CPU features: detected: TLB range maintenance instructions vm-test-run-docker> server # [ 0.004788] CPU features: detected: Speculative Store Bypassing Safe (SSBS) vm-test-run-docker> server # [ 0.004824] alternatives: applying system-wide alternatives vm-test-run-docker> server # [ 0.007742] CPU features: detected: BBM Level 2 without TLB conflict abort vm-test-run-docker> server # [ 0.007935] Memory: 895312K/1048576K available (24256K kernel code, 7078K rwdata, 26296K rodata, 4736K init, 1102K bss, 112000K reserved, 32768K cma-reserved) vm-test-run-docker> server # [ 0.008253] devtmpfs: initialized vm-test-run-docker> server # [ 0.009935] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns vm-test-run-docker> server # [ 0.009957] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-docker> server # [ 0.009976] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear). vm-test-run-docker> server # [ 0.010159] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL vm-test-run-docker> server # [ 0.010163] 0 pages in range for non-PLT usage vm-test-run-docker> server # [ 0.010164] 508368 pages in range for PLT usage vm-test-run-docker> server # [ 0.010276] pinctrl core: initialized pinctrl subsystem vm-test-run-docker> server # [ 0.011017] DMI not present or invalid. vm-test-run-docker> server # [ 0.013883] NET: Registered PF_NETLINK/PF_ROUTE protocol family vm-test-run-docker> server # [ 0.015891] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations vm-test-run-docker> server # [ 0.016074] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations vm-test-run-docker> server # [ 0.016251] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations vm-test-run-docker> server # [ 0.016270] audit: initializing netlink subsys (disabled) vm-test-run-docker> server # [ 0.017070] thermal_sys: Registered thermal governor 'fair_share' vm-test-run-docker> server # [ 0.017072] thermal_sys: Registered thermal governor 'bang_bang' vm-test-run-docker> server # [ 0.017076] thermal_sys: Registered thermal governor 'step_wise' vm-test-run-docker> server # [ 0.017078] thermal_sys: Registered thermal governor 'user_space' vm-test-run-docker> server # [ 0.017084] thermal_sys: Registered thermal governor 'power_allocator' vm-test-run-docker> server # [ 0.017116] audit: type=2000 audit(0.016:1): state=initialized audit_enabled=0 res=1 vm-test-run-docker> server # [ 0.017127] cpuidle: using governor ladder vm-test-run-docker> server # [ 0.017133] cpuidle: using governor menu vm-test-run-docker> server # [ 0.017325] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers. vm-test-run-docker> server # [ 0.017340] ASID allocator initialised with 65536 entries vm-test-run-docker> server # [ 0.018503] Serial: AMBA PL011 UART driver vm-test-run-docker> server # [ 0.023591] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1 vm-test-run-docker> server # [ 0.023742] printk: console [ttyAMA0] enabled vm-test-run-docker> server # [ 0.149465] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages vm-test-run-docker> server # [ 0.149485] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page vm-test-run-docker> server # [ 0.149490] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages vm-test-run-docker> server # [ 0.149495] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page vm-test-run-docker> server # [ 0.149499] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages vm-test-run-docker> server # [ 0.149503] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page vm-test-run-docker> server # [ 0.149508] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages vm-test-run-docker> server # [ 0.149512] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page vm-test-run-docker> server # [ 0.157309] fbcon: Taking over console vm-test-run-docker> server # [ 0.157325] ACPI: Interpreter disabled. vm-test-run-docker> server # [ 0.166304] iommu: Default domain type: Translated vm-test-run-docker> server # [ 0.166315] iommu: DMA domain TLB invalidation policy: strict mode vm-test-run-docker> server # [ 0.166687] SCSI subsystem initialized vm-test-run-docker> server # [ 0.168768] usbcore: registered new interface driver usbfs vm-test-run-docker> server # [ 0.168796] usbcore: registered new interface driver hub vm-test-run-docker> server # [ 0.168813] usbcore: registered new device driver usb vm-test-run-docker> server # [ 0.169080] pps_core: LinuxPPS API ver. 1 registered vm-test-run-docker> server # [ 0.169086] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti vm-test-run-docker> server # [ 0.169096] PTP clock support registered vm-test-run-docker> server # [ 0.169145] EDAC MC: Ver: 3.0.0 vm-test-run-docker> server # [ 0.174114] scmi_core: SCMI protocol bus registered vm-test-run-docker> server # [ 0.175143] FPGA manager framework vm-test-run-docker> server # [ 0.176119] vgaarb: loaded vm-test-run-docker> server # [ 0.176760] clocksource: Switched to clocksource arch_sys_counter vm-test-run-docker> server # [ 0.177172] VFS: Disk quotas dquot_6.6.0 vm-test-run-docker> server # [ 0.177203] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) vm-test-run-docker> server # [ 0.179759] netfs: FS-Cache loaded vm-test-run-docker> server # [ 0.179874] pnp: PnP ACPI: disabled vm-test-run-docker> server # [ 0.187296] NET: Registered PF_INET protocol family vm-test-run-docker> server # [ 0.187452] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) vm-test-run-docker> server # [ 0.216336] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) vm-test-run-docker> server # [ 0.216378] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) vm-test-run-docker> server # [ 0.216401] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) vm-test-run-docker> server # [ 0.216446] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) vm-test-run-docker> server # [ 0.216521] TCP: Hash tables configured (established 8192 bind 8192) vm-test-run-docker> server # [ 0.216600] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) vm-test-run-docker> server # [ 0.216652] UDP hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-docker> server # [ 0.216702] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear) vm-test-run-docker> server # [ 0.224302] NET: Registered PF_UNIX/PF_LOCAL protocol family vm-test-run-docker> server # [ 0.224325] NET: Registered PF_XDP protocol family vm-test-run-docker> server # [ 0.224344] PCI: CLS 0 bytes, default 64 vm-test-run-docker> server # [ 0.226531] Trying to unpack rootfs image as initramfs... vm-test-run-docker> server # [ 0.233490] kvm [1]: HYP mode not available vm-test-run-docker> server # [ 0.325288] Initialise system trusted keyrings vm-test-run-docker> server # [ 0.326043] workingset: timestamp_bits=42 max_order=18 bucket_order=0 vm-test-run-docker> server # [ 0.327327] squashfs: version 4.0 (2009/01/31) Phillip Lougher vm-test-run-docker> server # [ 0.328128] 9p: Installing v9fs 9p2000 file system support vm-test-run-docker> server # [ 0.356865] Key type asymmetric registered vm-test-run-docker> server # [ 0.356891] Asymmetric key parser 'x509' registered vm-test-run-docker> server # [ 0.356965] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242) vm-test-run-docker> server # [ 0.359136] io scheduler mq-deadline registered vm-test-run-docker> server # [ 0.359146] io scheduler kyber registered vm-test-run-docker> server # [ 0.368909] pl061_gpio 9030000.pl061: PL061 GPIO chip registered vm-test-run-docker> server # [ 0.370333] ledtrig-cpu: registered to indicate activity on CPUs vm-test-run-docker> server # [ 0.370715] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges: vm-test-run-docker> server # [ 0.370731] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000 vm-test-run-docker> server # [ 0.370742] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000 vm-test-run-docker> server # [ 0.370751] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 vm-test-run-docker> server # [ 0.370772] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits vm-test-run-docker> server # [ 0.370795] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] vm-test-run-docker> server # [ 0.370877] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00 vm-test-run-docker> server # [ 0.370886] pci_bus 0000:00: root bus resource [bus 00-ff] vm-test-run-docker> server # [ 0.370892] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] vm-test-run-docker> server # [ 0.370898] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] vm-test-run-docker> server # [ 0.370904] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] vm-test-run-docker> server # [ 0.370967] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint vm-test-run-docker> server # [ 0.371408] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-docker> server # [ 0.371594] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.371611] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.371640] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.371657] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-docker> server # [ 0.372122] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-docker> server # [ 0.372304] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.372319] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.372350] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.392514] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-docker> server # [ 0.392699] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f] vm-test-run-docker> server # [ 0.392715] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.392755] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.396438] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-docker> server # [ 0.396622] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.396638] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.396667] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.405225] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint vm-test-run-docker> server # [ 0.405432] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.405450] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.405479] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.405943] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint vm-test-run-docker> server # [ 0.406125] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f] vm-test-run-docker> server # [ 0.406140] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.406171] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.406627] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint vm-test-run-docker> server # [ 0.406811] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.406827] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.406856] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.406872] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref] vm-test-run-docker> server # [ 0.407344] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint vm-test-run-docker> server # [ 0.407530] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.407560] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.408016] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint vm-test-run-docker> server # [ 0.408201] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.408231] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.408622] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint vm-test-run-docker> server # [ 0.425729] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.425988] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint vm-test-run-docker> server # [ 0.426278] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f] vm-test-run-docker> server # [ 0.426296] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.426326] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.426787] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint vm-test-run-docker> server # [ 0.426969] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f] vm-test-run-docker> server # [ 0.426985] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff] vm-test-run-docker> server # [ 0.427015] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref] vm-test-run-docker> server # [ 0.427617] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned vm-test-run-docker> server # [ 0.427628] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned vm-test-run-docker> server # [ 0.427634] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427680] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427728] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427776] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427823] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427869] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427916] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned vm-test-run-docker> server # [ 0.427963] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned vm-test-run-docker> server # [ 0.428010] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.428056] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned vm-test-run-docker> server # [ 0.428127] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned vm-test-run-docker> server # [ 0.428174] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned vm-test-run-docker> server # [ 0.428195] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned vm-test-run-docker> server # [ 0.428217] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned vm-test-run-docker> server # [ 0.428239] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned vm-test-run-docker> server # [ 0.428261] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned vm-test-run-docker> server # [ 0.428285] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned vm-test-run-docker> server # [ 0.428308] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned vm-test-run-docker> server # [ 0.428331] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned vm-test-run-docker> server # [ 0.428353] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned vm-test-run-docker> server # [ 0.428376] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned vm-test-run-docker> server # [ 0.428399] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned vm-test-run-docker> server # [ 0.428421] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned vm-test-run-docker> server # [ 0.428443] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned vm-test-run-docker> server # [ 0.428465] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned vm-test-run-docker> server # [ 0.428487] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned vm-test-run-docker> server # [ 0.428509] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned vm-test-run-docker> server # [ 0.428531] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned vm-test-run-docker> server # [ 0.428553] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned vm-test-run-docker> server # [ 0.428575] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned vm-test-run-docker> server # [ 0.428597] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned vm-test-run-docker> server # [ 0.428619] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned vm-test-run-docker> server # [ 0.428646] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] vm-test-run-docker> server # [ 0.428655] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff] vm-test-run-docker> server # [ 0.428661] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff] vm-test-run-docker> server # [ 0.473899] pci 0000:00:0a.0: enabling device (0000 -> 0002) vm-test-run-docker> server # [ 0.498928] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.502003] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.503916] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.518254] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.520129] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.523962] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.526747] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.536971] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002) vm-test-run-docker> server # [ 0.538826] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002) vm-test-run-docker> server # [ 0.548938] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.551477] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003) vm-test-run-docker> server # [ 0.562049] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled vm-test-run-docker> server # [ 0.564550] msm_serial: driver initialized vm-test-run-docker> server # [ 0.564689] SuperH (H)SCI(F) driver initialized vm-test-run-docker> server # [ 0.565917] STM32 USART driver initialized vm-test-run-docker> server # [ 0.597780] loop: module loaded vm-test-run-docker> server # [ 0.597961] virtio_blk virtio5: 1/0/0 default/read/poll queues vm-test-run-docker> server # [ 0.598653] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) vm-test-run-docker> server # [ 0.609392] megasas: 07.734.00.00-rc1 vm-test-run-docker> server # [ 0.610055] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff] vm-test-run-docker> server # [ 0.611920] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-docker> server # [ 0.611947] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-docker> server # [ 0.613552] Using buffer write method vm-test-run-docker> server # [ 0.613626] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff] vm-test-run-docker> server # [ 0.615294] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000 vm-test-run-docker> server # [ 0.615316] Intel/Sharp Extended Query Table at 0x0031 vm-test-run-docker> server # [ 0.632801] Using buffer write method vm-test-run-docker> server # [ 0.632828] Concatenating MTD devices: vm-test-run-docker> server # [ 0.632832] (0): "0.flash" vm-test-run-docker> server # [ 0.632836] (1): "0.flash" vm-test-run-docker> server # [ 0.632840] into device "0.flash" vm-test-run-docker> server # [ 0.829646] Freeing initrd memory: 25464K vm-test-run-docker> server # [ 0.835692] tun: Universal TUN/TAP device driver, 1.6 vm-test-run-docker> server # [ 0.839393] thunder_xcv, ver 1.0 vm-test-run-docker> server # [ 0.839434] thunder_bgx, ver 1.0 vm-test-run-docker> server # [ 0.839462] nicpf, ver 1.0 vm-test-run-docker> server # [ 0.839997] e1000: Intel(R) PRO/1000 Network Driver vm-test-run-docker> server # [ 0.840005] e1000: Copyright (c) 1999-2006 Intel Corporation. vm-test-run-docker> server # [ 0.840028] e1000e: Intel(R) PRO/1000 Network Driver vm-test-run-docker> server # [ 0.840037] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. vm-test-run-docker> server # [ 0.840068] igb: Intel(R) Gigabit Ethernet Network Driver vm-test-run-docker> server # [ 0.840074] igb: Copyright (c) 2007-2014 Intel Corporation. vm-test-run-docker> server # [ 0.840097] igbvf: Intel(R) Gigabit Virtual Function Network Driver vm-test-run-docker> server # [ 0.840103] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. vm-test-run-docker> server # [ 0.840233] sky2: driver version 1.30 vm-test-run-docker> server # [ 0.849380] ehci-pci 0000:00:0a.0: EHCI Host Controller vm-test-run-docker> server # [ 0.849409] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1 vm-test-run-docker> server # [ 0.849571] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000 vm-test-run-docker> server # [ 0.852338] usbcore: registered new interface driver usb-storage vm-test-run-docker> server # [ 0.852461] usbcore: registered new interface driver usbserial_generic vm-test-run-docker> server # [ 0.852475] usbserial: USB Serial support registered for generic vm-test-run-docker> server # [ 0.855459] hv_vmbus: registering driver hyperv_keyboard vm-test-run-docker> server # [ 0.857000] rtc-pl031 9010000.pl031: registered as rtc0 vm-test-run-docker> server # [ 0.857026] rtc-pl031 9010000.pl031: setting system clock to 2026-08-02T06:39:26 UTC (1785652766) vm-test-run-docker> server # [ 0.857327] i2c_dev: i2c /dev entries driver vm-test-run-docker> server # [ 0.862359] sdhci: Secure Digital Host Controller Interface driver vm-test-run-docker> server # [ 0.862368] sdhci: Copyright(c) Pierre Ossman vm-test-run-docker> server # [ 0.862632] Synopsys Designware Multimedia Card Interface Driver vm-test-run-docker> server # [ 0.863000] sdhci-pltfm: SDHCI platform and OF driver helper vm-test-run-docker> server # [ 0.864637] hid: raw HID events driver (C) Jiri Kosina vm-test-run-docker> server # [ 0.868181] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00 vm-test-run-docker> server # [ 0.869241] hub 1-0:1.0: USB hub found vm-test-run-docker> server # [ 0.869838] hub 1-0:1.0: 6 ports detected vm-test-run-docker> server # [ 0.870888] usbcore: registered new interface driver usbhid vm-test-run-docker> server # [ 0.870899] usbhid: USB HID core driver vm-test-run-docker> server # [ 0.873273] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available vm-test-run-docker> server # [ 0.874762] drop_monitor: Initializing network drop monitor service vm-test-run-docker> server # [ 0.874884] NET: Registered PF_INET6 protocol family vm-test-run-docker> server # [ 0.877949] Segment Routing with IPv6 vm-test-run-docker> server # [ 0.877971] In-situ OAM (IOAM) with IPv6 vm-test-run-docker> server # [ 0.878001] NET: Registered PF_PACKET protocol family vm-test-run-docker> server # [ 0.879728] 9pnet: Installing 9P2000 support vm-test-run-docker> server # [ 0.882334] Key type dns_resolver registered vm-test-run-docker> server # [ 0.888406] registered taskstats version 1 vm-test-run-docker> server # [ 0.888543] Loading compiled-in X.509 certificates vm-test-run-docker> server # [ 0.897111] Demotion targets for Node 0: null vm-test-run-docker> server # [ 0.897219] Key type .fscrypt registered vm-test-run-docker> server # [ 0.897226] Key type fscrypt-provisioning registered vm-test-run-docker> server # [ 0.897326] ima: No TPM chip found, activating TPM-bypass! vm-test-run-docker> server # [ 0.897345] ima: Allocated hash algorithm: sha1 vm-test-run-docker> server # [ 0.897369] ima: No architecture policies found vm-test-run-docker> server # [ 0.901476] input: gpio-keys as /devices/platform/gpio-keys/input/input0 vm-test-run-docker> server # [ 0.920067] clk: Disabling unused clocks vm-test-run-docker> server # [ 0.920094] PM: genpd: Disabling unused power domains vm-test-run-docker> server # [ 0.924499] Freeing unused kernel memory: 4736K vm-test-run-docker> server # [ 0.924709] Run /init as init process vm-test-run-docker> server # [ 0.943034] systemd[1]: Successfully made /usr/ read-only. vm-test-run-docker> server # [ 1.120838] usb 1-1: new high-speed USB device number 2 using ehci-pci vm-test-run-docker> server # [ 1.273136] 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/input1 vm-test-run-docker> server # [ 1.279473] systemd[1]: systemd 260.1 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) vm-test-run-docker> server # [ 1.279532] systemd[1]: Detected virtualization qemu. vm-test-run-docker> server # [ 1.279606] systemd[1]: Detected architecture arm64. vm-test-run-docker> server # [ 1.279632] systemd[1]: Running in initrd. vm-test-run-docker> server # [ 1.298772] systemd[1]: Initializing machine ID from random generator. vm-test-run-docker> server # [ 1.301636] systemd[1]: Hostname set to . vm-test-run-docker> server # [ 1.357129] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0 vm-test-run-docker> server # [ 1.416835] systemd[1]: Queued start job for default target Initrd Default Target. vm-test-run-docker> server # [ 1.476863] usb 1-2: new high-speed USB device number 3 using ehci-pci vm-test-run-docker> server # [ 1.499592] systemd[1]: Created slice Slice /system/modprobe. vm-test-run-docker> server # [ 1.501101] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-docker> server # [ 1.502503] systemd[1]: Expecting device /dev/disk/by-label/nixos... vm-test-run-docker> server # [ 1.503681] systemd[1]: Reached target Path Units. vm-test-run-docker> server # [ 1.504547] systemd[1]: Reached target Slice Units. vm-test-run-docker> server # [ 1.505603] systemd[1]: Reached target Swaps. vm-test-run-docker> server # [ 1.506474] systemd[1]: Reached target Timer Units. vm-test-run-docker> server # [ 1.507526] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-docker> server # [ 1.508959] systemd[1]: Listening on Journal Socket (/dev/log). vm-test-run-docker> server # [ 1.510211] systemd[1]: Listening on Journal Sockets. vm-test-run-docker> server # [ 1.511259] systemd[1]: Listening on udev Control Socket. vm-test-run-docker> server # [ 1.512310] systemd[1]: Listening on udev Kernel Socket. vm-test-run-docker> server # [ 1.513381] systemd[1]: Reached target Socket Units. vm-test-run-docker> server # [ 1.517799] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-docker> server # [ 1.527536] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-docker> server # [ 1.528970] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-docker> server # [ 1.539064] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-docker> server # [ 1.562268] systemd[1]: Starting Journal Service... vm-test-run-docker> server # [ 1.570655] systemd[1]: Starting Load Kernel Modules... vm-test-run-docker> server # [ 1.571471] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-docker> server # [ 1.581008] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-docker> server # [ 1.625043] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-docker> server # [ 1.625941] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-docker> server # [ 1.630611] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-docker> server # [ 1.634942] systemd-journald[131]: Collecting audit messages is disabled. vm-test-run-docker> server # [ 1.641309] 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/input2 vm-test-run-docker> server # [ 1.643158] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0 vm-test-run-docker> server # [ 1.651948] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. vm-test-run-docker> server # [ 1.657090] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-docker> server # [ 1.660037] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev vm-test-run-docker> server # [ 1.672256] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0 vm-test-run-docker> server # [ 1.672488] [drm] features: -virgl +edid -resource_blob -host_visible vm-test-run-docker> server # [ 1.672499] [drm] features: -context_init vm-test-run-docker> server # [ 1.675566] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-docker> server # [ 1.685386] [drm] number of scanouts: 1 vm-test-run-docker> server # [ 1.685415] [drm] number of cap sets: 0 vm-test-run-docker> server # [ 1.689081] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic vm-test-run-docker> server # [ 1.689101] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0 vm-test-run-docker> server # [ 1.721463] Console: switching to colour frame buffer device 160x50 vm-test-run-docker> server # [ 1.727831] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device vm-test-run-docker> server # [ 1.749186] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-docker> server # [ 1.753364] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-docker> server # [ 1.773087] systemd[1]: Finished Load Kernel Modules. vm-test-run-docker> server # [ 1.782393] systemd[1]: Starting Apply Kernel Variables... vm-test-run-docker> server # [ 1.829401] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-docker> server # [ 1.829616] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-docker> server # [ 1.829652] systemd[1]: Reached target Local File Systems. vm-test-run-docker> server # [ 1.845571] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-docker> server # [ 1.833762] systemd-modules-load[133]: Inserted module 'dm_mod' vm-test-run-docker> server # [ 1.836850] systemd-modules-load[133]: Module 'virtio_balloon' is built in vm-test-run-docker> server # [ 1.860969] systemd[1]: Finished Apply Kernel Variables. vm-test-run-docker> server # [ 1.863143] systemd[1]: Started Journal Service. vm-test-run-docker> server # [ 1.846189] systemd-modules-load[133]: Module 'virtio_console' is built in vm-test-run-docker> server # [ 1.847531] systemd-modules-load[133]: Inserted module 'virtio_gpu' vm-test-run-docker> server # [ 1.856407] systemd-modules-load[133]: Module 'virtio_rng' is built in vm-test-run-docker> server # [ 1.872160] systemd[1]: Starting Create System Files and Directories... vm-test-run-docker> server # [ 1.902638] systemd-udevd[155]: Using default interface naming scheme 'v260'. vm-test-run-docker> server # [ 1.928410] systemd[1]: Finished Create System Files and Directories. vm-test-run-docker> server # [ 1.947561] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-docker> server # [ 2.024876] systemd[1]: Starting Virtual Console Setup... vm-test-run-docker> server # [ 2.105369] systemd-vconsole-setup[181]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-docker> server # [ 2.112354] systemd[1]: Finished Virtual Console Setup. vm-test-run-docker> server # [ 2.860646] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-docker> server # [ 2.862156] systemd[1]: Reached target System Initialization. vm-test-run-docker> server # [ 2.864133] systemd[1]: Reached target Basic System. vm-test-run-docker> server # [ 3.030301] (udev-worker)[175]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-docker> server # [ 3.033652] (udev-worker)[175]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 3.053724] (udev-worker)[173]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 3.090995] systemd[1]: Found device /dev/disk/by-label/nixos. vm-test-run-docker> server # [ 3.092777] systemd[1]: Reached target Initrd Root Device. vm-test-run-docker> server # [ 3.096357] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos... vm-test-run-docker> server # [ 3.147262] systemd-fsck[193]: nixos: clean, 12/65536 files, 13019/262144 blocks vm-test-run-docker> server # [ 3.156244] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos. vm-test-run-docker> server # [ 3.163200] systemd[1]: Mounting /sysroot... vm-test-run-docker> server # [ 3.233201] EXT4-fs (vda): mounted filesystem 695c54f7-d253-4c0a-90b3-675bd5090905 r/w with ordered data mode. Quota mode: none. vm-test-run-docker> server # [ 3.220982] systemd[1]: Mounted /sysroot. vm-test-run-docker> server # [ 3.222194] systemd[1]: Reached target Initrd Root File System. vm-test-run-docker> server # [ 3.230559] systemd[1]: Mounting /sysroot/nix/.ro-store... vm-test-run-docker> server # [ 3.247786] systemd[1]: Mounting /sysroot/nix/.rw-store... vm-test-run-docker> server # [ 3.261690] systemd[1]: Mounting /sysroot/run... vm-test-run-docker> server # [ 3.281148] systemd[1]: Mounting /sysroot/tmp/shared... vm-test-run-docker> server # [ 3.305715] systemd[1]: Mounting /sysroot/tmp/xchg... vm-test-run-docker> server # [ 3.344162] systemd[1]: Starting Mountpoints Configured in the Real Root... vm-test-run-docker> server # [ 3.348361] systemd[1]: Mounted /sysroot/nix/.ro-store. vm-test-run-docker> server # [ 3.350411] systemd[1]: Mounted /sysroot/nix/.rw-store. vm-test-run-docker> server # [ 3.357639] systemd[1]: Mounted /sysroot/run. vm-test-run-docker> server # [ 3.387913] systemd[1]: Mounted /sysroot/tmp/shared. vm-test-run-docker> server # [ 3.390642] systemd[1]: Mounted /sysroot/tmp/xchg. vm-test-run-docker> server # [ 3.400446] systemd-sysroot-fstab-check[214]: /sysroot should be mounted in the initrd, will request daemon-reload. vm-test-run-docker> server # [ 3.408183] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-docker> server # [ 3.419211] systemd[1]: Reload requested from client PID 214 ('systemd-sysroot') (unit initrd-parse-etc.service)... vm-test-run-docker> server # [ 3.424308] systemd[1]: Reloading... vm-test-run-docker> server # [ 3.937369] systemd[1]: Reloading finished in 515 ms. vm-test-run-docker> server # [ 3.996646] systemd-sysroot-fstab-check[214]: Requesting initrd-fs.target/start/replace... vm-test-run-docker> server # [ 4.138940] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-docker> server # [ 4.144471] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-docker> server # [ 4.151829] systemd-sysroot-fstab-check[214]: Requesting swap.target/start/replace... vm-test-run-docker> server # [ 4.157162] systemd[1]: initrd-parse-etc.service: Deactivated successfully. vm-test-run-docker> server # [ 4.163456] systemd[1]: Finished Mountpoints Configured in the Real Root. vm-test-run-docker> server # [ 4.166724] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. vm-test-run-docker> server # [ 4.175029] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-docker> server # [ 4.200721] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-docker> server # [ 4.203651] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-docker> server # [ 4.211586] systemd[1]: Mounting /sysroot/nix/store... vm-test-run-docker> server # [ 4.252899] systemd[1]: Mounted /sysroot/nix/store. vm-test-run-docker> server # [ 4.254801] systemd[1]: Reached target Initrd File Systems. vm-test-run-docker> server # [ 4.261495] systemd[1]: Starting Find NixOS closure... vm-test-run-docker> server # [ 4.279239] systemd[1]: Starting Create Volatile Files and Directories in the Real Root... vm-test-run-docker> server # [ 4.321634] systemd[1]: Finished Create Volatile Files and Directories in the Real Root. vm-test-run-docker> server # [ 4.324967] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully. vm-test-run-docker> server # [ 4.342950] systemd[1]: Finished Find NixOS closure. vm-test-run-docker> server # [ 4.347247] systemd[1]: Reached target Initrd Default Target. vm-test-run-docker> server # [ 4.353641] systemd[1]: Starting Cleaning Up and Shutting Down Daemons... vm-test-run-docker> server # [ 4.386749] systemd[1]: Stopped target Initrd Default Target. vm-test-run-docker> server # [ 4.389091] systemd[1]: Stopped target Basic System. vm-test-run-docker> server # [ 4.391265] systemd[1]: Stopped target Initrd Root Device. vm-test-run-docker> server # [ 4.395801] systemd[1]: Stopped target Path Units. vm-test-run-docker> server # [ 4.397619] systemd[1]: systemd-ask-password-console.path: Deactivated successfully. vm-test-run-docker> server # [ 4.401815] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch. vm-test-run-docker> server # [ 4.406335] systemd[1]: Stopped target Slice Units. vm-test-run-docker> server # [ 4.409029] systemd[1]: Stopped target Socket Units. vm-test-run-docker> server # [ 4.414197] systemd[1]: Stopped target System Initialization. vm-test-run-docker> server # [ 4.415841] systemd[1]: Stopped target Swaps. vm-test-run-docker> server # [ 4.417850] systemd[1]: Stopped target Timer Units. vm-test-run-docker> server # [ 4.423080] systemd[1]: dbus.socket: Deactivated successfully. vm-test-run-docker> server # [ 4.428201] systemd[1]: Closed D-Bus System Message Bus Socket. vm-test-run-docker> server # [ 4.429920] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully. vm-test-run-docker> server # [ 4.433154] systemd[1]: Stopped Find NixOS closure. vm-test-run-docker> server # [ 4.433888] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-docker> server # [ 4.447529] systemd[1]: Starting rw-sysroot-nix-store.service... vm-test-run-docker> server # [ 4.452288] systemd[1]: systemd-sysctl.service: Deactivated successfully. vm-test-run-docker> server # [ 4.453276] systemd[1]: Stopped Apply Kernel Variables. vm-test-run-docker> server # [ 4.468647] systemd[1]: systemd-modules-load.service: Deactivated successfully. vm-test-run-docker> server # [ 4.472304] systemd[1]: Stopped Load Kernel Modules. vm-test-run-docker> server # [ 4.478318] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully. vm-test-run-docker> server # [ 4.482077] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root. vm-test-run-docker> server # [ 4.485906] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. vm-test-run-docker> server # [ 4.490083] systemd[1]: Stopped Create System Files and Directories. vm-test-run-docker> server # [ 4.494273] systemd[1]: Stopped target Local File Systems. vm-test-run-docker> server # [ 4.497334] systemd[1]: Stopped target Preparation for Local File Systems. vm-test-run-docker> server # [ 4.500242] systemd[1]: systemd-udev-trigger.service: Deactivated successfully. vm-test-run-docker> server # [ 4.503637] systemd[1]: Stopped Coldplug All udev Devices. vm-test-run-docker> server # [ 4.506761] systemd[1]: Stopping Rule-based Manager for Device Events and Files... vm-test-run-docker> server # [ 4.513484] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-docker> server # [ 4.515786] systemd[1]: Stopped Virtual Console Setup. vm-test-run-docker> server # [ 4.519778] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-docker> server # [ 4.523237] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-docker> server # [ 4.527250] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully. vm-test-run-docker> server # [ 4.532276] systemd[1]: Finished rw-sysroot-nix-store.service. vm-test-run-docker> server # [ 4.540855] systemd[1]: initrd-cleanup.service: Deactivated successfully. vm-test-run-docker> server # [ 4.546245] systemd[1]: Finished Cleaning Up and Shutting Down Daemons. vm-test-run-docker> server # [ 4.572134] systemd[1]: systemd-udevd.service: Deactivated successfully. vm-test-run-docker> server # [ 4.573794] systemd[1]: Stopped Rule-based Manager for Device Events and Files. vm-test-run-docker> server # [ 4.576134] systemd[1]: systemd-udevd.service: Consumed 1.095s CPU time over 2.745s wall clock time, 15.8M memory peak. vm-test-run-docker> server # [ 4.580245] systemd[1]: systemd-udevd-control.socket: Deactivated successfully. vm-test-run-docker> server # [ 4.586091] systemd[1]: Closed udev Control Socket. vm-test-run-docker> server # [ 4.592253] systemd[1]: Starting Cleanup udev Database... vm-test-run-docker> server # [ 4.593187] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. vm-test-run-docker> server # [ 4.594277] systemd[1]: Stopped Create Static Device Nodes in /dev. vm-test-run-docker> server # [ 4.597657] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. vm-test-run-docker> server # [ 4.601922] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully. vm-test-run-docker> server # [ 4.604622] systemd[1]: kmod-static-nodes.service: Deactivated successfully. vm-test-run-docker> server # [ 4.607147] systemd[1]: Stopped Create List of Static Device Nodes. vm-test-run-docker> server # [ 4.639289] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. vm-test-run-docker> server # [ 4.642928] systemd[1]: Finished Cleanup udev Database. vm-test-run-docker> server # [ 4.647275] systemd[1]: Reached target Switch Root. vm-test-run-docker> server # [ 4.651337] systemd[1]: Starting NixOS Activation... vm-test-run-docker> server # [ 4.847722] initrd-nixos-activation-start[514]: booting system configuration /nix/store/2fndakxhm11kq8wkp0v4macadsw7dmw4-nixos-system-server-test vm-test-run-docker> server # [ 4.918063] initrd-nixos-activation-start[514]: running activation script... vm-test-run-docker> server # [ 5.367515] initrd-nixos-activation-start[537]: setting up /etc... vm-test-run-docker> server # [ 5.643420] systemd[1]: initrd-nixos-activation.service: Deactivated successfully. vm-test-run-docker> server # [ 5.647417] systemd[1]: Finished NixOS Activation. vm-test-run-docker> server # [ 5.655063] systemd[1]: Starting Switch Root... vm-test-run-docker> server # [ 5.680561] systemd[1]: Switching root. vm-test-run-docker> server # [ 5.934186] systemd-journald[131]: Received SIGTERM from PID 1 (systemd). vm-test-run-docker> server # [ 6.522000] systemd[1]: systemd 260.1 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) vm-test-run-docker> server # [ 6.534923] systemd[1]: Detected virtualization qemu. vm-test-run-docker> server # [ 6.538238] systemd[1]: Detected architecture arm64. vm-test-run-docker> server # [ 6.541984] systemd[1]: Detected first boot. vm-test-run-docker> server # [ 6.550408] systemd[1]: Initializing machine ID from random generator. vm-test-run-docker> server # [ 6.883238] systemd[1]: bpf-restrict-fs: LSM BPF program attached vm-test-run-docker> server # [ 7.111076] systemd[1]: Applying preset policy. vm-test-run-docker> server # [ 7.593878] systemd[1]: Populated /etc with preset unit settings. vm-test-run-docker> server # [ 8.086446] systemd[1]: initrd-switch-root.service: Deactivated successfully. vm-test-run-docker> server # [ 8.087813] systemd[1]: Stopped initrd-switch-root.service. vm-test-run-docker> server # [ 8.091106] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. vm-test-run-docker> server # [ 8.094043] systemd[1]: Created slice Slice /system/getty. vm-test-run-docker> server # [ 8.097178] systemd[1]: Created slice User and Session Slice. vm-test-run-docker> server # [ 8.099317] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. vm-test-run-docker> server # [ 8.101784] systemd[1]: Started Forward Password Requests to Wall Directory Watch. vm-test-run-docker> server # [ 8.103140] systemd[1]: Expecting device /dev/hvc0... vm-test-run-docker> server # [ 8.105426] systemd[1]: Expecting device /dev/ttyAMA0... vm-test-run-docker> server # [ 8.106489] systemd[1]: Reached target Local Encrypted Volumes. vm-test-run-docker> server # [ 8.108065] systemd[1]: Stopped target initrd-fs.target. vm-test-run-docker> server # [ 8.110478] systemd[1]: Stopped target initrd-root-fs.target. vm-test-run-docker> server # [ 8.111592] systemd[1]: Stopped target initrd-switch-root.target. vm-test-run-docker> server # [ 8.114074] systemd[1]: Reached target Virtual Machines and Containers. vm-test-run-docker> server # [ 8.115303] systemd[1]: Reached target Path Units. vm-test-run-docker> server # [ 8.116731] systemd[1]: Reached target Remote File Systems. vm-test-run-docker> server # [ 8.118273] systemd[1]: Reached target Slice Units. vm-test-run-docker> server # [ 8.119739] systemd[1]: Reached target Swaps. vm-test-run-docker> server # [ 8.124994] systemd[1]: Listening on Process Core Dump Socket. vm-test-run-docker> server # [ 8.128927] systemd[1]: Listening on Credential Encryption/Decryption. vm-test-run-docker> server # [ 8.134914] systemd[1]: Starting Journal Log Access Socket... vm-test-run-docker> server # [ 8.136520] systemd[1]: Listening on Journal Audit Socket. vm-test-run-docker> server # [ 8.137986] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. vm-test-run-docker> server # [ 8.140541] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-docker> server # [ 8.143396] systemd[1]: Listening on udev Control Socket. vm-test-run-docker> server # [ 8.150246] systemd[1]: Mounting Huge Pages File System... vm-test-run-docker> server # [ 8.154739] systemd[1]: Mounting POSIX Message Queue File System... vm-test-run-docker> server # [ 8.161011] systemd[1]: Mounting Kernel Debug File System... vm-test-run-docker> server # [ 8.169066] systemd[1]: Mounting Kernel Trace File System... vm-test-run-docker> server # [ 8.180410] systemd[1]: Starting Create List of Static Device Nodes... vm-test-run-docker> server # [ 8.194605] systemd[1]: Starting Load Kernel Module 9pnet_virtio... vm-test-run-docker> server # [ 8.194985] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-docker> server # [ 8.203862] systemd[1]: Mounting Kernel Configuration File System... vm-test-run-docker> server # [ 8.209633] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm vm-test-run-docker> server # [ 8.216638] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore vm-test-run-docker> server # [ 8.228907] systemd[1]: Starting Load Kernel Module fuse... vm-test-run-docker> server # [ 8.231828] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 vm-test-run-docker> server # [ 8.289417] systemd[1]: Starting Journal Service... vm-test-run-docker> server # [ 8.303624] systemd[1]: Starting Load Kernel Modules... vm-test-run-docker> server # [ 8.326904] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... vm-test-run-docker> server # [ 8.355249] systemd[1]: Starting Remount Root and Kernel File Systems... vm-test-run-docker> server # [ 8.355657] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-docker> server # [ 8.369585] systemd[1]: Starting Coldplug All udev Devices... vm-test-run-docker> server # [ 8.375022] systemd[1]: Listening on Journal Log Access Socket. vm-test-run-docker> server # [ 8.381120] systemd[1]: Mounted Huge Pages File System. vm-test-run-docker> server # [ 8.383533] systemd[1]: Mounted POSIX Message Queue File System. vm-test-run-docker> server # [ 8.388229] systemd[1]: Mounted Kernel Debug File System. vm-test-run-docker> server # [ 8.390647] systemd[1]: Mounted Kernel Trace File System. vm-test-run-docker> server # [ 8.391183] systemd[1]: Mounted Kernel Configuration File System. vm-test-run-docker> server # [ 8.418345] systemd[1]: Finished Create List of Static Device Nodes. vm-test-run-docker> server # [ 8.425286] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... vm-test-run-docker> server # [ 8.482483] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully. vm-test-run-docker> server # [ 8.485580] systemd[1]: Finished Load Kernel Module 9pnet_virtio. vm-test-run-docker> server # [ 8.516973] EXT4-fs (vda): re-mounted 695c54f7-d253-4c0a-90b3-675bd5090905. vm-test-run-docker> server # [ 8.535454] systemd[1]: Finished Remount Root and Kernel File Systems. vm-test-run-docker> server # [ 8.538177] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore vm-test-run-docker> server # [ 8.547002] systemd[1]: Starting Load/Save OS Random Seed... vm-test-run-docker> server # [ 8.549516] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki vm-test-run-docker> server # [ 8.554959] systemd-journald[747]: Collecting audit messages is enabled. vm-test-run-docker> server # [ 8.568642] systemd[1]: Started Journal Service. vm-test-run-docker> server # [ 8.575800] fuse: init (API version 7.45) vm-test-run-docker> server # [ 8.575197] systemd[1]: Queued start job for default target Multi-User System. vm-test-run-docker> server # [ 8.576829] systemd[1]: systemd-journald.service: Deactivated successfully. vm-test-run-docker> server # [ 8.589760] systemd-modules-load[748]: Module 'atkbd' is built in vm-test-run-docker> server # [ 8.625744] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. vm-test-run-docker> server # [ 8.609751] systemd[1]: Starting Flush Journal to Persistent Storage... vm-test-run-docker> server # [ 8.618151] systemd[1]: modprobe@fuse.service: Deactivated successfully. vm-test-run-docker> server # [ 8.626446] systemd[1]: Finished Load Kernel Module fuse. vm-test-run-docker> server # [ 8.658027] Bridge firewalling registered vm-test-run-docker> server # [ 8.644518] systemd-modules-load[748]: Inserted module 'br_netfilter' vm-test-run-docker> server # [ 8.655711] systemd-modules-load[748]: Module 'loop' is built in vm-test-run-docker> server # [ 8.664839] systemd-modules-load[748]: Inserted module 'veth' vm-test-run-docker> server # [ 8.684412] systemd-oomd[749]: No swap; memory pressure usage will be degraded vm-test-run-docker> server # [ 8.694834] systemd[1]: Finished Load/Save OS Random Seed. vm-test-run-docker> server # [ 8.697268] systemd[1]: Reached target First Boot Complete. vm-test-run-docker> server # [ 8.704435] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. vm-test-run-docker> server # [ 8.734105] systemd-journald[747]: Received client request to flush runtime journal. vm-test-run-docker> server # [ 8.793551] systemd-modules-load[748]: Inserted module 'xt_nat' vm-test-run-docker> server # [ 8.799169] systemd[1]: Finished Load Kernel Modules. vm-test-run-docker> server # [ 8.807316] systemd[1]: Starting Firewall... vm-test-run-docker> server # [ 8.809112] systemd[1]: Starting Apply Kernel Variables... vm-test-run-docker> server # [ 8.811537] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. vm-test-run-docker> server # [ 8.817272] systemd[1]: Starting Create Static Device Nodes in /dev... vm-test-run-docker> server # [ 8.824316] systemd[1]: Finished Flush Journal to Persistent Storage. vm-test-run-docker> server # [ 8.892270] systemd[1]: Finished Apply Kernel Variables. vm-test-run-docker> server # [ 8.914333] systemd[1]: Finished Create Static Device Nodes in /dev. vm-test-run-docker> server # [ 8.922968] systemd[1]: Reached target Preparation for Local File Systems. vm-test-run-docker> server # [ 8.925970] systemd[1]: Starting Rule-based Manager for Device Events and Files... vm-test-run-docker> server # [ 9.074063] systemd[1]: Mounting /run/wrappers... vm-test-run-docker> server # [ 9.079743] systemd[1]: Mounting FUSE Control File System... vm-test-run-docker> server # [ 9.128842] systemd[1]: Mounted FUSE Control File System. vm-test-run-docker> server # [ 9.155768] systemd[1]: Mounted /run/wrappers. vm-test-run-docker> server # [ 9.158029] systemd[1]: Reached target Local File Systems. vm-test-run-docker> server # [ 9.172344] systemd[1]: Listening on Boot Loader Control Service Socket. vm-test-run-docker> server # [ 9.173578] systemd[1]: Starting register-nix-paths.service... vm-test-run-docker> server # [ 9.179942] systemd[1]: Starting Create SUID/SGID Wrappers... vm-test-run-docker> server # [ 9.194363] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met. vm-test-run-docker> server # [ 9.203103] systemd[1]: Starting Save Transient machine-id to Disk... vm-test-run-docker> server # [ 9.211754] systemd[1]: Starting Create System Files and Directories... vm-test-run-docker> server # [ 9.314727] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. vm-test-run-docker> server # [ 9.322091] systemd[1]: Finished Save Transient machine-id to Disk. vm-test-run-docker> server # [ 9.493915] systemd[1]: Finished Create System Files and Directories. vm-test-run-docker> server # [ 9.508320] systemd[1]: Starting Rebuild Journal Catalog... vm-test-run-docker> server # [ 9.509710] systemd[1]: Starting Record System Boot/Shutdown in UTMP... vm-test-run-docker> server # [ 9.548761] systemd-udevd[780]: Using default interface naming scheme 'v260'. vm-test-run-docker> server # [ 9.644954] systemd[1]: Finished Record System Boot/Shutdown in UTMP. vm-test-run-docker> server # [ 9.735220] systemd[1]: Finished Rebuild Journal Catalog. vm-test-run-docker> server # [ 9.738395] systemd[1]: Starting Update is Completed... vm-test-run-docker> server # [ 9.859566] systemd[1]: Finished Update is Completed. vm-test-run-docker> server # [ 9.888292] systemd[1]: Started Rule-based Manager for Device Events and Files. vm-test-run-docker> server # [ 10.473133] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. vm-test-run-docker> server # [ 10.478610] systemd[1]: Finished Create SUID/SGID Wrappers. vm-test-run-docker> server # [ 10.850541] systemd[1]: Finished register-nix-paths.service. vm-test-run-docker> server # [ 10.925387] systemd[1]: Finished Firewall. vm-test-run-docker> server # [ 11.306889] systemd[1]: Finished Coldplug All udev Devices. vm-test-run-docker> server # [ 11.313633] systemd[1]: Reached target System Initialization. vm-test-run-docker> server # [ 11.315196] systemd[1]: Started Discard unused filesystem blocks once a week. vm-test-run-docker> server # [ 11.316546] systemd[1]: Started Daily Cleanup of Temporary Directories. vm-test-run-docker> server # [ 11.320759] systemd[1]: Reached target Timer Units. vm-test-run-docker> server # [ 11.325699] systemd[1]: Listening on D-Bus System Message Bus Socket. vm-test-run-docker> server # [ 11.328332] systemd[1]: Starting Docker Socket for the API... vm-test-run-docker> server # [ 11.332519] systemd[1]: Listening on Nix Daemon Socket. vm-test-run-docker> server # [ 11.336134] systemd[1]: Listening on Hostname Service Socket. vm-test-run-docker> server # [ 11.340297] systemd[1]: Starting D-Bus System Message Bus... vm-test-run-docker> server # [ 11.344145] systemd[1]: Listening on Docker Socket for the API. vm-test-run-docker> server # [ 11.345055] systemd[1]: Reached target Socket Units. vm-test-run-docker> server # [ 11.456865] dbus-broker-launch[969]: Looking up NSS user entry for 'systemd-timesync'... vm-test-run-docker> server # [ 11.473743] dbus-broker-launch[969]: NSS returned no entry for 'systemd-timesync' vm-test-run-docker> server # [ 11.476376] dbus-broker-launch[969]: Invalid user-name in /nix/store/lwsgwjdrin5hplqwrqm04hzn79wiih09-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync" vm-test-run-docker> server # [ 11.511003] systemd[1]: Started D-Bus System Message Bus. vm-test-run-docker> server # [ 11.544473] dbus-broker-launch[969]: Ready vm-test-run-docker> server # [ 11.547259] systemd[1]: Reached target Basic System. vm-test-run-docker> server # [ 11.553708] systemd[1]: Starting Import lastlog data into lastlog2 database... vm-test-run-docker> server # [ 11.559353] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-docker> server # [ 11.571442] systemd[1]: Starting Post-Boot Actions... vm-test-run-docker> server # [ 11.576679] systemd[1]: Started Reset console on configuration changes. vm-test-run-docker> server # [ 11.587122] systemd[1]: Starting resolvconf update... vm-test-run-docker> server # [ 11.670023] systemd[1]: Finished Post-Boot Actions. vm-test-run-docker> server # [ 11.721246] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-docker> server # [ 11.729594] nsncd[972]: Aug 02 06:39:37.379 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-docker> server # [ 11.736478] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-docker> server # [ 11.744282] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-docker> server # [ 11.749456] systemd[1]: Starting User Login Management... vm-test-run-docker> server # [ 11.761937] systemd[1]: Finished Import lastlog data into lastlog2 database. vm-test-run-docker> server # [ 11.884891] systemd[1]: Stopped target Host and Network Name Lookups. vm-test-run-docker> server # [ 11.893468] systemd[1]: Stopping Host and Network Name Lookups... vm-test-run-docker> server # [ 11.901000] systemd[1]: Stopped target User and Group Name Lookups. vm-test-run-docker> server # [ 11.914287] systemd[1]: Stopping User and Group Name Lookups... vm-test-run-docker> server # [ 11.917740] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... vm-test-run-docker> server # [ 11.927358] systemd[1]: nscd.service: Deactivated successfully. vm-test-run-docker> server # [ 11.931749] systemd[1]: Stopped Name Service Cache Daemon (nsncd). vm-test-run-docker> server # [ 11.939204] systemd[1]: Starting Name Service Cache Daemon (nsncd)... vm-test-run-docker> server # [ 11.948845] systemd-logind[984]: New seat seat0. vm-test-run-docker> server # [ 11.949730] systemd[1]: Started User Login Management. vm-test-run-docker> server # [ 11.958535] systemd[1]: Starting linger-users.service... vm-test-run-docker> server # [ 12.003033] input: QEMU Virtio Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:08.0/virtio7/input/input3 vm-test-run-docker> server # [ 12.030268] systemd[1]: linger-users.service: Deactivated successfully. vm-test-run-docker> server # [ 12.031779] systemd[1]: Finished linger-users.service. vm-test-run-docker> server # [ 12.036995] systemd[1]: Started Name Service Cache Daemon (nsncd). vm-test-run-docker> server # [ 12.040529] nsncd[1032]: Aug 02 06:39:37.692 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" vm-test-run-docker> server # [ 12.046050] systemd[1]: Reached target Host and Network Name Lookups. vm-test-run-docker> server # [ 12.049445] systemd[1]: Reached target User and Group Name Lookups. vm-test-run-docker> server # [ 12.079189] systemd[1]: Finished resolvconf update. vm-test-run-docker> server # [ 12.083215] systemd[1]: Reached target Preparation for Network. vm-test-run-docker> server # [ 12.086948] systemd[1]: Starting DHCP Client... vm-test-run-docker> server # [ 12.090485] systemd[1]: Starting Extra networking commands.... vm-test-run-docker> server # [ 12.325462] dhcpcd[1068]: dhcpcd-10.3.1 starting vm-test-run-docker> server # [ 12.344418] dhcpcd[1099]: dev: loaded udev vm-test-run-docker> server # [ 12.352966] dhcpcd[1099]: no valid interfaces found vm-test-run-docker> server # [ 12.354508] dhcpcd[1099]: no valid interfaces found vm-test-run-docker> server # [ 12.357167] dhcpcd[1099]: libudev: received NULL device vm-test-run-docker> server # [ 12.360188] dhcpcd[1099]: libudev: received NULL device vm-test-run-docker> server # [ 12.394497] systemd[1]: Finished Extra networking commands.. vm-test-run-docker> server # [ 12.401099] systemd[1]: Reached target Network. vm-test-run-docker> server # [ 12.403523] systemd[1]: Starting Permit User Sessions... vm-test-run-docker> server # [ 12.468660] systemd[1]: Finished Permit User Sessions. vm-test-run-docker> server # [ 12.471636] systemd[1]: Started Getty on tty1. vm-test-run-docker> server # [ 12.474185] systemd[1]: Reached target Login Prompts. vm-test-run-docker> server # [ 12.743991] systemd[1]: Starting Virtual Console Setup... vm-test-run-docker> server # [ 12.761483] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs vm-test-run-docker> server # [ 12.779262] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-docker> server # [ 12.786235] systemd[1]: Stopped Virtual Console Setup. vm-test-run-docker> server # [ 12.788342] systemd[1]: Starting Virtual Console Setup... vm-test-run-docker> server # [ 12.974759] systemd[1]: Condition check resulted in /dev/hvc0 being skipped. vm-test-run-docker> server # [ 13.026839] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped. vm-test-run-docker> server # [ 13.033733] systemd[1]: Started backdoor.service. vm-test-run-docker> server # [ 13.111190] 8021q: 802.1Q VLAN Support v1.8 vm-test-run-docker> server # connecting to host... vm-test-run-docker> server # [ 13.203620] cfg80211: Loading compiled-in X.509 certificates for regulatory database vm-test-run-docker> server: Guest shell says: b'Spawning backdoor root shell...\n' vm-test-run-docker> server: connected to guest root shell vm-test-run-docker> server: (connecting took 13.54 seconds) vm-test-run-docker> server # [ 13.239652] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' vm-test-run-docker> server: (finished: waiting for the VM to finish booting, in 13.54 seconds) vm-test-run-docker> server # [ 13.240195] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' vm-test-run-docker> server # [ 13.245330] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2 vm-test-run-docker> server # [ 13.245700] cfg80211: failed to load regulatory.db vm-test-run-docker> server # [ 13.236637] (udev-worker)[1114]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 13.245151] (udev-worker)[1118]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. vm-test-run-docker> server # [ 13.251098] (udev-worker)[1118]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 13.466724] systemd-vconsole-setup[1128]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-docker> server # [ 13.474750] systemd[1]: Finished Virtual Console Setup. vm-test-run-docker> server # [ 13.498319] systemd[1]: Condition check resulted in Virtio network device being skipped. vm-test-run-docker> server # [ 13.502092] systemd[1]: Starting Address configuration of eth1... vm-test-run-docker> server # [ 13.606803] 8021q: adding VLAN 0 to HW filter on device eth0 vm-test-run-docker> server # [ 13.590155] dhcpcd[1099]: eth0: waiting for carrier vm-test-run-docker> server # [ 13.590941] dhcpcd[1099]: eth0: carrier acquired vm-test-run-docker> server # [ 13.607852] dhcpcd[1099]: DUID 00:01:00:01:32:01:a2:ab:52:54:00:12:34:56 vm-test-run-docker> server # [ 13.610351] dhcpcd[1099]: eth0: IAID 00:12:34:56 vm-test-run-docker> server # [ 13.612453] dhcpcd[1099]: eth0: adding address fe80::5054:ff:fe12:3456 vm-test-run-docker> server # [ 13.638343] 8021q: adding VLAN 0 to HW filter on device eth1 vm-test-run-docker> server # [ 13.638017] network-addresses-eth1-start[1157]: adding address 192.168.1.1/24... done vm-test-run-docker> server # [ 13.653972] network-addresses-eth1-start[1157]: adding address 2001:db8:1::1/64... done vm-test-run-docker> server # [ 13.657198] systemd-logind[984]: Watching system buttons on /dev/input/event0 (gpio-keys) vm-test-run-docker> server # [ 13.677509] systemd[1]: Finished Address configuration of eth1. vm-test-run-docker> server # [ 13.809722] mousedev: PS/2 mouse device common for all mice vm-test-run-docker> server # [ 13.875101] systemd-logind[984]: Watching system buttons on /dev/input/event1 (QEMU QEMU USB Keyboard) vm-test-run-docker> server # [ 14.037924] dhcpcd[1099]: eth0: soliciting a DHCP lease vm-test-run-docker> server # [ 14.044894] dhcpcd[1099]: eth0: offered 10.0.2.15 from 10.0.2.2 vm-test-run-docker> server # [ 14.052434] dhcpcd[1099]: eth0: probing address 10.0.2.15/24 vm-test-run-docker> server # [ 15.062431] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. vm-test-run-docker> server # [ 15.070525] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-docker> server # [ 15.071650] systemd[1]: Stopped Virtual Console Setup. vm-test-run-docker> server # [ 15.078023] systemd[1]: Stopping Virtual Console Setup... vm-test-run-docker> server # [ 15.078869] systemd[1]: Starting Virtual Console Setup... vm-test-run-docker> server # [ 15.115385] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. vm-test-run-docker> server # [ 15.120593] systemd[1]: Stopped Virtual Console Setup. vm-test-run-docker> server # [ 15.123494] systemd[1]: Starting Virtual Console Setup... vm-test-run-docker> server # [ 15.148797] dhcpcd[1099]: eth0: soliciting an IPv6 router vm-test-run-docker> server # [ 15.150582] dhcpcd[1099]: eth0: Router Advertisement from fe80::2 vm-test-run-docker> server # [ 15.151788] dhcpcd[1099]: eth0: adding address fec0::5054:ff:fe12:3456/64 vm-test-run-docker> server # [ 15.153048] dhcpcd[1099]: eth0: adding route to fec0::/64 vm-test-run-docker> server # [ 15.154094] dhcpcd[1099]: eth0: adding default route via fe80::2 vm-test-run-docker> server # [ 15.159500] systemd-logind[984]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) vm-test-run-docker> server # [ 15.465032] systemd-vconsole-setup[1189]: Configuration of first virtual console was skipped, ignoring remaining ones. vm-test-run-docker> server # [ 15.468427] systemd[1]: Finished Virtual Console Setup. vm-test-run-docker> server # [ 18.628992] dhcpcd[1099]: eth0: leased 10.0.2.15 for 86400 seconds vm-test-run-docker> server # [ 18.632781] dhcpcd[1099]: eth0: adding route to 10.0.2.0/24 vm-test-run-docker> server # [ 18.636230] dhcpcd[1099]: eth0: adding default route via 10.0.2.2 vm-test-run-docker> server # [ 18.796695] systemd[1]: Started DHCP Client. vm-test-run-docker> server # [ 18.800372] systemd[1]: Reached target Network is Online. vm-test-run-docker> server # [ 18.803774] systemd[1]: Starting Docker Application Container Engine... vm-test-run-docker> server # [ 19.736711] dockerd[1271]: time="2026-08-02T06:39:45.399487840Z" level=info msg="Starting up" vm-test-run-docker> server # [ 19.739437] dockerd[1271]: time="2026-08-02T06:39:45.402939200Z" level=info msg="containerd not running, starting managed containerd" vm-test-run-docker> server # [ 19.752908] dockerd[1271]: time="2026-08-02T06:39:45.416439080Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=1286 vm-test-run-docker> server # [ 20.263749] dockerd[1286]: time="2026-08-02T06:39:45.926964040Z" level=info msg="starting containerd" revision=refs/tags/v2.2.3 version=v2.2.3 vm-test-run-docker> server # [ 20.284829] dockerd[1286]: time="2026-08-02T06:39:45.948476080Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="5µs" vm-test-run-docker> server # [ 20.289171] dockerd[1286]: time="2026-08-02T06:39:45.950838740Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 vm-test-run-docker> server # [ 20.291467] dockerd[1286]: time="2026-08-02T06:39:45.950926580Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 vm-test-run-docker> server # [ 20.294222] dockerd[1286]: time="2026-08-02T06:39:45.950947480Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 vm-test-run-docker> server # [ 20.296424] dockerd[1286]: time="2026-08-02T06:39:45.951306720Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 vm-test-run-docker> server # [ 20.298368] dockerd[1286]: time="2026-08-02T06:39:45.951329900Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 vm-test-run-docker> server # [ 20.300657] dockerd[1286]: time="2026-08-02T06:39:45.951345560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.303118] dockerd[1286]: time="2026-08-02T06:39:45.951431980Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.306170] dockerd[1286]: time="2026-08-02T06:39:45.951445960Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.308575] dockerd[1286]: time="2026-08-02T06:39:45.951852420Z" level=info msg="skip loading plugin" error="path /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.312538] dockerd[1286]: time="2026-08-02T06:39:45.951870020Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.314686] dockerd[1286]: time="2026-08-02T06:39:45.951907380Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.317868] dockerd[1286]: time="2026-08-02T06:39:45.951918100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.319889] dockerd[1286]: time="2026-08-02T06:39:45.952205980Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.323162] dockerd[1286]: time="2026-08-02T06:39:45.952218940Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.325493] dockerd[1286]: time="2026-08-02T06:39:45.952337920Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.327821] dockerd[1286]: time="2026-08-02T06:39:45.952640480Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.330042] dockerd[1286]: time="2026-08-02T06:39:45.952708840Z" level=info msg="skip loading plugin" error="lstat /var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 vm-test-run-docker> server # [ 20.334421] dockerd[1286]: time="2026-08-02T06:39:45.952721100Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 vm-test-run-docker> server # [ 20.336601] dockerd[1286]: time="2026-08-02T06:39:45.966536440Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 vm-test-run-docker> server # [ 20.338894] dockerd[1286]: time="2026-08-02T06:39:45.997845580Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 vm-test-run-docker> server # [ 20.341413] dockerd[1286]: time="2026-08-02T06:39:45.998006240Z" level=info msg="metadata content store policy set" policy=shared vm-test-run-docker> server # [ 20.350610] dockerd[1286]: time="2026-08-02T06:39:46.014228600Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 vm-test-run-docker> server # [ 20.353461] dockerd[1286]: time="2026-08-02T06:39:46.016593440Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 vm-test-run-docker> server # [ 20.355759] dockerd[1286]: time="2026-08-02T06:39:46.016671440Z" level=info msg="built-in NRI default validator is disabled" vm-test-run-docker> server # [ 20.357621] dockerd[1286]: time="2026-08-02T06:39:46.016719180Z" level=info msg="runtime interface created" vm-test-run-docker> server # [ 20.359125] dockerd[1286]: time="2026-08-02T06:39:46.016727940Z" level=info msg="created NRI interface" vm-test-run-docker> server # [ 20.360822] dockerd[1286]: time="2026-08-02T06:39:46.016753120Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 vm-test-run-docker> server # [ 20.369582] dockerd[1286]: time="2026-08-02T06:39:46.032497700Z" level=info msg="skip loading plugin" error="failed to check mkfs.erofs availability: failed to run mkfs.erofs --help: exec: \"mkfs.erofs\": executable file not found in $PATH: skip plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 vm-test-run-docker> server # [ 20.374436] dockerd[1286]: time="2026-08-02T06:39:46.032535380Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 vm-test-run-docker> server # [ 20.376866] dockerd[1286]: time="2026-08-02T06:39:46.032827580Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 vm-test-run-docker> server # [ 20.378992] dockerd[1286]: time="2026-08-02T06:39:46.032849360Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 vm-test-run-docker> server # [ 20.381405] dockerd[1286]: time="2026-08-02T06:39:46.032866520Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.383759] dockerd[1286]: time="2026-08-02T06:39:46.032890460Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.386150] dockerd[1286]: time="2026-08-02T06:39:46.032903880Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.388586] dockerd[1286]: time="2026-08-02T06:39:46.032918840Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.390651] dockerd[1286]: time="2026-08-02T06:39:46.032936380Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.393047] dockerd[1286]: time="2026-08-02T06:39:46.032950680Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.395343] dockerd[1286]: time="2026-08-02T06:39:46.032976220Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.397915] dockerd[1286]: time="2026-08-02T06:39:46.032991820Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 vm-test-run-docker> server # [ 20.400059] dockerd[1286]: time="2026-08-02T06:39:46.033007020Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 vm-test-run-docker> server # [ 20.402103] dockerd[1286]: time="2026-08-02T06:39:46.033168080Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 vm-test-run-docker> server # [ 20.404638] dockerd[1286]: time="2026-08-02T06:39:46.033192300Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.406866] dockerd[1286]: time="2026-08-02T06:39:46.033213500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.409023] dockerd[1286]: time="2026-08-02T06:39:46.037330540Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.410908] dockerd[1286]: time="2026-08-02T06:39:46.037374280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.413073] dockerd[1286]: time="2026-08-02T06:39:46.037392200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.415103] dockerd[1286]: time="2026-08-02T06:39:46.037412080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.417810] dockerd[1286]: time="2026-08-02T06:39:46.037671900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.420051] dockerd[1286]: time="2026-08-02T06:39:46.037715760Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.422126] dockerd[1286]: time="2026-08-02T06:39:46.037749900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.424380] dockerd[1286]: time="2026-08-02T06:39:46.037769200Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 vm-test-run-docker> server # [ 20.426552] dockerd[1286]: time="2026-08-02T06:39:46.037804080Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 vm-test-run-docker> server # [ 20.428922] dockerd[1286]: time="2026-08-02T06:39:46.037850740Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 vm-test-run-docker> server # [ 20.430963] dockerd[1286]: time="2026-08-02T06:39:46.037910380Z" level=info msg="Get image filesystem path \"/var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" vm-test-run-docker> server # [ 20.433740] dockerd[1286]: time="2026-08-02T06:39:46.037930140Z" level=info msg="Start snapshots syncer" vm-test-run-docker> server # [ 20.435225] dockerd[1286]: time="2026-08-02T06:39:46.081037780Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 vm-test-run-docker> server # [ 20.439848] dockerd[1286]: time="2026-08-02T06:39:46.103216260Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":false},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":false,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/docker/containerd/daemon\",\"containerdEndpoint\":\"/var/run/docker/containerd/containerd.sock\",\"rootDir\":\"/var/lib/docker/containerd/daemon/io.containerd.grpc.v1.cri\",\"stateDir\":\"/var/run/docker/containerd/daemon/io.containerd.grpc.v1.cri\"}" vm-test-run-docker> server # [ 20.473946] dockerd[1286]: time="2026-08-02T06:39:46.103327520Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 vm-test-run-docker> server # [ 20.476583] dockerd[1286]: time="2026-08-02T06:39:46.127813500Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 vm-test-run-docker> server # [ 20.479600] dockerd[1286]: time="2026-08-02T06:39:46.128072160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.481794] dockerd[1286]: time="2026-08-02T06:39:46.128100440Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.484198] dockerd[1286]: time="2026-08-02T06:39:46.128123340Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.486114] dockerd[1286]: time="2026-08-02T06:39:46.128140340Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 vm-test-run-docker> server # [ 20.488109] dockerd[1286]: time="2026-08-02T06:39:46.128187220Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.489864] dockerd[1286]: time="2026-08-02T06:39:46.128225160Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.491734] dockerd[1286]: time="2026-08-02T06:39:46.128242740Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.494218] dockerd[1286]: time="2026-08-02T06:39:46.128260600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.497063] dockerd[1286]: time="2026-08-02T06:39:46.128274120Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 vm-test-run-docker> server # [ 20.499310] dockerd[1286]: time="2026-08-02T06:39:46.130206460Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 vm-test-run-docker> server # [ 20.501714] dockerd[1286]: time="2026-08-02T06:39:46.130238320Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 vm-test-run-docker> server # [ 20.505318] dockerd[1286]: time="2026-08-02T06:39:46.130249560Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 vm-test-run-docker> server # [ 20.507480] dockerd[1286]: time="2026-08-02T06:39:46.130263120Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 vm-test-run-docker> server # [ 20.510933] dockerd[1286]: time="2026-08-02T06:39:46.130273800Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 vm-test-run-docker> server # [ 20.513091] dockerd[1286]: time="2026-08-02T06:39:46.130289060Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 vm-test-run-docker> server # [ 20.515494] dockerd[1286]: time="2026-08-02T06:39:46.160054940Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock vm-test-run-docker> server # [ 20.517567] dockerd[1286]: time="2026-08-02T06:39:46.160150340Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc vm-test-run-docker> server # [ 20.519405] dockerd[1286]: time="2026-08-02T06:39:46.160212580Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock vm-test-run-docker> server # [ 20.525187] dockerd[1286]: time="2026-08-02T06:39:46.160240800Z" level=info msg="containerd successfully booted in 0.239747s" vm-test-run-docker> server # [ 20.548684] dockerd[1271]: time="2026-08-02T06:39:46.212161840Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" vm-test-run-docker> server # [ 20.551896] dockerd[1271]: time="2026-08-02T06:39:46.215589260Z" level=info msg="CDI directory does not exist, skipping" dir=/etc/cdi vm-test-run-docker> server # [ 20.553813] dockerd[1271]: time="2026-08-02T06:39:46.217398480Z" level=info msg="CDI directory does not exist, skipping" dir=/var/run/cdi vm-test-run-docker> server # [ 20.728092] dockerd[1271]: time="2026-08-02T06:39:46.391673560Z" level=info msg="Creating a containerd client" address=/var/run/docker/containerd/containerd.sock timeout=1m0s vm-test-run-docker> server # [ 20.748461] dockerd[1271]: time="2026-08-02T06:39:46.411484620Z" level=info msg="Loading containers: start." vm-test-run-docker> server # [ 20.751388] dockerd[1271]: time="2026-08-02T06:39:46.411577080Z" level=info msg="NRI is disabled" vm-test-run-docker> server # [ 20.753152] dockerd[1271]: time="2026-08-02T06:39:46.411588480Z" level=info msg="Starting daemon with containerd snapshotter integration enabled" vm-test-run-docker> server # [ 20.762926] dockerd[1271]: time="2026-08-02T06:39:46.426559520Z" level=info msg="Restoring containers: start." vm-test-run-docker> server # [ 20.791667] dockerd[1271]: time="2026-08-02T06:39:46.455226060Z" level=info msg="Deleting nftables IPv4 rules" error="exec: \"nft\": executable file not found in $PATH" output= vm-test-run-docker> server # [ 20.794599] dockerd[1271]: time="2026-08-02T06:39:46.457961060Z" level=info msg="Deleting nftables IPv6 rules" error="exec: \"nft\": executable file not found in $PATH" output= vm-test-run-docker> server # [ 21.715132] Initializing XFRM netlink socket vm-test-run-docker> server # [ 21.791314] (udev-worker)[1295]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 21.986427] dockerd[1271]: time="2026-08-02T06:39:47.649551180Z" level=info msg="Loading containers: done." vm-test-run-docker> server # [ 22.021656] dockerd[1271]: time="2026-08-02T06:39:47.685248880Z" level=info msg="Docker daemon" commit=v29.4.3 containerd-snapshotter=true storage-driver=overlayfs version=29.4.3 vm-test-run-docker> server # [ 22.024556] dockerd[1271]: time="2026-08-02T06:39:47.688227320Z" level=info msg="Initializing buildkit" vm-test-run-docker> server # [ 22.087358] dockerd[1271]: time="2026-08-02T06:39:47.750839560Z" level=info msg="Completed buildkit initialization" vm-test-run-docker> server # [ 22.097591] dockerd[1271]: time="2026-08-02T06:39:47.760920140Z" level=info msg="Daemon has completed initialization" vm-test-run-docker> server # [ 22.099130] dockerd[1271]: time="2026-08-02T06:39:47.761120900Z" level=info msg="API listen on /run/docker.sock" vm-test-run-docker> server # [ 22.102638] dockerd[1271]: time="2026-08-02T06:39:47.761279860Z" level=info msg="API listen on /run/docker.sock" vm-test-run-docker> server # [ 22.105586] systemd[1]: Started Docker Application Container Engine. vm-test-run-docker> server # [ 22.108756] systemd[1]: Starting docker-busybox.service... vm-test-run-docker> server # [ 22.501906] pre-start[1470]: Error response from daemon: No such container: busybox vm-test-run-docker> server # [ 23.491864] dockerd[1271]: time="2026-08-02T06:39:49.154860080Z" level=error msg="failed to validate image signature" error="resolving signature chain for image sha256:c95c3b019441235b79a6e0f243302df15dd8ee990a634ee9be3f608ea90c188c: expected image index descriptor, got application/vnd.docker.distribution.manifest.v2+json" vm-test-run-docker> server # [ 23.514012] systemd[1]: var-lib-docker-containerd-daemon-tmpmounts-containerd\x2dmount1857109736.mount: Deactivated successfully. vm-test-run-docker> server # [ 24.039085] pre-start[1480]: Loaded image: busybox-test:latest vm-test-run-docker> server # [ 24.050844] systemd[1]: Started docker-busybox.service. vm-test-run-docker> server # [ 24.052415] systemd[1]: Reached target Multi-User System. vm-test-run-docker> server # [ 24.053553] systemd[1]: Startup finished in 909ms (kernel) + 5.105s (initrd) + 18.037s (userspace) = 24.052s. vm-test-run-docker> server # [ 24.153105] systemd[1]: tmp-containerd\x2dmount3507847360.mount: Deactivated successfully. vm-test-run-docker> server # [ 24.397763] dockerd[1286]: time="2026-08-02T06:39:50.060637340Z" level=info msg="connecting to shim b1183af2f2f5b66d6da1a0bf6a6dc34e5893ac2559e6dbf4b5b13fb1c8f30f5d" address="unix:///run/containerd/s/159d4511b9a70aaeadc7981221b4fea7bb63626844051f9b7a145254cb86df9c" namespace=moby protocol=ttrpc version=3 vm-test-run-docker> server: (finished: waiting for unit docker-busybox.service, in 24.78 seconds) vm-test-run-docker> server: must succeed: cntr attach busybox true vm-test-run-docker> server # [ 24.493405] systemd[1]: Started libcontainer container b1183af2f2f5b66d6da1a0bf6a6dc34e5893ac2559e6dbf4b5b13fb1c8f30f5d. vm-test-run-docker> server # [ 24.619696] docker0: port 1(vethede789c) entered blocking state vm-test-run-docker> server # [ 24.619752] docker0: port 1(vethede789c) entered disabled state vm-test-run-docker> server # [ 24.619792] vethede789c: entered allmulticast mode vm-test-run-docker> server # [ 24.619897] vethede789c: entered promiscuous mode vm-test-run-docker> server # [ 24.602741] (udev-worker)[1491]: Network interface NamePolicy= disabled on kernel command line. vm-test-run-docker> server # [ 24.677976] eth0: renamed from veth6e93235 vm-test-run-docker> server # [ 24.682706] docker0: port 1(vethede789c) entered blocking state vm-test-run-docker> server # [ 24.682759] docker0: port 1(vethede789c) entered forwarding state vm-test-run-docker> server # [ 24.674818] dockerd[1271]: time="2026-08-02T06:39:50.337963220Z" level=info msg="sbJoin: gwep4 ''->'b3cbde300473', gwep6 ''->''" eid=b3cbde300473 ep=busybox net=bridge nid=e99a6e995be3 vm-test-run-docker> server # [ 24.739275] dhcpcd[1099]: vethede789c: waiting for carrier vm-test-run-docker> server # [ 24.742832] dhcpcd[1099]: vethede789c: carrier acquired vm-test-run-docker> server # [ 24.762042] dhcpcd[1099]: vethede789c: IAID 09:d1:8d:d9 vm-test-run-docker> server # [ 24.763388] dhcpcd[1099]: vethede789c: adding address fe80::f889:9ff:fed1:8dd9 vm-test-run-docker> server: (finished: must succeed: cntr attach busybox true, in 0.32 seconds) vm-test-run-docker> server: must succeed: cntr exec busybox -- /bin/sh -c 'echo exec test passed' vm-test-run-docker> server: (finished: must succeed: cntr exec busybox -- /bin/sh -c 'echo exec test passed', in 0.07 seconds) vm-test-run-docker> (finished: run the VM test script, in 25.63 seconds) vm-test-run-docker> test script finished in 25.68s vm-test-run-docker> cleanup vm-test-run-docker> kill QemuMachine (pid 13) vm-test-run-docker> server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/36mns0lq3c2zgky08rsq0xvamfzglzvj-python3-3.13.12/bin/python3.13) vm-test-run-docker> (finished: cleanup, in 0.21 seconds) vm-test-run-docker> additionally exposed symbols: vm-test-run-docker> server, vm-test-run-docker> vlan1, vm-test-run-docker> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh post-build step Upload coverage to codecov: ok Skipping codecov: project=Mic92/cntr attr=default.checks.aarch64-linux.docker