Aug 13 00:20:29.221742 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Aug 13 00:20:29.221787 kernel: Linux version 6.6.100-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Tue Aug 12 22:21:53 -00 2025 Aug 13 00:20:29.221812 kernel: KASLR disabled due to lack of seed Aug 13 00:20:29.221829 kernel: efi: EFI v2.7 by EDK II Aug 13 00:20:29.221845 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7affea98 MEMRESERVE=0x7852ee18 Aug 13 00:20:29.221861 kernel: ACPI: Early table checksum verification disabled Aug 13 00:20:29.221879 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Aug 13 00:20:29.221894 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Aug 13 00:20:29.221910 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Aug 13 00:20:29.221926 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Aug 13 00:20:29.221946 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Aug 13 00:20:29.221962 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Aug 13 00:20:29.221978 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Aug 13 00:20:29.221994 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Aug 13 00:20:29.222012 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Aug 13 00:20:29.222033 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Aug 13 00:20:29.222050 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Aug 13 00:20:29.222067 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Aug 13 00:20:29.222083 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Aug 13 00:20:29.222100 kernel: printk: bootconsole [uart0] enabled Aug 13 00:20:29.222116 kernel: NUMA: Failed to initialise from firmware Aug 13 00:20:29.222133 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Aug 13 00:20:29.222172 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Aug 13 00:20:29.222194 kernel: Zone ranges: Aug 13 00:20:29.222212 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Aug 13 00:20:29.222229 kernel: DMA32 empty Aug 13 00:20:29.222251 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Aug 13 00:20:29.222268 kernel: Movable zone start for each node Aug 13 00:20:29.222284 kernel: Early memory node ranges Aug 13 00:20:29.222301 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Aug 13 00:20:29.222317 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Aug 13 00:20:29.222333 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Aug 13 00:20:29.222350 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Aug 13 00:20:29.222366 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Aug 13 00:20:29.222383 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Aug 13 00:20:29.222399 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Aug 13 00:20:29.222415 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Aug 13 00:20:29.222431 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Aug 13 00:20:29.222452 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Aug 13 00:20:29.222469 kernel: psci: probing for conduit method from ACPI. Aug 13 00:20:29.222493 kernel: psci: PSCIv1.0 detected in firmware. Aug 13 00:20:29.222511 kernel: psci: Using standard PSCI v0.2 function IDs Aug 13 00:20:29.222529 kernel: psci: Trusted OS migration not required Aug 13 00:20:29.222550 kernel: psci: SMC Calling Convention v1.1 Aug 13 00:20:29.222569 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Aug 13 00:20:29.222586 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976 Aug 13 00:20:29.222604 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096 Aug 13 00:20:29.222622 kernel: pcpu-alloc: [0] 0 [0] 1 Aug 13 00:20:29.222639 kernel: Detected PIPT I-cache on CPU0 Aug 13 00:20:29.222656 kernel: CPU features: detected: GIC system register CPU interface Aug 13 00:20:29.222674 kernel: CPU features: detected: Spectre-v2 Aug 13 00:20:29.222691 kernel: CPU features: detected: Spectre-v3a Aug 13 00:20:29.222709 kernel: CPU features: detected: Spectre-BHB Aug 13 00:20:29.222726 kernel: CPU features: detected: ARM erratum 1742098 Aug 13 00:20:29.222748 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Aug 13 00:20:29.222765 kernel: alternatives: applying boot alternatives Aug 13 00:20:29.222785 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=2f9df6e9e6c671c457040a64675390bbff42294b08c628cd2dc472ed8120146a Aug 13 00:20:29.222804 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 13 00:20:29.222821 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 13 00:20:29.222839 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 13 00:20:29.222857 kernel: Fallback order for Node 0: 0 Aug 13 00:20:29.222874 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Aug 13 00:20:29.222892 kernel: Policy zone: Normal Aug 13 00:20:29.222909 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 13 00:20:29.222926 kernel: software IO TLB: area num 2. Aug 13 00:20:29.222948 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Aug 13 00:20:29.222967 kernel: Memory: 3820088K/4030464K available (10304K kernel code, 2186K rwdata, 8108K rodata, 39424K init, 897K bss, 210376K reserved, 0K cma-reserved) Aug 13 00:20:29.222985 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Aug 13 00:20:29.223004 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 13 00:20:29.223023 kernel: rcu: RCU event tracing is enabled. Aug 13 00:20:29.223055 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Aug 13 00:20:29.223081 kernel: Trampoline variant of Tasks RCU enabled. Aug 13 00:20:29.223100 kernel: Tracing variant of Tasks RCU enabled. Aug 13 00:20:29.223118 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 13 00:20:29.223137 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Aug 13 00:20:29.223192 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 13 00:20:29.223221 kernel: GICv3: 96 SPIs implemented Aug 13 00:20:29.223240 kernel: GICv3: 0 Extended SPIs implemented Aug 13 00:20:29.223257 kernel: Root IRQ handler: gic_handle_irq Aug 13 00:20:29.223275 kernel: GICv3: GICv3 features: 16 PPIs Aug 13 00:20:29.223292 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Aug 13 00:20:29.223310 kernel: ITS [mem 0x10080000-0x1009ffff] Aug 13 00:20:29.223328 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Aug 13 00:20:29.223346 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Aug 13 00:20:29.223364 kernel: GICv3: using LPI property table @0x00000004000d0000 Aug 13 00:20:29.223381 kernel: ITS: Using hypervisor restricted LPI range [128] Aug 13 00:20:29.223399 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Aug 13 00:20:29.223417 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 13 00:20:29.223440 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Aug 13 00:20:29.223458 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Aug 13 00:20:29.223475 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Aug 13 00:20:29.223493 kernel: Console: colour dummy device 80x25 Aug 13 00:20:29.223512 kernel: printk: console [tty1] enabled Aug 13 00:20:29.223530 kernel: ACPI: Core revision 20230628 Aug 13 00:20:29.223548 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Aug 13 00:20:29.223567 kernel: pid_max: default: 32768 minimum: 301 Aug 13 00:20:29.223585 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Aug 13 00:20:29.223607 kernel: landlock: Up and running. Aug 13 00:20:29.223626 kernel: SELinux: Initializing. Aug 13 00:20:29.223644 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 00:20:29.223662 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 00:20:29.223680 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 13 00:20:29.223698 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 13 00:20:29.223716 kernel: rcu: Hierarchical SRCU implementation. Aug 13 00:20:29.223735 kernel: rcu: Max phase no-delay instances is 400. Aug 13 00:20:29.223753 kernel: Platform MSI: ITS@0x10080000 domain created Aug 13 00:20:29.223775 kernel: PCI/MSI: ITS@0x10080000 domain created Aug 13 00:20:29.223793 kernel: Remapping and enabling EFI services. Aug 13 00:20:29.223811 kernel: smp: Bringing up secondary CPUs ... Aug 13 00:20:29.223829 kernel: Detected PIPT I-cache on CPU1 Aug 13 00:20:29.223847 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Aug 13 00:20:29.223865 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Aug 13 00:20:29.223884 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Aug 13 00:20:29.223901 kernel: smp: Brought up 1 node, 2 CPUs Aug 13 00:20:29.223919 kernel: SMP: Total of 2 processors activated. Aug 13 00:20:29.223937 kernel: CPU features: detected: 32-bit EL0 Support Aug 13 00:20:29.223960 kernel: CPU features: detected: 32-bit EL1 Support Aug 13 00:20:29.223978 kernel: CPU features: detected: CRC32 instructions Aug 13 00:20:29.224017 kernel: CPU: All CPU(s) started at EL1 Aug 13 00:20:29.224041 kernel: alternatives: applying system-wide alternatives Aug 13 00:20:29.224059 kernel: devtmpfs: initialized Aug 13 00:20:29.224078 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 13 00:20:29.224097 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Aug 13 00:20:29.224115 kernel: pinctrl core: initialized pinctrl subsystem Aug 13 00:20:29.224135 kernel: SMBIOS 3.0.0 present. Aug 13 00:20:29.224200 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Aug 13 00:20:29.224222 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 13 00:20:29.224241 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 13 00:20:29.224260 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 13 00:20:29.224279 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 13 00:20:29.224297 kernel: audit: initializing netlink subsys (disabled) Aug 13 00:20:29.224316 kernel: audit: type=2000 audit(0.287:1): state=initialized audit_enabled=0 res=1 Aug 13 00:20:29.224344 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 13 00:20:29.224363 kernel: cpuidle: using governor menu Aug 13 00:20:29.224382 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 13 00:20:29.224400 kernel: ASID allocator initialised with 65536 entries Aug 13 00:20:29.224419 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 13 00:20:29.224437 kernel: Serial: AMBA PL011 UART driver Aug 13 00:20:29.224456 kernel: Modules: 17488 pages in range for non-PLT usage Aug 13 00:20:29.224474 kernel: Modules: 509008 pages in range for PLT usage Aug 13 00:20:29.224493 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 13 00:20:29.224516 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 13 00:20:29.224535 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 13 00:20:29.224553 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 13 00:20:29.224572 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 13 00:20:29.224591 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 13 00:20:29.224609 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 13 00:20:29.224629 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 13 00:20:29.224647 kernel: ACPI: Added _OSI(Module Device) Aug 13 00:20:29.224666 kernel: ACPI: Added _OSI(Processor Device) Aug 13 00:20:29.224688 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 13 00:20:29.224708 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 13 00:20:29.224727 kernel: ACPI: Interpreter enabled Aug 13 00:20:29.224745 kernel: ACPI: Using GIC for interrupt routing Aug 13 00:20:29.224764 kernel: ACPI: MCFG table detected, 1 entries Aug 13 00:20:29.224782 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Aug 13 00:20:29.225140 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 13 00:20:29.225459 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 13 00:20:29.225673 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 13 00:20:29.225880 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Aug 13 00:20:29.226092 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Aug 13 00:20:29.226118 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Aug 13 00:20:29.226139 kernel: acpiphp: Slot [1] registered Aug 13 00:20:29.226188 kernel: acpiphp: Slot [2] registered Aug 13 00:20:29.226211 kernel: acpiphp: Slot [3] registered Aug 13 00:20:29.226231 kernel: acpiphp: Slot [4] registered Aug 13 00:20:29.226260 kernel: acpiphp: Slot [5] registered Aug 13 00:20:29.226279 kernel: acpiphp: Slot [6] registered Aug 13 00:20:29.226298 kernel: acpiphp: Slot [7] registered Aug 13 00:20:29.226317 kernel: acpiphp: Slot [8] registered Aug 13 00:20:29.226336 kernel: acpiphp: Slot [9] registered Aug 13 00:20:29.226355 kernel: acpiphp: Slot [10] registered Aug 13 00:20:29.226374 kernel: acpiphp: Slot [11] registered Aug 13 00:20:29.226393 kernel: acpiphp: Slot [12] registered Aug 13 00:20:29.226411 kernel: acpiphp: Slot [13] registered Aug 13 00:20:29.226430 kernel: acpiphp: Slot [14] registered Aug 13 00:20:29.226454 kernel: acpiphp: Slot [15] registered Aug 13 00:20:29.226473 kernel: acpiphp: Slot [16] registered Aug 13 00:20:29.226491 kernel: acpiphp: Slot [17] registered Aug 13 00:20:29.226510 kernel: acpiphp: Slot [18] registered Aug 13 00:20:29.226529 kernel: acpiphp: Slot [19] registered Aug 13 00:20:29.226547 kernel: acpiphp: Slot [20] registered Aug 13 00:20:29.226565 kernel: acpiphp: Slot [21] registered Aug 13 00:20:29.226583 kernel: acpiphp: Slot [22] registered Aug 13 00:20:29.226602 kernel: acpiphp: Slot [23] registered Aug 13 00:20:29.226624 kernel: acpiphp: Slot [24] registered Aug 13 00:20:29.226643 kernel: acpiphp: Slot [25] registered Aug 13 00:20:29.226661 kernel: acpiphp: Slot [26] registered Aug 13 00:20:29.226680 kernel: acpiphp: Slot [27] registered Aug 13 00:20:29.226698 kernel: acpiphp: Slot [28] registered Aug 13 00:20:29.226717 kernel: acpiphp: Slot [29] registered Aug 13 00:20:29.226736 kernel: acpiphp: Slot [30] registered Aug 13 00:20:29.226754 kernel: acpiphp: Slot [31] registered Aug 13 00:20:29.226772 kernel: PCI host bridge to bus 0000:00 Aug 13 00:20:29.227000 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Aug 13 00:20:29.227253 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 13 00:20:29.227448 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Aug 13 00:20:29.227637 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Aug 13 00:20:29.227880 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Aug 13 00:20:29.230805 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Aug 13 00:20:29.231074 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Aug 13 00:20:29.231477 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Aug 13 00:20:29.231714 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Aug 13 00:20:29.231943 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Aug 13 00:20:29.232307 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Aug 13 00:20:29.232527 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Aug 13 00:20:29.232733 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Aug 13 00:20:29.232966 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Aug 13 00:20:29.233199 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Aug 13 00:20:29.233462 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Aug 13 00:20:29.233746 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Aug 13 00:20:29.233961 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Aug 13 00:20:29.234210 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Aug 13 00:20:29.234427 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Aug 13 00:20:29.234616 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Aug 13 00:20:29.234805 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 13 00:20:29.235072 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Aug 13 00:20:29.235109 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 13 00:20:29.235130 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 13 00:20:29.235185 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 13 00:20:29.235236 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 13 00:20:29.235259 kernel: iommu: Default domain type: Translated Aug 13 00:20:29.235279 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 13 00:20:29.235308 kernel: efivars: Registered efivars operations Aug 13 00:20:29.235327 kernel: vgaarb: loaded Aug 13 00:20:29.235346 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 13 00:20:29.235365 kernel: VFS: Disk quotas dquot_6.6.0 Aug 13 00:20:29.235384 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 13 00:20:29.235402 kernel: pnp: PnP ACPI init Aug 13 00:20:29.235637 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Aug 13 00:20:29.235667 kernel: pnp: PnP ACPI: found 1 devices Aug 13 00:20:29.235692 kernel: NET: Registered PF_INET protocol family Aug 13 00:20:29.235711 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 13 00:20:29.235731 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 13 00:20:29.235750 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 13 00:20:29.235770 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 13 00:20:29.235789 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 13 00:20:29.235808 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 13 00:20:29.235827 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 00:20:29.235846 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 00:20:29.235870 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 13 00:20:29.235889 kernel: PCI: CLS 0 bytes, default 64 Aug 13 00:20:29.235908 kernel: kvm [1]: HYP mode not available Aug 13 00:20:29.235927 kernel: Initialise system trusted keyrings Aug 13 00:20:29.235946 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 13 00:20:29.235965 kernel: Key type asymmetric registered Aug 13 00:20:29.235983 kernel: Asymmetric key parser 'x509' registered Aug 13 00:20:29.236002 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 13 00:20:29.236020 kernel: io scheduler mq-deadline registered Aug 13 00:20:29.236044 kernel: io scheduler kyber registered Aug 13 00:20:29.236063 kernel: io scheduler bfq registered Aug 13 00:20:29.236782 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Aug 13 00:20:29.236815 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 13 00:20:29.236834 kernel: ACPI: button: Power Button [PWRB] Aug 13 00:20:29.236853 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Aug 13 00:20:29.236872 kernel: ACPI: button: Sleep Button [SLPB] Aug 13 00:20:29.236890 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 13 00:20:29.236917 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Aug 13 00:20:29.237129 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Aug 13 00:20:29.237173 kernel: printk: console [ttyS0] disabled Aug 13 00:20:29.237195 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Aug 13 00:20:29.237214 kernel: printk: console [ttyS0] enabled Aug 13 00:20:29.237233 kernel: printk: bootconsole [uart0] disabled Aug 13 00:20:29.237251 kernel: thunder_xcv, ver 1.0 Aug 13 00:20:29.237284 kernel: thunder_bgx, ver 1.0 Aug 13 00:20:29.237407 kernel: nicpf, ver 1.0 Aug 13 00:20:29.237438 kernel: nicvf, ver 1.0 Aug 13 00:20:29.239479 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 13 00:20:29.239686 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-13T00:20:28 UTC (1755044428) Aug 13 00:20:29.239712 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 13 00:20:29.239731 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Aug 13 00:20:29.239750 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 13 00:20:29.239769 kernel: watchdog: Hard watchdog permanently disabled Aug 13 00:20:29.239788 kernel: NET: Registered PF_INET6 protocol family Aug 13 00:20:29.239813 kernel: Segment Routing with IPv6 Aug 13 00:20:29.239832 kernel: In-situ OAM (IOAM) with IPv6 Aug 13 00:20:29.239850 kernel: NET: Registered PF_PACKET protocol family Aug 13 00:20:29.239869 kernel: Key type dns_resolver registered Aug 13 00:20:29.239888 kernel: registered taskstats version 1 Aug 13 00:20:29.239906 kernel: Loading compiled-in X.509 certificates Aug 13 00:20:29.239925 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.100-flatcar: 7263800c6d21650660e2b030c1023dce09b1e8b6' Aug 13 00:20:29.239943 kernel: Key type .fscrypt registered Aug 13 00:20:29.239962 kernel: Key type fscrypt-provisioning registered Aug 13 00:20:29.239984 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 13 00:20:29.240003 kernel: ima: Allocated hash algorithm: sha1 Aug 13 00:20:29.240021 kernel: ima: No architecture policies found Aug 13 00:20:29.240040 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 13 00:20:29.240059 kernel: clk: Disabling unused clocks Aug 13 00:20:29.240077 kernel: Freeing unused kernel memory: 39424K Aug 13 00:20:29.240096 kernel: Run /init as init process Aug 13 00:20:29.240114 kernel: with arguments: Aug 13 00:20:29.240132 kernel: /init Aug 13 00:20:29.240867 kernel: with environment: Aug 13 00:20:29.240914 kernel: HOME=/ Aug 13 00:20:29.240934 kernel: TERM=linux Aug 13 00:20:29.240953 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 13 00:20:29.240976 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) Aug 13 00:20:29.241001 systemd[1]: Detected virtualization amazon. Aug 13 00:20:29.241022 systemd[1]: Detected architecture arm64. Aug 13 00:20:29.241042 systemd[1]: Running in initrd. Aug 13 00:20:29.241066 systemd[1]: No hostname configured, using default hostname. Aug 13 00:20:29.241086 systemd[1]: Hostname set to . Aug 13 00:20:29.241107 systemd[1]: Initializing machine ID from VM UUID. Aug 13 00:20:29.241127 systemd[1]: Queued start job for default target initrd.target. Aug 13 00:20:29.241147 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 00:20:29.241192 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 00:20:29.241215 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 13 00:20:29.241236 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 00:20:29.241263 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 13 00:20:29.241285 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 13 00:20:29.241309 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 13 00:20:29.241331 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 13 00:20:29.241352 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 00:20:29.241372 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 00:20:29.241393 systemd[1]: Reached target paths.target - Path Units. Aug 13 00:20:29.241418 systemd[1]: Reached target slices.target - Slice Units. Aug 13 00:20:29.241438 systemd[1]: Reached target swap.target - Swaps. Aug 13 00:20:29.241459 systemd[1]: Reached target timers.target - Timer Units. Aug 13 00:20:29.241479 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 00:20:29.241499 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 00:20:29.241520 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 00:20:29.241540 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 13 00:20:29.241560 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 00:20:29.241581 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 00:20:29.241606 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 00:20:29.241626 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 00:20:29.241646 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 13 00:20:29.241667 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 00:20:29.241687 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 13 00:20:29.241707 systemd[1]: Starting systemd-fsck-usr.service... Aug 13 00:20:29.241728 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 00:20:29.241748 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 00:20:29.241773 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 00:20:29.241793 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 13 00:20:29.241857 systemd-journald[251]: Collecting audit messages is disabled. Aug 13 00:20:29.241902 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 00:20:29.241928 systemd[1]: Finished systemd-fsck-usr.service. Aug 13 00:20:29.241949 systemd-journald[251]: Journal started Aug 13 00:20:29.241986 systemd-journald[251]: Runtime Journal (/run/log/journal/ec22b0411fd7072fb586091732909394) is 8.0M, max 75.3M, 67.3M free. Aug 13 00:20:29.231695 systemd-modules-load[252]: Inserted module 'overlay' Aug 13 00:20:29.262753 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 00:20:29.270062 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 00:20:29.278290 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 00:20:29.283578 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 13 00:20:29.286195 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 00:20:29.289757 kernel: Bridge firewalling registered Aug 13 00:20:29.286640 systemd-modules-load[252]: Inserted module 'br_netfilter' Aug 13 00:20:29.294780 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 00:20:29.305621 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 00:20:29.314442 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 00:20:29.320552 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 00:20:29.330518 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 00:20:29.358706 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 00:20:29.378224 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 00:20:29.388720 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 13 00:20:29.393906 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 00:20:29.398943 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 00:20:29.421872 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 00:20:29.450786 dracut-cmdline[284]: dracut-dracut-053 Aug 13 00:20:29.458015 dracut-cmdline[284]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=2f9df6e9e6c671c457040a64675390bbff42294b08c628cd2dc472ed8120146a Aug 13 00:20:29.504609 systemd-resolved[288]: Positive Trust Anchors: Aug 13 00:20:29.504644 systemd-resolved[288]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 00:20:29.504707 systemd-resolved[288]: 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 Aug 13 00:20:29.612182 kernel: SCSI subsystem initialized Aug 13 00:20:29.619189 kernel: Loading iSCSI transport class v2.0-870. Aug 13 00:20:29.632192 kernel: iscsi: registered transport (tcp) Aug 13 00:20:29.654504 kernel: iscsi: registered transport (qla4xxx) Aug 13 00:20:29.654579 kernel: QLogic iSCSI HBA Driver Aug 13 00:20:29.740190 kernel: random: crng init done Aug 13 00:20:29.740713 systemd-resolved[288]: Defaulting to hostname 'linux'. Aug 13 00:20:29.745213 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 00:20:29.747864 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 00:20:29.768796 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 13 00:20:29.780451 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 13 00:20:29.816234 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 13 00:20:29.816353 kernel: device-mapper: uevent: version 1.0.3 Aug 13 00:20:29.818203 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 13 00:20:29.884220 kernel: raid6: neonx8 gen() 6603 MB/s Aug 13 00:20:29.902190 kernel: raid6: neonx4 gen() 6490 MB/s Aug 13 00:20:29.919189 kernel: raid6: neonx2 gen() 5444 MB/s Aug 13 00:20:29.936195 kernel: raid6: neonx1 gen() 3946 MB/s Aug 13 00:20:29.953192 kernel: raid6: int64x8 gen() 3793 MB/s Aug 13 00:20:29.970191 kernel: raid6: int64x4 gen() 3720 MB/s Aug 13 00:20:29.987190 kernel: raid6: int64x2 gen() 3588 MB/s Aug 13 00:20:30.005524 kernel: raid6: int64x1 gen() 2768 MB/s Aug 13 00:20:30.005561 kernel: raid6: using algorithm neonx8 gen() 6603 MB/s Aug 13 00:20:30.024186 kernel: raid6: .... xor() 4922 MB/s, rmw enabled Aug 13 00:20:30.024235 kernel: raid6: using neon recovery algorithm Aug 13 00:20:30.032191 kernel: xor: measuring software checksum speed Aug 13 00:20:30.034336 kernel: 8regs : 10228 MB/sec Aug 13 00:20:30.034369 kernel: 32regs : 11900 MB/sec Aug 13 00:20:30.035619 kernel: arm64_neon : 9587 MB/sec Aug 13 00:20:30.035652 kernel: xor: using function: 32regs (11900 MB/sec) Aug 13 00:20:30.121212 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 13 00:20:30.140524 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 13 00:20:30.155552 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 00:20:30.202110 systemd-udevd[471]: Using default interface naming scheme 'v255'. Aug 13 00:20:30.211069 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 00:20:30.231810 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 13 00:20:30.263076 dracut-pre-trigger[476]: rd.md=0: removing MD RAID activation Aug 13 00:20:30.321392 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 00:20:30.334482 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 00:20:30.454002 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 00:20:30.479475 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 13 00:20:30.540865 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 13 00:20:30.549019 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 00:20:30.556017 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 00:20:30.567027 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 00:20:30.581035 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 13 00:20:30.628034 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 13 00:20:30.665189 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 13 00:20:30.665259 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Aug 13 00:20:30.672938 kernel: ena 0000:00:05.0: ENA device version: 0.10 Aug 13 00:20:30.673307 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Aug 13 00:20:30.677405 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 00:20:30.679712 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 00:20:30.688249 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 00:20:30.693756 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:7b:14:7c:00:a5 Aug 13 00:20:30.690736 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 00:20:30.693814 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 00:20:30.699818 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 00:20:30.717216 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Aug 13 00:20:30.719211 kernel: nvme nvme0: pci function 0000:00:04.0 Aug 13 00:20:30.720286 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 00:20:30.724743 (udev-worker)[517]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:20:30.740191 kernel: nvme nvme0: 2/0/0 default/read/poll queues Aug 13 00:20:30.748326 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 13 00:20:30.748380 kernel: GPT:9289727 != 16777215 Aug 13 00:20:30.748405 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 13 00:20:30.750320 kernel: GPT:9289727 != 16777215 Aug 13 00:20:30.750367 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 13 00:20:30.752908 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 13 00:20:30.772217 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 00:20:30.781459 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 13 00:20:30.829331 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 00:20:30.902185 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (520) Aug 13 00:20:30.902264 kernel: BTRFS: device fsid 03408483-5051-409a-aab4-4e6d5027e982 devid 1 transid 41 /dev/nvme0n1p3 scanned by (udev-worker) (530) Aug 13 00:20:30.935758 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Aug 13 00:20:31.015349 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Aug 13 00:20:31.044323 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Aug 13 00:20:31.061111 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Aug 13 00:20:31.068141 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Aug 13 00:20:31.080532 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 13 00:20:31.092382 disk-uuid[663]: Primary Header is updated. Aug 13 00:20:31.092382 disk-uuid[663]: Secondary Entries is updated. Aug 13 00:20:31.092382 disk-uuid[663]: Secondary Header is updated. Aug 13 00:20:31.104240 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 13 00:20:31.113216 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 13 00:20:31.122199 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 13 00:20:32.123259 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 13 00:20:32.123950 disk-uuid[664]: The operation has completed successfully. Aug 13 00:20:32.313942 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 13 00:20:32.314147 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 13 00:20:32.363478 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 13 00:20:32.381106 sh[1005]: Success Aug 13 00:20:32.400266 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 13 00:20:32.507943 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 13 00:20:32.529255 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 13 00:20:32.537250 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 13 00:20:32.577406 kernel: BTRFS info (device dm-0): first mount of filesystem 03408483-5051-409a-aab4-4e6d5027e982 Aug 13 00:20:32.577485 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:20:32.579833 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 13 00:20:32.581485 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 13 00:20:32.582970 kernel: BTRFS info (device dm-0): using free space tree Aug 13 00:20:32.711185 kernel: BTRFS info (device dm-0): enabling ssd optimizations Aug 13 00:20:32.749382 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 13 00:20:32.753925 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 13 00:20:32.763453 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 13 00:20:32.778728 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 13 00:20:32.812227 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem dbce4b09-c4b8-4cc9-bd11-416717f60c7d Aug 13 00:20:32.812308 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:20:32.813604 kernel: BTRFS info (device nvme0n1p6): using free space tree Aug 13 00:20:32.820408 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Aug 13 00:20:32.839847 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 13 00:20:32.842634 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem dbce4b09-c4b8-4cc9-bd11-416717f60c7d Aug 13 00:20:32.853223 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 13 00:20:32.861524 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 13 00:20:32.954944 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 00:20:32.967518 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 00:20:33.026540 systemd-networkd[1197]: lo: Link UP Aug 13 00:20:33.026563 systemd-networkd[1197]: lo: Gained carrier Aug 13 00:20:33.029175 systemd-networkd[1197]: Enumeration completed Aug 13 00:20:33.030220 systemd-networkd[1197]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 00:20:33.030227 systemd-networkd[1197]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 00:20:33.036922 systemd-networkd[1197]: eth0: Link UP Aug 13 00:20:33.036930 systemd-networkd[1197]: eth0: Gained carrier Aug 13 00:20:33.036949 systemd-networkd[1197]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 00:20:33.037409 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 00:20:33.052746 systemd[1]: Reached target network.target - Network. Aug 13 00:20:33.061273 systemd-networkd[1197]: eth0: DHCPv4 address 172.31.23.12/20, gateway 172.31.16.1 acquired from 172.31.16.1 Aug 13 00:20:33.357533 ignition[1125]: Ignition 2.19.0 Aug 13 00:20:33.357567 ignition[1125]: Stage: fetch-offline Aug 13 00:20:33.361764 ignition[1125]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:33.361804 ignition[1125]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:33.366451 ignition[1125]: Ignition finished successfully Aug 13 00:20:33.370534 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 00:20:33.383909 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Aug 13 00:20:33.407912 ignition[1208]: Ignition 2.19.0 Aug 13 00:20:33.408460 ignition[1208]: Stage: fetch Aug 13 00:20:33.409092 ignition[1208]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:33.409118 ignition[1208]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:33.409308 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:33.429099 ignition[1208]: PUT result: OK Aug 13 00:20:33.432276 ignition[1208]: parsed url from cmdline: "" Aug 13 00:20:33.432303 ignition[1208]: no config URL provided Aug 13 00:20:33.432318 ignition[1208]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 00:20:33.432346 ignition[1208]: no config at "/usr/lib/ignition/user.ign" Aug 13 00:20:33.432378 ignition[1208]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:33.440918 ignition[1208]: PUT result: OK Aug 13 00:20:33.442397 ignition[1208]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Aug 13 00:20:33.445224 ignition[1208]: GET result: OK Aug 13 00:20:33.445350 ignition[1208]: parsing config with SHA512: 6db1d60488c62bc4be2924ed6f2114f5ce97aa4df22c16a1374b538e8e77a9d3266196ff0852f7f949b224dcb012070baf7064f77b4f973b8ba82a799cbc46cb Aug 13 00:20:33.453065 unknown[1208]: fetched base config from "system" Aug 13 00:20:33.453097 unknown[1208]: fetched base config from "system" Aug 13 00:20:33.453713 ignition[1208]: fetch: fetch complete Aug 13 00:20:33.453111 unknown[1208]: fetched user config from "aws" Aug 13 00:20:33.453726 ignition[1208]: fetch: fetch passed Aug 13 00:20:33.453818 ignition[1208]: Ignition finished successfully Aug 13 00:20:33.465206 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Aug 13 00:20:33.477458 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 13 00:20:33.502806 ignition[1214]: Ignition 2.19.0 Aug 13 00:20:33.503390 ignition[1214]: Stage: kargs Aug 13 00:20:33.504041 ignition[1214]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:33.504067 ignition[1214]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:33.504250 ignition[1214]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:33.513097 ignition[1214]: PUT result: OK Aug 13 00:20:33.517117 ignition[1214]: kargs: kargs passed Aug 13 00:20:33.517302 ignition[1214]: Ignition finished successfully Aug 13 00:20:33.524273 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 13 00:20:33.534506 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 13 00:20:33.559971 ignition[1221]: Ignition 2.19.0 Aug 13 00:20:33.559999 ignition[1221]: Stage: disks Aug 13 00:20:33.560651 ignition[1221]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:33.560677 ignition[1221]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:33.560838 ignition[1221]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:33.562920 ignition[1221]: PUT result: OK Aug 13 00:20:33.574417 ignition[1221]: disks: disks passed Aug 13 00:20:33.574522 ignition[1221]: Ignition finished successfully Aug 13 00:20:33.578693 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 13 00:20:33.583569 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 13 00:20:33.586239 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 00:20:33.588913 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 00:20:33.593530 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 00:20:33.598315 systemd[1]: Reached target basic.target - Basic System. Aug 13 00:20:33.621429 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 13 00:20:33.657453 systemd-fsck[1229]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 13 00:20:33.663967 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 13 00:20:33.679346 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 13 00:20:33.771203 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 128aec8b-f05d-48ed-8996-c9e8b21a7810 r/w with ordered data mode. Quota mode: none. Aug 13 00:20:33.772767 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 13 00:20:33.776939 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 13 00:20:33.794317 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 00:20:33.799347 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 13 00:20:33.803568 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 13 00:20:33.803653 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 13 00:20:33.803705 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 00:20:33.824667 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 13 00:20:33.860762 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1248) Aug 13 00:20:33.860804 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem dbce4b09-c4b8-4cc9-bd11-416717f60c7d Aug 13 00:20:33.860832 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:20:33.860858 kernel: BTRFS info (device nvme0n1p6): using free space tree Aug 13 00:20:33.828199 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 13 00:20:33.892174 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Aug 13 00:20:33.895314 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 00:20:34.263673 initrd-setup-root[1272]: cut: /sysroot/etc/passwd: No such file or directory Aug 13 00:20:34.273624 initrd-setup-root[1279]: cut: /sysroot/etc/group: No such file or directory Aug 13 00:20:34.282815 initrd-setup-root[1286]: cut: /sysroot/etc/shadow: No such file or directory Aug 13 00:20:34.291583 initrd-setup-root[1293]: cut: /sysroot/etc/gshadow: No such file or directory Aug 13 00:20:34.395472 systemd-networkd[1197]: eth0: Gained IPv6LL Aug 13 00:20:34.608691 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 13 00:20:34.618419 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 13 00:20:34.621464 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 13 00:20:34.648866 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 13 00:20:34.651388 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem dbce4b09-c4b8-4cc9-bd11-416717f60c7d Aug 13 00:20:34.679590 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 13 00:20:34.700586 ignition[1361]: INFO : Ignition 2.19.0 Aug 13 00:20:34.700586 ignition[1361]: INFO : Stage: mount Aug 13 00:20:34.704823 ignition[1361]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:34.704823 ignition[1361]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:34.709814 ignition[1361]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:34.713283 ignition[1361]: INFO : PUT result: OK Aug 13 00:20:34.717335 ignition[1361]: INFO : mount: mount passed Aug 13 00:20:34.719134 ignition[1361]: INFO : Ignition finished successfully Aug 13 00:20:34.723130 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 13 00:20:34.731378 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 13 00:20:34.783907 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 13 00:20:34.805213 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1373) Aug 13 00:20:34.810191 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem dbce4b09-c4b8-4cc9-bd11-416717f60c7d Aug 13 00:20:34.810235 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:20:34.810262 kernel: BTRFS info (device nvme0n1p6): using free space tree Aug 13 00:20:34.816412 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Aug 13 00:20:34.819131 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 13 00:20:34.857051 ignition[1390]: INFO : Ignition 2.19.0 Aug 13 00:20:34.857051 ignition[1390]: INFO : Stage: files Aug 13 00:20:34.861445 ignition[1390]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:34.861445 ignition[1390]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:34.861445 ignition[1390]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:34.870904 ignition[1390]: INFO : PUT result: OK Aug 13 00:20:34.875052 ignition[1390]: DEBUG : files: compiled without relabeling support, skipping Aug 13 00:20:34.878972 ignition[1390]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 13 00:20:34.878972 ignition[1390]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 13 00:20:34.934787 ignition[1390]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 13 00:20:34.937950 ignition[1390]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 13 00:20:34.941430 unknown[1390]: wrote ssh authorized keys file for user: core Aug 13 00:20:34.944059 ignition[1390]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:20:34.948231 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-arm64.raw: attempt #1 Aug 13 00:20:35.289336 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Aug 13 00:20:35.668051 ignition[1390]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:20:35.668051 ignition[1390]: INFO : files: op(8): [started] processing unit "containerd.service" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: op(8): [finished] processing unit "containerd.service" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 13 00:20:35.675219 ignition[1390]: INFO : files: files passed Aug 13 00:20:35.675219 ignition[1390]: INFO : Ignition finished successfully Aug 13 00:20:35.700474 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 13 00:20:35.713447 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 13 00:20:35.729617 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 13 00:20:35.741686 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 13 00:20:35.744002 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 13 00:20:35.760124 initrd-setup-root-after-ignition[1418]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 00:20:35.760124 initrd-setup-root-after-ignition[1418]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 13 00:20:35.767419 initrd-setup-root-after-ignition[1422]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 00:20:35.774266 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 00:20:35.778552 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 13 00:20:35.791583 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 13 00:20:35.842322 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 13 00:20:35.842791 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 13 00:20:35.852332 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 13 00:20:35.854798 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 13 00:20:35.857232 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 13 00:20:35.869622 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 13 00:20:35.899069 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 00:20:35.910457 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 13 00:20:35.937304 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 13 00:20:35.942458 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 00:20:35.943301 systemd[1]: Stopped target timers.target - Timer Units. Aug 13 00:20:35.943505 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 13 00:20:35.943740 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 13 00:20:35.944551 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 13 00:20:35.944924 systemd[1]: Stopped target basic.target - Basic System. Aug 13 00:20:35.945291 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 13 00:20:35.945625 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 13 00:20:35.945972 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 13 00:20:35.946351 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 13 00:20:35.946669 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 13 00:20:35.947960 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 13 00:20:35.952702 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 13 00:20:35.952966 systemd[1]: Stopped target swap.target - Swaps. Aug 13 00:20:35.953268 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 13 00:20:35.953480 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 13 00:20:35.954775 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 13 00:20:35.958164 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 00:20:35.958946 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 13 00:20:35.976876 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 00:20:35.977102 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 13 00:20:35.977348 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 13 00:20:35.984787 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 13 00:20:35.985084 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 13 00:20:35.989796 systemd[1]: ignition-files.service: Deactivated successfully. Aug 13 00:20:35.990002 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 13 00:20:36.008063 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 13 00:20:36.010717 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 13 00:20:36.011461 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 00:20:36.074694 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 13 00:20:36.079407 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 13 00:20:36.079754 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 00:20:36.082745 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 13 00:20:36.083029 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 13 00:20:36.111691 ignition[1442]: INFO : Ignition 2.19.0 Aug 13 00:20:36.115110 ignition[1442]: INFO : Stage: umount Aug 13 00:20:36.115110 ignition[1442]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:20:36.115110 ignition[1442]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 13 00:20:36.115110 ignition[1442]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 13 00:20:36.114254 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 13 00:20:36.137046 ignition[1442]: INFO : PUT result: OK Aug 13 00:20:36.137046 ignition[1442]: INFO : umount: umount passed Aug 13 00:20:36.137046 ignition[1442]: INFO : Ignition finished successfully Aug 13 00:20:36.114493 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 13 00:20:36.142741 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 13 00:20:36.143147 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 13 00:20:36.156199 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 13 00:20:36.158229 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 13 00:20:36.158428 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 13 00:20:36.168859 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 13 00:20:36.168974 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 13 00:20:36.171563 systemd[1]: ignition-fetch.service: Deactivated successfully. Aug 13 00:20:36.171650 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Aug 13 00:20:36.176359 systemd[1]: Stopped target network.target - Network. Aug 13 00:20:36.181773 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 13 00:20:36.181894 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 13 00:20:36.182532 systemd[1]: Stopped target paths.target - Path Units. Aug 13 00:20:36.182856 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 13 00:20:36.192440 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 00:20:36.206640 systemd[1]: Stopped target slices.target - Slice Units. Aug 13 00:20:36.208801 systemd[1]: Stopped target sockets.target - Socket Units. Aug 13 00:20:36.212335 systemd[1]: iscsid.socket: Deactivated successfully. Aug 13 00:20:36.212423 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 13 00:20:36.217348 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 13 00:20:36.217427 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 13 00:20:36.230232 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 13 00:20:36.230958 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 13 00:20:36.236876 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 13 00:20:36.236970 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 13 00:20:36.245082 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 13 00:20:36.250044 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 13 00:20:36.263499 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 13 00:20:36.263930 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 13 00:20:36.271879 systemd-networkd[1197]: eth0: DHCPv6 lease lost Aug 13 00:20:36.275687 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 13 00:20:36.275801 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 00:20:36.290484 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 13 00:20:36.292904 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 13 00:20:36.297060 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 13 00:20:36.299547 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 13 00:20:36.317456 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 13 00:20:36.320215 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 13 00:20:36.320330 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 13 00:20:36.323231 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 13 00:20:36.323327 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 13 00:20:36.325823 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 13 00:20:36.325939 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 13 00:20:36.328499 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 00:20:36.369570 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 13 00:20:36.371987 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 00:20:36.378880 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 13 00:20:36.381603 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 13 00:20:36.386271 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 13 00:20:36.386406 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 13 00:20:36.390274 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 13 00:20:36.390366 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 00:20:36.401981 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 13 00:20:36.402393 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 13 00:20:36.409600 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 13 00:20:36.409706 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 13 00:20:36.412657 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 00:20:36.412750 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 13 00:20:36.420130 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 13 00:20:36.420254 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 13 00:20:36.443193 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 13 00:20:36.445594 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 13 00:20:36.445713 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 00:20:36.449355 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 00:20:36.449455 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 00:20:36.453072 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 13 00:20:36.454833 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 13 00:20:36.465486 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 13 00:20:36.467416 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 13 00:20:36.481450 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 13 00:20:36.500545 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 13 00:20:36.534533 systemd[1]: Switching root. Aug 13 00:20:36.571216 systemd-journald[251]: Journal stopped Aug 13 00:20:38.912484 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Aug 13 00:20:38.912623 kernel: SELinux: policy capability network_peer_controls=1 Aug 13 00:20:38.912666 kernel: SELinux: policy capability open_perms=1 Aug 13 00:20:38.912696 kernel: SELinux: policy capability extended_socket_class=1 Aug 13 00:20:38.912733 kernel: SELinux: policy capability always_check_network=0 Aug 13 00:20:38.912763 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 13 00:20:38.912794 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 13 00:20:38.912824 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 13 00:20:38.912853 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 13 00:20:38.912884 kernel: audit: type=1403 audit(1755044437.166:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 13 00:20:38.912923 systemd[1]: Successfully loaded SELinux policy in 83.462ms. Aug 13 00:20:38.912969 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 22.886ms. Aug 13 00:20:38.913003 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) Aug 13 00:20:38.913037 systemd[1]: Detected virtualization amazon. Aug 13 00:20:38.913075 systemd[1]: Detected architecture arm64. Aug 13 00:20:38.913106 systemd[1]: Detected first boot. Aug 13 00:20:38.913137 systemd[1]: Initializing machine ID from VM UUID. Aug 13 00:20:38.917074 zram_generator::config[1501]: No configuration found. Aug 13 00:20:38.917688 systemd[1]: Populated /etc with preset unit settings. Aug 13 00:20:38.917726 systemd[1]: Queued start job for default target multi-user.target. Aug 13 00:20:38.917763 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Aug 13 00:20:38.917803 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 13 00:20:38.917837 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 13 00:20:38.917870 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 13 00:20:38.917905 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 13 00:20:38.917937 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 13 00:20:38.917980 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 13 00:20:38.918014 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 13 00:20:38.918051 systemd[1]: Created slice user.slice - User and Session Slice. Aug 13 00:20:38.918082 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 13 00:20:38.918114 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 13 00:20:38.918144 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 13 00:20:38.922247 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 13 00:20:38.922293 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 13 00:20:38.922330 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 13 00:20:38.922370 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 13 00:20:38.922403 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 13 00:20:38.922434 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 13 00:20:38.922466 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 13 00:20:38.922499 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 13 00:20:38.922533 systemd[1]: Reached target slices.target - Slice Units. Aug 13 00:20:38.922568 systemd[1]: Reached target swap.target - Swaps. Aug 13 00:20:38.922605 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 13 00:20:38.922641 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 13 00:20:38.922674 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 13 00:20:38.922707 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 13 00:20:38.922741 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 13 00:20:38.922776 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 13 00:20:38.922808 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 13 00:20:38.922838 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 13 00:20:38.922872 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 13 00:20:38.922905 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 13 00:20:38.922937 systemd[1]: Mounting media.mount - External Media Directory... Aug 13 00:20:38.922971 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 13 00:20:38.923026 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 13 00:20:38.923059 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 13 00:20:38.923092 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 13 00:20:38.923125 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 00:20:38.926697 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 13 00:20:38.926761 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 13 00:20:38.926792 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 00:20:38.926831 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 00:20:38.926861 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 00:20:38.926892 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 13 00:20:38.926924 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 00:20:38.926956 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 13 00:20:38.927003 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Aug 13 00:20:38.927042 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.) Aug 13 00:20:38.927074 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 13 00:20:38.927102 kernel: fuse: init (API version 7.39) Aug 13 00:20:38.927136 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 13 00:20:38.927186 kernel: ACPI: bus type drm_connector registered Aug 13 00:20:38.927217 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 13 00:20:38.927248 kernel: loop: module loaded Aug 13 00:20:38.927277 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 13 00:20:38.927306 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 13 00:20:38.927394 systemd-journald[1615]: Collecting audit messages is disabled. Aug 13 00:20:38.927465 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 13 00:20:38.927496 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 13 00:20:38.927526 systemd[1]: Mounted media.mount - External Media Directory. Aug 13 00:20:38.927555 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 13 00:20:38.927583 systemd-journald[1615]: Journal started Aug 13 00:20:38.927630 systemd-journald[1615]: Runtime Journal (/run/log/journal/ec22b0411fd7072fb586091732909394) is 8.0M, max 75.3M, 67.3M free. Aug 13 00:20:38.930485 systemd[1]: Started systemd-journald.service - Journal Service. Aug 13 00:20:38.935552 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 13 00:20:38.938583 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 13 00:20:38.945396 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 13 00:20:38.956394 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 13 00:20:38.963298 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 13 00:20:38.963690 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 13 00:20:38.970457 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:20:38.970818 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 00:20:38.976342 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 00:20:38.976701 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 00:20:38.982817 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:20:38.983234 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 00:20:38.992466 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 13 00:20:38.992836 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 13 00:20:38.999000 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:20:38.999576 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 00:20:39.007356 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 13 00:20:39.016098 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 13 00:20:39.025812 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 13 00:20:39.056126 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 13 00:20:39.070500 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 13 00:20:39.084314 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 13 00:20:39.091735 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 13 00:20:39.108459 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 13 00:20:39.118441 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 13 00:20:39.123504 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:20:39.135506 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 13 00:20:39.147260 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 00:20:39.155119 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 13 00:20:39.178411 systemd-journald[1615]: Time spent on flushing to /var/log/journal/ec22b0411fd7072fb586091732909394 is 93.016ms for 875 entries. Aug 13 00:20:39.178411 systemd-journald[1615]: System Journal (/var/log/journal/ec22b0411fd7072fb586091732909394) is 8.0M, max 195.6M, 187.6M free. Aug 13 00:20:39.291359 systemd-journald[1615]: Received client request to flush runtime journal. Aug 13 00:20:39.180377 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 13 00:20:39.200526 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 13 00:20:39.215416 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 13 00:20:39.221666 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 13 00:20:39.232593 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 13 00:20:39.246043 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 13 00:20:39.266642 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 13 00:20:39.272999 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 13 00:20:39.298694 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 13 00:20:39.319454 udevadm[1664]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 13 00:20:39.323707 systemd-tmpfiles[1654]: ACLs are not supported, ignoring. Aug 13 00:20:39.323748 systemd-tmpfiles[1654]: ACLs are not supported, ignoring. Aug 13 00:20:39.334473 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 13 00:20:39.361435 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 13 00:20:39.427173 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 13 00:20:39.443432 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 13 00:20:39.482584 systemd-tmpfiles[1675]: ACLs are not supported, ignoring. Aug 13 00:20:39.483144 systemd-tmpfiles[1675]: ACLs are not supported, ignoring. Aug 13 00:20:39.494616 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 13 00:20:40.193694 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 13 00:20:40.206493 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 13 00:20:40.268439 systemd-udevd[1681]: Using default interface naming scheme 'v255'. Aug 13 00:20:40.318277 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 13 00:20:40.338466 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 13 00:20:40.387524 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 13 00:20:40.447745 (udev-worker)[1698]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:20:40.448678 systemd[1]: Found device dev-ttyS0.device - /dev/ttyS0. Aug 13 00:20:40.548967 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 13 00:20:40.729110 systemd-networkd[1690]: lo: Link UP Aug 13 00:20:40.729135 systemd-networkd[1690]: lo: Gained carrier Aug 13 00:20:40.731895 systemd-networkd[1690]: Enumeration completed Aug 13 00:20:40.732812 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 13 00:20:40.733008 systemd-networkd[1690]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 00:20:40.733015 systemd-networkd[1690]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 00:20:40.740758 systemd-networkd[1690]: eth0: Link UP Aug 13 00:20:40.741052 systemd-networkd[1690]: eth0: Gained carrier Aug 13 00:20:40.741086 systemd-networkd[1690]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 13 00:20:40.752915 systemd-networkd[1690]: eth0: DHCPv4 address 172.31.23.12/20, gateway 172.31.16.1 acquired from 172.31.16.1 Aug 13 00:20:40.755182 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (1689) Aug 13 00:20:40.783178 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 13 00:20:40.795174 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 13 00:20:40.970949 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 13 00:20:40.986794 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Aug 13 00:20:41.023626 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 13 00:20:41.032530 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 13 00:20:41.063430 lvm[1807]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 00:20:41.105957 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 13 00:20:41.109429 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 13 00:20:41.125595 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 13 00:20:41.136026 lvm[1813]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 00:20:41.173869 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 13 00:20:41.179762 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 13 00:20:41.182726 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). Aug 13 00:20:41.182899 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 13 00:20:41.185542 systemd[1]: Reached target machines.target - Containers. Aug 13 00:20:41.189792 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 13 00:20:41.201533 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 13 00:20:41.206829 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 13 00:20:41.209345 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 00:20:41.217653 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 13 00:20:41.227542 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 13 00:20:41.236504 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 13 00:20:41.240699 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 13 00:20:41.278817 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 13 00:20:41.291694 kernel: loop0: detected capacity change from 0 to 114432 Aug 13 00:20:41.294491 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 13 00:20:41.297507 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 13 00:20:41.382274 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 13 00:20:41.415305 kernel: loop1: detected capacity change from 0 to 114328 Aug 13 00:20:41.511235 kernel: loop2: detected capacity change from 0 to 52536 Aug 13 00:20:41.614219 kernel: loop3: detected capacity change from 0 to 203944 Aug 13 00:20:41.721180 kernel: loop4: detected capacity change from 0 to 114432 Aug 13 00:20:41.740233 kernel: loop5: detected capacity change from 0 to 114328 Aug 13 00:20:41.753199 kernel: loop6: detected capacity change from 0 to 52536 Aug 13 00:20:41.768203 kernel: loop7: detected capacity change from 0 to 203944 Aug 13 00:20:41.789974 (sd-merge)[1834]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Aug 13 00:20:41.791052 (sd-merge)[1834]: Merged extensions into '/usr'. Aug 13 00:20:41.797770 systemd[1]: Reloading requested from client PID 1821 ('systemd-sysext') (unit systemd-sysext.service)... Aug 13 00:20:41.797806 systemd[1]: Reloading... Aug 13 00:20:41.926187 zram_generator::config[1859]: No configuration found. Aug 13 00:20:42.228392 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. Aug 13 00:20:42.382434 systemd[1]: Reloading finished in 583 ms. Aug 13 00:20:42.409257 ldconfig[1817]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 13 00:20:42.411192 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 13 00:20:42.422552 systemd[1]: Starting ensure-sysext.service... Aug 13 00:20:42.433458 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 13 00:20:42.440320 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 13 00:20:42.455369 systemd[1]: Reloading requested from client PID 1919 ('systemctl') (unit ensure-sysext.service)... Aug 13 00:20:42.455530 systemd[1]: Reloading... Aug 13 00:20:42.491649 systemd-tmpfiles[1921]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 13 00:20:42.492633 systemd-tmpfiles[1921]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 13 00:20:42.495070 systemd-tmpfiles[1921]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 13 00:20:42.496199 systemd-tmpfiles[1921]: ACLs are not supported, ignoring. Aug 13 00:20:42.496776 systemd-tmpfiles[1921]: ACLs are not supported, ignoring. Aug 13 00:20:42.505500 systemd-tmpfiles[1921]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 00:20:42.505529 systemd-tmpfiles[1921]: Skipping /boot Aug 13 00:20:42.530137 systemd-tmpfiles[1921]: Detected autofs mount point /boot during canonicalization of boot. Aug 13 00:20:42.530207 systemd-tmpfiles[1921]: Skipping /boot Aug 13 00:20:42.613193 zram_generator::config[1954]: No configuration found. Aug 13 00:20:42.779323 systemd-networkd[1690]: eth0: Gained IPv6LL Aug 13 00:20:42.856957 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. Aug 13 00:20:43.009854 systemd[1]: Reloading finished in 553 ms. Aug 13 00:20:43.034845 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 13 00:20:43.045366 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 13 00:20:43.065557 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 13 00:20:43.073441 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 13 00:20:43.091500 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 13 00:20:43.102457 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 13 00:20:43.115405 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 13 00:20:43.138469 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 00:20:43.150680 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 13 00:20:43.158720 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 13 00:20:43.178945 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 13 00:20:43.181692 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 00:20:43.189601 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 00:20:43.189915 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 00:20:43.201921 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 13 00:20:43.208771 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 13 00:20:43.215892 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 13 00:20:43.216732 systemd[1]: Reached target time-set.target - System Time Set. Aug 13 00:20:43.227078 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 13 00:20:43.248030 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:20:43.254758 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 13 00:20:43.264508 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:20:43.268788 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 13 00:20:43.274598 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:20:43.274979 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 13 00:20:43.286764 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 00:20:43.289625 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 13 00:20:43.310640 systemd[1]: Finished ensure-sysext.service. Aug 13 00:20:43.313738 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 13 00:20:43.335637 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:20:43.336059 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 13 00:20:43.348589 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 13 00:20:43.373074 augenrules[2053]: No rules Aug 13 00:20:43.381894 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 13 00:20:43.394972 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 13 00:20:43.400063 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). Aug 13 00:20:43.413051 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 13 00:20:43.451067 systemd-resolved[2016]: Positive Trust Anchors: Aug 13 00:20:43.451654 systemd-resolved[2016]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 00:20:43.451818 systemd-resolved[2016]: 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 Aug 13 00:20:43.465129 systemd-resolved[2016]: Defaulting to hostname 'linux'. Aug 13 00:20:43.468665 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 13 00:20:43.471312 systemd[1]: Reached target network.target - Network. Aug 13 00:20:43.473305 systemd[1]: Reached target network-online.target - Network is Online. Aug 13 00:20:43.475637 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 13 00:20:43.478206 systemd[1]: Reached target sysinit.target - System Initialization. Aug 13 00:20:43.480702 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 13 00:20:43.483642 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 13 00:20:43.486790 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 13 00:20:43.489440 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 13 00:20:43.492491 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 13 00:20:43.495180 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 13 00:20:43.495235 systemd[1]: Reached target paths.target - Path Units. Aug 13 00:20:43.497332 systemd[1]: Reached target timers.target - Timer Units. Aug 13 00:20:43.500720 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 13 00:20:43.507016 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 13 00:20:43.511728 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 13 00:20:43.520974 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 13 00:20:43.523566 systemd[1]: Reached target sockets.target - Socket Units. Aug 13 00:20:43.526261 systemd[1]: Reached target basic.target - Basic System. Aug 13 00:20:43.531684 systemd[1]: System is tainted: cgroupsv1 Aug 13 00:20:43.531765 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 13 00:20:43.531816 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 13 00:20:43.534133 systemd[1]: Starting containerd.service - containerd container runtime... Aug 13 00:20:43.546582 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Aug 13 00:20:43.559455 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 13 00:20:43.570319 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 13 00:20:43.578477 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 13 00:20:43.582354 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). Aug 13 00:20:43.592321 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 00:20:43.600938 jq[2070]: false Aug 13 00:20:43.614499 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 13 00:20:43.626477 systemd[1]: Started ntpd.service - Network Time Service. Aug 13 00:20:43.647445 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 13 00:20:43.668936 systemd[1]: Starting setup-oem.service - Setup OEM... Aug 13 00:20:43.684846 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 13 00:20:43.709510 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 13 00:20:43.724565 dbus-daemon[2068]: [system] SELinux support is enabled Aug 13 00:20:43.734444 dbus-daemon[2068]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1690 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Aug 13 00:20:43.746783 extend-filesystems[2071]: Found loop4 Aug 13 00:20:43.754414 extend-filesystems[2071]: Found loop5 Aug 13 00:20:43.754414 extend-filesystems[2071]: Found loop6 Aug 13 00:20:43.754414 extend-filesystems[2071]: Found loop7 Aug 13 00:20:43.754414 extend-filesystems[2071]: Found nvme0n1 Aug 13 00:20:43.754414 extend-filesystems[2071]: Found nvme0n1p1 Aug 13 00:20:43.750458 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p2 Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p3 Aug 13 00:20:43.785592 extend-filesystems[2071]: Found usr Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p4 Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p6 Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p7 Aug 13 00:20:43.785592 extend-filesystems[2071]: Found nvme0n1p9 Aug 13 00:20:43.785592 extend-filesystems[2071]: Checking size of /dev/nvme0n1p9 Aug 13 00:20:43.762515 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 13 00:20:43.849359 coreos-metadata[2067]: Aug 13 00:20:43.838 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Aug 13 00:20:43.849359 coreos-metadata[2067]: Aug 13 00:20:43.843 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Aug 13 00:20:43.775831 systemd[1]: Starting update-engine.service - Update Engine... Aug 13 00:20:43.860634 coreos-metadata[2067]: Aug 13 00:20:43.853 INFO Fetch successful Aug 13 00:20:43.860634 coreos-metadata[2067]: Aug 13 00:20:43.854 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Aug 13 00:20:43.860634 coreos-metadata[2067]: Aug 13 00:20:43.855 INFO Fetch successful Aug 13 00:20:43.860634 coreos-metadata[2067]: Aug 13 00:20:43.856 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Aug 13 00:20:43.816558 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 13 00:20:43.825738 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 13 00:20:43.859139 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 13 00:20:43.864851 coreos-metadata[2067]: Aug 13 00:20:43.862 INFO Fetch successful Aug 13 00:20:43.864851 coreos-metadata[2067]: Aug 13 00:20:43.862 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Aug 13 00:20:43.859690 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 13 00:20:43.880877 ntpd[2075]: ntpd 4.2.8p17@1.4004-o Tue Aug 12 21:30:33 UTC 2025 (1): Starting Aug 13 00:20:43.886789 systemd[1]: motdgen.service: Deactivated successfully. Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: ntpd 4.2.8p17@1.4004-o Tue Aug 12 21:30:33 UTC 2025 (1): Starting Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: ---------------------------------------------------- Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: ntp-4 is maintained by Network Time Foundation, Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: corporation. Support and training for ntp-4 are Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: available at https://www.nwtime.org/support Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: ---------------------------------------------------- Aug 13 00:20:43.890704 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: proto: precision = 0.096 usec (-23) Aug 13 00:20:43.898783 coreos-metadata[2067]: Aug 13 00:20:43.889 INFO Fetch successful Aug 13 00:20:43.898783 coreos-metadata[2067]: Aug 13 00:20:43.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Aug 13 00:20:43.880941 ntpd[2075]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Aug 13 00:20:43.890594 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 13 00:20:43.900960 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: basedate set to 2025-07-31 Aug 13 00:20:43.900960 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: gps base set to 2025-08-03 (week 2378) Aug 13 00:20:43.880963 ntpd[2075]: ---------------------------------------------------- Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.899 INFO Fetch failed with 404: resource not found Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.899 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.900 INFO Fetch successful Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.900 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.901 INFO Fetch successful Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.901 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.902 INFO Fetch successful Aug 13 00:20:43.905555 coreos-metadata[2067]: Aug 13 00:20:43.902 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Aug 13 00:20:43.902418 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen and drop on 0 v6wildcard [::]:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen normally on 2 lo 127.0.0.1:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen normally on 3 eth0 172.31.23.12:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen normally on 4 lo [::1]:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listen normally on 5 eth0 [fe80::47b:14ff:fe7c:a5%2]:123 Aug 13 00:20:43.906125 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: Listening on routing socket on fd #22 for interface updates Aug 13 00:20:43.880982 ntpd[2075]: ntp-4 is maintained by Network Time Foundation, Aug 13 00:20:43.916067 coreos-metadata[2067]: Aug 13 00:20:43.906 INFO Fetch successful Aug 13 00:20:43.916067 coreos-metadata[2067]: Aug 13 00:20:43.906 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Aug 13 00:20:43.916067 coreos-metadata[2067]: Aug 13 00:20:43.907 INFO Fetch successful Aug 13 00:20:43.908933 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 13 00:20:43.881001 ntpd[2075]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Aug 13 00:20:43.881020 ntpd[2075]: corporation. Support and training for ntp-4 are Aug 13 00:20:43.881039 ntpd[2075]: available at https://www.nwtime.org/support Aug 13 00:20:43.881061 ntpd[2075]: ---------------------------------------------------- Aug 13 00:20:43.888561 ntpd[2075]: proto: precision = 0.096 usec (-23) Aug 13 00:20:43.896516 ntpd[2075]: basedate set to 2025-07-31 Aug 13 00:20:43.896553 ntpd[2075]: gps base set to 2025-08-03 (week 2378) Aug 13 00:20:43.904356 ntpd[2075]: Listen and drop on 0 v6wildcard [::]:123 Aug 13 00:20:43.904441 ntpd[2075]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 13 00:20:43.904750 ntpd[2075]: Listen normally on 2 lo 127.0.0.1:123 Aug 13 00:20:43.904831 ntpd[2075]: Listen normally on 3 eth0 172.31.23.12:123 Aug 13 00:20:43.904903 ntpd[2075]: Listen normally on 4 lo [::1]:123 Aug 13 00:20:43.904982 ntpd[2075]: Listen normally on 5 eth0 [fe80::47b:14ff:fe7c:a5%2]:123 Aug 13 00:20:43.905051 ntpd[2075]: Listening on routing socket on fd #22 for interface updates Aug 13 00:20:43.936188 jq[2098]: true Aug 13 00:20:43.939756 ntpd[2075]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 13 00:20:43.942773 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 13 00:20:43.942773 ntpd[2075]: 13 Aug 00:20:43 ntpd[2075]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 13 00:20:43.939969 ntpd[2075]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 13 00:20:43.965691 extend-filesystems[2071]: Resized partition /dev/nvme0n1p9 Aug 13 00:20:43.984644 extend-filesystems[2120]: resize2fs 1.47.1 (20-May-2024) Aug 13 00:20:43.990282 update_engine[2094]: I20250813 00:20:43.986214 2094 main.cc:92] Flatcar Update Engine starting Aug 13 00:20:43.991809 (ntainerd)[2112]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 13 00:20:44.004539 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Aug 13 00:20:44.020202 update_engine[2094]: I20250813 00:20:44.017040 2094 update_check_scheduler.cc:74] Next update check in 5m43s Aug 13 00:20:44.027957 jq[2117]: true Aug 13 00:20:44.033893 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). Aug 13 00:20:44.040523 dbus-daemon[2068]: [system] Successfully activated service 'org.freedesktop.systemd1' Aug 13 00:20:44.033952 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 13 00:20:44.036899 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). Aug 13 00:20:44.036940 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 13 00:20:44.041242 systemd[1]: Started update-engine.service - Update Engine. Aug 13 00:20:44.103858 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 13 00:20:44.183722 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 13 00:20:44.212104 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Aug 13 00:20:44.218776 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 13 00:20:44.236185 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Aug 13 00:20:44.250454 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 13 00:20:44.255376 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Aug 13 00:20:44.270213 extend-filesystems[2120]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Aug 13 00:20:44.270213 extend-filesystems[2120]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 13 00:20:44.270213 extend-filesystems[2120]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Aug 13 00:20:44.258822 systemd[1]: Finished setup-oem.service - Setup OEM. Aug 13 00:20:44.283558 extend-filesystems[2071]: Resized filesystem in /dev/nvme0n1p9 Aug 13 00:20:44.290121 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 13 00:20:44.296902 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 13 00:20:44.338763 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Aug 13 00:20:44.341438 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 13 00:20:44.393183 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (2170) Aug 13 00:20:44.415183 bash[2181]: Updated "/home/core/.ssh/authorized_keys" Aug 13 00:20:44.424950 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 13 00:20:44.467518 systemd[1]: Starting sshkeys.service... Aug 13 00:20:44.537533 systemd-logind[2091]: Watching system buttons on /dev/input/event0 (Power Button) Aug 13 00:20:44.537575 systemd-logind[2091]: Watching system buttons on /dev/input/event1 (Sleep Button) Aug 13 00:20:44.540457 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Aug 13 00:20:44.543491 systemd-logind[2091]: New seat seat0. Aug 13 00:20:44.583278 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Aug 13 00:20:44.587585 systemd[1]: Started systemd-logind.service - User Login Management. Aug 13 00:20:44.717691 amazon-ssm-agent[2171]: Initializing new seelog logger Aug 13 00:20:44.718567 amazon-ssm-agent[2171]: New Seelog Logger Creation Complete Aug 13 00:20:44.720441 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.720441 amazon-ssm-agent[2171]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.723177 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 processing appconfig overrides Aug 13 00:20:44.727310 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.727310 amazon-ssm-agent[2171]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.727493 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 processing appconfig overrides Aug 13 00:20:44.727784 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.727784 amazon-ssm-agent[2171]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.727906 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 processing appconfig overrides Aug 13 00:20:44.730448 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO Proxy environment variables: Aug 13 00:20:44.744945 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.744945 amazon-ssm-agent[2171]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 13 00:20:44.745126 amazon-ssm-agent[2171]: 2025/08/13 00:20:44 processing appconfig overrides Aug 13 00:20:44.795968 locksmithd[2158]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 13 00:20:44.832181 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO https_proxy: Aug 13 00:20:44.938297 containerd[2112]: time="2025-08-13T00:20:44.938122981Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Aug 13 00:20:44.945450 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO http_proxy: Aug 13 00:20:44.947598 coreos-metadata[2221]: Aug 13 00:20:44.947 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Aug 13 00:20:44.957360 coreos-metadata[2221]: Aug 13 00:20:44.957 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Aug 13 00:20:44.958906 coreos-metadata[2221]: Aug 13 00:20:44.958 INFO Fetch successful Aug 13 00:20:44.958906 coreos-metadata[2221]: Aug 13 00:20:44.958 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Aug 13 00:20:44.962262 coreos-metadata[2221]: Aug 13 00:20:44.962 INFO Fetch successful Aug 13 00:20:44.965259 unknown[2221]: wrote ssh authorized keys file for user: core Aug 13 00:20:45.019114 update-ssh-keys[2282]: Updated "/home/core/.ssh/authorized_keys" Aug 13 00:20:45.023772 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Aug 13 00:20:45.049184 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO no_proxy: Aug 13 00:20:45.045859 systemd[1]: Finished sshkeys.service. Aug 13 00:20:45.145415 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO Checking if agent identity type OnPrem can be assumed Aug 13 00:20:45.244347 amazon-ssm-agent[2171]: 2025-08-13 00:20:44 INFO Checking if agent identity type EC2 can be assumed Aug 13 00:20:45.263722 dbus-daemon[2068]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 13 00:20:45.263990 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Aug 13 00:20:45.274907 dbus-daemon[2068]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=2152 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Aug 13 00:20:45.290788 systemd[1]: Starting polkit.service - Authorization Manager... Aug 13 00:20:45.306865 containerd[2112]: time="2025-08-13T00:20:45.306572519Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.318505847Z" 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.100-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.318572255Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.318607847Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.318904403Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.318937547Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.319083947Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 00:20:45.319402 containerd[2112]: time="2025-08-13T00:20:45.319114115Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.325205 containerd[2112]: time="2025-08-13T00:20:45.323487299Z" 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 Aug 13 00:20:45.325205 containerd[2112]: time="2025-08-13T00:20:45.323551523Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.325205 containerd[2112]: time="2025-08-13T00:20:45.323586419Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Aug 13 00:20:45.325205 containerd[2112]: time="2025-08-13T00:20:45.323611367Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.325205 containerd[2112]: time="2025-08-13T00:20:45.323820731Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.332208 containerd[2112]: time="2025-08-13T00:20:45.331282919Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:20:45.332208 containerd[2112]: time="2025-08-13T00:20:45.331617419Z" 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 Aug 13 00:20:45.332208 containerd[2112]: time="2025-08-13T00:20:45.331656059Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 13 00:20:45.332208 containerd[2112]: time="2025-08-13T00:20:45.331867523Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 13 00:20:45.332208 containerd[2112]: time="2025-08-13T00:20:45.331971683Z" level=info msg="metadata content store policy set" policy=shared Aug 13 00:20:45.342609 containerd[2112]: time="2025-08-13T00:20:45.342519479Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.343318811Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.343392575Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.343433267Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.343469831Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.343744979Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344346863Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344581211Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344615507Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344648051Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344688455Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344723555Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344755163Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344788619Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346196 containerd[2112]: time="2025-08-13T00:20:45.344821019Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346820 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO Agent will take identity from EC2 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.344851895Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.344880803Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.344909015Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.344949203Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.344980163Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.345009179Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.345040295Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.345069311Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.345099779Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.346875 containerd[2112]: time="2025-08-13T00:20:45.345127055Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355238303Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355309379Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355352567Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355399199Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355432835Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355463471Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355507775Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355559327Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355601423Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355629239Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355855943Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355896719Z" 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 Aug 13 00:20:45.361172 containerd[2112]: time="2025-08-13T00:20:45.355924175Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 13 00:20:45.361823 containerd[2112]: time="2025-08-13T00:20:45.355956551Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 13 00:20:45.361823 containerd[2112]: time="2025-08-13T00:20:45.355980791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.361823 containerd[2112]: time="2025-08-13T00:20:45.356008307Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 13 00:20:45.361823 containerd[2112]: time="2025-08-13T00:20:45.356032235Z" level=info msg="NRI interface is disabled by configuration." Aug 13 00:20:45.361823 containerd[2112]: time="2025-08-13T00:20:45.356059499Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 13 00:20:45.362061 containerd[2112]: time="2025-08-13T00:20:45.356745707Z" 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:false] 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:false 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}" Aug 13 00:20:45.362061 containerd[2112]: time="2025-08-13T00:20:45.356856827Z" level=info msg="Connect containerd service" Aug 13 00:20:45.362061 containerd[2112]: time="2025-08-13T00:20:45.357053507Z" level=info msg="using legacy CRI server" Aug 13 00:20:45.362061 containerd[2112]: time="2025-08-13T00:20:45.357074351Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 13 00:20:45.363687 polkitd[2300]: Started polkitd version 121 Aug 13 00:20:45.370184 containerd[2112]: time="2025-08-13T00:20:45.366072287Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 13 00:20:45.370184 containerd[2112]: time="2025-08-13T00:20:45.369581003Z" 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" Aug 13 00:20:45.375468 containerd[2112]: time="2025-08-13T00:20:45.375375995Z" level=info msg="Start subscribing containerd event" Aug 13 00:20:45.375578 containerd[2112]: time="2025-08-13T00:20:45.375483575Z" level=info msg="Start recovering state" Aug 13 00:20:45.376348 containerd[2112]: time="2025-08-13T00:20:45.375641927Z" level=info msg="Start event monitor" Aug 13 00:20:45.376348 containerd[2112]: time="2025-08-13T00:20:45.375677699Z" level=info msg="Start snapshots syncer" Aug 13 00:20:45.376348 containerd[2112]: time="2025-08-13T00:20:45.375707195Z" level=info msg="Start cni network conf syncer for default" Aug 13 00:20:45.376348 containerd[2112]: time="2025-08-13T00:20:45.375739343Z" level=info msg="Start streaming server" Aug 13 00:20:45.395200 containerd[2112]: time="2025-08-13T00:20:45.395069339Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 13 00:20:45.395347 containerd[2112]: time="2025-08-13T00:20:45.395231603Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 13 00:20:45.395400 containerd[2112]: time="2025-08-13T00:20:45.395338523Z" level=info msg="containerd successfully booted in 0.461350s" Aug 13 00:20:45.396357 systemd[1]: Started containerd.service - containerd container runtime. Aug 13 00:20:45.404975 polkitd[2300]: Loading rules from directory /etc/polkit-1/rules.d Aug 13 00:20:45.405093 polkitd[2300]: Loading rules from directory /usr/share/polkit-1/rules.d Aug 13 00:20:45.410532 polkitd[2300]: Finished loading, compiling and executing 2 rules Aug 13 00:20:45.419380 dbus-daemon[2068]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 13 00:20:45.419646 systemd[1]: Started polkit.service - Authorization Manager. Aug 13 00:20:45.422329 polkitd[2300]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Aug 13 00:20:45.444514 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] using named pipe channel for IPC Aug 13 00:20:45.467872 systemd-hostnamed[2152]: Hostname set to (transient) Aug 13 00:20:45.468042 systemd-resolved[2016]: System hostname changed to 'ip-172-31-23-12'. Aug 13 00:20:45.544384 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] using named pipe channel for IPC Aug 13 00:20:45.646130 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] using named pipe channel for IPC Aug 13 00:20:45.743673 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Aug 13 00:20:45.844641 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Aug 13 00:20:45.945052 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] Starting Core Agent Aug 13 00:20:46.044995 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [amazon-ssm-agent] registrar detected. Attempting registration Aug 13 00:20:46.055038 sshd_keygen[2124]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 13 00:20:46.115904 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 13 00:20:46.134072 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 13 00:20:46.139682 systemd[1]: Started sshd@0-172.31.23.12:22-139.178.89.65:39412.service - OpenSSH per-connection server daemon (139.178.89.65:39412). Aug 13 00:20:46.145463 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [Registrar] Starting registrar module Aug 13 00:20:46.175549 systemd[1]: issuegen.service: Deactivated successfully. Aug 13 00:20:46.176138 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 13 00:20:46.192775 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 13 00:20:46.234818 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 13 00:20:46.245661 amazon-ssm-agent[2171]: 2025-08-13 00:20:45 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Aug 13 00:20:46.251481 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 13 00:20:46.260826 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 13 00:20:46.264019 systemd[1]: Reached target getty.target - Login Prompts. Aug 13 00:20:46.294974 amazon-ssm-agent[2171]: 2025-08-13 00:20:46 INFO [EC2Identity] EC2 registration was successful. Aug 13 00:20:46.294974 amazon-ssm-agent[2171]: 2025-08-13 00:20:46 INFO [CredentialRefresher] credentialRefresher has started Aug 13 00:20:46.294974 amazon-ssm-agent[2171]: 2025-08-13 00:20:46 INFO [CredentialRefresher] Starting credentials refresher loop Aug 13 00:20:46.295190 amazon-ssm-agent[2171]: 2025-08-13 00:20:46 INFO EC2RoleProvider Successfully connected with instance profile role credentials Aug 13 00:20:46.345624 amazon-ssm-agent[2171]: 2025-08-13 00:20:46 INFO [CredentialRefresher] Next credential rotation will be in 31.524992309 minutes Aug 13 00:20:46.381225 sshd[2334]: Accepted publickey for core from 139.178.89.65 port 39412 ssh2: RSA SHA256:5ZP49ylZaeKoaoG/AzraaaovTV7vWS+bRyuygC4N/Z4 Aug 13 00:20:46.385482 sshd[2334]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 00:20:46.407658 systemd-logind[2091]: New session 1 of user core. Aug 13 00:20:46.408481 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 13 00:20:46.418738 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 13 00:20:46.463365 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 13 00:20:46.482230 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 13 00:20:46.498531 (systemd)[2350]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:20:46.734381 systemd[2350]: Queued start job for default target default.target. Aug 13 00:20:46.735100 systemd[2350]: Created slice app.slice - User Application Slice. Aug 13 00:20:46.735141 systemd[2350]: Reached target paths.target - Paths. Aug 13 00:20:46.735216 systemd[2350]: Reached target timers.target - Timers. Aug 13 00:20:46.751321 systemd[2350]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 13 00:20:46.772025 systemd[2350]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 13 00:20:46.772580 systemd[2350]: Reached target sockets.target - Sockets. Aug 13 00:20:46.772779 systemd[2350]: Reached target basic.target - Basic System. Aug 13 00:20:46.772973 systemd[2350]: Reached target default.target - Main User Target. Aug 13 00:20:46.773247 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 13 00:20:46.775586 systemd[2350]: Startup finished in 265ms. Aug 13 00:20:46.781736 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 13 00:20:46.961358 systemd[1]: Started sshd@1-172.31.23.12:22-139.178.89.65:39424.service - OpenSSH per-connection server daemon (139.178.89.65:39424). Aug 13 00:20:46.997711 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 00:20:47.001103 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 13 00:20:47.005643 systemd[1]: Startup finished in 9.502s (kernel) + 9.922s (userspace) = 19.425s. Aug 13 00:20:47.022452 (kubelet)[2372]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Aug 13 00:20:47.148617 sshd[2365]: Accepted publickey for core from 139.178.89.65 port 39424 ssh2: RSA SHA256:5ZP49ylZaeKoaoG/AzraaaovTV7vWS+bRyuygC4N/Z4 Aug 13 00:20:47.149767 sshd[2365]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 00:20:47.158388 systemd-logind[2091]: New session 2 of user core. Aug 13 00:20:47.165865 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 13 00:20:47.295514 sshd[2365]: pam_unix(sshd:session): session closed for user core Aug 13 00:20:47.302542 systemd[1]: sshd@1-172.31.23.12:22-139.178.89.65:39424.service: Deactivated successfully. Aug 13 00:20:47.310896 systemd[1]: session-2.scope: Deactivated successfully. Aug 13 00:20:47.314798 systemd-logind[2091]: Session 2 logged out. Waiting for processes to exit. Aug 13 00:20:47.324670 systemd[1]: Started sshd@2-172.31.23.12:22-139.178.89.65:39438.service - OpenSSH per-connection server daemon (139.178.89.65:39438). Aug 13 00:20:47.328366 systemd-logind[2091]: Removed session 2. Aug 13 00:20:47.347792 amazon-ssm-agent[2171]: 2025-08-13 00:20:47 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Aug 13 00:20:47.449075 amazon-ssm-agent[2171]: 2025-08-13 00:20:47 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2389) started Aug 13 00:20:47.511222 sshd[2388]: Accepted publickey for core from 139.178.89.65 port 39438 ssh2: RSA SHA256:5ZP49ylZaeKoaoG/AzraaaovTV7vWS+bRyuygC4N/Z4 Aug 13 00:20:47.516798 sshd[2388]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 00:20:47.526507 systemd-logind[2091]: New session 3 of user core. Aug 13 00:20:47.534302 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 13 00:20:47.554906 amazon-ssm-agent[2171]: 2025-08-13 00:20:47 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Aug 13 00:20:47.664505 sshd[2388]: pam_unix(sshd:session): session closed for user core Aug 13 00:20:47.672090 systemd[1]: sshd@2-172.31.23.12:22-139.178.89.65:39438.service: Deactivated successfully. Aug 13 00:20:47.672385 systemd-logind[2091]: Session 3 logged out. Waiting for processes to exit. Aug 13 00:20:47.678261 systemd[1]: session-3.scope: Deactivated successfully. Aug 13 00:20:47.681248 systemd-logind[2091]: Removed session 3. Aug 13 00:20:47.696640 systemd[1]: Started sshd@3-172.31.23.12:22-139.178.89.65:39440.service - OpenSSH per-connection server daemon (139.178.89.65:39440). Aug 13 00:20:47.872450 sshd[2406]: Accepted publickey for core from 139.178.89.65 port 39440 ssh2: RSA SHA256:5ZP49ylZaeKoaoG/AzraaaovTV7vWS+bRyuygC4N/Z4 Aug 13 00:20:47.875013 sshd[2406]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 00:20:47.884526 systemd-logind[2091]: New session 4 of user core. Aug 13 00:20:47.901718 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 13 00:20:48.037897 sshd[2406]: pam_unix(sshd:session): session closed for user core Aug 13 00:20:48.053729 systemd-logind[2091]: Session 4 logged out. Waiting for processes to exit. Aug 13 00:20:48.054885 systemd[1]: sshd@3-172.31.23.12:22-139.178.89.65:39440.service: Deactivated successfully. Aug 13 00:20:48.068255 systemd[1]: session-4.scope: Deactivated successfully. Aug 13 00:20:48.078621 systemd[1]: Started sshd@4-172.31.23.12:22-139.178.89.65:39452.service - OpenSSH per-connection server daemon (139.178.89.65:39452). Aug 13 00:20:48.080983 systemd-logind[2091]: Removed session 4. Aug 13 00:20:48.259900 sshd[2415]: Accepted publickey for core from 139.178.89.65 port 39452 ssh2: RSA SHA256:5ZP49ylZaeKoaoG/AzraaaovTV7vWS+bRyuygC4N/Z4 Aug 13 00:20:48.259663 sshd[2415]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 13 00:20:48.268322 systemd-logind[2091]: New session 5 of user core. Aug 13 00:20:48.276675 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 13 00:20:48.324706 kubelet[2372]: E0813 00:20:48.324580 2372 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Aug 13 00:20:48.328779 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 13 00:20:48.330102 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 13 00:20:48.409359 sudo[2421]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 13 00:20:48.410559 sudo[2421]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 13 00:20:49.478500 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 00:20:49.486658 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 00:20:49.553831 systemd[1]: Reloading requested from client PID 2455 ('systemctl') (unit session-5.scope)... Aug 13 00:20:49.553856 systemd[1]: Reloading... Aug 13 00:20:49.786096 zram_generator::config[2495]: No configuration found. Aug 13 00:20:50.054442 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. Aug 13 00:20:50.225521 systemd[1]: Reloading finished in 670 ms. Aug 13 00:20:50.302803 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Aug 13 00:20:50.303039 systemd[1]: kubelet.service: Failed with result 'signal'. Aug 13 00:20:50.303648 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 00:20:50.316015 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 13 00:20:50.656514 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 13 00:20:50.669848 (kubelet)[2568]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Aug 13 00:20:50.743810 kubelet[2568]: 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. Aug 13 00:20:50.743810 kubelet[2568]: 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. Aug 13 00:20:50.743810 kubelet[2568]: 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. Aug 13 00:20:50.745746 kubelet[2568]: I0813 00:20:50.745654 2568 server.go:211] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Aug 13 00:20:52.365640 kubelet[2568]: I0813 00:20:52.365593 2568 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Aug 13 00:20:52.366388 kubelet[2568]: I0813 00:20:52.366207 2568 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 13 00:20:52.366708 kubelet[2568]: I0813 00:20:52.366660 2568 server.go:934] "Client rotation is on, will bootstrap in background" Aug 13 00:20:52.418508 kubelet[2568]: I0813 00:20:52.418450 2568 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 13 00:20:52.431039 kubelet[2568]: E0813 00:20:52.430826 2568 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Aug 13 00:20:52.431039 kubelet[2568]: I0813 00:20:52.430879 2568 server.go:1408] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Aug 13 00:20:52.438946 kubelet[2568]: I0813 00:20:52.438908 2568 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 13 00:20:52.440104 kubelet[2568]: I0813 00:20:52.440075 2568 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Aug 13 00:20:52.440556 kubelet[2568]: I0813 00:20:52.440510 2568 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 13 00:20:52.440922 kubelet[2568]: I0813 00:20:52.440647 2568 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.23.12","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":1} Aug 13 00:20:52.441933 kubelet[2568]: I0813 00:20:52.441269 2568 topology_manager.go:138] "Creating topology manager with none policy" Aug 13 00:20:52.441933 kubelet[2568]: I0813 00:20:52.441298 2568 container_manager_linux.go:300] "Creating device plugin manager" Aug 13 00:20:52.441933 kubelet[2568]: I0813 00:20:52.441609 2568 state_mem.go:36] "Initialized new in-memory state store" Aug 13 00:20:52.446485 kubelet[2568]: I0813 00:20:52.446450 2568 kubelet.go:408] "Attempting to sync node with API server" Aug 13 00:20:52.446649 kubelet[2568]: I0813 00:20:52.446630 2568 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 13 00:20:52.446759 kubelet[2568]: I0813 00:20:52.446742 2568 kubelet.go:314] "Adding apiserver pod source" Aug 13 00:20:52.446858 kubelet[2568]: I0813 00:20:52.446840 2568 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 13 00:20:52.447001 kubelet[2568]: E0813 00:20:52.446960 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:52.447060 kubelet[2568]: E0813 00:20:52.446907 2568 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:52.454193 kubelet[2568]: I0813 00:20:52.454116 2568 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Aug 13 00:20:52.456186 kubelet[2568]: I0813 00:20:52.455588 2568 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Aug 13 00:20:52.456186 kubelet[2568]: W0813 00:20:52.456013 2568 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 13 00:20:52.457023 kubelet[2568]: W0813 00:20:52.456984 2568 reflector.go:561] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "172.31.23.12" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope Aug 13 00:20:52.457227 kubelet[2568]: E0813 00:20:52.457200 2568 reflector.go:158] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"172.31.23.12\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" Aug 13 00:20:52.457490 kubelet[2568]: W0813 00:20:52.457468 2568 reflector.go:561] 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 Aug 13 00:20:52.457612 kubelet[2568]: E0813 00:20:52.457586 2568 reflector.go:158] "Unhandled Error" err="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" logger="UnhandledError" Aug 13 00:20:52.458517 kubelet[2568]: I0813 00:20:52.458467 2568 server.go:1274] "Started kubelet" Aug 13 00:20:52.463257 kubelet[2568]: I0813 00:20:52.461607 2568 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Aug 13 00:20:52.463257 kubelet[2568]: I0813 00:20:52.462492 2568 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Aug 13 00:20:52.463257 kubelet[2568]: I0813 00:20:52.462968 2568 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 13 00:20:52.463958 kubelet[2568]: I0813 00:20:52.463935 2568 server.go:449] "Adding debug handlers to kubelet server" Aug 13 00:20:52.468064 kubelet[2568]: I0813 00:20:52.468029 2568 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 13 00:20:52.473244 kubelet[2568]: I0813 00:20:52.473037 2568 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Aug 13 00:20:52.478445 kubelet[2568]: I0813 00:20:52.478413 2568 volume_manager.go:289] "Starting Kubelet Volume Manager" Aug 13 00:20:52.479073 kubelet[2568]: E0813 00:20:52.479037 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:52.480459 kubelet[2568]: I0813 00:20:52.480426 2568 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Aug 13 00:20:52.480689 kubelet[2568]: I0813 00:20:52.480670 2568 reconciler.go:26] "Reconciler: start to sync state" Aug 13 00:20:52.486881 kubelet[2568]: E0813 00:20:52.486824 2568 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 13 00:20:52.487492 kubelet[2568]: I0813 00:20:52.487434 2568 factory.go:221] Registration of the systemd container factory successfully Aug 13 00:20:52.487751 kubelet[2568]: I0813 00:20:52.487683 2568 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 Aug 13 00:20:52.496307 kubelet[2568]: E0813 00:20:52.493189 2568 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"172.31.23.12\" not found" node="172.31.23.12" Aug 13 00:20:52.496557 kubelet[2568]: I0813 00:20:52.496522 2568 factory.go:221] Registration of the containerd container factory successfully Aug 13 00:20:52.562443 kubelet[2568]: I0813 00:20:52.562349 2568 cpu_manager.go:214] "Starting CPU manager" policy="none" Aug 13 00:20:52.562623 kubelet[2568]: I0813 00:20:52.562601 2568 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Aug 13 00:20:52.562734 kubelet[2568]: I0813 00:20:52.562717 2568 state_mem.go:36] "Initialized new in-memory state store" Aug 13 00:20:52.568327 kubelet[2568]: I0813 00:20:52.568292 2568 policy_none.go:49] "None policy: Start" Aug 13 00:20:52.569855 kubelet[2568]: I0813 00:20:52.569828 2568 memory_manager.go:170] "Starting memorymanager" policy="None" Aug 13 00:20:52.570109 kubelet[2568]: I0813 00:20:52.570076 2568 state_mem.go:35] "Initializing new in-memory state store" Aug 13 00:20:52.582091 kubelet[2568]: E0813 00:20:52.582033 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:52.589541 kubelet[2568]: I0813 00:20:52.589491 2568 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 13 00:20:52.593579 kubelet[2568]: I0813 00:20:52.593547 2568 eviction_manager.go:189] "Eviction manager: starting control loop" Aug 13 00:20:52.594243 kubelet[2568]: I0813 00:20:52.593710 2568 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Aug 13 00:20:52.594428 kubelet[2568]: I0813 00:20:52.594406 2568 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 13 00:20:52.598357 kubelet[2568]: E0813 00:20:52.598305 2568 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.23.12\" not found" Aug 13 00:20:52.600872 kubelet[2568]: I0813 00:20:52.600602 2568 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 13 00:20:52.603666 kubelet[2568]: I0813 00:20:52.603626 2568 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 13 00:20:52.603825 kubelet[2568]: I0813 00:20:52.603806 2568 status_manager.go:217] "Starting to sync pod status with apiserver" Aug 13 00:20:52.604403 kubelet[2568]: I0813 00:20:52.603916 2568 kubelet.go:2321] "Starting kubelet main sync loop" Aug 13 00:20:52.604403 kubelet[2568]: E0813 00:20:52.603997 2568 kubelet.go:2345] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Aug 13 00:20:52.695578 kubelet[2568]: I0813 00:20:52.695448 2568 kubelet_node_status.go:72] "Attempting to register node" node="172.31.23.12" Aug 13 00:20:52.705551 kubelet[2568]: I0813 00:20:52.705511 2568 kubelet_node_status.go:75] "Successfully registered node" node="172.31.23.12" Aug 13 00:20:52.705733 kubelet[2568]: E0813 00:20:52.705711 2568 kubelet_node_status.go:535] "Error updating node status, will retry" err="error getting node \"172.31.23.12\": node \"172.31.23.12\" not found" Aug 13 00:20:52.744989 kubelet[2568]: E0813 00:20:52.744933 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:52.757836 sudo[2421]: pam_unix(sudo:session): session closed for user root Aug 13 00:20:52.781354 sshd[2415]: pam_unix(sshd:session): session closed for user core Aug 13 00:20:52.787097 systemd[1]: sshd@4-172.31.23.12:22-139.178.89.65:39452.service: Deactivated successfully. Aug 13 00:20:52.793676 systemd[1]: session-5.scope: Deactivated successfully. Aug 13 00:20:52.795552 systemd-logind[2091]: Session 5 logged out. Waiting for processes to exit. Aug 13 00:20:52.798588 systemd-logind[2091]: Removed session 5. Aug 13 00:20:52.845590 kubelet[2568]: E0813 00:20:52.845520 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:52.946309 kubelet[2568]: E0813 00:20:52.946188 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.047104 kubelet[2568]: E0813 00:20:53.047047 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.147735 kubelet[2568]: E0813 00:20:53.147695 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.248485 kubelet[2568]: E0813 00:20:53.248360 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.349207 kubelet[2568]: E0813 00:20:53.349134 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.379687 kubelet[2568]: I0813 00:20:53.379599 2568 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 13 00:20:53.380456 kubelet[2568]: W0813 00:20:53.379818 2568 reflector.go:484] 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 Aug 13 00:20:53.380456 kubelet[2568]: W0813 00:20:53.379877 2568 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.Service 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 Aug 13 00:20:53.380456 kubelet[2568]: W0813 00:20:53.379919 2568 reflector.go:484] 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 Aug 13 00:20:53.447328 kubelet[2568]: E0813 00:20:53.447270 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:53.449538 kubelet[2568]: E0813 00:20:53.449502 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.550637 kubelet[2568]: E0813 00:20:53.550521 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.651699 kubelet[2568]: E0813 00:20:53.651648 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.752292 kubelet[2568]: E0813 00:20:53.752256 2568 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"172.31.23.12\" not found" Aug 13 00:20:53.854878 kubelet[2568]: I0813 00:20:53.854026 2568 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 13 00:20:53.855061 containerd[2112]: time="2025-08-13T00:20:53.854792991Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 13 00:20:53.856118 kubelet[2568]: I0813 00:20:53.855758 2568 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 13 00:20:54.447460 kubelet[2568]: E0813 00:20:54.447398 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:54.447460 kubelet[2568]: I0813 00:20:54.447467 2568 apiserver.go:52] "Watching apiserver" Aug 13 00:20:54.482562 kubelet[2568]: I0813 00:20:54.482497 2568 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Aug 13 00:20:54.498804 kubelet[2568]: I0813 00:20:54.498748 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-sgd7s\" (UniqueName: \"kubernetes.io/projected/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-kube-api-access-sgd7s\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.499945 kubelet[2568]: I0813 00:20:54.499462 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/526c9d6d-f546-454a-8842-cd0faf8167a0-lib-modules\") pod \"kube-proxy-h5gbf\" (UID: \"526c9d6d-f546-454a-8842-cd0faf8167a0\") " pod="kube-system/kube-proxy-h5gbf" Aug 13 00:20:54.499945 kubelet[2568]: I0813 00:20:54.499535 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-xtables-lock\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.499945 kubelet[2568]: I0813 00:20:54.499576 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-cni-plugin\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.499945 kubelet[2568]: I0813 00:20:54.499615 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-cni\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.499945 kubelet[2568]: I0813 00:20:54.499652 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-flannel-cfg\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.500306 kubelet[2568]: I0813 00:20:54.499687 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/526c9d6d-f546-454a-8842-cd0faf8167a0-kube-proxy\") pod \"kube-proxy-h5gbf\" (UID: \"526c9d6d-f546-454a-8842-cd0faf8167a0\") " pod="kube-system/kube-proxy-h5gbf" Aug 13 00:20:54.500306 kubelet[2568]: I0813 00:20:54.499721 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/526c9d6d-f546-454a-8842-cd0faf8167a0-xtables-lock\") pod \"kube-proxy-h5gbf\" (UID: \"526c9d6d-f546-454a-8842-cd0faf8167a0\") " pod="kube-system/kube-proxy-h5gbf" Aug 13 00:20:54.500306 kubelet[2568]: I0813 00:20:54.499759 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-mgf7f\" (UniqueName: \"kubernetes.io/projected/526c9d6d-f546-454a-8842-cd0faf8167a0-kube-api-access-mgf7f\") pod \"kube-proxy-h5gbf\" (UID: \"526c9d6d-f546-454a-8842-cd0faf8167a0\") " pod="kube-system/kube-proxy-h5gbf" Aug 13 00:20:54.500306 kubelet[2568]: I0813 00:20:54.499794 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/d0b62270-fc3d-4d22-aaae-3e5ee0e3b225-run\") pod \"kube-flannel-ds-8g9jx\" (UID: \"d0b62270-fc3d-4d22-aaae-3e5ee0e3b225\") " pod="kube-flannel/kube-flannel-ds-8g9jx" Aug 13 00:20:54.759662 containerd[2112]: time="2025-08-13T00:20:54.759508786Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-8g9jx,Uid:d0b62270-fc3d-4d22-aaae-3e5ee0e3b225,Namespace:kube-flannel,Attempt:0,}" Aug 13 00:20:54.766749 containerd[2112]: time="2025-08-13T00:20:54.766690409Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-h5gbf,Uid:526c9d6d-f546-454a-8842-cd0faf8167a0,Namespace:kube-system,Attempt:0,}" Aug 13 00:20:55.377591 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount131043344.mount: Deactivated successfully. Aug 13 00:20:55.397624 containerd[2112]: time="2025-08-13T00:20:55.397534955Z" 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\"}" Aug 13 00:20:55.400205 containerd[2112]: time="2025-08-13T00:20:55.399576046Z" 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\"}" Aug 13 00:20:55.401515 containerd[2112]: time="2025-08-13T00:20:55.401418876Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269173" Aug 13 00:20:55.403327 containerd[2112]: time="2025-08-13T00:20:55.403278558Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Aug 13 00:20:55.405499 containerd[2112]: time="2025-08-13T00:20:55.405419295Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 13 00:20:55.411411 containerd[2112]: time="2025-08-13T00:20:55.411308301Z" 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\"}" Aug 13 00:20:55.413603 containerd[2112]: time="2025-08-13T00:20:55.413199119Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 653.563101ms" Aug 13 00:20:55.417926 containerd[2112]: time="2025-08-13T00:20:55.417849553Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 651.045657ms" Aug 13 00:20:55.447854 kubelet[2568]: E0813 00:20:55.447783 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.610068492Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.610213211Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.610251736Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.610436935Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.609757823Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.609875400Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:20:55.610701 containerd[2112]: time="2025-08-13T00:20:55.609913685Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:20:55.613390 containerd[2112]: time="2025-08-13T00:20:55.612716923Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:20:55.742130 systemd[1]: run-containerd-runc-k8s.io-9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472-runc.BFhxn8.mount: Deactivated successfully. Aug 13 00:20:55.800316 containerd[2112]: time="2025-08-13T00:20:55.799007743Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-h5gbf,Uid:526c9d6d-f546-454a-8842-cd0faf8167a0,Namespace:kube-system,Attempt:0,} returns sandbox id \"b0e4a65d3c1a7ec37999e9bd677afc7abc19fc3b760597cf872ffe345cad6c04\"" Aug 13 00:20:55.805646 containerd[2112]: time="2025-08-13T00:20:55.805599322Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\"" Aug 13 00:20:55.828210 containerd[2112]: time="2025-08-13T00:20:55.828115706Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-8g9jx,Uid:d0b62270-fc3d-4d22-aaae-3e5ee0e3b225,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\"" Aug 13 00:20:56.448811 kubelet[2568]: E0813 00:20:56.448489 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:57.075313 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1168426654.mount: Deactivated successfully. Aug 13 00:20:57.449248 kubelet[2568]: E0813 00:20:57.449049 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:57.624690 containerd[2112]: time="2025-08-13T00:20:57.624606609Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:57.626492 containerd[2112]: time="2025-08-13T00:20:57.626424024Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.11: active requests=0, bytes read=26915993" Aug 13 00:20:57.629289 containerd[2112]: time="2025-08-13T00:20:57.629212005Z" level=info msg="ImageCreate event name:\"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:57.633970 containerd[2112]: time="2025-08-13T00:20:57.633851800Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:57.635498 containerd[2112]: time="2025-08-13T00:20:57.635210108Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.11\" with image id \"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\", repo tag \"registry.k8s.io/kube-proxy:v1.31.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79\", size \"26915012\" in 1.828968244s" Aug 13 00:20:57.635498 containerd[2112]: time="2025-08-13T00:20:57.635274336Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\" returns image reference \"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\"" Aug 13 00:20:57.638082 containerd[2112]: time="2025-08-13T00:20:57.637753364Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 13 00:20:57.640319 containerd[2112]: time="2025-08-13T00:20:57.640245046Z" level=info msg="CreateContainer within sandbox \"b0e4a65d3c1a7ec37999e9bd677afc7abc19fc3b760597cf872ffe345cad6c04\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 13 00:20:57.676812 containerd[2112]: time="2025-08-13T00:20:57.676727855Z" level=info msg="CreateContainer within sandbox \"b0e4a65d3c1a7ec37999e9bd677afc7abc19fc3b760597cf872ffe345cad6c04\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"1e962fb4b4d88b95b9751280b475a8866e943bc32e2df6355811c227c1e12ee8\"" Aug 13 00:20:57.678175 containerd[2112]: time="2025-08-13T00:20:57.678103231Z" level=info msg="StartContainer for \"1e962fb4b4d88b95b9751280b475a8866e943bc32e2df6355811c227c1e12ee8\"" Aug 13 00:20:57.773667 containerd[2112]: time="2025-08-13T00:20:57.773486248Z" level=info msg="StartContainer for \"1e962fb4b4d88b95b9751280b475a8866e943bc32e2df6355811c227c1e12ee8\" returns successfully" Aug 13 00:20:58.449941 kubelet[2568]: E0813 00:20:58.449880 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:58.642347 kubelet[2568]: I0813 00:20:58.642087 2568 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-h5gbf" podStartSLOduration=4.808974534 podStartE2EDuration="6.642068486s" podCreationTimestamp="2025-08-13 00:20:52 +0000 UTC" firstStartedPulling="2025-08-13 00:20:55.804093547 +0000 UTC m=+5.127045154" lastFinishedPulling="2025-08-13 00:20:57.637187475 +0000 UTC m=+6.960139106" observedRunningTime="2025-08-13 00:20:58.641893746 +0000 UTC m=+7.964845389" watchObservedRunningTime="2025-08-13 00:20:58.642068486 +0000 UTC m=+7.965020129" Aug 13 00:20:59.451116 kubelet[2568]: E0813 00:20:59.451054 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:20:59.460832 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3534954543.mount: Deactivated successfully. Aug 13 00:20:59.524599 containerd[2112]: time="2025-08-13T00:20:59.523861876Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:59.527525 containerd[2112]: time="2025-08-13T00:20:59.527469035Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532" Aug 13 00:20:59.528438 containerd[2112]: time="2025-08-13T00:20:59.528367074Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:59.533547 containerd[2112]: time="2025-08-13T00:20:59.533464272Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:20:59.535589 containerd[2112]: time="2025-08-13T00:20:59.535052218Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3662650\" in 1.897234158s" Aug 13 00:20:59.535589 containerd[2112]: time="2025-08-13T00:20:59.535113375Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Aug 13 00:20:59.541956 containerd[2112]: time="2025-08-13T00:20:59.541450525Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 13 00:20:59.571123 containerd[2112]: time="2025-08-13T00:20:59.571067657Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2\"" Aug 13 00:20:59.572484 containerd[2112]: time="2025-08-13T00:20:59.572394649Z" level=info msg="StartContainer for \"53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2\"" Aug 13 00:20:59.671815 containerd[2112]: time="2025-08-13T00:20:59.671632886Z" level=info msg="StartContainer for \"53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2\" returns successfully" Aug 13 00:20:59.885101 containerd[2112]: time="2025-08-13T00:20:59.884921049Z" level=info msg="shim disconnected" id=53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2 namespace=k8s.io Aug 13 00:20:59.885723 containerd[2112]: time="2025-08-13T00:20:59.885401445Z" level=warning msg="cleaning up after shim disconnected" id=53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2 namespace=k8s.io Aug 13 00:20:59.885723 containerd[2112]: time="2025-08-13T00:20:59.885432581Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 13 00:21:00.325494 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-53388235943f06bd158e4b00c3c8df8d08239e8891bdbdc06a516e2dd3fb85d2-rootfs.mount: Deactivated successfully. Aug 13 00:21:00.451322 kubelet[2568]: E0813 00:21:00.451255 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:00.642859 containerd[2112]: time="2025-08-13T00:21:00.642590991Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 13 00:21:01.451611 kubelet[2568]: E0813 00:21:01.451527 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:02.451828 kubelet[2568]: E0813 00:21:02.451765 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:02.679675 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3808611968.mount: Deactivated successfully. Aug 13 00:21:03.452277 kubelet[2568]: E0813 00:21:03.452231 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:03.760026 containerd[2112]: time="2025-08-13T00:21:03.759623528Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:03.762768 containerd[2112]: time="2025-08-13T00:21:03.762685848Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261" Aug 13 00:21:03.765516 containerd[2112]: time="2025-08-13T00:21:03.765433805Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:03.771945 containerd[2112]: time="2025-08-13T00:21:03.771844035Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:03.774251 containerd[2112]: time="2025-08-13T00:21:03.774202499Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26863435\" in 3.131551034s" Aug 13 00:21:03.774546 containerd[2112]: time="2025-08-13T00:21:03.774407884Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Aug 13 00:21:03.778083 containerd[2112]: time="2025-08-13T00:21:03.777968675Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 13 00:21:03.800017 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount634899023.mount: Deactivated successfully. Aug 13 00:21:03.804826 containerd[2112]: time="2025-08-13T00:21:03.804747247Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9\"" Aug 13 00:21:03.805863 containerd[2112]: time="2025-08-13T00:21:03.805751529Z" level=info msg="StartContainer for \"7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9\"" Aug 13 00:21:03.857609 systemd[1]: run-containerd-runc-k8s.io-7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9-runc.tOrndc.mount: Deactivated successfully. Aug 13 00:21:03.917885 containerd[2112]: time="2025-08-13T00:21:03.917830937Z" level=info msg="StartContainer for \"7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9\" returns successfully" Aug 13 00:21:03.963342 kubelet[2568]: I0813 00:21:03.963312 2568 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Aug 13 00:21:04.080570 containerd[2112]: time="2025-08-13T00:21:04.080347239Z" level=info msg="shim disconnected" id=7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9 namespace=k8s.io Aug 13 00:21:04.080570 containerd[2112]: time="2025-08-13T00:21:04.080473344Z" level=warning msg="cleaning up after shim disconnected" id=7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9 namespace=k8s.io Aug 13 00:21:04.080570 containerd[2112]: time="2025-08-13T00:21:04.080529536Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 13 00:21:04.453253 kubelet[2568]: E0813 00:21:04.453084 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:04.662047 containerd[2112]: time="2025-08-13T00:21:04.661830466Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 13 00:21:04.678425 containerd[2112]: time="2025-08-13T00:21:04.678335913Z" level=info msg="CreateContainer within sandbox \"9e762672c2b708e0167e745b6f5b537a45d9156926d663bc39ca9cf4d0719472\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"4561d4fa09ffe9688abd8fb3045091511a9dbd9981d936115301c6d650b2f4f7\"" Aug 13 00:21:04.680505 containerd[2112]: time="2025-08-13T00:21:04.679596050Z" level=info msg="StartContainer for \"4561d4fa09ffe9688abd8fb3045091511a9dbd9981d936115301c6d650b2f4f7\"" Aug 13 00:21:04.763031 containerd[2112]: time="2025-08-13T00:21:04.762679904Z" level=info msg="StartContainer for \"4561d4fa09ffe9688abd8fb3045091511a9dbd9981d936115301c6d650b2f4f7\" returns successfully" Aug 13 00:21:04.800629 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-7cd97729ab7a301c1de9079addfc070166f62373b2d69d1bc185336e0600b8e9-rootfs.mount: Deactivated successfully. Aug 13 00:21:04.857653 kubelet[2568]: I0813 00:21:04.857537 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-x59ng\" (UniqueName: \"kubernetes.io/projected/dcd7b24d-f221-44a9-abe6-64f3729afa49-kube-api-access-x59ng\") pod \"nginx-deployment-8587fbcb89-f982h\" (UID: \"dcd7b24d-f221-44a9-abe6-64f3729afa49\") " pod="default/nginx-deployment-8587fbcb89-f982h" Aug 13 00:21:05.120456 containerd[2112]: time="2025-08-13T00:21:05.120300277Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-f982h,Uid:dcd7b24d-f221-44a9-abe6-64f3729afa49,Namespace:default,Attempt:0,}" Aug 13 00:21:05.175554 containerd[2112]: time="2025-08-13T00:21:05.175469463Z" level=error msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-f982h,Uid:dcd7b24d-f221-44a9-abe6-64f3729afa49,Namespace:default,Attempt:0,} failed, error" error="failed to setup network for sandbox \"988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Aug 13 00:21:05.176282 kubelet[2568]: E0813 00:21:05.175972 2568 log.go:32] "RunPodSandbox from runtime service failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" Aug 13 00:21:05.176282 kubelet[2568]: E0813 00:21:05.176072 2568 kuberuntime_sandbox.go:72] "Failed to create sandbox for pod" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-f982h" Aug 13 00:21:05.176282 kubelet[2568]: E0813 00:21:05.176104 2568 kuberuntime_manager.go:1170] "CreatePodSandbox for pod failed" err="rpc error: code = Unknown desc = failed to setup network for sandbox \"988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3\": plugin type=\"flannel\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory" pod="default/nginx-deployment-8587fbcb89-f982h" Aug 13 00:21:05.176036 systemd[1]: run-netns-cni\x2d86b85f2c\x2d33a6\x2d0250\x2dac9c\x2d64ada0dbef5d.mount: Deactivated successfully. Aug 13 00:21:05.177606 kubelet[2568]: E0813 00:21:05.177526 2568 pod_workers.go:1301] "Error syncing pod, skipping" err="failed to \"CreatePodSandbox\" for \"nginx-deployment-8587fbcb89-f982h_default(dcd7b24d-f221-44a9-abe6-64f3729afa49)\" with CreatePodSandboxError: \"Failed to create sandbox for pod \\\"nginx-deployment-8587fbcb89-f982h_default(dcd7b24d-f221-44a9-abe6-64f3729afa49)\\\": rpc error: code = Unknown desc = failed to setup network for sandbox \\\"988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3\\\": plugin type=\\\"flannel\\\" failed (add): loadFlannelSubnetEnv failed: open /run/flannel/subnet.env: no such file or directory\"" pod="default/nginx-deployment-8587fbcb89-f982h" podUID="dcd7b24d-f221-44a9-abe6-64f3729afa49" Aug 13 00:21:05.454113 kubelet[2568]: E0813 00:21:05.453930 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:05.792295 systemd[1]: run-containerd-io.containerd.grpc.v1.cri-sandboxes-988e80bfd6288c49248ca3d6d1566fc5adb03ac3d393d9e175508ddcf6a744d3-shm.mount: Deactivated successfully. Aug 13 00:21:05.874843 (udev-worker)[3094]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:21:05.894508 systemd-networkd[1690]: flannel.1: Link UP Aug 13 00:21:05.894530 systemd-networkd[1690]: flannel.1: Gained carrier Aug 13 00:21:06.454665 kubelet[2568]: E0813 00:21:06.454604 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:06.971503 systemd-networkd[1690]: flannel.1: Gained IPv6LL Aug 13 00:21:07.455010 kubelet[2568]: E0813 00:21:07.454845 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:08.455420 kubelet[2568]: E0813 00:21:08.455358 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:09.455944 kubelet[2568]: E0813 00:21:09.455876 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:09.881946 ntpd[2075]: Listen normally on 6 flannel.1 192.168.1.0:123 Aug 13 00:21:09.882683 ntpd[2075]: 13 Aug 00:21:09 ntpd[2075]: Listen normally on 6 flannel.1 192.168.1.0:123 Aug 13 00:21:09.882683 ntpd[2075]: 13 Aug 00:21:09 ntpd[2075]: Listen normally on 7 flannel.1 [fe80::2881:ff:fe52:9a79%3]:123 Aug 13 00:21:09.882100 ntpd[2075]: Listen normally on 7 flannel.1 [fe80::2881:ff:fe52:9a79%3]:123 Aug 13 00:21:10.456344 kubelet[2568]: E0813 00:21:10.456277 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:11.456830 kubelet[2568]: E0813 00:21:11.456762 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:12.447507 kubelet[2568]: E0813 00:21:12.447451 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:12.457316 kubelet[2568]: E0813 00:21:12.457276 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:13.457882 kubelet[2568]: E0813 00:21:13.457825 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:14.458338 kubelet[2568]: E0813 00:21:14.458279 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:15.458790 kubelet[2568]: E0813 00:21:15.458737 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:15.489089 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Aug 13 00:21:16.458959 kubelet[2568]: E0813 00:21:16.458885 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:17.460110 kubelet[2568]: E0813 00:21:17.460039 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:18.460745 kubelet[2568]: E0813 00:21:18.460679 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:18.605922 containerd[2112]: time="2025-08-13T00:21:18.605375603Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-f982h,Uid:dcd7b24d-f221-44a9-abe6-64f3729afa49,Namespace:default,Attempt:0,}" Aug 13 00:21:18.643413 systemd-networkd[1690]: cni0: Link UP Aug 13 00:21:18.643436 systemd-networkd[1690]: cni0: Gained carrier Aug 13 00:21:18.650345 (udev-worker)[3237]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:21:18.651871 systemd-networkd[1690]: cni0: Lost carrier Aug 13 00:21:18.657552 systemd-networkd[1690]: veth72c2e262: Link UP Aug 13 00:21:18.661421 kernel: cni0: port 1(veth72c2e262) entered blocking state Aug 13 00:21:18.661581 kernel: cni0: port 1(veth72c2e262) entered disabled state Aug 13 00:21:18.664252 kernel: veth72c2e262: entered allmulticast mode Aug 13 00:21:18.664355 kernel: veth72c2e262: entered promiscuous mode Aug 13 00:21:18.665881 kernel: cni0: port 1(veth72c2e262) entered blocking state Aug 13 00:21:18.665950 kernel: cni0: port 1(veth72c2e262) entered forwarding state Aug 13 00:21:18.673284 kernel: cni0: port 1(veth72c2e262) entered disabled state Aug 13 00:21:18.673743 (udev-worker)[3241]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:21:18.686800 kernel: cni0: port 1(veth72c2e262) entered blocking state Aug 13 00:21:18.686922 kernel: cni0: port 1(veth72c2e262) entered forwarding state Aug 13 00:21:18.685839 systemd-networkd[1690]: veth72c2e262: Gained carrier Aug 13 00:21:18.687605 systemd-networkd[1690]: cni0: Gained carrier Aug 13 00:21:18.693359 containerd[2112]: 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)(0x400001c938), "name":"cbr0", "type":"bridge"} Aug 13 00:21:18.693359 containerd[2112]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:21:18.734708 containerd[2112]: {"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":8951,"name":"cbr0","type":"bridge"}time="2025-08-13T00:21:18.734204716Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:21:18.734708 containerd[2112]: time="2025-08-13T00:21:18.734427697Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:21:18.734708 containerd[2112]: time="2025-08-13T00:21:18.734470467Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:18.735414 containerd[2112]: time="2025-08-13T00:21:18.735079751Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:18.822326 containerd[2112]: time="2025-08-13T00:21:18.822269294Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-f982h,Uid:dcd7b24d-f221-44a9-abe6-64f3729afa49,Namespace:default,Attempt:0,} returns sandbox id \"37fada8511a4454b765c280c7ab79106aa81f9b44526a72e85d9c625be363d05\"" Aug 13 00:21:18.825271 containerd[2112]: time="2025-08-13T00:21:18.824967429Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 00:21:19.461313 kubelet[2568]: E0813 00:21:19.461235 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:20.155474 systemd-networkd[1690]: veth72c2e262: Gained IPv6LL Aug 13 00:21:20.219630 systemd-networkd[1690]: cni0: Gained IPv6LL Aug 13 00:21:20.462007 kubelet[2568]: E0813 00:21:20.461849 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:21.462445 kubelet[2568]: E0813 00:21:21.462393 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:21.838235 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1513073140.mount: Deactivated successfully. Aug 13 00:21:22.463632 kubelet[2568]: E0813 00:21:22.463571 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:22.881986 ntpd[2075]: Listen normally on 8 cni0 192.168.1.1:123 Aug 13 00:21:22.882568 ntpd[2075]: 13 Aug 00:21:22 ntpd[2075]: Listen normally on 8 cni0 192.168.1.1:123 Aug 13 00:21:22.882568 ntpd[2075]: 13 Aug 00:21:22 ntpd[2075]: Listen normally on 9 cni0 [fe80::8862:82ff:fed5:1b9c%4]:123 Aug 13 00:21:22.882568 ntpd[2075]: 13 Aug 00:21:22 ntpd[2075]: Listen normally on 10 veth72c2e262 [fe80::58cc:4ff:fe5c:8c2f%5]:123 Aug 13 00:21:22.882133 ntpd[2075]: Listen normally on 9 cni0 [fe80::8862:82ff:fed5:1b9c%4]:123 Aug 13 00:21:22.882252 ntpd[2075]: Listen normally on 10 veth72c2e262 [fe80::58cc:4ff:fe5c:8c2f%5]:123 Aug 13 00:21:23.277784 containerd[2112]: time="2025-08-13T00:21:23.277697459Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:23.280024 containerd[2112]: time="2025-08-13T00:21:23.279957764Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69963857" Aug 13 00:21:23.282913 containerd[2112]: time="2025-08-13T00:21:23.282824762Z" level=info msg="ImageCreate event name:\"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:23.288918 containerd[2112]: time="2025-08-13T00:21:23.288807765Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:23.292731 containerd[2112]: time="2025-08-13T00:21:23.292518421Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"69963735\" in 4.467497103s" Aug 13 00:21:23.292731 containerd[2112]: time="2025-08-13T00:21:23.292580658Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 13 00:21:23.296358 containerd[2112]: time="2025-08-13T00:21:23.296270996Z" level=info msg="CreateContainer within sandbox \"37fada8511a4454b765c280c7ab79106aa81f9b44526a72e85d9c625be363d05\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 13 00:21:23.323209 containerd[2112]: time="2025-08-13T00:21:23.323111841Z" level=info msg="CreateContainer within sandbox \"37fada8511a4454b765c280c7ab79106aa81f9b44526a72e85d9c625be363d05\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"aa9bf4b2f9166afb82fce332442d9a333427cb3f799cde64716a94b4645dfcfa\"" Aug 13 00:21:23.323801 containerd[2112]: time="2025-08-13T00:21:23.323757682Z" level=info msg="StartContainer for \"aa9bf4b2f9166afb82fce332442d9a333427cb3f799cde64716a94b4645dfcfa\"" Aug 13 00:21:23.418759 containerd[2112]: time="2025-08-13T00:21:23.418681460Z" level=info msg="StartContainer for \"aa9bf4b2f9166afb82fce332442d9a333427cb3f799cde64716a94b4645dfcfa\" returns successfully" Aug 13 00:21:23.463835 kubelet[2568]: E0813 00:21:23.463767 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:23.725774 kubelet[2568]: I0813 00:21:23.725588 2568 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-8g9jx" podStartSLOduration=23.779660415 podStartE2EDuration="31.725568389s" podCreationTimestamp="2025-08-13 00:20:52 +0000 UTC" firstStartedPulling="2025-08-13 00:20:55.830121487 +0000 UTC m=+5.153073106" lastFinishedPulling="2025-08-13 00:21:03.776029461 +0000 UTC m=+13.098981080" observedRunningTime="2025-08-13 00:21:05.677545201 +0000 UTC m=+15.000496820" watchObservedRunningTime="2025-08-13 00:21:23.725568389 +0000 UTC m=+33.048520020" Aug 13 00:21:24.464211 kubelet[2568]: E0813 00:21:24.464118 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:25.465272 kubelet[2568]: E0813 00:21:25.465209 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:26.466026 kubelet[2568]: E0813 00:21:26.465960 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:27.466412 kubelet[2568]: E0813 00:21:27.466344 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:28.467471 kubelet[2568]: E0813 00:21:28.467409 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:29.468461 kubelet[2568]: E0813 00:21:29.468408 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:29.591880 update_engine[2094]: I20250813 00:21:29.591796 2094 update_attempter.cc:509] Updating boot flags... Aug 13 00:21:29.670352 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (3442) Aug 13 00:21:29.893225 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 41 scanned by (udev-worker) (3441) Aug 13 00:21:30.135225 kubelet[2568]: I0813 00:21:30.135088 2568 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-f982h" podStartSLOduration=21.665654279 podStartE2EDuration="26.135067963s" podCreationTimestamp="2025-08-13 00:21:04 +0000 UTC" firstStartedPulling="2025-08-13 00:21:18.824119285 +0000 UTC m=+28.147070904" lastFinishedPulling="2025-08-13 00:21:23.293532969 +0000 UTC m=+32.616484588" observedRunningTime="2025-08-13 00:21:23.726196587 +0000 UTC m=+33.049148230" watchObservedRunningTime="2025-08-13 00:21:30.135067963 +0000 UTC m=+39.458019594" Aug 13 00:21:30.222577 kubelet[2568]: I0813 00:21:30.222206 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-dcjgz\" (UniqueName: \"kubernetes.io/projected/41dfbda6-4316-4fab-87b9-798fb060c8c8-kube-api-access-dcjgz\") pod \"nfs-server-provisioner-0\" (UID: \"41dfbda6-4316-4fab-87b9-798fb060c8c8\") " pod="default/nfs-server-provisioner-0" Aug 13 00:21:30.222577 kubelet[2568]: I0813 00:21:30.222277 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/41dfbda6-4316-4fab-87b9-798fb060c8c8-data\") pod \"nfs-server-provisioner-0\" (UID: \"41dfbda6-4316-4fab-87b9-798fb060c8c8\") " pod="default/nfs-server-provisioner-0" Aug 13 00:21:30.442953 containerd[2112]: time="2025-08-13T00:21:30.442747359Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:41dfbda6-4316-4fab-87b9-798fb060c8c8,Namespace:default,Attempt:0,}" Aug 13 00:21:30.469667 kubelet[2568]: E0813 00:21:30.469414 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:30.486432 (udev-worker)[3433]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:21:30.489173 systemd-networkd[1690]: vethf5e5715e: Link UP Aug 13 00:21:30.494193 kernel: cni0: port 2(vethf5e5715e) entered blocking state Aug 13 00:21:30.494286 kernel: cni0: port 2(vethf5e5715e) entered disabled state Aug 13 00:21:30.494343 kernel: vethf5e5715e: entered allmulticast mode Aug 13 00:21:30.496182 kernel: vethf5e5715e: entered promiscuous mode Aug 13 00:21:30.511888 kernel: cni0: port 2(vethf5e5715e) entered blocking state Aug 13 00:21:30.512023 kernel: cni0: port 2(vethf5e5715e) entered forwarding state Aug 13 00:21:30.512029 systemd-networkd[1690]: vethf5e5715e: Gained carrier Aug 13 00:21:30.516891 containerd[2112]: 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)(0x40000928e8), "name":"cbr0", "type":"bridge"} Aug 13 00:21:30.516891 containerd[2112]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:21:30.552295 containerd[2112]: {"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":8951,"name":"cbr0","type":"bridge"}time="2025-08-13T00:21:30.551922109Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:21:30.552295 containerd[2112]: time="2025-08-13T00:21:30.552013635Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:21:30.552295 containerd[2112]: time="2025-08-13T00:21:30.552038691Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:30.552893 containerd[2112]: time="2025-08-13T00:21:30.552243164Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:30.592588 systemd[1]: run-containerd-runc-k8s.io-34b52a51550860d3a7ab5845e1c0761e705a1ec38cbeac39d9dca1502ab5d1b0-runc.D5pCgT.mount: Deactivated successfully. Aug 13 00:21:30.653100 containerd[2112]: time="2025-08-13T00:21:30.653020735Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:41dfbda6-4316-4fab-87b9-798fb060c8c8,Namespace:default,Attempt:0,} returns sandbox id \"34b52a51550860d3a7ab5845e1c0761e705a1ec38cbeac39d9dca1502ab5d1b0\"" Aug 13 00:21:30.656067 containerd[2112]: time="2025-08-13T00:21:30.655791589Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 13 00:21:31.470001 kubelet[2568]: E0813 00:21:31.469834 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:32.061083 systemd-networkd[1690]: vethf5e5715e: Gained IPv6LL Aug 13 00:21:32.447543 kubelet[2568]: E0813 00:21:32.447404 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:32.470651 kubelet[2568]: E0813 00:21:32.470379 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:33.140200 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3572027647.mount: Deactivated successfully. Aug 13 00:21:33.471689 kubelet[2568]: E0813 00:21:33.471397 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:34.471880 kubelet[2568]: E0813 00:21:34.471811 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:35.472386 kubelet[2568]: E0813 00:21:35.472338 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:36.473545 kubelet[2568]: E0813 00:21:36.473469 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:36.636419 containerd[2112]: time="2025-08-13T00:21:36.635554165Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:36.637671 containerd[2112]: time="2025-08-13T00:21:36.637598603Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373623" Aug 13 00:21:36.640057 containerd[2112]: time="2025-08-13T00:21:36.639981319Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:36.645841 containerd[2112]: time="2025-08-13T00:21:36.645740454Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:36.648002 containerd[2112]: time="2025-08-13T00:21:36.647779122Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 5.991922262s" Aug 13 00:21:36.648002 containerd[2112]: time="2025-08-13T00:21:36.647862576Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Aug 13 00:21:36.652536 containerd[2112]: time="2025-08-13T00:21:36.652460800Z" level=info msg="CreateContainer within sandbox \"34b52a51550860d3a7ab5845e1c0761e705a1ec38cbeac39d9dca1502ab5d1b0\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 13 00:21:36.680641 containerd[2112]: time="2025-08-13T00:21:36.680575504Z" level=info msg="CreateContainer within sandbox \"34b52a51550860d3a7ab5845e1c0761e705a1ec38cbeac39d9dca1502ab5d1b0\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"ef83402863f07a00a5068fb7754fc34dad150a78ba9d507389aed550123c34e8\"" Aug 13 00:21:36.681733 containerd[2112]: time="2025-08-13T00:21:36.681614904Z" level=info msg="StartContainer for \"ef83402863f07a00a5068fb7754fc34dad150a78ba9d507389aed550123c34e8\"" Aug 13 00:21:36.739030 systemd[1]: run-containerd-runc-k8s.io-ef83402863f07a00a5068fb7754fc34dad150a78ba9d507389aed550123c34e8-runc.1wS7cf.mount: Deactivated successfully. Aug 13 00:21:36.793689 containerd[2112]: time="2025-08-13T00:21:36.793607116Z" level=info msg="StartContainer for \"ef83402863f07a00a5068fb7754fc34dad150a78ba9d507389aed550123c34e8\" returns successfully" Aug 13 00:21:36.882069 ntpd[2075]: Listen normally on 11 vethf5e5715e [fe80::74a0:bdff:fe2f:d33d%6]:123 Aug 13 00:21:36.882683 ntpd[2075]: 13 Aug 00:21:36 ntpd[2075]: Listen normally on 11 vethf5e5715e [fe80::74a0:bdff:fe2f:d33d%6]:123 Aug 13 00:21:37.474669 kubelet[2568]: E0813 00:21:37.474596 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:37.780530 kubelet[2568]: I0813 00:21:37.780416 2568 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.785693498 podStartE2EDuration="7.780396377s" podCreationTimestamp="2025-08-13 00:21:30 +0000 UTC" firstStartedPulling="2025-08-13 00:21:30.655409208 +0000 UTC m=+39.978360815" lastFinishedPulling="2025-08-13 00:21:36.650112075 +0000 UTC m=+45.973063694" observedRunningTime="2025-08-13 00:21:37.780315658 +0000 UTC m=+47.103267301" watchObservedRunningTime="2025-08-13 00:21:37.780396377 +0000 UTC m=+47.103348032" Aug 13 00:21:38.474986 kubelet[2568]: E0813 00:21:38.474929 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:39.475585 kubelet[2568]: E0813 00:21:39.475523 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:40.476687 kubelet[2568]: E0813 00:21:40.476630 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:41.477516 kubelet[2568]: E0813 00:21:41.477447 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:42.477960 kubelet[2568]: E0813 00:21:42.477900 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:43.478901 kubelet[2568]: E0813 00:21:43.478832 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:44.479964 kubelet[2568]: E0813 00:21:44.479907 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:45.480925 kubelet[2568]: E0813 00:21:45.480864 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:46.481463 kubelet[2568]: E0813 00:21:46.481395 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:46.820211 kubelet[2568]: I0813 00:21:46.819986 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-1b212bdc-ead3-486f-ac4c-0e5879fee2a4\" (UniqueName: \"kubernetes.io/nfs/90324c65-7c1f-465f-b37c-9ebed54b8cd0-pvc-1b212bdc-ead3-486f-ac4c-0e5879fee2a4\") pod \"test-pod-1\" (UID: \"90324c65-7c1f-465f-b37c-9ebed54b8cd0\") " pod="default/test-pod-1" Aug 13 00:21:46.820211 kubelet[2568]: I0813 00:21:46.820047 2568 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-576rb\" (UniqueName: \"kubernetes.io/projected/90324c65-7c1f-465f-b37c-9ebed54b8cd0-kube-api-access-576rb\") pod \"test-pod-1\" (UID: \"90324c65-7c1f-465f-b37c-9ebed54b8cd0\") " pod="default/test-pod-1" Aug 13 00:21:46.956367 kernel: FS-Cache: Loaded Aug 13 00:21:46.999513 kernel: RPC: Registered named UNIX socket transport module. Aug 13 00:21:46.999636 kernel: RPC: Registered udp transport module. Aug 13 00:21:47.000692 kernel: RPC: Registered tcp transport module. Aug 13 00:21:47.001915 kernel: RPC: Registered tcp-with-tls transport module. Aug 13 00:21:47.003395 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 13 00:21:47.324653 kernel: NFS: Registering the id_resolver key type Aug 13 00:21:47.324778 kernel: Key type id_resolver registered Aug 13 00:21:47.324831 kernel: Key type id_legacy registered Aug 13 00:21:47.363699 nfsidmap[3890]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Aug 13 00:21:47.369325 nfsidmap[3891]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Aug 13 00:21:47.482397 kubelet[2568]: E0813 00:21:47.482345 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:47.684966 containerd[2112]: time="2025-08-13T00:21:47.684269553Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:90324c65-7c1f-465f-b37c-9ebed54b8cd0,Namespace:default,Attempt:0,}" Aug 13 00:21:47.733838 (udev-worker)[3881]: Network interface NamePolicy= disabled on kernel command line. Aug 13 00:21:47.738457 systemd-networkd[1690]: veth11c812c2: Link UP Aug 13 00:21:47.741035 kernel: cni0: port 3(veth11c812c2) entered blocking state Aug 13 00:21:47.741143 kernel: cni0: port 3(veth11c812c2) entered disabled state Aug 13 00:21:47.742365 kernel: veth11c812c2: entered allmulticast mode Aug 13 00:21:47.742433 kernel: veth11c812c2: entered promiscuous mode Aug 13 00:21:47.758436 kernel: cni0: port 3(veth11c812c2) entered blocking state Aug 13 00:21:47.758541 kernel: cni0: port 3(veth11c812c2) entered forwarding state Aug 13 00:21:47.758713 systemd-networkd[1690]: veth11c812c2: Gained carrier Aug 13 00:21:47.762116 containerd[2112]: 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)(0x40000a48e8), "name":"cbr0", "type":"bridge"} Aug 13 00:21:47.762116 containerd[2112]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:21:47.801615 containerd[2112]: {"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":8951,"name":"cbr0","type":"bridge"}time="2025-08-13T00:21:47.801420336Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:21:47.801919 containerd[2112]: time="2025-08-13T00:21:47.801549812Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:21:47.801919 containerd[2112]: time="2025-08-13T00:21:47.801635029Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:47.802100 containerd[2112]: time="2025-08-13T00:21:47.801921470Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:21:47.880427 containerd[2112]: time="2025-08-13T00:21:47.880373612Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:90324c65-7c1f-465f-b37c-9ebed54b8cd0,Namespace:default,Attempt:0,} returns sandbox id \"c0c5a03eda3f175451ae7a408293de3e0fbd3258e594f6cb50353fcf97d5376b\"" Aug 13 00:21:47.883211 containerd[2112]: time="2025-08-13T00:21:47.883130409Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 00:21:48.196202 containerd[2112]: time="2025-08-13T00:21:48.195474260Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 13 00:21:48.197509 containerd[2112]: time="2025-08-13T00:21:48.197438577Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Aug 13 00:21:48.203335 containerd[2112]: time="2025-08-13T00:21:48.203268129Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985\", size \"69963735\" in 320.052275ms" Aug 13 00:21:48.203335 containerd[2112]: time="2025-08-13T00:21:48.203328951Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 13 00:21:48.206609 containerd[2112]: time="2025-08-13T00:21:48.206552027Z" level=info msg="CreateContainer within sandbox \"c0c5a03eda3f175451ae7a408293de3e0fbd3258e594f6cb50353fcf97d5376b\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 13 00:21:48.237829 containerd[2112]: time="2025-08-13T00:21:48.237698466Z" level=info msg="CreateContainer within sandbox \"c0c5a03eda3f175451ae7a408293de3e0fbd3258e594f6cb50353fcf97d5376b\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"9ac733f5a67eca3a1c63a8d30ab177972d97bdfe335d86e15cabcbe75a9dcecd\"" Aug 13 00:21:48.239195 containerd[2112]: time="2025-08-13T00:21:48.238711083Z" level=info msg="StartContainer for \"9ac733f5a67eca3a1c63a8d30ab177972d97bdfe335d86e15cabcbe75a9dcecd\"" Aug 13 00:21:48.333972 containerd[2112]: time="2025-08-13T00:21:48.333904691Z" level=info msg="StartContainer for \"9ac733f5a67eca3a1c63a8d30ab177972d97bdfe335d86e15cabcbe75a9dcecd\" returns successfully" Aug 13 00:21:48.483001 kubelet[2568]: E0813 00:21:48.482799 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:48.806554 kubelet[2568]: I0813 00:21:48.806449 2568 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=18.484810788 podStartE2EDuration="18.806430367s" podCreationTimestamp="2025-08-13 00:21:30 +0000 UTC" firstStartedPulling="2025-08-13 00:21:47.882604772 +0000 UTC m=+57.205556403" lastFinishedPulling="2025-08-13 00:21:48.204224363 +0000 UTC m=+57.527175982" observedRunningTime="2025-08-13 00:21:48.806348292 +0000 UTC m=+58.129299911" watchObservedRunningTime="2025-08-13 00:21:48.806430367 +0000 UTC m=+58.129381974" Aug 13 00:21:48.955429 systemd-networkd[1690]: veth11c812c2: Gained IPv6LL Aug 13 00:21:49.483693 kubelet[2568]: E0813 00:21:49.483630 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:50.484035 kubelet[2568]: E0813 00:21:50.483958 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:51.484771 kubelet[2568]: E0813 00:21:51.484707 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:51.882186 ntpd[2075]: Listen normally on 12 veth11c812c2 [fe80::c877:5aff:fe63:169d%7]:123 Aug 13 00:21:51.883012 ntpd[2075]: 13 Aug 00:21:51 ntpd[2075]: Listen normally on 12 veth11c812c2 [fe80::c877:5aff:fe63:169d%7]:123 Aug 13 00:21:52.447058 kubelet[2568]: E0813 00:21:52.446995 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:52.485808 kubelet[2568]: E0813 00:21:52.485740 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:53.486071 kubelet[2568]: E0813 00:21:53.486016 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:54.487029 kubelet[2568]: E0813 00:21:54.486958 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:55.487465 kubelet[2568]: E0813 00:21:55.487402 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:56.488391 kubelet[2568]: E0813 00:21:56.488330 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:57.488650 kubelet[2568]: E0813 00:21:57.488593 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:58.489675 kubelet[2568]: E0813 00:21:58.489605 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:21:59.490041 kubelet[2568]: E0813 00:21:59.489979 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:00.490975 kubelet[2568]: E0813 00:22:00.490913 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:01.491748 kubelet[2568]: E0813 00:22:01.491688 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:02.492542 kubelet[2568]: E0813 00:22:02.492478 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:03.492922 kubelet[2568]: E0813 00:22:03.492863 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:04.493059 kubelet[2568]: E0813 00:22:04.493006 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:05.493505 kubelet[2568]: E0813 00:22:05.493444 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:06.493666 kubelet[2568]: E0813 00:22:06.493599 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:07.494430 kubelet[2568]: E0813 00:22:07.494360 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:08.495408 kubelet[2568]: E0813 00:22:08.495348 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:09.496415 kubelet[2568]: E0813 00:22:09.496354 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:10.496833 kubelet[2568]: E0813 00:22:10.496773 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:11.497334 kubelet[2568]: E0813 00:22:11.497273 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:12.446922 kubelet[2568]: E0813 00:22:12.446847 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:12.497896 kubelet[2568]: E0813 00:22:12.497845 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:13.498688 kubelet[2568]: E0813 00:22:13.498627 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:13.670680 kubelet[2568]: E0813 00:22:13.670639 2568 controller.go:195] "Failed to update lease" err="the server was unable to return a response in the time allotted, but may still be processing the request (put leases.coordination.k8s.io 172.31.23.12)" Aug 13 00:22:14.498861 kubelet[2568]: E0813 00:22:14.498792 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:15.499330 kubelet[2568]: E0813 00:22:15.499268 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:16.500266 kubelet[2568]: E0813 00:22:16.500205 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:17.501276 kubelet[2568]: E0813 00:22:17.501230 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:18.501945 kubelet[2568]: E0813 00:22:18.501885 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:19.502379 kubelet[2568]: E0813 00:22:19.502318 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:20.503313 kubelet[2568]: E0813 00:22:20.503230 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:21.504306 kubelet[2568]: E0813 00:22:21.504237 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:22.505328 kubelet[2568]: E0813 00:22:22.505274 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:23.505884 kubelet[2568]: E0813 00:22:23.505816 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:23.667697 kubelet[2568]: E0813 00:22:23.667634 2568 controller.go:195] "Failed to update lease" err="the server was unable to return a response in the time allotted, but may still be processing the request (put leases.coordination.k8s.io 172.31.23.12)" Aug 13 00:22:24.506240 kubelet[2568]: E0813 00:22:24.506184 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:25.507293 kubelet[2568]: E0813 00:22:25.507229 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:26.507935 kubelet[2568]: E0813 00:22:26.507870 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:27.509033 kubelet[2568]: E0813 00:22:27.508975 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:28.509866 kubelet[2568]: E0813 00:22:28.509806 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:29.510024 kubelet[2568]: E0813 00:22:29.509969 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:30.510177 kubelet[2568]: E0813 00:22:30.510096 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:31.510850 kubelet[2568]: E0813 00:22:31.510785 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:32.447208 kubelet[2568]: E0813 00:22:32.447131 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:32.511481 kubelet[2568]: E0813 00:22:32.511434 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:33.512413 kubelet[2568]: E0813 00:22:33.512351 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:33.664645 kubelet[2568]: E0813 00:22:33.664393 2568 controller.go:195] "Failed to update lease" err="the server was unable to return a response in the time allotted, but may still be processing the request (put leases.coordination.k8s.io 172.31.23.12)" Aug 13 00:22:34.513575 kubelet[2568]: E0813 00:22:34.513514 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:35.513699 kubelet[2568]: E0813 00:22:35.513632 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:36.514756 kubelet[2568]: E0813 00:22:36.514680 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:37.515628 kubelet[2568]: E0813 00:22:37.515561 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:37.581191 kubelet[2568]: E0813 00:22:37.578995 2568 controller.go:195] "Failed to update lease" err="Put \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": unexpected EOF" Aug 13 00:22:37.585020 kubelet[2568]: E0813 00:22:37.584063 2568 controller.go:195] "Failed to update lease" err="Put \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": read tcp 172.31.23.12:42104->172.31.16.52:6443: read: connection reset by peer" Aug 13 00:22:37.585020 kubelet[2568]: I0813 00:22:37.584125 2568 controller.go:115] "failed to update lease using latest lease, fallback to ensure lease" err="failed 5 attempts to update lease" Aug 13 00:22:37.585020 kubelet[2568]: E0813 00:22:37.584901 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": dial tcp 172.31.16.52:6443: connect: connection refused" interval="200ms" Aug 13 00:22:37.786539 kubelet[2568]: E0813 00:22:37.786391 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": dial tcp 172.31.16.52:6443: connect: connection refused" interval="400ms" Aug 13 00:22:38.188138 kubelet[2568]: E0813 00:22:38.187982 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": dial tcp 172.31.16.52:6443: connect: connection refused" interval="800ms" Aug 13 00:22:38.516465 kubelet[2568]: E0813 00:22:38.516402 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:38.989660 kubelet[2568]: E0813 00:22:38.989491 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": dial tcp 172.31.16.52:6443: connect: connection refused" interval="1.6s" Aug 13 00:22:39.517293 kubelet[2568]: E0813 00:22:39.517220 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:40.518280 kubelet[2568]: E0813 00:22:40.518224 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:40.591054 kubelet[2568]: E0813 00:22:40.590950 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": dial tcp 172.31.16.52:6443: connect: connection refused" interval="3.2s" Aug 13 00:22:41.519381 kubelet[2568]: E0813 00:22:41.519308 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:42.519771 kubelet[2568]: E0813 00:22:42.519716 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:43.520496 kubelet[2568]: E0813 00:22:43.520435 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:44.521643 kubelet[2568]: E0813 00:22:44.521582 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:45.522513 kubelet[2568]: E0813 00:22:45.522437 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:46.522758 kubelet[2568]: E0813 00:22:46.522696 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:47.523623 kubelet[2568]: E0813 00:22:47.523568 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:48.524270 kubelet[2568]: E0813 00:22:48.524207 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:49.525351 kubelet[2568]: E0813 00:22:49.525274 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:50.526500 kubelet[2568]: E0813 00:22:50.526441 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:51.526635 kubelet[2568]: E0813 00:22:51.526584 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:52.447570 kubelet[2568]: E0813 00:22:52.447501 2568 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:52.526994 kubelet[2568]: E0813 00:22:52.526927 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:53.527349 kubelet[2568]: E0813 00:22:53.527288 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:53.791645 kubelet[2568]: E0813 00:22:53.791489 2568 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.16.52:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.23.12?timeout=10s\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" interval="6.4s" Aug 13 00:22:54.528050 kubelet[2568]: E0813 00:22:54.527990 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:55.529138 kubelet[2568]: E0813 00:22:55.529070 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:56.530132 kubelet[2568]: E0813 00:22:56.530066 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:57.531280 kubelet[2568]: E0813 00:22:57.531223 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:58.531775 kubelet[2568]: E0813 00:22:58.531712 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:22:59.532480 kubelet[2568]: E0813 00:22:59.532418 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:23:00.533013 kubelet[2568]: E0813 00:23:00.532954 2568 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"