Apr 13 19:22:20.907860 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Apr 13 19:22:20.907885 kernel: Linux version 6.6.127-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Mon Apr 13 18:04:44 -00 2026 Apr 13 19:22:20.907896 kernel: KASLR enabled Apr 13 19:22:20.907901 kernel: efi: EFI v2.7 by Ubuntu distribution of EDK II Apr 13 19:22:20.907907 kernel: efi: SMBIOS 3.0=0x139ed0000 MEMATTR=0x1390c1018 ACPI 2.0=0x136760018 RNG=0x13676e918 MEMRESERVE=0x136b43d18 Apr 13 19:22:20.907913 kernel: random: crng init done Apr 13 19:22:20.907920 kernel: ACPI: Early table checksum verification disabled Apr 13 19:22:20.907926 kernel: ACPI: RSDP 0x0000000136760018 000024 (v02 BOCHS ) Apr 13 19:22:20.907932 kernel: ACPI: XSDT 0x000000013676FE98 00006C (v01 BOCHS BXPC 00000001 01000013) Apr 13 19:22:20.907940 kernel: ACPI: FACP 0x000000013676FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907947 kernel: ACPI: DSDT 0x0000000136767518 001468 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907953 kernel: ACPI: APIC 0x000000013676FC18 000108 (v04 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907959 kernel: ACPI: PPTT 0x000000013676FD98 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907965 kernel: ACPI: GTDT 0x000000013676D898 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907973 kernel: ACPI: MCFG 0x000000013676FF98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907981 kernel: ACPI: SPCR 0x000000013676E818 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907987 kernel: ACPI: DBG2 0x000000013676E898 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.907993 kernel: ACPI: IORT 0x000000013676E418 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Apr 13 19:22:20.908000 kernel: ACPI: BGRT 0x000000013676E798 000038 (v01 INTEL EDK2 00000002 01000013) Apr 13 19:22:20.908007 kernel: ACPI: SPCR: console: pl011,mmio32,0x9000000,9600 Apr 13 19:22:20.908013 kernel: NUMA: Failed to initialise from firmware Apr 13 19:22:20.908019 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x0000000139ffffff] Apr 13 19:22:20.908026 kernel: NUMA: NODE_DATA [mem 0x13966f800-0x139674fff] Apr 13 19:22:20.908032 kernel: Zone ranges: Apr 13 19:22:20.908038 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Apr 13 19:22:20.908046 kernel: DMA32 empty Apr 13 19:22:20.908053 kernel: Normal [mem 0x0000000100000000-0x0000000139ffffff] Apr 13 19:22:20.908059 kernel: Movable zone start for each node Apr 13 19:22:20.908077 kernel: Early memory node ranges Apr 13 19:22:20.908084 kernel: node 0: [mem 0x0000000040000000-0x000000013676ffff] Apr 13 19:22:20.908091 kernel: node 0: [mem 0x0000000136770000-0x0000000136b3ffff] Apr 13 19:22:20.908097 kernel: node 0: [mem 0x0000000136b40000-0x0000000139e1ffff] Apr 13 19:22:20.908104 kernel: node 0: [mem 0x0000000139e20000-0x0000000139eaffff] Apr 13 19:22:20.908110 kernel: node 0: [mem 0x0000000139eb0000-0x0000000139ebffff] Apr 13 19:22:20.908117 kernel: node 0: [mem 0x0000000139ec0000-0x0000000139fdffff] Apr 13 19:22:20.908123 kernel: node 0: [mem 0x0000000139fe0000-0x0000000139ffffff] Apr 13 19:22:20.908129 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x0000000139ffffff] Apr 13 19:22:20.908138 kernel: On node 0, zone Normal: 24576 pages in unavailable ranges Apr 13 19:22:20.908144 kernel: psci: probing for conduit method from ACPI. Apr 13 19:22:20.908150 kernel: psci: PSCIv1.1 detected in firmware. Apr 13 19:22:20.908159 kernel: psci: Using standard PSCI v0.2 function IDs Apr 13 19:22:20.908166 kernel: psci: Trusted OS migration not required Apr 13 19:22:20.908173 kernel: psci: SMC Calling Convention v1.1 Apr 13 19:22:20.908181 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Apr 13 19:22:20.908188 kernel: percpu: Embedded 30 pages/cpu s85736 r8192 d28952 u122880 Apr 13 19:22:20.908195 kernel: pcpu-alloc: s85736 r8192 d28952 u122880 alloc=30*4096 Apr 13 19:22:20.908202 kernel: pcpu-alloc: [0] 0 [0] 1 Apr 13 19:22:20.908208 kernel: Detected PIPT I-cache on CPU0 Apr 13 19:22:20.908215 kernel: CPU features: detected: GIC system register CPU interface Apr 13 19:22:20.908222 kernel: CPU features: detected: Hardware dirty bit management Apr 13 19:22:20.908229 kernel: CPU features: detected: Spectre-v4 Apr 13 19:22:20.908235 kernel: CPU features: detected: Spectre-BHB Apr 13 19:22:20.908242 kernel: CPU features: kernel page table isolation forced ON by KASLR Apr 13 19:22:20.908250 kernel: CPU features: detected: Kernel page table isolation (KPTI) Apr 13 19:22:20.908257 kernel: CPU features: detected: ARM erratum 1418040 Apr 13 19:22:20.908264 kernel: CPU features: detected: SSBS not fully self-synchronizing Apr 13 19:22:20.908270 kernel: alternatives: applying boot alternatives Apr 13 19:22:20.908278 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyAMA0,115200n8 flatcar.first_boot=detected acpi=force flatcar.oem.id=hetzner verity.usrhash=06a955818c1cb85215c4fc3bbca340081bcaba3fb92fe20a32668615ff23854b Apr 13 19:22:20.908285 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 13 19:22:20.908292 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 13 19:22:20.908299 kernel: Fallback order for Node 0: 0 Apr 13 19:22:20.908306 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1008000 Apr 13 19:22:20.908312 kernel: Policy zone: Normal Apr 13 19:22:20.908319 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 13 19:22:20.908327 kernel: software IO TLB: area num 2. Apr 13 19:22:20.908334 kernel: software IO TLB: mapped [mem 0x00000000fbfff000-0x00000000fffff000] (64MB) Apr 13 19:22:20.908341 kernel: Memory: 3882816K/4096000K available (10304K kernel code, 2180K rwdata, 8116K rodata, 39424K init, 897K bss, 213184K reserved, 0K cma-reserved) Apr 13 19:22:20.908348 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Apr 13 19:22:20.908355 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 13 19:22:20.908362 kernel: rcu: RCU event tracing is enabled. Apr 13 19:22:20.908369 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Apr 13 19:22:20.908376 kernel: Trampoline variant of Tasks RCU enabled. Apr 13 19:22:20.908383 kernel: Tracing variant of Tasks RCU enabled. Apr 13 19:22:20.908390 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 13 19:22:20.908397 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Apr 13 19:22:20.908404 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 13 19:22:20.908412 kernel: GICv3: 256 SPIs implemented Apr 13 19:22:20.908418 kernel: GICv3: 0 Extended SPIs implemented Apr 13 19:22:20.908425 kernel: Root IRQ handler: gic_handle_irq Apr 13 19:22:20.908432 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Apr 13 19:22:20.908439 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Apr 13 19:22:20.908445 kernel: ITS [mem 0x08080000-0x0809ffff] Apr 13 19:22:20.908452 kernel: ITS@0x0000000008080000: allocated 8192 Devices @1000c0000 (indirect, esz 8, psz 64K, shr 1) Apr 13 19:22:20.908459 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @1000d0000 (flat, esz 8, psz 64K, shr 1) Apr 13 19:22:20.908466 kernel: GICv3: using LPI property table @0x00000001000e0000 Apr 13 19:22:20.908473 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000001000f0000 Apr 13 19:22:20.908480 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 13 19:22:20.908488 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 13 19:22:20.908495 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Apr 13 19:22:20.908502 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Apr 13 19:22:20.908509 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Apr 13 19:22:20.908515 kernel: Console: colour dummy device 80x25 Apr 13 19:22:20.908523 kernel: ACPI: Core revision 20230628 Apr 13 19:22:20.908532 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Apr 13 19:22:20.908540 kernel: pid_max: default: 32768 minimum: 301 Apr 13 19:22:20.908548 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 13 19:22:20.908555 kernel: landlock: Up and running. Apr 13 19:22:20.908563 kernel: SELinux: Initializing. Apr 13 19:22:20.908570 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 13 19:22:20.908577 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 13 19:22:20.908584 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 13 19:22:20.908591 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 13 19:22:20.908599 kernel: rcu: Hierarchical SRCU implementation. Apr 13 19:22:20.908606 kernel: rcu: Max phase no-delay instances is 400. Apr 13 19:22:20.908613 kernel: Platform MSI: ITS@0x8080000 domain created Apr 13 19:22:20.908620 kernel: PCI/MSI: ITS@0x8080000 domain created Apr 13 19:22:20.908628 kernel: Remapping and enabling EFI services. Apr 13 19:22:20.908635 kernel: smp: Bringing up secondary CPUs ... Apr 13 19:22:20.908642 kernel: Detected PIPT I-cache on CPU1 Apr 13 19:22:20.908649 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Apr 13 19:22:20.908656 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000100100000 Apr 13 19:22:20.908663 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Apr 13 19:22:20.908670 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Apr 13 19:22:20.908677 kernel: smp: Brought up 1 node, 2 CPUs Apr 13 19:22:20.908684 kernel: SMP: Total of 2 processors activated. Apr 13 19:22:20.908690 kernel: CPU features: detected: 32-bit EL0 Support Apr 13 19:22:20.908699 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Apr 13 19:22:20.908706 kernel: CPU features: detected: Common not Private translations Apr 13 19:22:20.908718 kernel: CPU features: detected: CRC32 instructions Apr 13 19:22:20.908727 kernel: CPU features: detected: Enhanced Virtualization Traps Apr 13 19:22:20.908734 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Apr 13 19:22:20.908741 kernel: CPU features: detected: LSE atomic instructions Apr 13 19:22:20.908749 kernel: CPU features: detected: Privileged Access Never Apr 13 19:22:20.908756 kernel: CPU features: detected: RAS Extension Support Apr 13 19:22:20.908765 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Apr 13 19:22:20.908772 kernel: CPU: All CPU(s) started at EL1 Apr 13 19:22:20.908779 kernel: alternatives: applying system-wide alternatives Apr 13 19:22:20.908786 kernel: devtmpfs: initialized Apr 13 19:22:20.908794 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 13 19:22:20.908801 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Apr 13 19:22:20.908809 kernel: pinctrl core: initialized pinctrl subsystem Apr 13 19:22:20.908816 kernel: SMBIOS 3.0.0 present. Apr 13 19:22:20.908836 kernel: DMI: Hetzner vServer/KVM Virtual Machine, BIOS 20171111 11/11/2017 Apr 13 19:22:20.908845 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 13 19:22:20.908852 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 13 19:22:20.908859 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 13 19:22:20.908867 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 13 19:22:20.908874 kernel: audit: initializing netlink subsys (disabled) Apr 13 19:22:20.908881 kernel: audit: type=2000 audit(0.013:1): state=initialized audit_enabled=0 res=1 Apr 13 19:22:20.908889 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 13 19:22:20.908896 kernel: cpuidle: using governor menu Apr 13 19:22:20.908905 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 13 19:22:20.908913 kernel: ASID allocator initialised with 32768 entries Apr 13 19:22:20.908920 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 13 19:22:20.908927 kernel: Serial: AMBA PL011 UART driver Apr 13 19:22:20.908934 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Apr 13 19:22:20.908942 kernel: Modules: 0 pages in range for non-PLT usage Apr 13 19:22:20.908949 kernel: Modules: 509008 pages in range for PLT usage Apr 13 19:22:20.908956 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 13 19:22:20.908964 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 13 19:22:20.908973 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 13 19:22:20.908980 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 13 19:22:20.908988 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 13 19:22:20.908995 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 13 19:22:20.909002 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 13 19:22:20.909009 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 13 19:22:20.909017 kernel: ACPI: Added _OSI(Module Device) Apr 13 19:22:20.909024 kernel: ACPI: Added _OSI(Processor Device) Apr 13 19:22:20.909031 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 13 19:22:20.909040 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 13 19:22:20.909047 kernel: ACPI: Interpreter enabled Apr 13 19:22:20.909054 kernel: ACPI: Using GIC for interrupt routing Apr 13 19:22:20.909062 kernel: ACPI: MCFG table detected, 1 entries Apr 13 19:22:20.909075 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Apr 13 19:22:20.909083 kernel: printk: console [ttyAMA0] enabled Apr 13 19:22:20.909090 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Apr 13 19:22:20.909287 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 13 19:22:20.909371 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 13 19:22:20.909437 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 13 19:22:20.909502 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Apr 13 19:22:20.909566 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Apr 13 19:22:20.909576 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Apr 13 19:22:20.909583 kernel: PCI host bridge to bus 0000:00 Apr 13 19:22:20.909654 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Apr 13 19:22:20.909714 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 13 19:22:20.909777 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Apr 13 19:22:20.909888 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Apr 13 19:22:20.909988 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Apr 13 19:22:20.910093 kernel: pci 0000:00:01.0: [1af4:1050] type 00 class 0x038000 Apr 13 19:22:20.910186 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x11289000-0x11289fff] Apr 13 19:22:20.910257 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000600000-0x8000603fff 64bit pref] Apr 13 19:22:20.910342 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.910412 kernel: pci 0000:00:02.0: reg 0x10: [mem 0x11288000-0x11288fff] Apr 13 19:22:20.910488 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.910556 kernel: pci 0000:00:02.1: reg 0x10: [mem 0x11287000-0x11287fff] Apr 13 19:22:20.910630 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.910697 kernel: pci 0000:00:02.2: reg 0x10: [mem 0x11286000-0x11286fff] Apr 13 19:22:20.910776 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.910862 kernel: pci 0000:00:02.3: reg 0x10: [mem 0x11285000-0x11285fff] Apr 13 19:22:20.910941 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.911008 kernel: pci 0000:00:02.4: reg 0x10: [mem 0x11284000-0x11284fff] Apr 13 19:22:20.911117 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.911204 kernel: pci 0000:00:02.5: reg 0x10: [mem 0x11283000-0x11283fff] Apr 13 19:22:20.911292 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.911361 kernel: pci 0000:00:02.6: reg 0x10: [mem 0x11282000-0x11282fff] Apr 13 19:22:20.911434 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.911502 kernel: pci 0000:00:02.7: reg 0x10: [mem 0x11281000-0x11281fff] Apr 13 19:22:20.911574 kernel: pci 0000:00:03.0: [1b36:000c] type 01 class 0x060400 Apr 13 19:22:20.911641 kernel: pci 0000:00:03.0: reg 0x10: [mem 0x11280000-0x11280fff] Apr 13 19:22:20.911721 kernel: pci 0000:00:04.0: [1b36:0002] type 00 class 0x070002 Apr 13 19:22:20.911797 kernel: pci 0000:00:04.0: reg 0x10: [io 0x0000-0x0007] Apr 13 19:22:20.911939 kernel: pci 0000:01:00.0: [1af4:1041] type 00 class 0x020000 Apr 13 19:22:20.912024 kernel: pci 0000:01:00.0: reg 0x14: [mem 0x11000000-0x11000fff] Apr 13 19:22:20.912172 kernel: pci 0000:01:00.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Apr 13 19:22:20.912248 kernel: pci 0000:01:00.0: reg 0x30: [mem 0xfff80000-0xffffffff pref] Apr 13 19:22:20.912324 kernel: pci 0000:02:00.0: [1b36:000d] type 00 class 0x0c0330 Apr 13 19:22:20.912399 kernel: pci 0000:02:00.0: reg 0x10: [mem 0x10e00000-0x10e03fff 64bit] Apr 13 19:22:20.912474 kernel: pci 0000:03:00.0: [1af4:1043] type 00 class 0x078000 Apr 13 19:22:20.912544 kernel: pci 0000:03:00.0: reg 0x14: [mem 0x10c00000-0x10c00fff] Apr 13 19:22:20.912614 kernel: pci 0000:03:00.0: reg 0x20: [mem 0x8000100000-0x8000103fff 64bit pref] Apr 13 19:22:20.912691 kernel: pci 0000:04:00.0: [1af4:1045] type 00 class 0x00ff00 Apr 13 19:22:20.912762 kernel: pci 0000:04:00.0: reg 0x20: [mem 0x8000200000-0x8000203fff 64bit pref] Apr 13 19:22:20.912860 kernel: pci 0000:05:00.0: [1af4:1044] type 00 class 0x00ff00 Apr 13 19:22:20.913098 kernel: pci 0000:05:00.0: reg 0x14: [mem 0x10800000-0x10800fff] Apr 13 19:22:20.913211 kernel: pci 0000:05:00.0: reg 0x20: [mem 0x8000300000-0x8000303fff 64bit pref] Apr 13 19:22:20.913299 kernel: pci 0000:06:00.0: [1af4:1048] type 00 class 0x010000 Apr 13 19:22:20.913370 kernel: pci 0000:06:00.0: reg 0x14: [mem 0x10600000-0x10600fff] Apr 13 19:22:20.915157 kernel: pci 0000:06:00.0: reg 0x20: [mem 0x8000400000-0x8000403fff 64bit pref] Apr 13 19:22:20.915350 kernel: pci 0000:07:00.0: [1af4:1041] type 00 class 0x020000 Apr 13 19:22:20.915425 kernel: pci 0000:07:00.0: reg 0x14: [mem 0x10400000-0x10400fff] Apr 13 19:22:20.915493 kernel: pci 0000:07:00.0: reg 0x20: [mem 0x8000500000-0x8000503fff 64bit pref] Apr 13 19:22:20.915561 kernel: pci 0000:07:00.0: reg 0x30: [mem 0xfff80000-0xffffffff pref] Apr 13 19:22:20.915634 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01] add_size 1000 Apr 13 19:22:20.915701 kernel: pci 0000:00:02.0: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 01] add_size 100000 add_align 100000 Apr 13 19:22:20.915768 kernel: pci 0000:00:02.0: bridge window [mem 0x00100000-0x001fffff] to [bus 01] add_size 100000 add_align 100000 Apr 13 19:22:20.915904 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 02] add_size 1000 Apr 13 19:22:20.915979 kernel: pci 0000:00:02.1: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 02] add_size 200000 add_align 100000 Apr 13 19:22:20.916045 kernel: pci 0000:00:02.1: bridge window [mem 0x00100000-0x001fffff] to [bus 02] add_size 100000 add_align 100000 Apr 13 19:22:20.916146 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Apr 13 19:22:20.916218 kernel: pci 0000:00:02.2: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 03] add_size 100000 add_align 100000 Apr 13 19:22:20.916286 kernel: pci 0000:00:02.2: bridge window [mem 0x00100000-0x001fffff] to [bus 03] add_size 100000 add_align 100000 Apr 13 19:22:20.916357 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Apr 13 19:22:20.916427 kernel: pci 0000:00:02.3: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 04] add_size 100000 add_align 100000 Apr 13 19:22:20.916519 kernel: pci 0000:00:02.3: bridge window [mem 0x00100000-0x000fffff] to [bus 04] add_size 200000 add_align 100000 Apr 13 19:22:20.916605 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Apr 13 19:22:20.916676 kernel: pci 0000:00:02.4: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 05] add_size 100000 add_align 100000 Apr 13 19:22:20.917656 kernel: pci 0000:00:02.4: bridge window [mem 0x00100000-0x001fffff] to [bus 05] add_size 100000 add_align 100000 Apr 13 19:22:20.917883 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Apr 13 19:22:20.917962 kernel: pci 0000:00:02.5: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 06] add_size 100000 add_align 100000 Apr 13 19:22:20.918035 kernel: pci 0000:00:02.5: bridge window [mem 0x00100000-0x001fffff] to [bus 06] add_size 100000 add_align 100000 Apr 13 19:22:20.918134 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Apr 13 19:22:20.918203 kernel: pci 0000:00:02.6: bridge window [mem 0x00100000-0x001fffff 64bit pref] to [bus 07] add_size 100000 add_align 100000 Apr 13 19:22:20.918269 kernel: pci 0000:00:02.6: bridge window [mem 0x00100000-0x001fffff] to [bus 07] add_size 100000 add_align 100000 Apr 13 19:22:20.918341 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Apr 13 19:22:20.918409 kernel: pci 0000:00:02.7: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 08] add_size 200000 add_align 100000 Apr 13 19:22:20.918474 kernel: pci 0000:00:02.7: bridge window [mem 0x00100000-0x000fffff] to [bus 08] add_size 200000 add_align 100000 Apr 13 19:22:20.918544 kernel: pci 0000:00:03.0: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Apr 13 19:22:20.918612 kernel: pci 0000:00:03.0: bridge window [mem 0x00100000-0x000fffff 64bit pref] to [bus 09] add_size 200000 add_align 100000 Apr 13 19:22:20.918683 kernel: pci 0000:00:03.0: bridge window [mem 0x00100000-0x000fffff] to [bus 09] add_size 200000 add_align 100000 Apr 13 19:22:20.918751 kernel: pci 0000:00:02.0: BAR 14: assigned [mem 0x10000000-0x101fffff] Apr 13 19:22:20.918819 kernel: pci 0000:00:02.0: BAR 15: assigned [mem 0x8000000000-0x80001fffff 64bit pref] Apr 13 19:22:20.918943 kernel: pci 0000:00:02.1: BAR 14: assigned [mem 0x10200000-0x103fffff] Apr 13 19:22:20.919013 kernel: pci 0000:00:02.1: BAR 15: assigned [mem 0x8000200000-0x80003fffff 64bit pref] Apr 13 19:22:20.920256 kernel: pci 0000:00:02.2: BAR 14: assigned [mem 0x10400000-0x105fffff] Apr 13 19:22:20.920361 kernel: pci 0000:00:02.2: BAR 15: assigned [mem 0x8000400000-0x80005fffff 64bit pref] Apr 13 19:22:20.920436 kernel: pci 0000:00:02.3: BAR 14: assigned [mem 0x10600000-0x107fffff] Apr 13 19:22:20.920504 kernel: pci 0000:00:02.3: BAR 15: assigned [mem 0x8000600000-0x80007fffff 64bit pref] Apr 13 19:22:20.920572 kernel: pci 0000:00:02.4: BAR 14: assigned [mem 0x10800000-0x109fffff] Apr 13 19:22:20.920638 kernel: pci 0000:00:02.4: BAR 15: assigned [mem 0x8000800000-0x80009fffff 64bit pref] Apr 13 19:22:20.920709 kernel: pci 0000:00:02.5: BAR 14: assigned [mem 0x10a00000-0x10bfffff] Apr 13 19:22:20.920775 kernel: pci 0000:00:02.5: BAR 15: assigned [mem 0x8000a00000-0x8000bfffff 64bit pref] Apr 13 19:22:20.920907 kernel: pci 0000:00:02.6: BAR 14: assigned [mem 0x10c00000-0x10dfffff] Apr 13 19:22:20.920982 kernel: pci 0000:00:02.6: BAR 15: assigned [mem 0x8000c00000-0x8000dfffff 64bit pref] Apr 13 19:22:20.921052 kernel: pci 0000:00:02.7: BAR 14: assigned [mem 0x10e00000-0x10ffffff] Apr 13 19:22:20.922245 kernel: pci 0000:00:02.7: BAR 15: assigned [mem 0x8000e00000-0x8000ffffff 64bit pref] Apr 13 19:22:20.922336 kernel: pci 0000:00:03.0: BAR 14: assigned [mem 0x11000000-0x111fffff] Apr 13 19:22:20.922405 kernel: pci 0000:00:03.0: BAR 15: assigned [mem 0x8001000000-0x80011fffff 64bit pref] Apr 13 19:22:20.922479 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8001200000-0x8001203fff 64bit pref] Apr 13 19:22:20.922556 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x11200000-0x11200fff] Apr 13 19:22:20.922629 kernel: pci 0000:00:02.0: BAR 0: assigned [mem 0x11201000-0x11201fff] Apr 13 19:22:20.922699 kernel: pci 0000:00:02.0: BAR 13: assigned [io 0x1000-0x1fff] Apr 13 19:22:20.922771 kernel: pci 0000:00:02.1: BAR 0: assigned [mem 0x11202000-0x11202fff] Apr 13 19:22:20.922864 kernel: pci 0000:00:02.1: BAR 13: assigned [io 0x2000-0x2fff] Apr 13 19:22:20.922943 kernel: pci 0000:00:02.2: BAR 0: assigned [mem 0x11203000-0x11203fff] Apr 13 19:22:20.923011 kernel: pci 0000:00:02.2: BAR 13: assigned [io 0x3000-0x3fff] Apr 13 19:22:20.923180 kernel: pci 0000:00:02.3: BAR 0: assigned [mem 0x11204000-0x11204fff] Apr 13 19:22:20.923265 kernel: pci 0000:00:02.3: BAR 13: assigned [io 0x4000-0x4fff] Apr 13 19:22:20.923334 kernel: pci 0000:00:02.4: BAR 0: assigned [mem 0x11205000-0x11205fff] Apr 13 19:22:20.923408 kernel: pci 0000:00:02.4: BAR 13: assigned [io 0x5000-0x5fff] Apr 13 19:22:20.924503 kernel: pci 0000:00:02.5: BAR 0: assigned [mem 0x11206000-0x11206fff] Apr 13 19:22:20.924609 kernel: pci 0000:00:02.5: BAR 13: assigned [io 0x6000-0x6fff] Apr 13 19:22:20.924686 kernel: pci 0000:00:02.6: BAR 0: assigned [mem 0x11207000-0x11207fff] Apr 13 19:22:20.924759 kernel: pci 0000:00:02.6: BAR 13: assigned [io 0x7000-0x7fff] Apr 13 19:22:20.924844 kernel: pci 0000:00:02.7: BAR 0: assigned [mem 0x11208000-0x11208fff] Apr 13 19:22:20.924928 kernel: pci 0000:00:02.7: BAR 13: assigned [io 0x8000-0x8fff] Apr 13 19:22:20.925003 kernel: pci 0000:00:03.0: BAR 0: assigned [mem 0x11209000-0x11209fff] Apr 13 19:22:20.927043 kernel: pci 0000:00:03.0: BAR 13: assigned [io 0x9000-0x9fff] Apr 13 19:22:20.927461 kernel: pci 0000:00:04.0: BAR 0: assigned [io 0xa000-0xa007] Apr 13 19:22:20.927561 kernel: pci 0000:01:00.0: BAR 6: assigned [mem 0x10000000-0x1007ffff pref] Apr 13 19:22:20.927636 kernel: pci 0000:01:00.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Apr 13 19:22:20.927709 kernel: pci 0000:01:00.0: BAR 1: assigned [mem 0x10080000-0x10080fff] Apr 13 19:22:20.927782 kernel: pci 0000:00:02.0: PCI bridge to [bus 01] Apr 13 19:22:20.927925 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Apr 13 19:22:20.928352 kernel: pci 0000:00:02.0: bridge window [mem 0x10000000-0x101fffff] Apr 13 19:22:20.928462 kernel: pci 0000:00:02.0: bridge window [mem 0x8000000000-0x80001fffff 64bit pref] Apr 13 19:22:20.930153 kernel: pci 0000:02:00.0: BAR 0: assigned [mem 0x10200000-0x10203fff 64bit] Apr 13 19:22:20.930276 kernel: pci 0000:00:02.1: PCI bridge to [bus 02] Apr 13 19:22:20.930350 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Apr 13 19:22:20.930417 kernel: pci 0000:00:02.1: bridge window [mem 0x10200000-0x103fffff] Apr 13 19:22:20.930485 kernel: pci 0000:00:02.1: bridge window [mem 0x8000200000-0x80003fffff 64bit pref] Apr 13 19:22:20.930562 kernel: pci 0000:03:00.0: BAR 4: assigned [mem 0x8000400000-0x8000403fff 64bit pref] Apr 13 19:22:20.930634 kernel: pci 0000:03:00.0: BAR 1: assigned [mem 0x10400000-0x10400fff] Apr 13 19:22:20.930703 kernel: pci 0000:00:02.2: PCI bridge to [bus 03] Apr 13 19:22:20.930770 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Apr 13 19:22:20.930890 kernel: pci 0000:00:02.2: bridge window [mem 0x10400000-0x105fffff] Apr 13 19:22:20.930967 kernel: pci 0000:00:02.2: bridge window [mem 0x8000400000-0x80005fffff 64bit pref] Apr 13 19:22:20.931044 kernel: pci 0000:04:00.0: BAR 4: assigned [mem 0x8000600000-0x8000603fff 64bit pref] Apr 13 19:22:20.931130 kernel: pci 0000:00:02.3: PCI bridge to [bus 04] Apr 13 19:22:20.931199 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Apr 13 19:22:20.931264 kernel: pci 0000:00:02.3: bridge window [mem 0x10600000-0x107fffff] Apr 13 19:22:20.931330 kernel: pci 0000:00:02.3: bridge window [mem 0x8000600000-0x80007fffff 64bit pref] Apr 13 19:22:20.931406 kernel: pci 0000:05:00.0: BAR 4: assigned [mem 0x8000800000-0x8000803fff 64bit pref] Apr 13 19:22:20.931482 kernel: pci 0000:05:00.0: BAR 1: assigned [mem 0x10800000-0x10800fff] Apr 13 19:22:20.931552 kernel: pci 0000:00:02.4: PCI bridge to [bus 05] Apr 13 19:22:20.931619 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Apr 13 19:22:20.931685 kernel: pci 0000:00:02.4: bridge window [mem 0x10800000-0x109fffff] Apr 13 19:22:20.931750 kernel: pci 0000:00:02.4: bridge window [mem 0x8000800000-0x80009fffff 64bit pref] Apr 13 19:22:20.931838 kernel: pci 0000:06:00.0: BAR 4: assigned [mem 0x8000a00000-0x8000a03fff 64bit pref] Apr 13 19:22:20.931918 kernel: pci 0000:06:00.0: BAR 1: assigned [mem 0x10a00000-0x10a00fff] Apr 13 19:22:20.931987 kernel: pci 0000:00:02.5: PCI bridge to [bus 06] Apr 13 19:22:20.932061 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Apr 13 19:22:20.933235 kernel: pci 0000:00:02.5: bridge window [mem 0x10a00000-0x10bfffff] Apr 13 19:22:20.933308 kernel: pci 0000:00:02.5: bridge window [mem 0x8000a00000-0x8000bfffff 64bit pref] Apr 13 19:22:20.933385 kernel: pci 0000:07:00.0: BAR 6: assigned [mem 0x10c00000-0x10c7ffff pref] Apr 13 19:22:20.933456 kernel: pci 0000:07:00.0: BAR 4: assigned [mem 0x8000c00000-0x8000c03fff 64bit pref] Apr 13 19:22:20.933526 kernel: pci 0000:07:00.0: BAR 1: assigned [mem 0x10c80000-0x10c80fff] Apr 13 19:22:20.933594 kernel: pci 0000:00:02.6: PCI bridge to [bus 07] Apr 13 19:22:20.933663 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Apr 13 19:22:20.933738 kernel: pci 0000:00:02.6: bridge window [mem 0x10c00000-0x10dfffff] Apr 13 19:22:20.933807 kernel: pci 0000:00:02.6: bridge window [mem 0x8000c00000-0x8000dfffff 64bit pref] Apr 13 19:22:20.933935 kernel: pci 0000:00:02.7: PCI bridge to [bus 08] Apr 13 19:22:20.934010 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Apr 13 19:22:20.934126 kernel: pci 0000:00:02.7: bridge window [mem 0x10e00000-0x10ffffff] Apr 13 19:22:20.934199 kernel: pci 0000:00:02.7: bridge window [mem 0x8000e00000-0x8000ffffff 64bit pref] Apr 13 19:22:20.934269 kernel: pci 0000:00:03.0: PCI bridge to [bus 09] Apr 13 19:22:20.934334 kernel: pci 0000:00:03.0: bridge window [io 0x9000-0x9fff] Apr 13 19:22:20.934408 kernel: pci 0000:00:03.0: bridge window [mem 0x11000000-0x111fffff] Apr 13 19:22:20.934475 kernel: pci 0000:00:03.0: bridge window [mem 0x8001000000-0x80011fffff 64bit pref] Apr 13 19:22:20.934545 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Apr 13 19:22:20.934606 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 13 19:22:20.934664 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Apr 13 19:22:20.934740 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Apr 13 19:22:20.934802 kernel: pci_bus 0000:01: resource 1 [mem 0x10000000-0x101fffff] Apr 13 19:22:20.934884 kernel: pci_bus 0000:01: resource 2 [mem 0x8000000000-0x80001fffff 64bit pref] Apr 13 19:22:20.934956 kernel: pci_bus 0000:02: resource 0 [io 0x2000-0x2fff] Apr 13 19:22:20.935018 kernel: pci_bus 0000:02: resource 1 [mem 0x10200000-0x103fffff] Apr 13 19:22:20.936685 kernel: pci_bus 0000:02: resource 2 [mem 0x8000200000-0x80003fffff 64bit pref] Apr 13 19:22:20.936781 kernel: pci_bus 0000:03: resource 0 [io 0x3000-0x3fff] Apr 13 19:22:20.936869 kernel: pci_bus 0000:03: resource 1 [mem 0x10400000-0x105fffff] Apr 13 19:22:20.936943 kernel: pci_bus 0000:03: resource 2 [mem 0x8000400000-0x80005fffff 64bit pref] Apr 13 19:22:20.937017 kernel: pci_bus 0000:04: resource 0 [io 0x4000-0x4fff] Apr 13 19:22:20.937159 kernel: pci_bus 0000:04: resource 1 [mem 0x10600000-0x107fffff] Apr 13 19:22:20.937248 kernel: pci_bus 0000:04: resource 2 [mem 0x8000600000-0x80007fffff 64bit pref] Apr 13 19:22:20.937321 kernel: pci_bus 0000:05: resource 0 [io 0x5000-0x5fff] Apr 13 19:22:20.937385 kernel: pci_bus 0000:05: resource 1 [mem 0x10800000-0x109fffff] Apr 13 19:22:20.937445 kernel: pci_bus 0000:05: resource 2 [mem 0x8000800000-0x80009fffff 64bit pref] Apr 13 19:22:20.937517 kernel: pci_bus 0000:06: resource 0 [io 0x6000-0x6fff] Apr 13 19:22:20.937580 kernel: pci_bus 0000:06: resource 1 [mem 0x10a00000-0x10bfffff] Apr 13 19:22:20.937644 kernel: pci_bus 0000:06: resource 2 [mem 0x8000a00000-0x8000bfffff 64bit pref] Apr 13 19:22:20.937723 kernel: pci_bus 0000:07: resource 0 [io 0x7000-0x7fff] Apr 13 19:22:20.937789 kernel: pci_bus 0000:07: resource 1 [mem 0x10c00000-0x10dfffff] Apr 13 19:22:20.937869 kernel: pci_bus 0000:07: resource 2 [mem 0x8000c00000-0x8000dfffff 64bit pref] Apr 13 19:22:20.937946 kernel: pci_bus 0000:08: resource 0 [io 0x8000-0x8fff] Apr 13 19:22:20.938009 kernel: pci_bus 0000:08: resource 1 [mem 0x10e00000-0x10ffffff] Apr 13 19:22:20.938145 kernel: pci_bus 0000:08: resource 2 [mem 0x8000e00000-0x8000ffffff 64bit pref] Apr 13 19:22:20.938223 kernel: pci_bus 0000:09: resource 0 [io 0x9000-0x9fff] Apr 13 19:22:20.938286 kernel: pci_bus 0000:09: resource 1 [mem 0x11000000-0x111fffff] Apr 13 19:22:20.938373 kernel: pci_bus 0000:09: resource 2 [mem 0x8001000000-0x80011fffff 64bit pref] Apr 13 19:22:20.938384 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 13 19:22:20.938392 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 13 19:22:20.938400 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 13 19:22:20.938410 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 13 19:22:20.938418 kernel: iommu: Default domain type: Translated Apr 13 19:22:20.938426 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 13 19:22:20.938435 kernel: efivars: Registered efivars operations Apr 13 19:22:20.938443 kernel: vgaarb: loaded Apr 13 19:22:20.938452 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 13 19:22:20.938460 kernel: VFS: Disk quotas dquot_6.6.0 Apr 13 19:22:20.938468 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 13 19:22:20.938475 kernel: pnp: PnP ACPI init Apr 13 19:22:20.938551 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Apr 13 19:22:20.938563 kernel: pnp: PnP ACPI: found 1 devices Apr 13 19:22:20.938571 kernel: NET: Registered PF_INET protocol family Apr 13 19:22:20.938579 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 13 19:22:20.938590 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 13 19:22:20.938598 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 13 19:22:20.938606 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 13 19:22:20.938614 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 13 19:22:20.938621 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 13 19:22:20.938629 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 13 19:22:20.938637 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 13 19:22:20.938645 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 13 19:22:20.938724 kernel: pci 0000:02:00.0: enabling device (0000 -> 0002) Apr 13 19:22:20.938738 kernel: PCI: CLS 0 bytes, default 64 Apr 13 19:22:20.938746 kernel: kvm [1]: HYP mode not available Apr 13 19:22:20.938754 kernel: Initialise system trusted keyrings Apr 13 19:22:20.938762 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 13 19:22:20.938770 kernel: Key type asymmetric registered Apr 13 19:22:20.938778 kernel: Asymmetric key parser 'x509' registered Apr 13 19:22:20.938786 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 13 19:22:20.938794 kernel: io scheduler mq-deadline registered Apr 13 19:22:20.938802 kernel: io scheduler kyber registered Apr 13 19:22:20.938811 kernel: io scheduler bfq registered Apr 13 19:22:20.938820 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Apr 13 19:22:20.938958 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 50 Apr 13 19:22:20.939028 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 50 Apr 13 19:22:20.939115 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.939187 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 51 Apr 13 19:22:20.939254 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 51 Apr 13 19:22:20.939328 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.939400 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 52 Apr 13 19:22:20.939468 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 52 Apr 13 19:22:20.939553 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.939627 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 53 Apr 13 19:22:20.939695 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 53 Apr 13 19:22:20.939768 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.939856 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 54 Apr 13 19:22:20.939931 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 54 Apr 13 19:22:20.939998 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.940139 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 55 Apr 13 19:22:20.940221 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 55 Apr 13 19:22:20.940296 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.940367 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 56 Apr 13 19:22:20.940432 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 56 Apr 13 19:22:20.940506 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.940587 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 57 Apr 13 19:22:20.940666 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 57 Apr 13 19:22:20.940751 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.940764 kernel: ACPI: \_SB_.PCI0.GSI3: Enabled at IRQ 38 Apr 13 19:22:20.940862 kernel: pcieport 0000:00:03.0: PME: Signaling with IRQ 58 Apr 13 19:22:20.940945 kernel: pcieport 0000:00:03.0: AER: enabled with IRQ 58 Apr 13 19:22:20.941025 kernel: pcieport 0000:00:03.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Apr 13 19:22:20.941037 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 13 19:22:20.941050 kernel: ACPI: button: Power Button [PWRB] Apr 13 19:22:20.941059 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 13 19:22:20.941157 kernel: virtio-pci 0000:04:00.0: enabling device (0000 -> 0002) Apr 13 19:22:20.941246 kernel: virtio-pci 0000:07:00.0: enabling device (0000 -> 0002) Apr 13 19:22:20.941258 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 13 19:22:20.941271 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Apr 13 19:22:20.941356 kernel: serial 0000:00:04.0: enabling device (0000 -> 0001) Apr 13 19:22:20.941370 kernel: 0000:00:04.0: ttyS0 at I/O 0xa000 (irq = 45, base_baud = 115200) is a 16550A Apr 13 19:22:20.941380 kernel: thunder_xcv, ver 1.0 Apr 13 19:22:20.941390 kernel: thunder_bgx, ver 1.0 Apr 13 19:22:20.941400 kernel: nicpf, ver 1.0 Apr 13 19:22:20.941409 kernel: nicvf, ver 1.0 Apr 13 19:22:20.941492 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 13 19:22:20.941558 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-04-13T19:22:20 UTC (1776108140) Apr 13 19:22:20.941569 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 13 19:22:20.941577 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Apr 13 19:22:20.941586 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 13 19:22:20.941596 kernel: watchdog: Hard watchdog permanently disabled Apr 13 19:22:20.941604 kernel: NET: Registered PF_INET6 protocol family Apr 13 19:22:20.941613 kernel: Segment Routing with IPv6 Apr 13 19:22:20.941622 kernel: In-situ OAM (IOAM) with IPv6 Apr 13 19:22:20.941632 kernel: NET: Registered PF_PACKET protocol family Apr 13 19:22:20.941641 kernel: Key type dns_resolver registered Apr 13 19:22:20.941650 kernel: registered taskstats version 1 Apr 13 19:22:20.941657 kernel: Loading compiled-in X.509 certificates Apr 13 19:22:20.941666 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.127-flatcar: 51f707dd0fb1eacaaa32bdbd733952de038a5bd7' Apr 13 19:22:20.941676 kernel: Key type .fscrypt registered Apr 13 19:22:20.941684 kernel: Key type fscrypt-provisioning registered Apr 13 19:22:20.941691 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 13 19:22:20.941699 kernel: ima: Allocated hash algorithm: sha1 Apr 13 19:22:20.941707 kernel: ima: No architecture policies found Apr 13 19:22:20.941715 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 13 19:22:20.941723 kernel: clk: Disabling unused clocks Apr 13 19:22:20.941731 kernel: Freeing unused kernel memory: 39424K Apr 13 19:22:20.941739 kernel: Run /init as init process Apr 13 19:22:20.941748 kernel: with arguments: Apr 13 19:22:20.941756 kernel: /init Apr 13 19:22:20.941764 kernel: with environment: Apr 13 19:22:20.941771 kernel: HOME=/ Apr 13 19:22:20.941779 kernel: TERM=linux Apr 13 19:22:20.941789 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 13 19:22:20.941799 systemd[1]: Detected virtualization kvm. Apr 13 19:22:20.941808 systemd[1]: Detected architecture arm64. Apr 13 19:22:20.941818 systemd[1]: Running in initrd. Apr 13 19:22:20.941865 systemd[1]: No hostname configured, using default hostname. Apr 13 19:22:20.941874 systemd[1]: Hostname set to . Apr 13 19:22:20.941883 systemd[1]: Initializing machine ID from VM UUID. Apr 13 19:22:20.941892 systemd[1]: Queued start job for default target initrd.target. Apr 13 19:22:20.941900 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 13 19:22:20.941909 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 13 19:22:20.941917 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 13 19:22:20.941929 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 13 19:22:20.941938 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 13 19:22:20.941947 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 13 19:22:20.941957 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 13 19:22:20.941966 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 13 19:22:20.941974 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 13 19:22:20.941983 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 13 19:22:20.941993 systemd[1]: Reached target paths.target - Path Units. Apr 13 19:22:20.942001 systemd[1]: Reached target slices.target - Slice Units. Apr 13 19:22:20.942010 systemd[1]: Reached target swap.target - Swaps. Apr 13 19:22:20.942018 systemd[1]: Reached target timers.target - Timer Units. Apr 13 19:22:20.942026 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 13 19:22:20.942034 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 13 19:22:20.942045 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 13 19:22:20.942053 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 13 19:22:20.942064 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 13 19:22:20.942084 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 13 19:22:20.942092 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 13 19:22:20.942100 systemd[1]: Reached target sockets.target - Socket Units. Apr 13 19:22:20.942109 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 13 19:22:20.942118 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 13 19:22:20.942126 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 13 19:22:20.942135 systemd[1]: Starting systemd-fsck-usr.service... Apr 13 19:22:20.942143 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 13 19:22:20.942154 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 13 19:22:20.942162 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 13 19:22:20.942170 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 13 19:22:20.942179 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 13 19:22:20.942218 systemd-journald[238]: Collecting audit messages is disabled. Apr 13 19:22:20.942240 systemd[1]: Finished systemd-fsck-usr.service. Apr 13 19:22:20.942250 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 13 19:22:20.942258 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:20.942270 systemd-journald[238]: Journal started Apr 13 19:22:20.942290 systemd-journald[238]: Runtime Journal (/run/log/journal/6b72a671c300457e80973af9ab112b65) is 8.0M, max 76.6M, 68.6M free. Apr 13 19:22:20.917935 systemd-modules-load[239]: Inserted module 'overlay' Apr 13 19:22:20.944277 systemd[1]: Started systemd-journald.service - Journal Service. Apr 13 19:22:20.947536 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 13 19:22:20.951529 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 13 19:22:20.952609 systemd-modules-load[239]: Inserted module 'br_netfilter' Apr 13 19:22:20.953275 kernel: Bridge firewalling registered Apr 13 19:22:20.959562 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 13 19:22:20.965322 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 13 19:22:20.973301 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 13 19:22:20.976058 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 13 19:22:20.994488 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 13 19:22:20.996603 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 13 19:22:20.998501 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 13 19:22:21.000372 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 13 19:22:21.006310 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 13 19:22:21.007866 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 13 19:22:21.013274 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 13 19:22:21.020027 dracut-cmdline[272]: dracut-dracut-053 Apr 13 19:22:21.024367 dracut-cmdline[272]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyAMA0,115200n8 flatcar.first_boot=detected acpi=force flatcar.oem.id=hetzner verity.usrhash=06a955818c1cb85215c4fc3bbca340081bcaba3fb92fe20a32668615ff23854b Apr 13 19:22:21.054053 systemd-resolved[276]: Positive Trust Anchors: Apr 13 19:22:21.054769 systemd-resolved[276]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 13 19:22:21.054805 systemd-resolved[276]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 13 19:22:21.064538 systemd-resolved[276]: Defaulting to hostname 'linux'. Apr 13 19:22:21.066767 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 13 19:22:21.067517 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 13 19:22:21.111132 kernel: SCSI subsystem initialized Apr 13 19:22:21.115116 kernel: Loading iSCSI transport class v2.0-870. Apr 13 19:22:21.123528 kernel: iscsi: registered transport (tcp) Apr 13 19:22:21.137109 kernel: iscsi: registered transport (qla4xxx) Apr 13 19:22:21.137218 kernel: QLogic iSCSI HBA Driver Apr 13 19:22:21.187563 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 13 19:22:21.194390 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 13 19:22:21.212095 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 13 19:22:21.212162 kernel: device-mapper: uevent: version 1.0.3 Apr 13 19:22:21.213137 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 13 19:22:21.265167 kernel: raid6: neonx8 gen() 15644 MB/s Apr 13 19:22:21.282147 kernel: raid6: neonx4 gen() 15571 MB/s Apr 13 19:22:21.299122 kernel: raid6: neonx2 gen() 13148 MB/s Apr 13 19:22:21.316150 kernel: raid6: neonx1 gen() 10432 MB/s Apr 13 19:22:21.333129 kernel: raid6: int64x8 gen() 6928 MB/s Apr 13 19:22:21.350139 kernel: raid6: int64x4 gen() 7308 MB/s Apr 13 19:22:21.367128 kernel: raid6: int64x2 gen() 6090 MB/s Apr 13 19:22:21.384136 kernel: raid6: int64x1 gen() 5034 MB/s Apr 13 19:22:21.384220 kernel: raid6: using algorithm neonx8 gen() 15644 MB/s Apr 13 19:22:21.401132 kernel: raid6: .... xor() 11915 MB/s, rmw enabled Apr 13 19:22:21.401209 kernel: raid6: using neon recovery algorithm Apr 13 19:22:21.406113 kernel: xor: measuring software checksum speed Apr 13 19:22:21.406203 kernel: 8regs : 19802 MB/sec Apr 13 19:22:21.406230 kernel: 32regs : 17605 MB/sec Apr 13 19:22:21.407197 kernel: arm64_neon : 27105 MB/sec Apr 13 19:22:21.407234 kernel: xor: using function: arm64_neon (27105 MB/sec) Apr 13 19:22:21.459106 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 13 19:22:21.473948 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 13 19:22:21.482382 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 13 19:22:21.495484 systemd-udevd[458]: Using default interface naming scheme 'v255'. Apr 13 19:22:21.498892 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 13 19:22:21.508661 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 13 19:22:21.524175 dracut-pre-trigger[459]: rd.md=0: removing MD RAID activation Apr 13 19:22:21.563169 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 13 19:22:21.568335 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 13 19:22:21.627753 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 13 19:22:21.639227 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 13 19:22:21.650623 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 13 19:22:21.651919 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 13 19:22:21.655442 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 13 19:22:21.657928 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 13 19:22:21.666363 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 13 19:22:21.685425 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 13 19:22:21.728103 kernel: scsi host0: Virtio SCSI HBA Apr 13 19:22:21.729151 kernel: scsi 0:0:0:0: CD-ROM QEMU QEMU CD-ROM 2.5+ PQ: 0 ANSI: 5 Apr 13 19:22:21.730095 kernel: scsi 0:0:0:1: Direct-Access QEMU QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Apr 13 19:22:21.765559 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 13 19:22:21.765689 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 13 19:22:21.767699 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 13 19:22:21.769445 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 13 19:22:21.770175 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:21.771154 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 13 19:22:21.777370 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 13 19:22:21.793117 kernel: ACPI: bus type USB registered Apr 13 19:22:21.800088 kernel: usbcore: registered new interface driver usbfs Apr 13 19:22:21.800145 kernel: usbcore: registered new interface driver hub Apr 13 19:22:21.800157 kernel: usbcore: registered new device driver usb Apr 13 19:22:21.800167 kernel: sr 0:0:0:0: Power-on or device reset occurred Apr 13 19:22:21.802370 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:21.803765 kernel: sr 0:0:0:0: [sr0] scsi3-mmc drive: 16x/50x cd/rw xa/form2 cdda tray Apr 13 19:22:21.803979 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Apr 13 19:22:21.803993 kernel: sr 0:0:0:0: Attached scsi CD-ROM sr0 Apr 13 19:22:21.810537 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 13 19:22:21.829527 kernel: sd 0:0:0:1: Power-on or device reset occurred Apr 13 19:22:21.831571 kernel: sd 0:0:0:1: [sda] 80003072 512-byte logical blocks: (41.0 GB/38.1 GiB) Apr 13 19:22:21.831756 kernel: sd 0:0:0:1: [sda] Write Protect is off Apr 13 19:22:21.831872 kernel: sd 0:0:0:1: [sda] Mode Sense: 63 00 00 08 Apr 13 19:22:21.831963 kernel: sd 0:0:0:1: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Apr 13 19:22:21.839093 kernel: xhci_hcd 0000:02:00.0: xHCI Host Controller Apr 13 19:22:21.841288 kernel: xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 1 Apr 13 19:22:21.841439 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 13 19:22:21.841450 kernel: xhci_hcd 0000:02:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Apr 13 19:22:21.841541 kernel: GPT:17805311 != 80003071 Apr 13 19:22:21.842716 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 13 19:22:21.842747 kernel: GPT:17805311 != 80003071 Apr 13 19:22:21.842757 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 13 19:22:21.843688 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Apr 13 19:22:21.844096 kernel: xhci_hcd 0000:02:00.0: xHCI Host Controller Apr 13 19:22:21.847671 kernel: sd 0:0:0:1: [sda] Attached SCSI disk Apr 13 19:22:21.847888 kernel: xhci_hcd 0000:02:00.0: new USB bus registered, assigned bus number 2 Apr 13 19:22:21.848004 kernel: xhci_hcd 0000:02:00.0: Host supports USB 3.0 SuperSpeed Apr 13 19:22:21.848149 kernel: hub 1-0:1.0: USB hub found Apr 13 19:22:21.848301 kernel: hub 1-0:1.0: 4 ports detected Apr 13 19:22:21.852115 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Apr 13 19:22:21.852308 kernel: hub 2-0:1.0: USB hub found Apr 13 19:22:21.851118 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 13 19:22:21.854212 kernel: hub 2-0:1.0: 4 ports detected Apr 13 19:22:21.897141 kernel: BTRFS: device fsid ed38fcff-9752-482a-82dd-c0f0fcf94cdd devid 1 transid 33 /dev/sda3 scanned by (udev-worker) (509) Apr 13 19:22:21.905096 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/sda6 scanned by (udev-worker) (522) Apr 13 19:22:21.909886 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - QEMU_HARDDISK EFI-SYSTEM. Apr 13 19:22:21.915971 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - QEMU_HARDDISK USR-A. Apr 13 19:22:21.917251 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - QEMU_HARDDISK USR-A. Apr 13 19:22:21.929963 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - QEMU_HARDDISK ROOT. Apr 13 19:22:21.936885 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Apr 13 19:22:21.946269 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 13 19:22:21.953270 disk-uuid[578]: Primary Header is updated. Apr 13 19:22:21.953270 disk-uuid[578]: Secondary Entries is updated. Apr 13 19:22:21.953270 disk-uuid[578]: Secondary Header is updated. Apr 13 19:22:21.959087 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Apr 13 19:22:22.093109 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Apr 13 19:22:22.231744 kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:02.1/0000:02:00.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1 Apr 13 19:22:22.231831 kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:02:00.0-1/input0 Apr 13 19:22:22.232610 kernel: usbcore: registered new interface driver usbhid Apr 13 19:22:22.232630 kernel: usbhid: USB HID core driver Apr 13 19:22:22.339161 kernel: usb 1-2: new high-speed USB device number 3 using xhci_hcd Apr 13 19:22:22.469107 kernel: input: QEMU QEMU USB Keyboard as /devices/pci0000:00/0000:00:02.1/0000:02:00.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2 Apr 13 19:22:22.523581 kernel: hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:02:00.0-2/input0 Apr 13 19:22:22.971172 kernel: sda: sda1 sda2 sda3 sda4 sda6 sda7 sda9 Apr 13 19:22:22.974095 disk-uuid[579]: The operation has completed successfully. Apr 13 19:22:23.021210 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 13 19:22:23.021326 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 13 19:22:23.035331 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 13 19:22:23.052537 sh[596]: Success Apr 13 19:22:23.067514 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 13 19:22:23.129936 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 13 19:22:23.130939 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 13 19:22:23.138229 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 13 19:22:23.153419 kernel: BTRFS info (device dm-0): first mount of filesystem ed38fcff-9752-482a-82dd-c0f0fcf94cdd Apr 13 19:22:23.153497 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 13 19:22:23.153520 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 13 19:22:23.154554 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 13 19:22:23.154724 kernel: BTRFS info (device dm-0): using free space tree Apr 13 19:22:23.163124 kernel: BTRFS info (device dm-0): enabling ssd optimizations Apr 13 19:22:23.165375 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 13 19:22:23.166645 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 13 19:22:23.172281 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 13 19:22:23.177364 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 13 19:22:23.187147 kernel: BTRFS info (device sda6): first mount of filesystem 82e51161-2104-45f8-9ecc-3d62852b78d3 Apr 13 19:22:23.187218 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Apr 13 19:22:23.187235 kernel: BTRFS info (device sda6): using free space tree Apr 13 19:22:23.191124 kernel: BTRFS info (device sda6): enabling ssd optimizations Apr 13 19:22:23.191196 kernel: BTRFS info (device sda6): auto enabling async discard Apr 13 19:22:23.202786 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 13 19:22:23.205132 kernel: BTRFS info (device sda6): last unmount of filesystem 82e51161-2104-45f8-9ecc-3d62852b78d3 Apr 13 19:22:23.212761 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 13 19:22:23.219424 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 13 19:22:23.330129 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 13 19:22:23.340277 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 13 19:22:23.342232 ignition[672]: Ignition 2.19.0 Apr 13 19:22:23.342240 ignition[672]: Stage: fetch-offline Apr 13 19:22:23.342286 ignition[672]: no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:23.344346 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 13 19:22:23.342295 ignition[672]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:23.342484 ignition[672]: parsed url from cmdline: "" Apr 13 19:22:23.342487 ignition[672]: no config URL provided Apr 13 19:22:23.342492 ignition[672]: reading system config file "/usr/lib/ignition/user.ign" Apr 13 19:22:23.342498 ignition[672]: no config at "/usr/lib/ignition/user.ign" Apr 13 19:22:23.342504 ignition[672]: failed to fetch config: resource requires networking Apr 13 19:22:23.342751 ignition[672]: Ignition finished successfully Apr 13 19:22:23.368926 systemd-networkd[782]: lo: Link UP Apr 13 19:22:23.368940 systemd-networkd[782]: lo: Gained carrier Apr 13 19:22:23.370613 systemd-networkd[782]: Enumeration completed Apr 13 19:22:23.370842 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 13 19:22:23.371336 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:23.371339 systemd-networkd[782]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 13 19:22:23.372899 systemd[1]: Reached target network.target - Network. Apr 13 19:22:23.373412 systemd-networkd[782]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:23.373415 systemd-networkd[782]: eth1: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 13 19:22:23.374059 systemd-networkd[782]: eth0: Link UP Apr 13 19:22:23.374064 systemd-networkd[782]: eth0: Gained carrier Apr 13 19:22:23.374100 systemd-networkd[782]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:23.378697 systemd-networkd[782]: eth1: Link UP Apr 13 19:22:23.378704 systemd-networkd[782]: eth1: Gained carrier Apr 13 19:22:23.378723 systemd-networkd[782]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:23.380418 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 13 19:22:23.407231 ignition[785]: Ignition 2.19.0 Apr 13 19:22:23.407249 ignition[785]: Stage: fetch Apr 13 19:22:23.407503 ignition[785]: no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:23.407519 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:23.407652 ignition[785]: parsed url from cmdline: "" Apr 13 19:22:23.407656 ignition[785]: no config URL provided Apr 13 19:22:23.407660 ignition[785]: reading system config file "/usr/lib/ignition/user.ign" Apr 13 19:22:23.407667 ignition[785]: no config at "/usr/lib/ignition/user.ign" Apr 13 19:22:23.407692 ignition[785]: GET http://169.254.169.254/hetzner/v1/userdata: attempt #1 Apr 13 19:22:23.409510 ignition[785]: GET error: Get "http://169.254.169.254/hetzner/v1/userdata": dial tcp 169.254.169.254:80: connect: network is unreachable Apr 13 19:22:23.427189 systemd-networkd[782]: eth1: DHCPv4 address 10.0.0.4/32 acquired from 10.0.0.1 Apr 13 19:22:23.441215 systemd-networkd[782]: eth0: DHCPv4 address 49.13.52.168/32, gateway 172.31.1.1 acquired from 172.31.1.1 Apr 13 19:22:23.609682 ignition[785]: GET http://169.254.169.254/hetzner/v1/userdata: attempt #2 Apr 13 19:22:23.616104 ignition[785]: GET result: OK Apr 13 19:22:23.616180 ignition[785]: parsing config with SHA512: 0bbf2e78d81106dea605016f1c8d7fad6d4cd8c8842a13bb6bf4075c50a438be510c79740fc1cff3e566de5e5646db2a73bd2c134b004ecadce5c658dab7bac8 Apr 13 19:22:23.620262 unknown[785]: fetched base config from "system" Apr 13 19:22:23.620272 unknown[785]: fetched base config from "system" Apr 13 19:22:23.620609 ignition[785]: fetch: fetch complete Apr 13 19:22:23.620279 unknown[785]: fetched user config from "hetzner" Apr 13 19:22:23.620614 ignition[785]: fetch: fetch passed Apr 13 19:22:23.624462 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 13 19:22:23.620687 ignition[785]: Ignition finished successfully Apr 13 19:22:23.631393 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 13 19:22:23.647974 ignition[792]: Ignition 2.19.0 Apr 13 19:22:23.647999 ignition[792]: Stage: kargs Apr 13 19:22:23.648401 ignition[792]: no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:23.648424 ignition[792]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:23.650137 ignition[792]: kargs: kargs passed Apr 13 19:22:23.650204 ignition[792]: Ignition finished successfully Apr 13 19:22:23.653212 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 13 19:22:23.659305 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 13 19:22:23.673936 ignition[799]: Ignition 2.19.0 Apr 13 19:22:23.673955 ignition[799]: Stage: disks Apr 13 19:22:23.674481 ignition[799]: no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:23.674495 ignition[799]: no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:23.675571 ignition[799]: disks: disks passed Apr 13 19:22:23.678176 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 13 19:22:23.675626 ignition[799]: Ignition finished successfully Apr 13 19:22:23.679678 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 13 19:22:23.681170 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 13 19:22:23.682604 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 13 19:22:23.683729 systemd[1]: Reached target sysinit.target - System Initialization. Apr 13 19:22:23.684758 systemd[1]: Reached target basic.target - Basic System. Apr 13 19:22:23.691414 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 13 19:22:23.712759 systemd-fsck[808]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks Apr 13 19:22:23.716595 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 13 19:22:23.723230 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 13 19:22:23.770148 kernel: EXT4-fs (sda9): mounted filesystem 775210d8-8fbf-4f17-be2d-56007930061c r/w with ordered data mode. Quota mode: none. Apr 13 19:22:23.769889 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 13 19:22:23.770999 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 13 19:22:23.777208 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 13 19:22:23.781242 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 13 19:22:23.786345 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Apr 13 19:22:23.789279 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 13 19:22:23.790610 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 13 19:22:23.793486 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/sda6 scanned by mount (816) Apr 13 19:22:23.795319 kernel: BTRFS info (device sda6): first mount of filesystem 82e51161-2104-45f8-9ecc-3d62852b78d3 Apr 13 19:22:23.795371 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Apr 13 19:22:23.795395 kernel: BTRFS info (device sda6): using free space tree Apr 13 19:22:23.796695 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 13 19:22:23.803657 kernel: BTRFS info (device sda6): enabling ssd optimizations Apr 13 19:22:23.803742 kernel: BTRFS info (device sda6): auto enabling async discard Apr 13 19:22:23.806657 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 13 19:22:23.811791 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 13 19:22:23.870419 initrd-setup-root[844]: cut: /sysroot/etc/passwd: No such file or directory Apr 13 19:22:23.872284 coreos-metadata[818]: Apr 13 19:22:23.872 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/hostname: Attempt #1 Apr 13 19:22:23.875608 coreos-metadata[818]: Apr 13 19:22:23.875 INFO Fetch successful Apr 13 19:22:23.875608 coreos-metadata[818]: Apr 13 19:22:23.875 INFO wrote hostname ci-4081-3-7-b-5cbeb045b6 to /sysroot/etc/hostname Apr 13 19:22:23.880503 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Apr 13 19:22:23.884051 initrd-setup-root[852]: cut: /sysroot/etc/group: No such file or directory Apr 13 19:22:23.890059 initrd-setup-root[859]: cut: /sysroot/etc/shadow: No such file or directory Apr 13 19:22:23.896332 initrd-setup-root[866]: cut: /sysroot/etc/gshadow: No such file or directory Apr 13 19:22:24.015778 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 13 19:22:24.024276 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 13 19:22:24.044328 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 13 19:22:24.054123 kernel: BTRFS info (device sda6): last unmount of filesystem 82e51161-2104-45f8-9ecc-3d62852b78d3 Apr 13 19:22:24.073397 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 13 19:22:24.081380 ignition[934]: INFO : Ignition 2.19.0 Apr 13 19:22:24.081380 ignition[934]: INFO : Stage: mount Apr 13 19:22:24.083890 ignition[934]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:24.083890 ignition[934]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:24.083890 ignition[934]: INFO : mount: mount passed Apr 13 19:22:24.083890 ignition[934]: INFO : Ignition finished successfully Apr 13 19:22:24.085124 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 13 19:22:24.091284 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 13 19:22:24.154159 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 13 19:22:24.161373 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 13 19:22:24.174169 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/sda6 scanned by mount (945) Apr 13 19:22:24.176559 kernel: BTRFS info (device sda6): first mount of filesystem 82e51161-2104-45f8-9ecc-3d62852b78d3 Apr 13 19:22:24.176626 kernel: BTRFS info (device sda6): using crc32c (crc32c-generic) checksum algorithm Apr 13 19:22:24.176656 kernel: BTRFS info (device sda6): using free space tree Apr 13 19:22:24.181125 kernel: BTRFS info (device sda6): enabling ssd optimizations Apr 13 19:22:24.181201 kernel: BTRFS info (device sda6): auto enabling async discard Apr 13 19:22:24.185134 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 13 19:22:24.218250 ignition[963]: INFO : Ignition 2.19.0 Apr 13 19:22:24.218250 ignition[963]: INFO : Stage: files Apr 13 19:22:24.220140 ignition[963]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:24.220140 ignition[963]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:24.220140 ignition[963]: DEBUG : files: compiled without relabeling support, skipping Apr 13 19:22:24.223697 ignition[963]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 13 19:22:24.223697 ignition[963]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 13 19:22:24.225948 ignition[963]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 13 19:22:24.225948 ignition[963]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 13 19:22:24.225948 ignition[963]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 13 19:22:24.224910 unknown[963]: wrote ssh authorized keys file for user: core Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Apr 13 19:22:24.229869 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.35.1-arm64.raw: attempt #1 Apr 13 19:22:24.628362 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Apr 13 19:22:25.353556 systemd-networkd[782]: eth0: Gained IPv6LL Apr 13 19:22:25.353891 systemd-networkd[782]: eth1: Gained IPv6LL Apr 13 19:22:25.409187 ignition[963]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Apr 13 19:22:25.409187 ignition[963]: INFO : files: op(7): [started] processing unit "coreos-metadata.service" Apr 13 19:22:25.413737 ignition[963]: INFO : files: op(7): op(8): [started] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Apr 13 19:22:25.413737 ignition[963]: INFO : files: op(7): op(8): [finished] writing systemd drop-in "00-custom-metadata.conf" at "/sysroot/etc/systemd/system/coreos-metadata.service.d/00-custom-metadata.conf" Apr 13 19:22:25.413737 ignition[963]: INFO : files: op(7): [finished] processing unit "coreos-metadata.service" Apr 13 19:22:25.413737 ignition[963]: INFO : files: createResultFile: createFiles: op(9): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 13 19:22:25.413737 ignition[963]: INFO : files: createResultFile: createFiles: op(9): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 13 19:22:25.413737 ignition[963]: INFO : files: files passed Apr 13 19:22:25.413737 ignition[963]: INFO : Ignition finished successfully Apr 13 19:22:25.413755 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 13 19:22:25.419419 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 13 19:22:25.423600 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 13 19:22:25.431414 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 13 19:22:25.431532 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 13 19:22:25.443762 initrd-setup-root-after-ignition[991]: grep: Apr 13 19:22:25.443762 initrd-setup-root-after-ignition[995]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 13 19:22:25.446003 initrd-setup-root-after-ignition[991]: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 13 19:22:25.446003 initrd-setup-root-after-ignition[991]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 13 19:22:25.449059 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 13 19:22:25.450361 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 13 19:22:25.455293 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 13 19:22:25.510153 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 13 19:22:25.511144 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 13 19:22:25.513733 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 13 19:22:25.514613 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 13 19:22:25.516261 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 13 19:22:25.525344 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 13 19:22:25.539054 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 13 19:22:25.545455 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 13 19:22:25.559086 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 13 19:22:25.559878 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 13 19:22:25.560706 systemd[1]: Stopped target timers.target - Timer Units. Apr 13 19:22:25.561730 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 13 19:22:25.561870 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 13 19:22:25.563726 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 13 19:22:25.564385 systemd[1]: Stopped target basic.target - Basic System. Apr 13 19:22:25.564906 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 13 19:22:25.566011 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 13 19:22:25.567292 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 13 19:22:25.568409 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 13 19:22:25.569474 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 13 19:22:25.570804 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 13 19:22:25.571963 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 13 19:22:25.572974 systemd[1]: Stopped target swap.target - Swaps. Apr 13 19:22:25.573851 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 13 19:22:25.573973 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 13 19:22:25.575690 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 13 19:22:25.576475 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 13 19:22:25.577713 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 13 19:22:25.577787 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 13 19:22:25.578754 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 13 19:22:25.578889 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 13 19:22:25.580445 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 13 19:22:25.580556 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 13 19:22:25.581865 systemd[1]: ignition-files.service: Deactivated successfully. Apr 13 19:22:25.581960 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 13 19:22:25.583033 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Apr 13 19:22:25.583145 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Apr 13 19:22:25.590384 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 13 19:22:25.593751 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 13 19:22:25.594387 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 13 19:22:25.594531 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 13 19:22:25.599677 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 13 19:22:25.599810 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 13 19:22:25.610037 ignition[1015]: INFO : Ignition 2.19.0 Apr 13 19:22:25.610037 ignition[1015]: INFO : Stage: umount Apr 13 19:22:25.612685 ignition[1015]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 13 19:22:25.612685 ignition[1015]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/hetzner" Apr 13 19:22:25.612685 ignition[1015]: INFO : umount: umount passed Apr 13 19:22:25.612685 ignition[1015]: INFO : Ignition finished successfully Apr 13 19:22:25.616767 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 13 19:22:25.620044 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 13 19:22:25.621108 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 13 19:22:25.621216 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 13 19:22:25.622486 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 13 19:22:25.622588 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 13 19:22:25.628259 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 13 19:22:25.628332 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 13 19:22:25.629536 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 13 19:22:25.629589 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 13 19:22:25.632409 systemd[1]: Stopped target network.target - Network. Apr 13 19:22:25.635718 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 13 19:22:25.635833 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 13 19:22:25.637864 systemd[1]: Stopped target paths.target - Path Units. Apr 13 19:22:25.640297 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 13 19:22:25.645156 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 13 19:22:25.647835 systemd[1]: Stopped target slices.target - Slice Units. Apr 13 19:22:25.649533 systemd[1]: Stopped target sockets.target - Socket Units. Apr 13 19:22:25.652836 systemd[1]: iscsid.socket: Deactivated successfully. Apr 13 19:22:25.652910 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 13 19:22:25.656762 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 13 19:22:25.656893 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 13 19:22:25.659464 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 13 19:22:25.659542 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 13 19:22:25.660642 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 13 19:22:25.662995 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 13 19:22:25.664322 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 13 19:22:25.665594 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 13 19:22:25.669440 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 13 19:22:25.670040 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 13 19:22:25.670193 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 13 19:22:25.670284 systemd-networkd[782]: eth1: DHCPv6 lease lost Apr 13 19:22:25.671628 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 13 19:22:25.671720 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 13 19:22:25.675938 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 13 19:22:25.677103 systemd-networkd[782]: eth0: DHCPv6 lease lost Apr 13 19:22:25.678022 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 13 19:22:25.681403 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 13 19:22:25.681547 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 13 19:22:25.683629 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 13 19:22:25.683697 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 13 19:22:25.693304 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 13 19:22:25.693938 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 13 19:22:25.694044 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 13 19:22:25.696189 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 13 19:22:25.696244 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 13 19:22:25.696831 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 13 19:22:25.696887 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 13 19:22:25.697559 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 13 19:22:25.697600 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 13 19:22:25.698774 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 13 19:22:25.716748 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 13 19:22:25.716982 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 13 19:22:25.719685 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 13 19:22:25.719925 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 13 19:22:25.722262 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 13 19:22:25.722314 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 13 19:22:25.723667 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 13 19:22:25.723707 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 13 19:22:25.724366 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 13 19:22:25.724419 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 13 19:22:25.726007 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 13 19:22:25.726076 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 13 19:22:25.727743 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 13 19:22:25.727833 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 13 19:22:25.734315 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 13 19:22:25.734979 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 13 19:22:25.735053 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 13 19:22:25.737927 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Apr 13 19:22:25.737989 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 13 19:22:25.740346 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 13 19:22:25.740402 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 13 19:22:25.741045 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 13 19:22:25.741109 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:25.747550 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 13 19:22:25.747672 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 13 19:22:25.751013 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 13 19:22:25.765294 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 13 19:22:25.774691 systemd[1]: Switching root. Apr 13 19:22:25.812168 systemd-journald[238]: Journal stopped Apr 13 19:22:26.777140 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Apr 13 19:22:26.777211 kernel: SELinux: policy capability network_peer_controls=1 Apr 13 19:22:26.777233 kernel: SELinux: policy capability open_perms=1 Apr 13 19:22:26.777245 kernel: SELinux: policy capability extended_socket_class=1 Apr 13 19:22:26.777255 kernel: SELinux: policy capability always_check_network=0 Apr 13 19:22:26.777265 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 13 19:22:26.777276 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 13 19:22:26.777286 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 13 19:22:26.777296 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 13 19:22:26.777311 kernel: audit: type=1403 audit(1776108145.942:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 13 19:22:26.777322 systemd[1]: Successfully loaded SELinux policy in 42.093ms. Apr 13 19:22:26.777341 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.386ms. Apr 13 19:22:26.777354 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 13 19:22:26.777365 systemd[1]: Detected virtualization kvm. Apr 13 19:22:26.777380 systemd[1]: Detected architecture arm64. Apr 13 19:22:26.777391 systemd[1]: Detected first boot. Apr 13 19:22:26.777402 systemd[1]: Hostname set to . Apr 13 19:22:26.777413 systemd[1]: Initializing machine ID from VM UUID. Apr 13 19:22:26.777425 zram_generator::config[1059]: No configuration found. Apr 13 19:22:26.779345 systemd[1]: Populated /etc with preset unit settings. Apr 13 19:22:26.779370 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 13 19:22:26.779382 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 13 19:22:26.779393 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 13 19:22:26.779405 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 13 19:22:26.779415 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 13 19:22:26.779433 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 13 19:22:26.779444 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 13 19:22:26.779457 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 13 19:22:26.779468 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 13 19:22:26.779479 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 13 19:22:26.779489 systemd[1]: Created slice user.slice - User and Session Slice. Apr 13 19:22:26.779499 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 13 19:22:26.779511 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 13 19:22:26.779522 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 13 19:22:26.779533 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 13 19:22:26.779543 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 13 19:22:26.779555 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 13 19:22:26.779565 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Apr 13 19:22:26.779576 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 13 19:22:26.779586 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 13 19:22:26.779597 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 13 19:22:26.779607 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 13 19:22:26.779619 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 13 19:22:26.779630 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 13 19:22:26.779640 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 13 19:22:26.779651 systemd[1]: Reached target slices.target - Slice Units. Apr 13 19:22:26.779662 systemd[1]: Reached target swap.target - Swaps. Apr 13 19:22:26.779672 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 13 19:22:26.779682 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 13 19:22:26.779692 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 13 19:22:26.779702 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 13 19:22:26.779714 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 13 19:22:26.779724 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 13 19:22:26.779739 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 13 19:22:26.779749 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 13 19:22:26.779760 systemd[1]: Mounting media.mount - External Media Directory... Apr 13 19:22:26.779771 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 13 19:22:26.779792 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 13 19:22:26.779805 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 13 19:22:26.779816 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Apr 13 19:22:26.779829 systemd[1]: Reached target machines.target - Containers. Apr 13 19:22:26.779840 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 13 19:22:26.779851 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 13 19:22:26.779862 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 13 19:22:26.779873 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 13 19:22:26.779883 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 13 19:22:26.779893 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 13 19:22:26.779904 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 13 19:22:26.779917 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 13 19:22:26.779928 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 13 19:22:26.779939 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 13 19:22:26.779949 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 13 19:22:26.779959 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 13 19:22:26.779970 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 13 19:22:26.779980 systemd[1]: Stopped systemd-fsck-usr.service. Apr 13 19:22:26.779990 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 13 19:22:26.780000 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 13 19:22:26.780012 kernel: loop: module loaded Apr 13 19:22:26.780023 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 13 19:22:26.780033 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 13 19:22:26.780048 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 13 19:22:26.780061 systemd[1]: verity-setup.service: Deactivated successfully. Apr 13 19:22:26.780091 systemd[1]: Stopped verity-setup.service. Apr 13 19:22:26.780249 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 13 19:22:26.780267 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 13 19:22:26.780277 systemd[1]: Mounted media.mount - External Media Directory. Apr 13 19:22:26.780287 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 13 19:22:26.780298 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 13 19:22:26.780310 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 13 19:22:26.780321 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 13 19:22:26.780331 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 13 19:22:26.780341 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 13 19:22:26.780352 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 13 19:22:26.780362 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 13 19:22:26.780372 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 13 19:22:26.780383 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 13 19:22:26.780396 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 13 19:22:26.780406 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 13 19:22:26.780416 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 13 19:22:26.780427 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 13 19:22:26.780438 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 13 19:22:26.780448 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 13 19:22:26.780460 kernel: ACPI: bus type drm_connector registered Apr 13 19:22:26.780470 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 13 19:22:26.780481 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 13 19:22:26.780492 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 13 19:22:26.780502 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 13 19:22:26.780512 kernel: fuse: init (API version 7.39) Apr 13 19:22:26.780522 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 13 19:22:26.780572 systemd-journald[1126]: Collecting audit messages is disabled. Apr 13 19:22:26.780603 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 13 19:22:26.780614 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 13 19:22:26.780626 systemd-journald[1126]: Journal started Apr 13 19:22:26.780649 systemd-journald[1126]: Runtime Journal (/run/log/journal/6b72a671c300457e80973af9ab112b65) is 8.0M, max 76.6M, 68.6M free. Apr 13 19:22:26.462932 systemd[1]: Queued start job for default target multi-user.target. Apr 13 19:22:26.479961 systemd[1]: Unnecessary job was removed for dev-sda6.device - /dev/sda6. Apr 13 19:22:26.480465 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 13 19:22:26.785221 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 13 19:22:26.785274 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 13 19:22:26.789420 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 13 19:22:26.792091 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 13 19:22:26.797585 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 13 19:22:26.805226 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 13 19:22:26.808094 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 13 19:22:26.814488 systemd[1]: Started systemd-journald.service - Journal Service. Apr 13 19:22:26.815616 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 13 19:22:26.815815 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 13 19:22:26.818569 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 13 19:22:26.818730 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 13 19:22:26.820379 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 13 19:22:26.822149 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 13 19:22:26.860684 systemd-tmpfiles[1155]: ACLs are not supported, ignoring. Apr 13 19:22:26.860696 systemd-tmpfiles[1155]: ACLs are not supported, ignoring. Apr 13 19:22:26.862944 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 13 19:22:26.870758 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 13 19:22:26.880667 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 13 19:22:26.882341 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 13 19:22:26.891969 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 13 19:22:26.894231 systemd-journald[1126]: Time spent on flushing to /var/log/journal/6b72a671c300457e80973af9ab112b65 is 50.895ms for 1112 entries. Apr 13 19:22:26.894231 systemd-journald[1126]: System Journal (/var/log/journal/6b72a671c300457e80973af9ab112b65) is 8.0M, max 584.8M, 576.8M free. Apr 13 19:22:26.964592 systemd-journald[1126]: Received client request to flush runtime journal. Apr 13 19:22:26.964667 kernel: loop0: detected capacity change from 0 to 197488 Apr 13 19:22:26.902606 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 13 19:22:26.904138 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 13 19:22:26.905562 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 13 19:22:26.929641 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 13 19:22:26.971318 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 13 19:22:26.976636 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 13 19:22:26.993182 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 13 19:22:27.000740 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 13 19:22:27.001977 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 13 19:22:27.017620 kernel: loop1: detected capacity change from 0 to 8 Apr 13 19:22:27.020595 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 13 19:22:27.035314 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 13 19:22:27.036229 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 13 19:22:27.043716 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 13 19:22:27.048160 kernel: loop2: detected capacity change from 0 to 114432 Apr 13 19:22:27.068342 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. Apr 13 19:22:27.068360 systemd-tmpfiles[1195]: ACLs are not supported, ignoring. Apr 13 19:22:27.081393 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 13 19:22:27.087894 kernel: loop3: detected capacity change from 0 to 114328 Apr 13 19:22:27.086911 udevadm[1198]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Apr 13 19:22:27.123375 kernel: loop4: detected capacity change from 0 to 197488 Apr 13 19:22:27.148140 kernel: loop5: detected capacity change from 0 to 8 Apr 13 19:22:27.151211 kernel: loop6: detected capacity change from 0 to 114432 Apr 13 19:22:27.163148 kernel: loop7: detected capacity change from 0 to 114328 Apr 13 19:22:27.176529 (sd-merge)[1202]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-hetzner'. Apr 13 19:22:27.178240 (sd-merge)[1202]: Merged extensions into '/usr'. Apr 13 19:22:27.187353 systemd[1]: Reloading requested from client PID 1154 ('systemd-sysext') (unit systemd-sysext.service)... Apr 13 19:22:27.187516 systemd[1]: Reloading... Apr 13 19:22:27.291096 zram_generator::config[1229]: No configuration found. Apr 13 19:22:27.497296 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 13 19:22:27.502378 ldconfig[1147]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 13 19:22:27.551216 systemd[1]: Reloading finished in 363 ms. Apr 13 19:22:27.585254 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 13 19:22:27.591365 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 13 19:22:27.602375 systemd[1]: Starting ensure-sysext.service... Apr 13 19:22:27.605307 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 13 19:22:27.619650 systemd[1]: Reloading requested from client PID 1266 ('systemctl') (unit ensure-sysext.service)... Apr 13 19:22:27.619668 systemd[1]: Reloading... Apr 13 19:22:27.649769 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 13 19:22:27.650581 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 13 19:22:27.652249 systemd-tmpfiles[1267]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 13 19:22:27.652621 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Apr 13 19:22:27.652740 systemd-tmpfiles[1267]: ACLs are not supported, ignoring. Apr 13 19:22:27.657125 systemd-tmpfiles[1267]: Detected autofs mount point /boot during canonicalization of boot. Apr 13 19:22:27.657134 systemd-tmpfiles[1267]: Skipping /boot Apr 13 19:22:27.667332 systemd-tmpfiles[1267]: Detected autofs mount point /boot during canonicalization of boot. Apr 13 19:22:27.667468 systemd-tmpfiles[1267]: Skipping /boot Apr 13 19:22:27.718118 zram_generator::config[1294]: No configuration found. Apr 13 19:22:27.814891 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 13 19:22:27.864046 systemd[1]: Reloading finished in 243 ms. Apr 13 19:22:27.884040 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 13 19:22:27.885459 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 13 19:22:27.898915 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Apr 13 19:22:27.908313 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 13 19:22:27.914389 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 13 19:22:27.919985 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 13 19:22:27.926281 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 13 19:22:27.935473 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 13 19:22:27.944697 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 13 19:22:27.947805 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 13 19:22:27.950673 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 13 19:22:27.955042 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 13 19:22:27.958183 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 13 19:22:27.958911 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 13 19:22:27.961652 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 13 19:22:27.961842 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 13 19:22:27.964524 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 13 19:22:27.973465 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 13 19:22:27.974303 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 13 19:22:27.978666 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 13 19:22:27.980267 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 13 19:22:27.982797 systemd[1]: Finished ensure-sysext.service. Apr 13 19:22:27.997881 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Apr 13 19:22:28.008940 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 13 19:22:28.031317 augenrules[1363]: No rules Apr 13 19:22:28.034145 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Apr 13 19:22:28.047034 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 13 19:22:28.049539 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 13 19:22:28.049705 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 13 19:22:28.052486 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 13 19:22:28.058308 systemd-udevd[1344]: Using default interface naming scheme 'v255'. Apr 13 19:22:28.064337 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 13 19:22:28.065475 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 13 19:22:28.065636 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 13 19:22:28.068143 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 13 19:22:28.068304 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 13 19:22:28.072509 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 13 19:22:28.083680 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 13 19:22:28.092652 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 13 19:22:28.094023 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 13 19:22:28.097688 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 13 19:22:28.106671 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 13 19:22:28.109392 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 13 19:22:28.192219 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Apr 13 19:22:28.193586 systemd[1]: Reached target time-set.target - System Time Set. Apr 13 19:22:28.247605 systemd-networkd[1388]: lo: Link UP Apr 13 19:22:28.248005 systemd-networkd[1388]: lo: Gained carrier Apr 13 19:22:28.248864 systemd-networkd[1388]: Enumeration completed Apr 13 19:22:28.248986 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 13 19:22:28.260410 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 13 19:22:28.268102 systemd-resolved[1343]: Positive Trust Anchors: Apr 13 19:22:28.268118 systemd-resolved[1343]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 13 19:22:28.268157 systemd-resolved[1343]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 13 19:22:28.279029 systemd-resolved[1343]: Using system hostname 'ci-4081-3-7-b-5cbeb045b6'. Apr 13 19:22:28.282436 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 13 19:22:28.283988 systemd[1]: Reached target network.target - Network. Apr 13 19:22:28.285020 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 13 19:22:28.295562 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Apr 13 19:22:28.360131 kernel: mousedev: PS/2 mouse device common for all mice Apr 13 19:22:28.370911 systemd-networkd[1388]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:28.370921 systemd-networkd[1388]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 13 19:22:28.373991 systemd-networkd[1388]: eth0: Link UP Apr 13 19:22:28.374223 systemd-networkd[1388]: eth0: Gained carrier Apr 13 19:22:28.374300 systemd-networkd[1388]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:28.379132 systemd-networkd[1388]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:28.379473 systemd-networkd[1388]: eth1: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 13 19:22:28.381267 systemd-networkd[1388]: eth1: Link UP Apr 13 19:22:28.381650 systemd-networkd[1388]: eth1: Gained carrier Apr 13 19:22:28.381677 systemd-networkd[1388]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 13 19:22:28.423169 systemd-networkd[1388]: eth0: DHCPv4 address 49.13.52.168/32, gateway 172.31.1.1 acquired from 172.31.1.1 Apr 13 19:22:28.426195 systemd-networkd[1388]: eth1: DHCPv4 address 10.0.0.4/32 acquired from 10.0.0.1 Apr 13 19:22:28.427151 systemd-timesyncd[1360]: Network configuration changed, trying to establish connection. Apr 13 19:22:28.427230 systemd-timesyncd[1360]: Network configuration changed, trying to establish connection. Apr 13 19:22:28.428420 systemd-timesyncd[1360]: Network configuration changed, trying to establish connection. Apr 13 19:22:28.446000 systemd[1]: Condition check resulted in dev-virtio\x2dports-org.qemu.guest_agent.0.device - /dev/virtio-ports/org.qemu.guest_agent.0 being skipped. Apr 13 19:22:28.446549 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 13 19:22:28.453387 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 13 19:22:28.457608 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 13 19:22:28.463374 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 13 19:22:28.465210 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 13 19:22:28.465273 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 13 19:22:28.472503 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 13 19:22:28.472667 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 13 19:22:28.481500 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 13 19:22:28.481664 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 13 19:22:28.482624 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 13 19:22:28.495548 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 13 19:22:28.495967 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 13 19:22:28.497762 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 13 19:22:28.523100 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (1402) Apr 13 19:22:28.548223 kernel: [drm] pci: virtio-gpu-pci detected at 0000:00:01.0 Apr 13 19:22:28.548329 kernel: [drm] features: -virgl +edid -resource_blob -host_visible Apr 13 19:22:28.548357 kernel: [drm] features: -context_init Apr 13 19:22:28.551170 kernel: [drm] number of scanouts: 1 Apr 13 19:22:28.551269 kernel: [drm] number of cap sets: 0 Apr 13 19:22:28.553105 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:01.0 on minor 0 Apr 13 19:22:28.562559 kernel: Console: switching to colour frame buffer device 160x50 Apr 13 19:22:28.570106 kernel: virtio-pci 0000:00:01.0: [drm] fb0: virtio_gpudrmfb frame buffer device Apr 13 19:22:28.571381 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 13 19:22:28.579558 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - QEMU_HARDDISK OEM. Apr 13 19:22:28.588326 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 13 19:22:28.598441 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 13 19:22:28.601127 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:28.606293 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 13 19:22:28.607297 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 13 19:22:28.671420 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 13 19:22:28.703786 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 13 19:22:28.712499 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 13 19:22:28.727112 lvm[1447]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 13 19:22:28.758194 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 13 19:22:28.759821 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 13 19:22:28.760736 systemd[1]: Reached target sysinit.target - System Initialization. Apr 13 19:22:28.761665 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 13 19:22:28.763133 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 13 19:22:28.763986 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 13 19:22:28.764916 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 13 19:22:28.765801 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 13 19:22:28.766715 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 13 19:22:28.766759 systemd[1]: Reached target paths.target - Path Units. Apr 13 19:22:28.767398 systemd[1]: Reached target timers.target - Timer Units. Apr 13 19:22:28.770189 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 13 19:22:28.774022 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 13 19:22:28.780535 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 13 19:22:28.785186 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 13 19:22:28.786592 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 13 19:22:28.787557 systemd[1]: Reached target sockets.target - Socket Units. Apr 13 19:22:28.788437 systemd[1]: Reached target basic.target - Basic System. Apr 13 19:22:28.789198 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 13 19:22:28.789285 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 13 19:22:28.795536 systemd[1]: Starting containerd.service - containerd container runtime... Apr 13 19:22:28.800124 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 13 19:22:28.806100 lvm[1451]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 13 19:22:28.809232 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 13 19:22:28.815352 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 13 19:22:28.825401 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 13 19:22:28.826045 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Apr 13 19:22:28.828604 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 13 19:22:28.833375 systemd[1]: Started qemu-guest-agent.service - QEMU Guest Agent. Apr 13 19:22:28.835971 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 13 19:22:28.840583 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 13 19:22:28.844716 jq[1455]: false Apr 13 19:22:28.845283 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 13 19:22:28.848006 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 13 19:22:28.848680 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 13 19:22:28.853742 systemd[1]: Starting update-engine.service - Update Engine... Apr 13 19:22:28.864984 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 13 19:22:28.871121 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 13 19:22:28.874546 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 13 19:22:28.874794 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 13 19:22:28.896958 dbus-daemon[1454]: [system] SELinux support is enabled Apr 13 19:22:28.904156 coreos-metadata[1453]: Apr 13 19:22:28.903 INFO Fetching http://169.254.169.254/hetzner/v1/metadata: Attempt #1 Apr 13 19:22:28.907000 extend-filesystems[1458]: Found loop4 Apr 13 19:22:28.906269 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 13 19:22:28.917960 extend-filesystems[1458]: Found loop5 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found loop6 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found loop7 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda1 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda2 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda3 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found usr Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda4 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda6 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda7 Apr 13 19:22:28.917960 extend-filesystems[1458]: Found sda9 Apr 13 19:22:28.917960 extend-filesystems[1458]: Checking size of /dev/sda9 Apr 13 19:22:28.940595 coreos-metadata[1453]: Apr 13 19:22:28.909 INFO Fetch successful Apr 13 19:22:28.940595 coreos-metadata[1453]: Apr 13 19:22:28.909 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/private-networks: Attempt #1 Apr 13 19:22:28.940595 coreos-metadata[1453]: Apr 13 19:22:28.922 INFO Fetch successful Apr 13 19:22:28.910656 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 13 19:22:28.910840 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 13 19:22:28.943555 jq[1466]: true Apr 13 19:22:28.914817 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Apr 13 19:22:28.914876 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 13 19:22:28.916612 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Apr 13 19:22:28.916636 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 13 19:22:28.939220 (ntainerd)[1477]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 13 19:22:28.959286 extend-filesystems[1458]: Resized partition /dev/sda9 Apr 13 19:22:28.961408 systemd[1]: motdgen.service: Deactivated successfully. Apr 13 19:22:28.961592 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 13 19:22:28.976876 extend-filesystems[1493]: resize2fs 1.47.1 (20-May-2024) Apr 13 19:22:28.979663 update_engine[1464]: I20260413 19:22:28.979380 1464 main.cc:92] Flatcar Update Engine starting Apr 13 19:22:28.983577 kernel: EXT4-fs (sda9): resizing filesystem from 1617920 to 9393147 blocks Apr 13 19:22:28.991358 jq[1480]: true Apr 13 19:22:28.997447 update_engine[1464]: I20260413 19:22:28.997265 1464 update_check_scheduler.cc:74] Next update check in 10m36s Apr 13 19:22:29.007088 systemd[1]: Started update-engine.service - Update Engine. Apr 13 19:22:29.019438 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 13 19:22:29.106134 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 13 19:22:29.107105 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 13 19:22:29.124470 systemd-logind[1463]: New seat seat0. Apr 13 19:22:29.158121 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (1380) Apr 13 19:22:29.170099 kernel: EXT4-fs (sda9): resized filesystem to 9393147 Apr 13 19:22:29.184242 extend-filesystems[1493]: Filesystem at /dev/sda9 is mounted on /; on-line resizing required Apr 13 19:22:29.184242 extend-filesystems[1493]: old_desc_blocks = 1, new_desc_blocks = 5 Apr 13 19:22:29.184242 extend-filesystems[1493]: The filesystem on /dev/sda9 is now 9393147 (4k) blocks long. Apr 13 19:22:29.185124 systemd-logind[1463]: Watching system buttons on /dev/input/event0 (Power Button) Apr 13 19:22:29.205995 bash[1524]: Updated "/home/core/.ssh/authorized_keys" Apr 13 19:22:29.206101 extend-filesystems[1458]: Resized filesystem in /dev/sda9 Apr 13 19:22:29.206101 extend-filesystems[1458]: Found sr0 Apr 13 19:22:29.185161 systemd-logind[1463]: Watching system buttons on /dev/input/event2 (QEMU QEMU USB Keyboard) Apr 13 19:22:29.186200 systemd[1]: Started systemd-logind.service - User Login Management. Apr 13 19:22:29.195486 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 13 19:22:29.195820 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 13 19:22:29.200928 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 13 19:22:29.221114 systemd[1]: Starting sshkeys.service... Apr 13 19:22:29.237443 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Apr 13 19:22:29.241506 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Apr 13 19:22:29.271611 containerd[1477]: time="2026-04-13T19:22:29.271495320Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Apr 13 19:22:29.295151 coreos-metadata[1531]: Apr 13 19:22:29.295 INFO Fetching http://169.254.169.254/hetzner/v1/metadata/public-keys: Attempt #1 Apr 13 19:22:29.296264 coreos-metadata[1531]: Apr 13 19:22:29.296 INFO Fetch successful Apr 13 19:22:29.299014 unknown[1531]: wrote ssh authorized keys file for user: core Apr 13 19:22:29.317290 containerd[1477]: time="2026-04-13T19:22:29.316997760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.320860 locksmithd[1500]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322297480Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.127-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322340800Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322364080Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322556600Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322575000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322639720Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322655280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322866880Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322888120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322905120Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324375 containerd[1477]: time="2026-04-13T19:22:29.322924200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323011840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323259600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323369400Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323384360Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323464120Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 13 19:22:29.324750 containerd[1477]: time="2026-04-13T19:22:29.323556200Z" level=info msg="metadata content store policy set" policy=shared Apr 13 19:22:29.330823 containerd[1477]: time="2026-04-13T19:22:29.330682640Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 13 19:22:29.331684 containerd[1477]: time="2026-04-13T19:22:29.331010400Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 13 19:22:29.331684 containerd[1477]: time="2026-04-13T19:22:29.331168400Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 13 19:22:29.331684 containerd[1477]: time="2026-04-13T19:22:29.331223560Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 13 19:22:29.331684 containerd[1477]: time="2026-04-13T19:22:29.331255040Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 13 19:22:29.331684 containerd[1477]: time="2026-04-13T19:22:29.331559160Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 13 19:22:29.333166 containerd[1477]: time="2026-04-13T19:22:29.332607920Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 13 19:22:29.333510 containerd[1477]: time="2026-04-13T19:22:29.333329080Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 13 19:22:29.333510 containerd[1477]: time="2026-04-13T19:22:29.333374720Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 13 19:22:29.333510 containerd[1477]: time="2026-04-13T19:22:29.333400880Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 13 19:22:29.333510 containerd[1477]: time="2026-04-13T19:22:29.333437360Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.333510 containerd[1477]: time="2026-04-13T19:22:29.333464280Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334021280Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334054680Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334095560Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334114640Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334135120Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334151560Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334182920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334199600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334214840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334231640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334254800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334281560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334296840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334614 containerd[1477]: time="2026-04-13T19:22:29.334313160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334329280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334347280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334361680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334386680Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334406400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334426000Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334452280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334466440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.334975 containerd[1477]: time="2026-04-13T19:22:29.334479800Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335527640Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335720000Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335736640Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335751680Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335801000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335853640Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335869200Z" level=info msg="NRI interface is disabled by configuration." Apr 13 19:22:29.336132 containerd[1477]: time="2026-04-13T19:22:29.335884400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 13 19:22:29.337388 containerd[1477]: time="2026-04-13T19:22:29.336630600Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Apr 13 19:22:29.337388 containerd[1477]: time="2026-04-13T19:22:29.336715920Z" level=info msg="Connect containerd service" Apr 13 19:22:29.337388 containerd[1477]: time="2026-04-13T19:22:29.336773560Z" level=info msg="using legacy CRI server" Apr 13 19:22:29.337388 containerd[1477]: time="2026-04-13T19:22:29.336782040Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 13 19:22:29.337388 containerd[1477]: time="2026-04-13T19:22:29.336872920Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 13 19:22:29.338613 containerd[1477]: time="2026-04-13T19:22:29.338582920Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Apr 13 19:22:29.338971 containerd[1477]: time="2026-04-13T19:22:29.338921560Z" level=info msg="Start subscribing containerd event" Apr 13 19:22:29.340721 update-ssh-keys[1537]: Updated "/home/core/.ssh/authorized_keys" Apr 13 19:22:29.340950 containerd[1477]: time="2026-04-13T19:22:29.339951920Z" level=info msg="Start recovering state" Apr 13 19:22:29.340950 containerd[1477]: time="2026-04-13T19:22:29.340044960Z" level=info msg="Start event monitor" Apr 13 19:22:29.340950 containerd[1477]: time="2026-04-13T19:22:29.340056520Z" level=info msg="Start snapshots syncer" Apr 13 19:22:29.340950 containerd[1477]: time="2026-04-13T19:22:29.340085480Z" level=info msg="Start cni network conf syncer for default" Apr 13 19:22:29.340950 containerd[1477]: time="2026-04-13T19:22:29.340095520Z" level=info msg="Start streaming server" Apr 13 19:22:29.341468 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Apr 13 19:22:29.342813 containerd[1477]: time="2026-04-13T19:22:29.342746960Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 13 19:22:29.342925 containerd[1477]: time="2026-04-13T19:22:29.342910640Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 13 19:22:29.343032 containerd[1477]: time="2026-04-13T19:22:29.343021360Z" level=info msg="containerd successfully booted in 0.073916s" Apr 13 19:22:29.346742 systemd[1]: Started containerd.service - containerd container runtime. Apr 13 19:22:29.349818 systemd[1]: Finished sshkeys.service. Apr 13 19:22:29.470028 sshd_keygen[1492]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 13 19:22:29.493611 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 13 19:22:29.503636 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 13 19:22:29.510276 systemd[1]: issuegen.service: Deactivated successfully. Apr 13 19:22:29.510775 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 13 19:22:29.520507 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 13 19:22:29.534133 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 13 19:22:29.550917 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 13 19:22:29.559525 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Apr 13 19:22:29.560657 systemd[1]: Reached target getty.target - Login Prompts. Apr 13 19:22:30.089391 systemd-networkd[1388]: eth0: Gained IPv6LL Apr 13 19:22:30.092325 systemd-timesyncd[1360]: Network configuration changed, trying to establish connection. Apr 13 19:22:30.098169 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 13 19:22:30.100597 systemd[1]: Reached target network-online.target - Network is Online. Apr 13 19:22:30.106389 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:22:30.112201 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 13 19:22:30.141254 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 13 19:22:30.346404 systemd-networkd[1388]: eth1: Gained IPv6LL Apr 13 19:22:30.347590 systemd-timesyncd[1360]: Network configuration changed, trying to establish connection. Apr 13 19:22:30.896315 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:22:30.897816 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 13 19:22:30.904476 systemd[1]: Startup finished in 778ms (kernel) + 5.240s (initrd) + 5.003s (userspace) = 11.022s. Apr 13 19:22:30.906803 (kubelet)[1576]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 13 19:22:31.373586 kubelet[1576]: E0413 19:22:31.373444 1576 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Apr 13 19:22:31.377839 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 13 19:22:31.378181 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 13 19:22:41.628523 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 1. Apr 13 19:22:41.636054 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:22:41.786301 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:22:41.798359 (kubelet)[1595]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 13 19:22:41.845098 kubelet[1595]: E0413 19:22:41.842754 1595 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Apr 13 19:22:41.846525 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 13 19:22:41.846750 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 13 19:22:51.966038 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 2. Apr 13 19:22:51.976857 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:22:52.134184 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:22:52.146935 (kubelet)[1610]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 13 19:22:52.189400 kubelet[1610]: E0413 19:22:52.189319 1610 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Apr 13 19:22:52.193197 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 13 19:22:52.193523 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 13 19:23:00.662952 systemd-timesyncd[1360]: Contacted time server 134.60.111.110:123 (2.flatcar.pool.ntp.org). Apr 13 19:23:00.663125 systemd-timesyncd[1360]: Initial clock synchronization to Mon 2026-04-13 19:23:01.045424 UTC. Apr 13 19:23:02.216815 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 3. Apr 13 19:23:02.231515 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:23:02.383287 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:23:02.395771 (kubelet)[1625]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 13 19:23:02.445886 kubelet[1625]: E0413 19:23:02.445819 1625 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Apr 13 19:23:02.449634 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 13 19:23:02.450027 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 13 19:23:04.948220 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 13 19:23:04.977077 systemd[1]: Started sshd@0-49.13.52.168:22-50.85.169.122:59402.service - OpenSSH per-connection server daemon (50.85.169.122:59402). Apr 13 19:23:05.117320 sshd[1634]: Accepted publickey for core from 50.85.169.122 port 59402 ssh2: RSA SHA256:iZ69s7jdfZeZWl77uzTdj7kYKrt9+aDLOIz6i/Hnoms Apr 13 19:23:05.119632 sshd[1634]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 13 19:23:05.131279 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 13 19:23:05.140554 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 13 19:23:05.145249 systemd-logind[1463]: New session 1 of user core. Apr 13 19:23:05.159144 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 13 19:23:05.172715 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 13 19:23:05.177551 (systemd)[1638]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 13 19:23:05.291751 systemd[1638]: Queued start job for default target default.target. Apr 13 19:23:05.302552 systemd[1638]: Created slice app.slice - User Application Slice. Apr 13 19:23:05.302921 systemd[1638]: Reached target paths.target - Paths. Apr 13 19:23:05.302965 systemd[1638]: Reached target timers.target - Timers. Apr 13 19:23:05.305837 systemd[1638]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 13 19:23:05.322943 systemd[1638]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 13 19:23:05.323124 systemd[1638]: Reached target sockets.target - Sockets. Apr 13 19:23:05.323140 systemd[1638]: Reached target basic.target - Basic System. Apr 13 19:23:05.323194 systemd[1638]: Reached target default.target - Main User Target. Apr 13 19:23:05.323223 systemd[1638]: Startup finished in 137ms. Apr 13 19:23:05.323685 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 13 19:23:05.333486 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 13 19:23:05.470549 systemd[1]: Started sshd@1-49.13.52.168:22-50.85.169.122:59418.service - OpenSSH per-connection server daemon (50.85.169.122:59418). Apr 13 19:23:05.595913 sshd[1649]: Accepted publickey for core from 50.85.169.122 port 59418 ssh2: RSA SHA256:iZ69s7jdfZeZWl77uzTdj7kYKrt9+aDLOIz6i/Hnoms Apr 13 19:23:05.598755 sshd[1649]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 13 19:23:05.605306 systemd-logind[1463]: New session 2 of user core. Apr 13 19:23:05.611464 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 13 19:23:05.718051 sshd[1649]: pam_unix(sshd:session): session closed for user core Apr 13 19:23:05.724886 systemd[1]: sshd@1-49.13.52.168:22-50.85.169.122:59418.service: Deactivated successfully. Apr 13 19:23:05.727594 systemd[1]: session-2.scope: Deactivated successfully. Apr 13 19:23:05.728531 systemd-logind[1463]: Session 2 logged out. Waiting for processes to exit. Apr 13 19:23:05.729999 systemd-logind[1463]: Removed session 2. Apr 13 19:23:05.755647 systemd[1]: Started sshd@2-49.13.52.168:22-50.85.169.122:59434.service - OpenSSH per-connection server daemon (50.85.169.122:59434). Apr 13 19:23:05.882713 sshd[1656]: Accepted publickey for core from 50.85.169.122 port 59434 ssh2: RSA SHA256:iZ69s7jdfZeZWl77uzTdj7kYKrt9+aDLOIz6i/Hnoms Apr 13 19:23:05.884780 sshd[1656]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 13 19:23:05.890451 systemd-logind[1463]: New session 3 of user core. Apr 13 19:23:05.897387 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 13 19:23:05.998364 sshd[1656]: pam_unix(sshd:session): session closed for user core Apr 13 19:23:06.004762 systemd[1]: sshd@2-49.13.52.168:22-50.85.169.122:59434.service: Deactivated successfully. Apr 13 19:23:06.007230 systemd[1]: session-3.scope: Deactivated successfully. Apr 13 19:23:06.008504 systemd-logind[1463]: Session 3 logged out. Waiting for processes to exit. Apr 13 19:23:06.009941 systemd-logind[1463]: Removed session 3. Apr 13 19:23:06.044219 systemd[1]: Started sshd@3-49.13.52.168:22-50.85.169.122:59446.service - OpenSSH per-connection server daemon (50.85.169.122:59446). Apr 13 19:23:06.165363 sshd[1663]: Accepted publickey for core from 50.85.169.122 port 59446 ssh2: RSA SHA256:iZ69s7jdfZeZWl77uzTdj7kYKrt9+aDLOIz6i/Hnoms Apr 13 19:23:06.167213 sshd[1663]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 13 19:23:06.172921 systemd-logind[1463]: New session 4 of user core. Apr 13 19:23:06.183510 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 13 19:23:06.291965 sshd[1663]: pam_unix(sshd:session): session closed for user core Apr 13 19:23:06.297269 systemd-logind[1463]: Session 4 logged out. Waiting for processes to exit. Apr 13 19:23:06.297581 systemd[1]: sshd@3-49.13.52.168:22-50.85.169.122:59446.service: Deactivated successfully. Apr 13 19:23:06.299625 systemd[1]: session-4.scope: Deactivated successfully. Apr 13 19:23:06.300441 systemd-logind[1463]: Removed session 4. Apr 13 19:23:06.323393 systemd[1]: Started sshd@4-49.13.52.168:22-50.85.169.122:59448.service - OpenSSH per-connection server daemon (50.85.169.122:59448). Apr 13 19:23:06.460271 sshd[1670]: Accepted publickey for core from 50.85.169.122 port 59448 ssh2: RSA SHA256:iZ69s7jdfZeZWl77uzTdj7kYKrt9+aDLOIz6i/Hnoms Apr 13 19:23:06.462142 sshd[1670]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 13 19:23:06.470506 systemd-logind[1463]: New session 5 of user core. Apr 13 19:23:06.478415 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 13 19:23:06.576643 sudo[1673]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Apr 13 19:23:06.576946 sudo[1673]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 13 19:23:07.234739 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:23:07.245147 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:23:07.280302 systemd[1]: Reloading requested from client PID 1714 ('systemctl') (unit session-5.scope)... Apr 13 19:23:07.280335 systemd[1]: Reloading... Apr 13 19:23:07.405138 zram_generator::config[1753]: No configuration found. Apr 13 19:23:07.516586 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 13 19:23:07.589037 systemd[1]: Reloading finished in 308 ms. Apr 13 19:23:07.642378 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Apr 13 19:23:07.642466 systemd[1]: kubelet.service: Failed with result 'signal'. Apr 13 19:23:07.643008 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:23:07.651772 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 13 19:23:07.779155 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 13 19:23:07.786393 (kubelet)[1800]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Apr 13 19:23:07.832137 kubelet[1800]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Apr 13 19:23:08.201760 kubelet[1800]: I0413 19:23:08.201322 1800 server.go:525] "Kubelet version" kubeletVersion="v1.35.1" Apr 13 19:23:08.201760 kubelet[1800]: I0413 19:23:08.201388 1800 server.go:527] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Apr 13 19:23:08.201760 kubelet[1800]: I0413 19:23:08.201432 1800 watchdog_linux.go:95] "Systemd watchdog is not enabled" Apr 13 19:23:08.201760 kubelet[1800]: I0413 19:23:08.201441 1800 watchdog_linux.go:138] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Apr 13 19:23:08.201760 kubelet[1800]: I0413 19:23:08.201709 1800 server.go:951] "Client rotation is on, will bootstrap in background" Apr 13 19:23:08.207986 kubelet[1800]: I0413 19:23:08.207774 1800 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Apr 13 19:23:08.216923 kubelet[1800]: E0413 19:23:08.216877 1800 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Apr 13 19:23:08.217590 kubelet[1800]: I0413 19:23:08.217380 1800 server.go:1395] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Apr 13 19:23:08.221390 kubelet[1800]: I0413 19:23:08.221343 1800 server.go:775] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Apr 13 19:23:08.222586 kubelet[1800]: I0413 19:23:08.222494 1800 container_manager_linux.go:272] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Apr 13 19:23:08.222789 kubelet[1800]: I0413 19:23:08.222595 1800 container_manager_linux.go:277] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.4","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Apr 13 19:23:08.222899 kubelet[1800]: I0413 19:23:08.222800 1800 topology_manager.go:143] "Creating topology manager with none policy" Apr 13 19:23:08.222899 kubelet[1800]: I0413 19:23:08.222812 1800 container_manager_linux.go:308] "Creating device plugin manager" Apr 13 19:23:08.222949 kubelet[1800]: I0413 19:23:08.222941 1800 container_manager_linux.go:317] "Creating Dynamic Resource Allocation (DRA) manager" Apr 13 19:23:08.226773 kubelet[1800]: I0413 19:23:08.226727 1800 state_mem.go:41] "Initialized" logger="CPUManager state memory" Apr 13 19:23:08.227014 kubelet[1800]: I0413 19:23:08.226998 1800 kubelet.go:482] "Attempting to sync node with API server" Apr 13 19:23:08.227085 kubelet[1800]: I0413 19:23:08.227026 1800 kubelet.go:383] "Adding static pod path" path="/etc/kubernetes/manifests" Apr 13 19:23:08.227085 kubelet[1800]: I0413 19:23:08.227056 1800 kubelet.go:394] "Adding apiserver pod source" Apr 13 19:23:08.227085 kubelet[1800]: I0413 19:23:08.227070 1800 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Apr 13 19:23:08.228038 kubelet[1800]: E0413 19:23:08.227585 1800 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:08.228038 kubelet[1800]: E0413 19:23:08.227680 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:08.232045 kubelet[1800]: I0413 19:23:08.232017 1800 kuberuntime_manager.go:294] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Apr 13 19:23:08.234165 kubelet[1800]: I0413 19:23:08.233758 1800 kubelet.go:943] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Apr 13 19:23:08.234165 kubelet[1800]: I0413 19:23:08.233816 1800 kubelet.go:970] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Apr 13 19:23:08.234165 kubelet[1800]: W0413 19:23:08.233877 1800 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Apr 13 19:23:08.239203 kubelet[1800]: I0413 19:23:08.238638 1800 server.go:1257] "Started kubelet" Apr 13 19:23:08.240307 kubelet[1800]: I0413 19:23:08.240276 1800 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Apr 13 19:23:08.250312 kubelet[1800]: E0413 19:23:08.248972 1800 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.4.18a600fcaa9fabc0 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.4,UID:,APIVersion:v1,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.4,},FirstTimestamp:2026-04-13 19:23:08.238588864 +0000 UTC m=+0.447907887,LastTimestamp:2026-04-13 19:23:08.238588864 +0000 UTC m=+0.447907887,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.4,}" Apr 13 19:23:08.252382 kubelet[1800]: I0413 19:23:08.252301 1800 server.go:182] "Starting to listen" address="0.0.0.0" port=10250 Apr 13 19:23:08.253022 kubelet[1800]: I0413 19:23:08.252979 1800 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Apr 13 19:23:08.253217 kubelet[1800]: I0413 19:23:08.253200 1800 server_v1.go:49] "podresources" method="list" useActivePods=true Apr 13 19:23:08.253586 kubelet[1800]: I0413 19:23:08.253571 1800 server.go:254] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Apr 13 19:23:08.256004 kubelet[1800]: I0413 19:23:08.255965 1800 server.go:317] "Adding debug handlers to kubelet server" Apr 13 19:23:08.258124 kubelet[1800]: I0413 19:23:08.256781 1800 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Apr 13 19:23:08.258124 kubelet[1800]: I0413 19:23:08.256932 1800 volume_manager.go:311] "Starting Kubelet Volume Manager" Apr 13 19:23:08.258124 kubelet[1800]: E0413 19:23:08.257156 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.259870 kubelet[1800]: I0413 19:23:08.259848 1800 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Apr 13 19:23:08.260061 kubelet[1800]: I0413 19:23:08.260037 1800 reconciler.go:29] "Reconciler: start to sync state" Apr 13 19:23:08.261952 kubelet[1800]: I0413 19:23:08.261373 1800 factory.go:223] Registration of the systemd container factory successfully Apr 13 19:23:08.263276 kubelet[1800]: I0413 19:23:08.263250 1800 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Apr 13 19:23:08.264545 kubelet[1800]: E0413 19:23:08.264512 1800 kubelet.go:1656] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Apr 13 19:23:08.265047 kubelet[1800]: E0413 19:23:08.265016 1800 reflector.go:204] "Failed to watch" err="failed to list *v1.Node: nodes \"10.0.0.4\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Node" Apr 13 19:23:08.265351 kubelet[1800]: E0413 19:23:08.265313 1800 reflector.go:204] "Failed to watch" err="failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Service" Apr 13 19:23:08.268648 kubelet[1800]: I0413 19:23:08.267879 1800 factory.go:223] Registration of the containerd container factory successfully Apr 13 19:23:08.268648 kubelet[1800]: E0413 19:23:08.268044 1800 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.4.18a600fcac2ae196 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.4,UID:,APIVersion:v1,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.4,},FirstTimestamp:2026-04-13 19:23:08.264489366 +0000 UTC m=+0.473808389,LastTimestamp:2026-04-13 19:23:08.264489366 +0000 UTC m=+0.473808389,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.4,}" Apr 13 19:23:08.284801 kubelet[1800]: E0413 19:23:08.284766 1800 controller.go:201] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.4\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Apr 13 19:23:08.291795 kubelet[1800]: I0413 19:23:08.291756 1800 cpu_manager.go:225] "Starting" policy="none" Apr 13 19:23:08.291795 kubelet[1800]: I0413 19:23:08.291785 1800 cpu_manager.go:226] "Reconciling" reconcilePeriod="10s" Apr 13 19:23:08.291795 kubelet[1800]: I0413 19:23:08.291809 1800 state_mem.go:41] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Apr 13 19:23:08.296468 kubelet[1800]: I0413 19:23:08.296438 1800 policy_none.go:50] "Start" Apr 13 19:23:08.296626 kubelet[1800]: I0413 19:23:08.296614 1800 memory_manager.go:187] "Starting memorymanager" policy="None" Apr 13 19:23:08.296681 kubelet[1800]: I0413 19:23:08.296672 1800 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Apr 13 19:23:08.302715 kubelet[1800]: I0413 19:23:08.302680 1800 policy_none.go:44] "Start" Apr 13 19:23:08.313319 sudo[1673]: pam_unix(sudo:session): session closed for user root Apr 13 19:23:08.318038 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Apr 13 19:23:08.332369 sshd[1670]: pam_unix(sshd:session): session closed for user core Apr 13 19:23:08.333049 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Apr 13 19:23:08.340973 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Apr 13 19:23:08.341417 systemd[1]: sshd@4-49.13.52.168:22-50.85.169.122:59448.service: Deactivated successfully. Apr 13 19:23:08.343766 systemd[1]: session-5.scope: Deactivated successfully. Apr 13 19:23:08.344537 kubelet[1800]: I0413 19:23:08.344333 1800 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Apr 13 19:23:08.347629 systemd-logind[1463]: Session 5 logged out. Waiting for processes to exit. Apr 13 19:23:08.349356 kubelet[1800]: I0413 19:23:08.349312 1800 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Apr 13 19:23:08.349356 kubelet[1800]: I0413 19:23:08.349356 1800 status_manager.go:249] "Starting to sync pod status with apiserver" Apr 13 19:23:08.349628 kubelet[1800]: I0413 19:23:08.349388 1800 kubelet.go:2501] "Starting kubelet main sync loop" Apr 13 19:23:08.349628 kubelet[1800]: E0413 19:23:08.349449 1800 kubelet.go:2525] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Apr 13 19:23:08.354156 kubelet[1800]: E0413 19:23:08.353507 1800 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Apr 13 19:23:08.354156 kubelet[1800]: I0413 19:23:08.353735 1800 eviction_manager.go:194] "Eviction manager: starting control loop" Apr 13 19:23:08.354156 kubelet[1800]: I0413 19:23:08.353746 1800 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Apr 13 19:23:08.354853 kubelet[1800]: I0413 19:23:08.354829 1800 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Apr 13 19:23:08.356207 systemd-logind[1463]: Removed session 5. Apr 13 19:23:08.359768 kubelet[1800]: E0413 19:23:08.359560 1800 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Apr 13 19:23:08.359955 kubelet[1800]: E0413 19:23:08.359939 1800 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.4\" not found" Apr 13 19:23:08.457133 kubelet[1800]: I0413 19:23:08.455132 1800 kubelet_node_status.go:74] "Attempting to register node" node="10.0.0.4" Apr 13 19:23:08.465464 kubelet[1800]: I0413 19:23:08.465363 1800 kubelet_node_status.go:77] "Successfully registered node" node="10.0.0.4" Apr 13 19:23:08.465464 kubelet[1800]: E0413 19:23:08.465434 1800 kubelet_node_status.go:474] "Error updating node status, will retry" err="error getting node \"10.0.0.4\": node \"10.0.0.4\" not found" Apr 13 19:23:08.480390 kubelet[1800]: E0413 19:23:08.480275 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.580519 kubelet[1800]: E0413 19:23:08.580448 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.681034 kubelet[1800]: E0413 19:23:08.680912 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.781321 kubelet[1800]: E0413 19:23:08.781238 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.881716 kubelet[1800]: E0413 19:23:08.881601 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:08.982108 kubelet[1800]: E0413 19:23:08.982006 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.082877 kubelet[1800]: E0413 19:23:09.082659 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.183405 kubelet[1800]: E0413 19:23:09.183335 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.204394 kubelet[1800]: I0413 19:23:09.203823 1800 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Apr 13 19:23:09.204394 kubelet[1800]: I0413 19:23:09.204292 1800 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Apr 13 19:23:09.204394 kubelet[1800]: I0413 19:23:09.204353 1800 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Apr 13 19:23:09.228561 kubelet[1800]: E0413 19:23:09.228447 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:09.283762 kubelet[1800]: E0413 19:23:09.283484 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.384774 kubelet[1800]: E0413 19:23:09.384560 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.485258 kubelet[1800]: E0413 19:23:09.485013 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.585588 kubelet[1800]: E0413 19:23:09.585513 1800 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.0.0.4\" not found" Apr 13 19:23:09.687551 kubelet[1800]: I0413 19:23:09.687411 1800 kuberuntime_manager.go:2062] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Apr 13 19:23:09.688265 containerd[1477]: time="2026-04-13T19:23:09.688099634Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Apr 13 19:23:09.688730 kubelet[1800]: I0413 19:23:09.688400 1800 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Apr 13 19:23:10.229143 kubelet[1800]: I0413 19:23:10.228684 1800 apiserver.go:52] "Watching apiserver" Apr 13 19:23:10.229143 kubelet[1800]: E0413 19:23:10.228749 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:10.250820 systemd[1]: Created slice kubepods-burstable-pode2e07ff4_1e67_4ac7_8c1e_c451830752a2.slice - libcontainer container kubepods-burstable-pode2e07ff4_1e67_4ac7_8c1e_c451830752a2.slice. Apr 13 19:23:10.261131 kubelet[1800]: I0413 19:23:10.261090 1800 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Apr 13 19:23:10.268312 systemd[1]: Created slice kubepods-besteffort-pod7ecc24f4_8925_46c7_9fc1_142759a556b4.slice - libcontainer container kubepods-besteffort-pod7ecc24f4_8925_46c7_9fc1_142759a556b4.slice. Apr 13 19:23:10.272472 kubelet[1800]: I0413 19:23:10.272152 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-run\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272472 kubelet[1800]: I0413 19:23:10.272287 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-cni\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272472 kubelet[1800]: I0413 19:23:10.272338 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-flannel-cfg\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272472 kubelet[1800]: I0413 19:23:10.272362 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zq5bk\" (UniqueName: \"kubernetes.io/projected/7ecc24f4-8925-46c7-9fc1-142759a556b4-kube-api-access-zq5bk\") pod \"kube-proxy-868mc\" (UID: \"7ecc24f4-8925-46c7-9fc1-142759a556b4\") " pod="kube-system/kube-proxy-868mc" Apr 13 19:23:10.272472 kubelet[1800]: I0413 19:23:10.272377 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-cni-plugin\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272735 kubelet[1800]: I0413 19:23:10.272395 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-xtables-lock\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272735 kubelet[1800]: I0413 19:23:10.272411 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gwckj\" (UniqueName: \"kubernetes.io/projected/e2e07ff4-1e67-4ac7-8c1e-c451830752a2-kube-api-access-gwckj\") pod \"kube-flannel-ds-m72p4\" (UID: \"e2e07ff4-1e67-4ac7-8c1e-c451830752a2\") " pod="kube-flannel/kube-flannel-ds-m72p4" Apr 13 19:23:10.272735 kubelet[1800]: I0413 19:23:10.272441 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/7ecc24f4-8925-46c7-9fc1-142759a556b4-kube-proxy\") pod \"kube-proxy-868mc\" (UID: \"7ecc24f4-8925-46c7-9fc1-142759a556b4\") " pod="kube-system/kube-proxy-868mc" Apr 13 19:23:10.272735 kubelet[1800]: I0413 19:23:10.272498 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/7ecc24f4-8925-46c7-9fc1-142759a556b4-xtables-lock\") pod \"kube-proxy-868mc\" (UID: \"7ecc24f4-8925-46c7-9fc1-142759a556b4\") " pod="kube-system/kube-proxy-868mc" Apr 13 19:23:10.272735 kubelet[1800]: I0413 19:23:10.272544 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/7ecc24f4-8925-46c7-9fc1-142759a556b4-lib-modules\") pod \"kube-proxy-868mc\" (UID: \"7ecc24f4-8925-46c7-9fc1-142759a556b4\") " pod="kube-system/kube-proxy-868mc" Apr 13 19:23:10.570139 containerd[1477]: time="2026-04-13T19:23:10.569987700Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-m72p4,Uid:e2e07ff4-1e67-4ac7-8c1e-c451830752a2,Namespace:kube-flannel,Attempt:0,}" Apr 13 19:23:10.583094 containerd[1477]: time="2026-04-13T19:23:10.582718395Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-868mc,Uid:7ecc24f4-8925-46c7-9fc1-142759a556b4,Namespace:kube-system,Attempt:0,}" Apr 13 19:23:11.118222 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2545224700.mount: Deactivated successfully. Apr 13 19:23:11.132285 containerd[1477]: time="2026-04-13T19:23:11.132207270Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 13 19:23:11.135758 containerd[1477]: time="2026-04-13T19:23:11.134778755Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 13 19:23:11.136444 containerd[1477]: time="2026-04-13T19:23:11.136383098Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269193" Apr 13 19:23:11.137703 containerd[1477]: time="2026-04-13T19:23:11.137651869Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Apr 13 19:23:11.139748 containerd[1477]: time="2026-04-13T19:23:11.139673519Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 13 19:23:11.143197 containerd[1477]: time="2026-04-13T19:23:11.143125752Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 13 19:23:11.144169 containerd[1477]: time="2026-04-13T19:23:11.144121004Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 561.178391ms" Apr 13 19:23:11.147824 containerd[1477]: time="2026-04-13T19:23:11.147644968Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 577.563232ms" Apr 13 19:23:11.229851 kubelet[1800]: E0413 19:23:11.229797 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:11.276359 containerd[1477]: time="2026-04-13T19:23:11.276000531Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 13 19:23:11.276359 containerd[1477]: time="2026-04-13T19:23:11.276063474Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 13 19:23:11.276359 containerd[1477]: time="2026-04-13T19:23:11.276107177Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:11.276359 containerd[1477]: time="2026-04-13T19:23:11.276267368Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:11.279129 containerd[1477]: time="2026-04-13T19:23:11.279012815Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 13 19:23:11.279690 containerd[1477]: time="2026-04-13T19:23:11.279555521Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 13 19:23:11.279690 containerd[1477]: time="2026-04-13T19:23:11.279622555Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:11.280005 containerd[1477]: time="2026-04-13T19:23:11.279914382Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:11.350950 systemd[1]: Started cri-containerd-31ca87b16b6b12f34db8eb31ecf903f95a1a0a2b9798a597d206fa6689395a95.scope - libcontainer container 31ca87b16b6b12f34db8eb31ecf903f95a1a0a2b9798a597d206fa6689395a95. Apr 13 19:23:11.355401 systemd[1]: Started cri-containerd-aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1.scope - libcontainer container aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1. Apr 13 19:23:11.392333 containerd[1477]: time="2026-04-13T19:23:11.392206995Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-868mc,Uid:7ecc24f4-8925-46c7-9fc1-142759a556b4,Namespace:kube-system,Attempt:0,} returns sandbox id \"31ca87b16b6b12f34db8eb31ecf903f95a1a0a2b9798a597d206fa6689395a95\"" Apr 13 19:23:11.397119 containerd[1477]: time="2026-04-13T19:23:11.396419883Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.3\"" Apr 13 19:23:11.406411 containerd[1477]: time="2026-04-13T19:23:11.406221239Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-m72p4,Uid:e2e07ff4-1e67-4ac7-8c1e-c451830752a2,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\"" Apr 13 19:23:12.230679 kubelet[1800]: E0413 19:23:12.230595 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:12.479657 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1943822167.mount: Deactivated successfully. Apr 13 19:23:12.723117 containerd[1477]: time="2026-04-13T19:23:12.721745480Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.35.3\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:12.724666 containerd[1477]: time="2026-04-13T19:23:12.724291414Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.35.3: active requests=0, bytes read=22329611" Apr 13 19:23:12.725834 containerd[1477]: time="2026-04-13T19:23:12.725747436Z" level=info msg="ImageCreate event name:\"sha256:e21b1b28c776646ec72252e21482c2e273889e76006df8b76d97d9dd1ed544f6\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:12.728950 containerd[1477]: time="2026-04-13T19:23:12.728607836Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:8743aec6a360aedcb7a076cbecea367b072abe1bfade2e2098650df502e2bc89\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:12.729699 containerd[1477]: time="2026-04-13T19:23:12.729633165Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.35.3\" with image id \"sha256:e21b1b28c776646ec72252e21482c2e273889e76006df8b76d97d9dd1ed544f6\", repo tag \"registry.k8s.io/kube-proxy:v1.35.3\", repo digest \"registry.k8s.io/kube-proxy@sha256:8743aec6a360aedcb7a076cbecea367b072abe1bfade2e2098650df502e2bc89\", size \"22328604\" in 1.3331683s" Apr 13 19:23:12.729699 containerd[1477]: time="2026-04-13T19:23:12.729690429Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.3\" returns image reference \"sha256:e21b1b28c776646ec72252e21482c2e273889e76006df8b76d97d9dd1ed544f6\"" Apr 13 19:23:12.732473 containerd[1477]: time="2026-04-13T19:23:12.732385225Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Apr 13 19:23:12.737913 containerd[1477]: time="2026-04-13T19:23:12.737681198Z" level=info msg="CreateContainer within sandbox \"31ca87b16b6b12f34db8eb31ecf903f95a1a0a2b9798a597d206fa6689395a95\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Apr 13 19:23:12.752708 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2106715080.mount: Deactivated successfully. Apr 13 19:23:12.763325 containerd[1477]: time="2026-04-13T19:23:12.763237033Z" level=info msg="CreateContainer within sandbox \"31ca87b16b6b12f34db8eb31ecf903f95a1a0a2b9798a597d206fa6689395a95\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"5f71cda51ff72a0803e13951c6afa1b6376e823247c08e486c5a11cc226beaa7\"" Apr 13 19:23:12.764616 containerd[1477]: time="2026-04-13T19:23:12.764573188Z" level=info msg="StartContainer for \"5f71cda51ff72a0803e13951c6afa1b6376e823247c08e486c5a11cc226beaa7\"" Apr 13 19:23:12.801318 systemd[1]: Started cri-containerd-5f71cda51ff72a0803e13951c6afa1b6376e823247c08e486c5a11cc226beaa7.scope - libcontainer container 5f71cda51ff72a0803e13951c6afa1b6376e823247c08e486c5a11cc226beaa7. Apr 13 19:23:12.838220 containerd[1477]: time="2026-04-13T19:23:12.838128713Z" level=info msg="StartContainer for \"5f71cda51ff72a0803e13951c6afa1b6376e823247c08e486c5a11cc226beaa7\" returns successfully" Apr 13 19:23:13.230920 kubelet[1800]: E0413 19:23:13.230724 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:13.384882 kubelet[1800]: I0413 19:23:13.384789 1800 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-system/kube-proxy-868mc" podStartSLOduration=4.048916998 podStartE2EDuration="5.384759994s" podCreationTimestamp="2026-04-13 19:23:08 +0000 UTC" firstStartedPulling="2026-04-13 19:23:11.39551779 +0000 UTC m=+3.604836812" lastFinishedPulling="2026-04-13 19:23:12.731360785 +0000 UTC m=+4.940679808" observedRunningTime="2026-04-13 19:23:13.384696589 +0000 UTC m=+5.594015611" watchObservedRunningTime="2026-04-13 19:23:13.384759994 +0000 UTC m=+5.594078976" Apr 13 19:23:13.884043 update_engine[1464]: I20260413 19:23:13.883387 1464 update_attempter.cc:509] Updating boot flags... Apr 13 19:23:13.926223 kernel: BTRFS warning: duplicate device /dev/sda3 devid 1 generation 33 scanned by (udev-worker) (2117) Apr 13 19:23:14.230871 kubelet[1800]: E0413 19:23:14.230804 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:14.374427 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1569069061.mount: Deactivated successfully. Apr 13 19:23:14.424601 containerd[1477]: time="2026-04-13T19:23:14.424532074Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:14.426828 containerd[1477]: time="2026-04-13T19:23:14.426684068Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Apr 13 19:23:14.427746 containerd[1477]: time="2026-04-13T19:23:14.427184937Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:14.430983 containerd[1477]: time="2026-04-13T19:23:14.430929165Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:14.432675 containerd[1477]: time="2026-04-13T19:23:14.432627163Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"5125394\" in 1.700194937s" Apr 13 19:23:14.432821 containerd[1477]: time="2026-04-13T19:23:14.432787020Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Apr 13 19:23:14.438698 containerd[1477]: time="2026-04-13T19:23:14.438653433Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Apr 13 19:23:14.454744 containerd[1477]: time="2026-04-13T19:23:14.454696784Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422\"" Apr 13 19:23:14.456600 containerd[1477]: time="2026-04-13T19:23:14.455548345Z" level=info msg="StartContainer for \"056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422\"" Apr 13 19:23:14.485360 systemd[1]: Started cri-containerd-056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422.scope - libcontainer container 056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422. Apr 13 19:23:14.516838 systemd[1]: cri-containerd-056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422.scope: Deactivated successfully. Apr 13 19:23:14.518503 containerd[1477]: time="2026-04-13T19:23:14.518328256Z" level=info msg="StartContainer for \"056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422\" returns successfully" Apr 13 19:23:14.628845 containerd[1477]: time="2026-04-13T19:23:14.628590846Z" level=info msg="shim disconnected" id=056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422 namespace=k8s.io Apr 13 19:23:14.628845 containerd[1477]: time="2026-04-13T19:23:14.628657564Z" level=warning msg="cleaning up after shim disconnected" id=056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422 namespace=k8s.io Apr 13 19:23:14.628845 containerd[1477]: time="2026-04-13T19:23:14.628668576Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 13 19:23:15.231601 kubelet[1800]: E0413 19:23:15.231484 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:15.266996 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-056749775745fa360afc5922875d298db8c0a2230e6d0f3f346af75f3174c422-rootfs.mount: Deactivated successfully. Apr 13 19:23:15.376842 containerd[1477]: time="2026-04-13T19:23:15.376804945Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Apr 13 19:23:16.232051 kubelet[1800]: E0413 19:23:16.231987 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:17.232805 kubelet[1800]: E0413 19:23:17.232717 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:17.631023 containerd[1477]: time="2026-04-13T19:23:17.630769128Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:17.634959 containerd[1477]: time="2026-04-13T19:23:17.633368328Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Apr 13 19:23:17.636361 containerd[1477]: time="2026-04-13T19:23:17.636302772Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:17.643399 containerd[1477]: time="2026-04-13T19:23:17.643347665Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:17.646524 containerd[1477]: time="2026-04-13T19:23:17.646451942Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32412118\" in 2.269426774s" Apr 13 19:23:17.646740 containerd[1477]: time="2026-04-13T19:23:17.646712727Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Apr 13 19:23:17.654679 containerd[1477]: time="2026-04-13T19:23:17.654620265Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Apr 13 19:23:17.669262 containerd[1477]: time="2026-04-13T19:23:17.669118385Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7\"" Apr 13 19:23:17.670151 containerd[1477]: time="2026-04-13T19:23:17.670046760Z" level=info msg="StartContainer for \"8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7\"" Apr 13 19:23:17.706394 systemd[1]: Started cri-containerd-8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7.scope - libcontainer container 8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7. Apr 13 19:23:17.737066 systemd[1]: cri-containerd-8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7.scope: Deactivated successfully. Apr 13 19:23:17.739959 containerd[1477]: time="2026-04-13T19:23:17.739722183Z" level=info msg="StartContainer for \"8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7\" returns successfully" Apr 13 19:23:17.758033 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7-rootfs.mount: Deactivated successfully. Apr 13 19:23:17.808706 kubelet[1800]: I0413 19:23:17.808436 1800 kubelet_node_status.go:427] "Fast updating node status as it just became ready" Apr 13 19:23:17.814914 containerd[1477]: time="2026-04-13T19:23:17.814674528Z" level=info msg="shim disconnected" id=8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7 namespace=k8s.io Apr 13 19:23:17.814914 containerd[1477]: time="2026-04-13T19:23:17.814735309Z" level=warning msg="cleaning up after shim disconnected" id=8fd9928e76bd1250578cc739533c0af5bb16f70267ddc6845b5d73124137a9b7 namespace=k8s.io Apr 13 19:23:17.814914 containerd[1477]: time="2026-04-13T19:23:17.814747095Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 13 19:23:17.830153 containerd[1477]: time="2026-04-13T19:23:17.829367743Z" level=warning msg="cleanup warnings time=\"2026-04-13T19:23:17Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=k8s.io Apr 13 19:23:18.233571 kubelet[1800]: E0413 19:23:18.233502 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:18.391939 containerd[1477]: time="2026-04-13T19:23:18.391555446Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Apr 13 19:23:18.411686 containerd[1477]: time="2026-04-13T19:23:18.411560401Z" level=info msg="CreateContainer within sandbox \"aacf0582964a2e032dde9af7db94743902d31dcba10be6803ffd994d7da3c9f1\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"18dfd9464c8dd1a9dc0c1d42eb385437671a11232ba6302a67806b2475df0ec7\"" Apr 13 19:23:18.413780 containerd[1477]: time="2026-04-13T19:23:18.412670380Z" level=info msg="StartContainer for \"18dfd9464c8dd1a9dc0c1d42eb385437671a11232ba6302a67806b2475df0ec7\"" Apr 13 19:23:18.441465 systemd[1]: Started cri-containerd-18dfd9464c8dd1a9dc0c1d42eb385437671a11232ba6302a67806b2475df0ec7.scope - libcontainer container 18dfd9464c8dd1a9dc0c1d42eb385437671a11232ba6302a67806b2475df0ec7. Apr 13 19:23:18.470832 containerd[1477]: time="2026-04-13T19:23:18.470703418Z" level=info msg="StartContainer for \"18dfd9464c8dd1a9dc0c1d42eb385437671a11232ba6302a67806b2475df0ec7\" returns successfully" Apr 13 19:23:19.234033 kubelet[1800]: E0413 19:23:19.233966 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:19.415816 kubelet[1800]: I0413 19:23:19.415738 1800 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-m72p4" podStartSLOduration=4.437583534 podStartE2EDuration="11.415716207s" podCreationTimestamp="2026-04-13 19:23:08 +0000 UTC" firstStartedPulling="2026-04-13 19:23:11.408339571 +0000 UTC m=+3.617658553" lastFinishedPulling="2026-04-13 19:23:18.386472204 +0000 UTC m=+10.595791226" observedRunningTime="2026-04-13 19:23:19.41476925 +0000 UTC m=+11.624088633" watchObservedRunningTime="2026-04-13 19:23:19.415716207 +0000 UTC m=+11.625035270" Apr 13 19:23:19.571467 systemd-networkd[1388]: flannel.1: Link UP Apr 13 19:23:19.571498 systemd-networkd[1388]: flannel.1: Gained carrier Apr 13 19:23:20.027330 systemd[1]: Created slice kubepods-besteffort-podc5a07483_69c3_418e_b033_9878d40b88b9.slice - libcontainer container kubepods-besteffort-podc5a07483_69c3_418e_b033_9878d40b88b9.slice. Apr 13 19:23:20.042514 kubelet[1800]: I0413 19:23:20.042239 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-7lc9d\" (UniqueName: \"kubernetes.io/projected/c5a07483-69c3-418e-b033-9878d40b88b9-kube-api-access-7lc9d\") pod \"nginx-deployment-6cc69d4fc7-629m7\" (UID: \"c5a07483-69c3-418e-b033-9878d40b88b9\") " pod="default/nginx-deployment-6cc69d4fc7-629m7" Apr 13 19:23:20.234811 kubelet[1800]: E0413 19:23:20.234715 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:20.337054 containerd[1477]: time="2026-04-13T19:23:20.336897664Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-629m7,Uid:c5a07483-69c3-418e-b033-9878d40b88b9,Namespace:default,Attempt:0,}" Apr 13 19:23:20.380132 systemd-networkd[1388]: cni0: Link UP Apr 13 19:23:20.380338 systemd-networkd[1388]: cni0: Gained carrier Apr 13 19:23:20.380820 systemd-networkd[1388]: cni0: Lost carrier Apr 13 19:23:20.389234 systemd-networkd[1388]: veth37ff2248: Link UP Apr 13 19:23:20.393343 kernel: cni0: port 1(veth37ff2248) entered blocking state Apr 13 19:23:20.393441 kernel: cni0: port 1(veth37ff2248) entered disabled state Apr 13 19:23:20.393462 kernel: veth37ff2248: entered allmulticast mode Apr 13 19:23:20.395715 kernel: veth37ff2248: entered promiscuous mode Apr 13 19:23:20.395807 kernel: cni0: port 1(veth37ff2248) entered blocking state Apr 13 19:23:20.395826 kernel: cni0: port 1(veth37ff2248) entered forwarding state Apr 13 19:23:20.399129 kernel: cni0: port 1(veth37ff2248) entered disabled state Apr 13 19:23:20.407161 kernel: cni0: port 1(veth37ff2248) entered blocking state Apr 13 19:23:20.407249 kernel: cni0: port 1(veth37ff2248) entered forwarding state Apr 13 19:23:20.406915 systemd-networkd[1388]: veth37ff2248: Gained carrier Apr 13 19:23:20.407734 systemd-networkd[1388]: cni0: Gained carrier Apr 13 19:23:20.412830 containerd[1477]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x40001047f0), "name":"cbr0", "type":"bridge"} Apr 13 19:23:20.412830 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Apr 13 19:23:20.447825 containerd[1477]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2026-04-13T19:23:20.446964988Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 13 19:23:20.447825 containerd[1477]: time="2026-04-13T19:23:20.447044769Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 13 19:23:20.447825 containerd[1477]: time="2026-04-13T19:23:20.447060147Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:20.447825 containerd[1477]: time="2026-04-13T19:23:20.447171728Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:20.470543 systemd[1]: run-containerd-runc-k8s.io-e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0-runc.sRdNBb.mount: Deactivated successfully. Apr 13 19:23:20.479484 systemd[1]: Started cri-containerd-e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0.scope - libcontainer container e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0. Apr 13 19:23:20.516991 containerd[1477]: time="2026-04-13T19:23:20.516737638Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-629m7,Uid:c5a07483-69c3-418e-b033-9878d40b88b9,Namespace:default,Attempt:0,} returns sandbox id \"e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0\"" Apr 13 19:23:20.519663 containerd[1477]: time="2026-04-13T19:23:20.519625847Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 13 19:23:21.235566 kubelet[1800]: E0413 19:23:21.235498 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:21.354393 systemd-networkd[1388]: flannel.1: Gained IPv6LL Apr 13 19:23:21.673419 systemd-networkd[1388]: veth37ff2248: Gained IPv6LL Apr 13 19:23:21.801719 systemd-networkd[1388]: cni0: Gained IPv6LL Apr 13 19:23:22.236094 kubelet[1800]: E0413 19:23:22.235854 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:23.219949 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2085919225.mount: Deactivated successfully. Apr 13 19:23:23.236626 kubelet[1800]: E0413 19:23:23.236450 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:23.999294 containerd[1477]: time="2026-04-13T19:23:23.999241333Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:24.003109 containerd[1477]: time="2026-04-13T19:23:24.001707089Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=62483007" Apr 13 19:23:24.003109 containerd[1477]: time="2026-04-13T19:23:24.001916633Z" level=info msg="ImageCreate event name:\"sha256:9ccac550fb08f5ef414f45b47058b7d572d5b3c7c448508675da1b4ce05d6726\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:24.006598 containerd[1477]: time="2026-04-13T19:23:24.006551171Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:24.009122 containerd[1477]: time="2026-04-13T19:23:24.009049300Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:9ccac550fb08f5ef414f45b47058b7d572d5b3c7c448508675da1b4ce05d6726\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\", size \"62482885\" in 3.489379266s" Apr 13 19:23:24.009296 containerd[1477]: time="2026-04-13T19:23:24.009278407Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:9ccac550fb08f5ef414f45b47058b7d572d5b3c7c448508675da1b4ce05d6726\"" Apr 13 19:23:24.015016 containerd[1477]: time="2026-04-13T19:23:24.014973814Z" level=info msg="CreateContainer within sandbox \"e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Apr 13 19:23:24.029882 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3942238239.mount: Deactivated successfully. Apr 13 19:23:24.032635 containerd[1477]: time="2026-04-13T19:23:24.032567115Z" level=info msg="CreateContainer within sandbox \"e45309cc20ca728a5bcc71fa250d2aafdb21df822ff1fb3d2265dc731e3b70f0\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"72b633e8a240cc65be68b2506ee026d3d7b788a5b75499f05aa8055a421e43e7\"" Apr 13 19:23:24.033492 containerd[1477]: time="2026-04-13T19:23:24.033430586Z" level=info msg="StartContainer for \"72b633e8a240cc65be68b2506ee026d3d7b788a5b75499f05aa8055a421e43e7\"" Apr 13 19:23:24.063326 systemd[1]: Started cri-containerd-72b633e8a240cc65be68b2506ee026d3d7b788a5b75499f05aa8055a421e43e7.scope - libcontainer container 72b633e8a240cc65be68b2506ee026d3d7b788a5b75499f05aa8055a421e43e7. Apr 13 19:23:24.097107 containerd[1477]: time="2026-04-13T19:23:24.095933451Z" level=info msg="StartContainer for \"72b633e8a240cc65be68b2506ee026d3d7b788a5b75499f05aa8055a421e43e7\" returns successfully" Apr 13 19:23:24.237149 kubelet[1800]: E0413 19:23:24.237043 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:24.427215 kubelet[1800]: I0413 19:23:24.426260 1800 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nginx-deployment-6cc69d4fc7-629m7" podStartSLOduration=0.934834748 podStartE2EDuration="4.42624609s" podCreationTimestamp="2026-04-13 19:23:20 +0000 UTC" firstStartedPulling="2026-04-13 19:23:20.518771907 +0000 UTC m=+12.728090930" lastFinishedPulling="2026-04-13 19:23:24.01018329 +0000 UTC m=+16.219502272" observedRunningTime="2026-04-13 19:23:24.425902008 +0000 UTC m=+16.635221031" watchObservedRunningTime="2026-04-13 19:23:24.42624609 +0000 UTC m=+16.635565152" Apr 13 19:23:25.237592 kubelet[1800]: E0413 19:23:25.237519 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:26.238219 kubelet[1800]: E0413 19:23:26.238062 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:27.147455 systemd[1]: Created slice kubepods-besteffort-podbb9f308d_c4d9_4a6e_9bf1_90a00f75d683.slice - libcontainer container kubepods-besteffort-podbb9f308d_c4d9_4a6e_9bf1_90a00f75d683.slice. Apr 13 19:23:27.194955 kubelet[1800]: I0413 19:23:27.194887 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8vmlk\" (UniqueName: \"kubernetes.io/projected/bb9f308d-c4d9-4a6e-9bf1-90a00f75d683-kube-api-access-8vmlk\") pod \"nfs-server-provisioner-0\" (UID: \"bb9f308d-c4d9-4a6e-9bf1-90a00f75d683\") " pod="default/nfs-server-provisioner-0" Apr 13 19:23:27.195319 kubelet[1800]: I0413 19:23:27.195242 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/bb9f308d-c4d9-4a6e-9bf1-90a00f75d683-data\") pod \"nfs-server-provisioner-0\" (UID: \"bb9f308d-c4d9-4a6e-9bf1-90a00f75d683\") " pod="default/nfs-server-provisioner-0" Apr 13 19:23:27.238889 kubelet[1800]: E0413 19:23:27.238765 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:27.455274 containerd[1477]: time="2026-04-13T19:23:27.455126592Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:bb9f308d-c4d9-4a6e-9bf1-90a00f75d683,Namespace:default,Attempt:0,}" Apr 13 19:23:27.499394 kernel: cni0: port 2(vethab6110cc) entered blocking state Apr 13 19:23:27.499487 kernel: cni0: port 2(vethab6110cc) entered disabled state Apr 13 19:23:27.499506 kernel: vethab6110cc: entered allmulticast mode Apr 13 19:23:27.499523 kernel: vethab6110cc: entered promiscuous mode Apr 13 19:23:27.498208 systemd-networkd[1388]: vethab6110cc: Link UP Apr 13 19:23:27.512505 kernel: cni0: port 2(vethab6110cc) entered blocking state Apr 13 19:23:27.512613 kernel: cni0: port 2(vethab6110cc) entered forwarding state Apr 13 19:23:27.512610 systemd-networkd[1388]: vethab6110cc: Gained carrier Apr 13 19:23:27.515772 containerd[1477]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000082950), "name":"cbr0", "type":"bridge"} Apr 13 19:23:27.515772 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Apr 13 19:23:27.541178 containerd[1477]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2026-04-13T19:23:27.540848194Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 13 19:23:27.541453 containerd[1477]: time="2026-04-13T19:23:27.541190582Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 13 19:23:27.541453 containerd[1477]: time="2026-04-13T19:23:27.541403538Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:27.541595 containerd[1477]: time="2026-04-13T19:23:27.541530967Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:27.569537 systemd[1]: Started cri-containerd-ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e.scope - libcontainer container ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e. Apr 13 19:23:27.605309 containerd[1477]: time="2026-04-13T19:23:27.605203772Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:bb9f308d-c4d9-4a6e-9bf1-90a00f75d683,Namespace:default,Attempt:0,} returns sandbox id \"ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e\"" Apr 13 19:23:27.607795 containerd[1477]: time="2026-04-13T19:23:27.607755558Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Apr 13 19:23:28.228160 kubelet[1800]: E0413 19:23:28.228125 1800 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:28.239810 kubelet[1800]: E0413 19:23:28.239746 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:28.317717 systemd[1]: run-containerd-runc-k8s.io-ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e-runc.CTrQiR.mount: Deactivated successfully. Apr 13 19:23:29.162321 systemd-networkd[1388]: vethab6110cc: Gained IPv6LL Apr 13 19:23:29.240543 kubelet[1800]: E0413 19:23:29.240506 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:29.339291 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount206170222.mount: Deactivated successfully. Apr 13 19:23:30.242318 kubelet[1800]: E0413 19:23:30.242283 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:30.858473 containerd[1477]: time="2026-04-13T19:23:30.858425349Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:30.860831 containerd[1477]: time="2026-04-13T19:23:30.860797468Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373691" Apr 13 19:23:30.862101 containerd[1477]: time="2026-04-13T19:23:30.862037381Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:30.865289 containerd[1477]: time="2026-04-13T19:23:30.865247173Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:30.867084 containerd[1477]: time="2026-04-13T19:23:30.867030107Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 3.259200564s" Apr 13 19:23:30.867276 containerd[1477]: time="2026-04-13T19:23:30.867254530Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Apr 13 19:23:30.873625 containerd[1477]: time="2026-04-13T19:23:30.873558400Z" level=info msg="CreateContainer within sandbox \"ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Apr 13 19:23:30.893773 containerd[1477]: time="2026-04-13T19:23:30.893720613Z" level=info msg="CreateContainer within sandbox \"ec28e8534b18ce73d663d0b9d03f0cd17555768aa4be8dfd95e214b1bebc841e\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"55015c9fc936581f8b426c2e42edaaaf04cdc0627e196d9cf6aa1ec1d908e028\"" Apr 13 19:23:30.894670 containerd[1477]: time="2026-04-13T19:23:30.894614902Z" level=info msg="StartContainer for \"55015c9fc936581f8b426c2e42edaaaf04cdc0627e196d9cf6aa1ec1d908e028\"" Apr 13 19:23:30.928484 systemd[1]: Started cri-containerd-55015c9fc936581f8b426c2e42edaaaf04cdc0627e196d9cf6aa1ec1d908e028.scope - libcontainer container 55015c9fc936581f8b426c2e42edaaaf04cdc0627e196d9cf6aa1ec1d908e028. Apr 13 19:23:30.958244 containerd[1477]: time="2026-04-13T19:23:30.956281154Z" level=info msg="StartContainer for \"55015c9fc936581f8b426c2e42edaaaf04cdc0627e196d9cf6aa1ec1d908e028\" returns successfully" Apr 13 19:23:31.243091 kubelet[1800]: E0413 19:23:31.243019 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:32.243519 kubelet[1800]: E0413 19:23:32.243418 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:33.244731 kubelet[1800]: E0413 19:23:33.244581 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:34.245557 kubelet[1800]: E0413 19:23:34.245377 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:35.246029 kubelet[1800]: E0413 19:23:35.245932 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:36.246881 kubelet[1800]: E0413 19:23:36.246812 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:36.252106 kubelet[1800]: I0413 19:23:36.250902 1800 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=5.989410338 podStartE2EDuration="9.250875022s" podCreationTimestamp="2026-04-13 19:23:27 +0000 UTC" firstStartedPulling="2026-04-13 19:23:27.607270959 +0000 UTC m=+19.816589981" lastFinishedPulling="2026-04-13 19:23:30.868735643 +0000 UTC m=+23.078054665" observedRunningTime="2026-04-13 19:23:31.455515436 +0000 UTC m=+23.664834458" watchObservedRunningTime="2026-04-13 19:23:36.250875022 +0000 UTC m=+28.460194044" Apr 13 19:23:36.266773 systemd[1]: Created slice kubepods-besteffort-poddb778348_b49d_423f_a8c4_3109ae576656.slice - libcontainer container kubepods-besteffort-poddb778348_b49d_423f_a8c4_3109ae576656.slice. Apr 13 19:23:36.361578 kubelet[1800]: I0413 19:23:36.361488 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-cf2176c2-2ac4-4ce1-ad66-7d8db64ceaaa\" (UniqueName: \"kubernetes.io/nfs/db778348-b49d-423f-a8c4-3109ae576656-pvc-cf2176c2-2ac4-4ce1-ad66-7d8db64ceaaa\") pod \"test-pod-1\" (UID: \"db778348-b49d-423f-a8c4-3109ae576656\") " pod="default/test-pod-1" Apr 13 19:23:36.361578 kubelet[1800]: I0413 19:23:36.361572 1800 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-j86fw\" (UniqueName: \"kubernetes.io/projected/db778348-b49d-423f-a8c4-3109ae576656-kube-api-access-j86fw\") pod \"test-pod-1\" (UID: \"db778348-b49d-423f-a8c4-3109ae576656\") " pod="default/test-pod-1" Apr 13 19:23:36.492102 kernel: FS-Cache: Loaded Apr 13 19:23:36.522182 kernel: RPC: Registered named UNIX socket transport module. Apr 13 19:23:36.522339 kernel: RPC: Registered udp transport module. Apr 13 19:23:36.522362 kernel: RPC: Registered tcp transport module. Apr 13 19:23:36.522376 kernel: RPC: Registered tcp-with-tls transport module. Apr 13 19:23:36.522390 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 13 19:23:36.711440 kernel: NFS: Registering the id_resolver key type Apr 13 19:23:36.711614 kernel: Key type id_resolver registered Apr 13 19:23:36.711647 kernel: Key type id_legacy registered Apr 13 19:23:36.738395 nfsidmap[2791]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 13 19:23:36.742532 nfsidmap[2792]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Apr 13 19:23:36.873514 containerd[1477]: time="2026-04-13T19:23:36.873458301Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:db778348-b49d-423f-a8c4-3109ae576656,Namespace:default,Attempt:0,}" Apr 13 19:23:36.914307 kernel: cni0: port 3(veth2e5dcc50) entered blocking state Apr 13 19:23:36.914435 kernel: cni0: port 3(veth2e5dcc50) entered disabled state Apr 13 19:23:36.914455 kernel: veth2e5dcc50: entered allmulticast mode Apr 13 19:23:36.914473 kernel: veth2e5dcc50: entered promiscuous mode Apr 13 19:23:36.911055 systemd-networkd[1388]: veth2e5dcc50: Link UP Apr 13 19:23:36.923376 kernel: cni0: port 3(veth2e5dcc50) entered blocking state Apr 13 19:23:36.923488 kernel: cni0: port 3(veth2e5dcc50) entered forwarding state Apr 13 19:23:36.923558 systemd-networkd[1388]: veth2e5dcc50: Gained carrier Apr 13 19:23:36.926274 containerd[1477]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000082950), "name":"cbr0", "type":"bridge"} Apr 13 19:23:36.926274 containerd[1477]: delegateAdd: netconf sent to delegate plugin: Apr 13 19:23:36.954526 containerd[1477]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2026-04-13T19:23:36.954262749Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 13 19:23:36.954526 containerd[1477]: time="2026-04-13T19:23:36.954333009Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 13 19:23:36.954526 containerd[1477]: time="2026-04-13T19:23:36.954365036Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:36.955047 containerd[1477]: time="2026-04-13T19:23:36.954572854Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 13 19:23:36.977477 systemd[1]: Started cri-containerd-4d79810cc8d5daced23456079cea5c419d87f681d8ad5e1292a64a7c813aea27.scope - libcontainer container 4d79810cc8d5daced23456079cea5c419d87f681d8ad5e1292a64a7c813aea27. Apr 13 19:23:37.016018 containerd[1477]: time="2026-04-13T19:23:37.015884749Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:db778348-b49d-423f-a8c4-3109ae576656,Namespace:default,Attempt:0,} returns sandbox id \"4d79810cc8d5daced23456079cea5c419d87f681d8ad5e1292a64a7c813aea27\"" Apr 13 19:23:37.018062 containerd[1477]: time="2026-04-13T19:23:37.017920631Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 13 19:23:37.247345 kubelet[1800]: E0413 19:23:37.247177 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:37.434624 containerd[1477]: time="2026-04-13T19:23:37.434542749Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 13 19:23:37.435853 containerd[1477]: time="2026-04-13T19:23:37.435805128Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Apr 13 19:23:37.439830 containerd[1477]: time="2026-04-13T19:23:37.439683497Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:9ccac550fb08f5ef414f45b47058b7d572d5b3c7c448508675da1b4ce05d6726\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:37746262896e4e1a260f21898a0759befa3e3bc64a33bd95f7cd1b8400a9b03b\", size \"62482885\" in 421.705379ms" Apr 13 19:23:37.439830 containerd[1477]: time="2026-04-13T19:23:37.439733657Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:9ccac550fb08f5ef414f45b47058b7d572d5b3c7c448508675da1b4ce05d6726\"" Apr 13 19:23:37.444753 containerd[1477]: time="2026-04-13T19:23:37.444707030Z" level=info msg="CreateContainer within sandbox \"4d79810cc8d5daced23456079cea5c419d87f681d8ad5e1292a64a7c813aea27\" for container &ContainerMetadata{Name:test,Attempt:0,}" Apr 13 19:23:37.465294 containerd[1477]: time="2026-04-13T19:23:37.465145399Z" level=info msg="CreateContainer within sandbox \"4d79810cc8d5daced23456079cea5c419d87f681d8ad5e1292a64a7c813aea27\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"20b4578c03fe3167a5ce4ba5039e11cf256aa014996a8ec3f919c450aaf588ae\"" Apr 13 19:23:37.467245 containerd[1477]: time="2026-04-13T19:23:37.466036317Z" level=info msg="StartContainer for \"20b4578c03fe3167a5ce4ba5039e11cf256aa014996a8ec3f919c450aaf588ae\"" Apr 13 19:23:37.501517 systemd[1]: Started cri-containerd-20b4578c03fe3167a5ce4ba5039e11cf256aa014996a8ec3f919c450aaf588ae.scope - libcontainer container 20b4578c03fe3167a5ce4ba5039e11cf256aa014996a8ec3f919c450aaf588ae. Apr 13 19:23:37.532694 containerd[1477]: time="2026-04-13T19:23:37.532473837Z" level=info msg="StartContainer for \"20b4578c03fe3167a5ce4ba5039e11cf256aa014996a8ec3f919c450aaf588ae\" returns successfully" Apr 13 19:23:38.249405 kubelet[1800]: E0413 19:23:38.249325 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:38.489063 kubelet[1800]: I0413 19:23:38.488898 1800 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=11.065697322 podStartE2EDuration="11.488879012s" podCreationTimestamp="2026-04-13 19:23:27 +0000 UTC" firstStartedPulling="2026-04-13 19:23:37.017455336 +0000 UTC m=+29.226774358" lastFinishedPulling="2026-04-13 19:23:37.440637026 +0000 UTC m=+29.649956048" observedRunningTime="2026-04-13 19:23:38.488359215 +0000 UTC m=+30.697678237" watchObservedRunningTime="2026-04-13 19:23:38.488879012 +0000 UTC m=+30.698198074" Apr 13 19:23:38.505399 systemd-networkd[1388]: veth2e5dcc50: Gained IPv6LL Apr 13 19:23:39.251508 kubelet[1800]: E0413 19:23:39.249760 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:40.251517 kubelet[1800]: E0413 19:23:40.251435 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:41.251882 kubelet[1800]: E0413 19:23:41.251758 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:42.252755 kubelet[1800]: E0413 19:23:42.252677 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:43.252947 kubelet[1800]: E0413 19:23:43.252879 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:44.253539 kubelet[1800]: E0413 19:23:44.253470 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:45.253736 kubelet[1800]: E0413 19:23:45.253613 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:46.254030 kubelet[1800]: E0413 19:23:46.253854 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:47.255036 kubelet[1800]: E0413 19:23:47.254956 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:48.228288 kubelet[1800]: E0413 19:23:48.228152 1800 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:48.255562 kubelet[1800]: E0413 19:23:48.255496 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:49.256838 kubelet[1800]: E0413 19:23:49.256461 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:50.257659 kubelet[1800]: E0413 19:23:50.257575 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:51.258578 kubelet[1800]: E0413 19:23:51.258486 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:52.259598 kubelet[1800]: E0413 19:23:52.259520 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:53.260681 kubelet[1800]: E0413 19:23:53.260622 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:54.261667 kubelet[1800]: E0413 19:23:54.261546 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:55.262732 kubelet[1800]: E0413 19:23:55.262312 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:56.263333 kubelet[1800]: E0413 19:23:56.263250 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:57.263620 kubelet[1800]: E0413 19:23:57.263457 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 13 19:23:58.263779 kubelet[1800]: E0413 19:23:58.263685 1800 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"