Sep 4 23:48:30.212365 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 4 23:48:30.212412 kernel: Linux version 6.6.156-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 Fri Sep 4 22:23:35 -00 2026 Sep 4 23:48:30.212437 kernel: KASLR disabled due to lack of seed Sep 4 23:48:30.212454 kernel: efi: EFI v2.7 by EDK II Sep 4 23:48:30.212470 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b009a98 MEMRESERVE=0x7852ee18 Sep 4 23:48:30.212485 kernel: ACPI: Early table checksum verification disabled Sep 4 23:48:30.212503 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 4 23:48:30.212552 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 4 23:48:30.212571 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 4 23:48:30.212588 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Sep 4 23:48:30.212610 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 4 23:48:30.212626 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 4 23:48:30.212643 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 4 23:48:30.212659 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 4 23:48:30.212678 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 4 23:48:30.212699 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 4 23:48:30.212716 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 4 23:48:30.212733 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 4 23:48:30.212749 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 4 23:48:30.212766 kernel: printk: bootconsole [uart0] enabled Sep 4 23:48:30.212783 kernel: NUMA: Failed to initialise from firmware Sep 4 23:48:30.212800 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 4 23:48:30.212817 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Sep 4 23:48:30.212835 kernel: Zone ranges: Sep 4 23:48:30.212853 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 4 23:48:30.212870 kernel: DMA32 empty Sep 4 23:48:30.212892 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 4 23:48:30.212910 kernel: Movable zone start for each node Sep 4 23:48:30.212927 kernel: Early memory node ranges Sep 4 23:48:30.212943 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 4 23:48:30.212960 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 4 23:48:30.212977 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 4 23:48:30.212994 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 4 23:48:30.213010 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 4 23:48:30.213027 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 4 23:48:30.213043 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 4 23:48:30.213060 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 4 23:48:30.213076 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 4 23:48:30.213098 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 4 23:48:30.213116 kernel: psci: probing for conduit method from ACPI. Sep 4 23:48:30.213141 kernel: psci: PSCIv1.0 detected in firmware. Sep 4 23:48:30.213159 kernel: psci: Using standard PSCI v0.2 function IDs Sep 4 23:48:30.213177 kernel: psci: Trusted OS migration not required Sep 4 23:48:30.213208 kernel: psci: SMC Calling Convention v1.1 Sep 4 23:48:30.213247 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 4 23:48:30.213289 kernel: percpu: Embedded 30 pages/cpu s85800 r8192 d28888 u122880 Sep 4 23:48:30.213332 kernel: pcpu-alloc: s85800 r8192 d28888 u122880 alloc=30*4096 Sep 4 23:48:30.213367 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 4 23:48:30.213389 kernel: Detected PIPT I-cache on CPU0 Sep 4 23:48:30.213409 kernel: CPU features: detected: GIC system register CPU interface Sep 4 23:48:30.213427 kernel: CPU features: detected: Spectre-v2 Sep 4 23:48:30.213444 kernel: CPU features: detected: Spectre-v3a Sep 4 23:48:30.213462 kernel: CPU features: detected: Spectre-BHB Sep 4 23:48:30.213480 kernel: CPU features: detected: ARM erratum 1742098 Sep 4 23:48:30.213504 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 4 23:48:30.213543 kernel: alternatives: applying boot alternatives Sep 4 23:48:30.213566 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=b93d003b43d5ab98ae420f26cabb0cb9807dda45afde2a6503d15bee14b842f0 Sep 4 23:48:30.213585 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 23:48:30.213602 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 23:48:30.213620 kernel: Fallback order for Node 0: 0 Sep 4 23:48:30.213638 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Sep 4 23:48:30.213656 kernel: Policy zone: Normal Sep 4 23:48:30.213674 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 23:48:30.213692 kernel: software IO TLB: area num 2. Sep 4 23:48:30.213710 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Sep 4 23:48:30.213736 kernel: Memory: 3819968K/4030464K available (10304K kernel code, 2180K rwdata, 8132K rodata, 39488K init, 901K bss, 210496K reserved, 0K cma-reserved) Sep 4 23:48:30.213755 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 4 23:48:30.213773 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 23:48:30.213791 kernel: rcu: RCU event tracing is enabled. Sep 4 23:48:30.213809 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 4 23:48:30.213828 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 23:48:30.213847 kernel: Tracing variant of Tasks RCU enabled. Sep 4 23:48:30.213865 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 23:48:30.213883 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 4 23:48:30.213900 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 4 23:48:30.213918 kernel: GICv3: 96 SPIs implemented Sep 4 23:48:30.213940 kernel: GICv3: 0 Extended SPIs implemented Sep 4 23:48:30.213958 kernel: Root IRQ handler: gic_handle_irq Sep 4 23:48:30.213975 kernel: GICv3: GICv3 features: 16 PPIs Sep 4 23:48:30.213993 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 4 23:48:30.214011 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 4 23:48:30.214030 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Sep 4 23:48:30.214049 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Sep 4 23:48:30.214068 kernel: GICv3: using LPI property table @0x00000004000d0000 Sep 4 23:48:30.214086 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 4 23:48:30.214105 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Sep 4 23:48:30.214123 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 23:48:30.214141 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 4 23:48:30.214163 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 4 23:48:30.214181 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 4 23:48:30.214199 kernel: Console: colour dummy device 80x25 Sep 4 23:48:30.214217 kernel: printk: console [tty1] enabled Sep 4 23:48:30.214235 kernel: ACPI: Core revision 20230628 Sep 4 23:48:30.214254 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 4 23:48:30.214272 kernel: pid_max: default: 32768 minimum: 301 Sep 4 23:48:30.214290 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 4 23:48:30.214308 kernel: landlock: Up and running. Sep 4 23:48:30.214330 kernel: SELinux: Initializing. Sep 4 23:48:30.214349 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.214367 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.214385 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 23:48:30.214403 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 23:48:30.214421 kernel: rcu: Hierarchical SRCU implementation. Sep 4 23:48:30.214439 kernel: rcu: Max phase no-delay instances is 400. Sep 4 23:48:30.214457 kernel: Platform MSI: ITS@0x10080000 domain created Sep 4 23:48:30.214475 kernel: PCI/MSI: ITS@0x10080000 domain created Sep 4 23:48:30.214497 kernel: Remapping and enabling EFI services. Sep 4 23:48:30.214541 kernel: smp: Bringing up secondary CPUs ... Sep 4 23:48:30.214566 kernel: Detected PIPT I-cache on CPU1 Sep 4 23:48:30.214586 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 4 23:48:30.214604 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Sep 4 23:48:30.214623 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 4 23:48:30.214641 kernel: smp: Brought up 1 node, 2 CPUs Sep 4 23:48:30.214659 kernel: SMP: Total of 2 processors activated. Sep 4 23:48:30.214677 kernel: CPU features: detected: 32-bit EL0 Support Sep 4 23:48:30.214701 kernel: CPU features: detected: 32-bit EL1 Support Sep 4 23:48:30.214719 kernel: CPU features: detected: CRC32 instructions Sep 4 23:48:30.214738 kernel: CPU: All CPU(s) started at EL1 Sep 4 23:48:30.214768 kernel: alternatives: applying system-wide alternatives Sep 4 23:48:30.214791 kernel: devtmpfs: initialized Sep 4 23:48:30.214810 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 23:48:30.214829 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 4 23:48:30.214861 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 23:48:30.214882 kernel: SMBIOS 3.0.0 present. Sep 4 23:48:30.214907 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 4 23:48:30.214926 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 23:48:30.214945 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 4 23:48:30.214964 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 4 23:48:30.214983 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 4 23:48:30.215002 kernel: audit: initializing netlink subsys (disabled) Sep 4 23:48:30.215021 kernel: audit: type=2000 audit(0.303:1): state=initialized audit_enabled=0 res=1 Sep 4 23:48:30.215040 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 23:48:30.215064 kernel: cpuidle: using governor menu Sep 4 23:48:30.215083 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 4 23:48:30.215101 kernel: ASID allocator initialised with 65536 entries Sep 4 23:48:30.215120 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 23:48:30.215139 kernel: Serial: AMBA PL011 UART driver Sep 4 23:48:30.215158 kernel: Modules: 17456 pages in range for non-PLT usage Sep 4 23:48:30.215178 kernel: Modules: 508976 pages in range for PLT usage Sep 4 23:48:30.215197 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 23:48:30.215216 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 23:48:30.215239 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 4 23:48:30.215259 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 4 23:48:30.215278 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 23:48:30.215296 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 23:48:30.215316 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 4 23:48:30.215335 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 4 23:48:30.215384 kernel: ACPI: Added _OSI(Module Device) Sep 4 23:48:30.215406 kernel: ACPI: Added _OSI(Processor Device) Sep 4 23:48:30.215425 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 23:48:30.215450 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 23:48:30.215470 kernel: ACPI: Interpreter enabled Sep 4 23:48:30.215488 kernel: ACPI: Using GIC for interrupt routing Sep 4 23:48:30.215507 kernel: ACPI: MCFG table detected, 1 entries Sep 4 23:48:30.215546 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Sep 4 23:48:30.215882 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 23:48:30.216103 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 4 23:48:30.216328 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 4 23:48:30.216559 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Sep 4 23:48:30.216847 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Sep 4 23:48:30.216888 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 4 23:48:30.216908 kernel: acpiphp: Slot [1] registered Sep 4 23:48:30.216927 kernel: acpiphp: Slot [2] registered Sep 4 23:48:30.216946 kernel: acpiphp: Slot [3] registered Sep 4 23:48:30.216965 kernel: acpiphp: Slot [4] registered Sep 4 23:48:30.216985 kernel: acpiphp: Slot [5] registered Sep 4 23:48:30.217011 kernel: acpiphp: Slot [6] registered Sep 4 23:48:30.217031 kernel: acpiphp: Slot [7] registered Sep 4 23:48:30.217050 kernel: acpiphp: Slot [8] registered Sep 4 23:48:30.217068 kernel: acpiphp: Slot [9] registered Sep 4 23:48:30.217086 kernel: acpiphp: Slot [10] registered Sep 4 23:48:30.217106 kernel: acpiphp: Slot [11] registered Sep 4 23:48:30.217124 kernel: acpiphp: Slot [12] registered Sep 4 23:48:30.217144 kernel: acpiphp: Slot [13] registered Sep 4 23:48:30.217162 kernel: acpiphp: Slot [14] registered Sep 4 23:48:30.217181 kernel: acpiphp: Slot [15] registered Sep 4 23:48:30.217205 kernel: acpiphp: Slot [16] registered Sep 4 23:48:30.217224 kernel: acpiphp: Slot [17] registered Sep 4 23:48:30.217243 kernel: acpiphp: Slot [18] registered Sep 4 23:48:30.217262 kernel: acpiphp: Slot [19] registered Sep 4 23:48:30.217280 kernel: acpiphp: Slot [20] registered Sep 4 23:48:30.217299 kernel: acpiphp: Slot [21] registered Sep 4 23:48:30.217318 kernel: acpiphp: Slot [22] registered Sep 4 23:48:30.217336 kernel: acpiphp: Slot [23] registered Sep 4 23:48:30.217355 kernel: acpiphp: Slot [24] registered Sep 4 23:48:30.217381 kernel: acpiphp: Slot [25] registered Sep 4 23:48:30.217401 kernel: acpiphp: Slot [26] registered Sep 4 23:48:30.217420 kernel: acpiphp: Slot [27] registered Sep 4 23:48:30.217438 kernel: acpiphp: Slot [28] registered Sep 4 23:48:30.217457 kernel: acpiphp: Slot [29] registered Sep 4 23:48:30.217476 kernel: acpiphp: Slot [30] registered Sep 4 23:48:30.217495 kernel: acpiphp: Slot [31] registered Sep 4 23:48:30.217537 kernel: PCI host bridge to bus 0000:00 Sep 4 23:48:30.217807 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 4 23:48:30.218018 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 4 23:48:30.218214 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 4 23:48:30.218403 kernel: pci_bus 0000:00: root bus resource [bus 00] Sep 4 23:48:30.218759 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Sep 4 23:48:30.219007 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Sep 4 23:48:30.219227 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Sep 4 23:48:30.224190 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Sep 4 23:48:30.224465 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Sep 4 23:48:30.224878 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 4 23:48:30.225143 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Sep 4 23:48:30.225354 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Sep 4 23:48:30.225587 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Sep 4 23:48:30.225805 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Sep 4 23:48:30.226024 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 4 23:48:30.226218 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 4 23:48:30.226408 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 4 23:48:30.226624 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 4 23:48:30.226652 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 4 23:48:30.226672 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 4 23:48:30.226691 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 4 23:48:30.226710 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 4 23:48:30.226735 kernel: iommu: Default domain type: Translated Sep 4 23:48:30.226754 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 4 23:48:30.226773 kernel: efivars: Registered efivars operations Sep 4 23:48:30.226792 kernel: vgaarb: loaded Sep 4 23:48:30.226810 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 4 23:48:30.226829 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 23:48:30.226848 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 23:48:30.226867 kernel: pnp: PnP ACPI init Sep 4 23:48:30.227094 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 4 23:48:30.227131 kernel: pnp: PnP ACPI: found 1 devices Sep 4 23:48:30.227151 kernel: NET: Registered PF_INET protocol family Sep 4 23:48:30.227170 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 23:48:30.227190 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 23:48:30.227209 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 23:48:30.227228 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 23:48:30.227247 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 23:48:30.227266 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 23:48:30.227290 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.227309 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.227328 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 23:48:30.227348 kernel: PCI: CLS 0 bytes, default 64 Sep 4 23:48:30.227366 kernel: kvm [1]: HYP mode not available Sep 4 23:48:30.227385 kernel: Initialise system trusted keyrings Sep 4 23:48:30.227404 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 23:48:30.227423 kernel: Key type asymmetric registered Sep 4 23:48:30.227442 kernel: Asymmetric key parser 'x509' registered Sep 4 23:48:30.227465 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 23:48:30.227484 kernel: io scheduler mq-deadline registered Sep 4 23:48:30.227502 kernel: io scheduler kyber registered Sep 4 23:48:30.227591 kernel: io scheduler bfq registered Sep 4 23:48:30.227838 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 4 23:48:30.227868 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 4 23:48:30.227888 kernel: ACPI: button: Power Button [PWRB] Sep 4 23:48:30.227908 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 4 23:48:30.227927 kernel: ACPI: button: Sleep Button [SLPB] Sep 4 23:48:30.227954 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 23:48:30.227975 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 4 23:48:30.228223 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 4 23:48:30.228253 kernel: printk: console [ttyS0] disabled Sep 4 23:48:30.228274 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 4 23:48:30.228294 kernel: printk: console [ttyS0] enabled Sep 4 23:48:30.231446 kernel: printk: bootconsole [uart0] disabled Sep 4 23:48:30.231480 kernel: thunder_xcv, ver 1.0 Sep 4 23:48:30.231500 kernel: thunder_bgx, ver 1.0 Sep 4 23:48:30.231640 kernel: nicpf, ver 1.0 Sep 4 23:48:30.231661 kernel: nicvf, ver 1.0 Sep 4 23:48:30.231922 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 4 23:48:30.232162 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-04T23:48:29 UTC (1788565709) Sep 4 23:48:30.232191 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 23:48:30.232210 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Sep 4 23:48:30.232230 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 4 23:48:30.232250 kernel: watchdog: Hard watchdog permanently disabled Sep 4 23:48:30.232280 kernel: NET: Registered PF_INET6 protocol family Sep 4 23:48:30.232299 kernel: Segment Routing with IPv6 Sep 4 23:48:30.232319 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 23:48:30.232338 kernel: NET: Registered PF_PACKET protocol family Sep 4 23:48:30.232356 kernel: Key type dns_resolver registered Sep 4 23:48:30.232375 kernel: registered taskstats version 1 Sep 4 23:48:30.232394 kernel: Loading compiled-in X.509 certificates Sep 4 23:48:30.232414 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.156-flatcar: 3c163392e47099ee9cc38295227f8cfbbfe8b690' Sep 4 23:48:30.232433 kernel: Key type .fscrypt registered Sep 4 23:48:30.232457 kernel: Key type fscrypt-provisioning registered Sep 4 23:48:30.232477 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 23:48:30.232496 kernel: ima: Allocated hash algorithm: sha1 Sep 4 23:48:30.232544 kernel: ima: No architecture policies found Sep 4 23:48:30.232568 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 4 23:48:30.232587 kernel: clk: Disabling unused clocks Sep 4 23:48:30.232606 kernel: Freeing unused kernel memory: 39488K Sep 4 23:48:30.232625 kernel: Run /init as init process Sep 4 23:48:30.232644 kernel: with arguments: Sep 4 23:48:30.232669 kernel: /init Sep 4 23:48:30.232688 kernel: with environment: Sep 4 23:48:30.232706 kernel: HOME=/ Sep 4 23:48:30.232725 kernel: TERM=linux Sep 4 23:48:30.232749 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) Sep 4 23:48:30.232773 systemd[1]: Detected virtualization amazon. Sep 4 23:48:30.232793 systemd[1]: Detected architecture arm64. Sep 4 23:48:30.232813 systemd[1]: Running in initrd. Sep 4 23:48:30.232838 systemd[1]: No hostname configured, using default hostname. Sep 4 23:48:30.232858 systemd[1]: Hostname set to . Sep 4 23:48:30.232879 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:48:30.232899 systemd[1]: Queued start job for default target initrd.target. Sep 4 23:48:30.232920 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:30.232940 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:30.232962 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 23:48:30.232983 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:48:30.233008 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 23:48:30.233030 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 23:48:30.233053 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 23:48:30.233075 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 23:48:30.233095 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:30.233116 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:30.233141 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:48:30.233162 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:48:30.233182 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:48:30.233203 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:48:30.233224 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:48:30.235750 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:48:30.235779 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 23:48:30.235801 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 23:48:30.235822 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:30.235854 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:30.235877 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:30.235898 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:48:30.235919 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 23:48:30.235939 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:48:30.235960 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 23:48:30.235980 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 23:48:30.236000 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:48:30.236021 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:48:30.236046 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:30.236115 systemd-journald[251]: Collecting audit messages is disabled. Sep 4 23:48:30.236181 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 23:48:30.236214 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:30.236245 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 23:48:30.236267 systemd-journald[251]: Journal started Sep 4 23:48:30.236310 systemd-journald[251]: Runtime Journal (/run/log/journal/ec2155a4f170fbbf64454f4da0731741) is 8.0M, max 75.3M, 67.3M free. Sep 4 23:48:30.217342 systemd-modules-load[253]: Inserted module 'overlay' Sep 4 23:48:30.258544 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 23:48:30.258623 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:48:30.261719 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 23:48:30.273621 systemd-modules-load[253]: Inserted module 'br_netfilter' Sep 4 23:48:30.278108 kernel: Bridge firewalling registered Sep 4 23:48:30.285037 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:48:30.293440 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:30.294033 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:30.308771 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:48:30.313011 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:30.330870 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:30.343978 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:48:30.353793 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:48:30.376552 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:30.392811 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:48:30.395624 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:30.411982 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:30.427666 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 23:48:30.467368 dracut-cmdline[289]: dracut-dracut-053 Sep 4 23:48:30.473703 dracut-cmdline[289]: 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=b93d003b43d5ab98ae420f26cabb0cb9807dda45afde2a6503d15bee14b842f0 Sep 4 23:48:30.504007 systemd-resolved[284]: Positive Trust Anchors: Sep 4 23:48:30.504042 systemd-resolved[284]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:48:30.504105 systemd-resolved[284]: 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 Sep 4 23:48:30.629546 kernel: SCSI subsystem initialized Sep 4 23:48:30.636556 kernel: Loading iSCSI transport class v2.0-870. Sep 4 23:48:30.648552 kernel: iscsi: registered transport (tcp) Sep 4 23:48:30.671593 kernel: iscsi: registered transport (qla4xxx) Sep 4 23:48:30.671666 kernel: QLogic iSCSI HBA Driver Sep 4 23:48:30.744558 kernel: random: crng init done Sep 4 23:48:30.745174 systemd-resolved[284]: Defaulting to hostname 'linux'. Sep 4 23:48:30.749239 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:48:30.756382 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:30.778626 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 23:48:30.791884 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 23:48:30.824918 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 23:48:30.824995 kernel: device-mapper: uevent: version 1.0.3 Sep 4 23:48:30.825023 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 23:48:30.893573 kernel: raid6: neonx8 gen() 6621 MB/s Sep 4 23:48:30.910552 kernel: raid6: neonx4 gen() 6495 MB/s Sep 4 23:48:30.927555 kernel: raid6: neonx2 gen() 5422 MB/s Sep 4 23:48:30.944563 kernel: raid6: neonx1 gen() 3938 MB/s Sep 4 23:48:30.961567 kernel: raid6: int64x8 gen() 3793 MB/s Sep 4 23:48:30.978567 kernel: raid6: int64x4 gen() 3687 MB/s Sep 4 23:48:30.995553 kernel: raid6: int64x2 gen() 3594 MB/s Sep 4 23:48:31.013546 kernel: raid6: int64x1 gen() 2730 MB/s Sep 4 23:48:31.013591 kernel: raid6: using algorithm neonx8 gen() 6621 MB/s Sep 4 23:48:31.032469 kernel: raid6: .... xor() 4866 MB/s, rmw enabled Sep 4 23:48:31.032553 kernel: raid6: using neon recovery algorithm Sep 4 23:48:31.040553 kernel: xor: measuring software checksum speed Sep 4 23:48:31.041545 kernel: 8regs : 9975 MB/sec Sep 4 23:48:31.043943 kernel: 32regs : 11025 MB/sec Sep 4 23:48:31.043976 kernel: arm64_neon : 9357 MB/sec Sep 4 23:48:31.044011 kernel: xor: using function: 32regs (11025 MB/sec) Sep 4 23:48:31.129572 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 23:48:31.149225 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:48:31.163868 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:31.200901 systemd-udevd[473]: Using default interface naming scheme 'v255'. Sep 4 23:48:31.209771 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:31.231131 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 23:48:31.271866 dracut-pre-trigger[484]: rd.md=0: removing MD RAID activation Sep 4 23:48:31.331595 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:48:31.345843 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:48:31.459354 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:31.479300 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 23:48:31.530081 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 23:48:31.535473 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:48:31.538294 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:31.540913 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:48:31.557328 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 23:48:31.600900 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:48:31.670697 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 4 23:48:31.670761 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 4 23:48:31.674511 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:48:31.681864 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 4 23:48:31.682188 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 4 23:48:31.674898 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:31.683120 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:31.690044 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:48:31.690168 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:31.692799 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:31.705925 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:31.722574 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:03:22:a1:34:47 Sep 4 23:48:31.730565 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 4 23:48:31.732566 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 4 23:48:31.734366 (udev-worker)[525]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:48:31.738238 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:31.753660 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 4 23:48:31.754310 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:31.768782 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 4 23:48:31.768864 kernel: GPT:9289727 != 33554431 Sep 4 23:48:31.768908 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 4 23:48:31.771025 kernel: GPT:9289727 != 33554431 Sep 4 23:48:31.772671 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 4 23:48:31.773573 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:31.796342 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:31.852689 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (519) Sep 4 23:48:31.875564 kernel: BTRFS: device fsid b87ddc53-b6de-4050-b98d-680db2334337 devid 1 transid 32 /dev/nvme0n1p3 scanned by (udev-worker) (536) Sep 4 23:48:31.951626 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 4 23:48:32.006196 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 4 23:48:32.024099 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 4 23:48:32.037880 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 4 23:48:32.044223 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Sep 4 23:48:32.068895 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 23:48:32.082389 disk-uuid[665]: Primary Header is updated. Sep 4 23:48:32.082389 disk-uuid[665]: Secondary Entries is updated. Sep 4 23:48:32.082389 disk-uuid[665]: Secondary Header is updated. Sep 4 23:48:32.094558 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:32.105550 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:32.116547 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:33.117559 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:33.118627 disk-uuid[666]: The operation has completed successfully. Sep 4 23:48:33.337643 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 23:48:33.338220 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 23:48:33.391782 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 23:48:33.402041 sh[1009]: Success Sep 4 23:48:33.423578 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 4 23:48:33.527336 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 23:48:33.540762 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 23:48:33.554949 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 23:48:33.582871 kernel: BTRFS info (device dm-0): first mount of filesystem b87ddc53-b6de-4050-b98d-680db2334337 Sep 4 23:48:33.582932 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:33.585558 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 23:48:33.585596 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 23:48:33.587309 kernel: BTRFS info (device dm-0): using free space tree Sep 4 23:48:33.663564 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 4 23:48:33.673442 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 23:48:33.673972 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 23:48:33.687896 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 23:48:33.695758 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 23:48:33.720531 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:33.720624 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:33.720654 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:33.730561 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:33.750094 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 4 23:48:33.752820 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:33.762341 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 23:48:33.772784 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 23:48:33.893203 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:48:33.905838 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:48:33.971271 systemd-networkd[1203]: lo: Link UP Sep 4 23:48:33.971288 systemd-networkd[1203]: lo: Gained carrier Sep 4 23:48:33.974641 systemd-networkd[1203]: Enumeration completed Sep 4 23:48:33.974813 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:48:33.975908 systemd-networkd[1203]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:33.975916 systemd-networkd[1203]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:48:33.987477 systemd[1]: Reached target network.target - Network. Sep 4 23:48:33.995426 systemd-networkd[1203]: eth0: Link UP Sep 4 23:48:33.995433 systemd-networkd[1203]: eth0: Gained carrier Sep 4 23:48:33.995452 systemd-networkd[1203]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:34.016652 systemd-networkd[1203]: eth0: DHCPv4 address 172.31.16.224/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 4 23:48:34.106114 ignition[1114]: Ignition 2.19.0 Sep 4 23:48:34.106135 ignition[1114]: Stage: fetch-offline Sep 4 23:48:34.112178 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:48:34.107874 ignition[1114]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.107899 ignition[1114]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.108492 ignition[1114]: Ignition finished successfully Sep 4 23:48:34.133922 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 4 23:48:34.157056 ignition[1212]: Ignition 2.19.0 Sep 4 23:48:34.157078 ignition[1212]: Stage: fetch Sep 4 23:48:34.158267 ignition[1212]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.158293 ignition[1212]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.158475 ignition[1212]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.179933 ignition[1212]: PUT result: OK Sep 4 23:48:34.185675 ignition[1212]: parsed url from cmdline: "" Sep 4 23:48:34.185690 ignition[1212]: no config URL provided Sep 4 23:48:34.185708 ignition[1212]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 23:48:34.185734 ignition[1212]: no config at "/usr/lib/ignition/user.ign" Sep 4 23:48:34.185766 ignition[1212]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.188070 ignition[1212]: PUT result: OK Sep 4 23:48:34.188149 ignition[1212]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 4 23:48:34.195093 ignition[1212]: GET result: OK Sep 4 23:48:34.195224 ignition[1212]: parsing config with SHA512: c004663835c445a2b4143df65ec68cd6d8e7ff2712ba2e97750f4b320a9a809af38f32a17e566fb7bd087af0cf101cf6dfb228921525cfa4099a5ad89d7cf722 Sep 4 23:48:34.202299 unknown[1212]: fetched base config from "system" Sep 4 23:48:34.202331 unknown[1212]: fetched base config from "system" Sep 4 23:48:34.202346 unknown[1212]: fetched user config from "aws" Sep 4 23:48:34.204505 ignition[1212]: fetch: fetch complete Sep 4 23:48:34.204920 ignition[1212]: fetch: fetch passed Sep 4 23:48:34.211622 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 4 23:48:34.206095 ignition[1212]: Ignition finished successfully Sep 4 23:48:34.229944 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 23:48:34.253926 ignition[1219]: Ignition 2.19.0 Sep 4 23:48:34.253945 ignition[1219]: Stage: kargs Sep 4 23:48:34.254588 ignition[1219]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.254614 ignition[1219]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.254762 ignition[1219]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.258636 ignition[1219]: PUT result: OK Sep 4 23:48:34.269543 ignition[1219]: kargs: kargs passed Sep 4 23:48:34.269700 ignition[1219]: Ignition finished successfully Sep 4 23:48:34.277160 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 23:48:34.285796 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 23:48:34.318858 ignition[1225]: Ignition 2.19.0 Sep 4 23:48:34.318888 ignition[1225]: Stage: disks Sep 4 23:48:34.320569 ignition[1225]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.320595 ignition[1225]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.320748 ignition[1225]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.322786 ignition[1225]: PUT result: OK Sep 4 23:48:34.335051 ignition[1225]: disks: disks passed Sep 4 23:48:34.335147 ignition[1225]: Ignition finished successfully Sep 4 23:48:34.341905 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 23:48:34.349491 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 23:48:34.352256 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 23:48:34.354906 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:48:34.357865 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:48:34.360046 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:48:34.374806 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 23:48:34.418111 systemd-fsck[1233]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 4 23:48:34.425603 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 23:48:34.439092 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 23:48:34.536577 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 4bc94a1f-f803-467d-b7c6-f015244e0af4 r/w with ordered data mode. Quota mode: none. Sep 4 23:48:34.537636 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 23:48:34.541877 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 23:48:34.551732 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:48:34.557687 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 23:48:34.562172 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 23:48:34.564346 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 23:48:34.564399 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:48:34.586596 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 23:48:34.597879 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 23:48:34.609588 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1252) Sep 4 23:48:34.613670 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:34.613732 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:34.613764 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:34.622558 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:34.625423 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:48:34.843691 initrd-setup-root[1276]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 23:48:34.859212 initrd-setup-root[1283]: cut: /sysroot/etc/group: No such file or directory Sep 4 23:48:34.867620 initrd-setup-root[1290]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 23:48:34.876977 initrd-setup-root[1297]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 23:48:35.114852 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 23:48:35.123745 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 23:48:35.139773 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 23:48:35.158202 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 23:48:35.164632 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:35.197593 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 23:48:35.213574 ignition[1366]: INFO : Ignition 2.19.0 Sep 4 23:48:35.216919 ignition[1366]: INFO : Stage: mount Sep 4 23:48:35.216919 ignition[1366]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:35.216919 ignition[1366]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:35.216919 ignition[1366]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:35.227132 ignition[1366]: INFO : PUT result: OK Sep 4 23:48:35.230243 ignition[1366]: INFO : mount: mount passed Sep 4 23:48:35.231967 ignition[1366]: INFO : Ignition finished successfully Sep 4 23:48:35.236683 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 23:48:35.244641 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 23:48:35.272910 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:48:35.297767 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1377) Sep 4 23:48:35.301852 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:35.301893 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:35.303165 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:35.309642 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:35.313232 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:48:35.351387 ignition[1394]: INFO : Ignition 2.19.0 Sep 4 23:48:35.351387 ignition[1394]: INFO : Stage: files Sep 4 23:48:35.351387 ignition[1394]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:35.351387 ignition[1394]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:35.351387 ignition[1394]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:35.362743 ignition[1394]: INFO : PUT result: OK Sep 4 23:48:35.370780 ignition[1394]: DEBUG : files: compiled without relabeling support, skipping Sep 4 23:48:35.376559 ignition[1394]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 23:48:35.376559 ignition[1394]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 23:48:35.403263 ignition[1394]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 23:48:35.406446 ignition[1394]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 23:48:35.409757 unknown[1394]: wrote ssh authorized keys file for user: core Sep 4 23:48:35.412555 ignition[1394]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 23:48:35.415621 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.4-arm64.raw" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.4-arm64.raw" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.4-arm64.raw" Sep 4 23:48:35.419421 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.4-arm64.raw: attempt #1 Sep 4 23:48:35.822642 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Sep 4 23:48:35.958878 systemd-networkd[1203]: eth0: Gained IPv6LL Sep 4 23:48:36.234292 ignition[1394]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.4-arm64.raw" Sep 4 23:48:36.238972 ignition[1394]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:48:36.238972 ignition[1394]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:48:36.238972 ignition[1394]: INFO : files: files passed Sep 4 23:48:36.238972 ignition[1394]: INFO : Ignition finished successfully Sep 4 23:48:36.253578 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 23:48:36.262981 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 23:48:36.271974 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 23:48:36.282922 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 23:48:36.287764 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 23:48:36.310959 initrd-setup-root-after-ignition[1423]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.314655 initrd-setup-root-after-ignition[1423]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.320563 initrd-setup-root-after-ignition[1427]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.327301 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:48:36.334044 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 23:48:36.348765 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 23:48:36.398169 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 23:48:36.398615 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 23:48:36.406178 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 23:48:36.410605 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 23:48:36.413208 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 23:48:36.420411 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 23:48:36.463829 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:48:36.481012 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 23:48:36.507020 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:36.509931 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:36.512826 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 23:48:36.514977 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 23:48:36.515215 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:48:36.518735 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 23:48:36.520579 systemd[1]: Stopped target basic.target - Basic System. Sep 4 23:48:36.520900 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 23:48:36.521248 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:48:36.521610 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 23:48:36.521941 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 23:48:36.522277 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:48:36.522661 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 23:48:36.522980 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 23:48:36.523318 systemd[1]: Stopped target swap.target - Swaps. Sep 4 23:48:36.523629 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 23:48:36.523870 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:48:36.530216 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:36.530604 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:36.530842 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 23:48:36.547304 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:36.547555 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 23:48:36.547781 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 23:48:36.548454 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 23:48:36.548699 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:48:36.550007 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 23:48:36.550288 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 23:48:36.578713 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 23:48:36.596870 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 23:48:36.635914 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 23:48:36.636457 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:36.650420 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 23:48:36.650689 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:48:36.668222 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 23:48:36.668415 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 23:48:36.685823 ignition[1447]: INFO : Ignition 2.19.0 Sep 4 23:48:36.688935 ignition[1447]: INFO : Stage: umount Sep 4 23:48:36.688935 ignition[1447]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:36.688935 ignition[1447]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:36.688935 ignition[1447]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:36.699632 ignition[1447]: INFO : PUT result: OK Sep 4 23:48:36.704351 ignition[1447]: INFO : umount: umount passed Sep 4 23:48:36.706253 ignition[1447]: INFO : Ignition finished successfully Sep 4 23:48:36.711950 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 23:48:36.712185 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 23:48:36.730010 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 23:48:36.733039 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 23:48:36.733153 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 23:48:36.738345 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 23:48:36.738453 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 23:48:36.744766 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 4 23:48:36.744896 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 4 23:48:36.747145 systemd[1]: Stopped target network.target - Network. Sep 4 23:48:36.749360 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 23:48:36.749451 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:48:36.752154 systemd[1]: Stopped target paths.target - Path Units. Sep 4 23:48:36.754012 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 23:48:36.756190 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:36.757037 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 23:48:36.768825 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 23:48:36.770898 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 23:48:36.770980 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:48:36.774295 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 23:48:36.774367 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:48:36.776573 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 23:48:36.776658 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 23:48:36.778898 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 23:48:36.778976 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 23:48:36.813943 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 23:48:36.816428 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 23:48:36.823920 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 23:48:36.824722 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 23:48:36.834080 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 23:48:36.834259 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 23:48:36.834331 systemd-networkd[1203]: eth0: DHCPv6 lease lost Sep 4 23:48:36.842556 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 23:48:36.843492 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 23:48:36.853734 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 23:48:36.853961 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 23:48:36.858307 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 23:48:36.858422 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:36.871924 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 23:48:36.876412 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 23:48:36.876675 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:48:36.887054 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 23:48:36.887163 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:36.890027 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 23:48:36.890109 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:36.892493 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 23:48:36.892595 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:36.897558 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:36.937609 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 23:48:36.940109 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:36.946494 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 23:48:36.946838 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:36.950202 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 23:48:36.950276 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:36.950501 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 23:48:36.950605 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:48:36.951308 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 23:48:36.951386 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 23:48:36.974056 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:48:36.974168 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:36.986861 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 23:48:36.991766 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 23:48:36.991887 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:36.995388 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 23:48:36.995473 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:48:36.998708 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 23:48:36.998787 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:37.001929 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:48:37.002008 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:37.005378 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 23:48:37.005579 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 23:48:37.046997 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 23:48:37.047390 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 23:48:37.052734 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 23:48:37.062162 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 23:48:37.085862 systemd[1]: Switching root. Sep 4 23:48:37.127576 systemd-journald[251]: Journal stopped Sep 4 23:48:39.297696 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Sep 4 23:48:39.297831 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 23:48:39.297877 kernel: SELinux: policy capability open_perms=1 Sep 4 23:48:39.297909 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 23:48:39.297956 kernel: SELinux: policy capability always_check_network=0 Sep 4 23:48:39.297988 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 23:48:39.298019 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 23:48:39.298049 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 23:48:39.298080 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 23:48:39.298113 kernel: audit: type=1403 audit(1788565717.473:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 23:48:39.298145 systemd[1]: Successfully loaded SELinux policy in 57.051ms. Sep 4 23:48:39.298186 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.611ms. Sep 4 23:48:39.298222 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) Sep 4 23:48:39.298260 systemd[1]: Detected virtualization amazon. Sep 4 23:48:39.298291 systemd[1]: Detected architecture arm64. Sep 4 23:48:39.298322 systemd[1]: Detected first boot. Sep 4 23:48:39.298357 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:48:39.298393 zram_generator::config[1489]: No configuration found. Sep 4 23:48:39.298431 systemd[1]: Populated /etc with preset unit settings. Sep 4 23:48:39.298461 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 23:48:39.298494 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 23:48:39.298551 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 23:48:39.298588 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 23:48:39.298620 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 23:48:39.298654 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 23:48:39.298686 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 23:48:39.298725 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 23:48:39.298758 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 23:48:39.298795 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 23:48:39.298828 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 23:48:39.298861 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:39.298892 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:39.298927 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 23:48:39.298976 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 23:48:39.299010 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 23:48:39.299049 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:48:39.299084 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 23:48:39.299117 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:39.299149 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 23:48:39.299183 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 23:48:39.299216 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 23:48:39.300702 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 23:48:39.300752 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:39.300799 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:48:39.300832 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:48:39.300865 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:48:39.300898 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 23:48:39.300928 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 23:48:39.300961 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:39.300991 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:39.301025 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:39.301058 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 23:48:39.301094 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 23:48:39.301124 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 23:48:39.301156 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 23:48:39.301190 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 23:48:39.301220 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 23:48:39.301250 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 23:48:39.301292 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). Sep 4 23:48:39.301323 systemd[1]: Reached target machines.target - Containers. Sep 4 23:48:39.301363 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 23:48:39.301400 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:48:39.301431 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:48:39.301463 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 23:48:39.301493 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:48:39.301543 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:48:39.301579 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:48:39.301612 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 23:48:39.301642 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:48:39.301677 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 23:48:39.301711 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 23:48:39.301742 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 23:48:39.301775 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 23:48:39.301807 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 23:48:39.301840 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:48:39.301869 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:48:39.301898 kernel: fuse: init (API version 7.39) Sep 4 23:48:39.301928 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 23:48:39.301962 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 23:48:39.301993 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:48:39.302026 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 23:48:39.302056 systemd[1]: Stopped verity-setup.service. Sep 4 23:48:39.302089 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 23:48:39.302119 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 23:48:39.302149 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 23:48:39.302178 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 23:48:39.302207 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 23:48:39.302242 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 23:48:39.302272 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:39.302302 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 23:48:39.302332 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 23:48:39.302362 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:48:39.302397 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:48:39.302432 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:48:39.302462 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:48:39.302492 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 23:48:39.304579 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 23:48:39.304629 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:39.304671 kernel: loop: module loaded Sep 4 23:48:39.304702 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 23:48:39.304733 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 23:48:39.304764 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:48:39.304794 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:48:39.304824 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 23:48:39.304857 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 23:48:39.304889 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 23:48:39.304925 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 23:48:39.304955 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:48:39.304985 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 23:48:39.305059 systemd-journald[1571]: Collecting audit messages is disabled. Sep 4 23:48:39.305109 kernel: ACPI: bus type drm_connector registered Sep 4 23:48:39.305140 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 23:48:39.305170 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 23:48:39.305206 systemd-journald[1571]: Journal started Sep 4 23:48:39.305256 systemd-journald[1571]: Runtime Journal (/run/log/journal/ec2155a4f170fbbf64454f4da0731741) is 8.0M, max 75.3M, 67.3M free. Sep 4 23:48:38.560576 systemd[1]: Queued start job for default target multi-user.target. Sep 4 23:48:39.308173 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:48:38.602567 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 4 23:48:38.603340 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 23:48:39.329315 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 23:48:39.329406 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:48:39.345667 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 23:48:39.345763 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:48:39.370547 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:48:39.370642 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 23:48:39.388833 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 23:48:39.398599 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:48:39.401706 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 23:48:39.404954 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:48:39.405246 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:48:39.407997 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 23:48:39.411977 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 23:48:39.422758 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 23:48:39.427412 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 23:48:39.498048 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 23:48:39.518702 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 23:48:39.524997 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 4 23:48:39.537592 kernel: loop0: detected capacity change from 0 to 52536 Sep 4 23:48:39.569291 systemd-journald[1571]: Time spent on flushing to /var/log/journal/ec2155a4f170fbbf64454f4da0731741 is 52.540ms for 889 entries. Sep 4 23:48:39.569291 systemd-journald[1571]: System Journal (/var/log/journal/ec2155a4f170fbbf64454f4da0731741) is 8.0M, max 195.6M, 187.6M free. Sep 4 23:48:39.637835 systemd-journald[1571]: Received client request to flush runtime journal. Sep 4 23:48:39.637953 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 23:48:39.577112 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Sep 4 23:48:39.577137 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Sep 4 23:48:39.595410 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:48:39.606868 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 23:48:39.609806 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:39.640195 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 23:48:39.657028 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:39.676331 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 23:48:39.682168 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 23:48:39.684574 kernel: loop1: detected capacity change from 0 to 114432 Sep 4 23:48:39.685087 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 4 23:48:39.744289 udevadm[1639]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 4 23:48:39.769555 kernel: loop2: detected capacity change from 0 to 200864 Sep 4 23:48:39.770362 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 23:48:39.784806 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:48:39.855570 kernel: loop3: detected capacity change from 0 to 114328 Sep 4 23:48:39.869101 systemd-tmpfiles[1646]: ACLs are not supported, ignoring. Sep 4 23:48:39.869728 systemd-tmpfiles[1646]: ACLs are not supported, ignoring. Sep 4 23:48:39.887729 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:39.928593 kernel: loop4: detected capacity change from 0 to 52536 Sep 4 23:48:39.955016 kernel: loop5: detected capacity change from 0 to 114432 Sep 4 23:48:39.980948 kernel: loop6: detected capacity change from 0 to 200864 Sep 4 23:48:40.013575 kernel: loop7: detected capacity change from 0 to 114328 Sep 4 23:48:40.031160 (sd-merge)[1652]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Sep 4 23:48:40.032164 (sd-merge)[1652]: Merged extensions into '/usr'. Sep 4 23:48:40.040995 systemd[1]: Reloading requested from client PID 1600 ('systemd-sysext') (unit systemd-sysext.service)... Sep 4 23:48:40.041027 systemd[1]: Reloading... Sep 4 23:48:40.273731 zram_generator::config[1679]: No configuration found. Sep 4 23:48:40.596240 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. Sep 4 23:48:40.650548 ldconfig[1596]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 23:48:40.728860 systemd[1]: Reloading finished in 686 ms. Sep 4 23:48:40.766902 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 23:48:40.770138 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 23:48:40.773420 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 23:48:40.791887 systemd[1]: Starting ensure-sysext.service... Sep 4 23:48:40.796692 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:48:40.807936 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:40.832667 systemd[1]: Reloading requested from client PID 1731 ('systemctl') (unit ensure-sysext.service)... Sep 4 23:48:40.832704 systemd[1]: Reloading... Sep 4 23:48:40.843738 systemd-tmpfiles[1732]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 23:48:40.844435 systemd-tmpfiles[1732]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 23:48:40.846389 systemd-tmpfiles[1732]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 23:48:40.846980 systemd-tmpfiles[1732]: ACLs are not supported, ignoring. Sep 4 23:48:40.847115 systemd-tmpfiles[1732]: ACLs are not supported, ignoring. Sep 4 23:48:40.856615 systemd-tmpfiles[1732]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:48:40.856641 systemd-tmpfiles[1732]: Skipping /boot Sep 4 23:48:40.894787 systemd-tmpfiles[1732]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:48:40.894817 systemd-tmpfiles[1732]: Skipping /boot Sep 4 23:48:40.924955 systemd-udevd[1733]: Using default interface naming scheme 'v255'. Sep 4 23:48:41.059011 zram_generator::config[1760]: No configuration found. Sep 4 23:48:41.167735 (udev-worker)[1780]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:48:41.385706 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (1764) Sep 4 23:48:41.471116 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. Sep 4 23:48:41.640362 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 23:48:41.642132 systemd[1]: Reloading finished in 808 ms. Sep 4 23:48:41.677793 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:41.684991 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:41.755001 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 23:48:41.773585 systemd[1]: Finished ensure-sysext.service. Sep 4 23:48:41.804055 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 4 23:48:41.823796 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 23:48:41.831851 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 23:48:41.834665 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:48:41.839939 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 23:48:41.845852 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:48:41.854337 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:48:41.860864 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:48:41.869796 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:48:41.872363 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:48:41.892043 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 23:48:41.901098 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 23:48:41.916355 lvm[1930]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:48:41.908637 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:48:41.932095 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:48:41.934668 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 23:48:41.945002 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 23:48:41.954996 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:41.991849 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 23:48:42.001301 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 23:48:42.049374 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 23:48:42.053152 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:42.060832 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 23:48:42.071199 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 23:48:42.096799 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 23:48:42.100422 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:48:42.104157 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:48:42.108076 augenrules[1963]: No rules Sep 4 23:48:42.107664 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:48:42.107964 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:48:42.111282 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 23:48:42.114340 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:48:42.115644 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:48:42.123739 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:48:42.126128 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:48:42.140106 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:48:42.140249 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:48:42.145852 lvm[1959]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:48:42.150443 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 23:48:42.213208 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 23:48:42.217583 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 23:48:42.222594 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 23:48:42.229188 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). Sep 4 23:48:42.253277 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 23:48:42.286793 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:42.378584 systemd-networkd[1943]: lo: Link UP Sep 4 23:48:42.379204 systemd-networkd[1943]: lo: Gained carrier Sep 4 23:48:42.382534 systemd-resolved[1944]: Positive Trust Anchors: Sep 4 23:48:42.382575 systemd-resolved[1944]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:48:42.382640 systemd-resolved[1944]: 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 Sep 4 23:48:42.383443 systemd-networkd[1943]: Enumeration completed Sep 4 23:48:42.383813 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:48:42.387180 systemd-networkd[1943]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:42.387196 systemd-networkd[1943]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:48:42.389649 systemd-networkd[1943]: eth0: Link UP Sep 4 23:48:42.390082 systemd-networkd[1943]: eth0: Gained carrier Sep 4 23:48:42.390222 systemd-networkd[1943]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:42.402899 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 23:48:42.403635 systemd-networkd[1943]: eth0: DHCPv4 address 172.31.16.224/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 4 23:48:42.412908 systemd-resolved[1944]: Defaulting to hostname 'linux'. Sep 4 23:48:42.416335 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:48:42.418991 systemd[1]: Reached target network.target - Network. Sep 4 23:48:42.421018 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:42.423643 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:48:42.426120 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 23:48:42.428957 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 23:48:42.432122 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 23:48:42.434858 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 23:48:42.437834 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 23:48:42.440718 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 23:48:42.440781 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:48:42.442838 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:48:42.445837 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 23:48:42.451125 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 23:48:42.460797 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 23:48:42.464111 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 23:48:42.466674 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:48:42.468752 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:48:42.470751 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:48:42.470806 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:48:42.477853 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 23:48:42.486470 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 4 23:48:42.494114 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 23:48:42.503783 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 23:48:42.521841 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 23:48:42.526695 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). Sep 4 23:48:42.535356 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 23:48:42.544876 systemd[1]: Started ntpd.service - Network Time Service. Sep 4 23:48:42.552501 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 4 23:48:42.560889 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 23:48:42.566918 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 23:48:42.580723 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 23:48:42.586688 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 23:48:42.602703 extend-filesystems[1995]: Found loop4 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found loop5 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found loop6 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found loop7 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p1 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p2 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p3 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found usr Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p4 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p6 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p7 Sep 4 23:48:42.602703 extend-filesystems[1995]: Found nvme0n1p9 Sep 4 23:48:42.602703 extend-filesystems[1995]: Checking size of /dev/nvme0n1p9 Sep 4 23:48:42.587603 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 23:48:42.704944 jq[1994]: false Sep 4 23:48:42.592297 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 23:48:42.617385 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 23:48:42.647035 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 23:48:42.710423 dbus-daemon[1993]: [system] SELinux support is enabled Sep 4 23:48:42.735918 jq[2005]: true Sep 4 23:48:42.649597 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 23:48:42.711153 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 23:48:42.754896 extend-filesystems[1995]: Resized partition /dev/nvme0n1p9 Sep 4 23:48:42.748460 dbus-daemon[1993]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1943 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 4 23:48:42.718959 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). Sep 4 23:48:42.719003 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 23:48:42.722713 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). Sep 4 23:48:42.722750 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 23:48:42.780854 dbus-daemon[1993]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 4 23:48:42.782295 extend-filesystems[2020]: resize2fs 1.47.1 (20-May-2024) Sep 4 23:48:42.766289 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 23:48:42.766770 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 23:48:42.817834 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 4 23:48:42.824614 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Sep 4 23:48:42.857749 (ntainerd)[2024]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 23:48:42.893561 jq[2016]: true Sep 4 23:48:42.918286 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 4 23:48:42.931018 systemd-logind[2003]: Watching system buttons on /dev/input/event0 (Power Button) Sep 4 23:48:42.931071 systemd-logind[2003]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 4 23:48:42.931431 systemd-logind[2003]: New seat seat0. Sep 4 23:48:42.935898 ntpd[1997]: ntpd 4.2.8p17@1.4004-o Fri Sep 4 21:54:26 UTC 2026 (1): Starting Sep 4 23:48:42.935963 ntpd[1997]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: ntpd 4.2.8p17@1.4004-o Fri Sep 4 21:54:26 UTC 2026 (1): Starting Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: ---------------------------------------------------- Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: ntp-4 is maintained by Network Time Foundation, Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: corporation. Support and training for ntp-4 are Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: available at https://www.nwtime.org/support Sep 4 23:48:42.937905 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: ---------------------------------------------------- Sep 4 23:48:42.935984 ntpd[1997]: ---------------------------------------------------- Sep 4 23:48:42.936023 ntpd[1997]: ntp-4 is maintained by Network Time Foundation, Sep 4 23:48:42.936045 ntpd[1997]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 4 23:48:42.936065 ntpd[1997]: corporation. Support and training for ntp-4 are Sep 4 23:48:42.936084 ntpd[1997]: available at https://www.nwtime.org/support Sep 4 23:48:42.936103 ntpd[1997]: ---------------------------------------------------- Sep 4 23:48:42.944786 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 23:48:42.947781 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 23:48:42.953639 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 23:48:42.963811 ntpd[1997]: proto: precision = 0.108 usec (-23) Sep 4 23:48:42.964585 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: proto: precision = 0.108 usec (-23) Sep 4 23:48:42.964585 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: basedate set to 2026-08-23 Sep 4 23:48:42.964585 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: gps base set to 2026-08-23 (week 2433) Sep 4 23:48:42.964290 ntpd[1997]: basedate set to 2026-08-23 Sep 4 23:48:42.964320 ntpd[1997]: gps base set to 2026-08-23 (week 2433) Sep 4 23:48:42.969807 update_engine[2004]: I20260904 23:48:42.965409 2004 main.cc:92] Flatcar Update Engine starting Sep 4 23:48:42.986452 systemd[1]: Started update-engine.service - Update Engine. Sep 4 23:48:42.994662 ntpd[1997]: Listen and drop on 0 v6wildcard [::]:123 Sep 4 23:48:42.997796 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: Listen and drop on 0 v6wildcard [::]:123 Sep 4 23:48:42.997796 ntpd[1997]: 4 Sep 23:48:42 ntpd[1997]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 4 23:48:42.994743 ntpd[1997]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 4 23:48:42.998696 update_engine[2004]: I20260904 23:48:42.998222 2004 update_check_scheduler.cc:74] Next update check in 6m38s Sep 4 23:48:43.032568 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Sep 4 23:48:43.030963 ntpd[1997]: Listen normally on 2 lo 127.0.0.1:123 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: Listen normally on 2 lo 127.0.0.1:123 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: Listen normally on 3 eth0 172.31.16.224:123 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: Listen normally on 4 lo [::1]:123 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: bind(21) AF_INET6 fe80::403:22ff:fea1:3447%2#123 flags 0x11 failed: Cannot assign requested address Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: unable to create socket on eth0 (5) for fe80::403:22ff:fea1:3447%2#123 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: failed to init interface for address fe80::403:22ff:fea1:3447%2 Sep 4 23:48:43.032755 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: Listening on routing socket on fd #21 for interface updates Sep 4 23:48:43.026296 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 23:48:43.031065 ntpd[1997]: Listen normally on 3 eth0 172.31.16.224:123 Sep 4 23:48:43.031147 ntpd[1997]: Listen normally on 4 lo [::1]:123 Sep 4 23:48:43.031239 ntpd[1997]: bind(21) AF_INET6 fe80::403:22ff:fea1:3447%2#123 flags 0x11 failed: Cannot assign requested address Sep 4 23:48:43.031282 ntpd[1997]: unable to create socket on eth0 (5) for fe80::403:22ff:fea1:3447%2#123 Sep 4 23:48:43.051668 extend-filesystems[2020]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 4 23:48:43.051668 extend-filesystems[2020]: old_desc_blocks = 1, new_desc_blocks = 2 Sep 4 23:48:43.051668 extend-filesystems[2020]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Sep 4 23:48:43.031315 ntpd[1997]: failed to init interface for address fe80::403:22ff:fea1:3447%2 Sep 4 23:48:43.065333 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 23:48:43.078754 extend-filesystems[1995]: Resized filesystem in /dev/nvme0n1p9 Sep 4 23:48:43.031377 ntpd[1997]: Listening on routing socket on fd #21 for interface updates Sep 4 23:48:43.066765 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 23:48:43.084019 ntpd[1997]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:43.086634 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:43.086634 ntpd[1997]: 4 Sep 23:48:43 ntpd[1997]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:43.084073 ntpd[1997]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:43.117207 coreos-metadata[1992]: Sep 04 23:48:43.115 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.129 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.132 INFO Fetch successful Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.132 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.132 INFO Fetch successful Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.132 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.133 INFO Fetch successful Sep 4 23:48:43.140175 coreos-metadata[1992]: Sep 04 23:48:43.133 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 4 23:48:43.141549 coreos-metadata[1992]: Sep 04 23:48:43.141 INFO Fetch successful Sep 4 23:48:43.141549 coreos-metadata[1992]: Sep 04 23:48:43.141 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 4 23:48:43.146420 coreos-metadata[1992]: Sep 04 23:48:43.144 INFO Fetch failed with 404: resource not found Sep 4 23:48:43.146420 coreos-metadata[1992]: Sep 04 23:48:43.144 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 4 23:48:43.156875 coreos-metadata[1992]: Sep 04 23:48:43.154 INFO Fetch successful Sep 4 23:48:43.156875 coreos-metadata[1992]: Sep 04 23:48:43.154 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 4 23:48:43.156875 coreos-metadata[1992]: Sep 04 23:48:43.155 INFO Fetch successful Sep 4 23:48:43.156875 coreos-metadata[1992]: Sep 04 23:48:43.155 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 4 23:48:43.159446 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (1775) Sep 4 23:48:43.159559 coreos-metadata[1992]: Sep 04 23:48:43.158 INFO Fetch successful Sep 4 23:48:43.164845 coreos-metadata[1992]: Sep 04 23:48:43.158 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 4 23:48:43.164845 coreos-metadata[1992]: Sep 04 23:48:43.162 INFO Fetch successful Sep 4 23:48:43.164845 coreos-metadata[1992]: Sep 04 23:48:43.162 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 4 23:48:43.178990 coreos-metadata[1992]: Sep 04 23:48:43.176 INFO Fetch successful Sep 4 23:48:43.270674 bash[2077]: Updated "/home/core/.ssh/authorized_keys" Sep 4 23:48:43.292617 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 23:48:43.338178 systemd[1]: Starting sshkeys.service... Sep 4 23:48:43.374389 dbus-daemon[1993]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 4 23:48:43.375416 dbus-daemon[1993]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=2028 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 4 23:48:43.392199 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 4 23:48:43.405040 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 4 23:48:43.411120 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 23:48:43.467485 systemd[1]: Starting polkit.service - Authorization Manager... Sep 4 23:48:43.478288 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 4 23:48:43.486602 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 4 23:48:43.510751 polkitd[2116]: Started polkitd version 121 Sep 4 23:48:43.527314 polkitd[2116]: Loading rules from directory /etc/polkit-1/rules.d Sep 4 23:48:43.527429 polkitd[2116]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 4 23:48:43.528950 polkitd[2116]: Finished loading, compiling and executing 2 rules Sep 4 23:48:43.530491 dbus-daemon[1993]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 4 23:48:43.530776 systemd[1]: Started polkit.service - Authorization Manager. Sep 4 23:48:43.536971 polkitd[2116]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 4 23:48:43.557225 systemd-resolved[1944]: System hostname changed to 'ip-172-31-16-224'. Sep 4 23:48:43.557839 systemd-hostnamed[2028]: Hostname set to (transient) Sep 4 23:48:43.699544 containerd[2024]: time="2026-09-04T23:48:43.699097342Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 4 23:48:43.760762 coreos-metadata[2133]: Sep 04 23:48:43.759 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 4 23:48:43.761265 coreos-metadata[2133]: Sep 04 23:48:43.760 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 4 23:48:43.761745 coreos-metadata[2133]: Sep 04 23:48:43.761 INFO Fetch successful Sep 4 23:48:43.761745 coreos-metadata[2133]: Sep 04 23:48:43.761 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 4 23:48:43.767353 coreos-metadata[2133]: Sep 04 23:48:43.767 INFO Fetch successful Sep 4 23:48:43.770687 unknown[2133]: wrote ssh authorized keys file for user: core Sep 4 23:48:43.798237 locksmithd[2044]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 23:48:43.818090 update-ssh-keys[2176]: Updated "/home/core/.ssh/authorized_keys" Sep 4 23:48:43.819982 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 4 23:48:43.830647 systemd[1]: Finished sshkeys.service. Sep 4 23:48:43.863948 containerd[2024]: time="2026-09-04T23:48:43.863887343Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.867009 containerd[2024]: time="2026-09-04T23:48:43.866940971Z" 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.156-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.867172 containerd[2024]: time="2026-09-04T23:48:43.867143255Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 23:48:43.867292 containerd[2024]: time="2026-09-04T23:48:43.867264839Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.867715 containerd[2024]: time="2026-09-04T23:48:43.867679571Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 23:48:43.867868 containerd[2024]: time="2026-09-04T23:48:43.867839027Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.868119 containerd[2024]: time="2026-09-04T23:48:43.868082243Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.868235 containerd[2024]: time="2026-09-04T23:48:43.868206899Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.868715 containerd[2024]: time="2026-09-04T23:48:43.868675367Z" 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 Sep 4 23:48:43.868837 containerd[2024]: time="2026-09-04T23:48:43.868809143Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.868951 containerd[2024]: time="2026-09-04T23:48:43.868920767Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.869078 containerd[2024]: time="2026-09-04T23:48:43.869048447Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.869340 containerd[2024]: time="2026-09-04T23:48:43.869310119Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.869915 containerd[2024]: time="2026-09-04T23:48:43.869877695Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.870283 containerd[2024]: time="2026-09-04T23:48:43.870247619Z" 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 Sep 4 23:48:43.870562 containerd[2024]: time="2026-09-04T23:48:43.870363059Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 23:48:43.870683 containerd[2024]: time="2026-09-04T23:48:43.870655307Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 23:48:43.871001 containerd[2024]: time="2026-09-04T23:48:43.870854279Z" level=info msg="metadata content store policy set" policy=shared Sep 4 23:48:43.879078 containerd[2024]: time="2026-09-04T23:48:43.879023723Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 23:48:43.879817 containerd[2024]: time="2026-09-04T23:48:43.879259727Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 23:48:43.879817 containerd[2024]: time="2026-09-04T23:48:43.879378911Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 23:48:43.879817 containerd[2024]: time="2026-09-04T23:48:43.879418799Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 23:48:43.879817 containerd[2024]: time="2026-09-04T23:48:43.879452507Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 23:48:43.879817 containerd[2024]: time="2026-09-04T23:48:43.879732719Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 23:48:43.880801 containerd[2024]: time="2026-09-04T23:48:43.880763411Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881082131Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881133731Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881164835Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881199191Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881233715Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881265743Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881299511Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881333099Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881373935Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881404643Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881432567Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881472899Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881505491Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882296 containerd[2024]: time="2026-09-04T23:48:43.881562575Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881626823Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881661179Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881693183Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881721995Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881753075Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881783003Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881817491Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881847947Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881886299Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881921855Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881957303Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.881998451Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.882037967Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.882957 containerd[2024]: time="2026-09-04T23:48:43.882067955Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.883872 containerd[2024]: time="2026-09-04T23:48:43.883580423Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 23:48:43.884006 containerd[2024]: time="2026-09-04T23:48:43.883958651Z" 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 Sep 4 23:48:43.884111 containerd[2024]: time="2026-09-04T23:48:43.884084051Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.885548 containerd[2024]: time="2026-09-04T23:48:43.884191583Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 23:48:43.885548 containerd[2024]: time="2026-09-04T23:48:43.884226623Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.885548 containerd[2024]: time="2026-09-04T23:48:43.884266763Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 23:48:43.885548 containerd[2024]: time="2026-09-04T23:48:43.884291315Z" level=info msg="NRI interface is disabled by configuration." Sep 4 23:48:43.885548 containerd[2024]: time="2026-09-04T23:48:43.884316323Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.885834 containerd[2024]: time="2026-09-04T23:48:43.884967275Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 4 23:48:43.885834 containerd[2024]: time="2026-09-04T23:48:43.885072527Z" level=info msg="Connect containerd service" Sep 4 23:48:43.885834 containerd[2024]: time="2026-09-04T23:48:43.885122603Z" level=info msg="using legacy CRI server" Sep 4 23:48:43.885834 containerd[2024]: time="2026-09-04T23:48:43.885139643Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 23:48:43.885834 containerd[2024]: time="2026-09-04T23:48:43.885276491Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 23:48:43.887320 containerd[2024]: time="2026-09-04T23:48:43.887273135Z" 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" Sep 4 23:48:43.887791 containerd[2024]: time="2026-09-04T23:48:43.887736731Z" level=info msg="Start subscribing containerd event" Sep 4 23:48:43.887927 containerd[2024]: time="2026-09-04T23:48:43.887901179Z" level=info msg="Start recovering state" Sep 4 23:48:43.888501 containerd[2024]: time="2026-09-04T23:48:43.888461255Z" level=info msg="Start event monitor" Sep 4 23:48:43.888629 containerd[2024]: time="2026-09-04T23:48:43.888603719Z" level=info msg="Start snapshots syncer" Sep 4 23:48:43.888900 containerd[2024]: time="2026-09-04T23:48:43.888872243Z" level=info msg="Start cni network conf syncer for default" Sep 4 23:48:43.889019 containerd[2024]: time="2026-09-04T23:48:43.888994319Z" level=info msg="Start streaming server" Sep 4 23:48:43.890271 containerd[2024]: time="2026-09-04T23:48:43.890209595Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 23:48:43.890613 containerd[2024]: time="2026-09-04T23:48:43.890587043Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 23:48:43.892783 containerd[2024]: time="2026-09-04T23:48:43.892642187Z" level=info msg="containerd successfully booted in 0.203109s" Sep 4 23:48:43.892749 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 23:48:43.895385 systemd-networkd[1943]: eth0: Gained IPv6LL Sep 4 23:48:43.902283 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 23:48:43.907072 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 23:48:43.923056 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 4 23:48:43.942928 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:43.951581 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 23:48:44.042836 amazon-ssm-agent[2194]: Initializing new seelog logger Sep 4 23:48:44.043331 amazon-ssm-agent[2194]: New Seelog Logger Creation Complete Sep 4 23:48:44.043331 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.043331 amazon-ssm-agent[2194]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 processing appconfig overrides Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 processing appconfig overrides Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.045402 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 processing appconfig overrides Sep 4 23:48:44.046945 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO Proxy environment variables: Sep 4 23:48:44.051198 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.051198 amazon-ssm-agent[2194]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:44.051366 amazon-ssm-agent[2194]: 2026/09/04 23:48:44 processing appconfig overrides Sep 4 23:48:44.061576 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 23:48:44.146639 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO no_proxy: Sep 4 23:48:44.246658 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO https_proxy: Sep 4 23:48:44.345296 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO http_proxy: Sep 4 23:48:44.443536 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO Checking if agent identity type OnPrem can be assumed Sep 4 23:48:44.478428 sshd_keygen[2030]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 23:48:44.538612 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 23:48:44.544633 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO Checking if agent identity type EC2 can be assumed Sep 4 23:48:44.556044 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 23:48:44.593341 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 23:48:44.593810 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 23:48:44.604347 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 23:48:44.640928 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 23:48:44.648173 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO Agent will take identity from EC2 Sep 4 23:48:44.657079 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 23:48:44.668344 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 23:48:44.671160 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 23:48:44.747598 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.847242 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.908983 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.909204 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Sep 4 23:48:44.909345 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 4 23:48:44.909475 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] Starting Core Agent Sep 4 23:48:44.909599 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] registrar detected. Attempting registration Sep 4 23:48:44.909692 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [Registrar] Starting registrar module Sep 4 23:48:44.909784 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Sep 4 23:48:44.909877 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [EC2Identity] EC2 registration was successful. Sep 4 23:48:44.909988 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [CredentialRefresher] credentialRefresher has started Sep 4 23:48:44.910080 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [CredentialRefresher] Starting credentials refresher loop Sep 4 23:48:44.910171 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 4 23:48:44.946794 amazon-ssm-agent[2194]: 2026-09-04 23:48:44 INFO [CredentialRefresher] Next credential rotation will be in 32.35830406463333 minutes Sep 4 23:48:45.491577 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:45.495279 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 23:48:45.500149 systemd[1]: Startup finished in 1.264s (kernel) + 7.650s (initrd) + 8.083s (userspace) = 16.998s. Sep 4 23:48:45.520126 (kubelet)[2234]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Sep 4 23:48:45.934463 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 23:48:45.938911 ntpd[1997]: Listen normally on 6 eth0 [fe80::403:22ff:fea1:3447%2]:123 Sep 4 23:48:45.939854 ntpd[1997]: 4 Sep 23:48:45 ntpd[1997]: Listen normally on 6 eth0 [fe80::403:22ff:fea1:3447%2]:123 Sep 4 23:48:45.940005 systemd[1]: Started sshd@0-172.31.16.224:22-20.61.25.254:58826.service - OpenSSH per-connection server daemon (20.61.25.254:58826). Sep 4 23:48:45.954151 amazon-ssm-agent[2194]: 2026-09-04 23:48:45 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 4 23:48:46.056123 amazon-ssm-agent[2194]: 2026-09-04 23:48:45 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2246) started Sep 4 23:48:46.157205 amazon-ssm-agent[2194]: 2026-09-04 23:48:45 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 4 23:48:46.299047 kubelet[2234]: E0904 23:48:46.298880 2234 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" Sep 4 23:48:46.303279 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Sep 4 23:48:46.303676 systemd[1]: kubelet.service: Failed with result 'exit-code'. Sep 4 23:48:46.304468 systemd[1]: kubelet.service: Consumed 1.285s CPU time. Sep 4 23:48:46.973413 sshd[2245]: Accepted publickey for core from 20.61.25.254 port 58826 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:46.976138 sshd[2245]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:46.995284 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 23:48:47.004066 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 23:48:47.009623 systemd-logind[2003]: New session 1 of user core. Sep 4 23:48:47.033992 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 23:48:47.047100 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 23:48:47.062201 (systemd)[2260]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 23:48:47.294467 systemd[2260]: Queued start job for default target default.target. Sep 4 23:48:47.303914 systemd[2260]: Created slice app.slice - User Application Slice. Sep 4 23:48:47.303997 systemd[2260]: Reached target paths.target - Paths. Sep 4 23:48:47.304034 systemd[2260]: Reached target timers.target - Timers. Sep 4 23:48:47.306491 systemd[2260]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 23:48:47.337883 systemd[2260]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 23:48:47.338126 systemd[2260]: Reached target sockets.target - Sockets. Sep 4 23:48:47.338160 systemd[2260]: Reached target basic.target - Basic System. Sep 4 23:48:47.338262 systemd[2260]: Reached target default.target - Main User Target. Sep 4 23:48:47.338347 systemd[2260]: Startup finished in 264ms. Sep 4 23:48:47.339106 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 23:48:47.355796 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 23:48:48.049039 systemd[1]: Started sshd@1-172.31.16.224:22-20.61.25.254:52058.service - OpenSSH per-connection server daemon (20.61.25.254:52058). Sep 4 23:48:49.026033 sshd[2271]: Accepted publickey for core from 20.61.25.254 port 52058 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:49.028740 sshd[2271]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:49.035913 systemd-logind[2003]: New session 2 of user core. Sep 4 23:48:49.042782 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 23:48:49.697961 sshd[2271]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:49.705264 systemd[1]: sshd@1-172.31.16.224:22-20.61.25.254:52058.service: Deactivated successfully. Sep 4 23:48:49.708169 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 23:48:49.709651 systemd-logind[2003]: Session 2 logged out. Waiting for processes to exit. Sep 4 23:48:49.711893 systemd-logind[2003]: Removed session 2. Sep 4 23:48:49.881981 systemd[1]: Started sshd@2-172.31.16.224:22-20.61.25.254:52072.service - OpenSSH per-connection server daemon (20.61.25.254:52072). Sep 4 23:48:49.701614 systemd-resolved[1944]: Clock change detected. Flushing caches. Sep 4 23:48:49.712864 systemd-journald[1571]: Time jumped backwards, rotating. Sep 4 23:48:50.623883 sshd[2279]: Accepted publickey for core from 20.61.25.254 port 52072 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:50.625599 sshd[2279]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:50.634154 systemd-logind[2003]: New session 3 of user core. Sep 4 23:48:50.641785 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 23:48:51.293008 sshd[2279]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:51.299478 systemd[1]: sshd@2-172.31.16.224:22-20.61.25.254:52072.service: Deactivated successfully. Sep 4 23:48:51.304632 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 23:48:51.305989 systemd-logind[2003]: Session 3 logged out. Waiting for processes to exit. Sep 4 23:48:51.309450 systemd-logind[2003]: Removed session 3. Sep 4 23:48:51.462924 systemd[1]: Started sshd@3-172.31.16.224:22-20.61.25.254:52074.service - OpenSSH per-connection server daemon (20.61.25.254:52074). Sep 4 23:48:52.455347 sshd[2287]: Accepted publickey for core from 20.61.25.254 port 52074 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:52.456988 sshd[2287]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:52.464602 systemd-logind[2003]: New session 4 of user core. Sep 4 23:48:52.475768 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 23:48:53.135474 sshd[2287]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:53.142092 systemd[1]: sshd@3-172.31.16.224:22-20.61.25.254:52074.service: Deactivated successfully. Sep 4 23:48:53.145302 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 23:48:53.148462 systemd-logind[2003]: Session 4 logged out. Waiting for processes to exit. Sep 4 23:48:53.151196 systemd-logind[2003]: Removed session 4. Sep 4 23:48:53.312004 systemd[1]: Started sshd@4-172.31.16.224:22-20.61.25.254:52078.service - OpenSSH per-connection server daemon (20.61.25.254:52078). Sep 4 23:48:54.285827 sshd[2294]: Accepted publickey for core from 20.61.25.254 port 52078 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:54.288428 sshd[2294]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:54.297893 systemd-logind[2003]: New session 5 of user core. Sep 4 23:48:54.301789 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 23:48:54.819334 sudo[2297]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Sep 4 23:48:54.820091 sudo[2297]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 23:48:55.802820 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:55.803156 systemd[1]: kubelet.service: Consumed 1.285s CPU time. Sep 4 23:48:55.814037 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:55.876494 systemd[1]: Reloading requested from client PID 2330 ('systemctl') (unit session-5.scope)... Sep 4 23:48:55.876536 systemd[1]: Reloading... Sep 4 23:48:56.111556 zram_generator::config[2373]: No configuration found. Sep 4 23:48:56.369993 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. Sep 4 23:48:56.544551 systemd[1]: Reloading finished in 667 ms. Sep 4 23:48:56.642682 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Sep 4 23:48:56.642874 systemd[1]: kubelet.service: Failed with result 'signal'. Sep 4 23:48:56.643337 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:56.651216 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:56.984416 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:56.998297 (kubelet)[2433]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Sep 4 23:48:57.076552 kubelet[2433]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Sep 4 23:48:57.076552 kubelet[2433]: 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. Sep 4 23:48:57.076552 kubelet[2433]: I0904 23:48:57.074864 2433 server.go:213] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Sep 4 23:48:58.398580 kubelet[2433]: I0904 23:48:58.398494 2433 server.go:529] "Kubelet version" kubeletVersion="v1.34.4" Sep 4 23:48:58.399183 kubelet[2433]: I0904 23:48:58.399157 2433 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Sep 4 23:48:58.399312 kubelet[2433]: I0904 23:48:58.399293 2433 watchdog_linux.go:95] "Systemd watchdog is not enabled" Sep 4 23:48:58.399435 kubelet[2433]: I0904 23:48:58.399414 2433 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Sep 4 23:48:58.399924 kubelet[2433]: I0904 23:48:58.399898 2433 server.go:956] "Client rotation is on, will bootstrap in background" Sep 4 23:48:58.407953 kubelet[2433]: I0904 23:48:58.407897 2433 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Sep 4 23:48:58.416138 kubelet[2433]: E0904 23:48:58.416053 2433 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Sep 4 23:48:58.416275 kubelet[2433]: I0904 23:48:58.416188 2433 server.go:1400] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Sep 4 23:48:58.421115 kubelet[2433]: I0904 23:48:58.421062 2433 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Sep 4 23:48:58.421919 kubelet[2433]: I0904 23:48:58.421752 2433 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Sep 4 23:48:58.422256 kubelet[2433]: I0904 23:48:58.421810 2433 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.16.224","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"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},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Sep 4 23:48:58.423051 kubelet[2433]: I0904 23:48:58.422257 2433 topology_manager.go:138] "Creating topology manager with none policy" Sep 4 23:48:58.423051 kubelet[2433]: I0904 23:48:58.422278 2433 container_manager_linux.go:306] "Creating device plugin manager" Sep 4 23:48:58.423051 kubelet[2433]: I0904 23:48:58.422449 2433 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Sep 4 23:48:58.427943 kubelet[2433]: I0904 23:48:58.427902 2433 state_mem.go:36] "Initialized new in-memory state store" Sep 4 23:48:58.430655 kubelet[2433]: I0904 23:48:58.430615 2433 kubelet.go:475] "Attempting to sync node with API server" Sep 4 23:48:58.431573 kubelet[2433]: I0904 23:48:58.430834 2433 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Sep 4 23:48:58.431573 kubelet[2433]: I0904 23:48:58.430901 2433 kubelet.go:387] "Adding apiserver pod source" Sep 4 23:48:58.431573 kubelet[2433]: I0904 23:48:58.430925 2433 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Sep 4 23:48:58.434128 kubelet[2433]: E0904 23:48:58.434048 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:58.434965 kubelet[2433]: I0904 23:48:58.434918 2433 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Sep 4 23:48:58.435684 kubelet[2433]: E0904 23:48:58.435625 2433 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:58.435974 kubelet[2433]: I0904 23:48:58.435934 2433 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Sep 4 23:48:58.436069 kubelet[2433]: I0904 23:48:58.435994 2433 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Sep 4 23:48:58.436069 kubelet[2433]: W0904 23:48:58.436062 2433 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Sep 4 23:48:58.441467 kubelet[2433]: I0904 23:48:58.440807 2433 server.go:1262] "Started kubelet" Sep 4 23:48:58.443265 kubelet[2433]: I0904 23:48:58.443224 2433 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Sep 4 23:48:58.451207 kubelet[2433]: I0904 23:48:58.451055 2433 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Sep 4 23:48:58.454284 kubelet[2433]: I0904 23:48:58.453737 2433 server.go:310] "Adding debug handlers to kubelet server" Sep 4 23:48:58.458689 kubelet[2433]: I0904 23:48:58.458273 2433 volume_manager.go:313] "Starting Kubelet Volume Manager" Sep 4 23:48:58.458802 kubelet[2433]: E0904 23:48:58.458700 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:58.461544 kubelet[2433]: I0904 23:48:58.459032 2433 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Sep 4 23:48:58.461544 kubelet[2433]: I0904 23:48:58.459134 2433 reconciler.go:29] "Reconciler: start to sync state" Sep 4 23:48:58.465094 kubelet[2433]: I0904 23:48:58.464841 2433 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Sep 4 23:48:58.465094 kubelet[2433]: I0904 23:48:58.464944 2433 server_v1.go:49] "podresources" method="list" useActivePods=true Sep 4 23:48:58.466170 kubelet[2433]: I0904 23:48:58.466097 2433 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Sep 4 23:48:58.471788 kubelet[2433]: I0904 23:48:58.469595 2433 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Sep 4 23:48:58.471788 kubelet[2433]: E0904 23:48:58.469951 2433 reflector.go:205] "Failed to watch" err="failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" Sep 4 23:48:58.471788 kubelet[2433]: I0904 23:48:58.471441 2433 factory.go:223] Registration of the systemd container factory successfully Sep 4 23:48:58.471788 kubelet[2433]: I0904 23:48:58.471719 2433 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Sep 4 23:48:58.473370 kubelet[2433]: E0904 23:48:58.470921 2433 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{172.31.16.224.18d243101931adb3 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:172.31.16.224,UID:172.31.16.224,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:172.31.16.224,},FirstTimestamp:2026-09-04 23:48:58.440732083 +0000 UTC m=+1.435439924,LastTimestamp:2026-09-04 23:48:58.440732083 +0000 UTC m=+1.435439924,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:172.31.16.224,}" Sep 4 23:48:58.473568 kubelet[2433]: E0904 23:48:58.473441 2433 reflector.go:205] "Failed to watch" err="failed to list *v1.Node: nodes \"172.31.16.224\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Node" Sep 4 23:48:58.478223 kubelet[2433]: E0904 23:48:58.476734 2433 reflector.go:205] "Failed to watch" err="failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" Sep 4 23:48:58.479035 kubelet[2433]: E0904 23:48:58.478914 2433 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Sep 4 23:48:58.482624 kubelet[2433]: I0904 23:48:58.482576 2433 factory.go:223] Registration of the containerd container factory successfully Sep 4 23:48:58.517996 sudo[2297]: pam_unix(sudo:session): session closed for user root Sep 4 23:48:58.525195 kubelet[2433]: I0904 23:48:58.524853 2433 cpu_manager.go:221] "Starting CPU manager" policy="none" Sep 4 23:48:58.525195 kubelet[2433]: I0904 23:48:58.524878 2433 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Sep 4 23:48:58.525195 kubelet[2433]: I0904 23:48:58.524912 2433 state_mem.go:36] "Initialized new in-memory state store" Sep 4 23:48:58.527537 kubelet[2433]: I0904 23:48:58.527455 2433 policy_none.go:49] "None policy: Start" Sep 4 23:48:58.527649 kubelet[2433]: I0904 23:48:58.527502 2433 memory_manager.go:187] "Starting memorymanager" policy="None" Sep 4 23:48:58.527649 kubelet[2433]: I0904 23:48:58.527574 2433 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Sep 4 23:48:58.531585 kubelet[2433]: I0904 23:48:58.529399 2433 policy_none.go:47] "Start" Sep 4 23:48:58.545321 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Sep 4 23:48:58.559732 kubelet[2433]: E0904 23:48:58.559678 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:58.570494 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Sep 4 23:48:58.578630 kubelet[2433]: I0904 23:48:58.578570 2433 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Sep 4 23:48:58.581886 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Sep 4 23:48:58.584416 kubelet[2433]: I0904 23:48:58.584368 2433 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Sep 4 23:48:58.584416 kubelet[2433]: I0904 23:48:58.584413 2433 status_manager.go:244] "Starting to sync pod status with apiserver" Sep 4 23:48:58.584659 kubelet[2433]: I0904 23:48:58.584456 2433 kubelet.go:2428] "Starting kubelet main sync loop" Sep 4 23:48:58.584659 kubelet[2433]: E0904 23:48:58.584578 2433 kubelet.go:2452] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]" Sep 4 23:48:58.597221 kubelet[2433]: E0904 23:48:58.597183 2433 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Sep 4 23:48:58.601543 kubelet[2433]: I0904 23:48:58.599222 2433 eviction_manager.go:189] "Eviction manager: starting control loop" Sep 4 23:48:58.601543 kubelet[2433]: I0904 23:48:58.599265 2433 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Sep 4 23:48:58.601543 kubelet[2433]: I0904 23:48:58.600353 2433 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Sep 4 23:48:58.604880 kubelet[2433]: E0904 23:48:58.604605 2433 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Sep 4 23:48:58.606129 kubelet[2433]: E0904 23:48:58.605586 2433 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.16.224\" not found" Sep 4 23:48:58.676649 sshd[2294]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:58.686309 systemd-logind[2003]: Session 5 logged out. Waiting for processes to exit. Sep 4 23:48:58.687985 systemd[1]: sshd@4-172.31.16.224:22-20.61.25.254:52078.service: Deactivated successfully. Sep 4 23:48:58.693603 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 23:48:58.697038 systemd-logind[2003]: Removed session 5. Sep 4 23:48:58.701758 kubelet[2433]: I0904 23:48:58.700829 2433 kubelet_node_status.go:75] "Attempting to register node" node="172.31.16.224" Sep 4 23:48:58.706606 kubelet[2433]: I0904 23:48:58.706567 2433 kubelet_node_status.go:78] "Successfully registered node" node="172.31.16.224" Sep 4 23:48:58.706790 kubelet[2433]: E0904 23:48:58.706766 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.16.224\": node \"172.31.16.224\" not found" Sep 4 23:48:58.729173 kubelet[2433]: E0904 23:48:58.729130 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:58.829934 kubelet[2433]: E0904 23:48:58.829891 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:58.930724 kubelet[2433]: E0904 23:48:58.930588 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.031776 kubelet[2433]: E0904 23:48:59.031719 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.132418 kubelet[2433]: E0904 23:48:59.132360 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.233142 kubelet[2433]: E0904 23:48:59.233016 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.333761 kubelet[2433]: E0904 23:48:59.333703 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.403388 kubelet[2433]: I0904 23:48:59.403334 2433 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Sep 4 23:48:59.404111 kubelet[2433]: I0904 23:48:59.403672 2433 reflector.go:571] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:48:59.434780 kubelet[2433]: E0904 23:48:59.434723 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:59.434780 kubelet[2433]: E0904 23:48:59.434735 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.535058 kubelet[2433]: E0904 23:48:59.534999 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.635337 kubelet[2433]: E0904 23:48:59.635270 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.735691 kubelet[2433]: E0904 23:48:59.735645 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.836549 kubelet[2433]: E0904 23:48:59.836391 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:48:59.937353 kubelet[2433]: E0904 23:48:59.937314 2433 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.16.224\" not found" Sep 4 23:49:00.038989 kubelet[2433]: I0904 23:49:00.038771 2433 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Sep 4 23:49:00.040088 containerd[2024]: time="2026-09-04T23:49:00.039731515Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Sep 4 23:49:00.040692 kubelet[2433]: I0904 23:49:00.040071 2433 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Sep 4 23:49:00.435534 kubelet[2433]: E0904 23:49:00.435466 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:00.436697 kubelet[2433]: I0904 23:49:00.436646 2433 apiserver.go:52] "Watching apiserver" Sep 4 23:49:00.459640 kubelet[2433]: I0904 23:49:00.459587 2433 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Sep 4 23:49:00.461847 systemd[1]: Created slice kubepods-burstable-podbde9cd77_111e_4b91_b4a3_dfbe764c8dfc.slice - libcontainer container kubepods-burstable-podbde9cd77_111e_4b91_b4a3_dfbe764c8dfc.slice. Sep 4 23:49:00.471199 kubelet[2433]: I0904 23:49:00.471129 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-cni\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471345 kubelet[2433]: I0904 23:49:00.471204 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5nkxj\" (UniqueName: \"kubernetes.io/projected/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-kube-api-access-5nkxj\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471345 kubelet[2433]: I0904 23:49:00.471246 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/b11d7662-59e9-41cc-ad85-db878e6ebff0-lib-modules\") pod \"kube-proxy-njg44\" (UID: \"b11d7662-59e9-41cc-ad85-db878e6ebff0\") " pod="kube-system/kube-proxy-njg44" Sep 4 23:49:00.471345 kubelet[2433]: I0904 23:49:00.471285 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-run\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471345 kubelet[2433]: I0904 23:49:00.471330 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-cni-plugin\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471587 kubelet[2433]: I0904 23:49:00.471367 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-flannel-cfg\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471587 kubelet[2433]: I0904 23:49:00.471403 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/bde9cd77-111e-4b91-b4a3-dfbe764c8dfc-xtables-lock\") pod \"kube-flannel-ds-928qr\" (UID: \"bde9cd77-111e-4b91-b4a3-dfbe764c8dfc\") " pod="kube-flannel/kube-flannel-ds-928qr" Sep 4 23:49:00.471587 kubelet[2433]: I0904 23:49:00.471441 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/b11d7662-59e9-41cc-ad85-db878e6ebff0-kube-proxy\") pod \"kube-proxy-njg44\" (UID: \"b11d7662-59e9-41cc-ad85-db878e6ebff0\") " pod="kube-system/kube-proxy-njg44" Sep 4 23:49:00.471587 kubelet[2433]: I0904 23:49:00.471477 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/b11d7662-59e9-41cc-ad85-db878e6ebff0-xtables-lock\") pod \"kube-proxy-njg44\" (UID: \"b11d7662-59e9-41cc-ad85-db878e6ebff0\") " pod="kube-system/kube-proxy-njg44" Sep 4 23:49:00.471587 kubelet[2433]: I0904 23:49:00.471572 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2d4xx\" (UniqueName: \"kubernetes.io/projected/b11d7662-59e9-41cc-ad85-db878e6ebff0-kube-api-access-2d4xx\") pod \"kube-proxy-njg44\" (UID: \"b11d7662-59e9-41cc-ad85-db878e6ebff0\") " pod="kube-system/kube-proxy-njg44" Sep 4 23:49:00.486886 systemd[1]: Created slice kubepods-besteffort-podb11d7662_59e9_41cc_ad85_db878e6ebff0.slice - libcontainer container kubepods-besteffort-podb11d7662_59e9_41cc_ad85_db878e6ebff0.slice. Sep 4 23:49:00.786154 containerd[2024]: time="2026-09-04T23:49:00.786068579Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-928qr,Uid:bde9cd77-111e-4b91-b4a3-dfbe764c8dfc,Namespace:kube-flannel,Attempt:0,}" Sep 4 23:49:00.800570 containerd[2024]: time="2026-09-04T23:49:00.800480111Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-njg44,Uid:b11d7662-59e9-41cc-ad85-db878e6ebff0,Namespace:kube-system,Attempt:0,}" Sep 4 23:49:01.435797 kubelet[2433]: E0904 23:49:01.435721 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:01.546602 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2408507061.mount: Deactivated successfully. Sep 4 23:49:01.557720 containerd[2024]: time="2026-09-04T23:49:01.557641018Z" 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\"}" Sep 4 23:49:01.560287 containerd[2024]: time="2026-09-04T23:49:01.559443526Z" 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\"}" Sep 4 23:49:01.561443 containerd[2024]: time="2026-09-04T23:49:01.561384754Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269321" Sep 4 23:49:01.562903 containerd[2024]: time="2026-09-04T23:49:01.562789450Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Sep 4 23:49:01.565547 containerd[2024]: time="2026-09-04T23:49:01.564887182Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:49:01.571478 containerd[2024]: time="2026-09-04T23:49:01.570830050Z" 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\"}" Sep 4 23:49:01.573842 containerd[2024]: time="2026-09-04T23:49:01.572653522Z" 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 772.024167ms" Sep 4 23:49:01.577919 containerd[2024]: time="2026-09-04T23:49:01.577719610Z" 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 791.502147ms" Sep 4 23:49:01.746172 containerd[2024]: time="2026-09-04T23:49:01.745921403Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:01.746172 containerd[2024]: time="2026-09-04T23:49:01.746028383Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:01.746759 containerd[2024]: time="2026-09-04T23:49:01.746070887Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:01.746954 containerd[2024]: time="2026-09-04T23:49:01.746438435Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:01.750607 containerd[2024]: time="2026-09-04T23:49:01.750125087Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:01.750607 containerd[2024]: time="2026-09-04T23:49:01.750218507Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:01.750607 containerd[2024]: time="2026-09-04T23:49:01.750276563Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:01.750607 containerd[2024]: time="2026-09-04T23:49:01.750433355Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:01.901898 systemd[1]: Started cri-containerd-781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69.scope - libcontainer container 781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69. Sep 4 23:49:01.911791 systemd[1]: Started cri-containerd-7cf5c7196ca28f017c2cc21521a8bcb35e6b24e8f74c81645759cf85ce1079a7.scope - libcontainer container 7cf5c7196ca28f017c2cc21521a8bcb35e6b24e8f74c81645759cf85ce1079a7. Sep 4 23:49:01.975862 containerd[2024]: time="2026-09-04T23:49:01.975697548Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-njg44,Uid:b11d7662-59e9-41cc-ad85-db878e6ebff0,Namespace:kube-system,Attempt:0,} returns sandbox id \"7cf5c7196ca28f017c2cc21521a8bcb35e6b24e8f74c81645759cf85ce1079a7\"" Sep 4 23:49:01.988092 containerd[2024]: time="2026-09-04T23:49:01.987975109Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.11\"" Sep 4 23:49:01.994084 containerd[2024]: time="2026-09-04T23:49:01.993740029Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-928qr,Uid:bde9cd77-111e-4b91-b4a3-dfbe764c8dfc,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\"" Sep 4 23:49:02.436657 kubelet[2433]: E0904 23:49:02.436575 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:03.437571 kubelet[2433]: E0904 23:49:03.437465 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:03.527232 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4020946356.mount: Deactivated successfully. Sep 4 23:49:03.955842 containerd[2024]: time="2026-09-04T23:49:03.954433274Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:03.956598 containerd[2024]: time="2026-09-04T23:49:03.956552090Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.11: active requests=0, bytes read=23993951" Sep 4 23:49:03.958887 containerd[2024]: time="2026-09-04T23:49:03.958836854Z" level=info msg="ImageCreate event name:\"sha256:aa7699b2285ddb2a2ed8eab368c5e27602e3da4460b8288fb59e371bf126444a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:03.964224 containerd[2024]: time="2026-09-04T23:49:03.964169378Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:ab8219b43a5ddbafad58bf901509c29994e79fcd7e3b6c47f67f0af790328d89\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:03.965553 containerd[2024]: time="2026-09-04T23:49:03.965478554Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.11\" with image id \"sha256:aa7699b2285ddb2a2ed8eab368c5e27602e3da4460b8288fb59e371bf126444a\", repo tag \"registry.k8s.io/kube-proxy:v1.34.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:ab8219b43a5ddbafad58bf901509c29994e79fcd7e3b6c47f67f0af790328d89\", size \"23992785\" in 1.977442773s" Sep 4 23:49:03.965712 containerd[2024]: time="2026-09-04T23:49:03.965682134Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.11\" returns image reference \"sha256:aa7699b2285ddb2a2ed8eab368c5e27602e3da4460b8288fb59e371bf126444a\"" Sep 4 23:49:03.968582 containerd[2024]: time="2026-09-04T23:49:03.968487158Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Sep 4 23:49:03.974965 containerd[2024]: time="2026-09-04T23:49:03.974909570Z" level=info msg="CreateContainer within sandbox \"7cf5c7196ca28f017c2cc21521a8bcb35e6b24e8f74c81645759cf85ce1079a7\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Sep 4 23:49:04.015014 containerd[2024]: time="2026-09-04T23:49:04.014834291Z" level=info msg="CreateContainer within sandbox \"7cf5c7196ca28f017c2cc21521a8bcb35e6b24e8f74c81645759cf85ce1079a7\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"e548559354b0e7f91d4a3c18d4cac028732ebdb6ddf0e558ccb40bdcf9746300\"" Sep 4 23:49:04.017012 containerd[2024]: time="2026-09-04T23:49:04.016951943Z" level=info msg="StartContainer for \"e548559354b0e7f91d4a3c18d4cac028732ebdb6ddf0e558ccb40bdcf9746300\"" Sep 4 23:49:04.069893 systemd[1]: Started cri-containerd-e548559354b0e7f91d4a3c18d4cac028732ebdb6ddf0e558ccb40bdcf9746300.scope - libcontainer container e548559354b0e7f91d4a3c18d4cac028732ebdb6ddf0e558ccb40bdcf9746300. Sep 4 23:49:04.126390 containerd[2024]: time="2026-09-04T23:49:04.126187835Z" level=info msg="StartContainer for \"e548559354b0e7f91d4a3c18d4cac028732ebdb6ddf0e558ccb40bdcf9746300\" returns successfully" Sep 4 23:49:04.438750 kubelet[2433]: E0904 23:49:04.438664 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:04.627539 kubelet[2433]: I0904 23:49:04.627426 2433 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-njg44" podStartSLOduration=4.645774961 podStartE2EDuration="6.627406598s" podCreationTimestamp="2026-09-04 23:48:58 +0000 UTC" firstStartedPulling="2026-09-04 23:49:01.985770325 +0000 UTC m=+4.980478142" lastFinishedPulling="2026-09-04 23:49:03.967401842 +0000 UTC m=+6.962109779" observedRunningTime="2026-09-04 23:49:04.625726958 +0000 UTC m=+7.620434859" watchObservedRunningTime="2026-09-04 23:49:04.627406598 +0000 UTC m=+7.622114403" Sep 4 23:49:05.388121 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2270936814.mount: Deactivated successfully. Sep 4 23:49:05.439411 kubelet[2433]: E0904 23:49:05.439318 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:05.464228 containerd[2024]: time="2026-09-04T23:49:05.464157998Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:05.466615 containerd[2024]: time="2026-09-04T23:49:05.466487606Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Sep 4 23:49:05.469243 containerd[2024]: time="2026-09-04T23:49:05.468750026Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:05.476209 containerd[2024]: time="2026-09-04T23:49:05.475237838Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:05.477800 containerd[2024]: time="2026-09-04T23:49:05.477738170Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"5125394\" in 1.509153044s" Sep 4 23:49:05.477884 containerd[2024]: time="2026-09-04T23:49:05.477799250Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Sep 4 23:49:05.486014 containerd[2024]: time="2026-09-04T23:49:05.485961338Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Sep 4 23:49:05.517251 containerd[2024]: time="2026-09-04T23:49:05.517185902Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df\"" Sep 4 23:49:05.518211 containerd[2024]: time="2026-09-04T23:49:05.518150030Z" level=info msg="StartContainer for \"945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df\"" Sep 4 23:49:05.560829 systemd[1]: Started cri-containerd-945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df.scope - libcontainer container 945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df. Sep 4 23:49:05.609977 containerd[2024]: time="2026-09-04T23:49:05.609923019Z" level=info msg="StartContainer for \"945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df\" returns successfully" Sep 4 23:49:05.613969 systemd[1]: cri-containerd-945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df.scope: Deactivated successfully. Sep 4 23:49:05.821913 containerd[2024]: time="2026-09-04T23:49:05.821631820Z" level=info msg="shim disconnected" id=945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df namespace=k8s.io Sep 4 23:49:05.821913 containerd[2024]: time="2026-09-04T23:49:05.821701168Z" level=warning msg="cleaning up after shim disconnected" id=945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df namespace=k8s.io Sep 4 23:49:05.821913 containerd[2024]: time="2026-09-04T23:49:05.821722024Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:49:06.213353 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-945d02e57dbecf5f2359abea7da71248f63863415cb09feacd4c1aaef7c8b8df-rootfs.mount: Deactivated successfully. Sep 4 23:49:06.441234 kubelet[2433]: E0904 23:49:06.441162 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:06.628273 containerd[2024]: time="2026-09-04T23:49:06.628216468Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Sep 4 23:49:07.442373 kubelet[2433]: E0904 23:49:07.442310 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:08.443219 kubelet[2433]: E0904 23:49:08.443128 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:09.096115 containerd[2024]: time="2026-09-04T23:49:09.096058276Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:09.099717 containerd[2024]: time="2026-09-04T23:49:09.099654544Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Sep 4 23:49:09.101853 containerd[2024]: time="2026-09-04T23:49:09.101779348Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:09.109472 containerd[2024]: time="2026-09-04T23:49:09.109376500Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:09.112818 containerd[2024]: time="2026-09-04T23:49:09.112581148Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32412118\" in 2.484297336s" Sep 4 23:49:09.112818 containerd[2024]: time="2026-09-04T23:49:09.112642276Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Sep 4 23:49:09.122423 containerd[2024]: time="2026-09-04T23:49:09.122138164Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Sep 4 23:49:09.151049 containerd[2024]: time="2026-09-04T23:49:09.150820948Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6\"" Sep 4 23:49:09.152112 containerd[2024]: time="2026-09-04T23:49:09.152057776Z" level=info msg="StartContainer for \"6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6\"" Sep 4 23:49:09.202845 systemd[1]: Started cri-containerd-6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6.scope - libcontainer container 6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6. Sep 4 23:49:09.250698 systemd[1]: cri-containerd-6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6.scope: Deactivated successfully. Sep 4 23:49:09.253148 kubelet[2433]: I0904 23:49:09.252354 2433 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Sep 4 23:49:09.253300 containerd[2024]: time="2026-09-04T23:49:09.253004177Z" level=info msg="StartContainer for \"6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6\" returns successfully" Sep 4 23:49:09.286660 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6-rootfs.mount: Deactivated successfully. Sep 4 23:49:09.397322 containerd[2024]: time="2026-09-04T23:49:09.396909917Z" level=info msg="shim disconnected" id=6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6 namespace=k8s.io Sep 4 23:49:09.397322 containerd[2024]: time="2026-09-04T23:49:09.396979025Z" level=warning msg="cleaning up after shim disconnected" id=6368a349a4c330a6ea5b3ed1c2b77a7ff3321909cd69213103c7abbe712f29b6 namespace=k8s.io Sep 4 23:49:09.397322 containerd[2024]: time="2026-09-04T23:49:09.396998741Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:49:09.444102 kubelet[2433]: E0904 23:49:09.444019 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:09.644853 containerd[2024]: time="2026-09-04T23:49:09.644789275Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Sep 4 23:49:09.667475 containerd[2024]: time="2026-09-04T23:49:09.667255663Z" level=info msg="CreateContainer within sandbox \"781db4cb376fa026451e3868c4ac8e1400c414697040367e82363c23eaaa5c69\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"68c1a5d1e977c0e279304471d136f1d78fb6ba90d9338cbac7fcf143127c9248\"" Sep 4 23:49:09.668468 containerd[2024]: time="2026-09-04T23:49:09.668413651Z" level=info msg="StartContainer for \"68c1a5d1e977c0e279304471d136f1d78fb6ba90d9338cbac7fcf143127c9248\"" Sep 4 23:49:09.710176 systemd[1]: Started cri-containerd-68c1a5d1e977c0e279304471d136f1d78fb6ba90d9338cbac7fcf143127c9248.scope - libcontainer container 68c1a5d1e977c0e279304471d136f1d78fb6ba90d9338cbac7fcf143127c9248. Sep 4 23:49:09.754682 containerd[2024]: time="2026-09-04T23:49:09.754528807Z" level=info msg="StartContainer for \"68c1a5d1e977c0e279304471d136f1d78fb6ba90d9338cbac7fcf143127c9248\" returns successfully" Sep 4 23:49:10.444410 kubelet[2433]: E0904 23:49:10.444345 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:10.861170 (udev-worker)[2941]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:10.881703 systemd-networkd[1943]: flannel.1: Link UP Sep 4 23:49:10.881724 systemd-networkd[1943]: flannel.1: Gained carrier Sep 4 23:49:11.445335 kubelet[2433]: E0904 23:49:11.445281 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:12.446490 kubelet[2433]: E0904 23:49:12.446432 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:12.650703 systemd-networkd[1943]: flannel.1: Gained IPv6LL Sep 4 23:49:13.339111 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 4 23:49:13.447589 kubelet[2433]: E0904 23:49:13.447537 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:14.448109 kubelet[2433]: E0904 23:49:14.448044 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:14.700979 ntpd[1997]: Listen normally on 7 flannel.1 192.168.1.0:123 Sep 4 23:49:14.701803 ntpd[1997]: 4 Sep 23:49:14 ntpd[1997]: Listen normally on 7 flannel.1 192.168.1.0:123 Sep 4 23:49:14.701803 ntpd[1997]: 4 Sep 23:49:14 ntpd[1997]: Listen normally on 8 flannel.1 [fe80::d894:b5ff:fe73:8bb2%3]:123 Sep 4 23:49:14.701098 ntpd[1997]: Listen normally on 8 flannel.1 [fe80::d894:b5ff:fe73:8bb2%3]:123 Sep 4 23:49:15.449188 kubelet[2433]: E0904 23:49:15.449121 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:16.450199 kubelet[2433]: E0904 23:49:16.450132 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:16.456847 kubelet[2433]: I0904 23:49:16.456765 2433 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-928qr" podStartSLOduration=11.340295333 podStartE2EDuration="18.456746472s" podCreationTimestamp="2026-09-04 23:48:58 +0000 UTC" firstStartedPulling="2026-09-04 23:49:01.999453145 +0000 UTC m=+4.994160938" lastFinishedPulling="2026-09-04 23:49:09.115904272 +0000 UTC m=+12.110612077" observedRunningTime="2026-09-04 23:49:10.664041128 +0000 UTC m=+13.658748957" watchObservedRunningTime="2026-09-04 23:49:16.456746472 +0000 UTC m=+19.451454301" Sep 4 23:49:16.470701 systemd[1]: Created slice kubepods-besteffort-pod2d5849ec_fa9a_4bc1_893a_525f431a4351.slice - libcontainer container kubepods-besteffort-pod2d5849ec_fa9a_4bc1_893a_525f431a4351.slice. Sep 4 23:49:16.576460 kubelet[2433]: I0904 23:49:16.576398 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rzdjg\" (UniqueName: \"kubernetes.io/projected/2d5849ec-fa9a-4bc1-893a-525f431a4351-kube-api-access-rzdjg\") pod \"nginx-deployment-bb8f74bfb-9d86k\" (UID: \"2d5849ec-fa9a-4bc1-893a-525f431a4351\") " pod="default/nginx-deployment-bb8f74bfb-9d86k" Sep 4 23:49:16.778449 containerd[2024]: time="2026-09-04T23:49:16.777839282Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-9d86k,Uid:2d5849ec-fa9a-4bc1-893a-525f431a4351,Namespace:default,Attempt:0,}" Sep 4 23:49:16.823017 systemd-networkd[1943]: cni0: Link UP Sep 4 23:49:16.823039 systemd-networkd[1943]: cni0: Gained carrier Sep 4 23:49:16.827693 (udev-worker)[3035]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:16.829138 systemd-networkd[1943]: cni0: Lost carrier Sep 4 23:49:16.837325 systemd-networkd[1943]: vethe6d43401: Link UP Sep 4 23:49:16.839675 kernel: cni0: port 1(vethe6d43401) entered blocking state Sep 4 23:49:16.839798 kernel: cni0: port 1(vethe6d43401) entered disabled state Sep 4 23:49:16.842567 kernel: vethe6d43401: entered allmulticast mode Sep 4 23:49:16.842630 kernel: vethe6d43401: entered promiscuous mode Sep 4 23:49:16.847540 kernel: cni0: port 1(vethe6d43401) entered blocking state Sep 4 23:49:16.847631 kernel: cni0: port 1(vethe6d43401) entered forwarding state Sep 4 23:49:16.851564 kernel: cni0: port 1(vethe6d43401) entered disabled state Sep 4 23:49:16.853430 (udev-worker)[3038]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:16.866650 kernel: cni0: port 1(vethe6d43401) entered blocking state Sep 4 23:49:16.866754 kernel: cni0: port 1(vethe6d43401) entered forwarding state Sep 4 23:49:16.868216 systemd-networkd[1943]: vethe6d43401: Gained carrier Sep 4 23:49:16.869152 systemd-networkd[1943]: cni0: Gained carrier Sep 4 23:49:16.877321 containerd[2024]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000082950), "name":"cbr0", "type":"bridge"} Sep 4 23:49:16.877321 containerd[2024]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:16.915572 containerd[2024]: {"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="2026-09-04T23:49:16.915367263Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:16.916258 containerd[2024]: time="2026-09-04T23:49:16.915488091Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:16.916258 containerd[2024]: time="2026-09-04T23:49:16.915567171Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:16.916258 containerd[2024]: time="2026-09-04T23:49:16.915966123Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:16.957848 systemd[1]: Started cri-containerd-146232e4fe8875700b7e95f28202574a6e591c2a562ba42d67115d85159acc89.scope - libcontainer container 146232e4fe8875700b7e95f28202574a6e591c2a562ba42d67115d85159acc89. Sep 4 23:49:17.017392 containerd[2024]: time="2026-09-04T23:49:17.017334947Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-9d86k,Uid:2d5849ec-fa9a-4bc1-893a-525f431a4351,Namespace:default,Attempt:0,} returns sandbox id \"146232e4fe8875700b7e95f28202574a6e591c2a562ba42d67115d85159acc89\"" Sep 4 23:49:17.020074 containerd[2024]: time="2026-09-04T23:49:17.020031731Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 4 23:49:17.450992 kubelet[2433]: E0904 23:49:17.450928 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:18.025856 systemd-networkd[1943]: cni0: Gained IPv6LL Sep 4 23:49:18.218632 systemd-networkd[1943]: vethe6d43401: Gained IPv6LL Sep 4 23:49:18.431022 kubelet[2433]: E0904 23:49:18.430968 2433 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:18.451696 kubelet[2433]: E0904 23:49:18.451616 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:19.452074 kubelet[2433]: E0904 23:49:19.452018 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:19.971904 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4290448373.mount: Deactivated successfully. Sep 4 23:49:20.453770 kubelet[2433]: E0904 23:49:20.453727 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:20.701022 ntpd[1997]: Listen normally on 9 cni0 192.168.1.1:123 Sep 4 23:49:20.701168 ntpd[1997]: Listen normally on 10 cni0 [fe80::e081:30ff:fe86:8c7f%4]:123 Sep 4 23:49:20.702252 ntpd[1997]: 4 Sep 23:49:20 ntpd[1997]: Listen normally on 9 cni0 192.168.1.1:123 Sep 4 23:49:20.702252 ntpd[1997]: 4 Sep 23:49:20 ntpd[1997]: Listen normally on 10 cni0 [fe80::e081:30ff:fe86:8c7f%4]:123 Sep 4 23:49:20.702252 ntpd[1997]: 4 Sep 23:49:20 ntpd[1997]: Listen normally on 11 vethe6d43401 [fe80::94c0:23ff:feb5:98f5%5]:123 Sep 4 23:49:20.701253 ntpd[1997]: Listen normally on 11 vethe6d43401 [fe80::94c0:23ff:feb5:98f5%5]:123 Sep 4 23:49:21.332212 containerd[2024]: time="2026-09-04T23:49:21.331819385Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.334403 containerd[2024]: time="2026-09-04T23:49:21.334314185Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=62663441" Sep 4 23:49:21.336587 containerd[2024]: time="2026-09-04T23:49:21.336479393Z" level=info msg="ImageCreate event name:\"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.345061 containerd[2024]: time="2026-09-04T23:49:21.344969153Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.347213 containerd[2024]: time="2026-09-04T23:49:21.347030573Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"62663319\" in 4.32690097s" Sep 4 23:49:21.347213 containerd[2024]: time="2026-09-04T23:49:21.347086685Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\"" Sep 4 23:49:21.359169 containerd[2024]: time="2026-09-04T23:49:21.358795457Z" level=info msg="CreateContainer within sandbox \"146232e4fe8875700b7e95f28202574a6e591c2a562ba42d67115d85159acc89\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Sep 4 23:49:21.384988 containerd[2024]: time="2026-09-04T23:49:21.384915749Z" level=info msg="CreateContainer within sandbox \"146232e4fe8875700b7e95f28202574a6e591c2a562ba42d67115d85159acc89\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"1fd6b702db54cb5398a41f22fa27b55dd71c022bf9671ae199f37c65e1d5adce\"" Sep 4 23:49:21.387545 containerd[2024]: time="2026-09-04T23:49:21.386124401Z" level=info msg="StartContainer for \"1fd6b702db54cb5398a41f22fa27b55dd71c022bf9671ae199f37c65e1d5adce\"" Sep 4 23:49:21.438804 systemd[1]: Started cri-containerd-1fd6b702db54cb5398a41f22fa27b55dd71c022bf9671ae199f37c65e1d5adce.scope - libcontainer container 1fd6b702db54cb5398a41f22fa27b55dd71c022bf9671ae199f37c65e1d5adce. Sep 4 23:49:21.457914 kubelet[2433]: E0904 23:49:21.457827 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:21.489290 containerd[2024]: time="2026-09-04T23:49:21.488420717Z" level=info msg="StartContainer for \"1fd6b702db54cb5398a41f22fa27b55dd71c022bf9671ae199f37c65e1d5adce\" returns successfully" Sep 4 23:49:21.688461 kubelet[2433]: I0904 23:49:21.688266 2433 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-9d86k" podStartSLOduration=1.357460068 podStartE2EDuration="5.688248762s" podCreationTimestamp="2026-09-04 23:49:16 +0000 UTC" firstStartedPulling="2026-09-04 23:49:17.018781295 +0000 UTC m=+20.013489088" lastFinishedPulling="2026-09-04 23:49:21.349569977 +0000 UTC m=+24.344277782" observedRunningTime="2026-09-04 23:49:21.688212378 +0000 UTC m=+24.682920219" watchObservedRunningTime="2026-09-04 23:49:21.688248762 +0000 UTC m=+24.682956591" Sep 4 23:49:22.459054 kubelet[2433]: E0904 23:49:22.458987 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:23.460219 kubelet[2433]: E0904 23:49:23.460144 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:24.461050 kubelet[2433]: E0904 23:49:24.460993 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:25.461256 kubelet[2433]: E0904 23:49:25.461181 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:26.461828 kubelet[2433]: E0904 23:49:26.461761 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:27.462733 kubelet[2433]: E0904 23:49:27.462670 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:28.272604 update_engine[2004]: I20260904 23:49:28.272471 2004 update_attempter.cc:509] Updating boot flags... Sep 4 23:49:28.353633 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (3238) Sep 4 23:49:28.463890 kubelet[2433]: E0904 23:49:28.463703 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:28.619562 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (3240) Sep 4 23:49:28.893559 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (3240) Sep 4 23:49:29.464010 kubelet[2433]: E0904 23:49:29.463970 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:30.249550 systemd[1]: Created slice kubepods-besteffort-pod89c76627_7a56_4c66_96da_16b99d3159e4.slice - libcontainer container kubepods-besteffort-pod89c76627_7a56_4c66_96da_16b99d3159e4.slice. Sep 4 23:49:30.263314 kubelet[2433]: I0904 23:49:30.263272 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/89c76627-7a56-4c66-96da-16b99d3159e4-data\") pod \"nfs-server-provisioner-0\" (UID: \"89c76627-7a56-4c66-96da-16b99d3159e4\") " pod="default/nfs-server-provisioner-0" Sep 4 23:49:30.263581 kubelet[2433]: I0904 23:49:30.263550 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-c8lj5\" (UniqueName: \"kubernetes.io/projected/89c76627-7a56-4c66-96da-16b99d3159e4-kube-api-access-c8lj5\") pod \"nfs-server-provisioner-0\" (UID: \"89c76627-7a56-4c66-96da-16b99d3159e4\") " pod="default/nfs-server-provisioner-0" Sep 4 23:49:30.465730 kubelet[2433]: E0904 23:49:30.465670 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:30.560223 containerd[2024]: time="2026-09-04T23:49:30.560151122Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:89c76627-7a56-4c66-96da-16b99d3159e4,Namespace:default,Attempt:0,}" Sep 4 23:49:30.610457 (udev-worker)[3238]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:30.611819 systemd-networkd[1943]: veth2a7a747d: Link UP Sep 4 23:49:30.614116 kernel: cni0: port 2(veth2a7a747d) entered blocking state Sep 4 23:49:30.614240 kernel: cni0: port 2(veth2a7a747d) entered disabled state Sep 4 23:49:30.615456 kernel: veth2a7a747d: entered allmulticast mode Sep 4 23:49:30.616842 kernel: veth2a7a747d: entered promiscuous mode Sep 4 23:49:30.627038 kernel: cni0: port 2(veth2a7a747d) entered blocking state Sep 4 23:49:30.627112 kernel: cni0: port 2(veth2a7a747d) entered forwarding state Sep 4 23:49:30.627892 systemd-networkd[1943]: veth2a7a747d: Gained carrier Sep 4 23:49:30.636024 containerd[2024]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Sep 4 23:49:30.636024 containerd[2024]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:30.673243 containerd[2024]: {"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="2026-09-04T23:49:30.673073259Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:30.673754 containerd[2024]: time="2026-09-04T23:49:30.673172883Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:30.673754 containerd[2024]: time="2026-09-04T23:49:30.673324611Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:30.674660 containerd[2024]: time="2026-09-04T23:49:30.674531127Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:30.711816 systemd[1]: Started cri-containerd-8013974becfa3dd54af165245ea8df1d0602ff50e090be177a09e303bfbdfb48.scope - libcontainer container 8013974becfa3dd54af165245ea8df1d0602ff50e090be177a09e303bfbdfb48. Sep 4 23:49:30.773673 containerd[2024]: time="2026-09-04T23:49:30.773593348Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:89c76627-7a56-4c66-96da-16b99d3159e4,Namespace:default,Attempt:0,} returns sandbox id \"8013974becfa3dd54af165245ea8df1d0602ff50e090be177a09e303bfbdfb48\"" Sep 4 23:49:30.777047 containerd[2024]: time="2026-09-04T23:49:30.776922016Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Sep 4 23:49:31.466252 kubelet[2433]: E0904 23:49:31.466188 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:32.235048 systemd-networkd[1943]: veth2a7a747d: Gained IPv6LL Sep 4 23:49:32.467252 kubelet[2433]: E0904 23:49:32.467171 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:33.467623 kubelet[2433]: E0904 23:49:33.467577 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:33.533068 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2035139850.mount: Deactivated successfully. Sep 4 23:49:34.470711 kubelet[2433]: E0904 23:49:34.469864 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:34.701857 ntpd[1997]: Listen normally on 12 veth2a7a747d [fe80::d08f:bbff:fe2f:51d2%6]:123 Sep 4 23:49:34.702880 ntpd[1997]: 4 Sep 23:49:34 ntpd[1997]: Listen normally on 12 veth2a7a747d [fe80::d08f:bbff:fe2f:51d2%6]:123 Sep 4 23:49:35.470757 kubelet[2433]: E0904 23:49:35.470673 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:36.470916 kubelet[2433]: E0904 23:49:36.470861 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:36.987981 containerd[2024]: time="2026-09-04T23:49:36.987892270Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:36.990274 containerd[2024]: time="2026-09-04T23:49:36.990222706Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87374067" Sep 4 23:49:36.991839 containerd[2024]: time="2026-09-04T23:49:36.991761598Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:36.998778 containerd[2024]: time="2026-09-04T23:49:36.998709862Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:37.002257 containerd[2024]: time="2026-09-04T23:49:37.002075598Z" 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 6.225092526s" Sep 4 23:49:37.002257 containerd[2024]: time="2026-09-04T23:49:37.002132610Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Sep 4 23:49:37.008195 containerd[2024]: time="2026-09-04T23:49:37.007988334Z" level=info msg="CreateContainer within sandbox \"8013974becfa3dd54af165245ea8df1d0602ff50e090be177a09e303bfbdfb48\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Sep 4 23:49:37.029621 containerd[2024]: time="2026-09-04T23:49:37.029538967Z" level=info msg="CreateContainer within sandbox \"8013974becfa3dd54af165245ea8df1d0602ff50e090be177a09e303bfbdfb48\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"c7c321cba4c012f5340696b5148ce7da8a616c53899f10a75244bca34a4da28a\"" Sep 4 23:49:37.032012 containerd[2024]: time="2026-09-04T23:49:37.031708951Z" level=info msg="StartContainer for \"c7c321cba4c012f5340696b5148ce7da8a616c53899f10a75244bca34a4da28a\"" Sep 4 23:49:37.084812 systemd[1]: Started cri-containerd-c7c321cba4c012f5340696b5148ce7da8a616c53899f10a75244bca34a4da28a.scope - libcontainer container c7c321cba4c012f5340696b5148ce7da8a616c53899f10a75244bca34a4da28a. Sep 4 23:49:37.127832 containerd[2024]: time="2026-09-04T23:49:37.127764811Z" level=info msg="StartContainer for \"c7c321cba4c012f5340696b5148ce7da8a616c53899f10a75244bca34a4da28a\" returns successfully" Sep 4 23:49:37.471837 kubelet[2433]: E0904 23:49:37.471774 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:38.431167 kubelet[2433]: E0904 23:49:38.431112 2433 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:38.472152 kubelet[2433]: E0904 23:49:38.472090 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:39.472257 kubelet[2433]: E0904 23:49:39.472199 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:40.473058 kubelet[2433]: E0904 23:49:40.473001 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:41.473172 kubelet[2433]: E0904 23:49:41.473111 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:42.474481 kubelet[2433]: E0904 23:49:42.473385 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:42.520208 kubelet[2433]: I0904 23:49:42.520110 2433 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.292805924 podStartE2EDuration="12.520088378s" podCreationTimestamp="2026-09-04 23:49:30 +0000 UTC" firstStartedPulling="2026-09-04 23:49:30.776058028 +0000 UTC m=+33.770765833" lastFinishedPulling="2026-09-04 23:49:37.003340482 +0000 UTC m=+39.998048287" observedRunningTime="2026-09-04 23:49:37.751557454 +0000 UTC m=+40.746265295" watchObservedRunningTime="2026-09-04 23:49:42.520088378 +0000 UTC m=+45.514796183" Sep 4 23:49:42.532900 systemd[1]: Created slice kubepods-besteffort-podf6458906_f1b7_46c9_816e_87998587cc0d.slice - libcontainer container kubepods-besteffort-podf6458906_f1b7_46c9_816e_87998587cc0d.slice. Sep 4 23:49:42.641115 kubelet[2433]: I0904 23:49:42.641052 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5krqb\" (UniqueName: \"kubernetes.io/projected/f6458906-f1b7-46c9-816e-87998587cc0d-kube-api-access-5krqb\") pod \"test-pod-1\" (UID: \"f6458906-f1b7-46c9-816e-87998587cc0d\") " pod="default/test-pod-1" Sep 4 23:49:42.641242 kubelet[2433]: I0904 23:49:42.641121 2433 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-0843a877-899c-4863-b6be-4ef3a695bd1f\" (UniqueName: \"kubernetes.io/nfs/f6458906-f1b7-46c9-816e-87998587cc0d-pvc-0843a877-899c-4863-b6be-4ef3a695bd1f\") pod \"test-pod-1\" (UID: \"f6458906-f1b7-46c9-816e-87998587cc0d\") " pod="default/test-pod-1" Sep 4 23:49:42.783199 kernel: FS-Cache: Loaded Sep 4 23:49:42.826092 kernel: RPC: Registered named UNIX socket transport module. Sep 4 23:49:42.826223 kernel: RPC: Registered udp transport module. Sep 4 23:49:42.826282 kernel: RPC: Registered tcp transport module. Sep 4 23:49:42.827098 kernel: RPC: Registered tcp-with-tls transport module. Sep 4 23:49:42.828171 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 4 23:49:43.153445 kernel: NFS: Registering the id_resolver key type Sep 4 23:49:43.153593 kernel: Key type id_resolver registered Sep 4 23:49:43.153636 kernel: Key type id_legacy registered Sep 4 23:49:43.192239 nfsidmap[3753]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Sep 4 23:49:43.199018 nfsidmap[3754]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Sep 4 23:49:43.447051 containerd[2024]: time="2026-09-04T23:49:43.446065586Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:f6458906-f1b7-46c9-816e-87998587cc0d,Namespace:default,Attempt:0,}" Sep 4 23:49:43.475126 kubelet[2433]: E0904 23:49:43.474466 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:43.484780 (udev-worker)[3752]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:43.485808 systemd-networkd[1943]: vethffcf9bc0: Link UP Sep 4 23:49:43.489796 kernel: cni0: port 3(vethffcf9bc0) entered blocking state Sep 4 23:49:43.489890 kernel: cni0: port 3(vethffcf9bc0) entered disabled state Sep 4 23:49:43.489947 kernel: vethffcf9bc0: entered allmulticast mode Sep 4 23:49:43.491543 kernel: vethffcf9bc0: entered promiscuous mode Sep 4 23:49:43.508058 kernel: cni0: port 3(vethffcf9bc0) entered blocking state Sep 4 23:49:43.508918 kernel: cni0: port 3(vethffcf9bc0) entered forwarding state Sep 4 23:49:43.508299 systemd-networkd[1943]: vethffcf9bc0: Gained carrier Sep 4 23:49:43.512912 containerd[2024]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x40001047f0), "name":"cbr0", "type":"bridge"} Sep 4 23:49:43.512912 containerd[2024]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:43.546378 containerd[2024]: {"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="2026-09-04T23:49:43.545841279Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:43.546756 containerd[2024]: time="2026-09-04T23:49:43.546679467Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:43.547086 containerd[2024]: time="2026-09-04T23:49:43.546932787Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:43.548575 containerd[2024]: time="2026-09-04T23:49:43.548458611Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:43.577895 systemd[1]: Started cri-containerd-334eeabf22a3e757770b825ca261ab4895a2aa2942b2a355b0448eb2453d237b.scope - libcontainer container 334eeabf22a3e757770b825ca261ab4895a2aa2942b2a355b0448eb2453d237b. Sep 4 23:49:43.638497 containerd[2024]: time="2026-09-04T23:49:43.638344767Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:f6458906-f1b7-46c9-816e-87998587cc0d,Namespace:default,Attempt:0,} returns sandbox id \"334eeabf22a3e757770b825ca261ab4895a2aa2942b2a355b0448eb2453d237b\"" Sep 4 23:49:43.640952 containerd[2024]: time="2026-09-04T23:49:43.640571331Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 4 23:49:43.984929 containerd[2024]: time="2026-09-04T23:49:43.984864197Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:43.986042 containerd[2024]: time="2026-09-04T23:49:43.985953221Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Sep 4 23:49:43.992471 containerd[2024]: time="2026-09-04T23:49:43.992267285Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"62663319\" in 351.638522ms" Sep 4 23:49:43.992471 containerd[2024]: time="2026-09-04T23:49:43.992325713Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\"" Sep 4 23:49:43.998114 containerd[2024]: time="2026-09-04T23:49:43.998058677Z" level=info msg="CreateContainer within sandbox \"334eeabf22a3e757770b825ca261ab4895a2aa2942b2a355b0448eb2453d237b\" for container &ContainerMetadata{Name:test,Attempt:0,}" Sep 4 23:49:44.022522 containerd[2024]: time="2026-09-04T23:49:44.022439941Z" level=info msg="CreateContainer within sandbox \"334eeabf22a3e757770b825ca261ab4895a2aa2942b2a355b0448eb2453d237b\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"3334da41264fec6146ec82edcfc63d19c8b172a5a902cc6684e99d80b31fa2a4\"" Sep 4 23:49:44.023377 containerd[2024]: time="2026-09-04T23:49:44.023282233Z" level=info msg="StartContainer for \"3334da41264fec6146ec82edcfc63d19c8b172a5a902cc6684e99d80b31fa2a4\"" Sep 4 23:49:44.076817 systemd[1]: Started cri-containerd-3334da41264fec6146ec82edcfc63d19c8b172a5a902cc6684e99d80b31fa2a4.scope - libcontainer container 3334da41264fec6146ec82edcfc63d19c8b172a5a902cc6684e99d80b31fa2a4. Sep 4 23:49:44.123545 containerd[2024]: time="2026-09-04T23:49:44.123454274Z" level=info msg="StartContainer for \"3334da41264fec6146ec82edcfc63d19c8b172a5a902cc6684e99d80b31fa2a4\" returns successfully" Sep 4 23:49:44.475205 kubelet[2433]: E0904 23:49:44.475138 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:45.097708 systemd-networkd[1943]: vethffcf9bc0: Gained IPv6LL Sep 4 23:49:45.476219 kubelet[2433]: E0904 23:49:45.476066 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:46.477145 kubelet[2433]: E0904 23:49:46.477081 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:47.477654 kubelet[2433]: E0904 23:49:47.477594 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:48.477827 kubelet[2433]: E0904 23:49:48.477759 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:48.701150 ntpd[1997]: Listen normally on 13 vethffcf9bc0 [fe80::2ca8:83ff:feac:4385%7]:123 Sep 4 23:49:48.702223 ntpd[1997]: 4 Sep 23:49:48 ntpd[1997]: Listen normally on 13 vethffcf9bc0 [fe80::2ca8:83ff:feac:4385%7]:123 Sep 4 23:49:49.478285 kubelet[2433]: E0904 23:49:49.478213 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:50.479236 kubelet[2433]: E0904 23:49:50.479160 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:51.480380 kubelet[2433]: E0904 23:49:51.480316 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:52.481276 kubelet[2433]: E0904 23:49:52.481212 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:53.481737 kubelet[2433]: E0904 23:49:53.481676 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:54.482312 kubelet[2433]: E0904 23:49:54.482250 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:55.483451 kubelet[2433]: E0904 23:49:55.483385 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:56.483601 kubelet[2433]: E0904 23:49:56.483531 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:57.483775 kubelet[2433]: E0904 23:49:57.483709 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:58.431899 kubelet[2433]: E0904 23:49:58.431823 2433 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:58.484396 kubelet[2433]: E0904 23:49:58.484102 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:59.485316 kubelet[2433]: E0904 23:49:59.485252 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:00.486213 kubelet[2433]: E0904 23:50:00.486158 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:01.486350 kubelet[2433]: E0904 23:50:01.486281 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:02.486955 kubelet[2433]: E0904 23:50:02.486890 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:03.487243 kubelet[2433]: E0904 23:50:03.487179 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:04.488127 kubelet[2433]: E0904 23:50:04.488064 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:05.488586 kubelet[2433]: E0904 23:50:05.488500 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:06.488856 kubelet[2433]: E0904 23:50:06.488793 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:07.489595 kubelet[2433]: E0904 23:50:07.489531 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:08.490681 kubelet[2433]: E0904 23:50:08.490608 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:09.491653 kubelet[2433]: E0904 23:50:09.491537 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:09.733203 kubelet[2433]: E0904 23:50:09.732900 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="failed to patch status \"{\\\"status\\\":{\\\"$setElementOrder/conditions\\\":[{\\\"type\\\":\\\"NetworkUnavailable\\\"},{\\\"type\\\":\\\"MemoryPressure\\\"},{\\\"type\\\":\\\"DiskPressure\\\"},{\\\"type\\\":\\\"PIDPressure\\\"},{\\\"type\\\":\\\"Ready\\\"}],\\\"conditions\\\":[{\\\"lastHeartbeatTime\\\":\\\"2026-09-04T23:49:59Z\\\",\\\"type\\\":\\\"MemoryPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-09-04T23:49:59Z\\\",\\\"type\\\":\\\"DiskPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-09-04T23:49:59Z\\\",\\\"type\\\":\\\"PIDPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-09-04T23:49:59Z\\\",\\\"type\\\":\\\"Ready\\\"}],\\\"images\\\":[{\\\"names\\\":[\\\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\\\",\\\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\\\"],\\\"sizeBytes\\\":87371201},{\\\"names\\\":[\\\"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\\\",\\\"ghcr.io/flatcar/nginx:latest\\\"],\\\"sizeBytes\\\":62663319},{\\\"names\\\":[\\\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\\\",\\\"ghcr.io/flannel-io/flannel:v0.26.7\\\"],\\\"sizeBytes\\\":32412118},{\\\"names\\\":[\\\"registry.k8s.io/kube-proxy@sha256:ab8219b43a5ddbafad58bf901509c29994e79fcd7e3b6c47f67f0af790328d89\\\",\\\"registry.k8s.io/kube-proxy:v1.34.11\\\"],\\\"sizeBytes\\\":23992785},{\\\"names\\\":[\\\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\\\",\\\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\\\"],\\\"sizeBytes\\\":5125394},{\\\"names\\\":[\\\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\\\",\\\"registry.k8s.io/pause:3.8\\\"],\\\"sizeBytes\\\":268403}]}}\" for node \"172.31.16.224\": the server was unable to return a response in the time allotted, but may still be processing the request (patch nodes 172.31.16.224)" Sep 4 23:50:10.492234 kubelet[2433]: E0904 23:50:10.492159 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:10.499777 kubelet[2433]: E0904 23:50:10.499738 2433 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.16.224)" Sep 4 23:50:11.492768 kubelet[2433]: E0904 23:50:11.492697 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:12.493596 kubelet[2433]: E0904 23:50:12.493534 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:13.494358 kubelet[2433]: E0904 23:50:13.494291 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:14.494961 kubelet[2433]: E0904 23:50:14.494897 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:15.495168 kubelet[2433]: E0904 23:50:15.495103 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:16.496037 kubelet[2433]: E0904 23:50:16.495969 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:17.497086 kubelet[2433]: E0904 23:50:17.497036 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:18.431813 kubelet[2433]: E0904 23:50:18.431754 2433 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:18.497847 kubelet[2433]: E0904 23:50:18.497787 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:19.498747 kubelet[2433]: E0904 23:50:19.498673 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:19.729541 kubelet[2433]: E0904 23:50:19.729356 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.16.224\": the server was unable to return a response in the time allotted, but may still be processing the request (get nodes 172.31.16.224)" Sep 4 23:50:20.498479 kubelet[2433]: E0904 23:50:20.498125 2433 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.16.224)" Sep 4 23:50:20.499245 kubelet[2433]: E0904 23:50:20.499180 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:21.499751 kubelet[2433]: E0904 23:50:21.499688 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:22.500702 kubelet[2433]: E0904 23:50:22.500642 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:23.501496 kubelet[2433]: E0904 23:50:23.501429 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:24.501785 kubelet[2433]: E0904 23:50:24.501723 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:25.502903 kubelet[2433]: E0904 23:50:25.502844 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:26.503965 kubelet[2433]: E0904 23:50:26.503896 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:27.504660 kubelet[2433]: E0904 23:50:27.504601 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:28.505098 kubelet[2433]: E0904 23:50:28.505051 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:29.505662 kubelet[2433]: E0904 23:50:29.505596 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:29.730260 kubelet[2433]: E0904 23:50:29.730070 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.16.224\": Get \"https://172.31.28.149:6443/api/v1/nodes/172.31.16.224?timeout=10s\": context deadline exceeded" Sep 4 23:50:29.750542 kubelet[2433]: E0904 23:50:29.746992 2433 controller.go:195] "Failed to update lease" err="Put \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": read tcp 172.31.16.224:57238->172.31.28.149:6443: read: connection reset by peer" Sep 4 23:50:29.756220 kubelet[2433]: E0904 23:50:29.756070 2433 controller.go:195] "Failed to update lease" err="Put \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": write tcp 172.31.16.224:49582->172.31.28.149:6443: write: connection reset by peer" Sep 4 23:50:29.757178 kubelet[2433]: E0904 23:50:29.756689 2433 controller.go:195] "Failed to update lease" err="Put \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused" Sep 4 23:50:29.757178 kubelet[2433]: I0904 23:50:29.756746 2433 controller.go:115] "failed to update lease using latest lease, fallback to ensure lease" err="failed 5 attempts to update lease" Sep 4 23:50:29.757566 kubelet[2433]: E0904 23:50:29.757410 2433 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused" interval="200ms" Sep 4 23:50:29.958969 kubelet[2433]: E0904 23:50:29.958917 2433 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused" interval="400ms" Sep 4 23:50:30.360368 kubelet[2433]: E0904 23:50:30.360305 2433 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused" interval="800ms" Sep 4 23:50:30.505817 kubelet[2433]: E0904 23:50:30.505761 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:30.751398 kubelet[2433]: E0904 23:50:30.751247 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.16.224\": Get \"https://172.31.28.149:6443/api/v1/nodes/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused - error from a previous attempt: read tcp 172.31.16.224:57238->172.31.28.149:6443: read: connection reset by peer" Sep 4 23:50:30.751897 kubelet[2433]: E0904 23:50:30.751807 2433 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.16.224\": Get \"https://172.31.28.149:6443/api/v1/nodes/172.31.16.224?timeout=10s\": dial tcp 172.31.28.149:6443: connect: connection refused" Sep 4 23:50:30.751897 kubelet[2433]: E0904 23:50:30.751847 2433 kubelet_node_status.go:473] "Unable to update node status" err="update node status exceeds retry count" Sep 4 23:50:31.506363 kubelet[2433]: E0904 23:50:31.506301 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:32.506944 kubelet[2433]: E0904 23:50:32.506881 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:33.507255 kubelet[2433]: E0904 23:50:33.507195 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:34.507778 kubelet[2433]: E0904 23:50:34.507715 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:35.508238 kubelet[2433]: E0904 23:50:35.508182 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:36.509907 kubelet[2433]: E0904 23:50:36.509840 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:37.510944 kubelet[2433]: E0904 23:50:37.510887 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:38.431642 kubelet[2433]: E0904 23:50:38.431590 2433 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:38.511838 kubelet[2433]: E0904 23:50:38.511782 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:39.512178 kubelet[2433]: E0904 23:50:39.512105 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:40.512640 kubelet[2433]: E0904 23:50:40.512579 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:41.162259 kubelet[2433]: E0904 23:50:41.162199 2433 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.28.149:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.16.224?timeout=10s\": context deadline exceeded" interval="1.6s" Sep 4 23:50:41.513737 kubelet[2433]: E0904 23:50:41.513578 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:42.514042 kubelet[2433]: E0904 23:50:42.513984 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:43.514203 kubelet[2433]: E0904 23:50:43.514137 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:44.514914 kubelet[2433]: E0904 23:50:44.514857 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:45.515719 kubelet[2433]: E0904 23:50:45.515659 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:46.516176 kubelet[2433]: E0904 23:50:46.516100 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:47.516463 kubelet[2433]: E0904 23:50:47.516398 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:48.516803 kubelet[2433]: E0904 23:50:48.516740 2433 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"