Feb 13 15:52:32.496186 kernel: Linux version 6.6.71-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 14.2.1_p20241116 p3) 14.2.1 20241116, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT_DYNAMIC Thu Feb 13 14:06:02 -00 2025 Feb 13 15:52:32.496225 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=digitalocean verity.usrhash=85b856728ac62eb775b23688185fbd191f36059b11eac7a7eacb2da5f3555b05 Feb 13 15:52:32.496244 kernel: BIOS-provided physical RAM map: Feb 13 15:52:32.496254 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Feb 13 15:52:32.496265 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Feb 13 15:52:32.496274 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Feb 13 15:52:32.496286 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdafff] usable Feb 13 15:52:32.496297 kernel: BIOS-e820: [mem 0x000000007ffdb000-0x000000007fffffff] reserved Feb 13 15:52:32.496307 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Feb 13 15:52:32.496317 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Feb 13 15:52:32.496330 kernel: NX (Execute Disable) protection: active Feb 13 15:52:32.496340 kernel: APIC: Static calls initialized Feb 13 15:52:32.496355 kernel: SMBIOS 2.8 present. Feb 13 15:52:32.496365 kernel: DMI: DigitalOcean Droplet/Droplet, BIOS 20171212 12/12/2017 Feb 13 15:52:32.496378 kernel: Hypervisor detected: KVM Feb 13 15:52:32.496389 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Feb 13 15:52:32.496407 kernel: kvm-clock: using sched offset of 4341786413 cycles Feb 13 15:52:32.496419 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Feb 13 15:52:32.496430 kernel: tsc: Detected 1995.311 MHz processor Feb 13 15:52:32.496442 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Feb 13 15:52:32.496454 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Feb 13 15:52:32.496466 kernel: last_pfn = 0x7ffdb max_arch_pfn = 0x400000000 Feb 13 15:52:32.496477 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Feb 13 15:52:32.496488 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Feb 13 15:52:32.496503 kernel: ACPI: Early table checksum verification disabled Feb 13 15:52:32.496514 kernel: ACPI: RSDP 0x00000000000F5950 000014 (v00 BOCHS ) Feb 13 15:52:32.496525 kernel: ACPI: RSDT 0x000000007FFE1986 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496537 kernel: ACPI: FACP 0x000000007FFE176A 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496548 kernel: ACPI: DSDT 0x000000007FFE0040 00172A (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496559 kernel: ACPI: FACS 0x000000007FFE0000 000040 Feb 13 15:52:32.496570 kernel: ACPI: APIC 0x000000007FFE17DE 000080 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496581 kernel: ACPI: HPET 0x000000007FFE185E 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496592 kernel: ACPI: SRAT 0x000000007FFE1896 0000C8 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496608 kernel: ACPI: WAET 0x000000007FFE195E 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Feb 13 15:52:32.496619 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe176a-0x7ffe17dd] Feb 13 15:52:32.496630 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffe0040-0x7ffe1769] Feb 13 15:52:32.496641 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffe0000-0x7ffe003f] Feb 13 15:52:32.496652 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe17de-0x7ffe185d] Feb 13 15:52:32.496663 kernel: ACPI: Reserving HPET table memory at [mem 0x7ffe185e-0x7ffe1895] Feb 13 15:52:32.496674 kernel: ACPI: Reserving SRAT table memory at [mem 0x7ffe1896-0x7ffe195d] Feb 13 15:52:32.496800 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe195e-0x7ffe1985] Feb 13 15:52:32.496847 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Feb 13 15:52:32.496859 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Feb 13 15:52:32.496871 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Feb 13 15:52:32.496882 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0x7fffffff] Feb 13 15:52:32.496926 kernel: NUMA: Node 0 [mem 0x00000000-0x0009ffff] + [mem 0x00100000-0x7ffdafff] -> [mem 0x00000000-0x7ffdafff] Feb 13 15:52:32.496939 kernel: NODE_DATA(0) allocated [mem 0x7ffd5000-0x7ffdafff] Feb 13 15:52:32.496955 kernel: Zone ranges: Feb 13 15:52:32.496968 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Feb 13 15:52:32.496979 kernel: DMA32 [mem 0x0000000001000000-0x000000007ffdafff] Feb 13 15:52:32.496992 kernel: Normal empty Feb 13 15:52:32.497004 kernel: Movable zone start for each node Feb 13 15:52:32.497016 kernel: Early memory node ranges Feb 13 15:52:32.497028 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Feb 13 15:52:32.497040 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdafff] Feb 13 15:52:32.497053 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdafff] Feb 13 15:52:32.497068 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Feb 13 15:52:32.497080 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Feb 13 15:52:32.497096 kernel: On node 0, zone DMA32: 37 pages in unavailable ranges Feb 13 15:52:32.497108 kernel: ACPI: PM-Timer IO Port: 0x608 Feb 13 15:52:32.497120 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Feb 13 15:52:32.497132 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Feb 13 15:52:32.497144 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Feb 13 15:52:32.497156 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Feb 13 15:52:32.497168 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Feb 13 15:52:32.497180 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Feb 13 15:52:32.497195 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Feb 13 15:52:32.497207 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Feb 13 15:52:32.497219 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Feb 13 15:52:32.497231 kernel: TSC deadline timer available Feb 13 15:52:32.497242 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Feb 13 15:52:32.497254 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Feb 13 15:52:32.497265 kernel: [mem 0x80000000-0xfeffbfff] available for PCI devices Feb 13 15:52:32.497282 kernel: Booting paravirtualized kernel on KVM Feb 13 15:52:32.497295 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Feb 13 15:52:32.497311 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Feb 13 15:52:32.497324 kernel: percpu: Embedded 58 pages/cpu s197032 r8192 d32344 u1048576 Feb 13 15:52:32.497335 kernel: pcpu-alloc: s197032 r8192 d32344 u1048576 alloc=1*2097152 Feb 13 15:52:32.497348 kernel: pcpu-alloc: [0] 0 1 Feb 13 15:52:32.497360 kernel: kvm-guest: PV spinlocks disabled, no host support Feb 13 15:52:32.497374 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=digitalocean verity.usrhash=85b856728ac62eb775b23688185fbd191f36059b11eac7a7eacb2da5f3555b05 Feb 13 15:52:32.497387 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Feb 13 15:52:32.497399 kernel: random: crng init done Feb 13 15:52:32.497413 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Feb 13 15:52:32.497425 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Feb 13 15:52:32.497436 kernel: Fallback order for Node 0: 0 Feb 13 15:52:32.497447 kernel: Built 1 zonelists, mobility grouping on. Total pages: 515803 Feb 13 15:52:32.497458 kernel: Policy zone: DMA32 Feb 13 15:52:32.497471 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Feb 13 15:52:32.497485 kernel: Memory: 1969156K/2096612K available (14336K kernel code, 2299K rwdata, 22800K rodata, 43320K init, 1756K bss, 127196K reserved, 0K cma-reserved) Feb 13 15:52:32.497497 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Feb 13 15:52:32.497510 kernel: Kernel/User page tables isolation: enabled Feb 13 15:52:32.497526 kernel: ftrace: allocating 37890 entries in 149 pages Feb 13 15:52:32.497539 kernel: ftrace: allocated 149 pages with 4 groups Feb 13 15:52:32.497551 kernel: Dynamic Preempt: voluntary Feb 13 15:52:32.497563 kernel: rcu: Preemptible hierarchical RCU implementation. Feb 13 15:52:32.497587 kernel: rcu: RCU event tracing is enabled. Feb 13 15:52:32.497598 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Feb 13 15:52:32.497610 kernel: Trampoline variant of Tasks RCU enabled. Feb 13 15:52:32.497622 kernel: Rude variant of Tasks RCU enabled. Feb 13 15:52:32.497635 kernel: Tracing variant of Tasks RCU enabled. Feb 13 15:52:32.497652 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Feb 13 15:52:32.497763 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Feb 13 15:52:32.497778 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Feb 13 15:52:32.497792 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Feb 13 15:52:32.497812 kernel: Console: colour VGA+ 80x25 Feb 13 15:52:32.497824 kernel: printk: console [tty0] enabled Feb 13 15:52:32.497837 kernel: printk: console [ttyS0] enabled Feb 13 15:52:32.497849 kernel: ACPI: Core revision 20230628 Feb 13 15:52:32.497942 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Feb 13 15:52:32.497962 kernel: APIC: Switch to symmetric I/O mode setup Feb 13 15:52:32.497974 kernel: x2apic enabled Feb 13 15:52:32.497987 kernel: APIC: Switched APIC routing to: physical x2apic Feb 13 15:52:32.497999 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Feb 13 15:52:32.498012 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x3985c177478, max_idle_ns: 881590705666 ns Feb 13 15:52:32.498025 kernel: Calibrating delay loop (skipped) preset value.. 3990.62 BogoMIPS (lpj=1995311) Feb 13 15:52:32.498037 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Feb 13 15:52:32.498049 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Feb 13 15:52:32.498074 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Feb 13 15:52:32.498088 kernel: Spectre V2 : Mitigation: Retpolines Feb 13 15:52:32.498101 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Feb 13 15:52:32.498117 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Feb 13 15:52:32.498130 kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Feb 13 15:52:32.498143 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Feb 13 15:52:32.498156 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Feb 13 15:52:32.498169 kernel: MDS: Mitigation: Clear CPU buffers Feb 13 15:52:32.498184 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Feb 13 15:52:32.498203 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Feb 13 15:52:32.498216 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Feb 13 15:52:32.498230 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Feb 13 15:52:32.498242 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Feb 13 15:52:32.498255 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Feb 13 15:52:32.498268 kernel: Freeing SMP alternatives memory: 32K Feb 13 15:52:32.498280 kernel: pid_max: default: 32768 minimum: 301 Feb 13 15:52:32.498294 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Feb 13 15:52:32.498314 kernel: landlock: Up and running. Feb 13 15:52:32.498328 kernel: SELinux: Initializing. Feb 13 15:52:32.498343 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Feb 13 15:52:32.498356 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Feb 13 15:52:32.498370 kernel: smpboot: CPU0: Intel DO-Regular (family: 0x6, model: 0x4f, stepping: 0x1) Feb 13 15:52:32.498397 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Feb 13 15:52:32.498430 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Feb 13 15:52:32.498449 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Feb 13 15:52:32.498464 kernel: Performance Events: unsupported p6 CPU model 79 no PMU driver, software events only. Feb 13 15:52:32.498492 kernel: signal: max sigframe size: 1776 Feb 13 15:52:32.498506 kernel: rcu: Hierarchical SRCU implementation. Feb 13 15:52:32.498524 kernel: rcu: Max phase no-delay instances is 400. Feb 13 15:52:32.498540 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Feb 13 15:52:32.498556 kernel: smp: Bringing up secondary CPUs ... Feb 13 15:52:32.498572 kernel: smpboot: x86: Booting SMP configuration: Feb 13 15:52:32.498588 kernel: .... node #0, CPUs: #1 Feb 13 15:52:32.498604 kernel: smp: Brought up 1 node, 2 CPUs Feb 13 15:52:32.498626 kernel: smpboot: Max logical packages: 1 Feb 13 15:52:32.498646 kernel: smpboot: Total of 2 processors activated (7981.24 BogoMIPS) Feb 13 15:52:32.498660 kernel: devtmpfs: initialized Feb 13 15:52:32.498673 kernel: x86/mm: Memory block size: 128MB Feb 13 15:52:32.498685 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Feb 13 15:52:32.498698 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Feb 13 15:52:32.498710 kernel: pinctrl core: initialized pinctrl subsystem Feb 13 15:52:32.498724 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Feb 13 15:52:32.498736 kernel: audit: initializing netlink subsys (disabled) Feb 13 15:52:32.498748 kernel: thermal_sys: Registered thermal governor 'step_wise' Feb 13 15:52:32.498763 kernel: thermal_sys: Registered thermal governor 'user_space' Feb 13 15:52:32.498775 kernel: audit: type=2000 audit(1739461949.570:1): state=initialized audit_enabled=0 res=1 Feb 13 15:52:32.498787 kernel: cpuidle: using governor menu Feb 13 15:52:32.498800 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Feb 13 15:52:32.498814 kernel: dca service started, version 1.12.1 Feb 13 15:52:32.498827 kernel: PCI: Using configuration type 1 for base access Feb 13 15:52:32.498841 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Feb 13 15:52:32.498860 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Feb 13 15:52:32.498876 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Feb 13 15:52:32.498911 kernel: ACPI: Added _OSI(Module Device) Feb 13 15:52:32.498927 kernel: ACPI: Added _OSI(Processor Device) Feb 13 15:52:32.498943 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Feb 13 15:52:32.498959 kernel: ACPI: Added _OSI(Processor Aggregator Device) Feb 13 15:52:32.498974 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Feb 13 15:52:32.498990 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Feb 13 15:52:32.499005 kernel: ACPI: Interpreter enabled Feb 13 15:52:32.499020 kernel: ACPI: PM: (supports S0 S5) Feb 13 15:52:32.499032 kernel: ACPI: Using IOAPIC for interrupt routing Feb 13 15:52:32.499045 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Feb 13 15:52:32.499062 kernel: PCI: Using E820 reservations for host bridge windows Feb 13 15:52:32.499075 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Feb 13 15:52:32.499091 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Feb 13 15:52:32.501351 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Feb 13 15:52:32.501602 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Feb 13 15:52:32.501984 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Feb 13 15:52:32.502011 kernel: acpiphp: Slot [3] registered Feb 13 15:52:32.502027 kernel: acpiphp: Slot [4] registered Feb 13 15:52:32.502053 kernel: acpiphp: Slot [5] registered Feb 13 15:52:32.502067 kernel: acpiphp: Slot [6] registered Feb 13 15:52:32.502080 kernel: acpiphp: Slot [7] registered Feb 13 15:52:32.502093 kernel: acpiphp: Slot [8] registered Feb 13 15:52:32.502107 kernel: acpiphp: Slot [9] registered Feb 13 15:52:32.502122 kernel: acpiphp: Slot [10] registered Feb 13 15:52:32.502138 kernel: acpiphp: Slot [11] registered Feb 13 15:52:32.502154 kernel: acpiphp: Slot [12] registered Feb 13 15:52:32.502170 kernel: acpiphp: Slot [13] registered Feb 13 15:52:32.502189 kernel: acpiphp: Slot [14] registered Feb 13 15:52:32.502205 kernel: acpiphp: Slot [15] registered Feb 13 15:52:32.502221 kernel: acpiphp: Slot [16] registered Feb 13 15:52:32.502236 kernel: acpiphp: Slot [17] registered Feb 13 15:52:32.502252 kernel: acpiphp: Slot [18] registered Feb 13 15:52:32.502267 kernel: acpiphp: Slot [19] registered Feb 13 15:52:32.502282 kernel: acpiphp: Slot [20] registered Feb 13 15:52:32.502298 kernel: acpiphp: Slot [21] registered Feb 13 15:52:32.502314 kernel: acpiphp: Slot [22] registered Feb 13 15:52:32.502329 kernel: acpiphp: Slot [23] registered Feb 13 15:52:32.502348 kernel: acpiphp: Slot [24] registered Feb 13 15:52:32.502363 kernel: acpiphp: Slot [25] registered Feb 13 15:52:32.502379 kernel: acpiphp: Slot [26] registered Feb 13 15:52:32.502395 kernel: acpiphp: Slot [27] registered Feb 13 15:52:32.502411 kernel: acpiphp: Slot [28] registered Feb 13 15:52:32.502426 kernel: acpiphp: Slot [29] registered Feb 13 15:52:32.502442 kernel: acpiphp: Slot [30] registered Feb 13 15:52:32.502457 kernel: acpiphp: Slot [31] registered Feb 13 15:52:32.502473 kernel: PCI host bridge to bus 0000:00 Feb 13 15:52:32.502655 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Feb 13 15:52:32.502788 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Feb 13 15:52:32.502935 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Feb 13 15:52:32.503062 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] Feb 13 15:52:32.503186 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] Feb 13 15:52:32.503311 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Feb 13 15:52:32.503524 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Feb 13 15:52:32.504561 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Feb 13 15:52:32.506132 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Feb 13 15:52:32.506314 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc1e0-0xc1ef] Feb 13 15:52:32.506464 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Feb 13 15:52:32.506611 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Feb 13 15:52:32.506759 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Feb 13 15:52:32.506928 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Feb 13 15:52:32.507114 kernel: pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 Feb 13 15:52:32.507266 kernel: pci 0000:00:01.2: reg 0x20: [io 0xc180-0xc19f] Feb 13 15:52:32.513366 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Feb 13 15:52:32.513753 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Feb 13 15:52:32.514168 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Feb 13 15:52:32.514371 kernel: pci 0000:00:02.0: [1af4:1050] type 00 class 0x030000 Feb 13 15:52:32.514554 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfe000000-0xfe7fffff pref] Feb 13 15:52:32.514710 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfe800000-0xfe803fff 64bit pref] Feb 13 15:52:32.515432 kernel: pci 0000:00:02.0: reg 0x20: [mem 0xfebf0000-0xfebf0fff] Feb 13 15:52:32.515607 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] Feb 13 15:52:32.515765 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Feb 13 15:52:32.520348 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 Feb 13 15:52:32.520590 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc1a0-0xc1bf] Feb 13 15:52:32.522030 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebf1000-0xfebf1fff] Feb 13 15:52:32.522220 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe804000-0xfe807fff 64bit pref] Feb 13 15:52:32.522396 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Feb 13 15:52:32.522548 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc1c0-0xc1df] Feb 13 15:52:32.522698 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebf2000-0xfebf2fff] Feb 13 15:52:32.522838 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe808000-0xfe80bfff 64bit pref] Feb 13 15:52:32.530787 kernel: pci 0000:00:05.0: [1af4:1004] type 00 class 0x010000 Feb 13 15:52:32.531034 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc100-0xc13f] Feb 13 15:52:32.531176 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebf3000-0xfebf3fff] Feb 13 15:52:32.531317 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe80c000-0xfe80ffff 64bit pref] Feb 13 15:52:32.531469 kernel: pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 Feb 13 15:52:32.531601 kernel: pci 0000:00:06.0: reg 0x10: [io 0xc000-0xc07f] Feb 13 15:52:32.531732 kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfebf4000-0xfebf4fff] Feb 13 15:52:32.534204 kernel: pci 0000:00:06.0: reg 0x20: [mem 0xfe810000-0xfe813fff 64bit pref] Feb 13 15:52:32.534769 kernel: pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000 Feb 13 15:52:32.534963 kernel: pci 0000:00:07.0: reg 0x10: [io 0xc080-0xc0ff] Feb 13 15:52:32.535107 kernel: pci 0000:00:07.0: reg 0x14: [mem 0xfebf5000-0xfebf5fff] Feb 13 15:52:32.535258 kernel: pci 0000:00:07.0: reg 0x20: [mem 0xfe814000-0xfe817fff 64bit pref] Feb 13 15:52:32.535435 kernel: pci 0000:00:08.0: [1af4:1002] type 00 class 0x00ff00 Feb 13 15:52:32.535595 kernel: pci 0000:00:08.0: reg 0x10: [io 0xc140-0xc17f] Feb 13 15:52:32.535755 kernel: pci 0000:00:08.0: reg 0x20: [mem 0xfe818000-0xfe81bfff 64bit pref] Feb 13 15:52:32.535776 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Feb 13 15:52:32.535793 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Feb 13 15:52:32.535808 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Feb 13 15:52:32.535823 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Feb 13 15:52:32.535840 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Feb 13 15:52:32.535855 kernel: iommu: Default domain type: Translated Feb 13 15:52:32.535875 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Feb 13 15:52:32.537981 kernel: PCI: Using ACPI for IRQ routing Feb 13 15:52:32.538011 kernel: PCI: pci_cache_line_size set to 64 bytes Feb 13 15:52:32.538025 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Feb 13 15:52:32.538038 kernel: e820: reserve RAM buffer [mem 0x7ffdb000-0x7fffffff] Feb 13 15:52:32.538306 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Feb 13 15:52:32.538472 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Feb 13 15:52:32.538625 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Feb 13 15:52:32.538644 kernel: vgaarb: loaded Feb 13 15:52:32.538670 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Feb 13 15:52:32.538685 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Feb 13 15:52:32.538701 kernel: clocksource: Switched to clocksource kvm-clock Feb 13 15:52:32.538716 kernel: VFS: Disk quotas dquot_6.6.0 Feb 13 15:52:32.538732 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Feb 13 15:52:32.538749 kernel: pnp: PnP ACPI init Feb 13 15:52:32.538764 kernel: pnp: PnP ACPI: found 4 devices Feb 13 15:52:32.538781 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Feb 13 15:52:32.538797 kernel: NET: Registered PF_INET protocol family Feb 13 15:52:32.538818 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Feb 13 15:52:32.538833 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Feb 13 15:52:32.538848 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Feb 13 15:52:32.538863 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Feb 13 15:52:32.538875 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Feb 13 15:52:32.539964 kernel: TCP: Hash tables configured (established 16384 bind 16384) Feb 13 15:52:32.539997 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Feb 13 15:52:32.540021 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Feb 13 15:52:32.540041 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Feb 13 15:52:32.540073 kernel: NET: Registered PF_XDP protocol family Feb 13 15:52:32.540422 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Feb 13 15:52:32.540617 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Feb 13 15:52:32.540761 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Feb 13 15:52:32.551072 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] Feb 13 15:52:32.551294 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] Feb 13 15:52:32.551461 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Feb 13 15:52:32.551612 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Feb 13 15:52:32.551644 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Feb 13 15:52:32.551790 kernel: pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x7a0 took 71734 usecs Feb 13 15:52:32.551809 kernel: PCI: CLS 0 bytes, default 64 Feb 13 15:52:32.551823 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Feb 13 15:52:32.551838 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3985c177478, max_idle_ns: 881590705666 ns Feb 13 15:52:32.551851 kernel: Initialise system trusted keyrings Feb 13 15:52:32.551866 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Feb 13 15:52:32.551879 kernel: Key type asymmetric registered Feb 13 15:52:32.551923 kernel: Asymmetric key parser 'x509' registered Feb 13 15:52:32.551937 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Feb 13 15:52:32.551951 kernel: io scheduler mq-deadline registered Feb 13 15:52:32.551965 kernel: io scheduler kyber registered Feb 13 15:52:32.551979 kernel: io scheduler bfq registered Feb 13 15:52:32.551993 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Feb 13 15:52:32.552006 kernel: ACPI: \_SB_.LNKB: Enabled at IRQ 10 Feb 13 15:52:32.552021 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Feb 13 15:52:32.552034 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Feb 13 15:52:32.552051 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Feb 13 15:52:32.552066 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Feb 13 15:52:32.552081 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Feb 13 15:52:32.552093 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Feb 13 15:52:32.552106 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Feb 13 15:52:32.552301 kernel: rtc_cmos 00:03: RTC can wake from S4 Feb 13 15:52:32.552323 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Feb 13 15:52:32.552460 kernel: rtc_cmos 00:03: registered as rtc0 Feb 13 15:52:32.552602 kernel: rtc_cmos 00:03: setting system clock to 2025-02-13T15:52:31 UTC (1739461951) Feb 13 15:52:32.552735 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Feb 13 15:52:32.552753 kernel: intel_pstate: CPU model not supported Feb 13 15:52:32.552768 kernel: NET: Registered PF_INET6 protocol family Feb 13 15:52:32.552783 kernel: Segment Routing with IPv6 Feb 13 15:52:32.552798 kernel: In-situ OAM (IOAM) with IPv6 Feb 13 15:52:32.552829 kernel: NET: Registered PF_PACKET protocol family Feb 13 15:52:32.552843 kernel: Key type dns_resolver registered Feb 13 15:52:32.552858 kernel: IPI shorthand broadcast: enabled Feb 13 15:52:32.552877 kernel: sched_clock: Marking stable (1966015060, 208259887)->(2464935527, -290660580) Feb 13 15:52:32.554195 kernel: registered taskstats version 1 Feb 13 15:52:32.554220 kernel: Loading compiled-in X.509 certificates Feb 13 15:52:32.554238 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.71-flatcar: 3d19ae6dcd850c11d55bf09bd44e00c45ed399eb' Feb 13 15:52:32.554255 kernel: Key type .fscrypt registered Feb 13 15:52:32.554269 kernel: Key type fscrypt-provisioning registered Feb 13 15:52:32.554286 kernel: ima: No TPM chip found, activating TPM-bypass! Feb 13 15:52:32.554301 kernel: ima: Allocated hash algorithm: sha1 Feb 13 15:52:32.554317 kernel: ima: No architecture policies found Feb 13 15:52:32.554341 kernel: clk: Disabling unused clocks Feb 13 15:52:32.554356 kernel: Freeing unused kernel image (initmem) memory: 43320K Feb 13 15:52:32.554373 kernel: Write protecting the kernel read-only data: 38912k Feb 13 15:52:32.554412 kernel: Freeing unused kernel image (rodata/data gap) memory: 1776K Feb 13 15:52:32.554432 kernel: Run /init as init process Feb 13 15:52:32.554448 kernel: with arguments: Feb 13 15:52:32.554466 kernel: /init Feb 13 15:52:32.554482 kernel: with environment: Feb 13 15:52:32.554499 kernel: HOME=/ Feb 13 15:52:32.554520 kernel: TERM=linux Feb 13 15:52:32.554536 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Feb 13 15:52:32.554558 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) Feb 13 15:52:32.554580 systemd[1]: Detected virtualization kvm. Feb 13 15:52:32.554598 systemd[1]: Detected architecture x86-64. Feb 13 15:52:32.554615 systemd[1]: Running in initrd. Feb 13 15:52:32.554631 systemd[1]: No hostname configured, using default hostname. Feb 13 15:52:32.554651 systemd[1]: Hostname set to . Feb 13 15:52:32.564281 systemd[1]: Initializing machine ID from VM UUID. Feb 13 15:52:32.564316 systemd[1]: Queued start job for default target initrd.target. Feb 13 15:52:32.564335 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 15:52:32.564353 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 15:52:32.564374 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Feb 13 15:52:32.564392 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Feb 13 15:52:32.564410 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Feb 13 15:52:32.564444 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Feb 13 15:52:32.564467 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Feb 13 15:52:32.564484 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Feb 13 15:52:32.564501 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 15:52:32.564519 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 13 15:52:32.564537 systemd[1]: Reached target paths.target - Path Units. Feb 13 15:52:32.564555 systemd[1]: Reached target slices.target - Slice Units. Feb 13 15:52:32.564576 systemd[1]: Reached target swap.target - Swaps. Feb 13 15:52:32.564597 systemd[1]: Reached target timers.target - Timer Units. Feb 13 15:52:32.564615 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Feb 13 15:52:32.564633 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Feb 13 15:52:32.564651 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Feb 13 15:52:32.564670 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Feb 13 15:52:32.564691 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Feb 13 15:52:32.564709 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 13 15:52:32.564727 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 15:52:32.564745 systemd[1]: Reached target sockets.target - Socket Units. Feb 13 15:52:32.564763 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Feb 13 15:52:32.564781 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 13 15:52:32.564800 systemd[1]: Finished network-cleanup.service - Network Cleanup. Feb 13 15:52:32.564874 systemd[1]: Starting systemd-fsck-usr.service... Feb 13 15:52:32.565103 systemd[1]: Starting systemd-journald.service - Journal Service... Feb 13 15:52:32.565123 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 13 15:52:32.565141 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:32.565159 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Feb 13 15:52:32.565177 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 15:52:32.565195 systemd[1]: Finished systemd-fsck-usr.service. Feb 13 15:52:32.565456 systemd-journald[183]: Collecting audit messages is disabled. Feb 13 15:52:32.565505 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Feb 13 15:52:32.565525 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Feb 13 15:52:32.565550 systemd-journald[183]: Journal started Feb 13 15:52:32.565589 systemd-journald[183]: Runtime Journal (/run/log/journal/e77273e6f3fe48eb9d9ebfc13cb06402) is 4.9M, max 39.3M, 34.4M free. Feb 13 15:52:32.501868 systemd-modules-load[184]: Inserted module 'overlay' Feb 13 15:52:32.664220 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Feb 13 15:52:32.664262 kernel: Bridge firewalling registered Feb 13 15:52:32.664298 systemd[1]: Started systemd-journald.service - Journal Service. Feb 13 15:52:32.602798 systemd-modules-load[184]: Inserted module 'br_netfilter' Feb 13 15:52:32.674097 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 13 15:52:32.676266 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:32.695942 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 15:52:32.713675 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 13 15:52:32.733142 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 13 15:52:32.738197 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 13 15:52:32.775933 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 15:52:32.793254 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Feb 13 15:52:32.804311 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 15:52:32.810023 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 15:52:32.812803 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 13 15:52:32.820097 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Feb 13 15:52:32.842629 dracut-cmdline[213]: dracut-dracut-053 Feb 13 15:52:32.847267 dracut-cmdline[213]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=digitalocean verity.usrhash=85b856728ac62eb775b23688185fbd191f36059b11eac7a7eacb2da5f3555b05 Feb 13 15:52:32.885200 systemd-resolved[218]: Positive Trust Anchors: Feb 13 15:52:32.886069 systemd-resolved[218]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 13 15:52:32.886120 systemd-resolved[218]: 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 Feb 13 15:52:32.895695 systemd-resolved[218]: Defaulting to hostname 'linux'. Feb 13 15:52:32.899109 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Feb 13 15:52:32.900228 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Feb 13 15:52:33.043099 kernel: SCSI subsystem initialized Feb 13 15:52:33.064571 kernel: Loading iSCSI transport class v2.0-870. Feb 13 15:52:33.110151 kernel: iscsi: registered transport (tcp) Feb 13 15:52:33.163367 kernel: iscsi: registered transport (qla4xxx) Feb 13 15:52:33.163706 kernel: QLogic iSCSI HBA Driver Feb 13 15:52:33.266547 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Feb 13 15:52:33.298505 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Feb 13 15:52:33.368579 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Feb 13 15:52:33.368679 kernel: device-mapper: uevent: version 1.0.3 Feb 13 15:52:33.370952 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Feb 13 15:52:33.453398 kernel: raid6: avx2x4 gen() 14972 MB/s Feb 13 15:52:33.483286 kernel: raid6: avx2x2 gen() 13432 MB/s Feb 13 15:52:33.513968 kernel: raid6: avx2x1 gen() 12363 MB/s Feb 13 15:52:33.514068 kernel: raid6: using algorithm avx2x4 gen() 14972 MB/s Feb 13 15:52:33.533468 kernel: raid6: .... xor() 6892 MB/s, rmw enabled Feb 13 15:52:33.533569 kernel: raid6: using avx2x2 recovery algorithm Feb 13 15:52:33.573380 kernel: xor: automatically using best checksumming function avx Feb 13 15:52:33.924750 kernel: Btrfs loaded, zoned=no, fsverity=no Feb 13 15:52:33.950552 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Feb 13 15:52:33.979546 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 15:52:34.028778 systemd-udevd[401]: Using default interface naming scheme 'v255'. Feb 13 15:52:34.047506 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 15:52:34.117304 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Feb 13 15:52:34.143833 dracut-pre-trigger[405]: rd.md=0: removing MD RAID activation Feb 13 15:52:34.251301 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Feb 13 15:52:34.270841 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 13 15:52:34.398583 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 15:52:34.427352 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Feb 13 15:52:34.489698 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Feb 13 15:52:34.492062 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Feb 13 15:52:34.494840 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 15:52:34.496711 systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 13 15:52:34.520823 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Feb 13 15:52:34.599631 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Feb 13 15:52:34.628290 kernel: scsi host0: Virtio SCSI HBA Feb 13 15:52:34.715918 kernel: virtio_blk virtio4: 1/0/0 default/read/poll queues Feb 13 15:52:34.791567 kernel: cryptd: max_cpu_qlen set to 1000 Feb 13 15:52:34.791604 kernel: libata version 3.00 loaded. Feb 13 15:52:34.791647 kernel: virtio_blk virtio4: [vda] 125829120 512-byte logical blocks (64.4 GB/60.0 GiB) Feb 13 15:52:34.791852 kernel: ata_piix 0000:00:01.1: version 2.13 Feb 13 15:52:34.827778 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Feb 13 15:52:34.827807 kernel: GPT:9289727 != 125829119 Feb 13 15:52:34.827825 kernel: GPT:Alternate GPT header not at the end of the disk. Feb 13 15:52:34.827842 kernel: GPT:9289727 != 125829119 Feb 13 15:52:34.827859 kernel: GPT: Use GNU Parted to correct GPT errors. Feb 13 15:52:34.827876 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 15:52:34.827918 kernel: scsi host1: ata_piix Feb 13 15:52:34.828167 kernel: scsi host2: ata_piix Feb 13 15:52:34.828383 kernel: virtio_blk virtio5: 1/0/0 default/read/poll queues Feb 13 15:52:34.829606 kernel: ACPI: bus type USB registered Feb 13 15:52:34.829635 kernel: usbcore: registered new interface driver usbfs Feb 13 15:52:34.829825 kernel: usbcore: registered new interface driver hub Feb 13 15:52:34.829846 kernel: usbcore: registered new device driver usb Feb 13 15:52:34.829865 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 Feb 13 15:52:34.829916 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 Feb 13 15:52:34.829942 kernel: virtio_blk virtio5: [vdb] 932 512-byte logical blocks (477 kB/466 KiB) Feb 13 15:52:34.830142 kernel: AVX2 version of gcm_enc/dec engaged. Feb 13 15:52:34.830161 kernel: AES CTR mode by8 optimization enabled Feb 13 15:52:34.795067 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Feb 13 15:52:34.795239 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 15:52:34.805577 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 15:52:34.806919 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 15:52:34.807474 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:34.811252 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:34.827217 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:34.922297 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:34.934014 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Feb 13 15:52:34.963791 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 15:52:35.031308 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (472) Feb 13 15:52:35.042984 kernel: BTRFS: device fsid 0e178e67-0100-48b1-87c9-422b9a68652a devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (471) Feb 13 15:52:35.047532 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Feb 13 15:52:35.068923 kernel: uhci_hcd 0000:00:01.2: UHCI Host Controller Feb 13 15:52:35.077594 kernel: uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 Feb 13 15:52:35.077835 kernel: uhci_hcd 0000:00:01.2: detected 2 ports Feb 13 15:52:35.078110 kernel: uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c180 Feb 13 15:52:35.078399 kernel: hub 1-0:1.0: USB hub found Feb 13 15:52:35.078639 kernel: hub 1-0:1.0: 2 ports detected Feb 13 15:52:35.080968 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Feb 13 15:52:35.099599 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Feb 13 15:52:35.124567 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Feb 13 15:52:35.125645 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Feb 13 15:52:35.150321 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Feb 13 15:52:35.167195 disk-uuid[552]: Primary Header is updated. Feb 13 15:52:35.167195 disk-uuid[552]: Secondary Entries is updated. Feb 13 15:52:35.167195 disk-uuid[552]: Secondary Header is updated. Feb 13 15:52:35.183312 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 15:52:35.200933 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 15:52:36.197065 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Feb 13 15:52:36.198194 disk-uuid[553]: The operation has completed successfully. Feb 13 15:52:36.306064 systemd[1]: disk-uuid.service: Deactivated successfully. Feb 13 15:52:36.306268 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Feb 13 15:52:36.331405 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Feb 13 15:52:36.362473 sh[565]: Success Feb 13 15:52:36.452923 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Feb 13 15:52:36.635050 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Feb 13 15:52:36.641080 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Feb 13 15:52:36.644490 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Feb 13 15:52:36.709872 kernel: BTRFS info (device dm-0): first mount of filesystem 0e178e67-0100-48b1-87c9-422b9a68652a Feb 13 15:52:36.710017 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Feb 13 15:52:36.723438 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Feb 13 15:52:36.723539 kernel: BTRFS info (device dm-0): disabling log replay at mount time Feb 13 15:52:36.723559 kernel: BTRFS info (device dm-0): using free space tree Feb 13 15:52:36.736736 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Feb 13 15:52:36.738454 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Feb 13 15:52:36.750311 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Feb 13 15:52:36.759185 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Feb 13 15:52:36.795806 kernel: BTRFS info (device vda6): first mount of filesystem c26baa82-37e4-4435-b3ec-4748612bc475 Feb 13 15:52:36.795915 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Feb 13 15:52:36.795936 kernel: BTRFS info (device vda6): using free space tree Feb 13 15:52:36.820229 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 15:52:36.841419 systemd[1]: mnt-oem.mount: Deactivated successfully. Feb 13 15:52:36.843576 kernel: BTRFS info (device vda6): last unmount of filesystem c26baa82-37e4-4435-b3ec-4748612bc475 Feb 13 15:52:36.854240 systemd[1]: Finished ignition-setup.service - Ignition (setup). Feb 13 15:52:36.860173 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Feb 13 15:52:37.074040 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Feb 13 15:52:37.101295 systemd[1]: Starting systemd-networkd.service - Network Configuration... Feb 13 15:52:37.126051 ignition[663]: Ignition 2.20.0 Feb 13 15:52:37.127133 ignition[663]: Stage: fetch-offline Feb 13 15:52:37.127228 ignition[663]: no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:37.127243 ignition[663]: no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:37.127462 ignition[663]: parsed url from cmdline: "" Feb 13 15:52:37.127469 ignition[663]: no config URL provided Feb 13 15:52:37.127479 ignition[663]: reading system config file "/usr/lib/ignition/user.ign" Feb 13 15:52:37.134543 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Feb 13 15:52:37.127494 ignition[663]: no config at "/usr/lib/ignition/user.ign" Feb 13 15:52:37.127505 ignition[663]: failed to fetch config: resource requires networking Feb 13 15:52:37.127843 ignition[663]: Ignition finished successfully Feb 13 15:52:37.163425 systemd-networkd[753]: lo: Link UP Feb 13 15:52:37.163443 systemd-networkd[753]: lo: Gained carrier Feb 13 15:52:37.167033 systemd-networkd[753]: Enumeration completed Feb 13 15:52:37.167578 systemd[1]: Started systemd-networkd.service - Network Configuration. Feb 13 15:52:37.167637 systemd-networkd[753]: eth0: found matching network '/usr/lib/systemd/network/yy-digitalocean.network', based on potentially unpredictable interface name. Feb 13 15:52:37.167642 systemd-networkd[753]: eth0: Configuring with /usr/lib/systemd/network/yy-digitalocean.network. Feb 13 15:52:37.169063 systemd[1]: Reached target network.target - Network. Feb 13 15:52:37.169365 systemd-networkd[753]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 15:52:37.169370 systemd-networkd[753]: eth1: Configuring with /usr/lib/systemd/network/zz-default.network. Feb 13 15:52:37.170730 systemd-networkd[753]: eth0: Link UP Feb 13 15:52:37.170736 systemd-networkd[753]: eth0: Gained carrier Feb 13 15:52:37.170750 systemd-networkd[753]: eth0: found matching network '/usr/lib/systemd/network/yy-digitalocean.network', based on potentially unpredictable interface name. Feb 13 15:52:37.181455 systemd-networkd[753]: eth1: Link UP Feb 13 15:52:37.181460 systemd-networkd[753]: eth1: Gained carrier Feb 13 15:52:37.181481 systemd-networkd[753]: eth1: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Feb 13 15:52:37.184416 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Feb 13 15:52:37.206053 systemd-networkd[753]: eth0: DHCPv4 address 161.35.231.245/20, gateway 161.35.224.1 acquired from 169.254.169.253 Feb 13 15:52:37.224050 systemd-networkd[753]: eth1: DHCPv4 address 10.124.0.14/20 acquired from 169.254.169.253 Feb 13 15:52:37.246566 ignition[756]: Ignition 2.20.0 Feb 13 15:52:37.246582 ignition[756]: Stage: fetch Feb 13 15:52:37.246882 ignition[756]: no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:37.246930 ignition[756]: no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:37.247068 ignition[756]: parsed url from cmdline: "" Feb 13 15:52:37.247074 ignition[756]: no config URL provided Feb 13 15:52:37.247083 ignition[756]: reading system config file "/usr/lib/ignition/user.ign" Feb 13 15:52:37.247096 ignition[756]: no config at "/usr/lib/ignition/user.ign" Feb 13 15:52:37.247130 ignition[756]: GET http://169.254.169.254/metadata/v1/user-data: attempt #1 Feb 13 15:52:37.292381 ignition[756]: GET result: OK Feb 13 15:52:37.293174 ignition[756]: parsing config with SHA512: b836eb3594461b93ac860acdad859cd2990fbef09cbeb14ad9d56d3accb6ae91942009dc1421a84be1ce08fb0f26d0e00f2664b5074f397365e84647d4b8d44f Feb 13 15:52:37.302017 unknown[756]: fetched base config from "system" Feb 13 15:52:37.302465 ignition[756]: fetch: fetch complete Feb 13 15:52:37.302034 unknown[756]: fetched base config from "system" Feb 13 15:52:37.302474 ignition[756]: fetch: fetch passed Feb 13 15:52:37.302045 unknown[756]: fetched user config from "digitalocean" Feb 13 15:52:37.302554 ignition[756]: Ignition finished successfully Feb 13 15:52:37.305859 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Feb 13 15:52:37.318470 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Feb 13 15:52:37.395060 ignition[764]: Ignition 2.20.0 Feb 13 15:52:37.395076 ignition[764]: Stage: kargs Feb 13 15:52:37.395394 ignition[764]: no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:37.395407 ignition[764]: no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:37.398568 ignition[764]: kargs: kargs passed Feb 13 15:52:37.398667 ignition[764]: Ignition finished successfully Feb 13 15:52:37.401179 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Feb 13 15:52:37.416098 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Feb 13 15:52:37.445242 ignition[770]: Ignition 2.20.0 Feb 13 15:52:37.445265 ignition[770]: Stage: disks Feb 13 15:52:37.445968 ignition[770]: no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:37.445989 ignition[770]: no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:37.450111 systemd[1]: Finished ignition-disks.service - Ignition (disks). Feb 13 15:52:37.447704 ignition[770]: disks: disks passed Feb 13 15:52:37.451300 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Feb 13 15:52:37.447917 ignition[770]: Ignition finished successfully Feb 13 15:52:37.460151 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Feb 13 15:52:37.464952 systemd[1]: Reached target local-fs.target - Local File Systems. Feb 13 15:52:37.470227 systemd[1]: Reached target sysinit.target - System Initialization. Feb 13 15:52:37.472129 systemd[1]: Reached target basic.target - Basic System. Feb 13 15:52:37.483012 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Feb 13 15:52:37.522668 systemd-fsck[778]: ROOT: clean, 14/553520 files, 52654/553472 blocks Feb 13 15:52:37.538858 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Feb 13 15:52:37.573294 systemd[1]: Mounting sysroot.mount - /sysroot... Feb 13 15:52:37.788163 kernel: EXT4-fs (vda9): mounted filesystem e45e00fd-a630-4f0f-91bb-bc879e42a47e r/w with ordered data mode. Quota mode: none. Feb 13 15:52:37.801105 systemd[1]: Mounted sysroot.mount - /sysroot. Feb 13 15:52:37.803632 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Feb 13 15:52:37.822329 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Feb 13 15:52:37.833647 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Feb 13 15:52:37.838677 systemd[1]: Starting flatcar-afterburn-network.service - Flatcar Afterburn network service... Feb 13 15:52:37.849359 systemd[1]: Starting flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent... Feb 13 15:52:37.851986 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Feb 13 15:52:37.852069 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Feb 13 15:52:37.870939 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (786) Feb 13 15:52:37.870142 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Feb 13 15:52:37.881966 kernel: BTRFS info (device vda6): first mount of filesystem c26baa82-37e4-4435-b3ec-4748612bc475 Feb 13 15:52:37.882055 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Feb 13 15:52:37.882089 kernel: BTRFS info (device vda6): using free space tree Feb 13 15:52:37.885073 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Feb 13 15:52:37.931234 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 15:52:37.933481 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Feb 13 15:52:38.032820 initrd-setup-root[816]: cut: /sysroot/etc/passwd: No such file or directory Feb 13 15:52:38.050323 initrd-setup-root[823]: cut: /sysroot/etc/group: No such file or directory Feb 13 15:52:38.058937 coreos-metadata[789]: Feb 13 15:52:38.056 INFO Fetching http://169.254.169.254/metadata/v1.json: Attempt #1 Feb 13 15:52:38.064322 initrd-setup-root[830]: cut: /sysroot/etc/shadow: No such file or directory Feb 13 15:52:38.073205 initrd-setup-root[837]: cut: /sysroot/etc/gshadow: No such file or directory Feb 13 15:52:38.077936 coreos-metadata[789]: Feb 13 15:52:38.077 INFO Fetch successful Feb 13 15:52:38.084327 coreos-metadata[788]: Feb 13 15:52:38.084 INFO Fetching http://169.254.169.254/metadata/v1.json: Attempt #1 Feb 13 15:52:38.086189 coreos-metadata[789]: Feb 13 15:52:38.086 INFO wrote hostname ci-4186.1.1-1-15637b4b36 to /sysroot/etc/hostname Feb 13 15:52:38.088436 systemd[1]: Finished flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Feb 13 15:52:38.102294 coreos-metadata[788]: Feb 13 15:52:38.101 INFO Fetch successful Feb 13 15:52:38.108034 systemd[1]: flatcar-afterburn-network.service: Deactivated successfully. Feb 13 15:52:38.108244 systemd[1]: Finished flatcar-afterburn-network.service - Flatcar Afterburn network service. Feb 13 15:52:38.352744 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Feb 13 15:52:38.369341 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Feb 13 15:52:38.376135 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Feb 13 15:52:38.390157 kernel: BTRFS info (device vda6): last unmount of filesystem c26baa82-37e4-4435-b3ec-4748612bc475 Feb 13 15:52:38.389958 systemd[1]: sysroot-oem.mount: Deactivated successfully. Feb 13 15:52:38.446924 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Feb 13 15:52:38.478336 ignition[906]: INFO : Ignition 2.20.0 Feb 13 15:52:38.478336 ignition[906]: INFO : Stage: mount Feb 13 15:52:38.480227 ignition[906]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:38.480227 ignition[906]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:38.480227 ignition[906]: INFO : mount: mount passed Feb 13 15:52:38.480227 ignition[906]: INFO : Ignition finished successfully Feb 13 15:52:38.482027 systemd[1]: Finished ignition-mount.service - Ignition (mount). Feb 13 15:52:38.497261 systemd-networkd[753]: eth1: Gained IPv6LL Feb 13 15:52:38.498268 systemd[1]: Starting ignition-files.service - Ignition (files)... Feb 13 15:52:38.807724 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Feb 13 15:52:38.831372 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (918) Feb 13 15:52:38.840946 kernel: BTRFS info (device vda6): first mount of filesystem c26baa82-37e4-4435-b3ec-4748612bc475 Feb 13 15:52:38.841090 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Feb 13 15:52:38.841127 kernel: BTRFS info (device vda6): using free space tree Feb 13 15:52:38.849146 kernel: BTRFS info (device vda6): auto enabling async discard Feb 13 15:52:38.861573 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Feb 13 15:52:38.922520 ignition[935]: INFO : Ignition 2.20.0 Feb 13 15:52:38.922520 ignition[935]: INFO : Stage: files Feb 13 15:52:38.922520 ignition[935]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:38.922520 ignition[935]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:38.935281 ignition[935]: DEBUG : files: compiled without relabeling support, skipping Feb 13 15:52:38.935281 ignition[935]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Feb 13 15:52:38.935281 ignition[935]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Feb 13 15:52:38.941670 ignition[935]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Feb 13 15:52:38.941670 ignition[935]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Feb 13 15:52:38.941670 ignition[935]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Feb 13 15:52:38.936677 unknown[935]: wrote ssh authorized keys file for user: core Feb 13 15:52:38.947329 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-x86-64.raw" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-x86-64.raw" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-x86-64.raw" Feb 13 15:52:38.948756 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://github.com/flatcar/sysext-bakery/releases/download/latest/kubernetes-v1.30.1-x86-64.raw: attempt #1 Feb 13 15:52:39.137175 systemd-networkd[753]: eth0: Gained IPv6LL Feb 13 15:52:39.430291 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Feb 13 15:52:40.020798 ignition[935]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-x86-64.raw" Feb 13 15:52:40.020798 ignition[935]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Feb 13 15:52:40.024629 ignition[935]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Feb 13 15:52:40.024629 ignition[935]: INFO : files: files passed Feb 13 15:52:40.024629 ignition[935]: INFO : Ignition finished successfully Feb 13 15:52:40.034320 systemd[1]: Finished ignition-files.service - Ignition (files). Feb 13 15:52:40.061436 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Feb 13 15:52:40.072343 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Feb 13 15:52:40.104746 systemd[1]: ignition-quench.service: Deactivated successfully. Feb 13 15:52:40.106513 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Feb 13 15:52:40.121701 initrd-setup-root-after-ignition[964]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Feb 13 15:52:40.121701 initrd-setup-root-after-ignition[964]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Feb 13 15:52:40.128717 initrd-setup-root-after-ignition[968]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Feb 13 15:52:40.128362 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Feb 13 15:52:40.141571 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Feb 13 15:52:40.151633 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Feb 13 15:52:40.228763 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Feb 13 15:52:40.233007 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Feb 13 15:52:40.234824 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Feb 13 15:52:40.235998 systemd[1]: Reached target initrd.target - Initrd Default Target. Feb 13 15:52:40.239881 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Feb 13 15:52:40.250214 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Feb 13 15:52:40.277377 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Feb 13 15:52:40.285410 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Feb 13 15:52:40.322000 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Feb 13 15:52:40.323250 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 15:52:40.326320 systemd[1]: Stopped target timers.target - Timer Units. Feb 13 15:52:40.328613 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Feb 13 15:52:40.329054 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Feb 13 15:52:40.334761 systemd[1]: Stopped target initrd.target - Initrd Default Target. Feb 13 15:52:40.336651 systemd[1]: Stopped target basic.target - Basic System. Feb 13 15:52:40.338374 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Feb 13 15:52:40.341006 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Feb 13 15:52:40.342559 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Feb 13 15:52:40.343261 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Feb 13 15:52:40.343852 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Feb 13 15:52:40.344873 systemd[1]: Stopped target sysinit.target - System Initialization. Feb 13 15:52:40.347460 systemd[1]: Stopped target local-fs.target - Local File Systems. Feb 13 15:52:40.349482 systemd[1]: Stopped target swap.target - Swaps. Feb 13 15:52:40.351013 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Feb 13 15:52:40.351212 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Feb 13 15:52:40.353169 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Feb 13 15:52:40.354111 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 15:52:40.355596 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Feb 13 15:52:40.357499 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 15:52:40.359771 systemd[1]: dracut-initqueue.service: Deactivated successfully. Feb 13 15:52:40.360318 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Feb 13 15:52:40.362920 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Feb 13 15:52:40.363242 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Feb 13 15:52:40.365230 systemd[1]: ignition-files.service: Deactivated successfully. Feb 13 15:52:40.365621 systemd[1]: Stopped ignition-files.service - Ignition (files). Feb 13 15:52:40.370403 systemd[1]: flatcar-metadata-hostname.service: Deactivated successfully. Feb 13 15:52:40.370706 systemd[1]: Stopped flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent. Feb 13 15:52:40.381490 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Feb 13 15:52:40.395073 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Feb 13 15:52:40.395858 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Feb 13 15:52:40.396138 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 15:52:40.401642 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Feb 13 15:52:40.402530 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Feb 13 15:52:40.422932 systemd[1]: initrd-cleanup.service: Deactivated successfully. Feb 13 15:52:40.423038 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Feb 13 15:52:40.441963 ignition[989]: INFO : Ignition 2.20.0 Feb 13 15:52:40.441963 ignition[989]: INFO : Stage: umount Feb 13 15:52:40.441963 ignition[989]: INFO : no configs at "/usr/lib/ignition/base.d" Feb 13 15:52:40.441963 ignition[989]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/digitalocean" Feb 13 15:52:40.441963 ignition[989]: INFO : umount: umount passed Feb 13 15:52:40.441963 ignition[989]: INFO : Ignition finished successfully Feb 13 15:52:40.451946 systemd[1]: ignition-mount.service: Deactivated successfully. Feb 13 15:52:40.452173 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Feb 13 15:52:40.454491 systemd[1]: ignition-disks.service: Deactivated successfully. Feb 13 15:52:40.454589 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Feb 13 15:52:40.460093 systemd[1]: ignition-kargs.service: Deactivated successfully. Feb 13 15:52:40.460211 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Feb 13 15:52:40.463549 systemd[1]: ignition-fetch.service: Deactivated successfully. Feb 13 15:52:40.463670 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Feb 13 15:52:40.467175 systemd[1]: Stopped target network.target - Network. Feb 13 15:52:40.474027 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Feb 13 15:52:40.474171 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Feb 13 15:52:40.482156 systemd[1]: Stopped target paths.target - Path Units. Feb 13 15:52:40.485960 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Feb 13 15:52:40.490338 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 15:52:40.491396 systemd[1]: Stopped target slices.target - Slice Units. Feb 13 15:52:40.492176 systemd[1]: Stopped target sockets.target - Socket Units. Feb 13 15:52:40.493073 systemd[1]: iscsid.socket: Deactivated successfully. Feb 13 15:52:40.493177 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Feb 13 15:52:40.493973 systemd[1]: iscsiuio.socket: Deactivated successfully. Feb 13 15:52:40.494060 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Feb 13 15:52:40.494823 systemd[1]: ignition-setup.service: Deactivated successfully. Feb 13 15:52:40.494980 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Feb 13 15:52:40.495708 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Feb 13 15:52:40.500588 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Feb 13 15:52:40.528578 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Feb 13 15:52:40.530158 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Feb 13 15:52:40.538647 systemd[1]: sysroot-boot.mount: Deactivated successfully. Feb 13 15:52:40.541330 systemd[1]: sysroot-boot.service: Deactivated successfully. Feb 13 15:52:40.542403 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Feb 13 15:52:40.543077 systemd-networkd[753]: eth1: DHCPv6 lease lost Feb 13 15:52:40.544621 systemd[1]: systemd-resolved.service: Deactivated successfully. Feb 13 15:52:40.546032 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Feb 13 15:52:40.552963 systemd[1]: initrd-setup-root.service: Deactivated successfully. Feb 13 15:52:40.557483 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Feb 13 15:52:40.568278 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Feb 13 15:52:40.568427 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 15:52:40.574216 systemd-networkd[753]: eth0: DHCPv6 lease lost Feb 13 15:52:40.586265 systemd[1]: systemd-networkd.service: Deactivated successfully. Feb 13 15:52:40.586867 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Feb 13 15:52:40.597406 systemd[1]: systemd-networkd.socket: Deactivated successfully. Feb 13 15:52:40.597618 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Feb 13 15:52:40.635127 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Feb 13 15:52:40.635927 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Feb 13 15:52:40.636079 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Feb 13 15:52:40.637011 systemd[1]: systemd-sysctl.service: Deactivated successfully. Feb 13 15:52:40.637100 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Feb 13 15:52:40.637916 systemd[1]: systemd-modules-load.service: Deactivated successfully. Feb 13 15:52:40.637996 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Feb 13 15:52:40.639010 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 15:52:40.671817 systemd[1]: systemd-udevd.service: Deactivated successfully. Feb 13 15:52:40.673165 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 15:52:40.676924 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Feb 13 15:52:40.677057 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Feb 13 15:52:40.680250 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Feb 13 15:52:40.680362 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 15:52:40.683119 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Feb 13 15:52:40.683245 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Feb 13 15:52:40.684151 systemd[1]: dracut-cmdline.service: Deactivated successfully. Feb 13 15:52:40.684246 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Feb 13 15:52:40.686333 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Feb 13 15:52:40.686440 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Feb 13 15:52:40.710080 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Feb 13 15:52:40.710934 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Feb 13 15:52:40.711058 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 15:52:40.711918 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Feb 13 15:52:40.712010 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Feb 13 15:52:40.712976 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Feb 13 15:52:40.713069 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 15:52:40.713853 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 15:52:40.714009 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:40.715303 systemd[1]: network-cleanup.service: Deactivated successfully. Feb 13 15:52:40.715459 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Feb 13 15:52:40.743646 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Feb 13 15:52:40.743840 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Feb 13 15:52:40.747153 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Feb 13 15:52:40.756698 systemd[1]: Starting initrd-switch-root.service - Switch Root... Feb 13 15:52:40.774470 systemd[1]: Switching root. Feb 13 15:52:40.921800 systemd-journald[183]: Journal stopped Feb 13 15:52:42.931270 systemd-journald[183]: Received SIGTERM from PID 1 (systemd). Feb 13 15:52:42.931449 kernel: SELinux: policy capability network_peer_controls=1 Feb 13 15:52:42.931475 kernel: SELinux: policy capability open_perms=1 Feb 13 15:52:42.931494 kernel: SELinux: policy capability extended_socket_class=1 Feb 13 15:52:42.931511 kernel: SELinux: policy capability always_check_network=0 Feb 13 15:52:42.931529 kernel: SELinux: policy capability cgroup_seclabel=1 Feb 13 15:52:42.931560 kernel: SELinux: policy capability nnp_nosuid_transition=1 Feb 13 15:52:42.931578 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Feb 13 15:52:42.931603 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Feb 13 15:52:42.931622 kernel: audit: type=1403 audit(1739461961.134:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Feb 13 15:52:42.931650 systemd[1]: Successfully loaded SELinux policy in 60.307ms. Feb 13 15:52:42.931683 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 21.052ms. Feb 13 15:52:42.931706 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) Feb 13 15:52:42.931726 systemd[1]: Detected virtualization kvm. Feb 13 15:52:42.931749 systemd[1]: Detected architecture x86-64. Feb 13 15:52:42.931772 systemd[1]: Detected first boot. Feb 13 15:52:42.931793 systemd[1]: Hostname set to . Feb 13 15:52:42.931813 systemd[1]: Initializing machine ID from VM UUID. Feb 13 15:52:42.931853 zram_generator::config[1032]: No configuration found. Feb 13 15:52:42.931923 systemd[1]: Populated /etc with preset unit settings. Feb 13 15:52:42.931950 systemd[1]: initrd-switch-root.service: Deactivated successfully. Feb 13 15:52:42.931975 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Feb 13 15:52:42.932000 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Feb 13 15:52:42.932022 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Feb 13 15:52:42.932047 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Feb 13 15:52:42.932070 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Feb 13 15:52:42.932088 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Feb 13 15:52:42.932105 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Feb 13 15:52:42.932122 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Feb 13 15:52:42.932140 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Feb 13 15:52:42.932295 systemd[1]: Created slice user.slice - User and Session Slice. Feb 13 15:52:42.932360 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Feb 13 15:52:42.932381 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Feb 13 15:52:42.932401 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Feb 13 15:52:42.932422 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Feb 13 15:52:42.932441 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Feb 13 15:52:42.932461 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Feb 13 15:52:42.932477 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Feb 13 15:52:42.932495 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Feb 13 15:52:42.932514 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Feb 13 15:52:42.932541 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Feb 13 15:52:42.932561 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Feb 13 15:52:42.932581 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Feb 13 15:52:42.932604 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Feb 13 15:52:42.932624 systemd[1]: Reached target remote-fs.target - Remote File Systems. Feb 13 15:52:42.932643 systemd[1]: Reached target slices.target - Slice Units. Feb 13 15:52:42.932666 systemd[1]: Reached target swap.target - Swaps. Feb 13 15:52:42.933112 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Feb 13 15:52:42.933143 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Feb 13 15:52:42.933198 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Feb 13 15:52:42.933218 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Feb 13 15:52:42.933248 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Feb 13 15:52:42.933269 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Feb 13 15:52:42.933301 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Feb 13 15:52:42.933551 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Feb 13 15:52:42.933589 systemd[1]: Mounting media.mount - External Media Directory... Feb 13 15:52:42.933610 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:42.933628 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Feb 13 15:52:42.933647 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Feb 13 15:52:42.933665 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Feb 13 15:52:42.933687 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). Feb 13 15:52:42.933707 systemd[1]: Reached target machines.target - Containers. Feb 13 15:52:42.933727 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Feb 13 15:52:42.933745 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 15:52:42.933766 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Feb 13 15:52:42.933784 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Feb 13 15:52:42.933800 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 15:52:42.933817 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 13 15:52:42.933837 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 15:52:42.933856 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Feb 13 15:52:42.933873 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 15:52:42.933930 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Feb 13 15:52:42.933959 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Feb 13 15:52:42.933982 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Feb 13 15:52:42.934003 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Feb 13 15:52:42.934020 systemd[1]: Stopped systemd-fsck-usr.service. Feb 13 15:52:42.934039 systemd[1]: Starting systemd-journald.service - Journal Service... Feb 13 15:52:42.934236 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Feb 13 15:52:42.934267 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Feb 13 15:52:42.934287 kernel: loop: module loaded Feb 13 15:52:42.934309 kernel: ACPI: bus type drm_connector registered Feb 13 15:52:42.934339 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Feb 13 15:52:42.934359 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Feb 13 15:52:42.934378 systemd[1]: verity-setup.service: Deactivated successfully. Feb 13 15:52:42.934397 systemd[1]: Stopped verity-setup.service. Feb 13 15:52:42.934421 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:42.934439 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Feb 13 15:52:42.934457 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Feb 13 15:52:42.934476 systemd[1]: Mounted media.mount - External Media Directory. Feb 13 15:52:42.934502 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Feb 13 15:52:42.934523 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Feb 13 15:52:42.934544 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Feb 13 15:52:42.934565 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Feb 13 15:52:42.934592 systemd[1]: modprobe@configfs.service: Deactivated successfully. Feb 13 15:52:42.934641 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Feb 13 15:52:42.934662 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 15:52:42.934683 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 15:52:42.934700 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 13 15:52:42.934954 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 13 15:52:42.935047 systemd-journald[1105]: Collecting audit messages is disabled. Feb 13 15:52:42.935085 kernel: fuse: init (API version 7.39) Feb 13 15:52:42.935099 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 15:52:42.935123 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 15:52:42.935136 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 15:52:42.935149 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 15:52:42.935180 systemd-journald[1105]: Journal started Feb 13 15:52:42.935338 systemd-journald[1105]: Runtime Journal (/run/log/journal/e77273e6f3fe48eb9d9ebfc13cb06402) is 4.9M, max 39.3M, 34.4M free. Feb 13 15:52:42.229687 systemd[1]: Queued start job for default target multi-user.target. Feb 13 15:52:42.261564 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Feb 13 15:52:42.265797 systemd[1]: systemd-journald.service: Deactivated successfully. Feb 13 15:52:42.942811 systemd[1]: Started systemd-journald.service - Journal Service. Feb 13 15:52:42.942469 systemd[1]: modprobe@fuse.service: Deactivated successfully. Feb 13 15:52:42.942757 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Feb 13 15:52:42.944358 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Feb 13 15:52:42.954294 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Feb 13 15:52:42.955634 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Feb 13 15:52:42.983052 systemd[1]: Reached target network-pre.target - Preparation for Network. Feb 13 15:52:42.992088 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Feb 13 15:52:43.017065 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Feb 13 15:52:43.018542 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Feb 13 15:52:43.018636 systemd[1]: Reached target local-fs.target - Local File Systems. Feb 13 15:52:43.026963 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Feb 13 15:52:43.040223 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Feb 13 15:52:43.054292 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Feb 13 15:52:43.055378 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 15:52:43.065275 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Feb 13 15:52:43.077144 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Feb 13 15:52:43.078223 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 15:52:43.083806 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Feb 13 15:52:43.085835 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 15:52:43.098512 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Feb 13 15:52:43.119769 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Feb 13 15:52:43.136247 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Feb 13 15:52:43.147333 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Feb 13 15:52:43.149444 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Feb 13 15:52:43.153042 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Feb 13 15:52:43.179938 kernel: loop0: detected capacity change from 0 to 141000 Feb 13 15:52:43.215143 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Feb 13 15:52:43.250936 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Feb 13 15:52:43.306602 systemd-journald[1105]: Time spent on flushing to /var/log/journal/e77273e6f3fe48eb9d9ebfc13cb06402 is 99.522ms for 974 entries. Feb 13 15:52:43.306602 systemd-journald[1105]: System Journal (/var/log/journal/e77273e6f3fe48eb9d9ebfc13cb06402) is 8.0M, max 195.6M, 187.6M free. Feb 13 15:52:43.445444 systemd-journald[1105]: Received client request to flush runtime journal. Feb 13 15:52:43.445574 kernel: loop1: detected capacity change from 0 to 138184 Feb 13 15:52:43.445594 kernel: loop2: detected capacity change from 0 to 210664 Feb 13 15:52:43.307805 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Feb 13 15:52:43.311020 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Feb 13 15:52:43.346265 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Feb 13 15:52:43.431487 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Feb 13 15:52:43.449283 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Feb 13 15:52:43.456327 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Feb 13 15:52:43.459056 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Feb 13 15:52:43.472364 systemd-tmpfiles[1152]: ACLs are not supported, ignoring. Feb 13 15:52:43.474036 systemd-tmpfiles[1152]: ACLs are not supported, ignoring. Feb 13 15:52:43.529997 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Feb 13 15:52:43.532218 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Feb 13 15:52:43.548083 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Feb 13 15:52:43.570312 kernel: loop3: detected capacity change from 0 to 8 Feb 13 15:52:43.566403 systemd[1]: Starting systemd-sysusers.service - Create System Users... Feb 13 15:52:43.579012 udevadm[1167]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Feb 13 15:52:43.619863 kernel: loop4: detected capacity change from 0 to 141000 Feb 13 15:52:43.705956 kernel: loop5: detected capacity change from 0 to 138184 Feb 13 15:52:43.801788 systemd[1]: Finished systemd-sysusers.service - Create System Users. Feb 13 15:52:43.858007 kernel: loop6: detected capacity change from 0 to 210664 Feb 13 15:52:43.860409 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Feb 13 15:52:43.913584 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Feb 13 15:52:43.913612 systemd-tmpfiles[1178]: ACLs are not supported, ignoring. Feb 13 15:52:43.944589 kernel: loop7: detected capacity change from 0 to 8 Feb 13 15:52:43.943092 (sd-merge)[1175]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-digitalocean'. Feb 13 15:52:43.948507 (sd-merge)[1175]: Merged extensions into '/usr'. Feb 13 15:52:43.961853 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Feb 13 15:52:43.980938 systemd[1]: Reloading requested from client PID 1151 ('systemd-sysext') (unit systemd-sysext.service)... Feb 13 15:52:43.980966 systemd[1]: Reloading... Feb 13 15:52:44.288062 zram_generator::config[1205]: No configuration found. Feb 13 15:52:44.636466 ldconfig[1143]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Feb 13 15:52:44.782542 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. Feb 13 15:52:44.877046 systemd[1]: Reloading finished in 895 ms. Feb 13 15:52:44.927219 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Feb 13 15:52:44.932838 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Feb 13 15:52:44.952391 systemd[1]: Starting ensure-sysext.service... Feb 13 15:52:44.966255 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Feb 13 15:52:45.003442 systemd[1]: Reloading requested from client PID 1249 ('systemctl') (unit ensure-sysext.service)... Feb 13 15:52:45.003466 systemd[1]: Reloading... Feb 13 15:52:45.028426 systemd-tmpfiles[1250]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Feb 13 15:52:45.028962 systemd-tmpfiles[1250]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Feb 13 15:52:45.030707 systemd-tmpfiles[1250]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Feb 13 15:52:45.031283 systemd-tmpfiles[1250]: ACLs are not supported, ignoring. Feb 13 15:52:45.031430 systemd-tmpfiles[1250]: ACLs are not supported, ignoring. Feb 13 15:52:45.039246 systemd-tmpfiles[1250]: Detected autofs mount point /boot during canonicalization of boot. Feb 13 15:52:45.039267 systemd-tmpfiles[1250]: Skipping /boot Feb 13 15:52:45.072017 systemd-tmpfiles[1250]: Detected autofs mount point /boot during canonicalization of boot. Feb 13 15:52:45.072035 systemd-tmpfiles[1250]: Skipping /boot Feb 13 15:52:45.183940 zram_generator::config[1277]: No configuration found. Feb 13 15:52:45.427382 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. Feb 13 15:52:45.508378 systemd[1]: Reloading finished in 503 ms. Feb 13 15:52:45.535155 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Feb 13 15:52:45.536615 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Feb 13 15:52:45.561583 systemd[1]: Starting audit-rules.service - Load Audit Rules... Feb 13 15:52:45.571192 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Feb 13 15:52:45.576179 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Feb 13 15:52:45.582133 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Feb 13 15:52:45.592334 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Feb 13 15:52:45.607726 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Feb 13 15:52:45.629651 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.630314 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 15:52:45.636862 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 15:52:45.645408 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 15:52:45.656381 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 15:52:45.659933 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 15:52:45.660165 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.667378 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Feb 13 15:52:45.670815 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.672224 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 15:52:45.672528 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 15:52:45.672683 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.677623 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.678278 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 15:52:45.688337 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Feb 13 15:52:45.689380 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 15:52:45.689668 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:45.699960 systemd[1]: Finished ensure-sysext.service. Feb 13 15:52:45.704997 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Feb 13 15:52:45.708584 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 15:52:45.708983 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 15:52:45.728166 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Feb 13 15:52:45.803602 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 15:52:45.803882 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 15:52:45.805299 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 15:52:45.826795 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Feb 13 15:52:45.839438 systemd[1]: Starting systemd-update-done.service - Update is Completed... Feb 13 15:52:45.865609 systemd-udevd[1326]: Using default interface naming scheme 'v255'. Feb 13 15:52:45.876762 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Feb 13 15:52:45.879704 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 15:52:45.882299 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 15:52:45.883583 systemd[1]: modprobe@drm.service: Deactivated successfully. Feb 13 15:52:45.883830 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Feb 13 15:52:45.889094 systemd[1]: Finished systemd-update-done.service - Update is Completed. Feb 13 15:52:45.897576 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 15:52:45.897698 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). Feb 13 15:52:45.910737 augenrules[1364]: No rules Feb 13 15:52:45.911957 systemd[1]: audit-rules.service: Deactivated successfully. Feb 13 15:52:45.913355 systemd[1]: Finished audit-rules.service - Load Audit Rules. Feb 13 15:52:45.930959 systemd[1]: Started systemd-userdbd.service - User Database Manager. Feb 13 15:52:45.939615 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Feb 13 15:52:45.953286 systemd[1]: Starting systemd-networkd.service - Network Configuration... Feb 13 15:52:46.038752 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Feb 13 15:52:46.041134 systemd[1]: Reached target time-set.target - System Time Set. Feb 13 15:52:46.194053 systemd-networkd[1381]: lo: Link UP Feb 13 15:52:46.194067 systemd-networkd[1381]: lo: Gained carrier Feb 13 15:52:46.198511 systemd-networkd[1381]: Enumeration completed Feb 13 15:52:46.198670 systemd[1]: Started systemd-networkd.service - Network Configuration. Feb 13 15:52:46.209366 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Feb 13 15:52:46.211676 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Feb 13 15:52:46.214064 systemd-resolved[1325]: Positive Trust Anchors: Feb 13 15:52:46.214084 systemd-resolved[1325]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Feb 13 15:52:46.214121 systemd-resolved[1325]: 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 Feb 13 15:52:46.232166 systemd-resolved[1325]: Using system hostname 'ci-4186.1.1-1-15637b4b36'. Feb 13 15:52:46.236102 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Feb 13 15:52:46.237054 systemd[1]: Reached target network.target - Network. Feb 13 15:52:46.237580 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Feb 13 15:52:46.281021 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1388) Feb 13 15:52:46.290052 systemd[1]: Mounting media-configdrive.mount - /media/configdrive... Feb 13 15:52:46.290735 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:46.290927 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Feb 13 15:52:46.293488 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Feb 13 15:52:46.301296 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Feb 13 15:52:46.309228 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Feb 13 15:52:46.310192 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Feb 13 15:52:46.310262 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). Feb 13 15:52:46.310287 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Feb 13 15:52:46.336578 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Feb 13 15:52:46.337103 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Feb 13 15:52:46.338204 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Feb 13 15:52:46.341099 systemd[1]: modprobe@loop.service: Deactivated successfully. Feb 13 15:52:46.341368 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Feb 13 15:52:46.383111 kernel: ISO 9660 Extensions: RRIP_1991A Feb 13 15:52:46.389065 systemd[1]: Mounted media-configdrive.mount - /media/configdrive. Feb 13 15:52:46.399484 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Feb 13 15:52:46.400457 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Feb 13 15:52:46.414979 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Feb 13 15:52:46.430129 systemd-networkd[1381]: eth1: Configuring with /run/systemd/network/10-7e:71:73:29:5c:1f.network. Feb 13 15:52:46.433246 systemd-networkd[1381]: eth1: Link UP Feb 13 15:52:46.433264 systemd-networkd[1381]: eth1: Gained carrier Feb 13 15:52:46.442059 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:46.519368 systemd-networkd[1381]: eth0: Configuring with /run/systemd/network/10-52:0e:78:bc:e3:b0.network. Feb 13 15:52:46.520506 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:46.521109 systemd-networkd[1381]: eth0: Link UP Feb 13 15:52:46.521954 systemd-networkd[1381]: eth0: Gained carrier Feb 13 15:52:46.528446 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:46.531527 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:46.569964 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Feb 13 15:52:46.580735 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Feb 13 15:52:46.581065 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Feb 13 15:52:46.609596 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Feb 13 15:52:46.618212 kernel: ACPI: button: Power Button [PWRF] Feb 13 15:52:46.634790 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Feb 13 15:52:46.675944 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Feb 13 15:52:46.821836 kernel: [drm] pci: virtio-vga detected at 0000:00:02.0 Feb 13 15:52:46.824881 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:46.841931 kernel: virtio-pci 0000:00:02.0: vgaarb: deactivate vga console Feb 13 15:52:46.844943 kernel: mousedev: PS/2 mouse device common for all mice Feb 13 15:52:46.863103 kernel: Console: switching to colour dummy device 80x25 Feb 13 15:52:46.865092 kernel: [drm] features: -virgl +edid -resource_blob -host_visible Feb 13 15:52:46.865309 kernel: [drm] features: -context_init Feb 13 15:52:46.868942 kernel: [drm] number of scanouts: 1 Feb 13 15:52:46.869916 kernel: [drm] number of cap sets: 0 Feb 13 15:52:46.874925 kernel: [drm] Initialized virtio_gpu 0.1.0 0 for 0000:00:02.0 on minor 0 Feb 13 15:52:46.923949 kernel: fbcon: virtio_gpudrmfb (fb0) is primary device Feb 13 15:52:46.932712 kernel: Console: switching to colour frame buffer device 128x48 Feb 13 15:52:46.954315 kernel: virtio-pci 0000:00:02.0: [drm] fb0: virtio_gpudrmfb frame buffer device Feb 13 15:52:46.958292 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 15:52:46.958751 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:46.975250 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:47.010701 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Feb 13 15:52:47.014140 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:47.046689 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Feb 13 15:52:47.121498 kernel: EDAC MC: Ver: 3.0.0 Feb 13 15:52:47.161663 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Feb 13 15:52:47.179403 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Feb 13 15:52:47.200005 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Feb 13 15:52:47.220941 lvm[1435]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 13 15:52:47.268251 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Feb 13 15:52:47.270925 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Feb 13 15:52:47.272213 systemd[1]: Reached target sysinit.target - System Initialization. Feb 13 15:52:47.272518 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Feb 13 15:52:47.272662 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Feb 13 15:52:47.273290 systemd[1]: Started logrotate.timer - Daily rotation of log files. Feb 13 15:52:47.273606 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Feb 13 15:52:47.273709 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Feb 13 15:52:47.273788 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Feb 13 15:52:47.273818 systemd[1]: Reached target paths.target - Path Units. Feb 13 15:52:47.273879 systemd[1]: Reached target timers.target - Timer Units. Feb 13 15:52:47.276683 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Feb 13 15:52:47.280186 systemd[1]: Starting docker.socket - Docker Socket for the API... Feb 13 15:52:47.292266 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Feb 13 15:52:47.302376 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Feb 13 15:52:47.306098 systemd[1]: Listening on docker.socket - Docker Socket for the API. Feb 13 15:52:47.308048 systemd[1]: Reached target sockets.target - Socket Units. Feb 13 15:52:47.308965 systemd[1]: Reached target basic.target - Basic System. Feb 13 15:52:47.311409 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Feb 13 15:52:47.311469 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Feb 13 15:52:47.324296 systemd[1]: Starting containerd.service - containerd container runtime... Feb 13 15:52:47.333150 lvm[1441]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Feb 13 15:52:47.351544 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Feb 13 15:52:47.378592 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Feb 13 15:52:47.387835 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Feb 13 15:52:47.396299 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Feb 13 15:52:47.397265 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). Feb 13 15:52:47.405647 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Feb 13 15:52:47.422246 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Feb 13 15:52:47.431284 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Feb 13 15:52:47.439822 jq[1445]: false Feb 13 15:52:47.453341 systemd[1]: Starting systemd-logind.service - User Login Management... Feb 13 15:52:47.460267 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Feb 13 15:52:47.461319 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Feb 13 15:52:47.464298 systemd[1]: Starting update-engine.service - Update Engine... Feb 13 15:52:47.473229 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Feb 13 15:52:47.479587 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Feb 13 15:52:47.527046 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Feb 13 15:52:47.527701 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Feb 13 15:52:47.570713 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Feb 13 15:52:47.571085 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Feb 13 15:52:47.577039 dbus-daemon[1444]: [system] SELinux support is enabled Feb 13 15:52:47.579830 systemd[1]: Started dbus.service - D-Bus System Message Bus. Feb 13 15:52:47.612082 coreos-metadata[1443]: Feb 13 15:52:47.596 INFO Fetching http://169.254.169.254/metadata/v1.json: Attempt #1 Feb 13 15:52:47.596301 systemd-networkd[1381]: eth0: Gained IPv6LL Feb 13 15:52:47.597860 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). Feb 13 15:52:47.598019 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Feb 13 15:52:47.604122 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:47.623757 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). Feb 13 15:52:47.624012 systemd[1]: user-configdrive.service - Load cloud-config from /media/configdrive was skipped because of an unmet condition check (ConditionKernelCommandLine=!flatcar.oem.id=digitalocean). Feb 13 15:52:47.624056 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Feb 13 15:52:47.636752 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Feb 13 15:52:47.650001 coreos-metadata[1443]: Feb 13 15:52:47.643 INFO Fetch successful Feb 13 15:52:47.651034 systemd[1]: Reached target network-online.target - Network is Online. Feb 13 15:52:47.657334 jq[1454]: true Feb 13 15:52:47.668574 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Feb 13 15:52:47.683448 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Feb 13 15:52:47.696997 update_engine[1453]: I20250213 15:52:47.688570 1453 main.cc:92] Flatcar Update Engine starting Feb 13 15:52:47.719349 extend-filesystems[1448]: Found loop4 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found loop5 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found loop6 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found loop7 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda1 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda2 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda3 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found usr Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda4 Feb 13 15:52:47.719349 extend-filesystems[1448]: Found vda6 Feb 13 15:52:47.870081 extend-filesystems[1448]: Found vda7 Feb 13 15:52:47.870081 extend-filesystems[1448]: Found vda9 Feb 13 15:52:47.870081 extend-filesystems[1448]: Checking size of /dev/vda9 Feb 13 15:52:47.899485 update_engine[1453]: I20250213 15:52:47.729403 1453 update_check_scheduler.cc:74] Next update check in 7m9s Feb 13 15:52:47.731776 (ntainerd)[1464]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Feb 13 15:52:47.743563 systemd[1]: Started update-engine.service - Update Engine. Feb 13 15:52:47.768921 systemd[1]: motdgen.service: Deactivated successfully. Feb 13 15:52:47.770311 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Feb 13 15:52:47.811189 systemd[1]: Started locksmithd.service - Cluster reboot manager. Feb 13 15:52:47.952579 jq[1474]: true Feb 13 15:52:47.953521 extend-filesystems[1448]: Resized partition /dev/vda9 Feb 13 15:52:48.020956 extend-filesystems[1493]: resize2fs 1.47.1 (20-May-2024) Feb 13 15:52:48.052632 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 15121403 blocks Feb 13 15:52:48.114060 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Feb 13 15:52:48.119853 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Feb 13 15:52:48.151406 systemd-logind[1452]: New seat seat0. Feb 13 15:52:48.161311 systemd-logind[1452]: Watching system buttons on /dev/input/event1 (Power Button) Feb 13 15:52:48.161360 systemd-logind[1452]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Feb 13 15:52:48.161973 systemd[1]: Started systemd-logind.service - User Login Management. Feb 13 15:52:48.207608 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Feb 13 15:52:48.323549 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1376) Feb 13 15:52:48.492351 kernel: EXT4-fs (vda9): resized filesystem to 15121403 Feb 13 15:52:48.483127 systemd-networkd[1381]: eth1: Gained IPv6LL Feb 13 15:52:48.492080 systemd-timesyncd[1342]: Network configuration changed, trying to establish connection. Feb 13 15:52:48.516644 locksmithd[1481]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Feb 13 15:52:48.545815 sshd_keygen[1475]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Feb 13 15:52:48.550450 bash[1520]: Updated "/home/core/.ssh/authorized_keys" Feb 13 15:52:48.552541 extend-filesystems[1493]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Feb 13 15:52:48.552541 extend-filesystems[1493]: old_desc_blocks = 1, new_desc_blocks = 8 Feb 13 15:52:48.552541 extend-filesystems[1493]: The filesystem on /dev/vda9 is now 15121403 (4k) blocks long. Feb 13 15:52:48.602724 extend-filesystems[1448]: Resized filesystem in /dev/vda9 Feb 13 15:52:48.602724 extend-filesystems[1448]: Found vdb Feb 13 15:52:48.563351 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Feb 13 15:52:48.611544 systemd[1]: extend-filesystems.service: Deactivated successfully. Feb 13 15:52:48.613649 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Feb 13 15:52:48.634103 systemd[1]: Starting sshkeys.service... Feb 13 15:52:48.732846 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Feb 13 15:52:48.759728 systemd[1]: Starting issuegen.service - Generate /run/issue... Feb 13 15:52:48.813126 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Feb 13 15:52:48.832244 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Feb 13 15:52:48.857511 systemd[1]: issuegen.service: Deactivated successfully. Feb 13 15:52:48.857990 systemd[1]: Finished issuegen.service - Generate /run/issue. Feb 13 15:52:48.887133 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Feb 13 15:52:48.983882 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Feb 13 15:52:49.008988 containerd[1464]: time="2025-02-13T15:52:49.008451469Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 Feb 13 15:52:49.010229 systemd[1]: Started getty@tty1.service - Getty on tty1. Feb 13 15:52:49.033913 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Feb 13 15:52:49.052966 systemd[1]: Reached target getty.target - Login Prompts. Feb 13 15:52:49.058525 coreos-metadata[1537]: Feb 13 15:52:49.056 INFO Fetching http://169.254.169.254/metadata/v1.json: Attempt #1 Feb 13 15:52:49.080931 coreos-metadata[1537]: Feb 13 15:52:49.078 INFO Fetch successful Feb 13 15:52:49.102337 unknown[1537]: wrote ssh authorized keys file for user: core Feb 13 15:52:49.156013 containerd[1464]: time="2025-02-13T15:52:49.155406086Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.161369 containerd[1464]: time="2025-02-13T15:52:49.160301659Z" 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.71-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Feb 13 15:52:49.161369 containerd[1464]: time="2025-02-13T15:52:49.160391530Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Feb 13 15:52:49.161369 containerd[1464]: time="2025-02-13T15:52:49.160428875Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Feb 13 15:52:49.161369 containerd[1464]: time="2025-02-13T15:52:49.160723006Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Feb 13 15:52:49.162274 containerd[1464]: time="2025-02-13T15:52:49.161822099Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.162274 containerd[1464]: time="2025-02-13T15:52:49.162061761Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 15:52:49.162274 containerd[1464]: time="2025-02-13T15:52:49.162091515Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.163235 containerd[1464]: time="2025-02-13T15:52:49.163163044Z" 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 Feb 13 15:52:49.163235 containerd[1464]: time="2025-02-13T15:52:49.163218090Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.163235 containerd[1464]: time="2025-02-13T15:52:49.163245785Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Feb 13 15:52:49.163235 containerd[1464]: time="2025-02-13T15:52:49.163264593Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.164109635Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.164512038Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.164814538Z" 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 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.164846843Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.165002426Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Feb 13 15:52:49.165281 containerd[1464]: time="2025-02-13T15:52:49.165070218Z" level=info msg="metadata content store policy set" policy=shared Feb 13 15:52:49.168029 update-ssh-keys[1550]: Updated "/home/core/.ssh/authorized_keys" Feb 13 15:52:49.170073 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Feb 13 15:52:49.183177 systemd[1]: Finished sshkeys.service. Feb 13 15:52:49.186659 containerd[1464]: time="2025-02-13T15:52:49.186578848Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Feb 13 15:52:49.187345 containerd[1464]: time="2025-02-13T15:52:49.187039776Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Feb 13 15:52:49.187345 containerd[1464]: time="2025-02-13T15:52:49.187106493Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Feb 13 15:52:49.187345 containerd[1464]: time="2025-02-13T15:52:49.187139788Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Feb 13 15:52:49.187345 containerd[1464]: time="2025-02-13T15:52:49.187191869Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Feb 13 15:52:49.190167 containerd[1464]: time="2025-02-13T15:52:49.190098110Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Feb 13 15:52:49.191052 containerd[1464]: time="2025-02-13T15:52:49.191004035Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Feb 13 15:52:49.191316 containerd[1464]: time="2025-02-13T15:52:49.191286619Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Feb 13 15:52:49.191389 containerd[1464]: time="2025-02-13T15:52:49.191323413Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Feb 13 15:52:49.191551 containerd[1464]: time="2025-02-13T15:52:49.191506182Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Feb 13 15:52:49.191599 containerd[1464]: time="2025-02-13T15:52:49.191554980Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191599 containerd[1464]: time="2025-02-13T15:52:49.191582947Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191657 containerd[1464]: time="2025-02-13T15:52:49.191608752Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191657 containerd[1464]: time="2025-02-13T15:52:49.191642833Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191715 containerd[1464]: time="2025-02-13T15:52:49.191667260Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191715 containerd[1464]: time="2025-02-13T15:52:49.191688009Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191715 containerd[1464]: time="2025-02-13T15:52:49.191708536Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191815 containerd[1464]: time="2025-02-13T15:52:49.191732192Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Feb 13 15:52:49.191815 containerd[1464]: time="2025-02-13T15:52:49.191769188Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191815 containerd[1464]: time="2025-02-13T15:52:49.191794710Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191815092Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191836805Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191855937Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191876531Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191925933Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191949852Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191970819Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.191984 containerd[1464]: time="2025-02-13T15:52:49.191997033Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192026258Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192050133Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192071660Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192099957Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192139339Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192165182Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192184400Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192275224Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192308770Z" 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 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192327192Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192349702Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192366350Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192388402Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Feb 13 15:52:49.192554 containerd[1464]: time="2025-02-13T15:52:49.192408929Z" level=info msg="NRI interface is disabled by configuration." Feb 13 15:52:49.193372 containerd[1464]: time="2025-02-13T15:52:49.192427390Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Feb 13 15:52:49.193552 containerd[1464]: time="2025-02-13T15:52:49.193141055Z" 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}" Feb 13 15:52:49.193552 containerd[1464]: time="2025-02-13T15:52:49.193210856Z" level=info msg="Connect containerd service" Feb 13 15:52:49.193552 containerd[1464]: time="2025-02-13T15:52:49.193282172Z" level=info msg="using legacy CRI server" Feb 13 15:52:49.193552 containerd[1464]: time="2025-02-13T15:52:49.193293704Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Feb 13 15:52:49.193552 containerd[1464]: time="2025-02-13T15:52:49.193482676Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Feb 13 15:52:49.204093 containerd[1464]: time="2025-02-13T15:52:49.203743267Z" 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" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.205682786Z" level=info msg="Start subscribing containerd event" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.205821732Z" level=info msg="Start recovering state" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.206081500Z" level=info msg="Start event monitor" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.206159349Z" level=info msg="Start snapshots syncer" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.206187686Z" level=info msg="Start cni network conf syncer for default" Feb 13 15:52:49.206798 containerd[1464]: time="2025-02-13T15:52:49.206224299Z" level=info msg="Start streaming server" Feb 13 15:52:49.211381 containerd[1464]: time="2025-02-13T15:52:49.211306512Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Feb 13 15:52:49.213858 containerd[1464]: time="2025-02-13T15:52:49.213786033Z" level=info msg=serving... address=/run/containerd/containerd.sock Feb 13 15:52:49.214525 containerd[1464]: time="2025-02-13T15:52:49.214492336Z" level=info msg="containerd successfully booted in 0.207521s" Feb 13 15:52:49.215149 systemd[1]: Started containerd.service - containerd container runtime. Feb 13 15:52:50.580623 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Feb 13 15:52:50.582872 (kubelet)[1558]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Feb 13 15:52:50.592159 systemd[1]: Reached target multi-user.target - Multi-User System. Feb 13 15:52:50.606432 systemd[1]: Startup finished in 2.238s (kernel) + 9.252s (initrd) + 9.527s (userspace) = 21.018s. Feb 13 15:52:50.643744 agetty[1546]: failed to open credentials directory Feb 13 15:52:50.651240 agetty[1548]: failed to open credentials directory Feb 13 15:52:51.542346 kernel: hrtimer: interrupt took 6889282 ns Feb 13 15:52:51.878990 kubelet[1558]: E0213 15:52:51.878563 1558 run.go:74] "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" Feb 13 15:52:51.886034 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Feb 13 15:52:51.886341 systemd[1]: kubelet.service: Failed with result 'exit-code'. Feb 13 15:52:51.886929 systemd[1]: kubelet.service: Consumed 1.725s CPU time. Feb 13 15:52:53.789452 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Feb 13 15:52:53.811807 systemd[1]: Started sshd@0-161.35.231.245:22-218.92.0.207:53858.service - OpenSSH per-connection server daemon (218.92.0.207:53858). Feb 13 15:52:54.065661 sshd[1573]: Unable to negotiate with 218.92.0.207 port 53858: no matching key exchange method found. Their offer: diffie-hellman-group1-sha1,diffie-hellman-group14-sha1,diffie-hellman-group-exchange-sha1 [preauth] Feb 13 15:52:54.075260 systemd[1]: sshd@0-161.35.231.245:22-218.92.0.207:53858.service: Deactivated successfully. Feb 13 15:52:56.749660 systemd[1]: Started sshd@1-161.35.231.245:22-139.178.89.65:42346.service - OpenSSH per-connection server daemon (139.178.89.65:42346). Feb 13 15:52:56.917959 sshd[1578]: Accepted publickey for core from 139.178.89.65 port 42346 ssh2: RSA SHA256:xbQMFxKGhsFroWszVX4n07fPkTy8VMnJgGT8GFjL/e4 Feb 13 15:52:56.929190 sshd-session[1578]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 15:52:56.953503 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Feb 13 15:52:56.962579 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Feb 13 15:52:56.967017 systemd-logind[1452]: New session 1 of user core. Feb 13 15:52:56.990806 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Feb 13 15:52:57.003337 systemd[1]: Starting user@500.service - User Manager for UID 500... Feb 13 15:52:57.033064 (systemd)[1582]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Feb 13 15:52:57.314402 systemd[1582]: Queued start job for default target default.target. Feb 13 15:52:57.330788 systemd[1582]: Created slice app.slice - User Application Slice. Feb 13 15:52:57.331012 systemd[1582]: Reached target paths.target - Paths. Feb 13 15:52:57.331042 systemd[1582]: Reached target timers.target - Timers. Feb 13 15:52:57.354273 systemd[1582]: Starting dbus.socket - D-Bus User Message Bus Socket... Feb 13 15:52:57.394665 systemd[1582]: Listening on dbus.socket - D-Bus User Message Bus Socket. Feb 13 15:52:57.395008 systemd[1582]: Reached target sockets.target - Sockets. Feb 13 15:52:57.395045 systemd[1582]: Reached target basic.target - Basic System. Feb 13 15:52:57.395153 systemd[1582]: Reached target default.target - Main User Target. Feb 13 15:52:57.395217 systemd[1582]: Startup finished in 346ms. Feb 13 15:52:57.397701 systemd[1]: Started user@500.service - User Manager for UID 500. Feb 13 15:52:57.420826 systemd[1]: Started session-1.scope - Session 1 of User core. Feb 13 15:52:57.522282 systemd[1]: Started sshd@2-161.35.231.245:22-139.178.89.65:42362.service - OpenSSH per-connection server daemon (139.178.89.65:42362). Feb 13 15:52:57.631678 sshd[1593]: Accepted publickey for core from 139.178.89.65 port 42362 ssh2: RSA SHA256:xbQMFxKGhsFroWszVX4n07fPkTy8VMnJgGT8GFjL/e4 Feb 13 15:52:57.635391 sshd-session[1593]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 15:52:57.649552 systemd-logind[1452]: New session 2 of user core. Feb 13 15:52:57.655493 systemd[1]: Started session-2.scope - Session 2 of User core. Feb 13 15:52:57.738318 sshd[1595]: Connection closed by 139.178.89.65 port 42362 Feb 13 15:52:57.739616 sshd-session[1593]: pam_unix(sshd:session): session closed for user core Feb 13 15:52:57.758571 systemd[1]: sshd@2-161.35.231.245:22-139.178.89.65:42362.service: Deactivated successfully. Feb 13 15:52:57.762611 systemd[1]: session-2.scope: Deactivated successfully. Feb 13 15:52:57.764018 systemd-logind[1452]: Session 2 logged out. Waiting for processes to exit. Feb 13 15:52:57.813474 systemd[1]: Started sshd@3-161.35.231.245:22-139.178.89.65:42376.service - OpenSSH per-connection server daemon (139.178.89.65:42376). Feb 13 15:52:57.818181 systemd-logind[1452]: Removed session 2. Feb 13 15:52:57.945508 sshd[1600]: Accepted publickey for core from 139.178.89.65 port 42376 ssh2: RSA SHA256:xbQMFxKGhsFroWszVX4n07fPkTy8VMnJgGT8GFjL/e4 Feb 13 15:52:57.948775 sshd-session[1600]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 15:52:57.980521 systemd-logind[1452]: New session 3 of user core. Feb 13 15:52:57.993455 systemd[1]: Started session-3.scope - Session 3 of User core. Feb 13 15:52:58.076982 sshd[1602]: Connection closed by 139.178.89.65 port 42376 Feb 13 15:52:58.088301 sshd-session[1600]: pam_unix(sshd:session): session closed for user core Feb 13 15:52:58.141558 systemd[1]: sshd@3-161.35.231.245:22-139.178.89.65:42376.service: Deactivated successfully. Feb 13 15:52:58.146189 systemd[1]: session-3.scope: Deactivated successfully. Feb 13 15:52:58.153307 systemd-logind[1452]: Session 3 logged out. Waiting for processes to exit. Feb 13 15:52:58.168669 systemd[1]: Started sshd@4-161.35.231.245:22-139.178.89.65:42390.service - OpenSSH per-connection server daemon (139.178.89.65:42390). Feb 13 15:52:58.199302 systemd-logind[1452]: Removed session 3. Feb 13 15:52:58.293642 sshd[1607]: Accepted publickey for core from 139.178.89.65 port 42390 ssh2: RSA SHA256:xbQMFxKGhsFroWszVX4n07fPkTy8VMnJgGT8GFjL/e4 Feb 13 15:52:58.294670 sshd-session[1607]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 15:52:58.308341 systemd-logind[1452]: New session 4 of user core. Feb 13 15:52:58.317922 systemd[1]: Started session-4.scope - Session 4 of User core. Feb 13 15:52:58.435519 sshd[1609]: Connection closed by 139.178.89.65 port 42390 Feb 13 15:52:58.436430 sshd-session[1607]: pam_unix(sshd:session): session closed for user core Feb 13 15:52:58.448735 systemd[1]: sshd@4-161.35.231.245:22-139.178.89.65:42390.service: Deactivated successfully. Feb 13 15:52:58.453125 systemd[1]: session-4.scope: Deactivated successfully. Feb 13 15:52:58.454517 systemd-logind[1452]: Session 4 logged out. Waiting for processes to exit. Feb 13 15:52:58.457614 systemd-logind[1452]: Removed session 4. Feb 13 15:52:58.476161 systemd[1]: Started sshd@5-161.35.231.245:22-139.178.89.65:42402.service - OpenSSH per-connection server daemon (139.178.89.65:42402). Feb 13 15:52:58.601220 sshd[1614]: Accepted publickey for core from 139.178.89.65 port 42402 ssh2: RSA SHA256:xbQMFxKGhsFroWszVX4n07fPkTy8VMnJgGT8GFjL/e4 Feb 13 15:52:58.603775 sshd-session[1614]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Feb 13 15:52:58.618130 systemd-logind[1452]: New session 5 of user core. Feb 13 15:52:58.628753 systemd[1]: Started session-5.scope - Session 5 of User core. Feb 13 15:52:58.729645 sudo[1617]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Feb 13 15:52:58.731827 sudo[1617]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Feb 13 15:53:00.780419 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Feb 13 15:53:00.783563 systemd[1]: kubelet.service: Consumed 1.725s CPU time. Feb 13 15:53:00.792551 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Feb 13 15:53:00.946545 systemd[1]: Reloading requested from client PID 1655 ('systemctl') (unit session-5.scope)... Feb 13 15:53:00.946572 systemd[1]: Reloading... Feb 13 15:53:01.237311 zram_generator::config[1693]: No configuration found. Feb 13 15:53:01.570771 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. Feb 13 15:53:01.749276 systemd[1]: Reloading finished in 802 ms. Feb 13 15:53:01.875423 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Feb 13 15:53:01.875548 systemd[1]: kubelet.service: Failed with result 'signal'. Feb 13 15:53:01.875930 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Feb 13 15:53:01.896809 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Feb 13 15:53:02.182185 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Feb 13 15:53:02.196631 (kubelet)[1748]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Feb 13 15:53:02.365981 kubelet[1748]: Flag --container-runtime-endpoint 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. Feb 13 15:53:02.365981 kubelet[1748]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI. Feb 13 15:53:02.365981 kubelet[1748]: 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. Feb 13 15:53:02.365981 kubelet[1748]: I0213 15:53:02.364937 1748 server.go:205] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Feb 13 15:53:03.139629 kubelet[1748]: I0213 15:53:03.139563 1748 server.go:484] "Kubelet version" kubeletVersion="v1.30.1" Feb 13 15:53:03.139840 kubelet[1748]: I0213 15:53:03.139823 1748 server.go:486] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Feb 13 15:53:03.142299 kubelet[1748]: I0213 15:53:03.142087 1748 server.go:927] "Client rotation is on, will bootstrap in background" Feb 13 15:53:03.200930 kubelet[1748]: I0213 15:53:03.200846 1748 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Feb 13 15:53:03.240493 kubelet[1748]: I0213 15:53:03.240320 1748 server.go:742] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Feb 13 15:53:03.243240 kubelet[1748]: I0213 15:53:03.242229 1748 container_manager_linux.go:265] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Feb 13 15:53:03.243240 kubelet[1748]: I0213 15:53:03.242338 1748 container_manager_linux.go:270] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"161.35.231.245","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":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"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}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null} Feb 13 15:53:03.243240 kubelet[1748]: I0213 15:53:03.242670 1748 topology_manager.go:138] "Creating topology manager with none policy" Feb 13 15:53:03.243240 kubelet[1748]: I0213 15:53:03.242687 1748 container_manager_linux.go:301] "Creating device plugin manager" Feb 13 15:53:03.243240 kubelet[1748]: I0213 15:53:03.242912 1748 state_mem.go:36] "Initialized new in-memory state store" Feb 13 15:53:03.244409 kubelet[1748]: I0213 15:53:03.244375 1748 kubelet.go:400] "Attempting to sync node with API server" Feb 13 15:53:03.244542 kubelet[1748]: I0213 15:53:03.244529 1748 kubelet.go:301] "Adding static pod path" path="/etc/kubernetes/manifests" Feb 13 15:53:03.244624 kubelet[1748]: I0213 15:53:03.244616 1748 kubelet.go:312] "Adding apiserver pod source" Feb 13 15:53:03.244695 kubelet[1748]: I0213 15:53:03.244685 1748 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Feb 13 15:53:03.250682 kubelet[1748]: E0213 15:53:03.250623 1748 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:03.251000 kubelet[1748]: E0213 15:53:03.250974 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:03.262545 kubelet[1748]: I0213 15:53:03.262479 1748 kuberuntime_manager.go:261] "Container runtime initialized" containerRuntime="containerd" version="v1.7.23" apiVersion="v1" Feb 13 15:53:03.265858 kubelet[1748]: I0213 15:53:03.265336 1748 kubelet.go:815] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Feb 13 15:53:03.265858 kubelet[1748]: W0213 15:53:03.265482 1748 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Feb 13 15:53:03.270761 kubelet[1748]: I0213 15:53:03.268035 1748 server.go:1264] "Started kubelet" Feb 13 15:53:03.275947 kubelet[1748]: I0213 15:53:03.273504 1748 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Feb 13 15:53:03.286743 kubelet[1748]: I0213 15:53:03.286685 1748 server.go:455] "Adding debug handlers to kubelet server" Feb 13 15:53:03.292058 kubelet[1748]: I0213 15:53:03.291238 1748 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Feb 13 15:53:03.292058 kubelet[1748]: I0213 15:53:03.291873 1748 server.go:227] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Feb 13 15:53:03.299356 kubelet[1748]: I0213 15:53:03.280034 1748 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Feb 13 15:53:03.300509 kubelet[1748]: W0213 15:53:03.300306 1748 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "161.35.231.245" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Feb 13 15:53:03.300509 kubelet[1748]: E0213 15:53:03.300510 1748 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes "161.35.231.245" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Feb 13 15:53:03.302640 kubelet[1748]: W0213 15:53:03.300825 1748 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Feb 13 15:53:03.302640 kubelet[1748]: E0213 15:53:03.300863 1748 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Feb 13 15:53:03.317942 kubelet[1748]: I0213 15:53:03.315679 1748 volume_manager.go:291] "Starting Kubelet Volume Manager" Feb 13 15:53:03.317942 kubelet[1748]: I0213 15:53:03.316675 1748 desired_state_of_world_populator.go:149] "Desired state populator starts to run" Feb 13 15:53:03.317942 kubelet[1748]: I0213 15:53:03.316870 1748 reconciler.go:26] "Reconciler: start to sync state" Feb 13 15:53:03.325986 kubelet[1748]: I0213 15:53:03.325951 1748 factory.go:221] Registration of the systemd container factory successfully Feb 13 15:53:03.326466 kubelet[1748]: I0213 15:53:03.326432 1748 factory.go:219] 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 Feb 13 15:53:03.337105 kubelet[1748]: I0213 15:53:03.337061 1748 factory.go:221] Registration of the containerd container factory successfully Feb 13 15:53:03.339491 kubelet[1748]: E0213 15:53:03.339330 1748 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"161.35.231.245\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Feb 13 15:53:03.341386 kubelet[1748]: E0213 15:53:03.337576 1748 kubelet.go:1467] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Feb 13 15:53:03.377057 kubelet[1748]: I0213 15:53:03.377024 1748 cpu_manager.go:214] "Starting CPU manager" policy="none" Feb 13 15:53:03.378674 kubelet[1748]: I0213 15:53:03.378606 1748 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Feb 13 15:53:03.380773 kubelet[1748]: I0213 15:53:03.380742 1748 state_mem.go:36] "Initialized new in-memory state store" Feb 13 15:53:03.409638 kubelet[1748]: I0213 15:53:03.408106 1748 policy_none.go:49] "None policy: Start" Feb 13 15:53:03.422935 kubelet[1748]: I0213 15:53:03.420351 1748 kubelet_node_status.go:73] "Attempting to register node" node="161.35.231.245" Feb 13 15:53:03.422935 kubelet[1748]: I0213 15:53:03.420814 1748 memory_manager.go:170] "Starting memorymanager" policy="None" Feb 13 15:53:03.422935 kubelet[1748]: I0213 15:53:03.420854 1748 state_mem.go:35] "Initializing new in-memory state store" Feb 13 15:53:03.444393 kubelet[1748]: I0213 15:53:03.444330 1748 kubelet_node_status.go:76] "Successfully registered node" node="161.35.231.245" Feb 13 15:53:03.480911 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Feb 13 15:53:03.526016 kubelet[1748]: E0213 15:53:03.524239 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:03.527858 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Feb 13 15:53:03.555780 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Feb 13 15:53:03.581020 kubelet[1748]: I0213 15:53:03.579965 1748 manager.go:479] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Feb 13 15:53:03.581020 kubelet[1748]: I0213 15:53:03.580387 1748 container_log_manager.go:186] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Feb 13 15:53:03.581020 kubelet[1748]: I0213 15:53:03.580628 1748 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Feb 13 15:53:03.590428 kubelet[1748]: E0213 15:53:03.590083 1748 eviction_manager.go:282] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"161.35.231.245\" not found" Feb 13 15:53:03.596382 kubelet[1748]: I0213 15:53:03.596102 1748 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Feb 13 15:53:03.603307 kubelet[1748]: I0213 15:53:03.603174 1748 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Feb 13 15:53:03.603307 kubelet[1748]: I0213 15:53:03.603229 1748 status_manager.go:217] "Starting to sync pod status with apiserver" Feb 13 15:53:03.603307 kubelet[1748]: I0213 15:53:03.603262 1748 kubelet.go:2337] "Starting kubelet main sync loop" Feb 13 15:53:03.603592 kubelet[1748]: E0213 15:53:03.603339 1748 kubelet.go:2361] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Feb 13 15:53:03.634121 kubelet[1748]: E0213 15:53:03.626696 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:03.730950 kubelet[1748]: E0213 15:53:03.727143 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:03.777623 sudo[1617]: pam_unix(sudo:session): session closed for user root Feb 13 15:53:03.793492 sshd[1616]: Connection closed by 139.178.89.65 port 42402 Feb 13 15:53:03.791311 sshd-session[1614]: pam_unix(sshd:session): session closed for user core Feb 13 15:53:03.803157 systemd[1]: sshd@5-161.35.231.245:22-139.178.89.65:42402.service: Deactivated successfully. Feb 13 15:53:03.807296 systemd[1]: session-5.scope: Deactivated successfully. Feb 13 15:53:03.818861 systemd-logind[1452]: Session 5 logged out. Waiting for processes to exit. Feb 13 15:53:03.821434 systemd-logind[1452]: Removed session 5. Feb 13 15:53:03.827626 kubelet[1748]: E0213 15:53:03.827539 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:03.929291 kubelet[1748]: E0213 15:53:03.929086 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.030291 kubelet[1748]: E0213 15:53:04.029924 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.130417 kubelet[1748]: E0213 15:53:04.130210 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.146354 kubelet[1748]: I0213 15:53:04.145675 1748 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Feb 13 15:53:04.146354 kubelet[1748]: W0213 15:53:04.146069 1748 reflector.go:470] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Feb 13 15:53:04.146354 kubelet[1748]: W0213 15:53:04.146181 1748 reflector.go:470] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received Feb 13 15:53:04.231154 kubelet[1748]: E0213 15:53:04.230991 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.252138 kubelet[1748]: E0213 15:53:04.251988 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:04.332022 kubelet[1748]: E0213 15:53:04.331733 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.432572 kubelet[1748]: E0213 15:53:04.432460 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.533004 kubelet[1748]: E0213 15:53:04.532828 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.634034 kubelet[1748]: E0213 15:53:04.633722 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.735100 kubelet[1748]: E0213 15:53:04.734946 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.835978 kubelet[1748]: E0213 15:53:04.835854 1748 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"161.35.231.245\" not found" Feb 13 15:53:04.938496 kubelet[1748]: I0213 15:53:04.938114 1748 kuberuntime_manager.go:1523] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Feb 13 15:53:04.939387 containerd[1464]: time="2025-02-13T15:53:04.939196234Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Feb 13 15:53:04.940166 kubelet[1748]: I0213 15:53:04.939814 1748 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Feb 13 15:53:05.252844 kubelet[1748]: E0213 15:53:05.252285 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:05.252844 kubelet[1748]: I0213 15:53:05.252314 1748 apiserver.go:52] "Watching apiserver" Feb 13 15:53:05.272940 kubelet[1748]: I0213 15:53:05.260576 1748 topology_manager.go:215] "Topology Admit Handler" podUID="84fdc63f-887b-496a-acf0-1d42025b0abf" podNamespace="kube-flannel" podName="kube-flannel-ds-k6smc" Feb 13 15:53:05.273684 kubelet[1748]: I0213 15:53:05.273451 1748 topology_manager.go:215] "Topology Admit Handler" podUID="05819f9d-8891-43a0-9c66-2e1be3548a5a" podNamespace="kube-system" podName="kube-proxy-bxhcc" Feb 13 15:53:05.304105 systemd[1]: Created slice kubepods-besteffort-pod05819f9d_8891_43a0_9c66_2e1be3548a5a.slice - libcontainer container kubepods-besteffort-pod05819f9d_8891_43a0_9c66_2e1be3548a5a.slice. Feb 13 15:53:05.324314 kubelet[1748]: I0213 15:53:05.322904 1748 desired_state_of_world_populator.go:157] "Finished populating initial desired state of world" Feb 13 15:53:05.338685 kubelet[1748]: I0213 15:53:05.336019 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/84fdc63f-887b-496a-acf0-1d42025b0abf-flannel-cfg\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.338685 kubelet[1748]: I0213 15:53:05.336070 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/84fdc63f-887b-496a-acf0-1d42025b0abf-xtables-lock\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.338685 kubelet[1748]: I0213 15:53:05.336103 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-pmfcx\" (UniqueName: \"kubernetes.io/projected/84fdc63f-887b-496a-acf0-1d42025b0abf-kube-api-access-pmfcx\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.338685 kubelet[1748]: I0213 15:53:05.336137 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/05819f9d-8891-43a0-9c66-2e1be3548a5a-xtables-lock\") pod \"kube-proxy-bxhcc\" (UID: \"05819f9d-8891-43a0-9c66-2e1be3548a5a\") " pod="kube-system/kube-proxy-bxhcc" Feb 13 15:53:05.338685 kubelet[1748]: I0213 15:53:05.336170 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-gc22h\" (UniqueName: \"kubernetes.io/projected/05819f9d-8891-43a0-9c66-2e1be3548a5a-kube-api-access-gc22h\") pod \"kube-proxy-bxhcc\" (UID: \"05819f9d-8891-43a0-9c66-2e1be3548a5a\") " pod="kube-system/kube-proxy-bxhcc" Feb 13 15:53:05.339043 kubelet[1748]: I0213 15:53:05.336196 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/84fdc63f-887b-496a-acf0-1d42025b0abf-run\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.339043 kubelet[1748]: I0213 15:53:05.336223 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/84fdc63f-887b-496a-acf0-1d42025b0abf-cni-plugin\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.339043 kubelet[1748]: I0213 15:53:05.336246 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/05819f9d-8891-43a0-9c66-2e1be3548a5a-lib-modules\") pod \"kube-proxy-bxhcc\" (UID: \"05819f9d-8891-43a0-9c66-2e1be3548a5a\") " pod="kube-system/kube-proxy-bxhcc" Feb 13 15:53:05.339043 kubelet[1748]: I0213 15:53:05.336284 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/84fdc63f-887b-496a-acf0-1d42025b0abf-cni\") pod \"kube-flannel-ds-k6smc\" (UID: \"84fdc63f-887b-496a-acf0-1d42025b0abf\") " pod="kube-flannel/kube-flannel-ds-k6smc" Feb 13 15:53:05.339043 kubelet[1748]: I0213 15:53:05.336309 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/05819f9d-8891-43a0-9c66-2e1be3548a5a-kube-proxy\") pod \"kube-proxy-bxhcc\" (UID: \"05819f9d-8891-43a0-9c66-2e1be3548a5a\") " pod="kube-system/kube-proxy-bxhcc" Feb 13 15:53:05.358687 systemd[1]: Created slice kubepods-burstable-pod84fdc63f_887b_496a_acf0_1d42025b0abf.slice - libcontainer container kubepods-burstable-pod84fdc63f_887b_496a_acf0_1d42025b0abf.slice. Feb 13 15:53:05.638652 kubelet[1748]: E0213 15:53:05.637162 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:05.643412 containerd[1464]: time="2025-02-13T15:53:05.641322442Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-bxhcc,Uid:05819f9d-8891-43a0-9c66-2e1be3548a5a,Namespace:kube-system,Attempt:0,}" Feb 13 15:53:05.678108 kubelet[1748]: E0213 15:53:05.677870 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:05.679872 containerd[1464]: time="2025-02-13T15:53:05.679739732Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k6smc,Uid:84fdc63f-887b-496a-acf0-1d42025b0abf,Namespace:kube-flannel,Attempt:0,}" Feb 13 15:53:06.252877 kubelet[1748]: E0213 15:53:06.252671 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:06.393108 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2466256093.mount: Deactivated successfully. Feb 13 15:53:06.427064 containerd[1464]: time="2025-02-13T15:53:06.426715916Z" 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\"}" Feb 13 15:53:06.433176 containerd[1464]: time="2025-02-13T15:53:06.432395100Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312056" Feb 13 15:53:06.438150 containerd[1464]: time="2025-02-13T15:53:06.438062576Z" 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\"}" Feb 13 15:53:06.440318 containerd[1464]: time="2025-02-13T15:53:06.440044350Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Feb 13 15:53:06.441324 containerd[1464]: time="2025-02-13T15:53:06.441198064Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Feb 13 15:53:06.452959 containerd[1464]: time="2025-02-13T15:53:06.452623257Z" 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\"}" Feb 13 15:53:06.456037 containerd[1464]: time="2025-02-13T15:53:06.455979636Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 775.987685ms" Feb 13 15:53:06.459503 containerd[1464]: time="2025-02-13T15:53:06.459444001Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 817.918524ms" Feb 13 15:53:06.758494 containerd[1464]: time="2025-02-13T15:53:06.758343860Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 15:53:06.760426 containerd[1464]: time="2025-02-13T15:53:06.759336239Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 15:53:06.760426 containerd[1464]: time="2025-02-13T15:53:06.759452351Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:06.761168 containerd[1464]: time="2025-02-13T15:53:06.760108109Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 15:53:06.761168 containerd[1464]: time="2025-02-13T15:53:06.760195857Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 15:53:06.761168 containerd[1464]: time="2025-02-13T15:53:06.760220642Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:06.761168 containerd[1464]: time="2025-02-13T15:53:06.760369237Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:06.761168 containerd[1464]: time="2025-02-13T15:53:06.760469056Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:06.961190 systemd[1]: Started cri-containerd-4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89.scope - libcontainer container 4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89. Feb 13 15:53:06.984922 systemd[1]: Started cri-containerd-705768e8a671bad84063b26eaec06e0175b3b4d86db1bf6b2befe588dd9de3f0.scope - libcontainer container 705768e8a671bad84063b26eaec06e0175b3b4d86db1bf6b2befe588dd9de3f0. Feb 13 15:53:07.092843 containerd[1464]: time="2025-02-13T15:53:07.092651603Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-bxhcc,Uid:05819f9d-8891-43a0-9c66-2e1be3548a5a,Namespace:kube-system,Attempt:0,} returns sandbox id \"705768e8a671bad84063b26eaec06e0175b3b4d86db1bf6b2befe588dd9de3f0\"" Feb 13 15:53:07.103323 kubelet[1748]: E0213 15:53:07.102711 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:07.109553 containerd[1464]: time="2025-02-13T15:53:07.109102506Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.10\"" Feb 13 15:53:07.120410 containerd[1464]: time="2025-02-13T15:53:07.120151997Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-k6smc,Uid:84fdc63f-887b-496a-acf0-1d42025b0abf,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\"" Feb 13 15:53:07.126902 kubelet[1748]: E0213 15:53:07.126157 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:07.253960 kubelet[1748]: E0213 15:53:07.253870 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:08.255063 kubelet[1748]: E0213 15:53:08.254986 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:09.056416 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1913029028.mount: Deactivated successfully. Feb 13 15:53:09.258946 kubelet[1748]: E0213 15:53:09.258828 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:10.263679 kubelet[1748]: E0213 15:53:10.263600 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:10.628784 containerd[1464]: time="2025-02-13T15:53:10.627812808Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.30.10\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:10.631054 containerd[1464]: time="2025-02-13T15:53:10.630017006Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.30.10: active requests=0, bytes read=29057858" Feb 13 15:53:10.631603 containerd[1464]: time="2025-02-13T15:53:10.631504224Z" level=info msg="ImageCreate event name:\"sha256:a21d1b47e857207628486a387f670f224051a16b74b06a1b76d07a96e738ab54\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:10.634930 containerd[1464]: time="2025-02-13T15:53:10.634582335Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:d112e804e548fce28d9f1e3282c9ce54e374451e6a2c41b1ca9d7fca5d1fcc48\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:10.636169 containerd[1464]: time="2025-02-13T15:53:10.635579845Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.30.10\" with image id \"sha256:a21d1b47e857207628486a387f670f224051a16b74b06a1b76d07a96e738ab54\", repo tag \"registry.k8s.io/kube-proxy:v1.30.10\", repo digest \"registry.k8s.io/kube-proxy@sha256:d112e804e548fce28d9f1e3282c9ce54e374451e6a2c41b1ca9d7fca5d1fcc48\", size \"29056877\" in 3.526413611s" Feb 13 15:53:10.636169 containerd[1464]: time="2025-02-13T15:53:10.635642636Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.10\" returns image reference \"sha256:a21d1b47e857207628486a387f670f224051a16b74b06a1b76d07a96e738ab54\"" Feb 13 15:53:10.640059 containerd[1464]: time="2025-02-13T15:53:10.638697221Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Feb 13 15:53:10.641079 containerd[1464]: time="2025-02-13T15:53:10.641035786Z" level=info msg="CreateContainer within sandbox \"705768e8a671bad84063b26eaec06e0175b3b4d86db1bf6b2befe588dd9de3f0\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Feb 13 15:53:10.700046 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount374857252.mount: Deactivated successfully. Feb 13 15:53:10.734840 containerd[1464]: time="2025-02-13T15:53:10.734568567Z" level=info msg="CreateContainer within sandbox \"705768e8a671bad84063b26eaec06e0175b3b4d86db1bf6b2befe588dd9de3f0\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893\"" Feb 13 15:53:10.736954 containerd[1464]: time="2025-02-13T15:53:10.736217356Z" level=info msg="StartContainer for \"8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893\"" Feb 13 15:53:10.874587 systemd[1]: run-containerd-runc-k8s.io-8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893-runc.BjdAQL.mount: Deactivated successfully. Feb 13 15:53:10.901856 systemd[1]: Started cri-containerd-8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893.scope - libcontainer container 8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893. Feb 13 15:53:10.985520 containerd[1464]: time="2025-02-13T15:53:10.985234506Z" level=info msg="StartContainer for \"8dc5215ee4ec323c4c2d1388f206fd40269cea27805ecebf6f5e5587c0ff6893\" returns successfully" Feb 13 15:53:11.264926 kubelet[1748]: E0213 15:53:11.264833 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:11.676730 kubelet[1748]: E0213 15:53:11.675077 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:11.778711 systemd-resolved[1325]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 67.207.67.2. Feb 13 15:53:12.265183 kubelet[1748]: E0213 15:53:12.265132 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:12.680291 kubelet[1748]: E0213 15:53:12.679587 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:13.266118 kubelet[1748]: E0213 15:53:13.266065 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:13.477871 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount786194070.mount: Deactivated successfully. Feb 13 15:53:13.600399 containerd[1464]: time="2025-02-13T15:53:13.599139548Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:13.600399 containerd[1464]: time="2025-02-13T15:53:13.600219719Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852937" Feb 13 15:53:13.602545 containerd[1464]: time="2025-02-13T15:53:13.602489572Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:13.619738 containerd[1464]: time="2025-02-13T15:53:13.619689748Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:13.624916 containerd[1464]: time="2025-02-13T15:53:13.624611760Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3842055\" in 2.985859212s" Feb 13 15:53:13.625353 containerd[1464]: time="2025-02-13T15:53:13.625151115Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Feb 13 15:53:13.642155 containerd[1464]: time="2025-02-13T15:53:13.641856405Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Feb 13 15:53:13.679437 containerd[1464]: time="2025-02-13T15:53:13.679356765Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d\"" Feb 13 15:53:13.683935 containerd[1464]: time="2025-02-13T15:53:13.681946052Z" level=info msg="StartContainer for \"141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d\"" Feb 13 15:53:13.752225 systemd[1]: Started cri-containerd-141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d.scope - libcontainer container 141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d. Feb 13 15:53:13.804589 containerd[1464]: time="2025-02-13T15:53:13.804520676Z" level=info msg="StartContainer for \"141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d\" returns successfully" Feb 13 15:53:13.807090 systemd[1]: cri-containerd-141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d.scope: Deactivated successfully. Feb 13 15:53:13.954291 containerd[1464]: time="2025-02-13T15:53:13.953823280Z" level=info msg="shim disconnected" id=141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d namespace=k8s.io Feb 13 15:53:13.954291 containerd[1464]: time="2025-02-13T15:53:13.953898368Z" level=warning msg="cleaning up after shim disconnected" id=141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d namespace=k8s.io Feb 13 15:53:13.954291 containerd[1464]: time="2025-02-13T15:53:13.953908190Z" level=info msg="cleaning up dead shim" namespace=k8s.io Feb 13 15:53:13.998230 containerd[1464]: time="2025-02-13T15:53:13.997825223Z" level=warning msg="cleanup warnings time=\"2025-02-13T15:53:13Z\" 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 Feb 13 15:53:14.228514 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-141c74bfdd9a199ff639d70e947eb103017307c1ebc9cd76372a31c64d0b1d9d-rootfs.mount: Deactivated successfully. Feb 13 15:53:14.266551 kubelet[1748]: E0213 15:53:14.266493 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:14.717659 kubelet[1748]: E0213 15:53:14.717476 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:14.721501 containerd[1464]: time="2025-02-13T15:53:14.721220726Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Feb 13 15:53:14.751199 kubelet[1748]: I0213 15:53:14.750251 1748 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-bxhcc" podStartSLOduration=8.219134547 podStartE2EDuration="11.750213389s" podCreationTimestamp="2025-02-13 15:53:03 +0000 UTC" firstStartedPulling="2025-02-13 15:53:07.106326294 +0000 UTC m=+4.895625677" lastFinishedPulling="2025-02-13 15:53:10.637405111 +0000 UTC m=+8.426704519" observedRunningTime="2025-02-13 15:53:11.691845995 +0000 UTC m=+9.481145407" watchObservedRunningTime="2025-02-13 15:53:14.750213389 +0000 UTC m=+12.539512801" Feb 13 15:53:14.849264 systemd-resolved[1325]: Using degraded feature set UDP instead of UDP+EDNS0 for DNS server 67.207.67.3. Feb 13 15:53:15.268257 kubelet[1748]: E0213 15:53:15.268157 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:16.268565 kubelet[1748]: E0213 15:53:16.268462 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:17.269647 kubelet[1748]: E0213 15:53:17.269537 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:17.797407 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2903360320.mount: Deactivated successfully. Feb 13 15:53:17.922255 systemd-resolved[1325]: Using degraded feature set TCP instead of UDP for DNS server 67.207.67.2. Feb 13 15:53:18.270335 kubelet[1748]: E0213 15:53:18.270278 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:18.775251 systemd-timesyncd[1342]: Contacted time server 148.113.194.34:123 (2.flatcar.pool.ntp.org). Feb 13 15:53:18.775685 systemd-timesyncd[1342]: Initial clock synchronization to Thu 2025-02-13 15:53:19.116879 UTC. Feb 13 15:53:19.273967 kubelet[1748]: E0213 15:53:19.272248 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:20.272429 kubelet[1748]: E0213 15:53:20.272372 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:20.360858 containerd[1464]: time="2025-02-13T15:53:20.360768389Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:20.363327 containerd[1464]: time="2025-02-13T15:53:20.363247788Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866358" Feb 13 15:53:20.365480 containerd[1464]: time="2025-02-13T15:53:20.365393800Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:20.373182 containerd[1464]: time="2025-02-13T15:53:20.372967959Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:20.377965 containerd[1464]: time="2025-02-13T15:53:20.377035978Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26855532\" in 5.655743029s" Feb 13 15:53:20.377965 containerd[1464]: time="2025-02-13T15:53:20.377152147Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Feb 13 15:53:20.383665 containerd[1464]: time="2025-02-13T15:53:20.383586994Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Feb 13 15:53:20.444559 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount877178041.mount: Deactivated successfully. Feb 13 15:53:20.474037 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4176961135.mount: Deactivated successfully. Feb 13 15:53:20.490911 containerd[1464]: time="2025-02-13T15:53:20.490824162Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba\"" Feb 13 15:53:20.496550 containerd[1464]: time="2025-02-13T15:53:20.495434981Z" level=info msg="StartContainer for \"f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba\"" Feb 13 15:53:20.607747 systemd[1]: Started cri-containerd-f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba.scope - libcontainer container f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba. Feb 13 15:53:20.714095 systemd[1]: cri-containerd-f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba.scope: Deactivated successfully. Feb 13 15:53:20.745986 containerd[1464]: time="2025-02-13T15:53:20.734342075Z" level=info msg="StartContainer for \"f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba\" returns successfully" Feb 13 15:53:20.799486 kubelet[1748]: E0213 15:53:20.799431 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:20.825799 kubelet[1748]: I0213 15:53:20.825743 1748 kubelet_node_status.go:497] "Fast updating node status as it just became ready" Feb 13 15:53:21.000022 containerd[1464]: time="2025-02-13T15:53:20.981672722Z" level=info msg="shim disconnected" id=f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba namespace=k8s.io Feb 13 15:53:21.000022 containerd[1464]: time="2025-02-13T15:53:20.995869611Z" level=warning msg="cleaning up after shim disconnected" id=f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba namespace=k8s.io Feb 13 15:53:21.000022 containerd[1464]: time="2025-02-13T15:53:20.995957006Z" level=info msg="cleaning up dead shim" namespace=k8s.io Feb 13 15:53:21.273200 kubelet[1748]: E0213 15:53:21.272965 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:21.413860 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-f839ce1b7831fcb29c16b074ed21cec8357c4a7865efd7de34dadb5acaca84ba-rootfs.mount: Deactivated successfully. Feb 13 15:53:21.809787 kubelet[1748]: E0213 15:53:21.808489 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:21.819091 containerd[1464]: time="2025-02-13T15:53:21.816464281Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Feb 13 15:53:21.866354 containerd[1464]: time="2025-02-13T15:53:21.863385877Z" level=info msg="CreateContainer within sandbox \"4f70bb5e80e86731afc77691edb6a87eb4effa2bcc0ae467f733a2ef3c59af89\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"f810dbbe48b6d7ec1be1d1189f6c6bec9ef7aa46d94da266be3afd1eb1954159\"" Feb 13 15:53:21.868114 containerd[1464]: time="2025-02-13T15:53:21.868014586Z" level=info msg="StartContainer for \"f810dbbe48b6d7ec1be1d1189f6c6bec9ef7aa46d94da266be3afd1eb1954159\"" Feb 13 15:53:21.989316 systemd[1]: Started cri-containerd-f810dbbe48b6d7ec1be1d1189f6c6bec9ef7aa46d94da266be3afd1eb1954159.scope - libcontainer container f810dbbe48b6d7ec1be1d1189f6c6bec9ef7aa46d94da266be3afd1eb1954159. Feb 13 15:53:22.135239 containerd[1464]: time="2025-02-13T15:53:22.133766719Z" level=info msg="StartContainer for \"f810dbbe48b6d7ec1be1d1189f6c6bec9ef7aa46d94da266be3afd1eb1954159\" returns successfully" Feb 13 15:53:22.273409 kubelet[1748]: E0213 15:53:22.273225 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:22.832339 kubelet[1748]: E0213 15:53:22.832212 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:23.244921 kubelet[1748]: E0213 15:53:23.244808 1748 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:23.274672 kubelet[1748]: E0213 15:53:23.274425 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:23.277503 systemd-networkd[1381]: flannel.1: Link UP Feb 13 15:53:23.277512 systemd-networkd[1381]: flannel.1: Gained carrier Feb 13 15:53:23.835922 kubelet[1748]: E0213 15:53:23.835227 1748 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 67.207.67.2 67.207.67.3 67.207.67.2" Feb 13 15:53:24.275942 kubelet[1748]: E0213 15:53:24.275139 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:24.516203 systemd-networkd[1381]: flannel.1: Gained IPv6LL Feb 13 15:53:25.276255 kubelet[1748]: E0213 15:53:25.276137 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:26.277297 kubelet[1748]: E0213 15:53:26.277198 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:26.445351 kubelet[1748]: I0213 15:53:26.445086 1748 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-k6smc" podStartSLOduration=10.19226093 podStartE2EDuration="23.445028059s" podCreationTimestamp="2025-02-13 15:53:03 +0000 UTC" firstStartedPulling="2025-02-13 15:53:07.127698779 +0000 UTC m=+4.916998160" lastFinishedPulling="2025-02-13 15:53:20.380465903 +0000 UTC m=+18.169765289" observedRunningTime="2025-02-13 15:53:22.859905738 +0000 UTC m=+20.649205147" watchObservedRunningTime="2025-02-13 15:53:26.445028059 +0000 UTC m=+24.234327464" Feb 13 15:53:26.446087 kubelet[1748]: I0213 15:53:26.446024 1748 topology_manager.go:215] "Topology Admit Handler" podUID="b2815a1f-3c60-4d6a-b9a8-3b81dcea6d2e" podNamespace="default" podName="nginx-deployment-85f456d6dd-jd2zn" Feb 13 15:53:26.465425 systemd[1]: Created slice kubepods-besteffort-podb2815a1f_3c60_4d6a_b9a8_3b81dcea6d2e.slice - libcontainer container kubepods-besteffort-podb2815a1f_3c60_4d6a_b9a8_3b81dcea6d2e.slice. Feb 13 15:53:26.483522 kubelet[1748]: I0213 15:53:26.483333 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-j2z4k\" (UniqueName: \"kubernetes.io/projected/b2815a1f-3c60-4d6a-b9a8-3b81dcea6d2e-kube-api-access-j2z4k\") pod \"nginx-deployment-85f456d6dd-jd2zn\" (UID: \"b2815a1f-3c60-4d6a-b9a8-3b81dcea6d2e\") " pod="default/nginx-deployment-85f456d6dd-jd2zn" Feb 13 15:53:26.772458 containerd[1464]: time="2025-02-13T15:53:26.772309080Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-jd2zn,Uid:b2815a1f-3c60-4d6a-b9a8-3b81dcea6d2e,Namespace:default,Attempt:0,}" Feb 13 15:53:26.877489 systemd-networkd[1381]: cni0: Link UP Feb 13 15:53:26.877505 systemd-networkd[1381]: cni0: Gained carrier Feb 13 15:53:26.881452 systemd-networkd[1381]: cni0: Lost carrier Feb 13 15:53:26.897725 systemd-networkd[1381]: vethb7c7e25f: Link UP Feb 13 15:53:26.902757 kernel: cni0: port 1(vethb7c7e25f) entered blocking state Feb 13 15:53:26.905193 kernel: cni0: port 1(vethb7c7e25f) entered disabled state Feb 13 15:53:26.905635 kernel: vethb7c7e25f: entered allmulticast mode Feb 13 15:53:26.905670 kernel: vethb7c7e25f: entered promiscuous mode Feb 13 15:53:26.909627 kernel: cni0: port 1(vethb7c7e25f) entered blocking state Feb 13 15:53:26.910238 kernel: cni0: port 1(vethb7c7e25f) entered forwarding state Feb 13 15:53:26.910323 kernel: cni0: port 1(vethb7c7e25f) entered disabled state Feb 13 15:53:26.957466 kernel: cni0: port 1(vethb7c7e25f) entered blocking state Feb 13 15:53:26.961364 kernel: cni0: port 1(vethb7c7e25f) entered forwarding state Feb 13 15:53:26.960569 systemd-networkd[1381]: vethb7c7e25f: Gained carrier Feb 13 15:53:26.961010 systemd-networkd[1381]: cni0: Gained carrier Feb 13 15:53:26.973307 containerd[1464]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc000018938), "name":"cbr0", "type":"bridge"} Feb 13 15:53:26.973307 containerd[1464]: delegateAdd: netconf sent to delegate plugin: Feb 13 15:53:27.047397 containerd[1464]: {"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="2025-02-13T15:53:27.043477783Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 15:53:27.047397 containerd[1464]: time="2025-02-13T15:53:27.043578101Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 15:53:27.047397 containerd[1464]: time="2025-02-13T15:53:27.043598959Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:27.047397 containerd[1464]: time="2025-02-13T15:53:27.043754124Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:27.118693 systemd[1]: Started cri-containerd-e7af953859834d22d06e5ea18599010db110d077d401c993c6045a774f0f7194.scope - libcontainer container e7af953859834d22d06e5ea18599010db110d077d401c993c6045a774f0f7194. Feb 13 15:53:27.249500 containerd[1464]: time="2025-02-13T15:53:27.249456133Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-jd2zn,Uid:b2815a1f-3c60-4d6a-b9a8-3b81dcea6d2e,Namespace:default,Attempt:0,} returns sandbox id \"e7af953859834d22d06e5ea18599010db110d077d401c993c6045a774f0f7194\"" Feb 13 15:53:27.261294 containerd[1464]: time="2025-02-13T15:53:27.260303900Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Feb 13 15:53:27.278815 kubelet[1748]: E0213 15:53:27.278703 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:28.161462 systemd-networkd[1381]: vethb7c7e25f: Gained IPv6LL Feb 13 15:53:28.280254 kubelet[1748]: E0213 15:53:28.280127 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:28.676582 systemd-networkd[1381]: cni0: Gained IPv6LL Feb 13 15:53:29.280973 kubelet[1748]: E0213 15:53:29.280846 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:30.283462 kubelet[1748]: E0213 15:53:30.283346 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:31.284545 kubelet[1748]: E0213 15:53:31.284386 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:31.948810 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount185631681.mount: Deactivated successfully. Feb 13 15:53:32.284909 kubelet[1748]: E0213 15:53:32.284643 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:32.595394 update_engine[1453]: I20250213 15:53:32.593111 1453 update_attempter.cc:509] Updating boot flags... Feb 13 15:53:32.730378 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2424) Feb 13 15:53:32.907373 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2422) Feb 13 15:53:33.035436 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2422) Feb 13 15:53:33.285166 kubelet[1748]: E0213 15:53:33.285005 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:34.286533 kubelet[1748]: E0213 15:53:34.286463 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:35.289279 kubelet[1748]: E0213 15:53:35.289202 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:35.444371 containerd[1464]: time="2025-02-13T15:53:35.442580771Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:35.446762 containerd[1464]: time="2025-02-13T15:53:35.446614612Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=73054493" Feb 13 15:53:35.450929 containerd[1464]: time="2025-02-13T15:53:35.450130603Z" level=info msg="ImageCreate event name:\"sha256:fe94eb5f0c9c8d0ca277aa8cd5940f1faf5970175bf373932babc578545deda8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:35.455383 containerd[1464]: time="2025-02-13T15:53:35.455313141Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:d9bc3da999da9f147f1277c7b18292486847e8f39f95fcf81d914d0c22815faf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:35.457416 containerd[1464]: time="2025-02-13T15:53:35.457288746Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fe94eb5f0c9c8d0ca277aa8cd5940f1faf5970175bf373932babc578545deda8\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:d9bc3da999da9f147f1277c7b18292486847e8f39f95fcf81d914d0c22815faf\", size \"73054371\" in 8.196916248s" Feb 13 15:53:35.457635 containerd[1464]: time="2025-02-13T15:53:35.457611158Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fe94eb5f0c9c8d0ca277aa8cd5940f1faf5970175bf373932babc578545deda8\"" Feb 13 15:53:35.464514 containerd[1464]: time="2025-02-13T15:53:35.463984397Z" level=info msg="CreateContainer within sandbox \"e7af953859834d22d06e5ea18599010db110d077d401c993c6045a774f0f7194\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Feb 13 15:53:35.489698 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3761799214.mount: Deactivated successfully. Feb 13 15:53:35.494322 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount309181874.mount: Deactivated successfully. Feb 13 15:53:35.503270 containerd[1464]: time="2025-02-13T15:53:35.503052779Z" level=info msg="CreateContainer within sandbox \"e7af953859834d22d06e5ea18599010db110d077d401c993c6045a774f0f7194\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357\"" Feb 13 15:53:35.506526 containerd[1464]: time="2025-02-13T15:53:35.504051878Z" level=info msg="StartContainer for \"c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357\"" Feb 13 15:53:35.578388 systemd[1]: Started cri-containerd-c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357.scope - libcontainer container c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357. Feb 13 15:53:35.637855 containerd[1464]: time="2025-02-13T15:53:35.637718270Z" level=info msg="StartContainer for \"c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357\" returns successfully" Feb 13 15:53:36.290217 kubelet[1748]: E0213 15:53:36.290126 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:36.487883 systemd[1]: run-containerd-runc-k8s.io-c762949d62788816f5ea072cbec76c82f8e49ecbb9146112989a03cf64b1a357-runc.yB8yJB.mount: Deactivated successfully. Feb 13 15:53:37.291285 kubelet[1748]: E0213 15:53:37.291162 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:38.292237 kubelet[1748]: E0213 15:53:38.292104 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:39.293128 kubelet[1748]: E0213 15:53:39.293018 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:40.299034 kubelet[1748]: E0213 15:53:40.295111 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:40.623351 kubelet[1748]: I0213 15:53:40.622090 1748 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-85f456d6dd-jd2zn" podStartSLOduration=6.419064376 podStartE2EDuration="14.622044803s" podCreationTimestamp="2025-02-13 15:53:26 +0000 UTC" firstStartedPulling="2025-02-13 15:53:27.258442713 +0000 UTC m=+25.047742094" lastFinishedPulling="2025-02-13 15:53:35.461423105 +0000 UTC m=+33.250722521" observedRunningTime="2025-02-13 15:53:36.025695085 +0000 UTC m=+33.814994494" watchObservedRunningTime="2025-02-13 15:53:40.622044803 +0000 UTC m=+38.411344210" Feb 13 15:53:40.623351 kubelet[1748]: I0213 15:53:40.622284 1748 topology_manager.go:215] "Topology Admit Handler" podUID="7dbc0f1b-6d48-46be-961c-2494de2fa703" podNamespace="default" podName="nfs-server-provisioner-0" Feb 13 15:53:40.632216 systemd[1]: Created slice kubepods-besteffort-pod7dbc0f1b_6d48_46be_961c_2494de2fa703.slice - libcontainer container kubepods-besteffort-pod7dbc0f1b_6d48_46be_961c_2494de2fa703.slice. Feb 13 15:53:40.711376 kubelet[1748]: I0213 15:53:40.711183 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/7dbc0f1b-6d48-46be-961c-2494de2fa703-data\") pod \"nfs-server-provisioner-0\" (UID: \"7dbc0f1b-6d48-46be-961c-2494de2fa703\") " pod="default/nfs-server-provisioner-0" Feb 13 15:53:40.711376 kubelet[1748]: I0213 15:53:40.711243 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-fd7gg\" (UniqueName: \"kubernetes.io/projected/7dbc0f1b-6d48-46be-961c-2494de2fa703-kube-api-access-fd7gg\") pod \"nfs-server-provisioner-0\" (UID: \"7dbc0f1b-6d48-46be-961c-2494de2fa703\") " pod="default/nfs-server-provisioner-0" Feb 13 15:53:40.946579 containerd[1464]: time="2025-02-13T15:53:40.946012949Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7dbc0f1b-6d48-46be-961c-2494de2fa703,Namespace:default,Attempt:0,}" Feb 13 15:53:41.034496 systemd-networkd[1381]: veth6424705d: Link UP Feb 13 15:53:41.040485 kernel: cni0: port 2(veth6424705d) entered blocking state Feb 13 15:53:41.040687 kernel: cni0: port 2(veth6424705d) entered disabled state Feb 13 15:53:41.043580 kernel: veth6424705d: entered allmulticast mode Feb 13 15:53:41.043692 kernel: veth6424705d: entered promiscuous mode Feb 13 15:53:41.056297 kernel: cni0: port 2(veth6424705d) entered blocking state Feb 13 15:53:41.056428 kernel: cni0: port 2(veth6424705d) entered forwarding state Feb 13 15:53:41.056825 systemd-networkd[1381]: veth6424705d: Gained carrier Feb 13 15:53:41.083965 containerd[1464]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00001c938), "name":"cbr0", "type":"bridge"} Feb 13 15:53:41.083965 containerd[1464]: delegateAdd: netconf sent to delegate plugin: Feb 13 15:53:41.152180 containerd[1464]: {"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="2025-02-13T15:53:41.151865244Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 15:53:41.152180 containerd[1464]: time="2025-02-13T15:53:41.152117997Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 15:53:41.152850 containerd[1464]: time="2025-02-13T15:53:41.152149971Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:41.152850 containerd[1464]: time="2025-02-13T15:53:41.152645722Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:53:41.240758 systemd[1]: Started cri-containerd-cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd.scope - libcontainer container cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd. Feb 13 15:53:41.308732 kubelet[1748]: E0213 15:53:41.308666 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:41.387388 containerd[1464]: time="2025-02-13T15:53:41.387322059Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:7dbc0f1b-6d48-46be-961c-2494de2fa703,Namespace:default,Attempt:0,} returns sandbox id \"cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd\"" Feb 13 15:53:41.394246 containerd[1464]: time="2025-02-13T15:53:41.391071057Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Feb 13 15:53:41.836431 systemd[1]: run-containerd-runc-k8s.io-cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd-runc.LpPp2J.mount: Deactivated successfully. Feb 13 15:53:42.311052 kubelet[1748]: E0213 15:53:42.310968 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:42.498763 systemd-networkd[1381]: veth6424705d: Gained IPv6LL Feb 13 15:53:43.279211 kubelet[1748]: E0213 15:53:43.246467 1748 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:43.312359 kubelet[1748]: E0213 15:53:43.312304 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:44.312908 kubelet[1748]: E0213 15:53:44.312804 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:45.313711 kubelet[1748]: E0213 15:53:45.313657 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:45.841556 systemd[1]: Started sshd@6-161.35.231.245:22-183.108.86.173:52840.service - OpenSSH per-connection server daemon (183.108.86.173:52840). Feb 13 15:53:46.303673 sshd[2653]: kex_exchange_identification: read: Connection reset by peer Feb 13 15:53:46.303673 sshd[2653]: Connection reset by 183.108.86.173 port 52840 Feb 13 15:53:46.305861 systemd[1]: sshd@6-161.35.231.245:22-183.108.86.173:52840.service: Deactivated successfully. Feb 13 15:53:46.314256 kubelet[1748]: E0213 15:53:46.314153 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:46.703602 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2558116087.mount: Deactivated successfully. Feb 13 15:53:47.315098 kubelet[1748]: E0213 15:53:47.315036 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:47.502644 systemd[1]: Started sshd@7-161.35.231.245:22-183.108.86.173:57684.service - OpenSSH per-connection server daemon (183.108.86.173:57684). Feb 13 15:53:48.317095 kubelet[1748]: E0213 15:53:48.317021 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:49.317773 kubelet[1748]: E0213 15:53:49.317653 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:50.319275 kubelet[1748]: E0213 15:53:50.318726 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:51.324203 kubelet[1748]: E0213 15:53:51.324145 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:52.091972 containerd[1464]: time="2025-02-13T15:53:52.091661070Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:52.096022 containerd[1464]: time="2025-02-13T15:53:52.094935048Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Feb 13 15:53:52.098938 containerd[1464]: time="2025-02-13T15:53:52.097660424Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:52.102039 containerd[1464]: time="2025-02-13T15:53:52.101969505Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:53:52.104326 containerd[1464]: time="2025-02-13T15:53:52.104259501Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 10.713129004s" Feb 13 15:53:52.104564 containerd[1464]: time="2025-02-13T15:53:52.104534711Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Feb 13 15:53:52.111258 containerd[1464]: time="2025-02-13T15:53:52.111196685Z" level=info msg="CreateContainer within sandbox \"cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Feb 13 15:53:52.135768 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3472694188.mount: Deactivated successfully. Feb 13 15:53:52.169762 containerd[1464]: time="2025-02-13T15:53:52.168965877Z" level=info msg="CreateContainer within sandbox \"cf3ecf43fab261fc0ec531f00dc495c570edc44875c93f2eb8ea396009ddfdcd\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55\"" Feb 13 15:53:52.175968 containerd[1464]: time="2025-02-13T15:53:52.173279614Z" level=info msg="StartContainer for \"9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55\"" Feb 13 15:53:52.269715 systemd[1]: run-containerd-runc-k8s.io-9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55-runc.7JebiS.mount: Deactivated successfully. Feb 13 15:53:52.285439 systemd[1]: Started cri-containerd-9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55.scope - libcontainer container 9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55. Feb 13 15:53:52.326252 kubelet[1748]: E0213 15:53:52.326143 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:52.348273 containerd[1464]: time="2025-02-13T15:53:52.346669888Z" level=info msg="StartContainer for \"9ff871358043fa4724d7408c34815de6dd85a39497b298c473cafc4982b21f55\" returns successfully" Feb 13 15:53:53.128414 kubelet[1748]: I0213 15:53:53.127669 1748 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.408943937 podStartE2EDuration="13.1276407s" podCreationTimestamp="2025-02-13 15:53:40 +0000 UTC" firstStartedPulling="2025-02-13 15:53:41.389651773 +0000 UTC m=+39.178951168" lastFinishedPulling="2025-02-13 15:53:52.108348533 +0000 UTC m=+49.897647931" observedRunningTime="2025-02-13 15:53:53.127426437 +0000 UTC m=+50.916725845" watchObservedRunningTime="2025-02-13 15:53:53.1276407 +0000 UTC m=+50.916940108" Feb 13 15:53:53.326492 kubelet[1748]: E0213 15:53:53.326396 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:53.654997 sshd[2661]: Invalid user odoo from 183.108.86.173 port 57684 Feb 13 15:53:54.152481 sshd[2661]: Connection closed by invalid user odoo 183.108.86.173 port 57684 [preauth] Feb 13 15:53:54.154819 systemd[1]: sshd@7-161.35.231.245:22-183.108.86.173:57684.service: Deactivated successfully. Feb 13 15:53:54.327718 kubelet[1748]: E0213 15:53:54.327637 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:55.033530 systemd[1]: Started sshd@8-161.35.231.245:22-183.108.86.173:42074.service - OpenSSH per-connection server daemon (183.108.86.173:42074). Feb 13 15:53:55.329861 kubelet[1748]: E0213 15:53:55.329586 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:56.330409 kubelet[1748]: E0213 15:53:56.330036 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:57.331456 kubelet[1748]: E0213 15:53:57.331386 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:58.332333 kubelet[1748]: E0213 15:53:58.332186 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:53:59.245980 sshd[2801]: Connection closed by authenticating user root 183.108.86.173 port 42074 [preauth] Feb 13 15:53:59.247694 systemd[1]: sshd@8-161.35.231.245:22-183.108.86.173:42074.service: Deactivated successfully. Feb 13 15:53:59.333504 kubelet[1748]: E0213 15:53:59.333406 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:00.333755 kubelet[1748]: E0213 15:54:00.333671 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:01.334745 kubelet[1748]: E0213 15:54:01.334655 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:02.335240 kubelet[1748]: E0213 15:54:02.335146 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:02.383948 kubelet[1748]: I0213 15:54:02.383228 1748 topology_manager.go:215] "Topology Admit Handler" podUID="fe9def45-0745-419d-8ff0-aaab80edd6ca" podNamespace="default" podName="test-pod-1" Feb 13 15:54:02.403394 systemd[1]: Created slice kubepods-besteffort-podfe9def45_0745_419d_8ff0_aaab80edd6ca.slice - libcontainer container kubepods-besteffort-podfe9def45_0745_419d_8ff0_aaab80edd6ca.slice. Feb 13 15:54:02.518943 kubelet[1748]: I0213 15:54:02.518125 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-0859a9e8-0120-4e94-ba1f-90b0c08d6c16\" (UniqueName: \"kubernetes.io/nfs/fe9def45-0745-419d-8ff0-aaab80edd6ca-pvc-0859a9e8-0120-4e94-ba1f-90b0c08d6c16\") pod \"test-pod-1\" (UID: \"fe9def45-0745-419d-8ff0-aaab80edd6ca\") " pod="default/test-pod-1" Feb 13 15:54:02.518943 kubelet[1748]: I0213 15:54:02.518207 1748 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rh6zs\" (UniqueName: \"kubernetes.io/projected/fe9def45-0745-419d-8ff0-aaab80edd6ca-kube-api-access-rh6zs\") pod \"test-pod-1\" (UID: \"fe9def45-0745-419d-8ff0-aaab80edd6ca\") " pod="default/test-pod-1" Feb 13 15:54:02.763071 kernel: FS-Cache: Loaded Feb 13 15:54:03.046269 kernel: RPC: Registered named UNIX socket transport module. Feb 13 15:54:03.046516 kernel: RPC: Registered udp transport module. Feb 13 15:54:03.046583 kernel: RPC: Registered tcp transport module. Feb 13 15:54:03.046611 kernel: RPC: Registered tcp-with-tls transport module. Feb 13 15:54:03.046642 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Feb 13 15:54:03.254159 kubelet[1748]: E0213 15:54:03.253965 1748 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:03.349925 kubelet[1748]: E0213 15:54:03.342948 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:03.612613 kernel: NFS: Registering the id_resolver key type Feb 13 15:54:03.615727 kernel: Key type id_resolver registered Feb 13 15:54:03.615914 kernel: Key type id_legacy registered Feb 13 15:54:03.822257 nfsidmap[2850]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain '1.1-1-15637b4b36' Feb 13 15:54:03.850647 nfsidmap[2851]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain '1.1-1-15637b4b36' Feb 13 15:54:03.918510 containerd[1464]: time="2025-02-13T15:54:03.914991442Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:fe9def45-0745-419d-8ff0-aaab80edd6ca,Namespace:default,Attempt:0,}" Feb 13 15:54:04.113411 kernel: cni0: port 3(veth3d7a5483) entered blocking state Feb 13 15:54:04.113546 kernel: cni0: port 3(veth3d7a5483) entered disabled state Feb 13 15:54:04.113575 kernel: veth3d7a5483: entered allmulticast mode Feb 13 15:54:04.113603 kernel: veth3d7a5483: entered promiscuous mode Feb 13 15:54:04.096635 systemd-networkd[1381]: veth3d7a5483: Link UP Feb 13 15:54:04.180047 kernel: cni0: port 3(veth3d7a5483) entered blocking state Feb 13 15:54:04.180338 kernel: cni0: port 3(veth3d7a5483) entered forwarding state Feb 13 15:54:04.204655 systemd-networkd[1381]: veth3d7a5483: Gained carrier Feb 13 15:54:04.235639 containerd[1464]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc00009a8e8), "name":"cbr0", "type":"bridge"} Feb 13 15:54:04.235639 containerd[1464]: delegateAdd: netconf sent to delegate plugin: Feb 13 15:54:04.353834 kubelet[1748]: E0213 15:54:04.353678 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:04.445338 containerd[1464]: {"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="2025-02-13T15:54:04.443391997Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Feb 13 15:54:04.445338 containerd[1464]: time="2025-02-13T15:54:04.443520354Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Feb 13 15:54:04.445338 containerd[1464]: time="2025-02-13T15:54:04.443575052Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:54:04.445338 containerd[1464]: time="2025-02-13T15:54:04.443718476Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Feb 13 15:54:04.601580 systemd[1]: Started cri-containerd-1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4.scope - libcontainer container 1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4. Feb 13 15:54:04.753227 containerd[1464]: time="2025-02-13T15:54:04.752550054Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:fe9def45-0745-419d-8ff0-aaab80edd6ca,Namespace:default,Attempt:0,} returns sandbox id \"1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4\"" Feb 13 15:54:04.756955 containerd[1464]: time="2025-02-13T15:54:04.756879266Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Feb 13 15:54:04.864427 systemd[1]: run-containerd-runc-k8s.io-1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4-runc.TEP5TT.mount: Deactivated successfully. Feb 13 15:54:05.355937 kubelet[1748]: E0213 15:54:05.353838 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:05.359986 containerd[1464]: time="2025-02-13T15:54:05.354117816Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Feb 13 15:54:05.369611 containerd[1464]: time="2025-02-13T15:54:05.362485593Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Feb 13 15:54:05.377109 containerd[1464]: time="2025-02-13T15:54:05.374878367Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fe94eb5f0c9c8d0ca277aa8cd5940f1faf5970175bf373932babc578545deda8\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:d9bc3da999da9f147f1277c7b18292486847e8f39f95fcf81d914d0c22815faf\", size \"73054371\" in 617.706556ms" Feb 13 15:54:05.377109 containerd[1464]: time="2025-02-13T15:54:05.375099955Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fe94eb5f0c9c8d0ca277aa8cd5940f1faf5970175bf373932babc578545deda8\"" Feb 13 15:54:05.392005 containerd[1464]: time="2025-02-13T15:54:05.391944475Z" level=info msg="CreateContainer within sandbox \"1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4\" for container &ContainerMetadata{Name:test,Attempt:0,}" Feb 13 15:54:05.447378 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4249565842.mount: Deactivated successfully. Feb 13 15:54:05.458927 containerd[1464]: time="2025-02-13T15:54:05.457688599Z" level=info msg="CreateContainer within sandbox \"1670c43fedc6ccb6a52ba1afccf5032b9ca2059b3212c2321ce810031454b1e4\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"97da5f56df094d26d242d0c38fccda3fc31dd3e3af56da9634e120ad720afeec\"" Feb 13 15:54:05.465561 containerd[1464]: time="2025-02-13T15:54:05.463086857Z" level=info msg="StartContainer for \"97da5f56df094d26d242d0c38fccda3fc31dd3e3af56da9634e120ad720afeec\"" Feb 13 15:54:05.553345 systemd[1]: Started cri-containerd-97da5f56df094d26d242d0c38fccda3fc31dd3e3af56da9634e120ad720afeec.scope - libcontainer container 97da5f56df094d26d242d0c38fccda3fc31dd3e3af56da9634e120ad720afeec. Feb 13 15:54:05.676791 containerd[1464]: time="2025-02-13T15:54:05.676722143Z" level=info msg="StartContainer for \"97da5f56df094d26d242d0c38fccda3fc31dd3e3af56da9634e120ad720afeec\" returns successfully" Feb 13 15:54:05.793339 systemd-networkd[1381]: veth3d7a5483: Gained IPv6LL Feb 13 15:54:06.354269 kubelet[1748]: E0213 15:54:06.354135 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:07.355205 kubelet[1748]: E0213 15:54:07.355032 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:08.355825 kubelet[1748]: E0213 15:54:08.355707 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:09.355951 kubelet[1748]: E0213 15:54:09.355833 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:10.356595 kubelet[1748]: E0213 15:54:10.356167 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Feb 13 15:54:11.356919 kubelet[1748]: E0213 15:54:11.356721 1748 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"