nixbot

builds

failed x86_64-linux.docker build #4 · raw · ·

1these 16 derivations will be built:2  /nix/store/wlgpwnc125n32nkxwca7bsqkj114hzgl-system-path.drv3  /nix/store/apr38giq2dn3l55511wdp8bf7dz3h3a4-dbus-1.drv4  /nix/store/01frsppd6h8vvilqpdh9ckd852bs3cx1-X-Restart-Triggers-dbus-broker.drv5  /nix/store/15jcma1cfzfgpcdaqb0g9bs463brfnsv-unit-dbus-broker.service.drv6  /nix/store/5fklq3mfsk67vn5wikkmi5arn3dd21j1-unit-dbus-broker.service.drv7  /nix/store/knd544fb0rh4vlm1879hcdyx0n9k4cvy-user-units.drv8  /nix/store/v9xa95mj8y5g2m37nzlii7cli1gghkda-system-units.drv9  /nix/store/nkw3x20qx1m6wgzcvfpdf4wyihnld34n-etc.drv10  /nix/store/xsby4yvdchwl5qa90akqdnsk5v4qinmj-activate.drv11  /nix/store/lfm60b44av63z613dxd6k6p5amvckbnh-nixos-system-server-test.drv12  /nix/store/q7akx9vlv9l17z7msd8ydhh9yzd7q1kl-closure-info.drv13  /nix/store/r1x6m7wai0xvrl70rnazwxravfyk62zz-run-nixos-vm.drv14  /nix/store/ayni2pqi0mwh0nxf209v6y6dlzjw2aw2-nixos-vm.drv15  /nix/store/s4ljlardwn547h1rx24d3k5665d4bfqm-driverConfiguration.json.drv16  /nix/store/g6sq3dzb8gs1k3dnvmd5zbip87prhy99-nixos-test-driver-docker.drv17  /nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv18building '/nix/store/wlgpwnc125n32nkxwca7bsqkj114hzgl-system-path.drv'19system-path> structuredAttrs is enabled20system-path> created 6811 symlinks in user environment21system-path> install-info: warning: no info dir entry in `/nix/store/75ngg01d1p6hc64yzj4a87nmnzy3gj0m-system-path/share/info/notes.info'22building '/nix/store/apr38giq2dn3l55511wdp8bf7dz3h3a4-dbus-1.drv'23building '/nix/store/01frsppd6h8vvilqpdh9ckd852bs3cx1-X-Restart-Triggers-dbus-broker.drv'24building '/nix/store/15jcma1cfzfgpcdaqb0g9bs463brfnsv-unit-dbus-broker.service.drv'25building '/nix/store/5fklq3mfsk67vn5wikkmi5arn3dd21j1-unit-dbus-broker.service.drv'26building '/nix/store/knd544fb0rh4vlm1879hcdyx0n9k4cvy-user-units.drv'27building '/nix/store/v9xa95mj8y5g2m37nzlii7cli1gghkda-system-units.drv'28building '/nix/store/nkw3x20qx1m6wgzcvfpdf4wyihnld34n-etc.drv'29building '/nix/store/xsby4yvdchwl5qa90akqdnsk5v4qinmj-activate.drv'30building '/nix/store/lfm60b44av63z613dxd6k6p5amvckbnh-nixos-system-server-test.drv'31building '/nix/store/q7akx9vlv9l17z7msd8ydhh9yzd7q1kl-closure-info.drv'32closure-info> structuredAttrs is enabled33building '/nix/store/r1x6m7wai0xvrl70rnazwxravfyk62zz-run-nixos-vm.drv'34building '/nix/store/ayni2pqi0mwh0nxf209v6y6dlzjw2aw2-nixos-vm.drv'35building '/nix/store/s4ljlardwn547h1rx24d3k5665d4bfqm-driverConfiguration.json.drv'36building '/nix/store/g6sq3dzb8gs1k3dnvmd5zbip87prhy99-nixos-test-driver-docker.drv'37nixos-test-driver-docker> Running type check (enable/disable: config.skipTypeCheck)38nixos-test-driver-docker> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck39nixos-test-driver-docker> All checks passed!40nixos-test-driver-docker> Linting test script (enable/disable: config.skipLint)41nixos-test-driver-docker> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint42nixos-test-driver-docker> All checks passed!43building '/nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv' on 'ssh-ng://nix@jamie'44building '/nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv'45vm-test-run-docker> Machine state will be reset. To keep it, pass --keep-machine-state46vm-test-run-docker> start all VLans47vm-test-run-docker> (finished: start all VLans, in 0.00 seconds)48vm-test-run-docker> Test will time out and terminate in 3600 seconds49vm-test-run-docker> run the VM test script50vm-test-run-docker> additionally exposed symbols:51vm-test-run-docker>     server,52vm-test-run-docker>     vlan1,53vm-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_ssh54vm-test-run-docker> start all VMs55vm-test-run-docker> server: starting vm56vm-test-run-docker> server # Disk image does not exist, creating the virtualisation disk image...57vm-test-run-docker> server: QEMU running (pid 13)58vm-test-run-docker> server # Formatting '/build/vm-state-server/tmp.00b844G6Bl', fmt=raw size=107374182459vm-test-run-docker> server # mke2fs 1.47.3 (8-Jul-2025)60vm-test-run-docker> server # Discarding device blocks:      0/262144             done61vm-test-run-docker> server # Creating filesystem with 262144 4k blocks and 65536 inodes62vm-test-run-docker> server # Filesystem UUID: f80a0f2b-dfce-47fd-82a1-a90ac8eefcbb63vm-test-run-docker> server # Superblock backups stored on blocks:64vm-test-run-docker> server # 	32768, 98304, 163840, 22937665vm-test-run-docker> (finished: start all VMs, in 0.31 seconds)66vm-test-run-docker> server # 67vm-test-run-docker> server: waiting for unit docker-busybox.service68vm-test-run-docker> server # Allocating group tables: 0/8   done69vm-test-run-docker> server: waiting for the VM to finish booting70vm-test-run-docker> server # Writing inode tables: 0/8   done71vm-test-run-docker> server # Creating journal (8192 blocks): done72vm-test-run-docker> server # Writing superblocks and filesystem accounting information: 0/8   done73vm-test-run-docker> server # 74vm-test-run-docker> server # Virtualisation disk image created.75vm-test-run-docker> server # SeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)76vm-test-run-docker> server # 77vm-test-run-docker> server # 78vm-test-run-docker> server # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA0079vm-test-run-docker> server # Press Ctrl-B to configure iPXE (PCI 00:03.0)...80vm-test-run-docker> server # 81vm-test-run-docker> server # 82vm-test-run-docker> server # 83vm-test-run-docker> server # 84vm-test-run-docker> server # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB0085vm-test-run-docker> server # Press Ctrl-B to configure iPXE (PCI 00:09.0)...86vm-test-run-docker> server # 87vm-test-run-docker> server # 88vm-test-run-docker> server # Booting from ROM...89vm-test-run-docker> server # Probing EDD (edd=off to disable)... ok90vm-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_DYNAMIC Fri May 15 12:52:18 UTC 202691vm-test-run-docker> server # [    0.000000] Command line: console=ttyS0 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/cj14f5psqa7vw3v0gcb3hv9j15ybnfm8-nixos-system-server-test/init regInfo=/nix/store/mw6zv69d731hnkhk9liysfvqas3v103n-closure-info/registration console=ttyS0,115200n8 console=tty092vm-test-run-docker> server # [    0.000000] BIOS-provided physical RAM map:93vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable94vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved95vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved96vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable97vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved98vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved99vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved100vm-test-run-docker> server # [    0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved101vm-test-run-docker> server # [    0.000000] NX (Execute Disable) protection: active102vm-test-run-docker> server # [    0.000000] APIC: Static calls initialized103vm-test-run-docker> server # [    0.000000] SMBIOS 2.8 present.104vm-test-run-docker> server # [    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014105vm-test-run-docker> server # [    0.000000] DMI: Memory slots populated: 1/1106vm-test-run-docker> server # [    0.000000] Hypervisor detected: KVM107vm-test-run-docker> server # [    0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x10000000000108vm-test-run-docker> server # [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00109vm-test-run-docker> server # [    0.000000] kvm-clock: using sched offset of 484098967 cycles110vm-test-run-docker> server # [    0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns111vm-test-run-docker> server # [    0.000005] tsc: Detected 2400.008 MHz processor112vm-test-run-docker> server # [    0.000814] last_pfn = 0x3ffdb max_arch_pfn = 0x10000000000113vm-test-run-docker> server # [    0.000850] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs114vm-test-run-docker> server # [    0.000853] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WP  UC- WT115vm-test-run-docker> server # [    0.002770] found SMP MP-table at [mem 0x000f5470-0x000f547f]116vm-test-run-docker> server # [    0.002782] Using GB pages for direct mapping117vm-test-run-docker> server # [    0.002879] RAMDISK: [mem 0x3e504000-0x3ffcffff]118vm-test-run-docker> server # [    0.002888] ACPI: Early table checksum verification disabled119vm-test-run-docker> server # [    0.002890] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )120vm-test-run-docker> server # [    0.002894] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS  BXPC     00000001 BXPC 00000001)121vm-test-run-docker> server # [    0.002898] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS  BXPC     00000001 BXPC 00000001)122vm-test-run-docker> server # [    0.002906] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS  BXPC     00000001 BXPC 00000001)123vm-test-run-docker> server # [    0.002908] ACPI: FACS 0x000000003FFE0000 000040124vm-test-run-docker> server # [    0.002909] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS  BXPC     00000001 BXPC 00000001)125vm-test-run-docker> server # [    0.002911] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS  BXPC     00000001 BXPC 00000001)126vm-test-run-docker> server # [    0.002913] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS  BXPC     00000001 BXPC 00000001)127vm-test-run-docker> server # [    0.002914] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]128vm-test-run-docker> server # [    0.002915] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]129vm-test-run-docker> server # [    0.002916] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]130vm-test-run-docker> server # [    0.002916] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]131vm-test-run-docker> server # [    0.002917] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]132vm-test-run-docker> server # [    0.002917] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]133vm-test-run-docker> server # [    0.003390] No NUMA configuration found134vm-test-run-docker> server # [    0.003392] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]135vm-test-run-docker> server # [    0.003395] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]136vm-test-run-docker> server # [    0.006414] Zone ranges:137vm-test-run-docker> server # [    0.006415]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]138vm-test-run-docker> server # [    0.006417]   DMA32    [mem 0x0000000001000000-0x000000003ffdafff]139vm-test-run-docker> server # [    0.006418]   Normal   empty140vm-test-run-docker> server # [    0.006419]   Device   empty141vm-test-run-docker> server # [    0.006420] Movable zone start for each node142vm-test-run-docker> server # [    0.006421] Early memory node ranges143vm-test-run-docker> server # [    0.006421]   node   0: [mem 0x0000000000001000-0x000000000009efff]144vm-test-run-docker> server # [    0.006422]   node   0: [mem 0x0000000000100000-0x000000003ffdafff]145vm-test-run-docker> server # [    0.006423] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]146vm-test-run-docker> server # [    0.006514] On node 0, zone DMA: 1 pages in unavailable ranges147vm-test-run-docker> server # [    0.006811] On node 0, zone DMA: 97 pages in unavailable ranges148vm-test-run-docker> server # [    0.026794] On node 0, zone DMA32: 37 pages in unavailable ranges149vm-test-run-docker> server # [    0.027769] ACPI: PM-Timer IO Port: 0x608150vm-test-run-docker> server # [    0.027783] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])151vm-test-run-docker> server # [    0.027812] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23152vm-test-run-docker> server # [    0.027815] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)153vm-test-run-docker> server # [    0.027816] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)154vm-test-run-docker> server # [    0.027818] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)155vm-test-run-docker> server # [    0.027819] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)156vm-test-run-docker> server # [    0.027820] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)157vm-test-run-docker> server # [    0.027822] ACPI: Using ACPI (MADT) for SMP configuration information158vm-test-run-docker> server # [    0.027823] ACPI: HPET id: 0x8086a201 base: 0xfed00000159vm-test-run-docker> server # [    0.027827] TSC deadline timer available160vm-test-run-docker> server # [    0.027832] CPU topo: Max. logical packages:   1161vm-test-run-docker> server # [    0.027832] CPU topo: Max. logical dies:       1162vm-test-run-docker> server # [    0.027833] CPU topo: Max. dies per package:   1163vm-test-run-docker> server # [    0.027836] CPU topo: Max. threads per core:   1164vm-test-run-docker> server # [    0.027837] CPU topo: Num. cores per package:     1165vm-test-run-docker> server # [    0.027837] CPU topo: Num. threads per package:   1166vm-test-run-docker> server # [    0.027837] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs167vm-test-run-docker> server # [    0.027856] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()168vm-test-run-docker> server # [    0.027892] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]169vm-test-run-docker> server # [    0.027894] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]170vm-test-run-docker> server # [    0.027896] [mem 0x40000000-0xfeffbfff] available for PCI devices171vm-test-run-docker> server # [    0.027897] Booting paravirtualized kernel on KVM172vm-test-run-docker> server # [    0.027900] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns173vm-test-run-docker> server # [    0.032371] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1174vm-test-run-docker> server # [    0.034821] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152175vm-test-run-docker> server # [    0.034865] kvm-guest: PV spinlocks disabled, single CPU176vm-test-run-docker> server # [    0.034866] Kernel command line: console=ttyS0 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/cj14f5psqa7vw3v0gcb3hv9j15ybnfm8-nixos-system-server-test/init regInfo=/nix/store/mw6zv69d731hnkhk9liysfvqas3v103n-closure-info/registration console=ttyS0,115200n8 console=tty0177vm-test-run-docker> server # [    0.034959] Unknown kernel command line parameters "regInfo=/nix/store/mw6zv69d731hnkhk9liysfvqas3v103n-closure-info/registration", will be passed to user space.178vm-test-run-docker> server # [    0.034972] random: crng init done179vm-test-run-docker> server # [    0.034972] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes180vm-test-run-docker> server # [    0.036178] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)181vm-test-run-docker> server # [    0.036191] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)182vm-test-run-docker> server # [    0.036216] Fallback order for Node 0: 0183vm-test-run-docker> server # [    0.036219] Built 1 zonelists, mobility grouping on.  Total pages: 262009184vm-test-run-docker> server # [    0.036220] Policy zone: DMA32185vm-test-run-docker> server # [    0.038636] mem auto-init: stack:all(zero), heap alloc:on, heap free:off186vm-test-run-docker> server # [    0.041171] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1187vm-test-run-docker> server # [    0.044070] allocated 2097152 bytes of page_ext188vm-test-run-docker> server # [    0.053991] ftrace: allocating 48458 entries in 192 pages189vm-test-run-docker> server # [    0.053993] ftrace: allocated 192 pages with 2 groups190vm-test-run-docker> server # [    0.055174] Dynamic Preempt: voluntary191vm-test-run-docker> server # [    0.055368] rcu: Preemptible hierarchical RCU implementation.192vm-test-run-docker> server # [    0.055368] rcu: 	RCU event tracing is enabled.193vm-test-run-docker> server # [    0.055369] rcu: 	RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.194vm-test-run-docker> server # [    0.055370] 	Trampoline variant of Tasks RCU enabled.195vm-test-run-docker> server # [    0.055371] 	Rude variant of Tasks RCU enabled.196vm-test-run-docker> server # [    0.055371] 	Tracing variant of Tasks RCU enabled.197vm-test-run-docker> server # [    0.055372] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.198vm-test-run-docker> server # [    0.055372] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1199vm-test-run-docker> server # [    0.055397] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.200vm-test-run-docker> server # [    0.055399] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.201vm-test-run-docker> server # [    0.055400] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.202vm-test-run-docker> server # [    0.059895] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16203vm-test-run-docker> server # [    0.060174] rcu: srcu_init: Setting srcu_struct sizes based on contention.204vm-test-run-docker> server # [    0.060283] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)205vm-test-run-docker> server # [    0.067380] Console: colour VGA+ 80x25206vm-test-run-docker> server # [    0.067384] printk: legacy console [tty0] enabled207vm-test-run-docker> server # [    0.107485] printk: legacy console [ttyS0] enabled208vm-test-run-docker> server # [    0.293386] ACPI: Core revision 20250807209vm-test-run-docker> server # [    0.294953] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns210vm-test-run-docker> server # [    0.297688] APIC: Switch to symmetric I/O mode setup211vm-test-run-docker> server # [    0.299406] x2apic enabled212vm-test-run-docker> server # [    0.300634] APIC: Switched APIC routing to: physical x2apic213vm-test-run-docker> server # [    0.303403] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1214vm-test-run-docker> server # [    0.305236] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns215vm-test-run-docker> server # [    0.308307] Calibrating delay loop (skipped) preset value.. 4800.01 BogoMIPS (lpj=2400008)216vm-test-run-docker> server # [    0.310419] x86/cpu: User Mode Instruction Prevention (UMIP) activated217vm-test-run-docker> server # [    0.311446] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127218vm-test-run-docker> server # [    0.312306] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0219vm-test-run-docker> server # [    0.313311] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto220vm-test-run-docker> server # [    0.314306] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl221vm-test-run-docker> server # [    0.315315] Spectre V2 : Mitigation: Enhanced / Automatic IBRS222vm-test-run-docker> server # [    0.317305] Speculative Return Stack Overflow: Mitigation: Safe RET223vm-test-run-docker> server # [    0.318305] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization224vm-test-run-docker> server # [    0.319311] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier225vm-test-run-docker> server # [    0.321306] active return thunk: srso_alias_return_thunk226vm-test-run-docker> server # [    0.322330] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'227vm-test-run-docker> server # [    0.323305] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'228vm-test-run-docker> server # [    0.324305] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'229vm-test-run-docker> server # [    0.325305] x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask'230vm-test-run-docker> server # [    0.327305] x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256'231vm-test-run-docker> server # [    0.328305] x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256'232vm-test-run-docker> server # [    0.329305] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'233vm-test-run-docker> server # [    0.330306] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256234vm-test-run-docker> server # [    0.331305] x86/fpu: xstate_offset[5]:  832, xstate_sizes[5]:   64235vm-test-run-docker> server # [    0.332305] x86/fpu: xstate_offset[6]:  896, xstate_sizes[6]:  512236vm-test-run-docker> server # [    0.333305] x86/fpu: xstate_offset[7]: 1408, xstate_sizes[7]: 1024237vm-test-run-docker> server # [    0.334306] x86/fpu: xstate_offset[9]: 2432, xstate_sizes[9]:    8238vm-test-run-docker> server # [    0.336305] x86/fpu: Enabled xstate features 0x2e7, context size is 2440 bytes, using 'compacted' format.239vm-test-run-docker> server # [    0.372201] Freeing SMP alternatives memory: 44K240vm-test-run-docker> server # [    0.373308] pid_max: default: 32768 minimum: 301241vm-test-run-docker> server # [    0.374427] LSM: initializing lsm=capability,landlock,yama,bpf,ima242vm-test-run-docker> server # [    0.376418] landlock: Up and running.243vm-test-run-docker> server # [    0.378306] Yama: becoming mindful.244vm-test-run-docker> server # [    0.379528] LSM support for eBPF active245vm-test-run-docker> server # [    0.380424] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)246vm-test-run-docker> server # [    0.382334] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)247vm-test-run-docker> server # [    0.384817] smpboot: CPU0: AMD EPYC 9654 96-Core Processor (family: 0x19, model: 0x11, stepping: 0x1)248vm-test-run-docker> server # [    0.385977] Performance Events: Fam17h+ core perfctr, AMD PMU driver.249vm-test-run-docker> server # [    0.387310] ... version:                   2250vm-test-run-docker> server # [    0.388307] ... bit width:                 48251vm-test-run-docker> server # [    0.389307] ... generic counters:          6252vm-test-run-docker> server # [    0.390307] ... generic bitmap:            000000000000003f253vm-test-run-docker> server # [    0.391307] ... fixed-purpose counters:    0254vm-test-run-docker> server # [    0.392307] ... fixed-purpose bitmap:      0000000000000000255vm-test-run-docker> server # [    0.393307] ... value mask:                0000ffffffffffff256vm-test-run-docker> server # [    0.394307] ... max period:                00007fffffffffff257vm-test-run-docker> server # [    0.395307] ... global_ctrl mask:          000000000000003f258vm-test-run-docker> server # [    0.396432] signal: max sigframe size: 3376259vm-test-run-docker> server # [    0.397423] rcu: Hierarchical SRCU implementation.260vm-test-run-docker> server # [    0.398308] rcu: 	Max phase no-delay instances is 400.261vm-test-run-docker> server # [    0.404289] smp: Bringing up secondary CPUs ...262vm-test-run-docker> server # [    0.405321] smp: Brought up 1 node, 1 CPU263vm-test-run-docker> server # [    0.406310] smpboot: Total of 1 processors activated (4800.01 BogoMIPS)264vm-test-run-docker> server # [    0.407510] Memory: 942712K/1048036K available (17070K kernel code, 2717K rwdata, 13492K rodata, 3636K init, 3028K bss, 97964K reserved, 0K cma-reserved)265vm-test-run-docker> server # [    0.408562] devtmpfs: initialized266vm-test-run-docker> server # [    0.409554] x86/mm: Memory block size: 128MB267vm-test-run-docker> server # [    0.411383] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns268vm-test-run-docker> server # [    0.412341] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)269vm-test-run-docker> server # [    0.413339] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).270vm-test-run-docker> server # [    0.414405] pinctrl core: initialized pinctrl subsystem271vm-test-run-docker> server # [    0.415644] PM: RTC time: 06:43:58, date: 2026-06-08272vm-test-run-docker> server # [    0.419381] NET: Registered PF_NETLINK/PF_ROUTE protocol family273vm-test-run-docker> server # [    0.420703] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations274vm-test-run-docker> server # [    0.421333] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations275vm-test-run-docker> server # [    0.422488] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations276vm-test-run-docker> server # [    0.423318] audit: initializing netlink subsys (disabled)277vm-test-run-docker> server # [    0.424640] thermal_sys: Registered thermal governor 'fair_share'278vm-test-run-docker> server # [    0.424643] thermal_sys: Registered thermal governor 'bang_bang'279vm-test-run-docker> server # [    0.425311] audit: type=2000 audit(1780901039.115:1): state=initialized audit_enabled=0 res=1280vm-test-run-docker> server # [    0.427311] thermal_sys: Registered thermal governor 'step_wise'281vm-test-run-docker> server # [    0.427313] thermal_sys: Registered thermal governor 'user_space'282vm-test-run-docker> server # [    0.428308] thermal_sys: Registered thermal governor 'power_allocator'283vm-test-run-docker> server # [    0.429327] cpuidle: using governor menu284vm-test-run-docker> server # [    0.432490] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5285vm-test-run-docker> server # [    0.433619] PCI: Using configuration type 1 for base access286vm-test-run-docker> server # [    0.434308] PCI: Using configuration type 1 for extended access287vm-test-run-docker> server # [    0.435543] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.288vm-test-run-docker> server # [    0.461342] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages289vm-test-run-docker> server # [    0.462310] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page290vm-test-run-docker> server # [    0.463309] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages291vm-test-run-docker> server # [    0.464307] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page292vm-test-run-docker> server # [    0.471919] ACPI: Added _OSI(Module Device)293vm-test-run-docker> server # [    0.472316] ACPI: Added _OSI(Processor Device)294vm-test-run-docker> server # [    0.474336] ACPI: Added _OSI(Processor Aggregator Device)295vm-test-run-docker> server # [    0.477581] ACPI: 1 ACPI AML tables successfully acquired and loaded296vm-test-run-docker> server # [    0.479563] ACPI: Interpreter enabled297vm-test-run-docker> server # [    0.480325] ACPI: PM: (supports S0 S3 S4 S5)298vm-test-run-docker> server # [    0.481308] ACPI: Using IOAPIC for interrupt routing299vm-test-run-docker> server # [    0.482329] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug300vm-test-run-docker> server # [    0.483307] PCI: Using E820 reservations for host bridge windows301vm-test-run-docker> server # [    0.484468] ACPI: Enabled 2 GPEs in block 00 to 0F302vm-test-run-docker> server # [    0.489937] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])303vm-test-run-docker> server # [    0.490314] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]304vm-test-run-docker> server # [    0.491903] acpiphp: Slot [3] registered305vm-test-run-docker> server # [    0.492361] acpiphp: Slot [4] registered306vm-test-run-docker> server # [    0.493425] acpiphp: Slot [5] registered307vm-test-run-docker> server # [    0.494363] acpiphp: Slot [6] registered308vm-test-run-docker> server # [    0.495345] acpiphp: Slot [7] registered309vm-test-run-docker> server # [    0.496366] acpiphp: Slot [8] registered310vm-test-run-docker> server # [    0.497345] acpiphp: Slot [9] registered311vm-test-run-docker> server # [    0.498344] acpiphp: Slot [10] registered312vm-test-run-docker> server # [    0.499348] acpiphp: Slot [11] registered313vm-test-run-docker> server # [    0.500362] acpiphp: Slot [12] registered314vm-test-run-docker> server # [    0.501345] acpiphp: Slot [13] registered315vm-test-run-docker> server # [    0.502350] acpiphp: Slot [14] registered316vm-test-run-docker> server # [    0.503340] acpiphp: Slot [15] registered317vm-test-run-docker> server # [    0.504355] acpiphp: Slot [16] registered318vm-test-run-docker> server # [    0.505341] acpiphp: Slot [17] registered319vm-test-run-docker> server # [    0.506341] acpiphp: Slot [18] registered320vm-test-run-docker> server # [    0.507359] acpiphp: Slot [19] registered321vm-test-run-docker> server # [    0.508341] acpiphp: Slot [20] registered322vm-test-run-docker> server # [    0.509341] acpiphp: Slot [21] registered323vm-test-run-docker> server # [    0.510340] acpiphp: Slot [22] registered324vm-test-run-docker> server # [    0.511357] acpiphp: Slot [23] registered325vm-test-run-docker> server # [    0.512342] acpiphp: Slot [24] registered326vm-test-run-docker> server # [    0.513355] acpiphp: Slot [25] registered327vm-test-run-docker> server # [    0.514341] acpiphp: Slot [26] registered328vm-test-run-docker> server # [    0.515354] acpiphp: Slot [27] registered329vm-test-run-docker> server # [    0.516355] acpiphp: Slot [28] registered330vm-test-run-docker> server # [    0.517341] acpiphp: Slot [29] registered331vm-test-run-docker> server # [    0.518341] acpiphp: Slot [30] registered332vm-test-run-docker> server # [    0.519357] acpiphp: Slot [31] registered333vm-test-run-docker> server # [    0.520331] PCI host bridge to bus 0000:00334vm-test-run-docker> server # [    0.521314] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]335vm-test-run-docker> server # [    0.522308] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]336vm-test-run-docker> server # [    0.523309] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]337vm-test-run-docker> server # [    0.524308] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]338vm-test-run-docker> server # [    0.525308] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]339vm-test-run-docker> server # [    0.526309] pci_bus 0000:00: root bus resource [bus 00-ff]340vm-test-run-docker> server # [    0.527704] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint341vm-test-run-docker> server # [    0.529220] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint342vm-test-run-docker> server # [    0.531233] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint343vm-test-run-docker> server # [    0.533999] pci 0000:00:01.1: BAR 4 [io  0xc1e0-0xc1ef]344vm-test-run-docker> server # [    0.534374] pci 0000:00:01.1: BAR 0 [io  0x01f0-0x01f7]: legacy IDE quirk345vm-test-run-docker> server # [    0.535308] pci 0000:00:01.1: BAR 1 [io  0x03f6]: legacy IDE quirk346vm-test-run-docker> server # [    0.536308] pci 0000:00:01.1: BAR 2 [io  0x0170-0x0177]: legacy IDE quirk347vm-test-run-docker> server # [    0.537308] pci 0000:00:01.1: BAR 3 [io  0x0376]: legacy IDE quirk348vm-test-run-docker> server # [    0.538644] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint349vm-test-run-docker> server # [    0.540373] pci 0000:00:01.2: BAR 4 [io  0xc100-0xc11f]350vm-test-run-docker> server # [    0.542543] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint351vm-test-run-docker> server # [    0.544030] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI352vm-test-run-docker> server # [    0.545323] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB353vm-test-run-docker> server # [    0.546738] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint354vm-test-run-docker> server # [    0.549429] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]355vm-test-run-docker> server # [    0.550335] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]356vm-test-run-docker> server # [    0.551364] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]357vm-test-run-docker> server # [    0.552560] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]358vm-test-run-docker> server # [    0.554431] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint359vm-test-run-docker> server # [    0.557348] pci 0000:00:03.0: BAR 0 [io  0xc120-0xc13f]360vm-test-run-docker> server # [    0.558352] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]361vm-test-run-docker> server # [    0.559361] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]362vm-test-run-docker> server # [    0.560322] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]363vm-test-run-docker> server # [    0.563535] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint364vm-test-run-docker> server # [    0.566344] pci 0000:00:04.0: BAR 0 [io  0xc140-0xc15f]365vm-test-run-docker> server # [    0.567323] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]366vm-test-run-docker> server # [    0.568361] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]367vm-test-run-docker> server # [    0.571411] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint368vm-test-run-docker> server # [    0.574350] pci 0000:00:05.0: BAR 0 [io  0xc080-0xc0bf]369vm-test-run-docker> server # [    0.575323] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]370vm-test-run-docker> server # [    0.576360] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]371vm-test-run-docker> server # [    0.579347] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint372vm-test-run-docker> server # [    0.582343] pci 0000:00:06.0: BAR 0 [io  0xc160-0xc17f]373vm-test-run-docker> server # [    0.583322] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]374vm-test-run-docker> server # [    0.584360] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]375vm-test-run-docker> server # [    0.587334] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint376vm-test-run-docker> server # [    0.590353] pci 0000:00:07.0: BAR 0 [io  0xc180-0xc19f]377vm-test-run-docker> server # [    0.591322] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]378vm-test-run-docker> server # [    0.592360] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]379vm-test-run-docker> server # [    0.596575] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint380vm-test-run-docker> server # [    0.599347] pci 0000:00:08.0: BAR 0 [io  0xc000-0xc07f]381vm-test-run-docker> server # [    0.600323] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]382vm-test-run-docker> server # [    0.601361] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]383vm-test-run-docker> server # [    0.604874] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint384vm-test-run-docker> server # [    0.607346] pci 0000:00:09.0: BAR 0 [io  0xc1a0-0xc1bf]385vm-test-run-docker> server # [    0.608323] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]386vm-test-run-docker> server # [    0.609361] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]387vm-test-run-docker> server # [    0.610322] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]388vm-test-run-docker> server # [    0.613347] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint389vm-test-run-docker> server # [    0.615358] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]390vm-test-run-docker> server # [    0.616361] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]391vm-test-run-docker> server # [    0.619322] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint392vm-test-run-docker> server # [    0.622362] pci 0000:00:0b.0: BAR 0 [io  0xc0c0-0xc0ff]393vm-test-run-docker> server # [    0.623324] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]394vm-test-run-docker> server # [    0.624361] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]395vm-test-run-docker> server # [    0.627321] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint396vm-test-run-docker> server # [    0.630323] pci 0000:00:0c.0: BAR 0 [io  0xc1c0-0xc1df]397vm-test-run-docker> server # [    0.631322] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]398vm-test-run-docker> server # [    0.632360] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]399vm-test-run-docker> server # [    0.640881] ACPI: PCI: Interrupt link LNKA configured for IRQ 10400vm-test-run-docker> server # [    0.641521] ACPI: PCI: Interrupt link LNKB configured for IRQ 10401vm-test-run-docker> server # [    0.642513] ACPI: PCI: Interrupt link LNKC configured for IRQ 11402vm-test-run-docker> server # [    0.643505] ACPI: PCI: Interrupt link LNKD configured for IRQ 11403vm-test-run-docker> server # [    0.644426] ACPI: PCI: Interrupt link LNKS configured for IRQ 9404vm-test-run-docker> server # [    0.646505] iommu: Default domain type: Translated405vm-test-run-docker> server # [    0.647308] iommu: DMA domain TLB invalidation policy: lazy mode406vm-test-run-docker> server # [    0.648616] ACPI: bus type USB registered407vm-test-run-docker> server # [    0.649406] usbcore: registered new interface driver usbfs408vm-test-run-docker> server # [    0.650327] usbcore: registered new interface driver hub409vm-test-run-docker> server # [    0.651318] usbcore: registered new device driver usb410vm-test-run-docker> server # [    0.653340] NetLabel: Initializing411vm-test-run-docker> server # [    0.654307] NetLabel:  domain hash size = 128412vm-test-run-docker> server # [    0.655307] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO413vm-test-run-docker> server # [    0.656406] NetLabel:  unlabeled traffic allowed by default414vm-test-run-docker> server # [    0.657326] PCI: Using ACPI for IRQ routing415vm-test-run-docker> server # [    0.658990] pci 0000:00:02.0: vgaarb: setting as boot VGA device416vm-test-run-docker> server # [    0.659302] pci 0000:00:02.0: vgaarb: bridge control possible417vm-test-run-docker> server # [    0.659302] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none418vm-test-run-docker> server # [    0.659310] vgaarb: loaded419vm-test-run-docker> server # [    0.660478] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0420vm-test-run-docker> server # [    0.661307] hpet0: 3 comparators, 64-bit 100.000000 MHz counter421vm-test-run-docker> server # [    0.666428] clocksource: Switched to clocksource kvm-clock422vm-test-run-docker> server # [    0.670742] VFS: Disk quotas dquot_6.6.0423vm-test-run-docker> server # [    0.672086] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)424vm-test-run-docker> server # [    0.674415] pnp: PnP ACPI init425vm-test-run-docker> server # [    0.676097] pnp: PnP ACPI: found 6 devices426vm-test-run-docker> server # [    0.684457] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns427vm-test-run-docker> server # [    0.687079] clocksource: Switched to clocksource acpi_pm428vm-test-run-docker> server # [    0.688888] NET: Registered PF_INET protocol family429vm-test-run-docker> server # [    0.690691] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)430vm-test-run-docker> server # [    0.710309] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)431vm-test-run-docker> server # [    0.712860] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)432vm-test-run-docker> server # [    0.715252] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)433vm-test-run-docker> server # [    0.717636] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)434vm-test-run-docker> server # [    0.719845] TCP: Hash tables configured (established 8192 bind 8192)435vm-test-run-docker> server # [    0.721855] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)436vm-test-run-docker> server # [    0.724240] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)437vm-test-run-docker> server # [    0.726278] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)438vm-test-run-docker> server # [    0.728507] NET: Registered PF_UNIX/PF_LOCAL protocol family439vm-test-run-docker> server # [    0.730284] NET: Registered PF_XDP protocol family440vm-test-run-docker> server # [    0.731823] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]441vm-test-run-docker> server # [    0.733716] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]442vm-test-run-docker> server # [    0.735581] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]443vm-test-run-docker> server # [    0.737592] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]444vm-test-run-docker> server # [    0.739608] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]445vm-test-run-docker> server # [    0.741786] pci 0000:00:01.0: PIIX3: Enabling Passive Release446vm-test-run-docker> server # [    0.743562] pci 0000:00:00.0: Limiting direct PCI/PCI transfers447vm-test-run-docker> server # [    0.746925] ACPI: \_SB_.LNKD: Enabled at IRQ 11448vm-test-run-docker> server # [    0.750421] PCI: CLS 0 bytes, default 64449vm-test-run-docker> server # [    0.752006] Trying to unpack rootfs image as initramfs...450vm-test-run-docker> server # [    0.755569] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22983f10a64, max_idle_ns: 440795218721 ns451vm-test-run-docker> server # [    0.800846] Initialise system trusted keyrings452vm-test-run-docker> server # [    0.804683] workingset: timestamp_bits=40 max_order=18 bucket_order=0453vm-test-run-docker> server # [    0.830190] Key type asymmetric registered454vm-test-run-docker> server # [    0.833204] Asymmetric key parser 'x509' registered455vm-test-run-docker> server # [    0.837228] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)456vm-test-run-docker> server # [    0.843312] io scheduler mq-deadline registered457vm-test-run-docker> server # [    0.844757] io scheduler kyber registered458vm-test-run-docker> server # [    0.849379] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled459vm-test-run-docker> server # [    0.855588] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A460vm-test-run-docker> server # [    0.864426] Linux agpgart interface v0.103461vm-test-run-docker> server # [    0.868346] ACPI: bus type drm_connector registered462vm-test-run-docker> server # [    0.872648] usbcore: registered new interface driver usbserial_generic463vm-test-run-docker> server # [    0.878195] usbserial: USB Serial support registered for generic464vm-test-run-docker> server # [    0.880032] amd_pstate: The CPPC feature is supported but currently disabled by the BIOS.465vm-test-run-docker> server # [    0.880032] Please enable it if your BIOS has the CPPC option.466vm-test-run-docker> server # [    0.884090] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled467vm-test-run-docker> server # [    0.893310] drop_monitor: Initializing network drop monitor service468vm-test-run-docker> server # [    0.898469] NET: Registered PF_INET6 protocol family469vm-test-run-docker> server # [    0.903722] Segment Routing with IPv6470vm-test-run-docker> server # [    0.907307] In-situ OAM (IOAM) with IPv6471vm-test-run-docker> server # [    0.911532] IPI shorthand broadcast: enabled472vm-test-run-docker> server # [    0.921823] sched_clock: Marking stable (680030250, 241122353)->(1128074509, -206921906)473vm-test-run-docker> server # [    0.928370] registered taskstats version 1474vm-test-run-docker> server # [    0.931415] Loading compiled-in X.509 certificates475vm-test-run-docker> server # [    0.954272] Demotion targets for Node 0: null476vm-test-run-docker> server # [    0.957329] Key type .fscrypt registered477vm-test-run-docker> server # [    0.960174] Key type fscrypt-provisioning registered478vm-test-run-docker> server # [    0.963329] ima: No TPM chip found, activating TPM-bypass!479vm-test-run-docker> server # [    0.966266] ima: Allocated hash algorithm: sha1480vm-test-run-docker> server # [    0.970285] ima: No architecture policies found481vm-test-run-docker> server # [    0.973569] PM:   Magic number: 14:917:720482vm-test-run-docker> server # [    0.978334] RAS: Correctable Errors collector initialized.483vm-test-run-docker> server # [    0.989288] clk: Disabling unused clocks484vm-test-run-docker> server # [    0.992204] PM: genpd: Disabling unused power domains485vm-test-run-docker> server # [    1.125764] Freeing initrd memory: 27440K486vm-test-run-docker> server # [    1.129910] Freeing unused decrypted memory: 2028K487vm-test-run-docker> server # [    1.133627] Freeing unused kernel image (initmem) memory: 3636K488vm-test-run-docker> server # [    1.135566] Write protecting the kernel read-only data: 32768k489vm-test-run-docker> server # [    1.138485] Freeing unused kernel image (text/rodata gap) memory: 1360K490vm-test-run-docker> server # [    1.141041] Freeing unused kernel image (rodata/data gap) memory: 844K491vm-test-run-docker> server # [    1.193267] x86/mm: Checked W+X mappings: passed, no W+X pages found.492vm-test-run-docker> server # [    1.195292] Run /init as init process493vm-test-run-docker> server # [    1.207276] systemd[1]: Inserted module 'autofs4'494vm-test-run-docker> server # [    1.223786] fuse: init (API version 7.45)495vm-test-run-docker> server # [    1.231009] ACPI: \_SB_.LNKC: Enabled at IRQ 10496vm-test-run-docker> server # [    1.240240] ACPI: \_SB_.LNKA: Enabled at IRQ 10497vm-test-run-docker> server # [    1.244926] ACPI: \_SB_.LNKB: Enabled at IRQ 11498vm-test-run-docker> server # [    1.286087] systemd[1]: Successfully made /usr/ read-only.499vm-test-run-docker> server # [    1.627113] 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)500vm-test-run-docker> server # [    1.651386] systemd[1]: Detected virtualization kvm.501vm-test-run-docker> server # [    1.655958] systemd[1]: Detected architecture x86-64.502vm-test-run-docker> server # [    1.660484] systemd[1]: Running in initrd.503vm-test-run-docker> server # [    1.665293] systemd[1]: Initializing machine ID from random generator.504vm-test-run-docker> server # [    1.671035] systemd[1]: Hostname set to <server>.505vm-test-run-docker> server # [    1.736332] systemd[1]: Queued start job for default target Initrd Default Target.506vm-test-run-docker> server # [    1.793582] systemd[1]: Created slice Slice /system/modprobe.507vm-test-run-docker> server # [    1.795728] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.508vm-test-run-docker> server # [    1.798292] systemd[1]: Expecting device /dev/disk/by-label/nixos...509vm-test-run-docker> server # [    1.800343] systemd[1]: Reached target Path Units.510vm-test-run-docker> server # [    1.801981] systemd[1]: Reached target Slice Units.511vm-test-run-docker> server # [    1.803650] systemd[1]: Reached target Swaps.512vm-test-run-docker> server # [    1.805219] systemd[1]: Reached target Timer Units.513vm-test-run-docker> server # [    1.806955] systemd[1]: Listening on D-Bus System Message Bus Socket.514vm-test-run-docker> server # [    1.809217] systemd[1]: Listening on Journal Socket (/dev/log).515vm-test-run-docker> server # [    1.811346] systemd[1]: Listening on Journal Sockets.516vm-test-run-docker> server # [    1.813194] systemd[1]: Listening on udev Control Socket.517vm-test-run-docker> server # [    1.815051] systemd[1]: Listening on udev Kernel Socket.518vm-test-run-docker> server # [    1.816862] systemd[1]: Reached target Socket Units.519vm-test-run-docker> server # [    1.821250] systemd[1]: Starting Create List of Static Device Nodes...520vm-test-run-docker> server # [    1.828725] systemd[1]: Starting Load Kernel Module 9pnet_virtio...521vm-test-run-docker> server # [    1.838247] systemd[1]: Starting Load Kernel Module configfs...522vm-test-run-docker> server # [    1.855747] systemd[1]: Starting Journal Service...523vm-test-run-docker> server # [    1.871266] systemd[1]: Starting Load Kernel Modules...524vm-test-run-docker> server # [    1.876403] netfs: FS-Cache loaded525vm-test-run-docker> server # [    1.878239] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki526vm-test-run-docker> server # [    1.892175] 9pnet: Installing 9P2000 support527vm-test-run-docker> server # [    1.898256] systemd[1]: Starting Coldplug All udev Devices...528vm-test-run-docker> server # [    1.918580] systemd-journald[125]: Collecting audit messages is disabled.529vm-test-run-docker> server # [    1.930679] systemd[1]: Finished Create List of Static Device Nodes.530vm-test-run-docker> server # [    1.940965] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.531vm-test-run-docker> server # [    1.943871] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.532vm-test-run-docker> server # [    1.977723] systemd[1]: Finished Load Kernel Module 9pnet_virtio.533vm-test-run-docker> server # [    1.990434] systemd[1]: modprobe@configfs.service: Deactivated successfully.534vm-test-run-docker> server # [    2.001820] systemd[1]: Finished Load Kernel Module configfs.535vm-test-run-docker> server # [    2.006366] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev536vm-test-run-docker> server # [    2.018861] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config537vm-test-run-docker> server # [    2.041412] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...538vm-test-run-docker> server # [    2.059615] systemd[1]: Finished Load Kernel Modules.539vm-test-run-docker> server # [    2.076247] systemd[1]: Starting Apply Kernel Variables...540vm-test-run-docker> server # [    2.094293] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.541vm-test-run-docker> server # [    2.112281] systemd[1]: Starting Create Static Device Nodes in /dev...542vm-test-run-docker> server # [    2.129716] systemd[1]: Finished Apply Kernel Variables.543vm-test-run-docker> server # [    1.895424] systemd-modules-load[127]: Inserted module 'dm_mod'[    2.138952] systemd[1]: Started Journal Service.544vm-test-run-docker> server # 545vm-test-run-docker> server # [    1.901596] systemd-modules-load[127]: Inserted module 'virtio_balloon'546vm-test-run-docker> server # [    1.903646] systemd-modules-load[127]: Inserted module 'virtio_gpu'547vm-test-run-docker> server # [    1.916192] systemd[1]: Finished Create Static Device Nodes in /dev.548vm-test-run-docker> server # [    1.923930] systemd[1]: Reached target Preparation for Local File Systems.549vm-test-run-docker> server # [    1.928704] systemd[1]: Reached target Local File Systems.550vm-test-run-docker> server # [    1.934771] systemd[1]: Starting Create System Files and Directories...551vm-test-run-docker> server # [    1.941123] systemd[1]: Starting Rule-based Manager for Device Events and Files...552vm-test-run-docker> server # [    1.971104] systemd[1]: Finished Create System Files and Directories.553vm-test-run-docker> server # [    1.993478] systemd-udevd[160]: Using default interface naming scheme 'v260'.554vm-test-run-docker> server # [    2.028369] systemd[1]: Started Rule-based Manager for Device Events and Files.555vm-test-run-docker> server # [    2.068113] systemd[1]: Finished Coldplug All udev Devices.556vm-test-run-docker> server # [    2.069795] systemd[1]: Reached target System Initialization.557vm-test-run-docker> server # [    2.072365] systemd[1]: Reached target Basic System.558vm-test-run-docker> server # [    2.608912] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12559vm-test-run-docker> server # [    2.619184] uhci_hcd 0000:00:01.2: UHCI Host Controller560vm-test-run-docker> server # [    2.630058] serio: i8042 KBD port at 0x60,0x64 irq 1561vm-test-run-docker> server # [    2.632304] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1562vm-test-run-docker> server # [    2.638207] SCSI subsystem initialized563vm-test-run-docker> server # [    2.648946] serio: i8042 AUX port at 0x60,0x64 irq 12564vm-test-run-docker> server # [    2.652082] uhci_hcd 0000:00:01.2: detected 2 ports565vm-test-run-docker> server # [    2.655686] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100566vm-test-run-docker> server # [    2.667296] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18567vm-test-run-docker> server # [    2.669303] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1568vm-test-run-docker> server # [    2.671053] usb usb1: Product: UHCI Host Controller569vm-test-run-docker> server # [    2.672303] usb usb1: Manufacturer: Linux 6.18.31 uhci_hcd570vm-test-run-docker> server # [    2.673657] usb usb1: SerialNumber: 0000:00:01.2571vm-test-run-docker> server # [    2.683981] virtio_blk virtio5: 1/0/0 default/read/poll queues572vm-test-run-docker> server # [    2.716311] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)573vm-test-run-docker> server # [    2.745664] hub 1-0:1.0: USB hub found574vm-test-run-docker> server # [    2.751679] hub 1-0:1.0: 2 ports detected575vm-test-run-docker> server # [    2.527111] systemd[1]: Starting Virtual Console Setup...576vm-test-run-docker> server # [    2.537744] (udev-worker)[175]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.577vm-test-run-docker> server # [    2.541551] (udev-worker)[175]: Network interface NamePolicy= disabled on kernel command line.578vm-test-run-docker> server # [    2.804587] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0579vm-test-run-docker> server # [    2.567901] (udev-worker)[171]: Network interface NamePolicy= disabled on kernel command line.580vm-test-run-docker> server # [    2.574373] systemd-vconsole-setup[180]: Configuration of first virtual console was skipped, ignoring remaining ones.581vm-test-run-docker> server # [    2.580131] systemd[1]: Finished Virtual Console Setup.582vm-test-run-docker> server # [    2.844270] scsi host0: ata_piix583vm-test-run-docker> server # [    2.851857] scsi host1: ata_piix584vm-test-run-docker> server # [    2.855467] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0585vm-test-run-docker> server # [    2.857348] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0586vm-test-run-docker> server # [    2.629415] systemd[1]: Found device /dev/disk/by-label/nixos.587vm-test-run-docker> server # [    2.633591] systemd[1]: Reached target Initrd Root Device.588vm-test-run-docker> server # [    2.638234] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...589vm-test-run-docker> server # [    2.660340] systemd-fsck[194]: nixos: clean, 12/65536 files, 13019/262144 blocks590vm-test-run-docker> server # [    2.668289] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.591vm-test-run-docker> server # [    2.689183] systemd[1]: Mounting /sysroot...592vm-test-run-docker> server # [    2.990214] usb 1-1: new full-speed USB device number 2 using uhci_hcd593vm-test-run-docker> server # [    3.014736] ata2: found unknown device (class 0)594vm-test-run-docker> server # [    3.016877] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100595vm-test-run-docker> server # [    3.020011] scsi 1:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5596vm-test-run-docker> server # [    3.073581] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray597vm-test-run-docker> server # [    3.075157] cdrom: Uniform CD-ROM driver Revision: 3.20598vm-test-run-docker> server # [    3.121325] EXT4-fs (vda): mounted filesystem f80a0f2b-dfce-47fd-82a1-a90ac8eefcbb r/w with ordered data mode. Quota mode: none.599vm-test-run-docker> server # [    2.885990] systemd[1]: Mounted /sysroot.600vm-test-run-docker> server # [    2.890123] systemd[1]: Reached target Initrd Root File System.601vm-test-run-docker> server # [    2.895245] systemd[1]: Starting Mountpoints Configured in the Real Root...602vm-test-run-docker> server # [    2.916866] systemd-sysroot-fstab-check[209]: /sysroot should be mounted in the initrd, will request daemon-reload.603vm-test-run-docker> server # [    3.161048] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00604vm-test-run-docker> server # [    3.163075] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10605vm-test-run-docker> server # [    3.164871] usb 1-1: Product: QEMU USB Tablet606vm-test-run-docker> server # [    3.165992] usb 1-1: Manufacturer: QEMU607vm-test-run-docker> server # [    3.167001] usb 1-1: SerialNumber: 28754-0000:00:01.2-1608vm-test-run-docker> server # [    2.930909] systemd[1]: Reload requested from client PID 209 ('systemd-sysroot') (unit initrd-parse-etc.service)...609vm-test-run-docker> server # [    2.933660] systemd[1]: Reloading...610vm-test-run-docker> server # [    3.243371] hid: raw HID events driver (C) Jiri Kosina611vm-test-run-docker> server # [    3.274188] usbcore: registered new interface driver usbhid612vm-test-run-docker> server # [    3.275555] usbhid: USB HID core driver613vm-test-run-docker> server # [    3.302902] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2614vm-test-run-docker> server # [    3.312034] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0615vm-test-run-docker> server # [    3.196717] systemd[1]: Reloading finished in 267 ms.616vm-test-run-docker> server # [    3.212138] systemd-sysroot-fstab-check[209]: Requesting initrd-fs.target/start/replace...617vm-test-run-docker> server # [    3.266758] systemd-sysroot-fstab-check[209]: Requesting swap.target/start/replace...618vm-test-run-docker> server # [    3.272477] systemd[1]: initrd-parse-etc.service: Deactivated successfully.619vm-test-run-docker> server # [    3.276124] systemd[1]: Finished Mountpoints Configured in the Real Root.620vm-test-run-docker> server # [    3.277926] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.621vm-test-run-docker> server # [    3.283931] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio622vm-test-run-docker> server # [    3.691818] systemd[1]: Mounting /sysroot/nix/.ro-store...623vm-test-run-docker> server # [    3.705465] systemd[1]: Mounting /sysroot/nix/.rw-store...624vm-test-run-docker> server # [    3.722261] systemd[1]: Mounting /sysroot/run...625vm-test-run-docker> server # [    3.738358] systemd[1]: Mounting /sysroot/tmp/shared...626vm-test-run-docker> server # [    3.757996] systemd[1]: Mounting /sysroot/tmp/xchg...627vm-test-run-docker> server # [    4.010483] 9p: Installing v9fs 9p2000 file system support628vm-test-run-docker> server # [    3.780888] systemd[1]: Mounted /sysroot/nix/.ro-store.629vm-test-run-docker> server # [    3.794276] systemd[1]: Mounted /sysroot/nix/.rw-store.630vm-test-run-docker> server # [    3.796564] systemd[1]: Mounted /sysroot/run.631vm-test-run-docker> server # [    3.799202] systemd[1]: Mounted /sysroot/tmp/shared.632vm-test-run-docker> server # [    3.801568] systemd[1]: Mounted /sysroot/tmp/xchg.633vm-test-run-docker> server # [    3.807211] systemd[1]: Starting rw-sysroot-nix-store.service...634vm-test-run-docker> server # [    3.817905] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.635vm-test-run-docker> server # [    3.821540] systemd[1]: Finished rw-sysroot-nix-store.service.636vm-test-run-docker> server # [    4.693368] systemd[1]: Mounting /sysroot/nix/store...637vm-test-run-docker> server # [    4.738868] systemd[1]: Mounted /sysroot/nix/store.638vm-test-run-docker> server # [    4.740953] systemd[1]: Reached target Initrd File Systems.639vm-test-run-docker> server # [    4.745194] systemd[1]: Starting Find NixOS closure...640vm-test-run-docker> server # [    4.750345] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...641vm-test-run-docker> server # [    4.775102] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.642vm-test-run-docker> server # [    4.780135] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.643vm-test-run-docker> server # [    4.790303] systemd[1]: Finished Find NixOS closure.644vm-test-run-docker> server # [    4.792773] systemd[1]: Reached target Initrd Default Target.645vm-test-run-docker> server # [    4.797565] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...646vm-test-run-docker> server # [    4.812271] systemd[1]: Stopped target Initrd Default Target.647vm-test-run-docker> server # [    4.814088] systemd[1]: Stopped target Basic System.648vm-test-run-docker> server # [    4.816384] systemd[1]: Stopped target Initrd Root Device.649vm-test-run-docker> server # [    4.817912] systemd[1]: Stopped target Path Units.650vm-test-run-docker> server # [    4.820188] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.651vm-test-run-docker> server # [    4.822468] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.652vm-test-run-docker> server # [    4.824487] systemd[1]: Stopped target Slice Units.653vm-test-run-docker> server # [    4.825912] systemd[1]: Stopped target Socket Units.654vm-test-run-docker> server # [    4.829421] systemd[1]: Stopped target System Initialization.655vm-test-run-docker> server # [    4.831563] systemd[1]: Stopped target Swaps.656vm-test-run-docker> server # [    4.834387] systemd[1]: Stopped target Timer Units.657vm-test-run-docker> server # [    4.836195] systemd[1]: dbus.socket: Deactivated successfully.658vm-test-run-docker> server # [    4.838209] systemd[1]: Closed D-Bus System Message Bus Socket.659vm-test-run-docker> server # [    4.840385] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.660vm-test-run-docker> server # [    4.842734] systemd[1]: Stopped Find NixOS closure.661vm-test-run-docker> server # [    4.845191] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio662vm-test-run-docker> server # [    4.850521] systemd[1]: Starting rw-sysroot-nix-store.service...663vm-test-run-docker> server # [    4.852436] systemd[1]: systemd-sysctl.service: Deactivated successfully.664vm-test-run-docker> server # [    4.855367] systemd[1]: Stopped Apply Kernel Variables.665vm-test-run-docker> server # [    4.859947] systemd[1]: systemd-modules-load.service: Deactivated successfully.666vm-test-run-docker> server # [    4.863432] systemd[1]: Stopped Load Kernel Modules.667vm-test-run-docker> server # [    4.869973] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.668vm-test-run-docker> server # [    4.873116] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.669vm-test-run-docker> server # [    4.876188] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.670vm-test-run-docker> server # [    4.879343] systemd[1]: Stopped Create System Files and Directories.671vm-test-run-docker> server # [    4.883089] systemd[1]: Stopped target Local File Systems.672vm-test-run-docker> server # [    4.885241] systemd[1]: Stopped target Preparation for Local File Systems.673vm-test-run-docker> server # [    4.887395] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.674vm-test-run-docker> server # [    4.890383] systemd[1]: Stopped Coldplug All udev Devices.675vm-test-run-docker> server # [    4.892853] systemd[1]: Stopping Rule-based Manager for Device Events and Files...676vm-test-run-docker> server # [    4.895373] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.677vm-test-run-docker> server # [    4.899917] systemd[1]: Stopped Virtual Console Setup.678vm-test-run-docker> server # [    4.906113] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.679vm-test-run-docker> server # [    4.911222] systemd[1]: Finished rw-sysroot-nix-store.service.680vm-test-run-docker> server # [    4.919875] systemd[1]: systemd-udevd.service: Deactivated successfully.681vm-test-run-docker> server # [    4.923478] systemd[1]: Stopped Rule-based Manager for Device Events and Files.682vm-test-run-docker> server # [    4.928178] systemd[1]: initrd-cleanup.service: Deactivated successfully.683vm-test-run-docker> server # [    4.932105] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.684vm-test-run-docker> server # [    4.939342] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.685vm-test-run-docker> server # [    4.942372] systemd[1]: Closed udev Control Socket.686vm-test-run-docker> server # [    4.947379] systemd[1]: Starting Cleanup udev Database...687vm-test-run-docker> server # [    4.950374] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.688vm-test-run-docker> server # [    4.952373] systemd[1]: Stopped Create Static Device Nodes in /dev.689vm-test-run-docker> server # [    4.956725] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.690vm-test-run-docker> server # [    4.960377] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.691vm-test-run-docker> server # [    4.964051] systemd[1]: kmod-static-nodes.service: Deactivated successfully.692vm-test-run-docker> server # [    4.967100] systemd[1]: Stopped Create List of Static Device Nodes.693vm-test-run-docker> server # [    4.980820] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.694vm-test-run-docker> server # [    4.985119] systemd[1]: Finished Cleanup udev Database.695vm-test-run-docker> server # [    4.989101] systemd[1]: Reached target Switch Root.696vm-test-run-docker> server # [    4.993511] systemd[1]: Starting NixOS Activation...697vm-test-run-docker> server # [    5.175804] initrd-nixos-activation-start[505]: booting system configuration /nix/store/cj14f5psqa7vw3v0gcb3hv9j15ybnfm8-nixos-system-server-test698vm-test-run-docker> server # [    5.249978] initrd-nixos-activation-start[505]: running activation script...699vm-test-run-docker> server # [    5.725829] initrd-nixos-activation-start[528]: setting up /etc...700vm-test-run-docker> server # [    6.021926] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.701vm-test-run-docker> server # [    6.026961] systemd[1]: Finished NixOS Activation.702vm-test-run-docker> server # [    6.032315] systemd[1]: Starting Switch Root...703vm-test-run-docker> server # [    6.046567] systemd[1]: Switching root.704vm-test-run-docker> server # [    6.431933] systemd-journald[125]: Received SIGTERM from PID 1 (systemd).705vm-test-run-docker> server # [    6.592599] NET: Registered PF_VSOCK protocol family706vm-test-run-docker> server # [    6.984278] 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)707vm-test-run-docker> server # [    7.000996] systemd[1]: Detected virtualization kvm.708vm-test-run-docker> server # [    7.004281] systemd[1]: Detected architecture x86-64.709vm-test-run-docker> server # [    7.007672] systemd[1]: Detected first boot.710vm-test-run-docker> server # [    7.016821] systemd[1]: Initializing machine ID from random generator.711vm-test-run-docker> server # [    7.279546] systemd[1]: bpf-restrict-fs: LSM BPF program attached712vm-test-run-docker> server # [    7.413302] systemd[1]: Applying preset policy.713vm-test-run-docker> server # [    7.910393] systemd[1]: Populated /etc with preset unit settings.714vm-test-run-docker> server # [    8.371348] systemd[1]: initrd-switch-root.service: Deactivated successfully.715vm-test-run-docker> server # [    8.373945] systemd[1]: Stopped initrd-switch-root.service.716vm-test-run-docker> server # [    8.377615] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.717vm-test-run-docker> server # [    8.380813] systemd[1]: Created slice Slice /system/getty.718vm-test-run-docker> server # [    8.382956] systemd[1]: Created slice User and Session Slice.719vm-test-run-docker> server # [    8.384570] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.720vm-test-run-docker> server # [    8.386645] systemd[1]: Started Forward Password Requests to Wall Directory Watch.721vm-test-run-docker> server # [    8.388643] systemd[1]: Expecting device /dev/hvc0...722vm-test-run-docker> server # [    8.389915] systemd[1]: Expecting device /dev/ttyS0...723vm-test-run-docker> server # [    8.391302] systemd[1]: Reached target Local Encrypted Volumes.724vm-test-run-docker> server # [    8.392767] systemd[1]: Stopped target initrd-fs.target.725vm-test-run-docker> server # [    8.394160] systemd[1]: Stopped target initrd-root-fs.target.726vm-test-run-docker> server # [    8.395582] systemd[1]: Stopped target initrd-switch-root.target.727vm-test-run-docker> server # [    8.397143] systemd[1]: Reached target Virtual Machines and Containers.728vm-test-run-docker> server # [    8.398764] systemd[1]: Reached target Path Units.729vm-test-run-docker> server # [    8.400038] systemd[1]: Reached target Remote File Systems.730vm-test-run-docker> server # [    8.401488] systemd[1]: Reached target Slice Units.731vm-test-run-docker> server # [    8.402785] systemd[1]: Reached target Swaps.732vm-test-run-docker> server # [    8.407975] systemd[1]: Listening on Process Core Dump Socket.733vm-test-run-docker> server # [    8.411868] systemd[1]: Listening on Credential Encryption/Decryption.734vm-test-run-docker> server # [    8.417257] systemd[1]: Starting Journal Log Access Socket...735vm-test-run-docker> server # [    8.419889] systemd[1]: Listening on Journal Audit Socket.736vm-test-run-docker> server # [    8.421599] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.737vm-test-run-docker> server # [    8.423830] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki738vm-test-run-docker> server # [    8.426438] systemd[1]: Listening on udev Control Socket.739vm-test-run-docker> server # [    8.431795] systemd[1]: Mounting Huge Pages File System...740vm-test-run-docker> server # [    8.436324] systemd[1]: Mounting POSIX Message Queue File System...741vm-test-run-docker> server # [    8.443810] systemd[1]: Mounting Kernel Debug File System...742vm-test-run-docker> server # [    8.453938] systemd[1]: Mounting Kernel Trace File System...743vm-test-run-docker> server # [    8.462534] systemd[1]: Starting Create List of Static Device Nodes...744vm-test-run-docker> server # [    8.468850] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio745vm-test-run-docker> server # [    8.486326] systemd[1]: Starting Load Kernel Module configfs...746vm-test-run-docker> server # [    8.489324] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm747vm-test-run-docker> server # [    8.491827] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore748vm-test-run-docker> server # [    8.494605] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse749vm-test-run-docker> server # [    8.501564] systemd[1]: Mounting FUSE Control File System...750vm-test-run-docker> server # [    8.503971] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67751vm-test-run-docker> server # [    8.527466] systemd[1]: Starting Journal Service...752vm-test-run-docker> server # [    8.532240] systemd[1]: Starting Load Kernel Modules...753vm-test-run-docker> server # [    8.541932] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...754vm-test-run-docker> server # [    8.550189] systemd[1]: Starting Remount Root and Kernel File Systems...755vm-test-run-docker> server # [    8.554238] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki756vm-test-run-docker> server # [    8.563428] systemd[1]: Starting Coldplug All udev Devices...757vm-test-run-docker> server # [    8.570669] systemd[1]: Listening on Journal Log Access Socket.758vm-test-run-docker> server # [    8.574239] systemd[1]: Mounted Huge Pages File System.759vm-test-run-docker> server # [    8.577394] systemd[1]: Mounted POSIX Message Queue File System.760vm-test-run-docker> server # [    8.581546] systemd[1]: Mounted Kernel Debug File System.761vm-test-run-docker> server # [    8.585103] systemd[1]: Mounted Kernel Trace File System.762vm-test-run-docker> server # [    8.590516] systemd[1]: Finished Create List of Static Device Nodes.763vm-test-run-docker> server # [    8.594248] systemd[1]: Mounted FUSE Control File System.764vm-test-run-docker> server # [    8.603257] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...765vm-test-run-docker> server # [    8.613400] systemd[1]: modprobe@configfs.service: Deactivated successfully.766vm-test-run-docker> server # [    8.616881] systemd[1]: Finished Load Kernel Module configfs.767vm-test-run-docker> server # [    8.623917] systemd[1]: Mounting Kernel Configuration File System...768vm-test-run-docker> server # [    8.654411] systemd[1]: Mounted Kernel Configuration File System.769vm-test-run-docker> server # [    8.673242] EXT4-fs (vda): re-mounted f80a0f2b-dfce-47fd-82a1-a90ac8eefcbb.770vm-test-run-docker> server # [    8.688356] systemd[1]: Finished Remount Root and Kernel File Systems.771vm-test-run-docker> server # [    8.691512] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore772vm-test-run-docker> server # [    8.700689] systemd[1]: Starting Load/Save OS Random Seed...773vm-test-run-docker> server # [    8.702431] systemd-journald[738]: Collecting audit messages is enabled.774vm-test-run-docker> server # [    8.704098] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki775vm-test-run-docker> server # [    8.789369] systemd[1]: Started Journal Service.776vm-test-run-docker> server # [    8.552387] systemd[1]: Queued start job for default target Multi-User System.777vm-test-run-docker> server # [    8.557280] systemd[1]: systemd-journald.service: Deactivated successfully.778vm-test-run-docker> server # [    8.563368] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.779vm-test-run-docker> server # [    8.569438] systemd[1]: Finished Load/Save OS Random Seed.780vm-test-run-docker> server # [    8.814328] bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.781vm-test-run-docker> server # [    8.576586] systemd[1]: Reached target First Boot Complete.782vm-test-run-docker> server # [    8.579693] systemd[1]: Starting Flush Journal to Persistent Storage...783vm-test-run-docker> server # [    8.592170] systemd-oomd[740]: No swap; memory pressure usage will be degraded784vm-test-run-docker> server # [    8.598171] systemd[1]: Starting Create Static Device Nodes in /dev...785vm-test-run-docker> server # [    8.848862] Bridge firewalling registered786vm-test-run-docker> server # [    8.610532] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.787vm-test-run-docker> server # [    8.619147] systemd-modules-load[739]: Inserted module 'br_netfilter'788vm-test-run-docker> server # [    8.877514] loop: module loaded789vm-test-run-docker> server # [    8.640161] systemd-modules-load[739]: Inserted module 'loop'790vm-test-run-docker> server # [    8.649344] systemd-modules-load[739]: Inserted module 'veth'791vm-test-run-docker> server # [    8.898297] systemd-journald[738]: Received client request to flush runtime journal.792vm-test-run-docker> server # [    8.902868] systemd[1]: Finished Create Static Device Nodes in /dev.793vm-test-run-docker> server # [    8.913143] systemd[1]: Reached target Preparation for Local File Systems.794vm-test-run-docker> server # [    8.915799] systemd[1]: Starting Rule-based Manager for Device Events and Files...795vm-test-run-docker> server # [    8.920085] systemd-modules-load[739]: Inserted module 'xt_nat'796vm-test-run-docker> server # [    8.923373] systemd[1]: Finished Load Kernel Modules.797vm-test-run-docker> server # [    8.925050] systemd[1]: Starting Firewall...798vm-test-run-docker> server # [    8.929113] systemd[1]: Starting Apply Kernel Variables...799vm-test-run-docker> server # [    8.930807] systemd[1]: Finished Apply Kernel Variables.800vm-test-run-docker> server # [    8.934149] systemd-udevd[763]: Using default interface naming scheme 'v260'.801vm-test-run-docker> server # [    8.936774] systemd[1]: Finished Flush Journal to Persistent Storage.802vm-test-run-docker> server # [    9.045123] systemd[1]: Started Rule-based Manager for Device Events and Files.803vm-test-run-docker> server # [    9.086160] systemd[1]: Finished Coldplug All udev Devices.804vm-test-run-docker> server # [    9.136289] systemd[1]: Mounting /run/wrappers...805vm-test-run-docker> server # [    9.175375] systemd[1]: Mounted /run/wrappers.806vm-test-run-docker> server # [    9.178447] systemd[1]: Reached target Local File Systems.807vm-test-run-docker> server # [    9.181813] systemd[1]: Listening on Boot Loader Control Service Socket.808vm-test-run-docker> server # [    9.187649] systemd[1]: Starting register-nix-paths.service...809vm-test-run-docker> server # [    9.191449] systemd[1]: Starting Create SUID/SGID Wrappers...810vm-test-run-docker> server # [    9.196163] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.811vm-test-run-docker> server # [    9.201246] systemd[1]: Starting Save Transient machine-id to Disk...812vm-test-run-docker> server # [    9.207211] systemd[1]: Starting Create System Files and Directories...813vm-test-run-docker> server # [    9.283607] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.814vm-test-run-docker> server # [    9.290756] systemd[1]: Finished Save Transient machine-id to Disk.815vm-test-run-docker> server # [    9.371710] systemd[1]: Finished Create System Files and Directories.816vm-test-run-docker> server # [    9.380357] systemd[1]: Starting Rebuild Journal Catalog...817vm-test-run-docker> server # [    9.385683] systemd[1]: Starting Record System Boot/Shutdown in UTMP...818vm-test-run-docker> server # [    9.466344] systemd[1]: Finished Record System Boot/Shutdown in UTMP.819vm-test-run-docker> server # [    9.535718] systemd[1]: Finished Rebuild Journal Catalog.820vm-test-run-docker> server # [    9.543824] systemd[1]: Starting Update is Completed...821vm-test-run-docker> server # [    9.608516] systemd[1]: Finished Update is Completed.822vm-test-run-docker> server # [    9.640849] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse823vm-test-run-docker> server # [    9.899926] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.824vm-test-run-docker> server # [    9.962637] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.825vm-test-run-docker> server # [    9.966807] systemd[1]: Finished Create SUID/SGID Wrappers.826vm-test-run-docker> server # [    9.995584] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.827vm-test-run-docker> server # [   10.033773] (udev-worker)[831]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.828vm-test-run-docker> server # [   10.039514] (udev-worker)[831]: Network interface NamePolicy= disabled on kernel command line.829vm-test-run-docker> server # [   10.042589] (udev-worker)[830]: Network interface NamePolicy= disabled on kernel command line.830vm-test-run-docker> server # [   10.145136] systemd[1]: Finished Firewall.831vm-test-run-docker> server # [   10.216619] systemd[1]: Finished register-nix-paths.service.832vm-test-run-docker> server # [   10.220099] systemd[1]: Reached target System Initialization.833vm-test-run-docker> server # [   10.223737] systemd[1]: Started Discard unused filesystem blocks once a week.834vm-test-run-docker> server # [   10.227433] systemd[1]: Started Daily Cleanup of Temporary Directories.835vm-test-run-docker> server # [   10.230926] systemd[1]: Reached target Timer Units.836vm-test-run-docker> server # [   10.233273] systemd[1]: Listening on D-Bus System Message Bus Socket.837vm-test-run-docker> server # [   10.236610] systemd[1]: Starting Docker Socket for the API...838vm-test-run-docker> server # [   10.239592] systemd[1]: Listening on Nix Daemon Socket.839vm-test-run-docker> server # [   10.243147] systemd[1]: Listening on Hostname Service Socket.840vm-test-run-docker> server # [   10.246655] systemd[1]: Starting D-Bus System Message Bus...841vm-test-run-docker> server # [   10.248286] systemd[1]: Listening on Docker Socket for the API.842vm-test-run-docker> server # [   10.250287] systemd[1]: Reached target Socket Units.843vm-test-run-docker> server # [   10.263648] systemd[1]: Condition check resulted in Virtio network device being skipped.844vm-test-run-docker> server # [   10.370917] dbus-broker-launch[964]: Looking up NSS user entry for 'systemd-timesync'...845vm-test-run-docker> server # [   10.384366] dbus-broker-launch[964]: NSS returned no entry for 'systemd-timesync'846vm-test-run-docker> server # [   10.386972] dbus-broker-launch[964]: Invalid user-name in /nix/store/75ngg01d1p6hc64yzj4a87nmnzy3gj0m-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"847vm-test-run-docker> server # [   10.422639] systemd[1]: Started D-Bus System Message Bus.848vm-test-run-docker> server # [   10.665852] mousedev: PS/2 mouse device common for all mice849vm-test-run-docker> server # [   10.679844] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3850vm-test-run-docker> server # [   10.453429] dbus-broker-launch[964]: Ready851vm-test-run-docker> server # [   10.461170] systemd[1]: Reached target Basic System.852vm-test-run-docker> server # [   10.466162] systemd[1]: Started backdoor.service.853vm-test-run-docker> server # [   10.471200] systemd[1]: Starting Import lastlog data into lastlog2 database...854vm-test-run-docker> server # [   10.476327] systemd[1]: Starting Name Service Cache Daemon (nsncd)...855vm-test-run-docker> server # [   10.481504] systemd[1]: Starting Post-Boot Actions...856vm-test-run-docker> server # [   10.486909] systemd[1]: Started Reset console on configuration changes.857vm-test-run-docker> server # [   10.732871] ACPI: button: Power Button [PWRF]858vm-test-run-docker> server # [   10.496556] systemd[1]: Starting resolvconf update...859vm-test-run-docker> server # [   10.811762] rtc_cmos 00:05: RTC can wake from S4860vm-test-run-docker> server # [   10.583832] systemd[1]: Finished Post-Boot Actions.861vm-test-run-docker> server # connecting to host...862vm-test-run-docker> server # [   10.630358] nsncd[969]: Jun 08 06:44:09.559 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"863vm-test-run-docker> server # [   10.637967] systemd[1]: Started Name Service Cache Daemon (nsncd).864vm-test-run-docker> server # [   10.642950] systemd[1]: Reached target Host and Network Name Lookups.865vm-test-run-docker> server # [   10.647570] systemd[1]: Reached target User and Group Name Lookups.866vm-test-run-docker> server # [   10.652411] systemd[1]: Starting User Login Management...867vm-test-run-docker> server # [   10.655193] systemd[1]: Finished Import lastlog data into lastlog2 database.868vm-test-run-docker> server: Guest shell says: b'Spawning backdoor root shell...\n'869vm-test-run-docker> server: connected to guest root shell870vm-test-run-docker> server: (connecting took 11.61 seconds)871vm-test-run-docker> server: (finished: waiting for the VM to finish booting, in 11.61 seconds)872vm-test-run-docker> server # [   10.936206] rtc_cmos 00:05: registered as rtc0873vm-test-run-docker> server # [   10.960597] Floppy drive(s): fd0 is 2.88M AMI BIOS874vm-test-run-docker> server # [   10.966785] parport_pc 00:03: reported by Plug and Play ACPI875vm-test-run-docker> server # [   10.978526] rtc_cmos 00:05: setting system clock to 2026-06-08T06:44:09 UTC (1780901049)876vm-test-run-docker> server # [   10.982555] systemd-journald[738]: Time jumped backwards, rotating.877vm-test-run-docker> server # [   11.012520] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]878vm-test-run-docker> server # [   11.052666] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs879vm-test-run-docker> server # [   11.063997] FDC 0 is a S82078B880vm-test-run-docker> server # [   10.837244] systemd-logind[993]: New seat seat0.881vm-test-run-docker> server # [   10.850820] systemd[1]: Started User Login Management.882vm-test-run-docker> server # [   10.859171] systemd[1]: Stopped target Host and Network Name Lookups.883vm-test-run-docker> server # [   10.865479] systemd[1]: Stopping Host and Network Name Lookups...884vm-test-run-docker> server # [   10.870392] systemd[1]: Stopped target User and Group Name Lookups.885vm-test-run-docker> server # [   10.874806] systemd[1]: Stopping User and Group Name Lookups...886vm-test-run-docker> server # [   10.880634] systemd[1]: Starting linger-users.service...887vm-test-run-docker> server # [   10.884592] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...888vm-test-run-docker> server # [   10.888893] systemd[1]: nscd.service: Deactivated successfully.889vm-test-run-docker> server # [   10.892285] systemd[1]: Stopped Name Service Cache Daemon (nsncd).890vm-test-run-docker> server # [   10.895899] systemd[1]: Starting Name Service Cache Daemon (nsncd)...891vm-test-run-docker> server # [   10.962965] systemd[1]: linger-users.service: Deactivated successfully.892vm-test-run-docker> server # [   10.966883] systemd[1]: Finished linger-users.service.893vm-test-run-docker> server # [   10.981052] nsncd[1043]: Jun 08 06:44:09.742 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"894vm-test-run-docker> server # [   11.229062] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console895vm-test-run-docker> server # [   10.989716] systemd[1]: Started Name Service Cache Daemon (nsncd).896vm-test-run-docker> server # [   10.991475] systemd[1]: Reached target Host and Network Name Lookups.897vm-test-run-docker> server # [   10.993734] systemd[1]: Reached target User and Group Name Lookups.898vm-test-run-docker> server # [   11.247784] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0899vm-test-run-docker> server # [   11.039766] systemd[1]: Finished resolvconf update.900vm-test-run-docker> server # [   11.042171] systemd[1]: Reached target Preparation for Network.901vm-test-run-docker> server # [   11.051428] systemd[1]: Starting DHCP Client...902vm-test-run-docker> server # [   11.056293] systemd[1]: Starting Address configuration of eth1...903vm-test-run-docker> server # [   11.062445] systemd[1]: Starting Extra networking commands....904vm-test-run-docker> server # [   11.291616] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD905vm-test-run-docker> server # [   11.315765] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4906vm-test-run-docker> server # [   11.351973] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6907vm-test-run-docker> server # [   11.352396] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5908vm-test-run-docker> server # [   11.393365] Console: switching to colour dummy device 80x25909vm-test-run-docker> server # [   11.254344] dhcpcd[1078]: dhcpcd-10.3.1 starting[   11.510986] [drm] Found bochs VGA, ID 0xb0c5.910vm-test-run-docker> server # [   11.511932] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.911vm-test-run-docker> server # 912vm-test-run-docker> server # [   11.272673] systemd[1]: Starting Virtual Console Setup...913vm-test-run-docker> server # [   11.276833] dhcpcd[1084]: dev: loaded udev914vm-test-run-docker> server # [   11.546808] 8021q: 802.1Q VLAN Support v1.8915vm-test-run-docker> server # [   11.609559] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic916vm-test-run-docker> server # [   11.611039] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0917vm-test-run-docker> server # [   11.410672] systemd-logind[993]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)918vm-test-run-docker> server # [   11.670479] 8021q: adding VLAN 0 to HW filter on device eth1919vm-test-run-docker> server # [   11.690206] cfg80211: Loading compiled-in X.509 certificates for regulatory database920vm-test-run-docker> server # [   11.467486] network-addresses-eth1-start[1073]: adding address 192.168.1.1/24... done921vm-test-run-docker> server # [   11.726350] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'922vm-test-run-docker> server # [   11.728236] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'923vm-test-run-docker> server # [   11.732982] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2924vm-test-run-docker> server # [   11.734684] cfg80211: failed to load regulatory.db925vm-test-run-docker> server # [   11.501550] network-addresses-eth1-start[1073]: adding address 2001:db8:1::1/64... done926vm-test-run-docker> server # [   11.518568] systemd-logind[993]: Watching system buttons on /dev/input/event2 (Power Button)927vm-test-run-docker> server # [   11.536060] systemd[1]: Finished Address configuration of eth1.928vm-test-run-docker> server # [   11.590743] dhcpcd[1134]: /nix/store/bs3myr97dqvz8y1vlvwkv97ib5kdrl9n-openresolv-3.17.0/sbin/.resolvconf-wrapped: line 1221: kill: (1088) - Operation not permitted929vm-test-run-docker> server # [   11.595984] dhcpcd[1134]: clearing stale lock pid 1088930vm-test-run-docker> server # [   11.616345] systemd[1]: Finished Extra networking commands..931vm-test-run-docker> server # [   11.618841] systemd[1]: Reached target Network.932vm-test-run-docker> server # [   11.622280] systemd[1]: Starting Permit User Sessions...933vm-test-run-docker> server # [   11.803073] fbcon: bochs-drmdrmfb (fb0) is primary device934vm-test-run-docker> server # [   11.887374] 8021q: adding VLAN 0 to HW filter on device eth0935vm-test-run-docker> server # [   11.905272] ppdev: user-space parallel port driver936vm-test-run-docker> server # [   11.907060] Console: switching to colour frame buffer device 160x50937vm-test-run-docker> server # [   11.966919] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device938vm-test-run-docker> server # [   11.647317] dhcpcd[1084]: eth0: waiting for carrier939vm-test-run-docker> server # [   11.730852] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.940vm-test-run-docker> server # [   11.741572] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.941vm-test-run-docker> server # [   11.744100] systemd-logind[993]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)942vm-test-run-docker> server # [   11.748341] systemd[1]: Stopped Virtual Console Setup.943vm-test-run-docker> server # [   11.750388] systemd[1]: Starting Virtual Console Setup...944vm-test-run-docker> server # [   11.793274] systemd[1]: Finished Permit User Sessions.945vm-test-run-docker> server # [   11.799200] systemd[1]: Started Getty on tty1.946vm-test-run-docker> server # [   11.801710] systemd[1]: Reached target Login Prompts.947vm-test-run-docker> server # [   11.830235] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.948vm-test-run-docker> server # [   11.832257] systemd[1]: Stopped Virtual Console Setup.949vm-test-run-docker> server # [   11.836774] systemd[1]: Starting Virtual Console Setup...950vm-test-run-docker> server # [   12.152872] kvm_amd: TSC scaling supported951vm-test-run-docker> server # [   12.153752] kvm_amd: Nested Virtualization enabled952vm-test-run-docker> server # [   12.154640] kvm_amd: Nested Paging enabled953vm-test-run-docker> server # [   12.155423] kvm_amd: LBR virtualization supported954vm-test-run-docker> server # [   12.157935] kvm_amd: Virtual VMLOAD VMSAVE supported955vm-test-run-docker> server # [   12.158955] kvm_amd: Virtual GIF supported956vm-test-run-docker> server # [   12.159724] kvm_amd: Virtual NMI enabled957vm-test-run-docker> server # [   12.207940] EDAC MC: Ver: 3.0.0958vm-test-run-docker> server # [   12.391364] systemd-vconsole-setup[1159]: Configuration of first virtual console was skipped, ignoring remaining ones.959vm-test-run-docker> server # [   12.398425] systemd[1]: Finished Virtual Console Setup.960vm-test-run-docker> server # [   12.445827] dhcpcd[1084]: eth0: carrier acquired961vm-test-run-docker> server # [   12.461379] dhcpcd[1084]: DUID 00:01:00:01:31:b9:21:3b:52:54:00:12:34:56962vm-test-run-docker> server # [   12.463337] dhcpcd[1084]: eth0: IAID 00:12:34:56963vm-test-run-docker> server # [   12.464903] dhcpcd[1084]: eth0: adding address fe80::5054:ff:fe12:3456964vm-test-run-docker> server # [   13.287460] dhcpcd[1084]: eth0: soliciting a DHCP lease965vm-test-run-docker> server # [   13.561598] NET: Registered PF_PACKET protocol family966vm-test-run-docker> server # [   13.330209] dhcpcd[1084]: eth0: offered 10.0.2.15 from 10.0.2.2967vm-test-run-docker> server # [   13.335466] dhcpcd[1084]: eth0: probing address 10.0.2.15/24968vm-test-run-docker> server # [   13.854590] dhcpcd[1084]: eth0: soliciting an IPv6 router969vm-test-run-docker> server # [   13.858523] dhcpcd[1084]: eth0: Router Advertisement from fe80::2970vm-test-run-docker> server # [   13.862691] dhcpcd[1084]: eth0: adding address fec0::5054:ff:fe12:3456/64971vm-test-run-docker> server # [   13.867157] dhcpcd[1084]: eth0: adding route to fec0::/64972vm-test-run-docker> server # [   13.870833] dhcpcd[1084]: eth0: adding default route via fe80::2973vm-test-run-docker> server # [   18.869603] dhcpcd[1084]: eth0: leased 10.0.2.15 for 86400 seconds974vm-test-run-docker> server # [   18.874624] dhcpcd[1084]: eth0: adding route to 10.0.2.0/24975vm-test-run-docker> server # [   18.878865] dhcpcd[1084]: eth0: adding default route via 10.0.2.2976vm-test-run-docker> server # [   19.015609] systemd[1]: Started DHCP Client.977vm-test-run-docker> server # [   19.018381] systemd[1]: Reached target Network is Online.978vm-test-run-docker> server # [   19.023294] systemd[1]: Starting Docker Application Container Engine...979vm-test-run-docker> server # [   19.878150] dockerd[1290]: time="2026-06-08T06:44:18.639172994Z" level=info msg="Starting up"980vm-test-run-docker> server # [   19.881893] dockerd[1290]: time="2026-06-08T06:44:18.644433998Z" level=info msg="containerd not running, starting managed containerd"981vm-test-run-docker> server # [   19.895322] dockerd[1290]: time="2026-06-08T06:44:18.657823130Z" level=info msg="started new containerd process" address=/var/run/docker/containerd/containerd.sock module=libcontainerd pid=1305982vm-test-run-docker> server # [   20.342268] dockerd[1305]: time="2026-06-08T06:44:19.101946894Z" level=info msg="starting containerd" revision=refs/tags/v2.2.3 version=v2.2.3983vm-test-run-docker> server # [   20.363331] dockerd[1305]: time="2026-06-08T06:44:19.125571684Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="275.454µs"984vm-test-run-docker> server # [   20.367316] dockerd[1305]: time="2026-06-08T06:44:19.125809424Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1985vm-test-run-docker> server # [   20.371090] dockerd[1305]: time="2026-06-08T06:44:19.133553425Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1986vm-test-run-docker> server # [   20.375152] dockerd[1305]: time="2026-06-08T06:44:19.133599241Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1987vm-test-run-docker> server # [   20.378331] dockerd[1305]: time="2026-06-08T06:44:19.137143267Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1988vm-test-run-docker> server # [   20.381882] dockerd[1305]: time="2026-06-08T06:44:19.137177629Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1989vm-test-run-docker> server # [   20.385605] dockerd[1305]: time="2026-06-08T06:44:19.137212270Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1990vm-test-run-docker> server # [   20.389341] dockerd[1305]: time="2026-06-08T06:44:19.137296079Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1991vm-test-run-docker> server # [   20.393912] dockerd[1305]: time="2026-06-08T06:44:19.137328486Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1992vm-test-run-docker> server # [   20.398655] dockerd[1305]: time="2026-06-08T06:44:19.161180679Z" 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.v1993vm-test-run-docker> server # [   20.405317] dockerd[1305]: time="2026-06-08T06:44:19.167298496Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1994vm-test-run-docker> server # [   20.409300] dockerd[1305]: time="2026-06-08T06:44:19.167334534Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1995vm-test-run-docker> server # [   20.413763] dockerd[1305]: time="2026-06-08T06:44:19.167361632Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1996vm-test-run-docker> server # [   20.417601] dockerd[1305]: time="2026-06-08T06:44:19.179717672Z" level=info msg="skip loading plugin" error="EROFS unsupported, please `modprobe erofs`: skip plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1997vm-test-run-docker> server # [   20.422980] dockerd[1305]: time="2026-06-08T06:44:19.179750078Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1998vm-test-run-docker> server # [   20.426406] dockerd[1305]: time="2026-06-08T06:44:19.184719984Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1999vm-test-run-docker> server # [   20.429807] dockerd[1305]: time="2026-06-08T06:44:19.185349114Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v11000vm-test-run-docker> server # [   20.433315] dockerd[1305]: time="2026-06-08T06:44:19.185416162Z" 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.v11001vm-test-run-docker> server # [   20.439112] dockerd[1305]: time="2026-06-08T06:44:19.185449685Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v11002vm-test-run-docker> server # [   20.442515] dockerd[1305]: time="2026-06-08T06:44:19.201562348Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v11003vm-test-run-docker> server # [   20.449811] dockerd[1305]: time="2026-06-08T06:44:19.212195822Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v11004vm-test-run-docker> server # [   20.453091] dockerd[1305]: time="2026-06-08T06:44:19.212298908Z" level=info msg="metadata content store policy set" policy=shared1005vm-test-run-docker> server # [   20.470139] dockerd[1305]: time="2026-06-08T06:44:19.232659876Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v11006vm-test-run-docker> server # [   20.474323] dockerd[1305]: time="2026-06-08T06:44:19.236731063Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v11007vm-test-run-docker> server # [   20.478879] dockerd[1305]: time="2026-06-08T06:44:19.241247839Z" level=info msg="built-in NRI default validator is disabled"1008vm-test-run-docker> server # [   20.481451] dockerd[1305]: time="2026-06-08T06:44:19.241280524Z" level=info msg="runtime interface created"1009vm-test-run-docker> server # [   20.483957] dockerd[1305]: time="2026-06-08T06:44:19.241304270Z" level=info msg="created NRI interface"1010vm-test-run-docker> server # [   20.486225] dockerd[1305]: time="2026-06-08T06:44:19.241367686Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v11011vm-test-run-docker> server # [   20.503226] dockerd[1305]: time="2026-06-08T06:44:19.265660159Z" 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.v11012vm-test-run-docker> server # [   20.509332] dockerd[1305]: time="2026-06-08T06:44:19.265743131Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v11013vm-test-run-docker> server # [   20.514610] dockerd[1305]: time="2026-06-08T06:44:19.277136757Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v11014vm-test-run-docker> server # [   20.518427] dockerd[1305]: time="2026-06-08T06:44:19.280224301Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v11015vm-test-run-docker> server # [   20.521560] dockerd[1305]: time="2026-06-08T06:44:19.280258942Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v11016vm-test-run-docker> server # [   20.525514] dockerd[1305]: time="2026-06-08T06:44:19.280356440Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v11017vm-test-run-docker> server # [   20.529238] dockerd[1305]: time="2026-06-08T06:44:19.280728275Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v11018vm-test-run-docker> server # [   20.532587] dockerd[1305]: time="2026-06-08T06:44:19.280760682Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v11019vm-test-run-docker> server # [   20.536316] dockerd[1305]: time="2026-06-08T06:44:19.280969367Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v11020vm-test-run-docker> server # [   20.540431] dockerd[1305]: time="2026-06-08T06:44:19.280998701Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v11021vm-test-run-docker> server # [   20.544842] dockerd[1305]: time="2026-06-08T06:44:19.291295261Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v11022vm-test-run-docker> server # [   20.548277] dockerd[1305]: time="2026-06-08T06:44:19.291349458Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v11023vm-test-run-docker> server # [   20.551628] dockerd[1305]: time="2026-06-08T06:44:19.291381864Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v21024vm-test-run-docker> server # [   20.554838] dockerd[1305]: time="2026-06-08T06:44:19.302329065Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v11025vm-test-run-docker> server # [   20.558156] dockerd[1305]: time="2026-06-08T06:44:19.302372088Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v11026vm-test-run-docker> server # [   20.562252] dockerd[1305]: time="2026-06-08T06:44:19.302463161Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v11027vm-test-run-docker> server # [   20.565624] dockerd[1305]: time="2026-06-08T06:44:19.306524850Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v11028vm-test-run-docker> server # [   20.569137] dockerd[1305]: time="2026-06-08T06:44:19.306588266Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v11029vm-test-run-docker> server # [   20.572581] dockerd[1305]: time="2026-06-08T06:44:19.306661739Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v11030vm-test-run-docker> server # [   20.576286] dockerd[1305]: time="2026-06-08T06:44:19.306721802Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v11031vm-test-run-docker> server # [   20.579494] dockerd[1305]: time="2026-06-08T06:44:19.306773764Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v11032vm-test-run-docker> server # [   20.583220] dockerd[1305]: time="2026-06-08T06:44:19.306806450Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v11033vm-test-run-docker> server # [   20.586677] dockerd[1305]: time="2026-06-08T06:44:19.306871821Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v11034vm-test-run-docker> server # [   20.590414] dockerd[1305]: time="2026-06-08T06:44:19.306905066Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v11035vm-test-run-docker> server # [   20.594166] dockerd[1305]: time="2026-06-08T06:44:19.306933282Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v11036vm-test-run-docker> server # [   20.597668] dockerd[1305]: time="2026-06-08T06:44:19.345004322Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v11037vm-test-run-docker> server # [   20.601329] dockerd[1305]: time="2026-06-08T06:44:19.363564502Z" level=info msg="Get image filesystem path \"/var/lib/docker/containerd/daemon/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\""1038vm-test-run-docker> server # [   20.605721] dockerd[1305]: time="2026-06-08T06:44:19.363668705Z" level=info msg="Start snapshots syncer"1039vm-test-run-docker> server # [   20.614152] dockerd[1305]: time="2026-06-08T06:44:19.376498548Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v11040vm-test-run-docker> server # [   20.621716] dockerd[1305]: time="2026-06-08T06:44:19.384101749Z" 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\"}"1041vm-test-run-docker> server # [   20.668595] dockerd[1305]: time="2026-06-08T06:44:19.384202879Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v11042vm-test-run-docker> server # [   20.672502] dockerd[1305]: time="2026-06-08T06:44:19.425043265Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v11043vm-test-run-docker> server # [   20.676678] dockerd[1305]: time="2026-06-08T06:44:19.425213398Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v11044vm-test-run-docker> server # [   20.680293] dockerd[1305]: time="2026-06-08T06:44:19.425254186Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v11045vm-test-run-docker> server # [   20.683447] dockerd[1305]: time="2026-06-08T06:44:19.425284636Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v11046vm-test-run-docker> server # [   20.687264] dockerd[1305]: time="2026-06-08T06:44:19.425317881Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v11047vm-test-run-docker> server # [   20.691065] dockerd[1305]: time="2026-06-08T06:44:19.425597246Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v11048vm-test-run-docker> server # [   20.694553] dockerd[1305]: time="2026-06-08T06:44:19.425694186Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v11049vm-test-run-docker> server # [   20.698143] dockerd[1305]: time="2026-06-08T06:44:19.425725195Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v11050vm-test-run-docker> server # [   20.701616] dockerd[1305]: time="2026-06-08T06:44:19.425757322Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v11051vm-test-run-docker> server # [   20.705273] dockerd[1305]: time="2026-06-08T06:44:19.425785818Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v11052vm-test-run-docker> server # [   20.709258] dockerd[1305]: time="2026-06-08T06:44:19.426437576Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v11053vm-test-run-docker> server # [   20.713156] dockerd[1305]: time="2026-06-08T06:44:19.426474173Z" 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.v11054vm-test-run-docker> server # [   20.717969] dockerd[1305]: time="2026-06-08T06:44:19.426503506Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v11055vm-test-run-docker> server # [   20.721707] dockerd[1305]: time="2026-06-08T06:44:19.426533957Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v11056vm-test-run-docker> server # [   20.726383] dockerd[1305]: time="2026-06-08T06:44:19.426560776Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v11057vm-test-run-docker> server # [   20.730232] dockerd[1305]: time="2026-06-08T06:44:19.426666935Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v11058vm-test-run-docker> server # [   20.733503] dockerd[1305]: time="2026-06-08T06:44:19.429772916Z" level=info msg=serving... address=/var/run/docker/containerd/containerd-debug.sock1059vm-test-run-docker> server # [   20.736864] dockerd[1305]: time="2026-06-08T06:44:19.429842758Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock.ttrpc1060vm-test-run-docker> server # [   20.740190] dockerd[1305]: time="2026-06-08T06:44:19.429994174Z" level=info msg=serving... address=/var/run/docker/containerd/containerd.sock1061vm-test-run-docker> server # [   20.743531] dockerd[1305]: time="2026-06-08T06:44:19.430162631Z" level=info msg="containerd successfully booted in 0.334387s"1062vm-test-run-docker> server # [   20.810722] dockerd[1290]: time="2026-06-08T06:44:19.573186395Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider"1063vm-test-run-docker> server # [   20.815799] dockerd[1290]: time="2026-06-08T06:44:19.578203792Z" level=info msg="CDI directory does not exist, skipping" dir=/var/run/cdi1064vm-test-run-docker> server # [   20.818712] dockerd[1290]: time="2026-06-08T06:44:19.578295424Z" level=info msg="CDI directory does not exist, skipping" dir=/etc/cdi1065vm-test-run-docker> server # [   21.015592] dockerd[1290]: time="2026-06-08T06:44:19.777123208Z" level=info msg="Creating a containerd client" address=/var/run/docker/containerd/containerd.sock timeout=1m0s1066vm-test-run-docker> server # [   21.060439] dockerd[1290]: time="2026-06-08T06:44:19.822875392Z" level=info msg="Loading containers: start."1067vm-test-run-docker> server # [   21.063375] dockerd[1290]: time="2026-06-08T06:44:19.825870744Z" level=info msg="NRI is disabled"1068vm-test-run-docker> server # [   21.065910] dockerd[1290]: time="2026-06-08T06:44:19.825899240Z" level=info msg="Starting daemon with containerd snapshotter integration enabled"1069vm-test-run-docker> server # [   21.087476] dockerd[1290]: time="2026-06-08T06:44:19.849893630Z" level=info msg="Restoring containers: start."1070vm-test-run-docker> server # [   21.116979] dockerd[1290]: time="2026-06-08T06:44:19.879430345Z" level=info msg="Deleting nftables IPv4 rules" error="exec: \"nft\": executable file not found in $PATH" output=1071vm-test-run-docker> server # [   21.121149] dockerd[1290]: time="2026-06-08T06:44:19.883305418Z" level=info msg="Deleting nftables IPv6 rules" error="exec: \"nft\": executable file not found in $PATH" output=1072vm-test-run-docker> server # [   22.548538] Initializing XFRM netlink socket1073vm-test-run-docker> server # [   22.420263] (udev-worker)[1339]: Network interface NamePolicy= disabled on kernel command line.1074vm-test-run-docker> server # [   22.657214] dockerd[1290]: time="2026-06-08T06:44:21.418895835Z" level=info msg="Loading containers: done."1075vm-test-run-docker> server # [   22.703720] dockerd[1290]: time="2026-06-08T06:44:21.466204083Z" level=info msg="Docker daemon" commit=v29.4.3 containerd-snapshotter=true storage-driver=overlayfs version=29.4.31076vm-test-run-docker> server # [   22.708393] dockerd[1290]: time="2026-06-08T06:44:21.470885683Z" level=info msg="Initializing buildkit"1077vm-test-run-docker> server # [   22.775586] dockerd[1290]: time="2026-06-08T06:44:21.538068803Z" level=info msg="Completed buildkit initialization"1078vm-test-run-docker> server # [   22.796184] dockerd[1290]: time="2026-06-08T06:44:21.558536209Z" level=info msg="Daemon has completed initialization"1079vm-test-run-docker> server # [   22.800141] dockerd[1290]: time="2026-06-08T06:44:21.558708298Z" level=info msg="API listen on /run/docker.sock"1080vm-test-run-docker> server # [   22.803279] dockerd[1290]: time="2026-06-08T06:44:21.565812273Z" level=info msg="API listen on /run/docker.sock"1081vm-test-run-docker> server # [   22.806731] systemd[1]: Started Docker Application Container Engine.1082vm-test-run-docker> server # [   22.814177] systemd[1]: Starting docker-busybox.service...1083vm-test-run-docker> server # [   23.221522] pre-start[1490]: Error response from daemon: No such container: busybox1084vm-test-run-docker> server # [   24.555566] dockerd[1290]: time="2026-06-08T06:44:23.317144914Z" level=error msg="failed to validate image signature" error="resolving signature chain for image sha256:7a02869f171604b718a1b45f07cc412fb1ff66e80041d5cb620dcf31d46b41ec: expected image index descriptor, got application/vnd.docker.distribution.manifest.v2+json"1085vm-test-run-docker> server # [   24.576254] systemd[1]: var-lib-docker-containerd-daemon-tmpmounts-containerd\x2dmount3878004979.mount: Deactivated successfully.1086vm-test-run-docker> server # [   25.229859] pre-start[1500]: Loaded image: busybox-test:latest1087vm-test-run-docker> server # [   25.257127] systemd[1]: Started docker-busybox.service.1088vm-test-run-docker> server # [   25.265991] systemd[1]: Reached target Multi-User System.1089vm-test-run-docker> server # [   25.267826] systemd[1]: Startup finished in 958ms (kernel) + 5.330s (initrd) + 18.976s (userspace) = 25.265s.1090vm-test-run-docker> server: (finished: waiting for unit docker-busybox.service, in 26.21 seconds)1091vm-test-run-docker> server: must succeed: cntr attach busybox true1092vm-test-run-docker> server # [   25.428837] systemd[1]: tmp-containerd\x2dmount4197545806.mount: Deactivated successfully.1093vm-test-run-docker> server # [   25.526245] systemd[1]: Created slice Virtual Machine and Container Slice.1094vm-test-run-docker> server # [   25.530863] systemd[1]: Starting Virtual Machine and Container Registration Service...1095vm-test-run-docker> server # [   25.603428] systemd[1]: Started Virtual Machine and Container Registration Service.1096vm-test-run-docker> server # failed to attach to container 'busybox': failed to lookup container 'busybox'1097vm-test-run-docker> server: output: 1098vm-test-run-docker> !!! Traceback (most recent call last):1099vm-test-run-docker> !!!   File "<string>", line 3, in <module>1100vm-test-run-docker> !!!     server.succeed("cntr attach busybox true")1101vm-test-run-docker> !!! 1102vm-test-run-docker> !!! RequestedAssertionFailed: command `cntr attach busybox true` failed (exit code 1)1103vm-test-run-docker> cleanup1104vm-test-run-docker> kill QemuMachine (pid 13)1105vm-test-run-docker> server # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/0r6k8xa2kgqyp3r4v2w7yrb80ma2iawm-python3-3.13.12/bin/python3.13)1106vm-test-run-docker> (finished: cleanup, in 0.20 seconds)1107error: build of '/nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv' on 'ssh-ng://nix@jamie' failed: Cannot build '/nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv'.1108       Reason: builder failed with exit code 1.1109       Output paths:1110         /nix/store/pjjr1dms6x99g7v22qdjniwhscl3h3yv-vm-test-run-docker1111       Last 25 log lines:1112       > server # [   22.814177] systemd[1]: Starting docker-busybox.service...1113       > server # [   23.221522] pre-start[1490]: Error response from daemon: No such container: busybox1114       > server # [   24.555566] dockerd[1290]: time="2026-06-08T06:44:23.317144914Z" level=error msg="failed to validate image signature" error="resolving signature chain for image sha256:7a02869f171604b718a1b45f07cc412fb1ff66e80041d5cb620dcf31d46b41ec: expected image index descriptor, got application/vnd.docker.distribution.manifest.v2+json"1115       > server # [   24.576254] systemd[1]: var-lib-docker-containerd-daemon-tmpmounts-containerd\x2dmount3878004979.mount: Deactivated successfully.1116       > server # [   25.229859] pre-start[1500]: Loaded image: busybox-test:latest1117       > server # [   25.257127] systemd[1]: Started docker-busybox.service.1118       > server # [   25.265991] systemd[1]: Reached target Multi-User System.1119       > server # [   25.267826] systemd[1]: Startup finished in 958ms (kernel) + 5.330s (initrd) + 18.976s (userspace) = 25.265s.1120       > server: (finished: waiting for unit docker-busybox.service, in 26.21 seconds)1121       > server: must succeed: cntr attach busybox true1122       > server # [   25.428837] systemd[1]: tmp-containerd\x2dmount4197545806.mount: Deactivated successfully.1123       > server # [   25.526245] systemd[1]: Created slice Virtual Machine and Container Slice.1124       > server # [   25.530863] systemd[1]: Starting Virtual Machine and Container Registration Service...1125       > server # [   25.603428] systemd[1]: Started Virtual Machine and Container Registration Service.1126       > server # failed to attach to container 'busybox': failed to lookup container 'busybox'1127       > server: output:1128       > !!! Traceback (most recent call last):1129       > !!!   File "<string>", line 3, in <module>1130       > !!!     server.succeed("cntr attach busybox true")1131       > !!! 1132       > !!! RequestedAssertionFailed: command `cntr attach busybox true` failed (exit code 1)1133       > cleanup1134       > kill QemuMachine (pid 13)1135       > server # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/0r6k8xa2kgqyp3r4v2w7yrb80ma2iawm-python3-3.13.12/bin/python3.13)1136       > (finished: cleanup, in 0.20 seconds)1137       For full logs, run:1138         nix log /nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv1139error: Cannot build '/nix/store/wr18llhgw85cy0lsaf9alqy26yhill58-vm-test-run-docker.drv'.1140       Reason: builder failed with exit code 1.1141       Output paths:1142         /nix/store/pjjr1dms6x99g7v22qdjniwhscl3h3yv-vm-test-run-docker