Nov 8 00:05:56.235687 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Nov 8 00:05:56.235739 kernel: Linux version 6.6.113-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 Nov 7 22:41:39 -00 2025 Nov 8 00:05:56.235765 kernel: KASLR disabled due to lack of seed Nov 8 00:05:56.235782 kernel: efi: EFI v2.7 by EDK II Nov 8 00:05:56.235799 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7affea98 MEMRESERVE=0x7852ee18 Nov 8 00:05:56.235815 kernel: ACPI: Early table checksum verification disabled Nov 8 00:05:56.235833 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Nov 8 00:05:56.235849 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Nov 8 00:05:56.235866 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Nov 8 00:05:56.235882 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Nov 8 00:05:56.235904 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Nov 8 00:05:56.235920 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Nov 8 00:05:56.235937 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Nov 8 00:05:56.235955 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Nov 8 00:05:56.235975 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Nov 8 00:05:56.235997 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Nov 8 00:05:56.236016 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Nov 8 00:05:56.236034 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Nov 8 00:05:56.236089 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Nov 8 00:05:56.236108 kernel: printk: bootconsole [uart0] enabled Nov 8 00:05:56.236144 kernel: NUMA: Failed to initialise from firmware Nov 8 00:05:56.236163 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Nov 8 00:05:56.236182 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Nov 8 00:05:56.236199 kernel: Zone ranges: Nov 8 00:05:56.236216 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Nov 8 00:05:56.236233 kernel: DMA32 empty Nov 8 00:05:56.236266 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Nov 8 00:05:56.236290 kernel: Movable zone start for each node Nov 8 00:05:56.236308 kernel: Early memory node ranges Nov 8 00:05:56.236325 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Nov 8 00:05:56.236343 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Nov 8 00:05:56.236361 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Nov 8 00:05:56.236379 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Nov 8 00:05:56.236396 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Nov 8 00:05:56.236414 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Nov 8 00:05:56.236431 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Nov 8 00:05:56.236447 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Nov 8 00:05:56.236464 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Nov 8 00:05:56.236488 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Nov 8 00:05:56.236506 kernel: psci: probing for conduit method from ACPI. Nov 8 00:05:56.236530 kernel: psci: PSCIv1.0 detected in firmware. Nov 8 00:05:56.236548 kernel: psci: Using standard PSCI v0.2 function IDs Nov 8 00:05:56.236566 kernel: psci: Trusted OS migration not required Nov 8 00:05:56.236589 kernel: psci: SMC Calling Convention v1.1 Nov 8 00:05:56.236607 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Nov 8 00:05:56.236625 kernel: percpu: Embedded 31 pages/cpu s86120 r8192 d32664 u126976 Nov 8 00:05:56.236643 kernel: pcpu-alloc: s86120 r8192 d32664 u126976 alloc=31*4096 Nov 8 00:05:56.236661 kernel: pcpu-alloc: [0] 0 [0] 1 Nov 8 00:05:56.236679 kernel: Detected PIPT I-cache on CPU0 Nov 8 00:05:56.236697 kernel: CPU features: detected: GIC system register CPU interface Nov 8 00:05:56.236715 kernel: CPU features: detected: Spectre-v2 Nov 8 00:05:56.236732 kernel: CPU features: detected: Spectre-v3a Nov 8 00:05:56.236764 kernel: CPU features: detected: Spectre-BHB Nov 8 00:05:56.236783 kernel: CPU features: detected: ARM erratum 1742098 Nov 8 00:05:56.236807 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Nov 8 00:05:56.236825 kernel: alternatives: applying boot alternatives Nov 8 00:05:56.236845 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=653fdcb8a67e255793a721f32d76976d3ed6223b235b7c618cf75e5edffbdb68 Nov 8 00:05:56.236864 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 8 00:05:56.236882 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 8 00:05:56.236899 kernel: Fallback order for Node 0: 0 Nov 8 00:05:56.236917 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Nov 8 00:05:56.236935 kernel: Policy zone: Normal Nov 8 00:05:56.236953 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 8 00:05:56.236970 kernel: software IO TLB: area num 2. Nov 8 00:05:56.236988 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Nov 8 00:05:56.237012 kernel: Memory: 3820088K/4030464K available (10304K kernel code, 2180K rwdata, 8112K rodata, 39424K init, 897K bss, 210376K reserved, 0K cma-reserved) Nov 8 00:05:56.237030 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 8 00:05:56.237088 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 8 00:05:56.237111 kernel: rcu: RCU event tracing is enabled. Nov 8 00:05:56.237130 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 8 00:05:56.237148 kernel: Trampoline variant of Tasks RCU enabled. Nov 8 00:05:56.237166 kernel: Tracing variant of Tasks RCU enabled. Nov 8 00:05:56.237184 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 8 00:05:56.237201 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 8 00:05:56.237219 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 8 00:05:56.237236 kernel: GICv3: 96 SPIs implemented Nov 8 00:05:56.237261 kernel: GICv3: 0 Extended SPIs implemented Nov 8 00:05:56.237279 kernel: Root IRQ handler: gic_handle_irq Nov 8 00:05:56.237297 kernel: GICv3: GICv3 features: 16 PPIs Nov 8 00:05:56.237314 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Nov 8 00:05:56.237332 kernel: ITS [mem 0x10080000-0x1009ffff] Nov 8 00:05:56.237350 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Nov 8 00:05:56.237368 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Nov 8 00:05:56.237397 kernel: GICv3: using LPI property table @0x00000004000d0000 Nov 8 00:05:56.237419 kernel: ITS: Using hypervisor restricted LPI range [128] Nov 8 00:05:56.237437 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Nov 8 00:05:56.237454 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Nov 8 00:05:56.237472 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Nov 8 00:05:56.237496 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Nov 8 00:05:56.237514 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Nov 8 00:05:56.237532 kernel: Console: colour dummy device 80x25 Nov 8 00:05:56.237550 kernel: printk: console [tty1] enabled Nov 8 00:05:56.237568 kernel: ACPI: Core revision 20230628 Nov 8 00:05:56.237586 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Nov 8 00:05:56.237623 kernel: pid_max: default: 32768 minimum: 301 Nov 8 00:05:56.237644 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Nov 8 00:05:56.237662 kernel: landlock: Up and running. Nov 8 00:05:56.237685 kernel: SELinux: Initializing. Nov 8 00:05:56.237704 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 8 00:05:56.237722 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 8 00:05:56.237740 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 8 00:05:56.237758 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Nov 8 00:05:56.237776 kernel: rcu: Hierarchical SRCU implementation. Nov 8 00:05:56.237794 kernel: rcu: Max phase no-delay instances is 400. Nov 8 00:05:56.237812 kernel: Platform MSI: ITS@0x10080000 domain created Nov 8 00:05:56.237831 kernel: PCI/MSI: ITS@0x10080000 domain created Nov 8 00:05:56.237853 kernel: Remapping and enabling EFI services. Nov 8 00:05:56.237871 kernel: smp: Bringing up secondary CPUs ... Nov 8 00:05:56.237889 kernel: Detected PIPT I-cache on CPU1 Nov 8 00:05:56.237907 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Nov 8 00:05:56.237925 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Nov 8 00:05:56.237944 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Nov 8 00:05:56.237962 kernel: smp: Brought up 1 node, 2 CPUs Nov 8 00:05:56.237980 kernel: SMP: Total of 2 processors activated. Nov 8 00:05:56.237998 kernel: CPU features: detected: 32-bit EL0 Support Nov 8 00:05:56.238020 kernel: CPU features: detected: 32-bit EL1 Support Nov 8 00:05:56.238038 kernel: CPU features: detected: CRC32 instructions Nov 8 00:05:56.238095 kernel: CPU: All CPU(s) started at EL1 Nov 8 00:05:56.238130 kernel: alternatives: applying system-wide alternatives Nov 8 00:05:56.238156 kernel: devtmpfs: initialized Nov 8 00:05:56.238177 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 8 00:05:56.238197 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 8 00:05:56.238216 kernel: pinctrl core: initialized pinctrl subsystem Nov 8 00:05:56.238236 kernel: SMBIOS 3.0.0 present. Nov 8 00:05:56.238262 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Nov 8 00:05:56.238282 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 8 00:05:56.238302 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 8 00:05:56.238321 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 8 00:05:56.238341 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 8 00:05:56.238360 kernel: audit: initializing netlink subsys (disabled) Nov 8 00:05:56.238379 kernel: audit: type=2000 audit(0.287:1): state=initialized audit_enabled=0 res=1 Nov 8 00:05:56.238398 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 8 00:05:56.238422 kernel: cpuidle: using governor menu Nov 8 00:05:56.238442 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 8 00:05:56.238461 kernel: ASID allocator initialised with 65536 entries Nov 8 00:05:56.238480 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 8 00:05:56.238498 kernel: Serial: AMBA PL011 UART driver Nov 8 00:05:56.238517 kernel: Modules: 17488 pages in range for non-PLT usage Nov 8 00:05:56.238536 kernel: Modules: 509008 pages in range for PLT usage Nov 8 00:05:56.238555 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Nov 8 00:05:56.238574 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Nov 8 00:05:56.238597 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Nov 8 00:05:56.238616 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Nov 8 00:05:56.238635 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Nov 8 00:05:56.238654 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Nov 8 00:05:56.238673 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Nov 8 00:05:56.238692 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Nov 8 00:05:56.238710 kernel: ACPI: Added _OSI(Module Device) Nov 8 00:05:56.238729 kernel: ACPI: Added _OSI(Processor Device) Nov 8 00:05:56.238748 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 8 00:05:56.238771 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 8 00:05:56.238790 kernel: ACPI: Interpreter enabled Nov 8 00:05:56.238809 kernel: ACPI: Using GIC for interrupt routing Nov 8 00:05:56.238828 kernel: ACPI: MCFG table detected, 1 entries Nov 8 00:05:56.238846 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Nov 8 00:05:56.239219 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 8 00:05:56.239447 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 8 00:05:56.239657 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 8 00:05:56.239973 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Nov 8 00:05:56.240286 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Nov 8 00:05:56.240317 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Nov 8 00:05:56.240337 kernel: acpiphp: Slot [1] registered Nov 8 00:05:56.240356 kernel: acpiphp: Slot [2] registered Nov 8 00:05:56.240375 kernel: acpiphp: Slot [3] registered Nov 8 00:05:56.240394 kernel: acpiphp: Slot [4] registered Nov 8 00:05:56.240413 kernel: acpiphp: Slot [5] registered Nov 8 00:05:56.240440 kernel: acpiphp: Slot [6] registered Nov 8 00:05:56.240459 kernel: acpiphp: Slot [7] registered Nov 8 00:05:56.240480 kernel: acpiphp: Slot [8] registered Nov 8 00:05:56.240499 kernel: acpiphp: Slot [9] registered Nov 8 00:05:56.240518 kernel: acpiphp: Slot [10] registered Nov 8 00:05:56.240537 kernel: acpiphp: Slot [11] registered Nov 8 00:05:56.240556 kernel: acpiphp: Slot [12] registered Nov 8 00:05:56.240574 kernel: acpiphp: Slot [13] registered Nov 8 00:05:56.240593 kernel: acpiphp: Slot [14] registered Nov 8 00:05:56.240612 kernel: acpiphp: Slot [15] registered Nov 8 00:05:56.240636 kernel: acpiphp: Slot [16] registered Nov 8 00:05:56.240655 kernel: acpiphp: Slot [17] registered Nov 8 00:05:56.240673 kernel: acpiphp: Slot [18] registered Nov 8 00:05:56.240692 kernel: acpiphp: Slot [19] registered Nov 8 00:05:56.240712 kernel: acpiphp: Slot [20] registered Nov 8 00:05:56.240731 kernel: acpiphp: Slot [21] registered Nov 8 00:05:56.240750 kernel: acpiphp: Slot [22] registered Nov 8 00:05:56.240769 kernel: acpiphp: Slot [23] registered Nov 8 00:05:56.240787 kernel: acpiphp: Slot [24] registered Nov 8 00:05:56.240810 kernel: acpiphp: Slot [25] registered Nov 8 00:05:56.240830 kernel: acpiphp: Slot [26] registered Nov 8 00:05:56.240848 kernel: acpiphp: Slot [27] registered Nov 8 00:05:56.240867 kernel: acpiphp: Slot [28] registered Nov 8 00:05:56.240885 kernel: acpiphp: Slot [29] registered Nov 8 00:05:56.240904 kernel: acpiphp: Slot [30] registered Nov 8 00:05:56.240923 kernel: acpiphp: Slot [31] registered Nov 8 00:05:56.240941 kernel: PCI host bridge to bus 0000:00 Nov 8 00:05:56.241244 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Nov 8 00:05:56.241470 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 8 00:05:56.241705 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Nov 8 00:05:56.241938 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Nov 8 00:05:56.242225 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Nov 8 00:05:56.242482 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Nov 8 00:05:56.243234 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Nov 8 00:05:56.243512 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Nov 8 00:05:56.243728 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Nov 8 00:05:56.243937 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 8 00:05:56.244191 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Nov 8 00:05:56.244405 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Nov 8 00:05:56.244672 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Nov 8 00:05:56.244947 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Nov 8 00:05:56.245222 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 8 00:05:56.245456 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Nov 8 00:05:56.245731 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Nov 8 00:05:56.245983 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Nov 8 00:05:56.246263 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Nov 8 00:05:56.246492 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Nov 8 00:05:56.246721 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Nov 8 00:05:56.246930 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 8 00:05:56.247174 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Nov 8 00:05:56.247202 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 8 00:05:56.247222 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 8 00:05:56.247241 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 8 00:05:56.247260 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 8 00:05:56.247279 kernel: iommu: Default domain type: Translated Nov 8 00:05:56.247298 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 8 00:05:56.247317 kernel: efivars: Registered efivars operations Nov 8 00:05:56.247357 kernel: vgaarb: loaded Nov 8 00:05:56.247377 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 8 00:05:56.247396 kernel: VFS: Disk quotas dquot_6.6.0 Nov 8 00:05:56.247415 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 8 00:05:56.247434 kernel: pnp: PnP ACPI init Nov 8 00:05:56.247679 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Nov 8 00:05:56.247708 kernel: pnp: PnP ACPI: found 1 devices Nov 8 00:05:56.247727 kernel: NET: Registered PF_INET protocol family Nov 8 00:05:56.247753 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 8 00:05:56.247773 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 8 00:05:56.247792 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 8 00:05:56.247811 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 8 00:05:56.247830 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Nov 8 00:05:56.247850 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 8 00:05:56.247870 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 8 00:05:56.247954 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 8 00:05:56.247974 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 8 00:05:56.248000 kernel: PCI: CLS 0 bytes, default 64 Nov 8 00:05:56.248019 kernel: kvm [1]: HYP mode not available Nov 8 00:05:56.248038 kernel: Initialise system trusted keyrings Nov 8 00:05:56.248127 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 8 00:05:56.248146 kernel: Key type asymmetric registered Nov 8 00:05:56.248165 kernel: Asymmetric key parser 'x509' registered Nov 8 00:05:56.248184 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Nov 8 00:05:56.248204 kernel: io scheduler mq-deadline registered Nov 8 00:05:56.248222 kernel: io scheduler kyber registered Nov 8 00:05:56.248248 kernel: io scheduler bfq registered Nov 8 00:05:56.248506 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Nov 8 00:05:56.248537 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 8 00:05:56.248557 kernel: ACPI: button: Power Button [PWRB] Nov 8 00:05:56.248576 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Nov 8 00:05:56.248596 kernel: ACPI: button: Sleep Button [SLPB] Nov 8 00:05:56.248614 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 8 00:05:56.248634 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Nov 8 00:05:56.248851 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Nov 8 00:05:56.248878 kernel: printk: console [ttyS0] disabled Nov 8 00:05:56.248897 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Nov 8 00:05:56.248916 kernel: printk: console [ttyS0] enabled Nov 8 00:05:56.248935 kernel: printk: bootconsole [uart0] disabled Nov 8 00:05:56.248953 kernel: thunder_xcv, ver 1.0 Nov 8 00:05:56.248972 kernel: thunder_bgx, ver 1.0 Nov 8 00:05:56.248990 kernel: nicpf, ver 1.0 Nov 8 00:05:56.249008 kernel: nicvf, ver 1.0 Nov 8 00:05:56.249461 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 8 00:05:56.249705 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-08T00:05:55 UTC (1762560355) Nov 8 00:05:56.249733 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 8 00:05:56.249753 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Nov 8 00:05:56.249772 kernel: watchdog: Delayed init of the lockup detector failed: -19 Nov 8 00:05:56.249790 kernel: watchdog: Hard watchdog permanently disabled Nov 8 00:05:56.249809 kernel: NET: Registered PF_INET6 protocol family Nov 8 00:05:56.249828 kernel: Segment Routing with IPv6 Nov 8 00:05:56.249856 kernel: In-situ OAM (IOAM) with IPv6 Nov 8 00:05:56.249875 kernel: NET: Registered PF_PACKET protocol family Nov 8 00:05:56.249894 kernel: Key type dns_resolver registered Nov 8 00:05:56.249912 kernel: registered taskstats version 1 Nov 8 00:05:56.249931 kernel: Loading compiled-in X.509 certificates Nov 8 00:05:56.249950 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.113-flatcar: e35af6a719ba4c60f9d6788b11f5e5836ebf73b5' Nov 8 00:05:56.249969 kernel: Key type .fscrypt registered Nov 8 00:05:56.249987 kernel: Key type fscrypt-provisioning registered Nov 8 00:05:56.250006 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 8 00:05:56.250029 kernel: ima: Allocated hash algorithm: sha1 Nov 8 00:05:56.250073 kernel: ima: No architecture policies found Nov 8 00:05:56.250095 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 8 00:05:56.250114 kernel: clk: Disabling unused clocks Nov 8 00:05:56.250133 kernel: Freeing unused kernel memory: 39424K Nov 8 00:05:56.250152 kernel: Run /init as init process Nov 8 00:05:56.250170 kernel: with arguments: Nov 8 00:05:56.250189 kernel: /init Nov 8 00:05:56.250207 kernel: with environment: Nov 8 00:05:56.250225 kernel: HOME=/ Nov 8 00:05:56.250250 kernel: TERM=linux Nov 8 00:05:56.250273 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) Nov 8 00:05:56.250297 systemd[1]: Detected virtualization amazon. Nov 8 00:05:56.250318 systemd[1]: Detected architecture arm64. Nov 8 00:05:56.250338 systemd[1]: Running in initrd. Nov 8 00:05:56.250358 systemd[1]: No hostname configured, using default hostname. Nov 8 00:05:56.250378 systemd[1]: Hostname set to . Nov 8 00:05:56.250404 systemd[1]: Initializing machine ID from VM UUID. Nov 8 00:05:56.250424 systemd[1]: Queued start job for default target initrd.target. Nov 8 00:05:56.250445 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 8 00:05:56.250465 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 8 00:05:56.250487 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Nov 8 00:05:56.250508 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 8 00:05:56.250529 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Nov 8 00:05:56.250550 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Nov 8 00:05:56.250578 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Nov 8 00:05:56.250599 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Nov 8 00:05:56.250620 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 8 00:05:56.250640 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 8 00:05:56.250661 systemd[1]: Reached target paths.target - Path Units. Nov 8 00:05:56.250681 systemd[1]: Reached target slices.target - Slice Units. Nov 8 00:05:56.250702 systemd[1]: Reached target swap.target - Swaps. Nov 8 00:05:56.250727 systemd[1]: Reached target timers.target - Timer Units. Nov 8 00:05:56.250748 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Nov 8 00:05:56.250768 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 8 00:05:56.250789 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Nov 8 00:05:56.250809 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Nov 8 00:05:56.250830 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 8 00:05:56.250851 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 8 00:05:56.250871 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 8 00:05:56.250897 systemd[1]: Reached target sockets.target - Socket Units. Nov 8 00:05:56.250918 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Nov 8 00:05:56.250939 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 8 00:05:56.250959 systemd[1]: Finished network-cleanup.service - Network Cleanup. Nov 8 00:05:56.250980 systemd[1]: Starting systemd-fsck-usr.service... Nov 8 00:05:56.251001 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 8 00:05:56.251021 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 8 00:05:56.251067 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 8 00:05:56.251095 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Nov 8 00:05:56.251124 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 8 00:05:56.251145 systemd[1]: Finished systemd-fsck-usr.service. Nov 8 00:05:56.251168 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 8 00:05:56.251224 systemd-journald[251]: Collecting audit messages is disabled. Nov 8 00:05:56.251274 systemd-journald[251]: Journal started Nov 8 00:05:56.251311 systemd-journald[251]: Runtime Journal (/run/log/journal/ec297de833f7ab6037917324ac433940) is 8.0M, max 75.3M, 67.3M free. Nov 8 00:05:56.242991 systemd-modules-load[252]: Inserted module 'overlay' Nov 8 00:05:56.261870 systemd[1]: Started systemd-journald.service - Journal Service. Nov 8 00:05:56.273407 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 8 00:05:56.279602 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 8 00:05:56.290545 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 8 00:05:56.300465 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 8 00:05:56.302649 systemd-modules-load[252]: Inserted module 'br_netfilter' Nov 8 00:05:56.304902 kernel: Bridge firewalling registered Nov 8 00:05:56.308157 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 8 00:05:56.319350 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 8 00:05:56.330333 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 8 00:05:56.347840 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 8 00:05:56.358893 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 8 00:05:56.379419 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 8 00:05:56.386693 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 8 00:05:56.390782 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 8 00:05:56.410424 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Nov 8 00:05:56.416837 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 8 00:05:56.444484 dracut-cmdline[286]: dracut-dracut-053 Nov 8 00:05:56.453026 dracut-cmdline[286]: 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=653fdcb8a67e255793a721f32d76976d3ed6223b235b7c618cf75e5edffbdb68 Nov 8 00:05:56.511283 systemd-resolved[287]: Positive Trust Anchors: Nov 8 00:05:56.511320 systemd-resolved[287]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 8 00:05:56.511384 systemd-resolved[287]: 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 Nov 8 00:05:56.603084 kernel: SCSI subsystem initialized Nov 8 00:05:56.612079 kernel: Loading iSCSI transport class v2.0-870. Nov 8 00:05:56.624082 kernel: iscsi: registered transport (tcp) Nov 8 00:05:56.646714 kernel: iscsi: registered transport (qla4xxx) Nov 8 00:05:56.646801 kernel: QLogic iSCSI HBA Driver Nov 8 00:05:56.734087 kernel: random: crng init done Nov 8 00:05:56.734633 systemd-resolved[287]: Defaulting to hostname 'linux'. Nov 8 00:05:56.736853 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 8 00:05:56.742295 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 8 00:05:56.770133 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Nov 8 00:05:56.780463 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Nov 8 00:05:56.816102 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 8 00:05:56.816178 kernel: device-mapper: uevent: version 1.0.3 Nov 8 00:05:56.816205 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Nov 8 00:05:56.883095 kernel: raid6: neonx8 gen() 6632 MB/s Nov 8 00:05:56.900082 kernel: raid6: neonx4 gen() 6483 MB/s Nov 8 00:05:56.917079 kernel: raid6: neonx2 gen() 5419 MB/s Nov 8 00:05:56.934085 kernel: raid6: neonx1 gen() 3921 MB/s Nov 8 00:05:56.951080 kernel: raid6: int64x8 gen() 3783 MB/s Nov 8 00:05:56.968083 kernel: raid6: int64x4 gen() 3703 MB/s Nov 8 00:05:56.985080 kernel: raid6: int64x2 gen() 3572 MB/s Nov 8 00:05:57.003167 kernel: raid6: int64x1 gen() 2755 MB/s Nov 8 00:05:57.003212 kernel: raid6: using algorithm neonx8 gen() 6632 MB/s Nov 8 00:05:57.022080 kernel: raid6: .... xor() 4913 MB/s, rmw enabled Nov 8 00:05:57.022129 kernel: raid6: using neon recovery algorithm Nov 8 00:05:57.030086 kernel: xor: measuring software checksum speed Nov 8 00:05:57.032441 kernel: 8regs : 10231 MB/sec Nov 8 00:05:57.032475 kernel: 32regs : 11903 MB/sec Nov 8 00:05:57.033764 kernel: arm64_neon : 9501 MB/sec Nov 8 00:05:57.033797 kernel: xor: using function: 32regs (11903 MB/sec) Nov 8 00:05:57.120103 kernel: Btrfs loaded, zoned=no, fsverity=no Nov 8 00:05:57.139551 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Nov 8 00:05:57.152352 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 8 00:05:57.195668 systemd-udevd[469]: Using default interface naming scheme 'v255'. Nov 8 00:05:57.203733 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 8 00:05:57.222447 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Nov 8 00:05:57.251935 dracut-pre-trigger[471]: rd.md=0: removing MD RAID activation Nov 8 00:05:57.309828 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Nov 8 00:05:57.320507 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 8 00:05:57.442414 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 8 00:05:57.459464 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Nov 8 00:05:57.504910 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Nov 8 00:05:57.512454 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Nov 8 00:05:57.520447 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 8 00:05:57.525855 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 8 00:05:57.541358 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Nov 8 00:05:57.574366 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Nov 8 00:05:57.648076 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 8 00:05:57.648146 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Nov 8 00:05:57.653951 kernel: ena 0000:00:05.0: ENA device version: 0.10 Nov 8 00:05:57.654333 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Nov 8 00:05:57.660987 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 8 00:05:57.663375 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 8 00:05:57.672478 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 8 00:05:57.677799 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 8 00:05:57.680308 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 8 00:05:57.685211 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:22:ee:e0:7f:c3 Nov 8 00:05:57.686091 (udev-worker)[519]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:05:57.686199 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Nov 8 00:05:57.704542 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 8 00:05:57.729550 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Nov 8 00:05:57.729634 kernel: nvme nvme0: pci function 0000:00:04.0 Nov 8 00:05:57.739093 kernel: nvme nvme0: 2/0/0 default/read/poll queues Nov 8 00:05:57.742367 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 8 00:05:57.755332 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 8 00:05:57.755406 kernel: GPT:9289727 != 33554431 Nov 8 00:05:57.755433 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 8 00:05:57.755459 kernel: GPT:9289727 != 33554431 Nov 8 00:05:57.756134 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 8 00:05:57.758207 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 8 00:05:57.763251 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Nov 8 00:05:57.791424 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 8 00:05:57.833085 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (515) Nov 8 00:05:57.884145 kernel: BTRFS: device fsid 55a292e1-3824-4229-a9ae-952140d2698c devid 1 transid 37 /dev/nvme0n1p3 scanned by (udev-worker) (516) Nov 8 00:05:57.935966 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 8 00:05:57.989405 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Nov 8 00:05:58.008577 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Nov 8 00:05:58.023140 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Nov 8 00:05:58.029582 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Nov 8 00:05:58.043325 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Nov 8 00:05:58.058292 disk-uuid[662]: Primary Header is updated. Nov 8 00:05:58.058292 disk-uuid[662]: Secondary Entries is updated. Nov 8 00:05:58.058292 disk-uuid[662]: Secondary Header is updated. Nov 8 00:05:58.070206 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 8 00:05:59.091129 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 8 00:05:59.092417 disk-uuid[663]: The operation has completed successfully. Nov 8 00:05:59.271554 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 8 00:05:59.273493 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Nov 8 00:05:59.323358 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Nov 8 00:05:59.345870 sh[1009]: Success Nov 8 00:05:59.374196 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 8 00:05:59.480728 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Nov 8 00:05:59.495242 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Nov 8 00:05:59.499315 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Nov 8 00:05:59.543019 kernel: BTRFS info (device dm-0): first mount of filesystem 55a292e1-3824-4229-a9ae-952140d2698c Nov 8 00:05:59.543097 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Nov 8 00:05:59.543125 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Nov 8 00:05:59.546399 kernel: BTRFS info (device dm-0): disabling log replay at mount time Nov 8 00:05:59.546439 kernel: BTRFS info (device dm-0): using free space tree Nov 8 00:05:59.667085 kernel: BTRFS info (device dm-0): enabling ssd optimizations Nov 8 00:05:59.694214 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Nov 8 00:05:59.698732 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Nov 8 00:05:59.714306 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Nov 8 00:05:59.720906 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Nov 8 00:05:59.753421 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7afafbf9-edbd-49b5-ac90-6fc331f667e9 Nov 8 00:05:59.753494 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 8 00:05:59.755123 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 8 00:05:59.767107 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 8 00:05:59.784297 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 8 00:05:59.788603 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 7afafbf9-edbd-49b5-ac90-6fc331f667e9 Nov 8 00:05:59.799427 systemd[1]: Finished ignition-setup.service - Ignition (setup). Nov 8 00:05:59.809367 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Nov 8 00:05:59.915985 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 8 00:05:59.931361 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 8 00:05:59.983585 systemd-networkd[1201]: lo: Link UP Nov 8 00:05:59.983607 systemd-networkd[1201]: lo: Gained carrier Nov 8 00:05:59.986104 systemd-networkd[1201]: Enumeration completed Nov 8 00:05:59.986253 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 8 00:05:59.987825 systemd-networkd[1201]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 8 00:05:59.987832 systemd-networkd[1201]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 8 00:05:59.994726 systemd[1]: Reached target network.target - Network. Nov 8 00:05:59.994971 systemd-networkd[1201]: eth0: Link UP Nov 8 00:05:59.994979 systemd-networkd[1201]: eth0: Gained carrier Nov 8 00:05:59.994996 systemd-networkd[1201]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 8 00:06:00.024152 systemd-networkd[1201]: eth0: DHCPv4 address 172.31.28.188/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 8 00:06:00.234562 ignition[1117]: Ignition 2.19.0 Nov 8 00:06:00.234591 ignition[1117]: Stage: fetch-offline Nov 8 00:06:00.239215 ignition[1117]: no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:00.239254 ignition[1117]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:00.244253 ignition[1117]: Ignition finished successfully Nov 8 00:06:00.247861 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Nov 8 00:06:00.262508 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Nov 8 00:06:00.290416 ignition[1211]: Ignition 2.19.0 Nov 8 00:06:00.290438 ignition[1211]: Stage: fetch Nov 8 00:06:00.291577 ignition[1211]: no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:00.291610 ignition[1211]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:00.291774 ignition[1211]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:00.317283 ignition[1211]: PUT result: OK Nov 8 00:06:00.320132 ignition[1211]: parsed url from cmdline: "" Nov 8 00:06:00.320250 ignition[1211]: no config URL provided Nov 8 00:06:00.320856 ignition[1211]: reading system config file "/usr/lib/ignition/user.ign" Nov 8 00:06:00.320897 ignition[1211]: no config at "/usr/lib/ignition/user.ign" Nov 8 00:06:00.320935 ignition[1211]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:00.328937 ignition[1211]: PUT result: OK Nov 8 00:06:00.329098 ignition[1211]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Nov 8 00:06:00.333262 ignition[1211]: GET result: OK Nov 8 00:06:00.333361 ignition[1211]: parsing config with SHA512: 4db3df0964ff1dec78ba523ff820452250791e6c0021c007e4b185cfeb3ffc3a7bcee0e7602653b3cb8deed8dd8905a9f2c593f730003f1fcc478232ad886d4e Nov 8 00:06:00.339565 unknown[1211]: fetched base config from "system" Nov 8 00:06:00.341636 unknown[1211]: fetched base config from "system" Nov 8 00:06:00.342049 ignition[1211]: fetch: fetch complete Nov 8 00:06:00.341654 unknown[1211]: fetched user config from "aws" Nov 8 00:06:00.342061 ignition[1211]: fetch: fetch passed Nov 8 00:06:00.348656 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Nov 8 00:06:00.342172 ignition[1211]: Ignition finished successfully Nov 8 00:06:00.358436 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Nov 8 00:06:00.388722 ignition[1218]: Ignition 2.19.0 Nov 8 00:06:00.389275 ignition[1218]: Stage: kargs Nov 8 00:06:00.389949 ignition[1218]: no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:00.389974 ignition[1218]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:00.390162 ignition[1218]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:00.399892 ignition[1218]: PUT result: OK Nov 8 00:06:00.404751 ignition[1218]: kargs: kargs passed Nov 8 00:06:00.404846 ignition[1218]: Ignition finished successfully Nov 8 00:06:00.410241 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Nov 8 00:06:00.425328 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Nov 8 00:06:00.452708 ignition[1224]: Ignition 2.19.0 Nov 8 00:06:00.452728 ignition[1224]: Stage: disks Nov 8 00:06:00.453892 ignition[1224]: no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:00.453921 ignition[1224]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:00.454115 ignition[1224]: PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:00.463952 ignition[1224]: PUT result: OK Nov 8 00:06:00.468169 ignition[1224]: disks: disks passed Nov 8 00:06:00.468459 ignition[1224]: Ignition finished successfully Nov 8 00:06:00.475867 systemd[1]: Finished ignition-disks.service - Ignition (disks). Nov 8 00:06:00.479298 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Nov 8 00:06:00.484126 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Nov 8 00:06:00.489196 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 8 00:06:00.496904 systemd[1]: Reached target sysinit.target - System Initialization. Nov 8 00:06:00.501221 systemd[1]: Reached target basic.target - Basic System. Nov 8 00:06:00.515309 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Nov 8 00:06:00.557451 systemd-fsck[1232]: ROOT: clean, 14/553520 files, 52654/553472 blocks Nov 8 00:06:00.564444 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Nov 8 00:06:00.579357 systemd[1]: Mounting sysroot.mount - /sysroot... Nov 8 00:06:00.662346 kernel: EXT4-fs (nvme0n1p9): mounted filesystem ba97f76e-2e9b-450a-8320-3c4b94a19632 r/w with ordered data mode. Quota mode: none. Nov 8 00:06:00.660476 systemd[1]: Mounted sysroot.mount - /sysroot. Nov 8 00:06:00.664857 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Nov 8 00:06:00.687223 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 8 00:06:00.696173 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Nov 8 00:06:00.697017 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Nov 8 00:06:00.697137 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 8 00:06:00.697187 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Nov 8 00:06:00.722221 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1251) Nov 8 00:06:00.728932 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7afafbf9-edbd-49b5-ac90-6fc331f667e9 Nov 8 00:06:00.730369 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 8 00:06:00.730399 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 8 00:06:00.730941 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Nov 8 00:06:00.743474 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Nov 8 00:06:00.754370 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 8 00:06:00.756777 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 8 00:06:01.141555 initrd-setup-root[1275]: cut: /sysroot/etc/passwd: No such file or directory Nov 8 00:06:01.164246 initrd-setup-root[1282]: cut: /sysroot/etc/group: No such file or directory Nov 8 00:06:01.184908 initrd-setup-root[1289]: cut: /sysroot/etc/shadow: No such file or directory Nov 8 00:06:01.193559 initrd-setup-root[1296]: cut: /sysroot/etc/gshadow: No such file or directory Nov 8 00:06:01.520796 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Nov 8 00:06:01.533409 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Nov 8 00:06:01.542305 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Nov 8 00:06:01.566672 systemd[1]: sysroot-oem.mount: Deactivated successfully. Nov 8 00:06:01.570551 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 7afafbf9-edbd-49b5-ac90-6fc331f667e9 Nov 8 00:06:01.598814 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Nov 8 00:06:01.625087 ignition[1365]: INFO : Ignition 2.19.0 Nov 8 00:06:01.625087 ignition[1365]: INFO : Stage: mount Nov 8 00:06:01.630243 ignition[1365]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:01.630243 ignition[1365]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:01.635302 ignition[1365]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:01.638821 ignition[1365]: INFO : PUT result: OK Nov 8 00:06:01.644459 ignition[1365]: INFO : mount: mount passed Nov 8 00:06:01.646332 ignition[1365]: INFO : Ignition finished successfully Nov 8 00:06:01.650697 systemd[1]: Finished ignition-mount.service - Ignition (mount). Nov 8 00:06:01.660243 systemd[1]: Starting ignition-files.service - Ignition (files)... Nov 8 00:06:01.687419 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Nov 8 00:06:01.719110 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1376) Nov 8 00:06:01.723018 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7afafbf9-edbd-49b5-ac90-6fc331f667e9 Nov 8 00:06:01.723078 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 8 00:06:01.723107 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 8 00:06:01.729076 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 8 00:06:01.732514 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Nov 8 00:06:01.770398 ignition[1393]: INFO : Ignition 2.19.0 Nov 8 00:06:01.770398 ignition[1393]: INFO : Stage: files Nov 8 00:06:01.776950 ignition[1393]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:01.776950 ignition[1393]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:01.776950 ignition[1393]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:01.776950 ignition[1393]: INFO : PUT result: OK Nov 8 00:06:01.787594 ignition[1393]: DEBUG : files: compiled without relabeling support, skipping Nov 8 00:06:01.800324 ignition[1393]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 8 00:06:01.800324 ignition[1393]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 8 00:06:01.853669 ignition[1393]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 8 00:06:01.856874 ignition[1393]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 8 00:06:01.859937 ignition[1393]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 8 00:06:01.857644 unknown[1393]: wrote ssh authorized keys file for user: core Nov 8 00:06:01.873104 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Nov 8 00:06:01.873104 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Nov 8 00:06:01.873104 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 8 00:06:01.873104 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 8 00:06:01.873104 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Nov 8 00:06:01.895413 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Nov 8 00:06:01.895413 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Nov 8 00:06:01.895413 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.34.1-arm64.raw: attempt #1 Nov 8 00:06:01.906450 systemd-networkd[1201]: eth0: Gained IPv6LL Nov 8 00:06:02.202216 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Nov 8 00:06:02.556580 ignition[1393]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.34.1-arm64.raw" Nov 8 00:06:02.561385 ignition[1393]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 8 00:06:02.561385 ignition[1393]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 8 00:06:02.561385 ignition[1393]: INFO : files: files passed Nov 8 00:06:02.561385 ignition[1393]: INFO : Ignition finished successfully Nov 8 00:06:02.575760 systemd[1]: Finished ignition-files.service - Ignition (files). Nov 8 00:06:02.589343 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Nov 8 00:06:02.598989 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Nov 8 00:06:02.610574 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 8 00:06:02.610765 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Nov 8 00:06:02.636918 initrd-setup-root-after-ignition[1421]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 8 00:06:02.636918 initrd-setup-root-after-ignition[1421]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Nov 8 00:06:02.646866 initrd-setup-root-after-ignition[1425]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 8 00:06:02.652743 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 8 00:06:02.659261 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Nov 8 00:06:02.668548 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Nov 8 00:06:02.725037 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 8 00:06:02.727329 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Nov 8 00:06:02.731120 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Nov 8 00:06:02.736814 systemd[1]: Reached target initrd.target - Initrd Default Target. Nov 8 00:06:02.739483 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Nov 8 00:06:02.750497 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Nov 8 00:06:02.782149 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 8 00:06:02.795321 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Nov 8 00:06:02.821023 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Nov 8 00:06:02.826791 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 8 00:06:02.834705 systemd[1]: Stopped target timers.target - Timer Units. Nov 8 00:06:02.837020 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 8 00:06:02.837281 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Nov 8 00:06:02.847618 systemd[1]: Stopped target initrd.target - Initrd Default Target. Nov 8 00:06:02.855121 systemd[1]: Stopped target basic.target - Basic System. Nov 8 00:06:02.857296 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Nov 8 00:06:02.860760 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Nov 8 00:06:02.870620 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Nov 8 00:06:02.875748 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Nov 8 00:06:02.878317 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Nov 8 00:06:02.881847 systemd[1]: Stopped target sysinit.target - System Initialization. Nov 8 00:06:02.891390 systemd[1]: Stopped target local-fs.target - Local File Systems. Nov 8 00:06:02.893937 systemd[1]: Stopped target swap.target - Swaps. Nov 8 00:06:02.895945 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 8 00:06:02.896227 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Nov 8 00:06:02.907217 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Nov 8 00:06:02.909745 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 8 00:06:02.913018 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Nov 8 00:06:02.916019 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 8 00:06:02.919302 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 8 00:06:02.919546 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Nov 8 00:06:02.929300 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 8 00:06:02.929728 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Nov 8 00:06:02.943110 systemd[1]: ignition-files.service: Deactivated successfully. Nov 8 00:06:02.943513 systemd[1]: Stopped ignition-files.service - Ignition (files). Nov 8 00:06:02.959538 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Nov 8 00:06:02.966598 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Nov 8 00:06:02.976224 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 8 00:06:02.977455 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Nov 8 00:06:02.990536 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 8 00:06:02.990781 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Nov 8 00:06:03.007152 ignition[1445]: INFO : Ignition 2.19.0 Nov 8 00:06:03.011974 ignition[1445]: INFO : Stage: umount Nov 8 00:06:03.011974 ignition[1445]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 8 00:06:03.011974 ignition[1445]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 8 00:06:03.011974 ignition[1445]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 8 00:06:03.016019 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 8 00:06:03.016525 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Nov 8 00:06:03.030334 ignition[1445]: INFO : PUT result: OK Nov 8 00:06:03.040439 ignition[1445]: INFO : umount: umount passed Nov 8 00:06:03.042582 ignition[1445]: INFO : Ignition finished successfully Nov 8 00:06:03.046883 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 8 00:06:03.047123 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Nov 8 00:06:03.057720 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 8 00:06:03.057999 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Nov 8 00:06:03.069796 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 8 00:06:03.069935 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Nov 8 00:06:03.074481 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 8 00:06:03.074576 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Nov 8 00:06:03.077225 systemd[1]: Stopped target network.target - Network. Nov 8 00:06:03.079337 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 8 00:06:03.079442 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Nov 8 00:06:03.082282 systemd[1]: Stopped target paths.target - Path Units. Nov 8 00:06:03.084387 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 8 00:06:03.084580 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 8 00:06:03.111231 systemd[1]: Stopped target slices.target - Slice Units. Nov 8 00:06:03.113330 systemd[1]: Stopped target sockets.target - Socket Units. Nov 8 00:06:03.116940 systemd[1]: iscsid.socket: Deactivated successfully. Nov 8 00:06:03.117027 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Nov 8 00:06:03.124000 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 8 00:06:03.124115 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Nov 8 00:06:03.126387 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 8 00:06:03.126480 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Nov 8 00:06:03.128659 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Nov 8 00:06:03.128740 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Nov 8 00:06:03.132268 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Nov 8 00:06:03.140163 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Nov 8 00:06:03.151394 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 8 00:06:03.162924 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 8 00:06:03.163182 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Nov 8 00:06:03.172138 systemd-networkd[1201]: eth0: DHCPv6 lease lost Nov 8 00:06:03.182994 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 8 00:06:03.183299 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Nov 8 00:06:03.192785 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 8 00:06:03.192931 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Nov 8 00:06:03.205829 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Nov 8 00:06:03.214434 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 8 00:06:03.216292 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Nov 8 00:06:03.224226 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 8 00:06:03.224354 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Nov 8 00:06:03.229734 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 8 00:06:03.229819 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Nov 8 00:06:03.232418 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Nov 8 00:06:03.232499 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 8 00:06:03.235550 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 8 00:06:03.251695 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 8 00:06:03.254978 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Nov 8 00:06:03.276657 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 8 00:06:03.276762 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Nov 8 00:06:03.289517 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 8 00:06:03.292237 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 8 00:06:03.301185 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 8 00:06:03.301335 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Nov 8 00:06:03.307653 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 8 00:06:03.307738 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Nov 8 00:06:03.313386 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 8 00:06:03.313494 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Nov 8 00:06:03.315965 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 8 00:06:03.316073 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Nov 8 00:06:03.316699 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 8 00:06:03.316778 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Nov 8 00:06:03.347608 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Nov 8 00:06:03.352908 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Nov 8 00:06:03.353029 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 8 00:06:03.355941 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Nov 8 00:06:03.356034 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 8 00:06:03.358941 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 8 00:06:03.359029 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Nov 8 00:06:03.361889 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 8 00:06:03.361974 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Nov 8 00:06:03.388645 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 8 00:06:03.389664 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Nov 8 00:06:03.396634 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 8 00:06:03.396949 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Nov 8 00:06:03.406413 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Nov 8 00:06:03.417483 systemd[1]: Starting initrd-switch-root.service - Switch Root... Nov 8 00:06:03.433382 systemd[1]: Switching root. Nov 8 00:06:03.476932 systemd-journald[251]: Journal stopped Nov 8 00:06:06.038780 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Nov 8 00:06:06.038960 kernel: SELinux: policy capability network_peer_controls=1 Nov 8 00:06:06.039012 kernel: SELinux: policy capability open_perms=1 Nov 8 00:06:06.039098 kernel: SELinux: policy capability extended_socket_class=1 Nov 8 00:06:06.039152 kernel: SELinux: policy capability always_check_network=0 Nov 8 00:06:06.039190 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 8 00:06:06.039235 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 8 00:06:06.039276 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 8 00:06:06.039309 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 8 00:06:06.039343 kernel: audit: type=1403 audit(1762560363.950:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 8 00:06:06.039390 systemd[1]: Successfully loaded SELinux policy in 72.095ms. Nov 8 00:06:06.039439 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.096ms. Nov 8 00:06:06.039482 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) Nov 8 00:06:06.039515 systemd[1]: Detected virtualization amazon. Nov 8 00:06:06.039550 systemd[1]: Detected architecture arm64. Nov 8 00:06:06.039584 systemd[1]: Detected first boot. Nov 8 00:06:06.039618 systemd[1]: Initializing machine ID from VM UUID. Nov 8 00:06:06.039658 zram_generator::config[1488]: No configuration found. Nov 8 00:06:06.039697 systemd[1]: Populated /etc with preset unit settings. Nov 8 00:06:06.039732 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 8 00:06:06.039778 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Nov 8 00:06:06.039813 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 8 00:06:06.039849 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Nov 8 00:06:06.039884 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Nov 8 00:06:06.039943 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Nov 8 00:06:06.039992 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Nov 8 00:06:06.040033 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Nov 8 00:06:06.044160 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Nov 8 00:06:06.044218 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Nov 8 00:06:06.044259 systemd[1]: Created slice user.slice - User and Session Slice. Nov 8 00:06:06.044297 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Nov 8 00:06:06.044336 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Nov 8 00:06:06.044373 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Nov 8 00:06:06.044410 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Nov 8 00:06:06.044455 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Nov 8 00:06:06.044489 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Nov 8 00:06:06.044524 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Nov 8 00:06:06.044560 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Nov 8 00:06:06.044596 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Nov 8 00:06:06.044633 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Nov 8 00:06:06.044666 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Nov 8 00:06:06.044701 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Nov 8 00:06:06.044745 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Nov 8 00:06:06.044779 systemd[1]: Reached target remote-fs.target - Remote File Systems. Nov 8 00:06:06.044812 systemd[1]: Reached target slices.target - Slice Units. Nov 8 00:06:06.044848 systemd[1]: Reached target swap.target - Swaps. Nov 8 00:06:06.044885 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Nov 8 00:06:06.044920 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Nov 8 00:06:06.044954 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Nov 8 00:06:06.044989 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Nov 8 00:06:06.045021 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Nov 8 00:06:06.045145 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Nov 8 00:06:06.045190 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Nov 8 00:06:06.045235 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Nov 8 00:06:06.045270 systemd[1]: Mounting media.mount - External Media Directory... Nov 8 00:06:06.045304 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Nov 8 00:06:06.045338 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Nov 8 00:06:06.045369 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Nov 8 00:06:06.045403 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). Nov 8 00:06:06.045438 systemd[1]: Reached target machines.target - Containers. Nov 8 00:06:06.045479 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Nov 8 00:06:06.045511 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 8 00:06:06.045573 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Nov 8 00:06:06.045620 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Nov 8 00:06:06.045656 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 8 00:06:06.045693 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 8 00:06:06.045733 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 8 00:06:06.045782 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Nov 8 00:06:06.045826 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 8 00:06:06.045859 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 8 00:06:06.045895 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 8 00:06:06.045927 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Nov 8 00:06:06.045960 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 8 00:06:06.045992 systemd[1]: Stopped systemd-fsck-usr.service. Nov 8 00:06:06.046025 systemd[1]: Starting systemd-journald.service - Journal Service... Nov 8 00:06:06.047806 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Nov 8 00:06:06.047867 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Nov 8 00:06:06.047908 kernel: fuse: init (API version 7.39) Nov 8 00:06:06.047941 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Nov 8 00:06:06.047974 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Nov 8 00:06:06.048010 systemd[1]: verity-setup.service: Deactivated successfully. Nov 8 00:06:06.048083 systemd[1]: Stopped verity-setup.service. Nov 8 00:06:06.048130 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Nov 8 00:06:06.048164 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Nov 8 00:06:06.048198 systemd[1]: Mounted media.mount - External Media Directory. Nov 8 00:06:06.048231 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Nov 8 00:06:06.048274 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Nov 8 00:06:06.048316 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Nov 8 00:06:06.048349 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Nov 8 00:06:06.048380 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 8 00:06:06.048413 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Nov 8 00:06:06.048455 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 8 00:06:06.048487 kernel: ACPI: bus type drm_connector registered Nov 8 00:06:06.048520 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 8 00:06:06.048554 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 8 00:06:06.048585 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 8 00:06:06.048617 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 8 00:06:06.048651 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Nov 8 00:06:06.048688 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Nov 8 00:06:06.048732 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 8 00:06:06.048764 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 8 00:06:06.048799 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Nov 8 00:06:06.048835 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Nov 8 00:06:06.048871 systemd[1]: Reached target network-pre.target - Preparation for Network. Nov 8 00:06:06.048904 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Nov 8 00:06:06.048944 kernel: loop: module loaded Nov 8 00:06:06.048977 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Nov 8 00:06:06.049009 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 8 00:06:06.054205 systemd-journald[1570]: Collecting audit messages is disabled. Nov 8 00:06:06.054283 systemd[1]: Reached target local-fs.target - Local File Systems. Nov 8 00:06:06.054322 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Nov 8 00:06:06.054357 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Nov 8 00:06:06.054399 systemd-journald[1570]: Journal started Nov 8 00:06:06.054454 systemd-journald[1570]: Runtime Journal (/run/log/journal/ec297de833f7ab6037917324ac433940) is 8.0M, max 75.3M, 67.3M free. Nov 8 00:06:05.206385 systemd[1]: Queued start job for default target multi-user.target. Nov 8 00:06:05.299516 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Nov 8 00:06:05.300396 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 8 00:06:06.071257 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Nov 8 00:06:06.078274 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 8 00:06:06.089249 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Nov 8 00:06:06.096754 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 8 00:06:06.108189 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Nov 8 00:06:06.115548 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Nov 8 00:06:06.132084 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Nov 8 00:06:06.160262 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Nov 8 00:06:06.160365 systemd[1]: Started systemd-journald.service - Journal Service. Nov 8 00:06:06.159432 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Nov 8 00:06:06.163868 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 8 00:06:06.165455 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 8 00:06:06.168618 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Nov 8 00:06:06.171670 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Nov 8 00:06:06.176348 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Nov 8 00:06:06.182095 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Nov 8 00:06:06.194802 kernel: loop0: detected capacity change from 0 to 52536 Nov 8 00:06:06.247073 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 8 00:06:06.241586 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Nov 8 00:06:06.253334 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Nov 8 00:06:06.269481 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Nov 8 00:06:06.274288 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 8 00:06:06.300075 kernel: loop1: detected capacity change from 0 to 200800 Nov 8 00:06:06.323147 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Nov 8 00:06:06.339799 systemd-journald[1570]: Time spent on flushing to /var/log/journal/ec297de833f7ab6037917324ac433940 is 69.517ms for 895 entries. Nov 8 00:06:06.339799 systemd-journald[1570]: System Journal (/var/log/journal/ec297de833f7ab6037917324ac433940) is 8.0M, max 195.6M, 187.6M free. Nov 8 00:06:06.425306 systemd-journald[1570]: Received client request to flush runtime journal. Nov 8 00:06:06.349368 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 8 00:06:06.354966 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Nov 8 00:06:06.386404 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Nov 8 00:06:06.386430 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Nov 8 00:06:06.422163 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Nov 8 00:06:06.430110 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Nov 8 00:06:06.455370 systemd[1]: Starting systemd-sysusers.service - Create System Users... Nov 8 00:06:06.465908 kernel: loop2: detected capacity change from 0 to 114432 Nov 8 00:06:06.470152 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Nov 8 00:06:06.485425 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Nov 8 00:06:06.532487 udevadm[1639]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 8 00:06:06.543111 systemd[1]: Finished systemd-sysusers.service - Create System Users. Nov 8 00:06:06.553376 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Nov 8 00:06:06.605633 systemd-tmpfiles[1641]: ACLs are not supported, ignoring. Nov 8 00:06:06.605674 systemd-tmpfiles[1641]: ACLs are not supported, ignoring. Nov 8 00:06:06.615105 kernel: loop3: detected capacity change from 0 to 114328 Nov 8 00:06:06.624149 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Nov 8 00:06:06.737098 kernel: loop4: detected capacity change from 0 to 52536 Nov 8 00:06:06.758106 kernel: loop5: detected capacity change from 0 to 200800 Nov 8 00:06:06.789088 kernel: loop6: detected capacity change from 0 to 114432 Nov 8 00:06:06.804523 kernel: loop7: detected capacity change from 0 to 114328 Nov 8 00:06:06.819645 (sd-merge)[1646]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Nov 8 00:06:06.821208 (sd-merge)[1646]: Merged extensions into '/usr'. Nov 8 00:06:06.830199 systemd[1]: Reloading requested from client PID 1600 ('systemd-sysext') (unit systemd-sysext.service)... Nov 8 00:06:06.830231 systemd[1]: Reloading... Nov 8 00:06:07.002116 zram_generator::config[1668]: No configuration found. Nov 8 00:06:07.373628 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. Nov 8 00:06:07.495875 systemd[1]: Reloading finished in 664 ms. Nov 8 00:06:07.534135 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Nov 8 00:06:07.537712 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Nov 8 00:06:07.552448 systemd[1]: Starting ensure-sysext.service... Nov 8 00:06:07.560131 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Nov 8 00:06:07.576504 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Nov 8 00:06:07.595728 systemd[1]: Reloading requested from client PID 1724 ('systemctl') (unit ensure-sysext.service)... Nov 8 00:06:07.595759 systemd[1]: Reloading... Nov 8 00:06:07.624423 systemd-tmpfiles[1725]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 8 00:06:07.627501 systemd-tmpfiles[1725]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Nov 8 00:06:07.629707 systemd-tmpfiles[1725]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 8 00:06:07.630465 systemd-tmpfiles[1725]: ACLs are not supported, ignoring. Nov 8 00:06:07.630830 systemd-tmpfiles[1725]: ACLs are not supported, ignoring. Nov 8 00:06:07.641423 systemd-tmpfiles[1725]: Detected autofs mount point /boot during canonicalization of boot. Nov 8 00:06:07.641442 systemd-tmpfiles[1725]: Skipping /boot Nov 8 00:06:07.674959 systemd-tmpfiles[1725]: Detected autofs mount point /boot during canonicalization of boot. Nov 8 00:06:07.675155 systemd-tmpfiles[1725]: Skipping /boot Nov 8 00:06:07.706479 systemd-udevd[1726]: Using default interface naming scheme 'v255'. Nov 8 00:06:07.839096 zram_generator::config[1763]: No configuration found. Nov 8 00:06:07.869094 ldconfig[1596]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 8 00:06:07.956552 (udev-worker)[1754]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:06:08.241549 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. Nov 8 00:06:08.281077 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (1792) Nov 8 00:06:08.442920 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Nov 8 00:06:08.444260 systemd[1]: Reloading finished in 847 ms. Nov 8 00:06:08.474630 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Nov 8 00:06:08.482791 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Nov 8 00:06:08.493200 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Nov 8 00:06:08.544134 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Nov 8 00:06:08.601130 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Nov 8 00:06:08.622502 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Nov 8 00:06:08.634029 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Nov 8 00:06:08.637007 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Nov 8 00:06:08.646731 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Nov 8 00:06:08.656563 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Nov 8 00:06:08.665568 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Nov 8 00:06:08.673574 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Nov 8 00:06:08.686569 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Nov 8 00:06:08.689206 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Nov 8 00:06:08.694573 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Nov 8 00:06:08.703182 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Nov 8 00:06:08.714576 systemd[1]: Starting systemd-networkd.service - Network Configuration... Nov 8 00:06:08.722350 lvm[1925]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 8 00:06:08.728537 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Nov 8 00:06:08.733436 systemd[1]: Reached target time-set.target - System Time Set. Nov 8 00:06:08.741587 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Nov 8 00:06:08.749389 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Nov 8 00:06:08.770579 systemd[1]: Finished ensure-sysext.service. Nov 8 00:06:08.790720 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Nov 8 00:06:08.820434 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Nov 8 00:06:08.830430 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Nov 8 00:06:08.845825 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Nov 8 00:06:08.881675 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 8 00:06:08.882019 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Nov 8 00:06:08.886963 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 8 00:06:08.887339 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Nov 8 00:06:08.890528 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 8 00:06:08.904024 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 8 00:06:08.904410 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Nov 8 00:06:08.911590 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Nov 8 00:06:08.920228 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Nov 8 00:06:08.932984 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 8 00:06:08.934212 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Nov 8 00:06:08.938152 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Nov 8 00:06:08.940643 augenrules[1962]: No rules Nov 8 00:06:08.944834 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Nov 8 00:06:08.951193 lvm[1951]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 8 00:06:08.950686 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). Nov 8 00:06:08.959168 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Nov 8 00:06:08.966465 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Nov 8 00:06:08.984122 systemd[1]: Starting systemd-update-done.service - Update is Completed... Nov 8 00:06:09.008177 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Nov 8 00:06:09.019763 systemd[1]: Finished systemd-update-done.service - Update is Completed. Nov 8 00:06:09.055861 systemd[1]: Started systemd-userdbd.service - User Database Manager. Nov 8 00:06:09.147602 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Nov 8 00:06:09.189038 systemd-networkd[1938]: lo: Link UP Nov 8 00:06:09.189092 systemd-networkd[1938]: lo: Gained carrier Nov 8 00:06:09.192675 systemd-networkd[1938]: Enumeration completed Nov 8 00:06:09.193006 systemd[1]: Started systemd-networkd.service - Network Configuration. Nov 8 00:06:09.194476 systemd-networkd[1938]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 8 00:06:09.194619 systemd-networkd[1938]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 8 00:06:09.203950 systemd-networkd[1938]: eth0: Link UP Nov 8 00:06:09.204683 systemd-resolved[1939]: Positive Trust Anchors: Nov 8 00:06:09.204707 systemd-resolved[1939]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 8 00:06:09.204771 systemd-resolved[1939]: 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 Nov 8 00:06:09.206587 systemd-networkd[1938]: eth0: Gained carrier Nov 8 00:06:09.206623 systemd-networkd[1938]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Nov 8 00:06:09.211368 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Nov 8 00:06:09.220200 systemd-networkd[1938]: eth0: DHCPv4 address 172.31.28.188/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 8 00:06:09.222899 systemd-resolved[1939]: Defaulting to hostname 'linux'. Nov 8 00:06:09.227263 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Nov 8 00:06:09.230208 systemd[1]: Reached target network.target - Network. Nov 8 00:06:09.232221 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Nov 8 00:06:09.235004 systemd[1]: Reached target sysinit.target - System Initialization. Nov 8 00:06:09.237574 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Nov 8 00:06:09.240423 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Nov 8 00:06:09.243610 systemd[1]: Started logrotate.timer - Daily rotation of log files. Nov 8 00:06:09.246267 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Nov 8 00:06:09.249125 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Nov 8 00:06:09.252013 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 8 00:06:09.252094 systemd[1]: Reached target paths.target - Path Units. Nov 8 00:06:09.254243 systemd[1]: Reached target timers.target - Timer Units. Nov 8 00:06:09.257501 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Nov 8 00:06:09.262593 systemd[1]: Starting docker.socket - Docker Socket for the API... Nov 8 00:06:09.272419 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Nov 8 00:06:09.275859 systemd[1]: Listening on docker.socket - Docker Socket for the API. Nov 8 00:06:09.278610 systemd[1]: Reached target sockets.target - Socket Units. Nov 8 00:06:09.280902 systemd[1]: Reached target basic.target - Basic System. Nov 8 00:06:09.283170 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Nov 8 00:06:09.283246 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Nov 8 00:06:09.291260 systemd[1]: Starting containerd.service - containerd container runtime... Nov 8 00:06:09.298985 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Nov 8 00:06:09.307351 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Nov 8 00:06:09.321364 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Nov 8 00:06:09.326607 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Nov 8 00:06:09.331425 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). Nov 8 00:06:09.334557 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Nov 8 00:06:09.348364 systemd[1]: Started ntpd.service - Network Time Service. Nov 8 00:06:09.356496 jq[1991]: false Nov 8 00:06:09.361252 systemd[1]: Starting setup-oem.service - Setup OEM... Nov 8 00:06:09.379440 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Nov 8 00:06:09.388402 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Nov 8 00:06:09.400398 systemd[1]: Starting systemd-logind.service - User Login Management... Nov 8 00:06:09.405773 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 8 00:06:09.407102 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 8 00:06:09.410417 systemd[1]: Starting update-engine.service - Update Engine... Nov 8 00:06:09.442550 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Nov 8 00:06:09.453915 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 8 00:06:09.456146 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Nov 8 00:06:09.471366 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 8 00:06:09.473848 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Nov 8 00:06:09.485247 dbus-daemon[1990]: [system] SELinux support is enabled Nov 8 00:06:09.488129 systemd[1]: Started dbus.service - D-Bus System Message Bus. Nov 8 00:06:09.495401 dbus-daemon[1990]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1938 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 8 00:06:09.502789 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). Nov 8 00:06:09.502843 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Nov 8 00:06:09.523133 jq[2002]: true Nov 8 00:06:09.505936 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). Nov 8 00:06:09.519283 dbus-daemon[1990]: [system] Successfully activated service 'org.freedesktop.systemd1' Nov 8 00:06:09.505977 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Nov 8 00:06:09.549431 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Nov 8 00:06:09.582450 extend-filesystems[1992]: Found loop4 Nov 8 00:06:09.582450 extend-filesystems[1992]: Found loop5 Nov 8 00:06:09.591533 extend-filesystems[1992]: Found loop6 Nov 8 00:06:09.591533 extend-filesystems[1992]: Found loop7 Nov 8 00:06:09.591533 extend-filesystems[1992]: Found nvme0n1 Nov 8 00:06:09.591533 extend-filesystems[1992]: Found nvme0n1p1 Nov 8 00:06:09.600522 ntpd[1994]: ntpd 4.2.8p17@1.4004-o Fri Nov 7 22:04:46 UTC 2025 (1): Starting Nov 8 00:06:09.601036 extend-filesystems[1992]: Found nvme0n1p2 Nov 8 00:06:09.602741 extend-filesystems[1992]: Found nvme0n1p3 Nov 8 00:06:09.602741 extend-filesystems[1992]: Found usr Nov 8 00:06:09.611300 extend-filesystems[1992]: Found nvme0n1p4 Nov 8 00:06:09.611300 extend-filesystems[1992]: Found nvme0n1p6 Nov 8 00:06:09.611300 extend-filesystems[1992]: Found nvme0n1p7 Nov 8 00:06:09.611300 extend-filesystems[1992]: Found nvme0n1p9 Nov 8 00:06:09.611300 extend-filesystems[1992]: Checking size of /dev/nvme0n1p9 Nov 8 00:06:09.621811 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: ntpd 4.2.8p17@1.4004-o Fri Nov 7 22:04:46 UTC 2025 (1): Starting Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: ---------------------------------------------------- Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: ntp-4 is maintained by Network Time Foundation, Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: corporation. Support and training for ntp-4 are Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: available at https://www.nwtime.org/support Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: ---------------------------------------------------- Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: proto: precision = 0.096 usec (-23) Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: basedate set to 2025-10-26 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: gps base set to 2025-10-26 (week 2390) Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listen and drop on 0 v6wildcard [::]:123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listen normally on 2 lo 127.0.0.1:123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listen normally on 3 eth0 172.31.28.188:123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listen normally on 4 lo [::1]:123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: bind(21) AF_INET6 fe80::422:eeff:fee0:7fc3%2#123 flags 0x11 failed: Cannot assign requested address Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: unable to create socket on eth0 (5) for fe80::422:eeff:fee0:7fc3%2#123 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: failed to init interface for address fe80::422:eeff:fee0:7fc3%2 Nov 8 00:06:09.648364 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: Listening on routing socket on fd #21 for interface updates Nov 8 00:06:09.649227 jq[2012]: true Nov 8 00:06:09.622066 ntpd[1994]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Nov 8 00:06:09.622092 ntpd[1994]: ---------------------------------------------------- Nov 8 00:06:09.651523 (ntainerd)[2017]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Nov 8 00:06:09.622112 ntpd[1994]: ntp-4 is maintained by Network Time Foundation, Nov 8 00:06:09.622132 ntpd[1994]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Nov 8 00:06:09.622151 ntpd[1994]: corporation. Support and training for ntp-4 are Nov 8 00:06:09.622170 ntpd[1994]: available at https://www.nwtime.org/support Nov 8 00:06:09.622188 ntpd[1994]: ---------------------------------------------------- Nov 8 00:06:09.628017 ntpd[1994]: proto: precision = 0.096 usec (-23) Nov 8 00:06:09.629111 ntpd[1994]: basedate set to 2025-10-26 Nov 8 00:06:09.629143 ntpd[1994]: gps base set to 2025-10-26 (week 2390) Nov 8 00:06:09.634792 ntpd[1994]: Listen and drop on 0 v6wildcard [::]:123 Nov 8 00:06:09.634881 ntpd[1994]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 8 00:06:09.635240 ntpd[1994]: Listen normally on 2 lo 127.0.0.1:123 Nov 8 00:06:09.635306 ntpd[1994]: Listen normally on 3 eth0 172.31.28.188:123 Nov 8 00:06:09.635372 ntpd[1994]: Listen normally on 4 lo [::1]:123 Nov 8 00:06:09.635448 ntpd[1994]: bind(21) AF_INET6 fe80::422:eeff:fee0:7fc3%2#123 flags 0x11 failed: Cannot assign requested address Nov 8 00:06:09.635487 ntpd[1994]: unable to create socket on eth0 (5) for fe80::422:eeff:fee0:7fc3%2#123 Nov 8 00:06:09.635520 ntpd[1994]: failed to init interface for address fe80::422:eeff:fee0:7fc3%2 Nov 8 00:06:09.635579 ntpd[1994]: Listening on routing socket on fd #21 for interface updates Nov 8 00:06:09.664997 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 8 00:06:09.664997 ntpd[1994]: 8 Nov 00:06:09 ntpd[1994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 8 00:06:09.660135 ntpd[1994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 8 00:06:09.660189 ntpd[1994]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 8 00:06:09.669856 systemd[1]: Finished setup-oem.service - Setup OEM. Nov 8 00:06:09.678090 update_engine[2001]: I20251108 00:06:09.677667 2001 main.cc:92] Flatcar Update Engine starting Nov 8 00:06:09.682019 systemd[1]: motdgen.service: Deactivated successfully. Nov 8 00:06:09.683214 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Nov 8 00:06:09.699251 update_engine[2001]: I20251108 00:06:09.687445 2001 update_check_scheduler.cc:74] Next update check in 6m5s Nov 8 00:06:09.690236 systemd[1]: Started update-engine.service - Update Engine. Nov 8 00:06:09.711367 systemd[1]: Started locksmithd.service - Cluster reboot manager. Nov 8 00:06:09.726955 extend-filesystems[1992]: Resized partition /dev/nvme0n1p9 Nov 8 00:06:09.736415 extend-filesystems[2041]: resize2fs 1.47.1 (20-May-2024) Nov 8 00:06:09.751078 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Nov 8 00:06:09.832767 coreos-metadata[1989]: Nov 08 00:06:09.830 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 8 00:06:09.842876 coreos-metadata[1989]: Nov 08 00:06:09.840 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Nov 8 00:06:09.848966 coreos-metadata[1989]: Nov 08 00:06:09.848 INFO Fetch successful Nov 8 00:06:09.848966 coreos-metadata[1989]: Nov 08 00:06:09.848 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Nov 8 00:06:09.851660 coreos-metadata[1989]: Nov 08 00:06:09.850 INFO Fetch successful Nov 8 00:06:09.851660 coreos-metadata[1989]: Nov 08 00:06:09.850 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Nov 8 00:06:09.854464 coreos-metadata[1989]: Nov 08 00:06:09.854 INFO Fetch successful Nov 8 00:06:09.854464 coreos-metadata[1989]: Nov 08 00:06:09.854 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Nov 8 00:06:09.860515 coreos-metadata[1989]: Nov 08 00:06:09.857 INFO Fetch successful Nov 8 00:06:09.860515 coreos-metadata[1989]: Nov 08 00:06:09.859 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Nov 8 00:06:09.863936 coreos-metadata[1989]: Nov 08 00:06:09.863 INFO Fetch failed with 404: resource not found Nov 8 00:06:09.863936 coreos-metadata[1989]: Nov 08 00:06:09.863 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Nov 8 00:06:09.866188 coreos-metadata[1989]: Nov 08 00:06:09.865 INFO Fetch successful Nov 8 00:06:09.868097 coreos-metadata[1989]: Nov 08 00:06:09.866 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Nov 8 00:06:09.880168 coreos-metadata[1989]: Nov 08 00:06:09.870 INFO Fetch successful Nov 8 00:06:09.880168 coreos-metadata[1989]: Nov 08 00:06:09.872 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Nov 8 00:06:09.880168 coreos-metadata[1989]: Nov 08 00:06:09.875 INFO Fetch successful Nov 8 00:06:09.880168 coreos-metadata[1989]: Nov 08 00:06:09.875 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Nov 8 00:06:09.884468 coreos-metadata[1989]: Nov 08 00:06:09.884 INFO Fetch successful Nov 8 00:06:09.884468 coreos-metadata[1989]: Nov 08 00:06:09.884 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Nov 8 00:06:09.889097 coreos-metadata[1989]: Nov 08 00:06:09.887 INFO Fetch successful Nov 8 00:06:09.919080 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Nov 8 00:06:09.934088 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (1767) Nov 8 00:06:09.945108 bash[2061]: Updated "/home/core/.ssh/authorized_keys" Nov 8 00:06:09.948191 extend-filesystems[2041]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Nov 8 00:06:09.948191 extend-filesystems[2041]: old_desc_blocks = 1, new_desc_blocks = 2 Nov 8 00:06:09.948191 extend-filesystems[2041]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Nov 8 00:06:09.971320 extend-filesystems[1992]: Resized filesystem in /dev/nvme0n1p9 Nov 8 00:06:09.951742 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Nov 8 00:06:10.015019 systemd[1]: Starting sshkeys.service... Nov 8 00:06:10.018288 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 8 00:06:10.018694 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Nov 8 00:06:10.046233 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Nov 8 00:06:10.049668 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Nov 8 00:06:10.073403 locksmithd[2037]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 8 00:06:10.096004 systemd-logind[1998]: Watching system buttons on /dev/input/event0 (Power Button) Nov 8 00:06:10.096079 systemd-logind[1998]: Watching system buttons on /dev/input/event1 (Sleep Button) Nov 8 00:06:10.100530 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Nov 8 00:06:10.103257 systemd-logind[1998]: New seat seat0. Nov 8 00:06:10.126760 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Nov 8 00:06:10.130503 systemd[1]: Started systemd-logind.service - User Login Management. Nov 8 00:06:10.289240 systemd-networkd[1938]: eth0: Gained IPv6LL Nov 8 00:06:10.318140 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Nov 8 00:06:10.325327 systemd[1]: Reached target network-online.target - Network is Online. Nov 8 00:06:10.358395 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Nov 8 00:06:10.376512 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 8 00:06:10.386163 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Nov 8 00:06:10.397415 coreos-metadata[2108]: Nov 08 00:06:10.389 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 8 00:06:10.397415 coreos-metadata[2108]: Nov 08 00:06:10.389 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Nov 8 00:06:10.397415 coreos-metadata[2108]: Nov 08 00:06:10.389 INFO Fetch successful Nov 8 00:06:10.397415 coreos-metadata[2108]: Nov 08 00:06:10.389 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Nov 8 00:06:10.397415 coreos-metadata[2108]: Nov 08 00:06:10.389 INFO Fetch successful Nov 8 00:06:10.393123 unknown[2108]: wrote ssh authorized keys file for user: core Nov 8 00:06:10.405987 dbus-daemon[1990]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 8 00:06:10.434848 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Nov 8 00:06:10.443974 dbus-daemon[1990]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=2016 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 8 00:06:10.459078 systemd[1]: Starting polkit.service - Authorization Manager... Nov 8 00:06:10.503684 update-ssh-keys[2165]: Updated "/home/core/.ssh/authorized_keys" Nov 8 00:06:10.507672 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Nov 8 00:06:10.519155 systemd[1]: Finished sshkeys.service. Nov 8 00:06:10.592236 polkitd[2172]: Started polkitd version 121 Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: Initializing new seelog logger Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: New Seelog Logger Creation Complete Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 processing appconfig overrides Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 processing appconfig overrides Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 processing appconfig overrides Nov 8 00:06:10.624566 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO Proxy environment variables: Nov 8 00:06:10.632250 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.632250 amazon-ssm-agent[2155]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 8 00:06:10.632250 amazon-ssm-agent[2155]: 2025/11/08 00:06:10 processing appconfig overrides Nov 8 00:06:10.654379 polkitd[2172]: Loading rules from directory /etc/polkit-1/rules.d Nov 8 00:06:10.654496 polkitd[2172]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 8 00:06:10.662031 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Nov 8 00:06:10.677225 polkitd[2172]: Finished loading, compiling and executing 2 rules Nov 8 00:06:10.681627 dbus-daemon[1990]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 8 00:06:10.682482 systemd[1]: Started polkit.service - Authorization Manager. Nov 8 00:06:10.690581 polkitd[2172]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 8 00:06:10.726365 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO https_proxy: Nov 8 00:06:10.730823 systemd-hostnamed[2016]: Hostname set to (transient) Nov 8 00:06:10.730851 systemd-resolved[1939]: System hostname changed to 'ip-172-31-28-188'. Nov 8 00:06:10.814673 containerd[2017]: time="2025-11-08T00:06:10.814537188Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Nov 8 00:06:10.829065 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO http_proxy: Nov 8 00:06:10.927199 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO no_proxy: Nov 8 00:06:10.930114 containerd[2017]: time="2025-11-08T00:06:10.928212144Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.940651 containerd[2017]: time="2025-11-08T00:06:10.940567560Z" 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.113-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 8 00:06:10.940651 containerd[2017]: time="2025-11-08T00:06:10.940642896Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 8 00:06:10.940837 containerd[2017]: time="2025-11-08T00:06:10.940694196Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 8 00:06:10.941073 containerd[2017]: time="2025-11-08T00:06:10.941003244Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Nov 8 00:06:10.942174 containerd[2017]: time="2025-11-08T00:06:10.942129444Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.942337 containerd[2017]: time="2025-11-08T00:06:10.942291276Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Nov 8 00:06:10.942393 containerd[2017]: time="2025-11-08T00:06:10.942332508Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.942656868Z" 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 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.942702720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.942736188Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.942777000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.942956496Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.943896 containerd[2017]: time="2025-11-08T00:06:10.943414644Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 8 00:06:10.944576 containerd[2017]: time="2025-11-08T00:06:10.944276028Z" 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 Nov 8 00:06:10.944576 containerd[2017]: time="2025-11-08T00:06:10.944324184Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 8 00:06:10.944576 containerd[2017]: time="2025-11-08T00:06:10.944507736Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 8 00:06:10.944728 containerd[2017]: time="2025-11-08T00:06:10.944603988Z" level=info msg="metadata content store policy set" policy=shared Nov 8 00:06:10.960386 containerd[2017]: time="2025-11-08T00:06:10.960308472Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 8 00:06:10.960511 containerd[2017]: time="2025-11-08T00:06:10.960436656Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 8 00:06:10.960649 containerd[2017]: time="2025-11-08T00:06:10.960570816Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Nov 8 00:06:10.960649 containerd[2017]: time="2025-11-08T00:06:10.960625896Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Nov 8 00:06:10.960796 containerd[2017]: time="2025-11-08T00:06:10.960661608Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 8 00:06:10.960963 containerd[2017]: time="2025-11-08T00:06:10.960919008Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962604576Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962811900Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962844384Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962874396Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962905500Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962935320Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.963632 containerd[2017]: time="2025-11-08T00:06:10.962967900Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965144 containerd[2017]: time="2025-11-08T00:06:10.965097684Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965202 containerd[2017]: time="2025-11-08T00:06:10.965155344Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965251 containerd[2017]: time="2025-11-08T00:06:10.965193132Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965251 containerd[2017]: time="2025-11-08T00:06:10.965223744Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965370 containerd[2017]: time="2025-11-08T00:06:10.965251560Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 8 00:06:10.965370 containerd[2017]: time="2025-11-08T00:06:10.965292828Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965370 containerd[2017]: time="2025-11-08T00:06:10.965325924Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965370 containerd[2017]: time="2025-11-08T00:06:10.965354880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965385564Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965415432Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965447004Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965475540Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965505324Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965572 containerd[2017]: time="2025-11-08T00:06:10.965564244Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965606436Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965636496Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965665068Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965715576Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965751252Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Nov 8 00:06:10.965824 containerd[2017]: time="2025-11-08T00:06:10.965795316Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.966099 containerd[2017]: time="2025-11-08T00:06:10.965825088Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.966099 containerd[2017]: time="2025-11-08T00:06:10.965853852Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966308676Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966367236Z" 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 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966400104Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966430812Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966457944Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966487272Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966510024Z" level=info msg="NRI interface is disabled by configuration." Nov 8 00:06:10.967059 containerd[2017]: time="2025-11-08T00:06:10.966535620Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 8 00:06:10.970707 containerd[2017]: time="2025-11-08T00:06:10.969292080Z" 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}" Nov 8 00:06:10.970707 containerd[2017]: time="2025-11-08T00:06:10.969415848Z" level=info msg="Connect containerd service" Nov 8 00:06:10.970707 containerd[2017]: time="2025-11-08T00:06:10.969469920Z" level=info msg="using legacy CRI server" Nov 8 00:06:10.970707 containerd[2017]: time="2025-11-08T00:06:10.969487308Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Nov 8 00:06:10.970707 containerd[2017]: time="2025-11-08T00:06:10.969646764Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 8 00:06:10.971226 containerd[2017]: time="2025-11-08T00:06:10.970911552Z" 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" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972321732Z" level=info msg="Start subscribing containerd event" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972407916Z" level=info msg="Start recovering state" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972543300Z" level=info msg="Start event monitor" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972569268Z" level=info msg="Start snapshots syncer" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972591480Z" level=info msg="Start cni network conf syncer for default" Nov 8 00:06:10.973700 containerd[2017]: time="2025-11-08T00:06:10.972609960Z" level=info msg="Start streaming server" Nov 8 00:06:10.976481 containerd[2017]: time="2025-11-08T00:06:10.976424808Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 8 00:06:10.976572 containerd[2017]: time="2025-11-08T00:06:10.976542156Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 8 00:06:10.979830 containerd[2017]: time="2025-11-08T00:06:10.976664592Z" level=info msg="containerd successfully booted in 0.165619s" Nov 8 00:06:10.976800 systemd[1]: Started containerd.service - containerd container runtime. Nov 8 00:06:11.002478 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Nov 8 00:06:11.026059 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO Checking if agent identity type OnPrem can be assumed Nov 8 00:06:11.051438 sshd_keygen[2035]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 8 00:06:11.098163 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Nov 8 00:06:11.117550 systemd[1]: Starting issuegen.service - Generate /run/issue... Nov 8 00:06:11.125551 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO Checking if agent identity type EC2 can be assumed Nov 8 00:06:11.131652 systemd[1]: Started sshd@0-172.31.28.188:22-139.178.89.65:50986.service - OpenSSH per-connection server daemon (139.178.89.65:50986). Nov 8 00:06:11.154477 systemd[1]: issuegen.service: Deactivated successfully. Nov 8 00:06:11.154843 systemd[1]: Finished issuegen.service - Generate /run/issue. Nov 8 00:06:11.170480 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Nov 8 00:06:11.217189 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Nov 8 00:06:11.226082 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO Agent will take identity from EC2 Nov 8 00:06:11.230705 systemd[1]: Started getty@tty1.service - Getty on tty1. Nov 8 00:06:11.247840 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Nov 8 00:06:11.250905 systemd[1]: Reached target getty.target - Login Prompts. Nov 8 00:06:11.324227 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 8 00:06:11.377199 sshd[2219]: Accepted publickey for core from 139.178.89.65 port 50986 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:11.380033 sshd[2219]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:11.399871 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Nov 8 00:06:11.412112 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Nov 8 00:06:11.427406 systemd-logind[1998]: New session 1 of user core. Nov 8 00:06:11.430889 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 8 00:06:11.454911 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Nov 8 00:06:11.467532 systemd[1]: Starting user@500.service - User Manager for UID 500... Nov 8 00:06:11.472555 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] using named pipe channel for IPC Nov 8 00:06:11.472704 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Nov 8 00:06:11.472704 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Nov 8 00:06:11.472704 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] Starting Core Agent Nov 8 00:06:11.472704 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [amazon-ssm-agent] registrar detected. Attempting registration Nov 8 00:06:11.472704 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [Registrar] Starting registrar module Nov 8 00:06:11.472950 amazon-ssm-agent[2155]: 2025-11-08 00:06:10 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Nov 8 00:06:11.472950 amazon-ssm-agent[2155]: 2025-11-08 00:06:11 INFO [EC2Identity] EC2 registration was successful. Nov 8 00:06:11.472950 amazon-ssm-agent[2155]: 2025-11-08 00:06:11 INFO [CredentialRefresher] credentialRefresher has started Nov 8 00:06:11.472950 amazon-ssm-agent[2155]: 2025-11-08 00:06:11 INFO [CredentialRefresher] Starting credentials refresher loop Nov 8 00:06:11.472950 amazon-ssm-agent[2155]: 2025-11-08 00:06:11 INFO EC2RoleProvider Successfully connected with instance profile role credentials Nov 8 00:06:11.495763 (systemd)[2230]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 8 00:06:11.526768 amazon-ssm-agent[2155]: 2025-11-08 00:06:11 INFO [CredentialRefresher] Next credential rotation will be in 30.1749863845 minutes Nov 8 00:06:11.728374 systemd[2230]: Queued start job for default target default.target. Nov 8 00:06:11.740183 systemd[2230]: Created slice app.slice - User Application Slice. Nov 8 00:06:11.740243 systemd[2230]: Reached target paths.target - Paths. Nov 8 00:06:11.740275 systemd[2230]: Reached target timers.target - Timers. Nov 8 00:06:11.747163 systemd[2230]: Starting dbus.socket - D-Bus User Message Bus Socket... Nov 8 00:06:11.775795 systemd[2230]: Listening on dbus.socket - D-Bus User Message Bus Socket. Nov 8 00:06:11.776087 systemd[2230]: Reached target sockets.target - Sockets. Nov 8 00:06:11.776136 systemd[2230]: Reached target basic.target - Basic System. Nov 8 00:06:11.776222 systemd[2230]: Reached target default.target - Main User Target. Nov 8 00:06:11.776284 systemd[2230]: Startup finished in 266ms. Nov 8 00:06:11.776414 systemd[1]: Started user@500.service - User Manager for UID 500. Nov 8 00:06:11.785332 systemd[1]: Started session-1.scope - Session 1 of User core. Nov 8 00:06:11.962550 systemd[1]: Started sshd@1-172.31.28.188:22-139.178.89.65:50990.service - OpenSSH per-connection server daemon (139.178.89.65:50990). Nov 8 00:06:12.147283 sshd[2241]: Accepted publickey for core from 139.178.89.65 port 50990 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:12.149249 sshd[2241]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:12.158655 systemd-logind[1998]: New session 2 of user core. Nov 8 00:06:12.169006 systemd[1]: Started session-2.scope - Session 2 of User core. Nov 8 00:06:12.307388 sshd[2241]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:12.314151 systemd[1]: session-2.scope: Deactivated successfully. Nov 8 00:06:12.315815 systemd[1]: sshd@1-172.31.28.188:22-139.178.89.65:50990.service: Deactivated successfully. Nov 8 00:06:12.324483 systemd-logind[1998]: Session 2 logged out. Waiting for processes to exit. Nov 8 00:06:12.328333 systemd-logind[1998]: Removed session 2. Nov 8 00:06:12.356523 systemd[1]: Started sshd@2-172.31.28.188:22-139.178.89.65:51002.service - OpenSSH per-connection server daemon (139.178.89.65:51002). Nov 8 00:06:12.529403 amazon-ssm-agent[2155]: 2025-11-08 00:06:12 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Nov 8 00:06:12.530310 sshd[2248]: Accepted publickey for core from 139.178.89.65 port 51002 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:12.534194 sshd[2248]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:12.546647 systemd-logind[1998]: New session 3 of user core. Nov 8 00:06:12.553730 systemd[1]: Started session-3.scope - Session 3 of User core. Nov 8 00:06:12.623255 ntpd[1994]: Listen normally on 6 eth0 [fe80::422:eeff:fee0:7fc3%2]:123 Nov 8 00:06:12.625457 ntpd[1994]: 8 Nov 00:06:12 ntpd[1994]: Listen normally on 6 eth0 [fe80::422:eeff:fee0:7fc3%2]:123 Nov 8 00:06:12.629894 amazon-ssm-agent[2155]: 2025-11-08 00:06:12 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2251) started Nov 8 00:06:12.697100 sshd[2248]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:12.705249 systemd[1]: sshd@2-172.31.28.188:22-139.178.89.65:51002.service: Deactivated successfully. Nov 8 00:06:12.710274 systemd[1]: session-3.scope: Deactivated successfully. Nov 8 00:06:12.712422 systemd-logind[1998]: Session 3 logged out. Waiting for processes to exit. Nov 8 00:06:12.715663 systemd-logind[1998]: Removed session 3. Nov 8 00:06:12.732263 amazon-ssm-agent[2155]: 2025-11-08 00:06:12 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Nov 8 00:06:12.916331 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 8 00:06:12.919678 (kubelet)[2271]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 8 00:06:12.920252 systemd[1]: Reached target multi-user.target - Multi-User System. Nov 8 00:06:12.925840 systemd[1]: Startup finished in 1.188s (kernel) + 8.114s (initrd) + 9.047s (userspace) = 18.350s. Nov 8 00:06:13.884891 kubelet[2271]: E1108 00:06:13.884807 2271 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" Nov 8 00:06:13.889526 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 8 00:06:13.889878 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 8 00:06:13.891219 systemd[1]: kubelet.service: Consumed 1.280s CPU time. Nov 8 00:06:17.076142 systemd-resolved[1939]: Clock change detected. Flushing caches. Nov 8 00:06:23.182159 systemd[1]: Started sshd@3-172.31.28.188:22-139.178.89.65:44948.service - OpenSSH per-connection server daemon (139.178.89.65:44948). Nov 8 00:06:23.370888 sshd[2283]: Accepted publickey for core from 139.178.89.65 port 44948 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:23.373431 sshd[2283]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:23.381963 systemd-logind[1998]: New session 4 of user core. Nov 8 00:06:23.389109 systemd[1]: Started session-4.scope - Session 4 of User core. Nov 8 00:06:23.518435 sshd[2283]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:23.523772 systemd-logind[1998]: Session 4 logged out. Waiting for processes to exit. Nov 8 00:06:23.524994 systemd[1]: sshd@3-172.31.28.188:22-139.178.89.65:44948.service: Deactivated successfully. Nov 8 00:06:23.529936 systemd[1]: session-4.scope: Deactivated successfully. Nov 8 00:06:23.534061 systemd-logind[1998]: Removed session 4. Nov 8 00:06:23.552951 systemd[1]: Started sshd@4-172.31.28.188:22-139.178.89.65:44958.service - OpenSSH per-connection server daemon (139.178.89.65:44958). Nov 8 00:06:23.737617 sshd[2290]: Accepted publickey for core from 139.178.89.65 port 44958 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:23.740248 sshd[2290]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:23.747655 systemd-logind[1998]: New session 5 of user core. Nov 8 00:06:23.760122 systemd[1]: Started session-5.scope - Session 5 of User core. Nov 8 00:06:23.882207 sshd[2290]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:23.888426 systemd-logind[1998]: Session 5 logged out. Waiting for processes to exit. Nov 8 00:06:23.890046 systemd[1]: sshd@4-172.31.28.188:22-139.178.89.65:44958.service: Deactivated successfully. Nov 8 00:06:23.893191 systemd[1]: session-5.scope: Deactivated successfully. Nov 8 00:06:23.894972 systemd-logind[1998]: Removed session 5. Nov 8 00:06:23.925435 systemd[1]: Started sshd@5-172.31.28.188:22-139.178.89.65:44962.service - OpenSSH per-connection server daemon (139.178.89.65:44962). Nov 8 00:06:24.103084 sshd[2297]: Accepted publickey for core from 139.178.89.65 port 44962 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:24.105639 sshd[2297]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:24.113019 systemd-logind[1998]: New session 6 of user core. Nov 8 00:06:24.123097 systemd[1]: Started session-6.scope - Session 6 of User core. Nov 8 00:06:24.254465 sshd[2297]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:24.259678 systemd-logind[1998]: Session 6 logged out. Waiting for processes to exit. Nov 8 00:06:24.260089 systemd[1]: sshd@5-172.31.28.188:22-139.178.89.65:44962.service: Deactivated successfully. Nov 8 00:06:24.263212 systemd[1]: session-6.scope: Deactivated successfully. Nov 8 00:06:24.266618 systemd-logind[1998]: Removed session 6. Nov 8 00:06:24.291403 systemd[1]: Started sshd@6-172.31.28.188:22-139.178.89.65:44970.service - OpenSSH per-connection server daemon (139.178.89.65:44970). Nov 8 00:06:24.440103 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 1. Nov 8 00:06:24.452224 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 8 00:06:24.472159 sshd[2304]: Accepted publickey for core from 139.178.89.65 port 44970 ssh2: RSA SHA256:tnEXpnDY8gLTej7GJ+T99WI4otIwvlI9IcMNDF42aqw Nov 8 00:06:24.475622 sshd[2304]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Nov 8 00:06:24.486242 systemd-logind[1998]: New session 7 of user core. Nov 8 00:06:24.495494 systemd[1]: Started session-7.scope - Session 7 of User core. Nov 8 00:06:24.643909 sudo[2310]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 8 00:06:24.644572 sudo[2310]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Nov 8 00:06:24.837248 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 8 00:06:24.847626 (kubelet)[2326]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Nov 8 00:06:24.927979 kubelet[2326]: E1108 00:06:24.927708 2326 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" Nov 8 00:06:24.934533 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 8 00:06:24.934871 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 8 00:06:25.893063 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 8 00:06:25.907796 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 8 00:06:25.952044 systemd[1]: Reloading requested from client PID 2355 ('systemctl') (unit session-7.scope)... Nov 8 00:06:25.952280 systemd[1]: Reloading... Nov 8 00:06:26.183442 zram_generator::config[2395]: No configuration found. Nov 8 00:06:26.433032 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. Nov 8 00:06:26.608160 systemd[1]: Reloading finished in 655 ms. Nov 8 00:06:26.708639 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Nov 8 00:06:26.708817 systemd[1]: kubelet.service: Failed with result 'signal'. Nov 8 00:06:26.709629 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Nov 8 00:06:26.719626 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Nov 8 00:06:27.046665 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Nov 8 00:06:27.063427 (kubelet)[2459]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Nov 8 00:06:27.137566 kubelet[2459]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 8 00:06:27.137566 kubelet[2459]: 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. Nov 8 00:06:27.138902 kubelet[2459]: I1108 00:06:27.138589 2459 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" Nov 8 00:06:28.808687 kubelet[2459]: I1108 00:06:28.808614 2459 server.go:529] "Kubelet version" kubeletVersion="v1.34.1" Nov 8 00:06:28.808687 kubelet[2459]: I1108 00:06:28.808664 2459 server.go:531] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 8 00:06:28.811189 kubelet[2459]: I1108 00:06:28.811140 2459 watchdog_linux.go:95] "Systemd watchdog is not enabled" Nov 8 00:06:28.811189 kubelet[2459]: I1108 00:06:28.811182 2459 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 8 00:06:28.811625 kubelet[2459]: I1108 00:06:28.811581 2459 server.go:956] "Client rotation is on, will bootstrap in background" Nov 8 00:06:28.823755 kubelet[2459]: I1108 00:06:28.823685 2459 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 8 00:06:28.831923 kubelet[2459]: E1108 00:06:28.831737 2459 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Nov 8 00:06:28.831923 kubelet[2459]: I1108 00:06:28.831831 2459 server.go:1400] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Nov 8 00:06:28.836665 kubelet[2459]: I1108 00:06:28.836601 2459 server.go:781] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Nov 8 00:06:28.837162 kubelet[2459]: I1108 00:06:28.837107 2459 container_manager_linux.go:270] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 8 00:06:28.837425 kubelet[2459]: I1108 00:06:28.837165 2459 container_manager_linux.go:275] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.28.188","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Nov 8 00:06:28.837584 kubelet[2459]: I1108 00:06:28.837427 2459 topology_manager.go:138] "Creating topology manager with none policy" Nov 8 00:06:28.837584 kubelet[2459]: I1108 00:06:28.837447 2459 container_manager_linux.go:306] "Creating device plugin manager" Nov 8 00:06:28.837691 kubelet[2459]: I1108 00:06:28.837609 2459 container_manager_linux.go:315] "Creating Dynamic Resource Allocation (DRA) manager" Nov 8 00:06:28.844826 kubelet[2459]: I1108 00:06:28.844785 2459 state_mem.go:36] "Initialized new in-memory state store" Nov 8 00:06:28.847760 kubelet[2459]: I1108 00:06:28.847249 2459 kubelet.go:475] "Attempting to sync node with API server" Nov 8 00:06:28.847760 kubelet[2459]: I1108 00:06:28.847286 2459 kubelet.go:376] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 8 00:06:28.847760 kubelet[2459]: I1108 00:06:28.847331 2459 kubelet.go:387] "Adding apiserver pod source" Nov 8 00:06:28.847760 kubelet[2459]: I1108 00:06:28.847354 2459 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 8 00:06:28.848346 kubelet[2459]: E1108 00:06:28.848155 2459 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:28.849471 kubelet[2459]: E1108 00:06:28.848504 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:28.850006 kubelet[2459]: I1108 00:06:28.849975 2459 kuberuntime_manager.go:291] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Nov 8 00:06:28.851307 kubelet[2459]: I1108 00:06:28.851278 2459 kubelet.go:940] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Nov 8 00:06:28.851492 kubelet[2459]: I1108 00:06:28.851471 2459 kubelet.go:964] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Nov 8 00:06:28.851630 kubelet[2459]: W1108 00:06:28.851610 2459 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 8 00:06:28.856143 kubelet[2459]: I1108 00:06:28.856112 2459 server.go:1262] "Started kubelet" Nov 8 00:06:28.858505 kubelet[2459]: I1108 00:06:28.858468 2459 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 8 00:06:28.871201 kubelet[2459]: I1108 00:06:28.871145 2459 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Nov 8 00:06:28.873507 kubelet[2459]: I1108 00:06:28.872763 2459 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 8 00:06:28.873507 kubelet[2459]: I1108 00:06:28.872868 2459 server_v1.go:49] "podresources" method="list" useActivePods=true Nov 8 00:06:28.873507 kubelet[2459]: I1108 00:06:28.873233 2459 server.go:249] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 8 00:06:28.875623 kubelet[2459]: E1108 00:06:28.870560 2459 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.28.188.1875df55d0f07b76 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:172.31.28.188,UID:172.31.28.188,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:172.31.28.188,},FirstTimestamp:2025-11-08 00:06:28.856052598 +0000 UTC m=+1.786598254,LastTimestamp:2025-11-08 00:06:28.856052598 +0000 UTC m=+1.786598254,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:172.31.28.188,}" Nov 8 00:06:28.875840 kubelet[2459]: E1108 00:06:28.875741 2459 reflector.go:205] "Failed to watch" err="failed to list *v1.Node: nodes \"172.31.28.188\" 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" Nov 8 00:06:28.876014 kubelet[2459]: E1108 00:06:28.875970 2459 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" Nov 8 00:06:28.877563 kubelet[2459]: I1108 00:06:28.877397 2459 server.go:310] "Adding debug handlers to kubelet server" Nov 8 00:06:28.881911 kubelet[2459]: I1108 00:06:28.881629 2459 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 8 00:06:28.885647 kubelet[2459]: I1108 00:06:28.885441 2459 volume_manager.go:313] "Starting Kubelet Volume Manager" Nov 8 00:06:28.885782 kubelet[2459]: E1108 00:06:28.885766 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:28.887607 kubelet[2459]: I1108 00:06:28.887569 2459 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Nov 8 00:06:28.887760 kubelet[2459]: I1108 00:06:28.887661 2459 reconciler.go:29] "Reconciler: start to sync state" Nov 8 00:06:28.889783 kubelet[2459]: I1108 00:06:28.889390 2459 factory.go:223] Registration of the systemd container factory successfully Nov 8 00:06:28.889783 kubelet[2459]: I1108 00:06:28.889542 2459 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 Nov 8 00:06:28.889783 kubelet[2459]: E1108 00:06:28.889709 2459 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"172.31.28.188\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" Nov 8 00:06:28.891070 kubelet[2459]: E1108 00:06:28.890943 2459 kubelet.go:1615] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 8 00:06:28.897929 kubelet[2459]: I1108 00:06:28.895971 2459 factory.go:223] Registration of the containerd container factory successfully Nov 8 00:06:28.947154 kubelet[2459]: I1108 00:06:28.947092 2459 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 8 00:06:28.947154 kubelet[2459]: I1108 00:06:28.947129 2459 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 8 00:06:28.947154 kubelet[2459]: I1108 00:06:28.947161 2459 state_mem.go:36] "Initialized new in-memory state store" Nov 8 00:06:28.951003 kubelet[2459]: I1108 00:06:28.950957 2459 policy_none.go:49] "None policy: Start" Nov 8 00:06:28.951003 kubelet[2459]: I1108 00:06:28.950999 2459 memory_manager.go:187] "Starting memorymanager" policy="None" Nov 8 00:06:28.951184 kubelet[2459]: I1108 00:06:28.951024 2459 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Nov 8 00:06:28.954685 kubelet[2459]: I1108 00:06:28.954637 2459 policy_none.go:47] "Start" Nov 8 00:06:28.966333 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Nov 8 00:06:28.987076 kubelet[2459]: E1108 00:06:28.986390 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:28.991530 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Nov 8 00:06:29.001236 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Nov 8 00:06:29.017086 kubelet[2459]: E1108 00:06:29.017048 2459 manager.go:513] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Nov 8 00:06:29.018146 kubelet[2459]: I1108 00:06:29.017943 2459 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 8 00:06:29.018146 kubelet[2459]: I1108 00:06:29.017994 2459 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 8 00:06:29.018685 kubelet[2459]: I1108 00:06:29.018522 2459 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 8 00:06:29.021350 kubelet[2459]: E1108 00:06:29.021195 2459 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 8 00:06:29.021350 kubelet[2459]: E1108 00:06:29.021260 2459 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.28.188\" not found" Nov 8 00:06:29.076288 sudo[2310]: pam_unix(sudo:session): session closed for user root Nov 8 00:06:29.083466 kubelet[2459]: I1108 00:06:29.083390 2459 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Nov 8 00:06:29.089798 kubelet[2459]: I1108 00:06:29.088022 2459 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Nov 8 00:06:29.089798 kubelet[2459]: I1108 00:06:29.088068 2459 status_manager.go:244] "Starting to sync pod status with apiserver" Nov 8 00:06:29.089798 kubelet[2459]: I1108 00:06:29.088118 2459 kubelet.go:2427] "Starting kubelet main sync loop" Nov 8 00:06:29.089798 kubelet[2459]: E1108 00:06:29.088184 2459 kubelet.go:2451] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Nov 8 00:06:29.097586 kubelet[2459]: E1108 00:06:29.097545 2459 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"172.31.28.188\" not found" node="172.31.28.188" Nov 8 00:06:29.102200 sshd[2304]: pam_unix(sshd:session): session closed for user core Nov 8 00:06:29.106685 systemd[1]: sshd@6-172.31.28.188:22-139.178.89.65:44970.service: Deactivated successfully. Nov 8 00:06:29.111024 systemd[1]: session-7.scope: Deactivated successfully. Nov 8 00:06:29.114150 systemd-logind[1998]: Session 7 logged out. Waiting for processes to exit. Nov 8 00:06:29.116753 systemd-logind[1998]: Removed session 7. Nov 8 00:06:29.119946 kubelet[2459]: I1108 00:06:29.119737 2459 kubelet_node_status.go:75] "Attempting to register node" node="172.31.28.188" Nov 8 00:06:29.126126 kubelet[2459]: I1108 00:06:29.126086 2459 kubelet_node_status.go:78] "Successfully registered node" node="172.31.28.188" Nov 8 00:06:29.126126 kubelet[2459]: E1108 00:06:29.126134 2459 kubelet_node_status.go:486] "Error updating node status, will retry" err="error getting node \"172.31.28.188\": node \"172.31.28.188\" not found" Nov 8 00:06:29.161019 kubelet[2459]: E1108 00:06:29.160972 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.261179 kubelet[2459]: E1108 00:06:29.261121 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.361350 kubelet[2459]: E1108 00:06:29.361221 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.461931 kubelet[2459]: E1108 00:06:29.461850 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.562571 kubelet[2459]: E1108 00:06:29.562524 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.663253 kubelet[2459]: E1108 00:06:29.663141 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.763907 kubelet[2459]: E1108 00:06:29.763835 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.815581 kubelet[2459]: I1108 00:06:29.815489 2459 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 8 00:06:29.816146 kubelet[2459]: I1108 00:06:29.815742 2459 reflector.go:568] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" 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" Nov 8 00:06:29.816146 kubelet[2459]: I1108 00:06:29.815951 2459 reflector.go:568] "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" Nov 8 00:06:29.850211 kubelet[2459]: E1108 00:06:29.850168 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:29.864180 kubelet[2459]: E1108 00:06:29.864120 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:29.965052 kubelet[2459]: E1108 00:06:29.964908 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:30.065789 kubelet[2459]: E1108 00:06:30.065737 2459 kubelet_node_status.go:404] "Error getting the current node from lister" err="node \"172.31.28.188\" not found" Nov 8 00:06:30.167796 kubelet[2459]: I1108 00:06:30.167555 2459 kuberuntime_manager.go:1828] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 8 00:06:30.168244 containerd[2017]: time="2025-11-08T00:06:30.168078329Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 8 00:06:30.169725 kubelet[2459]: I1108 00:06:30.168940 2459 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 8 00:06:30.850402 kubelet[2459]: E1108 00:06:30.850339 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:30.850402 kubelet[2459]: I1108 00:06:30.850349 2459 apiserver.go:52] "Watching apiserver" Nov 8 00:06:30.873662 systemd[1]: Created slice kubepods-besteffort-pod92f19f58_265b_48cc_abd4_da014813c124.slice - libcontainer container kubepods-besteffort-pod92f19f58_265b_48cc_abd4_da014813c124.slice. Nov 8 00:06:30.888903 kubelet[2459]: I1108 00:06:30.888350 2459 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Nov 8 00:06:30.892274 systemd[1]: Created slice kubepods-burstable-podb4a56ffe_1553_4ce0_a7dd_05a5bcdd66ce.slice - libcontainer container kubepods-burstable-podb4a56ffe_1553_4ce0_a7dd_05a5bcdd66ce.slice. Nov 8 00:06:30.899111 kubelet[2459]: I1108 00:06:30.898995 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-xtables-lock\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:30.899280 kubelet[2459]: I1108 00:06:30.899195 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/92f19f58-265b-48cc-abd4-da014813c124-kube-proxy\") pod \"kube-proxy-7kl99\" (UID: \"92f19f58-265b-48cc-abd4-da014813c124\") " pod="kube-system/kube-proxy-7kl99" Nov 8 00:06:30.899280 kubelet[2459]: I1108 00:06:30.899257 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qhll2\" (UniqueName: \"kubernetes.io/projected/92f19f58-265b-48cc-abd4-da014813c124-kube-api-access-qhll2\") pod \"kube-proxy-7kl99\" (UID: \"92f19f58-265b-48cc-abd4-da014813c124\") " pod="kube-system/kube-proxy-7kl99" Nov 8 00:06:30.899400 kubelet[2459]: I1108 00:06:30.899372 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-run\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:30.899459 kubelet[2459]: I1108 00:06:30.899428 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-cxdwd\" (UniqueName: \"kubernetes.io/projected/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-kube-api-access-cxdwd\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:30.899519 kubelet[2459]: I1108 00:06:30.899473 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/92f19f58-265b-48cc-abd4-da014813c124-xtables-lock\") pod \"kube-proxy-7kl99\" (UID: \"92f19f58-265b-48cc-abd4-da014813c124\") " pod="kube-system/kube-proxy-7kl99" Nov 8 00:06:30.899519 kubelet[2459]: I1108 00:06:30.899507 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/92f19f58-265b-48cc-abd4-da014813c124-lib-modules\") pod \"kube-proxy-7kl99\" (UID: \"92f19f58-265b-48cc-abd4-da014813c124\") " pod="kube-system/kube-proxy-7kl99" Nov 8 00:06:30.899633 kubelet[2459]: I1108 00:06:30.899541 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-cni-plugin\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:30.899633 kubelet[2459]: I1108 00:06:30.899573 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-cni\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:30.899633 kubelet[2459]: I1108 00:06:30.899616 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce-flannel-cfg\") pod \"kube-flannel-ds-trdjc\" (UID: \"b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce\") " pod="kube-flannel/kube-flannel-ds-trdjc" Nov 8 00:06:31.192534 containerd[2017]: time="2025-11-08T00:06:31.191322690Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-7kl99,Uid:92f19f58-265b-48cc-abd4-da014813c124,Namespace:kube-system,Attempt:0,}" Nov 8 00:06:31.208522 containerd[2017]: time="2025-11-08T00:06:31.208127670Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-trdjc,Uid:b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce,Namespace:kube-flannel,Attempt:0,}" Nov 8 00:06:31.763829 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3968153151.mount: Deactivated successfully. Nov 8 00:06:31.780436 containerd[2017]: time="2025-11-08T00:06:31.780359025Z" 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\"}" Nov 8 00:06:31.789072 containerd[2017]: time="2025-11-08T00:06:31.788933589Z" 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\"}" Nov 8 00:06:31.791386 containerd[2017]: time="2025-11-08T00:06:31.791228121Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269173" Nov 8 00:06:31.794903 containerd[2017]: time="2025-11-08T00:06:31.793802061Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Nov 8 00:06:31.795378 containerd[2017]: time="2025-11-08T00:06:31.795327057Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Nov 8 00:06:31.802659 containerd[2017]: time="2025-11-08T00:06:31.802591221Z" 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\"}" Nov 8 00:06:31.804722 containerd[2017]: time="2025-11-08T00:06:31.804674433Z" 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 596.442435ms" Nov 8 00:06:31.807143 containerd[2017]: time="2025-11-08T00:06:31.807066705Z" 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 615.601659ms" Nov 8 00:06:31.851287 kubelet[2459]: E1108 00:06:31.851205 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:32.087780 containerd[2017]: time="2025-11-08T00:06:32.087384450Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 8 00:06:32.087780 containerd[2017]: time="2025-11-08T00:06:32.087605166Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 8 00:06:32.088207 containerd[2017]: time="2025-11-08T00:06:32.087658158Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:32.090508 containerd[2017]: time="2025-11-08T00:06:32.090010650Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:32.103378 containerd[2017]: time="2025-11-08T00:06:32.103237914Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 8 00:06:32.103584 containerd[2017]: time="2025-11-08T00:06:32.103401930Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 8 00:06:32.103584 containerd[2017]: time="2025-11-08T00:06:32.103486590Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:32.103806 containerd[2017]: time="2025-11-08T00:06:32.103720542Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:32.303216 systemd[1]: Started cri-containerd-a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1.scope - libcontainer container a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1. Nov 8 00:06:32.311163 systemd[1]: Started cri-containerd-b9eae51ecdf068dfd88ebdf22634f7263343074b4051ffd4ed5ebda6996332a5.scope - libcontainer container b9eae51ecdf068dfd88ebdf22634f7263343074b4051ffd4ed5ebda6996332a5. Nov 8 00:06:32.386652 containerd[2017]: time="2025-11-08T00:06:32.386307548Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-7kl99,Uid:92f19f58-265b-48cc-abd4-da014813c124,Namespace:kube-system,Attempt:0,} returns sandbox id \"b9eae51ecdf068dfd88ebdf22634f7263343074b4051ffd4ed5ebda6996332a5\"" Nov 8 00:06:32.393957 containerd[2017]: time="2025-11-08T00:06:32.393898976Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.1\"" Nov 8 00:06:32.403351 containerd[2017]: time="2025-11-08T00:06:32.403280720Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-trdjc,Uid:b4a56ffe-1553-4ce0-a7dd-05a5bcdd66ce,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\"" Nov 8 00:06:32.852290 kubelet[2459]: E1108 00:06:32.852142 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:33.682084 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3954330780.mount: Deactivated successfully. Nov 8 00:06:33.852507 kubelet[2459]: E1108 00:06:33.852414 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:34.068512 containerd[2017]: time="2025-11-08T00:06:34.067013972Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.34.1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:34.069515 containerd[2017]: time="2025-11-08T00:06:34.069462716Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.34.1: active requests=0, bytes read=22789028" Nov 8 00:06:34.070917 containerd[2017]: time="2025-11-08T00:06:34.070818320Z" level=info msg="ImageCreate event name:\"sha256:05baa95f5142d87797a2bc1d3d11edfb0bf0a9236d436243d15061fae8b58cb9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:34.076889 containerd[2017]: time="2025-11-08T00:06:34.075508280Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:913cc83ca0b5588a81d86ce8eedeb3ed1e9c1326e81852a1ea4f622b74ff749a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:34.077230 containerd[2017]: time="2025-11-08T00:06:34.077184476Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.34.1\" with image id \"sha256:05baa95f5142d87797a2bc1d3d11edfb0bf0a9236d436243d15061fae8b58cb9\", repo tag \"registry.k8s.io/kube-proxy:v1.34.1\", repo digest \"registry.k8s.io/kube-proxy@sha256:913cc83ca0b5588a81d86ce8eedeb3ed1e9c1326e81852a1ea4f622b74ff749a\", size \"22788047\" in 1.683107708s" Nov 8 00:06:34.077376 containerd[2017]: time="2025-11-08T00:06:34.077346020Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.34.1\" returns image reference \"sha256:05baa95f5142d87797a2bc1d3d11edfb0bf0a9236d436243d15061fae8b58cb9\"" Nov 8 00:06:34.079989 containerd[2017]: time="2025-11-08T00:06:34.079924256Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Nov 8 00:06:34.085027 containerd[2017]: time="2025-11-08T00:06:34.084970304Z" level=info msg="CreateContainer within sandbox \"b9eae51ecdf068dfd88ebdf22634f7263343074b4051ffd4ed5ebda6996332a5\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 8 00:06:34.109300 containerd[2017]: time="2025-11-08T00:06:34.109191656Z" level=info msg="CreateContainer within sandbox \"b9eae51ecdf068dfd88ebdf22634f7263343074b4051ffd4ed5ebda6996332a5\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"a73dfd46ea0e5df553163ab06d76ce2a8c891e5bfca52747abaa8e60fced5410\"" Nov 8 00:06:34.110676 containerd[2017]: time="2025-11-08T00:06:34.110613872Z" level=info msg="StartContainer for \"a73dfd46ea0e5df553163ab06d76ce2a8c891e5bfca52747abaa8e60fced5410\"" Nov 8 00:06:34.171171 systemd[1]: Started cri-containerd-a73dfd46ea0e5df553163ab06d76ce2a8c891e5bfca52747abaa8e60fced5410.scope - libcontainer container a73dfd46ea0e5df553163ab06d76ce2a8c891e5bfca52747abaa8e60fced5410. Nov 8 00:06:34.223637 containerd[2017]: time="2025-11-08T00:06:34.223284825Z" level=info msg="StartContainer for \"a73dfd46ea0e5df553163ab06d76ce2a8c891e5bfca52747abaa8e60fced5410\" returns successfully" Nov 8 00:06:34.853087 kubelet[2459]: E1108 00:06:34.853025 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:35.418813 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2230375762.mount: Deactivated successfully. Nov 8 00:06:35.487921 containerd[2017]: time="2025-11-08T00:06:35.487767563Z" 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\"}" Nov 8 00:06:35.491526 containerd[2017]: time="2025-11-08T00:06:35.491461247Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Nov 8 00:06:35.494583 containerd[2017]: time="2025-11-08T00:06:35.494514167Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:35.500975 containerd[2017]: time="2025-11-08T00:06:35.500038127Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:35.502570 containerd[2017]: time="2025-11-08T00:06:35.502485983Z" 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.422493051s" Nov 8 00:06:35.502717 containerd[2017]: time="2025-11-08T00:06:35.502565711Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Nov 8 00:06:35.512060 containerd[2017]: time="2025-11-08T00:06:35.511997915Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 8 00:06:35.544998 containerd[2017]: time="2025-11-08T00:06:35.544933619Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45\"" Nov 8 00:06:35.546491 containerd[2017]: time="2025-11-08T00:06:35.546433499Z" level=info msg="StartContainer for \"9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45\"" Nov 8 00:06:35.602211 systemd[1]: Started cri-containerd-9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45.scope - libcontainer container 9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45. Nov 8 00:06:35.650944 containerd[2017]: time="2025-11-08T00:06:35.650725704Z" level=info msg="StartContainer for \"9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45\" returns successfully" Nov 8 00:06:35.653541 systemd[1]: cri-containerd-9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45.scope: Deactivated successfully. Nov 8 00:06:35.854129 kubelet[2459]: E1108 00:06:35.853982 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:35.862595 containerd[2017]: time="2025-11-08T00:06:35.862508149Z" level=info msg="shim disconnected" id=9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45 namespace=k8s.io Nov 8 00:06:35.862595 containerd[2017]: time="2025-11-08T00:06:35.862587433Z" level=warning msg="cleaning up after shim disconnected" id=9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45 namespace=k8s.io Nov 8 00:06:35.862595 containerd[2017]: time="2025-11-08T00:06:35.862612057Z" level=info msg="cleaning up dead shim" namespace=k8s.io Nov 8 00:06:36.138974 containerd[2017]: time="2025-11-08T00:06:36.138523930Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Nov 8 00:06:36.156511 kubelet[2459]: I1108 00:06:36.156281 2459 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-7kl99" podStartSLOduration=5.469458466 podStartE2EDuration="7.156262018s" podCreationTimestamp="2025-11-08 00:06:29 +0000 UTC" firstStartedPulling="2025-11-08 00:06:32.392090288 +0000 UTC m=+5.322635932" lastFinishedPulling="2025-11-08 00:06:34.078893768 +0000 UTC m=+7.009439484" observedRunningTime="2025-11-08 00:06:35.141694341 +0000 UTC m=+8.072240021" watchObservedRunningTime="2025-11-08 00:06:36.156262018 +0000 UTC m=+9.086807686" Nov 8 00:06:36.249542 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-9a12a860e0d9d74254a44bbc953e343e28f350db7c7b6cdb24484560496ddf45-rootfs.mount: Deactivated successfully. Nov 8 00:06:36.854908 kubelet[2459]: E1108 00:06:36.854815 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:37.855057 kubelet[2459]: E1108 00:06:37.855009 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:38.594201 containerd[2017]: time="2025-11-08T00:06:38.594112094Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:38.596071 containerd[2017]: time="2025-11-08T00:06:38.595971710Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Nov 8 00:06:38.598419 containerd[2017]: time="2025-11-08T00:06:38.597225950Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:38.606642 containerd[2017]: time="2025-11-08T00:06:38.606586490Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:38.608677 containerd[2017]: time="2025-11-08T00:06:38.608615870Z" 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.47003176s" Nov 8 00:06:38.608807 containerd[2017]: time="2025-11-08T00:06:38.608673710Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Nov 8 00:06:38.616182 containerd[2017]: time="2025-11-08T00:06:38.616107962Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 8 00:06:38.640869 containerd[2017]: time="2025-11-08T00:06:38.640774575Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8\"" Nov 8 00:06:38.641783 containerd[2017]: time="2025-11-08T00:06:38.641732871Z" level=info msg="StartContainer for \"3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8\"" Nov 8 00:06:38.696191 systemd[1]: Started cri-containerd-3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8.scope - libcontainer container 3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8. Nov 8 00:06:38.743918 systemd[1]: cri-containerd-3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8.scope: Deactivated successfully. Nov 8 00:06:38.749539 containerd[2017]: time="2025-11-08T00:06:38.749456271Z" level=info msg="StartContainer for \"3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8\" returns successfully" Nov 8 00:06:38.828035 kubelet[2459]: I1108 00:06:38.827985 2459 kubelet_node_status.go:439] "Fast updating node status as it just became ready" Nov 8 00:06:38.857353 kubelet[2459]: E1108 00:06:38.856524 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:38.895001 containerd[2017]: time="2025-11-08T00:06:38.894591064Z" level=info msg="shim disconnected" id=3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8 namespace=k8s.io Nov 8 00:06:38.895001 containerd[2017]: time="2025-11-08T00:06:38.894719296Z" level=warning msg="cleaning up after shim disconnected" id=3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8 namespace=k8s.io Nov 8 00:06:38.895001 containerd[2017]: time="2025-11-08T00:06:38.894739948Z" level=info msg="cleaning up dead shim" namespace=k8s.io Nov 8 00:06:39.149531 containerd[2017]: time="2025-11-08T00:06:39.149134009Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 8 00:06:39.167325 containerd[2017]: time="2025-11-08T00:06:39.167239141Z" level=info msg="CreateContainer within sandbox \"a85fe81290fa3a4fc3b9bf33fc14267f9faa68c5a65c5adc22f28a36a2ef7dd1\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"b749b6c0f13814a3ae7dbf94a9f75ee2a7dfcedc4cd95f9f5d8ebce50affeb14\"" Nov 8 00:06:39.169769 containerd[2017]: time="2025-11-08T00:06:39.168423421Z" level=info msg="StartContainer for \"b749b6c0f13814a3ae7dbf94a9f75ee2a7dfcedc4cd95f9f5d8ebce50affeb14\"" Nov 8 00:06:39.210214 systemd[1]: Started cri-containerd-b749b6c0f13814a3ae7dbf94a9f75ee2a7dfcedc4cd95f9f5d8ebce50affeb14.scope - libcontainer container b749b6c0f13814a3ae7dbf94a9f75ee2a7dfcedc4cd95f9f5d8ebce50affeb14. Nov 8 00:06:39.252901 containerd[2017]: time="2025-11-08T00:06:39.252796922Z" level=info msg="StartContainer for \"b749b6c0f13814a3ae7dbf94a9f75ee2a7dfcedc4cd95f9f5d8ebce50affeb14\" returns successfully" Nov 8 00:06:39.630283 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-3de4f4a2f449de67180f0c1deffaafea29a37949571ede46a52b65bdcaf077b8-rootfs.mount: Deactivated successfully. Nov 8 00:06:39.856755 kubelet[2459]: E1108 00:06:39.856682 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:40.170219 kubelet[2459]: I1108 00:06:40.170111 2459 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-trdjc" podStartSLOduration=4.964436604 podStartE2EDuration="11.170091362s" podCreationTimestamp="2025-11-08 00:06:29 +0000 UTC" firstStartedPulling="2025-11-08 00:06:32.405696032 +0000 UTC m=+5.336241676" lastFinishedPulling="2025-11-08 00:06:38.61135079 +0000 UTC m=+11.541896434" observedRunningTime="2025-11-08 00:06:40.169789154 +0000 UTC m=+13.100334798" watchObservedRunningTime="2025-11-08 00:06:40.170091362 +0000 UTC m=+13.100637006" Nov 8 00:06:40.365248 (udev-worker)[2972]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:06:40.377549 systemd-networkd[1938]: flannel.1: Link UP Nov 8 00:06:40.377572 systemd-networkd[1938]: flannel.1: Gained carrier Nov 8 00:06:40.857127 kubelet[2459]: E1108 00:06:40.857062 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:41.209520 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Nov 8 00:06:41.239665 systemd[1]: Created slice kubepods-besteffort-pod6653de52_7a64_4be7_a6b0_20ec0429bd87.slice - libcontainer container kubepods-besteffort-pod6653de52_7a64_4be7_a6b0_20ec0429bd87.slice. Nov 8 00:06:41.266444 kubelet[2459]: I1108 00:06:41.266384 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-xm5qt\" (UniqueName: \"kubernetes.io/projected/6653de52-7a64-4be7-a6b0-20ec0429bd87-kube-api-access-xm5qt\") pod \"nginx-deployment-bb8f74bfb-8nfzm\" (UID: \"6653de52-7a64-4be7-a6b0-20ec0429bd87\") " pod="default/nginx-deployment-bb8f74bfb-8nfzm" Nov 8 00:06:41.547931 containerd[2017]: time="2025-11-08T00:06:41.547749449Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-8nfzm,Uid:6653de52-7a64-4be7-a6b0-20ec0429bd87,Namespace:default,Attempt:0,}" Nov 8 00:06:41.591474 systemd-networkd[1938]: cni0: Link UP Nov 8 00:06:41.592705 systemd-networkd[1938]: cni0: Gained carrier Nov 8 00:06:41.595116 systemd-networkd[1938]: cni0: Lost carrier Nov 8 00:06:41.604766 systemd-networkd[1938]: vethdf85025b: Link UP Nov 8 00:06:41.604929 (udev-worker)[2973]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:06:41.612082 kernel: cni0: port 1(vethdf85025b) entered blocking state Nov 8 00:06:41.612201 kernel: cni0: port 1(vethdf85025b) entered disabled state Nov 8 00:06:41.615304 kernel: vethdf85025b: entered allmulticast mode Nov 8 00:06:41.615426 kernel: vethdf85025b: entered promiscuous mode Nov 8 00:06:41.619905 kernel: cni0: port 1(vethdf85025b) entered blocking state Nov 8 00:06:41.620008 kernel: cni0: port 1(vethdf85025b) entered forwarding state Nov 8 00:06:41.622909 kernel: cni0: port 1(vethdf85025b) entered disabled state Nov 8 00:06:41.643344 kernel: cni0: port 1(vethdf85025b) entered blocking state Nov 8 00:06:41.643487 kernel: cni0: port 1(vethdf85025b) entered forwarding state Nov 8 00:06:41.643711 systemd-networkd[1938]: vethdf85025b: Gained carrier Nov 8 00:06:41.644670 systemd-networkd[1938]: cni0: Gained carrier Nov 8 00:06:41.649463 containerd[2017]: 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"} Nov 8 00:06:41.649463 containerd[2017]: delegateAdd: netconf sent to delegate plugin: Nov 8 00:06:41.686695 containerd[2017]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2025-11-08T00:06:41.686234430Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 8 00:06:41.686695 containerd[2017]: time="2025-11-08T00:06:41.686356050Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 8 00:06:41.686695 containerd[2017]: time="2025-11-08T00:06:41.686394030Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:41.687542 containerd[2017]: time="2025-11-08T00:06:41.687376110Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:41.737156 systemd[1]: Started cri-containerd-8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6.scope - libcontainer container 8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6. Nov 8 00:06:41.796671 containerd[2017]: time="2025-11-08T00:06:41.796620522Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-bb8f74bfb-8nfzm,Uid:6653de52-7a64-4be7-a6b0-20ec0429bd87,Namespace:default,Attempt:0,} returns sandbox id \"8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6\"" Nov 8 00:06:41.799381 containerd[2017]: time="2025-11-08T00:06:41.799229634Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 8 00:06:41.857849 kubelet[2459]: E1108 00:06:41.857783 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:42.291183 systemd-networkd[1938]: flannel.1: Gained IPv6LL Nov 8 00:06:42.394453 systemd[1]: run-containerd-runc-k8s.io-8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6-runc.324zxA.mount: Deactivated successfully. Nov 8 00:06:42.803202 systemd-networkd[1938]: vethdf85025b: Gained IPv6LL Nov 8 00:06:42.858638 kubelet[2459]: E1108 00:06:42.858574 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:43.572554 systemd-networkd[1938]: cni0: Gained IPv6LL Nov 8 00:06:43.859218 kubelet[2459]: E1108 00:06:43.859033 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:44.859889 kubelet[2459]: E1108 00:06:44.859796 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:44.957519 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount953045265.mount: Deactivated successfully. Nov 8 00:06:45.860340 kubelet[2459]: E1108 00:06:45.860280 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:46.076419 ntpd[1994]: Listen normally on 7 flannel.1 192.168.1.0:123 Nov 8 00:06:46.077424 ntpd[1994]: 8 Nov 00:06:46 ntpd[1994]: Listen normally on 7 flannel.1 192.168.1.0:123 Nov 8 00:06:46.077424 ntpd[1994]: 8 Nov 00:06:46 ntpd[1994]: Listen normally on 8 cni0 192.168.1.1:123 Nov 8 00:06:46.077424 ntpd[1994]: 8 Nov 00:06:46 ntpd[1994]: Listen normally on 9 flannel.1 [fe80::944b:2eff:fe71:28fa%3]:123 Nov 8 00:06:46.077424 ntpd[1994]: 8 Nov 00:06:46 ntpd[1994]: Listen normally on 10 cni0 [fe80::5ca0:48ff:fe01:3515%4]:123 Nov 8 00:06:46.077424 ntpd[1994]: 8 Nov 00:06:46 ntpd[1994]: Listen normally on 11 vethdf85025b [fe80::2834:e7ff:fe12:e738%5]:123 Nov 8 00:06:46.076534 ntpd[1994]: Listen normally on 8 cni0 192.168.1.1:123 Nov 8 00:06:46.076632 ntpd[1994]: Listen normally on 9 flannel.1 [fe80::944b:2eff:fe71:28fa%3]:123 Nov 8 00:06:46.076715 ntpd[1994]: Listen normally on 10 cni0 [fe80::5ca0:48ff:fe01:3515%4]:123 Nov 8 00:06:46.076809 ntpd[1994]: Listen normally on 11 vethdf85025b [fe80::2834:e7ff:fe12:e738%5]:123 Nov 8 00:06:46.400550 containerd[2017]: time="2025-11-08T00:06:46.400470453Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:46.407237 containerd[2017]: time="2025-11-08T00:06:46.407177301Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=70017144" Nov 8 00:06:46.407639 containerd[2017]: time="2025-11-08T00:06:46.407596773Z" level=info msg="ImageCreate event name:\"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:46.412973 containerd[2017]: time="2025-11-08T00:06:46.412902249Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:46.415267 containerd[2017]: time="2025-11-08T00:06:46.415200117Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"70017022\" in 4.615906079s" Nov 8 00:06:46.415395 containerd[2017]: time="2025-11-08T00:06:46.415262565Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\"" Nov 8 00:06:46.421816 containerd[2017]: time="2025-11-08T00:06:46.421621197Z" level=info msg="CreateContainer within sandbox \"8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 8 00:06:46.438062 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1407321803.mount: Deactivated successfully. Nov 8 00:06:46.448001 containerd[2017]: time="2025-11-08T00:06:46.447926973Z" level=info msg="CreateContainer within sandbox \"8446f7de12fc300cfc21ad620ff90eaa90ea58a313153361d090f39759b4e0a6\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"71f07b54ee2b6d3a71f0f42a8d3db8f60c5ec276d43575d4ab5be118c97d62fb\"" Nov 8 00:06:46.448997 containerd[2017]: time="2025-11-08T00:06:46.448943013Z" level=info msg="StartContainer for \"71f07b54ee2b6d3a71f0f42a8d3db8f60c5ec276d43575d4ab5be118c97d62fb\"" Nov 8 00:06:46.500165 systemd[1]: Started cri-containerd-71f07b54ee2b6d3a71f0f42a8d3db8f60c5ec276d43575d4ab5be118c97d62fb.scope - libcontainer container 71f07b54ee2b6d3a71f0f42a8d3db8f60c5ec276d43575d4ab5be118c97d62fb. Nov 8 00:06:46.545722 containerd[2017]: time="2025-11-08T00:06:46.544674202Z" level=info msg="StartContainer for \"71f07b54ee2b6d3a71f0f42a8d3db8f60c5ec276d43575d4ab5be118c97d62fb\" returns successfully" Nov 8 00:06:46.860506 kubelet[2459]: E1108 00:06:46.860444 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:47.194396 kubelet[2459]: I1108 00:06:47.194137 2459 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-bb8f74bfb-8nfzm" podStartSLOduration=1.574917162 podStartE2EDuration="6.194105757s" podCreationTimestamp="2025-11-08 00:06:41 +0000 UTC" firstStartedPulling="2025-11-08 00:06:41.798305682 +0000 UTC m=+14.728851326" lastFinishedPulling="2025-11-08 00:06:46.417494289 +0000 UTC m=+19.348039921" observedRunningTime="2025-11-08 00:06:47.193193049 +0000 UTC m=+20.123738729" watchObservedRunningTime="2025-11-08 00:06:47.194105757 +0000 UTC m=+20.124651401" Nov 8 00:06:47.860685 kubelet[2459]: E1108 00:06:47.860619 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:48.847931 kubelet[2459]: E1108 00:06:48.847840 2459 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:48.861514 kubelet[2459]: E1108 00:06:48.861438 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:49.271703 systemd[1]: Created slice kubepods-besteffort-pod99ce5fff_08c8_49d2_a374_136703593181.slice - libcontainer container kubepods-besteffort-pod99ce5fff_08c8_49d2_a374_136703593181.slice. Nov 8 00:06:49.318657 kubelet[2459]: I1108 00:06:49.318599 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/99ce5fff-08c8-49d2-a374-136703593181-data\") pod \"nfs-server-provisioner-0\" (UID: \"99ce5fff-08c8-49d2-a374-136703593181\") " pod="default/nfs-server-provisioner-0" Nov 8 00:06:49.319105 kubelet[2459]: I1108 00:06:49.318970 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-sxhfc\" (UniqueName: \"kubernetes.io/projected/99ce5fff-08c8-49d2-a374-136703593181-kube-api-access-sxhfc\") pod \"nfs-server-provisioner-0\" (UID: \"99ce5fff-08c8-49d2-a374-136703593181\") " pod="default/nfs-server-provisioner-0" Nov 8 00:06:49.579242 containerd[2017]: time="2025-11-08T00:06:49.578596021Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:99ce5fff-08c8-49d2-a374-136703593181,Namespace:default,Attempt:0,}" Nov 8 00:06:49.617357 systemd-networkd[1938]: vetha0ab5f86: Link UP Nov 8 00:06:49.620941 kernel: cni0: port 2(vetha0ab5f86) entered blocking state Nov 8 00:06:49.621092 kernel: cni0: port 2(vetha0ab5f86) entered disabled state Nov 8 00:06:49.622277 kernel: vetha0ab5f86: entered allmulticast mode Nov 8 00:06:49.623717 kernel: vetha0ab5f86: entered promiscuous mode Nov 8 00:06:49.624265 (udev-worker)[3217]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:06:49.637545 kernel: cni0: port 2(vetha0ab5f86) entered blocking state Nov 8 00:06:49.637654 kernel: cni0: port 2(vetha0ab5f86) entered forwarding state Nov 8 00:06:49.636070 systemd-networkd[1938]: vetha0ab5f86: Gained carrier Nov 8 00:06:49.646663 containerd[2017]: 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"} Nov 8 00:06:49.646663 containerd[2017]: delegateAdd: netconf sent to delegate plugin: Nov 8 00:06:49.685504 containerd[2017]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2025-11-08T00:06:49.685340497Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 8 00:06:49.685504 containerd[2017]: time="2025-11-08T00:06:49.685451185Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 8 00:06:49.685899 containerd[2017]: time="2025-11-08T00:06:49.685718017Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:49.686350 containerd[2017]: time="2025-11-08T00:06:49.686128345Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:06:49.724241 systemd[1]: Started cri-containerd-a46fdba2ebfd02f83564a83f4e947ab0a4ec0223d1e0137b8bdc8df2986bd4eb.scope - libcontainer container a46fdba2ebfd02f83564a83f4e947ab0a4ec0223d1e0137b8bdc8df2986bd4eb. Nov 8 00:06:49.785692 containerd[2017]: time="2025-11-08T00:06:49.785626706Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:99ce5fff-08c8-49d2-a374-136703593181,Namespace:default,Attempt:0,} returns sandbox id \"a46fdba2ebfd02f83564a83f4e947ab0a4ec0223d1e0137b8bdc8df2986bd4eb\"" Nov 8 00:06:49.789292 containerd[2017]: time="2025-11-08T00:06:49.789181106Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 8 00:06:49.862567 kubelet[2459]: E1108 00:06:49.862393 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:50.863496 kubelet[2459]: E1108 00:06:50.863432 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:51.317406 systemd-networkd[1938]: vetha0ab5f86: Gained IPv6LL Nov 8 00:06:51.864452 kubelet[2459]: E1108 00:06:51.864363 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:52.304668 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1882986415.mount: Deactivated successfully. Nov 8 00:06:52.864836 kubelet[2459]: E1108 00:06:52.864745 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:53.865730 kubelet[2459]: E1108 00:06:53.865685 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:54.076025 ntpd[1994]: Listen normally on 12 vetha0ab5f86 [fe80::b4d6:18ff:fea3:cd77%6]:123 Nov 8 00:06:54.077435 ntpd[1994]: 8 Nov 00:06:54 ntpd[1994]: Listen normally on 12 vetha0ab5f86 [fe80::b4d6:18ff:fea3:cd77%6]:123 Nov 8 00:06:54.867830 kubelet[2459]: E1108 00:06:54.867759 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:55.033928 update_engine[2001]: I20251108 00:06:55.032898 2001 update_attempter.cc:509] Updating boot flags... Nov 8 00:06:55.218484 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (3368) Nov 8 00:06:55.702144 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (3369) Nov 8 00:06:55.869354 kubelet[2459]: E1108 00:06:55.869293 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:55.961973 containerd[2017]: time="2025-11-08T00:06:55.960091533Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:55.965902 containerd[2017]: time="2025-11-08T00:06:55.965459277Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373623" Nov 8 00:06:55.969898 containerd[2017]: time="2025-11-08T00:06:55.969194757Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:55.980918 containerd[2017]: time="2025-11-08T00:06:55.980776101Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:06:55.986057 containerd[2017]: time="2025-11-08T00:06:55.985985541Z" 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.196682095s" Nov 8 00:06:55.986201 containerd[2017]: time="2025-11-08T00:06:55.986063385Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Nov 8 00:06:55.999012 containerd[2017]: time="2025-11-08T00:06:55.998316405Z" level=info msg="CreateContainer within sandbox \"a46fdba2ebfd02f83564a83f4e947ab0a4ec0223d1e0137b8bdc8df2986bd4eb\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 8 00:06:56.027721 containerd[2017]: time="2025-11-08T00:06:56.027640793Z" level=info msg="CreateContainer within sandbox \"a46fdba2ebfd02f83564a83f4e947ab0a4ec0223d1e0137b8bdc8df2986bd4eb\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843\"" Nov 8 00:06:56.028839 containerd[2017]: time="2025-11-08T00:06:56.028784069Z" level=info msg="StartContainer for \"5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843\"" Nov 8 00:06:56.079561 systemd[1]: run-containerd-runc-k8s.io-5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843-runc.V0VwMr.mount: Deactivated successfully. Nov 8 00:06:56.091213 systemd[1]: Started cri-containerd-5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843.scope - libcontainer container 5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843. Nov 8 00:06:56.142215 containerd[2017]: time="2025-11-08T00:06:56.142144878Z" level=info msg="StartContainer for \"5bbd098ee82e3cd85f6438ff707e24d523921eb5f67b9c5e7a9eea6ebb590843\" returns successfully" Nov 8 00:06:56.869655 kubelet[2459]: E1108 00:06:56.869586 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:57.870084 kubelet[2459]: E1108 00:06:57.869995 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:58.871057 kubelet[2459]: E1108 00:06:58.870994 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:06:59.871729 kubelet[2459]: E1108 00:06:59.871646 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:00.872102 kubelet[2459]: E1108 00:07:00.872038 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:01.578438 kubelet[2459]: I1108 00:07:01.578231 2459 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.378204174 podStartE2EDuration="12.578208469s" podCreationTimestamp="2025-11-08 00:06:49 +0000 UTC" firstStartedPulling="2025-11-08 00:06:49.788466518 +0000 UTC m=+22.719012162" lastFinishedPulling="2025-11-08 00:06:55.988470813 +0000 UTC m=+28.919016457" observedRunningTime="2025-11-08 00:06:56.233378106 +0000 UTC m=+29.163923786" watchObservedRunningTime="2025-11-08 00:07:01.578208469 +0000 UTC m=+34.508754101" Nov 8 00:07:01.593665 systemd[1]: Created slice kubepods-besteffort-pod20d3763b_5d5b_4627_9b2b_aead4ecedace.slice - libcontainer container kubepods-besteffort-pod20d3763b_5d5b_4627_9b2b_aead4ecedace.slice. Nov 8 00:07:01.707435 kubelet[2459]: I1108 00:07:01.707077 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-aaadadfb-c083-4a0d-83f3-4f345499e4f2\" (UniqueName: \"kubernetes.io/nfs/20d3763b-5d5b-4627-9b2b-aead4ecedace-pvc-aaadadfb-c083-4a0d-83f3-4f345499e4f2\") pod \"test-pod-1\" (UID: \"20d3763b-5d5b-4627-9b2b-aead4ecedace\") " pod="default/test-pod-1" Nov 8 00:07:01.707435 kubelet[2459]: I1108 00:07:01.707315 2459 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-brnvz\" (UniqueName: \"kubernetes.io/projected/20d3763b-5d5b-4627-9b2b-aead4ecedace-kube-api-access-brnvz\") pod \"test-pod-1\" (UID: \"20d3763b-5d5b-4627-9b2b-aead4ecedace\") " pod="default/test-pod-1" Nov 8 00:07:01.848914 kernel: FS-Cache: Loaded Nov 8 00:07:01.872464 kubelet[2459]: E1108 00:07:01.872387 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:01.892567 kernel: RPC: Registered named UNIX socket transport module. Nov 8 00:07:01.892744 kernel: RPC: Registered udp transport module. Nov 8 00:07:01.892795 kernel: RPC: Registered tcp transport module. Nov 8 00:07:01.894689 kernel: RPC: Registered tcp-with-tls transport module. Nov 8 00:07:01.894747 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 8 00:07:02.219511 kernel: NFS: Registering the id_resolver key type Nov 8 00:07:02.219646 kernel: Key type id_resolver registered Nov 8 00:07:02.219706 kernel: Key type id_legacy registered Nov 8 00:07:02.257459 nfsidmap[3658]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Nov 8 00:07:02.263785 nfsidmap[3659]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Nov 8 00:07:02.503466 containerd[2017]: time="2025-11-08T00:07:02.502949725Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:20d3763b-5d5b-4627-9b2b-aead4ecedace,Namespace:default,Attempt:0,}" Nov 8 00:07:02.552265 systemd-networkd[1938]: vethe1579210: Link UP Nov 8 00:07:02.554539 kernel: cni0: port 3(vethe1579210) entered blocking state Nov 8 00:07:02.554619 kernel: cni0: port 3(vethe1579210) entered disabled state Nov 8 00:07:02.555929 kernel: vethe1579210: entered allmulticast mode Nov 8 00:07:02.557303 kernel: vethe1579210: entered promiscuous mode Nov 8 00:07:02.558704 (udev-worker)[3645]: Network interface NamePolicy= disabled on kernel command line. Nov 8 00:07:02.570723 kernel: cni0: port 3(vethe1579210) entered blocking state Nov 8 00:07:02.570842 kernel: cni0: port 3(vethe1579210) entered forwarding state Nov 8 00:07:02.570383 systemd-networkd[1938]: vethe1579210: Gained carrier Nov 8 00:07:02.577817 containerd[2017]: 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"} Nov 8 00:07:02.577817 containerd[2017]: delegateAdd: netconf sent to delegate plugin: Nov 8 00:07:02.615975 containerd[2017]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2025-11-08T00:07:02.615496094Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 8 00:07:02.615975 containerd[2017]: time="2025-11-08T00:07:02.615579638Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 8 00:07:02.615975 containerd[2017]: time="2025-11-08T00:07:02.615604334Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:07:02.615975 containerd[2017]: time="2025-11-08T00:07:02.615738290Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 8 00:07:02.645509 systemd[1]: Started cri-containerd-43eeac2a01ccfefd249c430bdf0df68373434c71143bdcf1965ebe7431da0d85.scope - libcontainer container 43eeac2a01ccfefd249c430bdf0df68373434c71143bdcf1965ebe7431da0d85. Nov 8 00:07:02.710250 containerd[2017]: time="2025-11-08T00:07:02.710197586Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:20d3763b-5d5b-4627-9b2b-aead4ecedace,Namespace:default,Attempt:0,} returns sandbox id \"43eeac2a01ccfefd249c430bdf0df68373434c71143bdcf1965ebe7431da0d85\"" Nov 8 00:07:02.713158 containerd[2017]: time="2025-11-08T00:07:02.712819466Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 8 00:07:02.873179 kubelet[2459]: E1108 00:07:02.873046 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:03.038921 containerd[2017]: time="2025-11-08T00:07:03.038303772Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Nov 8 00:07:03.040393 containerd[2017]: time="2025-11-08T00:07:03.040322580Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Nov 8 00:07:03.046192 containerd[2017]: time="2025-11-08T00:07:03.046116504Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90\", size \"70017022\" in 333.205082ms" Nov 8 00:07:03.046192 containerd[2017]: time="2025-11-08T00:07:03.046181520Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\"" Nov 8 00:07:03.054448 containerd[2017]: time="2025-11-08T00:07:03.054390564Z" level=info msg="CreateContainer within sandbox \"43eeac2a01ccfefd249c430bdf0df68373434c71143bdcf1965ebe7431da0d85\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 8 00:07:03.083607 containerd[2017]: time="2025-11-08T00:07:03.083529516Z" level=info msg="CreateContainer within sandbox \"43eeac2a01ccfefd249c430bdf0df68373434c71143bdcf1965ebe7431da0d85\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"3dcc397459109d2211cd44dfea3b127452428b24bc8e265f5a14f3af0baac916\"" Nov 8 00:07:03.084880 containerd[2017]: time="2025-11-08T00:07:03.084760920Z" level=info msg="StartContainer for \"3dcc397459109d2211cd44dfea3b127452428b24bc8e265f5a14f3af0baac916\"" Nov 8 00:07:03.144196 systemd[1]: Started cri-containerd-3dcc397459109d2211cd44dfea3b127452428b24bc8e265f5a14f3af0baac916.scope - libcontainer container 3dcc397459109d2211cd44dfea3b127452428b24bc8e265f5a14f3af0baac916. Nov 8 00:07:03.198243 containerd[2017]: time="2025-11-08T00:07:03.198179353Z" level=info msg="StartContainer for \"3dcc397459109d2211cd44dfea3b127452428b24bc8e265f5a14f3af0baac916\" returns successfully" Nov 8 00:07:03.874247 kubelet[2459]: E1108 00:07:03.874169 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:04.179259 systemd-networkd[1938]: vethe1579210: Gained IPv6LL Nov 8 00:07:04.874792 kubelet[2459]: E1108 00:07:04.874717 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:05.875566 kubelet[2459]: E1108 00:07:05.875487 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:06.875892 kubelet[2459]: E1108 00:07:06.875811 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:07.876563 kubelet[2459]: E1108 00:07:07.876499 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:08.076082 ntpd[1994]: Listen normally on 13 vethe1579210 [fe80::f064:39ff:feff:7f31%7]:123 Nov 8 00:07:08.076639 ntpd[1994]: 8 Nov 00:07:08 ntpd[1994]: Listen normally on 13 vethe1579210 [fe80::f064:39ff:feff:7f31%7]:123 Nov 8 00:07:08.848343 kubelet[2459]: E1108 00:07:08.848284 2459 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:08.877021 kubelet[2459]: E1108 00:07:08.876975 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:09.878119 kubelet[2459]: E1108 00:07:09.878058 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:10.878440 kubelet[2459]: E1108 00:07:10.878376 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:11.879522 kubelet[2459]: E1108 00:07:11.879451 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:12.880009 kubelet[2459]: E1108 00:07:12.879936 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:13.880666 kubelet[2459]: E1108 00:07:13.880599 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:14.881681 kubelet[2459]: E1108 00:07:14.881624 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:15.882180 kubelet[2459]: E1108 00:07:15.882114 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:16.883356 kubelet[2459]: E1108 00:07:16.883289 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:17.884365 kubelet[2459]: E1108 00:07:17.884300 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:18.885009 kubelet[2459]: E1108 00:07:18.884936 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:19.885826 kubelet[2459]: E1108 00:07:19.885758 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:20.886480 kubelet[2459]: E1108 00:07:20.886416 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:21.887600 kubelet[2459]: E1108 00:07:21.887533 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:22.888406 kubelet[2459]: E1108 00:07:22.888341 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:23.889087 kubelet[2459]: E1108 00:07:23.889011 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:24.889511 kubelet[2459]: E1108 00:07:24.889446 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:25.889829 kubelet[2459]: E1108 00:07:25.889766 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:26.890805 kubelet[2459]: E1108 00:07:26.890740 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:27.891070 kubelet[2459]: E1108 00:07:27.891009 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:28.848421 kubelet[2459]: E1108 00:07:28.848348 2459 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:28.891748 kubelet[2459]: E1108 00:07:28.891691 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:29.892641 kubelet[2459]: E1108 00:07:29.892563 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:30.171323 kubelet[2459]: E1108 00:07:30.171162 2459 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.28.188)" Nov 8 00:07:30.893034 kubelet[2459]: E1108 00:07:30.892969 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:31.893182 kubelet[2459]: E1108 00:07:31.893104 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:32.893324 kubelet[2459]: E1108 00:07:32.893243 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:33.893629 kubelet[2459]: E1108 00:07:33.893554 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:34.894579 kubelet[2459]: E1108 00:07:34.894503 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:35.895558 kubelet[2459]: E1108 00:07:35.895489 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:36.896699 kubelet[2459]: E1108 00:07:36.896567 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:37.897269 kubelet[2459]: E1108 00:07:37.897201 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:38.898017 kubelet[2459]: E1108 00:07:38.897948 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:39.898977 kubelet[2459]: E1108 00:07:39.898899 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:40.168430 kubelet[2459]: E1108 00:07:40.168256 2459 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.28.188)" Nov 8 00:07:40.899439 kubelet[2459]: E1108 00:07:40.899392 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:41.900616 kubelet[2459]: E1108 00:07:41.900551 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:42.901298 kubelet[2459]: E1108 00:07:42.901225 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:43.902217 kubelet[2459]: E1108 00:07:43.902153 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:44.903085 kubelet[2459]: E1108 00:07:44.903019 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:45.903793 kubelet[2459]: E1108 00:07:45.903725 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:46.904851 kubelet[2459]: E1108 00:07:46.904771 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:47.905500 kubelet[2459]: E1108 00:07:47.905434 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:48.847719 kubelet[2459]: E1108 00:07:48.847646 2459 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:48.906715 kubelet[2459]: E1108 00:07:48.906647 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:49.907015 kubelet[2459]: E1108 00:07:49.906946 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:50.166140 kubelet[2459]: E1108 00:07:50.165953 2459 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.28.188)" Nov 8 00:07:50.907760 kubelet[2459]: E1108 00:07:50.907694 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:51.908177 kubelet[2459]: E1108 00:07:51.908102 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:52.908665 kubelet[2459]: E1108 00:07:52.908592 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:53.909611 kubelet[2459]: E1108 00:07:53.909545 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:54.910562 kubelet[2459]: E1108 00:07:54.910498 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:55.911616 kubelet[2459]: E1108 00:07:55.911556 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:56.495374 kubelet[2459]: E1108 00:07:56.493796 2459 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": unexpected EOF" Nov 8 00:07:56.499330 kubelet[2459]: E1108 00:07:56.499069 2459 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": dial tcp 172.31.25.26:6443: connect: connection refused" Nov 8 00:07:56.499330 kubelet[2459]: I1108 00:07:56.499150 2459 controller.go:115] "failed to update lease using latest lease, fallback to ensure lease" err="failed 5 attempts to update lease" Nov 8 00:07:56.500154 kubelet[2459]: E1108 00:07:56.500094 2459 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": dial tcp 172.31.25.26:6443: connect: connection refused" interval="200ms" Nov 8 00:07:56.701689 kubelet[2459]: E1108 00:07:56.701620 2459 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": dial tcp 172.31.25.26:6443: connect: connection refused" interval="400ms" Nov 8 00:07:56.912391 kubelet[2459]: E1108 00:07:56.912332 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:57.102515 kubelet[2459]: E1108 00:07:57.102438 2459 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": dial tcp 172.31.25.26:6443: connect: connection refused" interval="800ms" Nov 8 00:07:57.912558 kubelet[2459]: E1108 00:07:57.912500 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:58.913086 kubelet[2459]: E1108 00:07:58.913024 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:07:59.913886 kubelet[2459]: E1108 00:07:59.913788 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:00.914953 kubelet[2459]: E1108 00:08:00.914849 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:01.915260 kubelet[2459]: E1108 00:08:01.915191 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:02.915817 kubelet[2459]: E1108 00:08:02.915757 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:03.916387 kubelet[2459]: E1108 00:08:03.916324 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:04.917204 kubelet[2459]: E1108 00:08:04.917141 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:05.918079 kubelet[2459]: E1108 00:08:05.918014 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:06.918612 kubelet[2459]: E1108 00:08:06.918548 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:07.903953 kubelet[2459]: E1108 00:08:07.903849 2459 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.26:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.28.188?timeout=10s\": net/http: request canceled while waiting for connection (Client.Timeout exceeded while awaiting headers)" interval="1.6s" Nov 8 00:08:07.919033 kubelet[2459]: E1108 00:08:07.918971 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:08.848105 kubelet[2459]: E1108 00:08:08.848045 2459 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:08.919141 kubelet[2459]: E1108 00:08:08.919088 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:09.919547 kubelet[2459]: E1108 00:08:09.919463 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:10.920583 kubelet[2459]: E1108 00:08:10.920504 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:11.921760 kubelet[2459]: E1108 00:08:11.921692 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:12.922936 kubelet[2459]: E1108 00:08:12.922849 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 8 00:08:13.923396 kubelet[2459]: E1108 00:08:13.923326 2459 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"