Apr 24 23:37:34.308372 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Apr 24 23:37:34.308420 kernel: Linux version 6.6.127-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Apr 24 22:19:35 -00 2026 Apr 24 23:37:34.308447 kernel: KASLR disabled due to lack of seed Apr 24 23:37:34.308464 kernel: efi: EFI v2.7 by EDK II Apr 24 23:37:34.308481 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b001a98 MEMRESERVE=0x7852ee18 Apr 24 23:37:34.308497 kernel: ACPI: Early table checksum verification disabled Apr 24 23:37:34.308514 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Apr 24 23:37:34.308530 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Apr 24 23:37:34.308547 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Apr 24 23:37:34.308563 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Apr 24 23:37:34.311666 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Apr 24 23:37:34.311699 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Apr 24 23:37:34.311717 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Apr 24 23:37:34.311737 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Apr 24 23:37:34.311757 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Apr 24 23:37:34.311787 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Apr 24 23:37:34.311806 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Apr 24 23:37:34.311824 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Apr 24 23:37:34.311842 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Apr 24 23:37:34.311861 kernel: printk: bootconsole [uart0] enabled Apr 24 23:37:34.311882 kernel: NUMA: Failed to initialise from firmware Apr 24 23:37:34.311900 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Apr 24 23:37:34.311918 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Apr 24 23:37:34.311937 kernel: Zone ranges: Apr 24 23:37:34.311954 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Apr 24 23:37:34.311977 kernel: DMA32 empty Apr 24 23:37:34.312002 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Apr 24 23:37:34.312020 kernel: Movable zone start for each node Apr 24 23:37:34.312038 kernel: Early memory node ranges Apr 24 23:37:34.312056 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Apr 24 23:37:34.312075 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Apr 24 23:37:34.312093 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Apr 24 23:37:34.312111 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Apr 24 23:37:34.312128 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Apr 24 23:37:34.312146 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Apr 24 23:37:34.312164 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Apr 24 23:37:34.312183 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Apr 24 23:37:34.312201 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Apr 24 23:37:34.312224 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Apr 24 23:37:34.312243 kernel: psci: probing for conduit method from ACPI. Apr 24 23:37:34.312268 kernel: psci: PSCIv1.0 detected in firmware. Apr 24 23:37:34.312288 kernel: psci: Using standard PSCI v0.2 function IDs Apr 24 23:37:34.312306 kernel: psci: Trusted OS migration not required Apr 24 23:37:34.312330 kernel: psci: SMC Calling Convention v1.1 Apr 24 23:37:34.312348 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Apr 24 23:37:34.312368 kernel: percpu: Embedded 30 pages/cpu s85736 r8192 d28952 u122880 Apr 24 23:37:34.312387 kernel: pcpu-alloc: s85736 r8192 d28952 u122880 alloc=30*4096 Apr 24 23:37:34.312406 kernel: pcpu-alloc: [0] 0 [0] 1 Apr 24 23:37:34.312425 kernel: Detected PIPT I-cache on CPU0 Apr 24 23:37:34.312444 kernel: CPU features: detected: GIC system register CPU interface Apr 24 23:37:34.312463 kernel: CPU features: detected: Spectre-v2 Apr 24 23:37:34.312483 kernel: CPU features: detected: Spectre-v3a Apr 24 23:37:34.312503 kernel: CPU features: detected: Spectre-BHB Apr 24 23:37:34.312521 kernel: CPU features: detected: ARM erratum 1742098 Apr 24 23:37:34.312546 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Apr 24 23:37:34.312564 kernel: alternatives: applying boot alternatives Apr 24 23:37:34.312622 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=63304dd98a277d4592d17e0085ae3f91ca70cc8ec6dedfdd357a1e9755f9a8b3 Apr 24 23:37:34.312645 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Apr 24 23:37:34.312664 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Apr 24 23:37:34.312681 kernel: Fallback order for Node 0: 0 Apr 24 23:37:34.312700 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Apr 24 23:37:34.312718 kernel: Policy zone: Normal Apr 24 23:37:34.312736 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Apr 24 23:37:34.312754 kernel: software IO TLB: area num 2. Apr 24 23:37:34.312772 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Apr 24 23:37:34.312800 kernel: Memory: 3820096K/4030464K available (10304K kernel code, 2180K rwdata, 8116K rodata, 39424K init, 897K bss, 210368K reserved, 0K cma-reserved) Apr 24 23:37:34.312818 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Apr 24 23:37:34.312837 kernel: rcu: Preemptible hierarchical RCU implementation. Apr 24 23:37:34.312856 kernel: rcu: RCU event tracing is enabled. Apr 24 23:37:34.312874 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Apr 24 23:37:34.312893 kernel: Trampoline variant of Tasks RCU enabled. Apr 24 23:37:34.312911 kernel: Tracing variant of Tasks RCU enabled. Apr 24 23:37:34.312929 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Apr 24 23:37:34.312948 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Apr 24 23:37:34.312966 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Apr 24 23:37:34.313004 kernel: GICv3: 96 SPIs implemented Apr 24 23:37:34.313035 kernel: GICv3: 0 Extended SPIs implemented Apr 24 23:37:34.313054 kernel: Root IRQ handler: gic_handle_irq Apr 24 23:37:34.313072 kernel: GICv3: GICv3 features: 16 PPIs Apr 24 23:37:34.313091 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Apr 24 23:37:34.313109 kernel: ITS [mem 0x10080000-0x1009ffff] Apr 24 23:37:34.313128 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Apr 24 23:37:34.313147 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Apr 24 23:37:34.313166 kernel: GICv3: using LPI property table @0x00000004000d0000 Apr 24 23:37:34.313185 kernel: ITS: Using hypervisor restricted LPI range [128] Apr 24 23:37:34.313203 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Apr 24 23:37:34.313221 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Apr 24 23:37:34.313239 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Apr 24 23:37:34.313264 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Apr 24 23:37:34.313282 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Apr 24 23:37:34.313301 kernel: Console: colour dummy device 80x25 Apr 24 23:37:34.313320 kernel: printk: console [tty1] enabled Apr 24 23:37:34.313338 kernel: ACPI: Core revision 20230628 Apr 24 23:37:34.313357 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Apr 24 23:37:34.313375 kernel: pid_max: default: 32768 minimum: 301 Apr 24 23:37:34.313394 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Apr 24 23:37:34.313412 kernel: landlock: Up and running. Apr 24 23:37:34.313434 kernel: SELinux: Initializing. Apr 24 23:37:34.313453 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 24 23:37:34.313471 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Apr 24 23:37:34.313490 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 24 23:37:34.313509 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Apr 24 23:37:34.313527 kernel: rcu: Hierarchical SRCU implementation. Apr 24 23:37:34.313545 kernel: rcu: Max phase no-delay instances is 400. Apr 24 23:37:34.313564 kernel: Platform MSI: ITS@0x10080000 domain created Apr 24 23:37:34.314652 kernel: PCI/MSI: ITS@0x10080000 domain created Apr 24 23:37:34.314698 kernel: Remapping and enabling EFI services. Apr 24 23:37:34.314718 kernel: smp: Bringing up secondary CPUs ... Apr 24 23:37:34.314736 kernel: Detected PIPT I-cache on CPU1 Apr 24 23:37:34.314755 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Apr 24 23:37:34.314773 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Apr 24 23:37:34.314792 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Apr 24 23:37:34.314810 kernel: smp: Brought up 1 node, 2 CPUs Apr 24 23:37:34.314828 kernel: SMP: Total of 2 processors activated. Apr 24 23:37:34.314846 kernel: CPU features: detected: 32-bit EL0 Support Apr 24 23:37:34.314870 kernel: CPU features: detected: 32-bit EL1 Support Apr 24 23:37:34.314889 kernel: CPU features: detected: CRC32 instructions Apr 24 23:37:34.314908 kernel: CPU: All CPU(s) started at EL1 Apr 24 23:37:34.314938 kernel: alternatives: applying system-wide alternatives Apr 24 23:37:34.314963 kernel: devtmpfs: initialized Apr 24 23:37:34.314983 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Apr 24 23:37:34.315002 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Apr 24 23:37:34.315021 kernel: pinctrl core: initialized pinctrl subsystem Apr 24 23:37:34.315041 kernel: SMBIOS 3.0.0 present. Apr 24 23:37:34.315066 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Apr 24 23:37:34.315087 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Apr 24 23:37:34.315106 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Apr 24 23:37:34.315125 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Apr 24 23:37:34.315145 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Apr 24 23:37:34.315163 kernel: audit: initializing netlink subsys (disabled) Apr 24 23:37:34.315182 kernel: audit: type=2000 audit(0.299:1): state=initialized audit_enabled=0 res=1 Apr 24 23:37:34.315201 kernel: thermal_sys: Registered thermal governor 'step_wise' Apr 24 23:37:34.315225 kernel: cpuidle: using governor menu Apr 24 23:37:34.315244 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Apr 24 23:37:34.315263 kernel: ASID allocator initialised with 65536 entries Apr 24 23:37:34.315282 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Apr 24 23:37:34.315301 kernel: Serial: AMBA PL011 UART driver Apr 24 23:37:34.315320 kernel: Modules: 17488 pages in range for non-PLT usage Apr 24 23:37:34.315339 kernel: Modules: 509008 pages in range for PLT usage Apr 24 23:37:34.315358 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Apr 24 23:37:34.315377 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Apr 24 23:37:34.315401 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Apr 24 23:37:34.315420 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Apr 24 23:37:34.315439 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Apr 24 23:37:34.315458 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Apr 24 23:37:34.315477 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Apr 24 23:37:34.315496 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Apr 24 23:37:34.315515 kernel: ACPI: Added _OSI(Module Device) Apr 24 23:37:34.315534 kernel: ACPI: Added _OSI(Processor Device) Apr 24 23:37:34.315553 kernel: ACPI: Added _OSI(Processor Aggregator Device) Apr 24 23:37:34.315605 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Apr 24 23:37:34.315638 kernel: ACPI: Interpreter enabled Apr 24 23:37:34.319029 kernel: ACPI: Using GIC for interrupt routing Apr 24 23:37:34.319070 kernel: ACPI: MCFG table detected, 1 entries Apr 24 23:37:34.319090 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Apr 24 23:37:34.319448 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Apr 24 23:37:34.319713 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Apr 24 23:37:34.319940 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Apr 24 23:37:34.320182 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Apr 24 23:37:34.320415 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Apr 24 23:37:34.320444 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Apr 24 23:37:34.320465 kernel: acpiphp: Slot [1] registered Apr 24 23:37:34.320484 kernel: acpiphp: Slot [2] registered Apr 24 23:37:34.320504 kernel: acpiphp: Slot [3] registered Apr 24 23:37:34.320522 kernel: acpiphp: Slot [4] registered Apr 24 23:37:34.320542 kernel: acpiphp: Slot [5] registered Apr 24 23:37:34.320569 kernel: acpiphp: Slot [6] registered Apr 24 23:37:34.320650 kernel: acpiphp: Slot [7] registered Apr 24 23:37:34.320673 kernel: acpiphp: Slot [8] registered Apr 24 23:37:34.320693 kernel: acpiphp: Slot [9] registered Apr 24 23:37:34.320712 kernel: acpiphp: Slot [10] registered Apr 24 23:37:34.320731 kernel: acpiphp: Slot [11] registered Apr 24 23:37:34.320749 kernel: acpiphp: Slot [12] registered Apr 24 23:37:34.320768 kernel: acpiphp: Slot [13] registered Apr 24 23:37:34.320787 kernel: acpiphp: Slot [14] registered Apr 24 23:37:34.320805 kernel: acpiphp: Slot [15] registered Apr 24 23:37:34.320832 kernel: acpiphp: Slot [16] registered Apr 24 23:37:34.320850 kernel: acpiphp: Slot [17] registered Apr 24 23:37:34.320869 kernel: acpiphp: Slot [18] registered Apr 24 23:37:34.320888 kernel: acpiphp: Slot [19] registered Apr 24 23:37:34.320906 kernel: acpiphp: Slot [20] registered Apr 24 23:37:34.320925 kernel: acpiphp: Slot [21] registered Apr 24 23:37:34.320945 kernel: acpiphp: Slot [22] registered Apr 24 23:37:34.320964 kernel: acpiphp: Slot [23] registered Apr 24 23:37:34.321000 kernel: acpiphp: Slot [24] registered Apr 24 23:37:34.321030 kernel: acpiphp: Slot [25] registered Apr 24 23:37:34.321050 kernel: acpiphp: Slot [26] registered Apr 24 23:37:34.321069 kernel: acpiphp: Slot [27] registered Apr 24 23:37:34.321089 kernel: acpiphp: Slot [28] registered Apr 24 23:37:34.321109 kernel: acpiphp: Slot [29] registered Apr 24 23:37:34.321128 kernel: acpiphp: Slot [30] registered Apr 24 23:37:34.321147 kernel: acpiphp: Slot [31] registered Apr 24 23:37:34.321166 kernel: PCI host bridge to bus 0000:00 Apr 24 23:37:34.321450 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Apr 24 23:37:34.321718 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Apr 24 23:37:34.321919 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Apr 24 23:37:34.322113 kernel: pci_bus 0000:00: root bus resource [bus 00] Apr 24 23:37:34.322364 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Apr 24 23:37:34.322660 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Apr 24 23:37:34.322890 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Apr 24 23:37:34.323148 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Apr 24 23:37:34.323377 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Apr 24 23:37:34.323624 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 24 23:37:34.323863 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Apr 24 23:37:34.324111 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Apr 24 23:37:34.324341 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Apr 24 23:37:34.324565 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Apr 24 23:37:34.324850 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Apr 24 23:37:34.325086 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Apr 24 23:37:34.325289 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Apr 24 23:37:34.325487 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Apr 24 23:37:34.325514 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Apr 24 23:37:34.325534 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Apr 24 23:37:34.325554 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Apr 24 23:37:34.325573 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Apr 24 23:37:34.325782 kernel: iommu: Default domain type: Translated Apr 24 23:37:34.325804 kernel: iommu: DMA domain TLB invalidation policy: strict mode Apr 24 23:37:34.325824 kernel: efivars: Registered efivars operations Apr 24 23:37:34.325843 kernel: vgaarb: loaded Apr 24 23:37:34.325863 kernel: clocksource: Switched to clocksource arch_sys_counter Apr 24 23:37:34.325882 kernel: VFS: Disk quotas dquot_6.6.0 Apr 24 23:37:34.325901 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Apr 24 23:37:34.325920 kernel: pnp: PnP ACPI init Apr 24 23:37:34.326181 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Apr 24 23:37:34.326216 kernel: pnp: PnP ACPI: found 1 devices Apr 24 23:37:34.326236 kernel: NET: Registered PF_INET protocol family Apr 24 23:37:34.326256 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Apr 24 23:37:34.326275 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Apr 24 23:37:34.326294 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Apr 24 23:37:34.326313 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Apr 24 23:37:34.326332 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Apr 24 23:37:34.326351 kernel: TCP: Hash tables configured (established 32768 bind 32768) Apr 24 23:37:34.326374 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 24 23:37:34.326394 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Apr 24 23:37:34.326413 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Apr 24 23:37:34.326432 kernel: PCI: CLS 0 bytes, default 64 Apr 24 23:37:34.326450 kernel: kvm [1]: HYP mode not available Apr 24 23:37:34.326469 kernel: Initialise system trusted keyrings Apr 24 23:37:34.326488 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Apr 24 23:37:34.326506 kernel: Key type asymmetric registered Apr 24 23:37:34.326525 kernel: Asymmetric key parser 'x509' registered Apr 24 23:37:34.326548 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Apr 24 23:37:34.326568 kernel: io scheduler mq-deadline registered Apr 24 23:37:34.326637 kernel: io scheduler kyber registered Apr 24 23:37:34.326662 kernel: io scheduler bfq registered Apr 24 23:37:34.326897 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Apr 24 23:37:34.326926 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Apr 24 23:37:34.326946 kernel: ACPI: button: Power Button [PWRB] Apr 24 23:37:34.326965 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Apr 24 23:37:34.326984 kernel: ACPI: button: Sleep Button [SLPB] Apr 24 23:37:34.327010 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Apr 24 23:37:34.327031 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Apr 24 23:37:34.327258 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Apr 24 23:37:34.327285 kernel: printk: console [ttyS0] disabled Apr 24 23:37:34.327305 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Apr 24 23:37:34.327324 kernel: printk: console [ttyS0] enabled Apr 24 23:37:34.327343 kernel: printk: bootconsole [uart0] disabled Apr 24 23:37:34.327361 kernel: thunder_xcv, ver 1.0 Apr 24 23:37:34.327381 kernel: thunder_bgx, ver 1.0 Apr 24 23:37:34.327405 kernel: nicpf, ver 1.0 Apr 24 23:37:34.327424 kernel: nicvf, ver 1.0 Apr 24 23:37:34.327721 kernel: rtc-efi rtc-efi.0: registered as rtc0 Apr 24 23:37:34.327924 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-04-24T23:37:33 UTC (1777073853) Apr 24 23:37:34.327950 kernel: hid: raw HID events driver (C) Jiri Kosina Apr 24 23:37:34.327970 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Apr 24 23:37:34.327989 kernel: watchdog: Delayed init of the lockup detector failed: -19 Apr 24 23:37:34.328009 kernel: watchdog: Hard watchdog permanently disabled Apr 24 23:37:34.328035 kernel: NET: Registered PF_INET6 protocol family Apr 24 23:37:34.328054 kernel: Segment Routing with IPv6 Apr 24 23:37:34.328073 kernel: In-situ OAM (IOAM) with IPv6 Apr 24 23:37:34.328091 kernel: NET: Registered PF_PACKET protocol family Apr 24 23:37:34.328110 kernel: Key type dns_resolver registered Apr 24 23:37:34.328128 kernel: registered taskstats version 1 Apr 24 23:37:34.328147 kernel: Loading compiled-in X.509 certificates Apr 24 23:37:34.328167 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.127-flatcar: 96a6e7da7ac9a3ef656057ccd8e13f251b310c24' Apr 24 23:37:34.328185 kernel: Key type .fscrypt registered Apr 24 23:37:34.328208 kernel: Key type fscrypt-provisioning registered Apr 24 23:37:34.328226 kernel: ima: No TPM chip found, activating TPM-bypass! Apr 24 23:37:34.328245 kernel: ima: Allocated hash algorithm: sha1 Apr 24 23:37:34.328264 kernel: ima: No architecture policies found Apr 24 23:37:34.328283 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Apr 24 23:37:34.328301 kernel: clk: Disabling unused clocks Apr 24 23:37:34.328320 kernel: Freeing unused kernel memory: 39424K Apr 24 23:37:34.328338 kernel: Run /init as init process Apr 24 23:37:34.328357 kernel: with arguments: Apr 24 23:37:34.328380 kernel: /init Apr 24 23:37:34.328398 kernel: with environment: Apr 24 23:37:34.328416 kernel: HOME=/ Apr 24 23:37:34.328435 kernel: TERM=linux Apr 24 23:37:34.328458 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 24 23:37:34.328482 systemd[1]: Detected virtualization amazon. Apr 24 23:37:34.328503 systemd[1]: Detected architecture arm64. Apr 24 23:37:34.328523 systemd[1]: Running in initrd. Apr 24 23:37:34.328548 systemd[1]: No hostname configured, using default hostname. Apr 24 23:37:34.328568 systemd[1]: Hostname set to . Apr 24 23:37:34.328618 systemd[1]: Initializing machine ID from VM UUID. Apr 24 23:37:34.328641 systemd[1]: Queued start job for default target initrd.target. Apr 24 23:37:34.328661 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 23:37:34.328682 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 23:37:34.328704 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Apr 24 23:37:34.328725 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 24 23:37:34.328752 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Apr 24 23:37:34.328773 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Apr 24 23:37:34.328798 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Apr 24 23:37:34.328821 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Apr 24 23:37:34.328845 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 23:37:34.328868 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 24 23:37:34.328895 systemd[1]: Reached target paths.target - Path Units. Apr 24 23:37:34.328917 systemd[1]: Reached target slices.target - Slice Units. Apr 24 23:37:34.328938 systemd[1]: Reached target swap.target - Swaps. Apr 24 23:37:34.328959 systemd[1]: Reached target timers.target - Timer Units. Apr 24 23:37:34.328979 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Apr 24 23:37:34.329024 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 24 23:37:34.329056 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Apr 24 23:37:34.329084 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Apr 24 23:37:34.329106 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 24 23:37:34.329135 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 24 23:37:34.329157 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 23:37:34.329179 systemd[1]: Reached target sockets.target - Socket Units. Apr 24 23:37:34.329200 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Apr 24 23:37:34.329221 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 24 23:37:34.329242 systemd[1]: Finished network-cleanup.service - Network Cleanup. Apr 24 23:37:34.329264 systemd[1]: Starting systemd-fsck-usr.service... Apr 24 23:37:34.329284 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 24 23:37:34.329305 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 24 23:37:34.329331 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 23:37:34.329352 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Apr 24 23:37:34.329373 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 23:37:34.329393 systemd[1]: Finished systemd-fsck-usr.service. Apr 24 23:37:34.329486 systemd-journald[252]: Collecting audit messages is disabled. Apr 24 23:37:34.329540 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Apr 24 23:37:34.329561 systemd-journald[252]: Journal started Apr 24 23:37:34.329647 systemd-journald[252]: Runtime Journal (/run/log/journal/ec245eabc560a78eeb521581398ef53f) is 8.0M, max 75.3M, 67.3M free. Apr 24 23:37:34.337020 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Apr 24 23:37:34.300298 systemd-modules-load[253]: Inserted module 'overlay' Apr 24 23:37:34.347643 systemd[1]: Started systemd-journald.service - Journal Service. Apr 24 23:37:34.347713 kernel: Bridge firewalling registered Apr 24 23:37:34.343438 systemd-modules-load[253]: Inserted module 'br_netfilter' Apr 24 23:37:34.347637 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 24 23:37:34.352147 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 23:37:34.367411 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Apr 24 23:37:34.383171 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 24 23:37:34.393987 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 24 23:37:34.400262 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 24 23:37:34.404564 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 24 23:37:34.450676 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 23:37:34.461685 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 24 23:37:34.474659 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 23:37:34.476500 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 23:37:34.490161 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Apr 24 23:37:34.508944 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 24 23:37:34.543549 dracut-cmdline[290]: dracut-dracut-053 Apr 24 23:37:34.556621 dracut-cmdline[290]: 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=63304dd98a277d4592d17e0085ae3f91ca70cc8ec6dedfdd357a1e9755f9a8b3 Apr 24 23:37:34.599410 systemd-resolved[291]: Positive Trust Anchors: Apr 24 23:37:34.602428 systemd-resolved[291]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 24 23:37:34.602498 systemd-resolved[291]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 24 23:37:34.730632 kernel: SCSI subsystem initialized Apr 24 23:37:34.738615 kernel: Loading iSCSI transport class v2.0-870. Apr 24 23:37:34.752624 kernel: iscsi: registered transport (tcp) Apr 24 23:37:34.777360 kernel: iscsi: registered transport (qla4xxx) Apr 24 23:37:34.777448 kernel: QLogic iSCSI HBA Driver Apr 24 23:37:34.844624 kernel: random: crng init done Apr 24 23:37:34.845145 systemd-resolved[291]: Defaulting to hostname 'linux'. Apr 24 23:37:34.851730 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 24 23:37:34.865661 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 24 23:37:34.876381 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Apr 24 23:37:34.893856 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Apr 24 23:37:34.925366 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Apr 24 23:37:34.925448 kernel: device-mapper: uevent: version 1.0.3 Apr 24 23:37:34.927421 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Apr 24 23:37:34.996643 kernel: raid6: neonx8 gen() 6678 MB/s Apr 24 23:37:35.013634 kernel: raid6: neonx4 gen() 6498 MB/s Apr 24 23:37:35.030632 kernel: raid6: neonx2 gen() 5415 MB/s Apr 24 23:37:35.047645 kernel: raid6: neonx1 gen() 3915 MB/s Apr 24 23:37:35.064641 kernel: raid6: int64x8 gen() 3767 MB/s Apr 24 23:37:35.081649 kernel: raid6: int64x4 gen() 3678 MB/s Apr 24 23:37:35.098649 kernel: raid6: int64x2 gen() 3547 MB/s Apr 24 23:37:35.116737 kernel: raid6: int64x1 gen() 2724 MB/s Apr 24 23:37:35.116817 kernel: raid6: using algorithm neonx8 gen() 6678 MB/s Apr 24 23:37:35.135684 kernel: raid6: .... xor() 4750 MB/s, rmw enabled Apr 24 23:37:35.135787 kernel: raid6: using neon recovery algorithm Apr 24 23:37:35.144644 kernel: xor: measuring software checksum speed Apr 24 23:37:35.144726 kernel: 8regs : 9984 MB/sec Apr 24 23:37:35.148256 kernel: 32regs : 10539 MB/sec Apr 24 23:37:35.148331 kernel: arm64_neon : 9460 MB/sec Apr 24 23:37:35.148374 kernel: xor: using function: 32regs (10539 MB/sec) Apr 24 23:37:35.238632 kernel: Btrfs loaded, zoned=no, fsverity=no Apr 24 23:37:35.261101 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Apr 24 23:37:35.278891 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 23:37:35.314045 systemd-udevd[473]: Using default interface naming scheme 'v255'. Apr 24 23:37:35.322833 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 23:37:35.344958 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Apr 24 23:37:35.380237 dracut-pre-trigger[482]: rd.md=0: removing MD RAID activation Apr 24 23:37:35.448169 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Apr 24 23:37:35.466103 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 24 23:37:35.601368 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 23:37:35.628209 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Apr 24 23:37:35.687139 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Apr 24 23:37:35.696095 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Apr 24 23:37:35.705666 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 23:37:35.714744 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 24 23:37:35.731025 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Apr 24 23:37:35.785048 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Apr 24 23:37:35.851636 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Apr 24 23:37:35.851723 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Apr 24 23:37:35.858646 kernel: ena 0000:00:05.0: ENA device version: 0.10 Apr 24 23:37:35.859089 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Apr 24 23:37:35.862418 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 24 23:37:35.864833 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 23:37:35.898703 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:41:f1:85:5a:23 Apr 24 23:37:35.877441 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 24 23:37:35.891236 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 24 23:37:35.891570 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 23:37:35.896120 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 23:37:35.926902 (udev-worker)[544]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:37:35.927871 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 23:37:35.969350 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Apr 24 23:37:35.969431 kernel: nvme nvme0: pci function 0000:00:04.0 Apr 24 23:37:35.974852 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 23:37:35.995370 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Apr 24 23:37:36.005105 kernel: nvme nvme0: 2/0/0 default/read/poll queues Apr 24 23:37:36.013491 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Apr 24 23:37:36.013596 kernel: GPT:9289727 != 33554431 Apr 24 23:37:36.013630 kernel: GPT:Alternate GPT header not at the end of the disk. Apr 24 23:37:36.013656 kernel: GPT:9289727 != 33554431 Apr 24 23:37:36.015618 kernel: GPT: Use GNU Parted to correct GPT errors. Apr 24 23:37:36.015683 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 24 23:37:36.054420 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 23:37:36.120718 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (526) Apr 24 23:37:36.135666 kernel: BTRFS: device fsid 5f4cf890-f9e2-4e04-aa84-1bcfb6e5643e devid 1 transid 36 /dev/nvme0n1p3 scanned by (udev-worker) (516) Apr 24 23:37:36.181523 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Apr 24 23:37:36.255455 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Apr 24 23:37:36.273782 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Apr 24 23:37:36.284641 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Apr 24 23:37:36.306427 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 24 23:37:36.321911 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Apr 24 23:37:36.344653 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 24 23:37:36.344732 disk-uuid[663]: Primary Header is updated. Apr 24 23:37:36.344732 disk-uuid[663]: Secondary Entries is updated. Apr 24 23:37:36.344732 disk-uuid[663]: Secondary Header is updated. Apr 24 23:37:36.379609 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 24 23:37:37.399533 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Apr 24 23:37:37.400511 disk-uuid[664]: The operation has completed successfully. Apr 24 23:37:37.604808 systemd[1]: disk-uuid.service: Deactivated successfully. Apr 24 23:37:37.605131 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Apr 24 23:37:37.673940 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Apr 24 23:37:37.691520 sh[922]: Success Apr 24 23:37:37.712644 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Apr 24 23:37:37.828440 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Apr 24 23:37:37.848781 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Apr 24 23:37:37.864496 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Apr 24 23:37:37.894631 kernel: BTRFS info (device dm-0): first mount of filesystem 5f4cf890-f9e2-4e04-aa84-1bcfb6e5643e Apr 24 23:37:37.894712 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Apr 24 23:37:37.894740 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Apr 24 23:37:37.894766 kernel: BTRFS info (device dm-0): disabling log replay at mount time Apr 24 23:37:37.896077 kernel: BTRFS info (device dm-0): using free space tree Apr 24 23:37:37.963641 kernel: BTRFS info (device dm-0): enabling ssd optimizations Apr 24 23:37:37.992801 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Apr 24 23:37:37.995905 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Apr 24 23:37:38.011083 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Apr 24 23:37:38.024849 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Apr 24 23:37:38.041211 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7d1fb622-285b-4375-96d6-a0d989283452 Apr 24 23:37:38.041288 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 24 23:37:38.043179 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 24 23:37:38.050628 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 24 23:37:38.071361 systemd[1]: mnt-oem.mount: Deactivated successfully. Apr 24 23:37:38.077161 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 7d1fb622-285b-4375-96d6-a0d989283452 Apr 24 23:37:38.087138 systemd[1]: Finished ignition-setup.service - Ignition (setup). Apr 24 23:37:38.106102 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Apr 24 23:37:38.235404 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 24 23:37:38.254889 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 24 23:37:38.311141 systemd-networkd[1116]: lo: Link UP Apr 24 23:37:38.311157 systemd-networkd[1116]: lo: Gained carrier Apr 24 23:37:38.315986 systemd-networkd[1116]: Enumeration completed Apr 24 23:37:38.317075 systemd-networkd[1116]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 23:37:38.317083 systemd-networkd[1116]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 24 23:37:38.317177 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 24 23:37:38.323399 systemd[1]: Reached target network.target - Network. Apr 24 23:37:38.324565 systemd-networkd[1116]: eth0: Link UP Apr 24 23:37:38.324573 systemd-networkd[1116]: eth0: Gained carrier Apr 24 23:37:38.324615 systemd-networkd[1116]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 23:37:38.363709 systemd-networkd[1116]: eth0: DHCPv4 address 172.31.19.73/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 24 23:37:38.497902 ignition[1023]: Ignition 2.19.0 Apr 24 23:37:38.497933 ignition[1023]: Stage: fetch-offline Apr 24 23:37:38.503146 ignition[1023]: no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:38.503197 ignition[1023]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:38.509110 ignition[1023]: Ignition finished successfully Apr 24 23:37:38.514128 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Apr 24 23:37:38.530889 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Apr 24 23:37:38.557447 ignition[1124]: Ignition 2.19.0 Apr 24 23:37:38.558103 ignition[1124]: Stage: fetch Apr 24 23:37:38.560014 ignition[1124]: no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:38.560073 ignition[1124]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:38.560272 ignition[1124]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:38.588928 ignition[1124]: PUT result: OK Apr 24 23:37:38.592473 ignition[1124]: parsed url from cmdline: "" Apr 24 23:37:38.592491 ignition[1124]: no config URL provided Apr 24 23:37:38.592510 ignition[1124]: reading system config file "/usr/lib/ignition/user.ign" Apr 24 23:37:38.592540 ignition[1124]: no config at "/usr/lib/ignition/user.ign" Apr 24 23:37:38.592609 ignition[1124]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:38.594964 ignition[1124]: PUT result: OK Apr 24 23:37:38.595119 ignition[1124]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Apr 24 23:37:38.603201 ignition[1124]: GET result: OK Apr 24 23:37:38.609950 unknown[1124]: fetched base config from "system" Apr 24 23:37:38.603382 ignition[1124]: parsing config with SHA512: a50e17a0a7b1d036f8891eb9689b824180b3cca7e123f122908e15ef7113a60f588f3043022c88aecef2163340395c1901016be5f502a49234351d87dbf8867d Apr 24 23:37:38.609967 unknown[1124]: fetched base config from "system" Apr 24 23:37:38.610433 ignition[1124]: fetch: fetch complete Apr 24 23:37:38.610009 unknown[1124]: fetched user config from "aws" Apr 24 23:37:38.610445 ignition[1124]: fetch: fetch passed Apr 24 23:37:38.618226 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Apr 24 23:37:38.610534 ignition[1124]: Ignition finished successfully Apr 24 23:37:38.639926 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Apr 24 23:37:38.674974 ignition[1131]: Ignition 2.19.0 Apr 24 23:37:38.675499 ignition[1131]: Stage: kargs Apr 24 23:37:38.676208 ignition[1131]: no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:38.676234 ignition[1131]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:38.676432 ignition[1131]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:38.687666 ignition[1131]: PUT result: OK Apr 24 23:37:38.693615 ignition[1131]: kargs: kargs passed Apr 24 23:37:38.693966 ignition[1131]: Ignition finished successfully Apr 24 23:37:38.701693 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Apr 24 23:37:38.716972 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Apr 24 23:37:38.751229 ignition[1137]: Ignition 2.19.0 Apr 24 23:37:38.751251 ignition[1137]: Stage: disks Apr 24 23:37:38.752556 ignition[1137]: no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:38.752632 ignition[1137]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:38.752800 ignition[1137]: PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:38.768715 ignition[1137]: PUT result: OK Apr 24 23:37:38.781190 ignition[1137]: disks: disks passed Apr 24 23:37:38.781630 ignition[1137]: Ignition finished successfully Apr 24 23:37:38.790671 systemd[1]: Finished ignition-disks.service - Ignition (disks). Apr 24 23:37:38.798489 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Apr 24 23:37:38.804240 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Apr 24 23:37:38.809721 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 24 23:37:38.820461 systemd[1]: Reached target sysinit.target - System Initialization. Apr 24 23:37:38.823345 systemd[1]: Reached target basic.target - Basic System. Apr 24 23:37:38.841835 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Apr 24 23:37:38.877688 systemd-fsck[1145]: ROOT: clean, 14/553520 files, 52654/553472 blocks Apr 24 23:37:38.882654 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Apr 24 23:37:38.904030 systemd[1]: Mounting sysroot.mount - /sysroot... Apr 24 23:37:38.990684 kernel: EXT4-fs (nvme0n1p9): mounted filesystem edaa698b-3baa-4242-8691-64cb9f35f18f r/w with ordered data mode. Quota mode: none. Apr 24 23:37:38.991900 systemd[1]: Mounted sysroot.mount - /sysroot. Apr 24 23:37:38.996867 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Apr 24 23:37:39.011780 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 24 23:37:39.026427 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Apr 24 23:37:39.035064 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Apr 24 23:37:39.035150 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Apr 24 23:37:39.056111 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1164) Apr 24 23:37:39.063509 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7d1fb622-285b-4375-96d6-a0d989283452 Apr 24 23:37:39.063610 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 24 23:37:39.063658 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 24 23:37:39.035200 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Apr 24 23:37:39.056048 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Apr 24 23:37:39.075987 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Apr 24 23:37:39.089641 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 24 23:37:39.089150 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 24 23:37:39.415210 initrd-setup-root[1188]: cut: /sysroot/etc/passwd: No such file or directory Apr 24 23:37:39.430187 initrd-setup-root[1195]: cut: /sysroot/etc/group: No such file or directory Apr 24 23:37:39.445100 initrd-setup-root[1202]: cut: /sysroot/etc/shadow: No such file or directory Apr 24 23:37:39.456508 initrd-setup-root[1209]: cut: /sysroot/etc/gshadow: No such file or directory Apr 24 23:37:39.746965 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Apr 24 23:37:39.760950 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Apr 24 23:37:39.769555 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Apr 24 23:37:39.793080 systemd[1]: sysroot-oem.mount: Deactivated successfully. Apr 24 23:37:39.796730 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 7d1fb622-285b-4375-96d6-a0d989283452 Apr 24 23:37:39.837155 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Apr 24 23:37:39.852626 ignition[1277]: INFO : Ignition 2.19.0 Apr 24 23:37:39.852626 ignition[1277]: INFO : Stage: mount Apr 24 23:37:39.857097 ignition[1277]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:39.857097 ignition[1277]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:39.857097 ignition[1277]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:39.869209 ignition[1277]: INFO : PUT result: OK Apr 24 23:37:39.877803 ignition[1277]: INFO : mount: mount passed Apr 24 23:37:39.880064 ignition[1277]: INFO : Ignition finished successfully Apr 24 23:37:39.885367 systemd[1]: Finished ignition-mount.service - Ignition (mount). Apr 24 23:37:39.896907 systemd-networkd[1116]: eth0: Gained IPv6LL Apr 24 23:37:39.897759 systemd[1]: Starting ignition-files.service - Ignition (files)... Apr 24 23:37:40.002947 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Apr 24 23:37:40.038639 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1289) Apr 24 23:37:40.038713 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 7d1fb622-285b-4375-96d6-a0d989283452 Apr 24 23:37:40.044028 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Apr 24 23:37:40.044091 kernel: BTRFS info (device nvme0n1p6): using free space tree Apr 24 23:37:40.052134 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Apr 24 23:37:40.054971 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Apr 24 23:37:40.090569 ignition[1306]: INFO : Ignition 2.19.0 Apr 24 23:37:40.090569 ignition[1306]: INFO : Stage: files Apr 24 23:37:40.096082 ignition[1306]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:40.096082 ignition[1306]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:40.096082 ignition[1306]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:40.096082 ignition[1306]: INFO : PUT result: OK Apr 24 23:37:40.110934 ignition[1306]: DEBUG : files: compiled without relabeling support, skipping Apr 24 23:37:40.114406 ignition[1306]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Apr 24 23:37:40.114406 ignition[1306]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Apr 24 23:37:40.159335 ignition[1306]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Apr 24 23:37:40.163611 ignition[1306]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Apr 24 23:37:40.167801 unknown[1306]: wrote ssh authorized keys file for user: core Apr 24 23:37:40.173244 ignition[1306]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.8-arm64.raw" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.8-arm64.raw" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.8-arm64.raw" Apr 24 23:37:40.181624 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.33.8-arm64.raw: attempt #1 Apr 24 23:37:40.566891 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Apr 24 23:37:40.968215 ignition[1306]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.8-arm64.raw" Apr 24 23:37:40.973678 ignition[1306]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Apr 24 23:37:40.973678 ignition[1306]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Apr 24 23:37:40.973678 ignition[1306]: INFO : files: files passed Apr 24 23:37:40.973678 ignition[1306]: INFO : Ignition finished successfully Apr 24 23:37:40.989598 systemd[1]: Finished ignition-files.service - Ignition (files). Apr 24 23:37:41.004854 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Apr 24 23:37:41.017109 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Apr 24 23:37:41.027482 systemd[1]: ignition-quench.service: Deactivated successfully. Apr 24 23:37:41.030674 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Apr 24 23:37:41.063254 initrd-setup-root-after-ignition[1334]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 24 23:37:41.063254 initrd-setup-root-after-ignition[1334]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Apr 24 23:37:41.073823 initrd-setup-root-after-ignition[1338]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Apr 24 23:37:41.081378 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 24 23:37:41.085445 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Apr 24 23:37:41.110565 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Apr 24 23:37:41.170173 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Apr 24 23:37:41.170694 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Apr 24 23:37:41.176294 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Apr 24 23:37:41.179408 systemd[1]: Reached target initrd.target - Initrd Default Target. Apr 24 23:37:41.182383 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Apr 24 23:37:41.184747 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Apr 24 23:37:41.233701 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 24 23:37:41.248820 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Apr 24 23:37:41.275755 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Apr 24 23:37:41.279121 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 23:37:41.282480 systemd[1]: Stopped target timers.target - Timer Units. Apr 24 23:37:41.285039 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Apr 24 23:37:41.285336 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Apr 24 23:37:41.303079 systemd[1]: Stopped target initrd.target - Initrd Default Target. Apr 24 23:37:41.306054 systemd[1]: Stopped target basic.target - Basic System. Apr 24 23:37:41.308860 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Apr 24 23:37:41.314772 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Apr 24 23:37:41.318306 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Apr 24 23:37:41.321700 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Apr 24 23:37:41.324869 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Apr 24 23:37:41.328514 systemd[1]: Stopped target sysinit.target - System Initialization. Apr 24 23:37:41.331669 systemd[1]: Stopped target local-fs.target - Local File Systems. Apr 24 23:37:41.335687 systemd[1]: Stopped target swap.target - Swaps. Apr 24 23:37:41.347117 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Apr 24 23:37:41.347514 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Apr 24 23:37:41.367310 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Apr 24 23:37:41.374771 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 23:37:41.383297 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Apr 24 23:37:41.395810 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 23:37:41.400083 systemd[1]: dracut-initqueue.service: Deactivated successfully. Apr 24 23:37:41.400413 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Apr 24 23:37:41.414814 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Apr 24 23:37:41.415393 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Apr 24 23:37:41.425424 systemd[1]: ignition-files.service: Deactivated successfully. Apr 24 23:37:41.425716 systemd[1]: Stopped ignition-files.service - Ignition (files). Apr 24 23:37:41.440987 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Apr 24 23:37:41.444002 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Apr 24 23:37:41.444431 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 23:37:41.462053 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Apr 24 23:37:41.468759 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Apr 24 23:37:41.469111 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 23:37:41.473080 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Apr 24 23:37:41.473331 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Apr 24 23:37:41.501375 systemd[1]: initrd-cleanup.service: Deactivated successfully. Apr 24 23:37:41.501674 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Apr 24 23:37:41.522640 ignition[1358]: INFO : Ignition 2.19.0 Apr 24 23:37:41.522640 ignition[1358]: INFO : Stage: umount Apr 24 23:37:41.528720 ignition[1358]: INFO : no configs at "/usr/lib/ignition/base.d" Apr 24 23:37:41.528720 ignition[1358]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Apr 24 23:37:41.528720 ignition[1358]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Apr 24 23:37:41.542656 ignition[1358]: INFO : PUT result: OK Apr 24 23:37:41.551789 systemd[1]: sysroot-boot.mount: Deactivated successfully. Apr 24 23:37:41.556660 ignition[1358]: INFO : umount: umount passed Apr 24 23:37:41.556660 ignition[1358]: INFO : Ignition finished successfully Apr 24 23:37:41.562085 systemd[1]: ignition-mount.service: Deactivated successfully. Apr 24 23:37:41.562525 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Apr 24 23:37:41.573393 systemd[1]: sysroot-boot.service: Deactivated successfully. Apr 24 23:37:41.573694 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Apr 24 23:37:41.579462 systemd[1]: ignition-disks.service: Deactivated successfully. Apr 24 23:37:41.580119 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Apr 24 23:37:41.584512 systemd[1]: ignition-kargs.service: Deactivated successfully. Apr 24 23:37:41.584655 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Apr 24 23:37:41.590887 systemd[1]: ignition-fetch.service: Deactivated successfully. Apr 24 23:37:41.590992 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Apr 24 23:37:41.591274 systemd[1]: Stopped target network.target - Network. Apr 24 23:37:41.591612 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Apr 24 23:37:41.591709 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Apr 24 23:37:41.592414 systemd[1]: Stopped target paths.target - Path Units. Apr 24 23:37:41.620475 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Apr 24 23:37:41.624202 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 23:37:41.627782 systemd[1]: Stopped target slices.target - Slice Units. Apr 24 23:37:41.630470 systemd[1]: Stopped target sockets.target - Socket Units. Apr 24 23:37:41.633414 systemd[1]: iscsid.socket: Deactivated successfully. Apr 24 23:37:41.633507 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Apr 24 23:37:41.636428 systemd[1]: iscsiuio.socket: Deactivated successfully. Apr 24 23:37:41.636509 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Apr 24 23:37:41.637748 systemd[1]: ignition-setup.service: Deactivated successfully. Apr 24 23:37:41.637872 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Apr 24 23:37:41.638159 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Apr 24 23:37:41.638257 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Apr 24 23:37:41.639101 systemd[1]: initrd-setup-root.service: Deactivated successfully. Apr 24 23:37:41.639215 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Apr 24 23:37:41.679326 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Apr 24 23:37:41.687617 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Apr 24 23:37:41.700689 systemd-networkd[1116]: eth0: DHCPv6 lease lost Apr 24 23:37:41.706400 systemd[1]: systemd-resolved.service: Deactivated successfully. Apr 24 23:37:41.706733 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Apr 24 23:37:41.717436 systemd[1]: systemd-networkd.service: Deactivated successfully. Apr 24 23:37:41.720291 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Apr 24 23:37:41.724302 systemd[1]: systemd-networkd.socket: Deactivated successfully. Apr 24 23:37:41.724426 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Apr 24 23:37:41.743021 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Apr 24 23:37:41.745517 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Apr 24 23:37:41.745665 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Apr 24 23:37:41.757956 systemd[1]: systemd-sysctl.service: Deactivated successfully. Apr 24 23:37:41.758069 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Apr 24 23:37:41.760992 systemd[1]: systemd-modules-load.service: Deactivated successfully. Apr 24 23:37:41.761090 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Apr 24 23:37:41.764083 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Apr 24 23:37:41.764169 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 23:37:41.767848 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 23:37:41.813997 systemd[1]: systemd-udevd.service: Deactivated successfully. Apr 24 23:37:41.816441 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 23:37:41.822841 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Apr 24 23:37:41.822987 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Apr 24 23:37:41.834809 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Apr 24 23:37:41.834900 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 23:37:41.838013 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Apr 24 23:37:41.838122 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Apr 24 23:37:41.841871 systemd[1]: dracut-cmdline.service: Deactivated successfully. Apr 24 23:37:41.841969 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Apr 24 23:37:41.860955 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Apr 24 23:37:41.861099 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Apr 24 23:37:41.878001 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Apr 24 23:37:41.880750 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Apr 24 23:37:41.880875 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 23:37:41.884798 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Apr 24 23:37:41.884900 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 23:37:41.889479 systemd[1]: network-cleanup.service: Deactivated successfully. Apr 24 23:37:41.889707 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Apr 24 23:37:41.936302 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Apr 24 23:37:41.938869 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Apr 24 23:37:41.945886 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Apr 24 23:37:41.961468 systemd[1]: Starting initrd-switch-root.service - Switch Root... Apr 24 23:37:41.981117 systemd[1]: Switching root. Apr 24 23:37:42.054660 systemd-journald[252]: Journal stopped Apr 24 23:37:44.427213 systemd-journald[252]: Received SIGTERM from PID 1 (systemd). Apr 24 23:37:44.427365 kernel: SELinux: policy capability network_peer_controls=1 Apr 24 23:37:44.427414 kernel: SELinux: policy capability open_perms=1 Apr 24 23:37:44.427446 kernel: SELinux: policy capability extended_socket_class=1 Apr 24 23:37:44.427477 kernel: SELinux: policy capability always_check_network=0 Apr 24 23:37:44.427507 kernel: SELinux: policy capability cgroup_seclabel=1 Apr 24 23:37:44.427537 kernel: SELinux: policy capability nnp_nosuid_transition=1 Apr 24 23:37:44.427567 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Apr 24 23:37:44.427620 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Apr 24 23:37:44.427655 kernel: audit: type=1403 audit(1777073862.544:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Apr 24 23:37:44.427700 systemd[1]: Successfully loaded SELinux policy in 76.300ms. Apr 24 23:37:44.427749 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 25.018ms. Apr 24 23:37:44.427785 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Apr 24 23:37:44.427820 systemd[1]: Detected virtualization amazon. Apr 24 23:37:44.427852 systemd[1]: Detected architecture arm64. Apr 24 23:37:44.427884 systemd[1]: Detected first boot. Apr 24 23:37:44.427915 systemd[1]: Initializing machine ID from VM UUID. Apr 24 23:37:44.427947 zram_generator::config[1401]: No configuration found. Apr 24 23:37:44.427987 systemd[1]: Populated /etc with preset unit settings. Apr 24 23:37:44.428018 systemd[1]: initrd-switch-root.service: Deactivated successfully. Apr 24 23:37:44.428051 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Apr 24 23:37:44.428086 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Apr 24 23:37:44.428117 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Apr 24 23:37:44.428150 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Apr 24 23:37:44.428185 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Apr 24 23:37:44.428215 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Apr 24 23:37:44.428247 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Apr 24 23:37:44.428277 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Apr 24 23:37:44.428307 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Apr 24 23:37:44.428338 systemd[1]: Created slice user.slice - User and Session Slice. Apr 24 23:37:44.428371 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Apr 24 23:37:44.428403 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Apr 24 23:37:44.428433 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Apr 24 23:37:44.428469 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Apr 24 23:37:44.428502 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Apr 24 23:37:44.428536 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Apr 24 23:37:44.428567 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Apr 24 23:37:44.428622 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Apr 24 23:37:44.428655 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Apr 24 23:37:44.428687 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Apr 24 23:37:44.428717 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Apr 24 23:37:44.428755 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Apr 24 23:37:44.428786 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Apr 24 23:37:44.428819 systemd[1]: Reached target remote-fs.target - Remote File Systems. Apr 24 23:37:44.428852 systemd[1]: Reached target slices.target - Slice Units. Apr 24 23:37:44.428886 systemd[1]: Reached target swap.target - Swaps. Apr 24 23:37:44.428917 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Apr 24 23:37:44.428950 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Apr 24 23:37:44.429479 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Apr 24 23:37:44.429595 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Apr 24 23:37:44.429639 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Apr 24 23:37:44.429671 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Apr 24 23:37:44.429705 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Apr 24 23:37:44.429739 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Apr 24 23:37:44.429770 systemd[1]: Mounting media.mount - External Media Directory... Apr 24 23:37:44.429804 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Apr 24 23:37:44.429837 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Apr 24 23:37:44.429869 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Apr 24 23:37:44.429919 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Apr 24 23:37:44.429951 systemd[1]: Reached target machines.target - Containers. Apr 24 23:37:44.429985 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Apr 24 23:37:44.430019 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 24 23:37:44.430065 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Apr 24 23:37:44.430097 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Apr 24 23:37:44.430127 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 24 23:37:44.430156 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 24 23:37:44.430186 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 24 23:37:44.430222 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Apr 24 23:37:44.430254 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 24 23:37:44.430284 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Apr 24 23:37:44.430314 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Apr 24 23:37:44.430345 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Apr 24 23:37:44.430376 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Apr 24 23:37:44.430407 systemd[1]: Stopped systemd-fsck-usr.service. Apr 24 23:37:44.430437 systemd[1]: Starting systemd-journald.service - Journal Service... Apr 24 23:37:44.430474 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Apr 24 23:37:44.430506 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Apr 24 23:37:44.430539 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Apr 24 23:37:44.430569 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Apr 24 23:37:44.430658 systemd[1]: verity-setup.service: Deactivated successfully. Apr 24 23:37:44.430692 systemd[1]: Stopped verity-setup.service. Apr 24 23:37:44.430723 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Apr 24 23:37:44.430753 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Apr 24 23:37:44.430782 kernel: loop: module loaded Apr 24 23:37:44.430821 systemd[1]: Mounted media.mount - External Media Directory. Apr 24 23:37:44.430852 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Apr 24 23:37:44.430882 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Apr 24 23:37:44.430912 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Apr 24 23:37:44.430942 kernel: fuse: init (API version 7.39) Apr 24 23:37:44.430979 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Apr 24 23:37:44.431010 kernel: ACPI: bus type drm_connector registered Apr 24 23:37:44.431042 systemd[1]: modprobe@configfs.service: Deactivated successfully. Apr 24 23:37:44.431075 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Apr 24 23:37:44.431108 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 24 23:37:44.431200 systemd-journald[1486]: Collecting audit messages is disabled. Apr 24 23:37:44.431271 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 24 23:37:44.431310 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 24 23:37:44.431341 systemd-journald[1486]: Journal started Apr 24 23:37:44.431389 systemd-journald[1486]: Runtime Journal (/run/log/journal/ec245eabc560a78eeb521581398ef53f) is 8.0M, max 75.3M, 67.3M free. Apr 24 23:37:43.772522 systemd[1]: Queued start job for default target multi-user.target. Apr 24 23:37:43.825481 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Apr 24 23:37:43.826350 systemd[1]: systemd-journald.service: Deactivated successfully. Apr 24 23:37:44.437738 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 24 23:37:44.448063 systemd[1]: Started systemd-journald.service - Journal Service. Apr 24 23:37:44.452950 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 24 23:37:44.453295 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 24 23:37:44.461492 systemd[1]: modprobe@fuse.service: Deactivated successfully. Apr 24 23:37:44.462020 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Apr 24 23:37:44.472170 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Apr 24 23:37:44.476483 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 24 23:37:44.476914 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 24 23:37:44.482301 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Apr 24 23:37:44.490321 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Apr 24 23:37:44.495979 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Apr 24 23:37:44.531132 systemd[1]: Reached target network-pre.target - Preparation for Network. Apr 24 23:37:44.542846 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Apr 24 23:37:44.561910 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Apr 24 23:37:44.570863 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Apr 24 23:37:44.570959 systemd[1]: Reached target local-fs.target - Local File Systems. Apr 24 23:37:44.580345 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Apr 24 23:37:44.595101 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Apr 24 23:37:44.614112 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Apr 24 23:37:44.617993 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 24 23:37:44.623159 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Apr 24 23:37:44.640211 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Apr 24 23:37:44.645885 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 24 23:37:44.657961 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Apr 24 23:37:44.665407 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 24 23:37:44.689644 systemd-journald[1486]: Time spent on flushing to /var/log/journal/ec245eabc560a78eeb521581398ef53f is 115.352ms for 876 entries. Apr 24 23:37:44.689644 systemd-journald[1486]: System Journal (/var/log/journal/ec245eabc560a78eeb521581398ef53f) is 8.0M, max 195.6M, 187.6M free. Apr 24 23:37:44.825618 systemd-journald[1486]: Received client request to flush runtime journal. Apr 24 23:37:44.684141 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Apr 24 23:37:44.699167 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Apr 24 23:37:44.710096 systemd[1]: Starting systemd-sysusers.service - Create System Users... Apr 24 23:37:44.722856 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Apr 24 23:37:44.727010 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Apr 24 23:37:44.733012 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Apr 24 23:37:44.775255 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Apr 24 23:37:44.779617 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Apr 24 23:37:44.794009 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Apr 24 23:37:44.815749 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Apr 24 23:37:44.839939 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Apr 24 23:37:44.846466 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Apr 24 23:37:44.873425 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Apr 24 23:37:44.913651 kernel: loop0: detected capacity change from 0 to 114432 Apr 24 23:37:44.937282 udevadm[1541]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Apr 24 23:37:44.953764 systemd[1]: Finished systemd-sysusers.service - Create System Users. Apr 24 23:37:44.968918 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Apr 24 23:37:44.973819 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Apr 24 23:37:44.980354 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Apr 24 23:37:45.038215 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Apr 24 23:37:45.051170 systemd-tmpfiles[1546]: ACLs are not supported, ignoring. Apr 24 23:37:45.051216 systemd-tmpfiles[1546]: ACLs are not supported, ignoring. Apr 24 23:37:45.062647 kernel: loop1: detected capacity change from 0 to 209336 Apr 24 23:37:45.069677 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Apr 24 23:37:45.154641 kernel: loop2: detected capacity change from 0 to 114328 Apr 24 23:37:45.244676 kernel: loop3: detected capacity change from 0 to 52536 Apr 24 23:37:45.338492 kernel: loop4: detected capacity change from 0 to 114432 Apr 24 23:37:45.364612 kernel: loop5: detected capacity change from 0 to 209336 Apr 24 23:37:45.397140 kernel: loop6: detected capacity change from 0 to 114328 Apr 24 23:37:45.415623 kernel: loop7: detected capacity change from 0 to 52536 Apr 24 23:37:45.441445 (sd-merge)[1556]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Apr 24 23:37:45.443485 (sd-merge)[1556]: Merged extensions into '/usr'. Apr 24 23:37:45.452457 systemd[1]: Reloading requested from client PID 1530 ('systemd-sysext') (unit systemd-sysext.service)... Apr 24 23:37:45.453042 systemd[1]: Reloading... Apr 24 23:37:45.624644 zram_generator::config[1578]: No configuration found. Apr 24 23:37:46.037074 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 24 23:37:46.154847 systemd[1]: Reloading finished in 700 ms. Apr 24 23:37:46.189429 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Apr 24 23:37:46.193646 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Apr 24 23:37:46.213123 systemd[1]: Starting ensure-sysext.service... Apr 24 23:37:46.224948 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Apr 24 23:37:46.233997 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Apr 24 23:37:46.247149 systemd[1]: Reloading requested from client PID 1635 ('systemctl') (unit ensure-sysext.service)... Apr 24 23:37:46.247183 systemd[1]: Reloading... Apr 24 23:37:46.325308 ldconfig[1525]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Apr 24 23:37:46.344566 systemd-tmpfiles[1636]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Apr 24 23:37:46.347623 systemd-udevd[1637]: Using default interface naming scheme 'v255'. Apr 24 23:37:46.349320 systemd-tmpfiles[1636]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Apr 24 23:37:46.354448 systemd-tmpfiles[1636]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Apr 24 23:37:46.355061 systemd-tmpfiles[1636]: ACLs are not supported, ignoring. Apr 24 23:37:46.355198 systemd-tmpfiles[1636]: ACLs are not supported, ignoring. Apr 24 23:37:46.372899 systemd-tmpfiles[1636]: Detected autofs mount point /boot during canonicalization of boot. Apr 24 23:37:46.373151 systemd-tmpfiles[1636]: Skipping /boot Apr 24 23:37:46.437330 systemd-tmpfiles[1636]: Detected autofs mount point /boot during canonicalization of boot. Apr 24 23:37:46.437538 systemd-tmpfiles[1636]: Skipping /boot Apr 24 23:37:46.495609 zram_generator::config[1664]: No configuration found. Apr 24 23:37:46.644110 (udev-worker)[1666]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:37:46.880623 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (1671) Apr 24 23:37:46.911330 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 24 23:37:47.093457 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Apr 24 23:37:47.094748 systemd[1]: Reloading finished in 846 ms. Apr 24 23:37:47.142751 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Apr 24 23:37:47.152894 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Apr 24 23:37:47.161256 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Apr 24 23:37:47.294519 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Apr 24 23:37:47.307179 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Apr 24 23:37:47.313246 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 24 23:37:47.319188 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 24 23:37:47.327186 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 24 23:37:47.332909 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 24 23:37:47.338267 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 24 23:37:47.345242 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Apr 24 23:37:47.359130 systemd[1]: Starting systemd-networkd.service - Network Configuration... Apr 24 23:37:47.381166 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Apr 24 23:37:47.395138 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Apr 24 23:37:47.406200 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Apr 24 23:37:47.417913 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 24 23:37:47.418260 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 24 23:37:47.442491 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Apr 24 23:37:47.458089 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 24 23:37:47.458428 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 24 23:37:47.465634 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 24 23:37:47.467685 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 24 23:37:47.541303 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Apr 24 23:37:47.546561 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Apr 24 23:37:47.557820 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Apr 24 23:37:47.564035 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Apr 24 23:37:47.568977 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Apr 24 23:37:47.573450 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Apr 24 23:37:47.576982 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Apr 24 23:37:47.577689 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Apr 24 23:37:47.582154 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Apr 24 23:37:47.582380 systemd[1]: Reached target time-set.target - System Time Set. Apr 24 23:37:47.593918 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Apr 24 23:37:47.596175 systemd[1]: Finished ensure-sysext.service. Apr 24 23:37:47.598124 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Apr 24 23:37:47.657371 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Apr 24 23:37:47.681951 systemd[1]: Starting systemd-update-done.service - Update is Completed... Apr 24 23:37:47.689174 lvm[1856]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 24 23:37:47.697886 systemd[1]: modprobe@loop.service: Deactivated successfully. Apr 24 23:37:47.699729 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Apr 24 23:37:47.730276 augenrules[1874]: No rules Apr 24 23:37:47.734506 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Apr 24 23:37:47.735053 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Apr 24 23:37:47.737472 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Apr 24 23:37:47.740174 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Apr 24 23:37:47.763110 systemd[1]: modprobe@drm.service: Deactivated successfully. Apr 24 23:37:47.763428 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Apr 24 23:37:47.771327 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Apr 24 23:37:47.771763 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Apr 24 23:37:47.772211 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Apr 24 23:37:47.808704 systemd[1]: Finished systemd-update-done.service - Update is Completed. Apr 24 23:37:47.821722 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Apr 24 23:37:47.822737 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Apr 24 23:37:47.824532 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Apr 24 23:37:47.841231 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Apr 24 23:37:47.856750 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Apr 24 23:37:47.857349 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Apr 24 23:37:47.867377 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Apr 24 23:37:47.873337 lvm[1888]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Apr 24 23:37:47.891280 systemd[1]: Started systemd-userdbd.service - User Database Manager. Apr 24 23:37:47.918691 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Apr 24 23:37:48.021073 systemd-networkd[1837]: lo: Link UP Apr 24 23:37:48.021096 systemd-networkd[1837]: lo: Gained carrier Apr 24 23:37:48.024270 systemd-networkd[1837]: Enumeration completed Apr 24 23:37:48.024507 systemd[1]: Started systemd-networkd.service - Network Configuration. Apr 24 23:37:48.025786 systemd-networkd[1837]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 23:37:48.025797 systemd-networkd[1837]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Apr 24 23:37:48.031118 systemd-networkd[1837]: eth0: Link UP Apr 24 23:37:48.031415 systemd-networkd[1837]: eth0: Gained carrier Apr 24 23:37:48.031450 systemd-networkd[1837]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Apr 24 23:37:48.039846 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Apr 24 23:37:48.046783 systemd-resolved[1838]: Positive Trust Anchors: Apr 24 23:37:48.047340 systemd-resolved[1838]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Apr 24 23:37:48.047536 systemd-resolved[1838]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Apr 24 23:37:48.049696 systemd-networkd[1837]: eth0: DHCPv4 address 172.31.19.73/20, gateway 172.31.16.1 acquired from 172.31.16.1 Apr 24 23:37:48.062123 systemd-resolved[1838]: Defaulting to hostname 'linux'. Apr 24 23:37:48.065760 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Apr 24 23:37:48.069198 systemd[1]: Reached target network.target - Network. Apr 24 23:37:48.071769 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Apr 24 23:37:48.075046 systemd[1]: Reached target sysinit.target - System Initialization. Apr 24 23:37:48.078337 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Apr 24 23:37:48.081738 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Apr 24 23:37:48.085361 systemd[1]: Started logrotate.timer - Daily rotation of log files. Apr 24 23:37:48.088488 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Apr 24 23:37:48.092257 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Apr 24 23:37:48.095427 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Apr 24 23:37:48.095490 systemd[1]: Reached target paths.target - Path Units. Apr 24 23:37:48.097911 systemd[1]: Reached target timers.target - Timer Units. Apr 24 23:37:48.101452 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Apr 24 23:37:48.106973 systemd[1]: Starting docker.socket - Docker Socket for the API... Apr 24 23:37:48.119027 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Apr 24 23:37:48.122674 systemd[1]: Listening on docker.socket - Docker Socket for the API. Apr 24 23:37:48.125725 systemd[1]: Reached target sockets.target - Socket Units. Apr 24 23:37:48.128109 systemd[1]: Reached target basic.target - Basic System. Apr 24 23:37:48.130719 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Apr 24 23:37:48.130773 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Apr 24 23:37:48.133289 systemd[1]: Starting containerd.service - containerd container runtime... Apr 24 23:37:48.140924 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Apr 24 23:37:48.153016 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Apr 24 23:37:48.163984 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Apr 24 23:37:48.179163 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Apr 24 23:37:48.184166 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Apr 24 23:37:48.196975 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Apr 24 23:37:48.215975 systemd[1]: Started ntpd.service - Network Time Service. Apr 24 23:37:48.222788 jq[1905]: false Apr 24 23:37:48.241985 systemd[1]: Starting setup-oem.service - Setup OEM... Apr 24 23:37:48.250216 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Apr 24 23:37:48.262923 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Apr 24 23:37:48.283556 systemd[1]: Starting systemd-logind.service - User Login Management... Apr 24 23:37:48.291443 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Apr 24 23:37:48.294571 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Apr 24 23:37:48.301961 systemd[1]: Starting update-engine.service - Update Engine... Apr 24 23:37:48.313891 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Apr 24 23:37:48.327508 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Apr 24 23:37:48.327983 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Apr 24 23:37:48.332537 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Apr 24 23:37:48.335723 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Apr 24 23:37:48.361234 dbus-daemon[1904]: [system] SELinux support is enabled Apr 24 23:37:48.365795 systemd[1]: Started dbus.service - D-Bus System Message Bus. Apr 24 23:37:48.366850 dbus-daemon[1904]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1837 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Apr 24 23:37:48.380647 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Apr 24 23:37:48.380726 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Apr 24 23:37:48.386124 dbus-daemon[1904]: [system] Successfully activated service 'org.freedesktop.systemd1' Apr 24 23:37:48.388410 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Apr 24 23:37:48.388456 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Apr 24 23:37:48.411241 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Apr 24 23:37:48.438602 jq[1919]: true Apr 24 23:37:48.475972 systemd[1]: motdgen.service: Deactivated successfully. Apr 24 23:37:48.479413 extend-filesystems[1906]: Found loop4 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found loop5 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found loop6 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found loop7 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p1 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p2 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p3 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found usr Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p4 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p6 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p7 Apr 24 23:37:48.479413 extend-filesystems[1906]: Found nvme0n1p9 Apr 24 23:37:48.476369 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: ntpd 4.2.8p17@1.4004-o Fri Apr 24 21:50:58 UTC 2026 (1): Starting Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: ---------------------------------------------------- Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: ntp-4 is maintained by Network Time Foundation, Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: corporation. Support and training for ntp-4 are Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: available at https://www.nwtime.org/support Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: ---------------------------------------------------- Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: proto: precision = 0.096 usec (-23) Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: basedate set to 2026-04-12 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: gps base set to 2026-04-12 (week 2414) Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listen and drop on 0 v6wildcard [::]:123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listen normally on 2 lo 127.0.0.1:123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listen normally on 3 eth0 172.31.19.73:123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listen normally on 4 lo [::1]:123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: bind(21) AF_INET6 fe80::441:f1ff:fe85:5a23%2#123 flags 0x11 failed: Cannot assign requested address Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: unable to create socket on eth0 (5) for fe80::441:f1ff:fe85:5a23%2#123 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: failed to init interface for address fe80::441:f1ff:fe85:5a23%2 Apr 24 23:37:48.569529 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: Listening on routing socket on fd #21 for interface updates Apr 24 23:37:48.542722 ntpd[1908]: ntpd 4.2.8p17@1.4004-o Fri Apr 24 21:50:58 UTC 2026 (1): Starting Apr 24 23:37:48.596166 extend-filesystems[1906]: Checking size of /dev/nvme0n1p9 Apr 24 23:37:48.542776 ntpd[1908]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Apr 24 23:37:48.593888 (ntainerd)[1941]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Apr 24 23:37:48.604103 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 24 23:37:48.604103 ntpd[1908]: 24 Apr 23:37:48 ntpd[1908]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 24 23:37:48.542797 ntpd[1908]: ---------------------------------------------------- Apr 24 23:37:48.601261 systemd[1]: Finished setup-oem.service - Setup OEM. Apr 24 23:37:48.542817 ntpd[1908]: ntp-4 is maintained by Network Time Foundation, Apr 24 23:37:48.542836 ntpd[1908]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Apr 24 23:37:48.542854 ntpd[1908]: corporation. Support and training for ntp-4 are Apr 24 23:37:48.542873 ntpd[1908]: available at https://www.nwtime.org/support Apr 24 23:37:48.542892 ntpd[1908]: ---------------------------------------------------- Apr 24 23:37:48.549758 ntpd[1908]: proto: precision = 0.096 usec (-23) Apr 24 23:37:48.622233 update_engine[1918]: I20260424 23:37:48.621296 1918 main.cc:92] Flatcar Update Engine starting Apr 24 23:37:48.556235 ntpd[1908]: basedate set to 2026-04-12 Apr 24 23:37:48.556275 ntpd[1908]: gps base set to 2026-04-12 (week 2414) Apr 24 23:37:48.566236 ntpd[1908]: Listen and drop on 0 v6wildcard [::]:123 Apr 24 23:37:48.566331 ntpd[1908]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Apr 24 23:37:48.566672 ntpd[1908]: Listen normally on 2 lo 127.0.0.1:123 Apr 24 23:37:48.566746 ntpd[1908]: Listen normally on 3 eth0 172.31.19.73:123 Apr 24 23:37:48.566817 ntpd[1908]: Listen normally on 4 lo [::1]:123 Apr 24 23:37:48.566927 ntpd[1908]: bind(21) AF_INET6 fe80::441:f1ff:fe85:5a23%2#123 flags 0x11 failed: Cannot assign requested address Apr 24 23:37:48.566979 ntpd[1908]: unable to create socket on eth0 (5) for fe80::441:f1ff:fe85:5a23%2#123 Apr 24 23:37:48.567009 ntpd[1908]: failed to init interface for address fe80::441:f1ff:fe85:5a23%2 Apr 24 23:37:48.567073 ntpd[1908]: Listening on routing socket on fd #21 for interface updates Apr 24 23:37:48.590991 ntpd[1908]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 24 23:37:48.591047 ntpd[1908]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Apr 24 23:37:48.635658 jq[1936]: true Apr 24 23:37:48.634493 systemd[1]: Started update-engine.service - Update Engine. Apr 24 23:37:48.650865 update_engine[1918]: I20260424 23:37:48.642438 1918 update_check_scheduler.cc:74] Next update check in 8m46s Apr 24 23:37:48.651080 extend-filesystems[1906]: Resized partition /dev/nvme0n1p9 Apr 24 23:37:48.652867 systemd[1]: Started locksmithd.service - Cluster reboot manager. Apr 24 23:37:48.665090 extend-filesystems[1952]: resize2fs 1.47.1 (20-May-2024) Apr 24 23:37:48.682626 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Apr 24 23:37:48.798884 systemd-logind[1915]: Watching system buttons on /dev/input/event0 (Power Button) Apr 24 23:37:48.798929 systemd-logind[1915]: Watching system buttons on /dev/input/event1 (Sleep Button) Apr 24 23:37:48.801377 systemd-logind[1915]: New seat seat0. Apr 24 23:37:48.808333 systemd[1]: Started systemd-logind.service - User Login Management. Apr 24 23:37:48.827274 coreos-metadata[1903]: Apr 24 23:37:48.826 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 24 23:37:48.834736 coreos-metadata[1903]: Apr 24 23:37:48.834 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Apr 24 23:37:48.834736 coreos-metadata[1903]: Apr 24 23:37:48.834 INFO Fetch successful Apr 24 23:37:48.835160 coreos-metadata[1903]: Apr 24 23:37:48.834 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Apr 24 23:37:48.837507 coreos-metadata[1903]: Apr 24 23:37:48.836 INFO Fetch successful Apr 24 23:37:48.839784 coreos-metadata[1903]: Apr 24 23:37:48.838 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Apr 24 23:37:48.845750 coreos-metadata[1903]: Apr 24 23:37:48.840 INFO Fetch successful Apr 24 23:37:48.845750 coreos-metadata[1903]: Apr 24 23:37:48.840 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Apr 24 23:37:48.847994 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Apr 24 23:37:48.848100 coreos-metadata[1903]: Apr 24 23:37:48.847 INFO Fetch successful Apr 24 23:37:48.848100 coreos-metadata[1903]: Apr 24 23:37:48.847 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Apr 24 23:37:48.848665 coreos-metadata[1903]: Apr 24 23:37:48.848 INFO Fetch failed with 404: resource not found Apr 24 23:37:48.848665 coreos-metadata[1903]: Apr 24 23:37:48.848 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.849 INFO Fetch successful Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.851 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.851 INFO Fetch successful Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.851 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.857 INFO Fetch successful Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.857 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.859 INFO Fetch successful Apr 24 23:37:48.860083 coreos-metadata[1903]: Apr 24 23:37:48.859 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Apr 24 23:37:48.864674 extend-filesystems[1952]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Apr 24 23:37:48.864674 extend-filesystems[1952]: old_desc_blocks = 1, new_desc_blocks = 2 Apr 24 23:37:48.864674 extend-filesystems[1952]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Apr 24 23:37:48.894925 extend-filesystems[1906]: Resized filesystem in /dev/nvme0n1p9 Apr 24 23:37:48.868842 systemd[1]: extend-filesystems.service: Deactivated successfully. Apr 24 23:37:48.895350 coreos-metadata[1903]: Apr 24 23:37:48.866 INFO Fetch successful Apr 24 23:37:48.869283 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Apr 24 23:37:48.924254 bash[1975]: Updated "/home/core/.ssh/authorized_keys" Apr 24 23:37:48.933031 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Apr 24 23:37:48.948121 systemd[1]: Starting sshkeys.service... Apr 24 23:37:49.005519 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Apr 24 23:37:49.010700 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Apr 24 23:37:49.042093 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Apr 24 23:37:49.056759 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (1674) Apr 24 23:37:49.067311 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Apr 24 23:37:49.087805 dbus-daemon[1904]: [system] Successfully activated service 'org.freedesktop.hostname1' Apr 24 23:37:49.088105 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Apr 24 23:37:49.097813 dbus-daemon[1904]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1931 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Apr 24 23:37:49.114379 systemd[1]: Starting polkit.service - Authorization Manager... Apr 24 23:37:49.225474 polkitd[1996]: Started polkitd version 121 Apr 24 23:37:49.269677 polkitd[1996]: Loading rules from directory /etc/polkit-1/rules.d Apr 24 23:37:49.271629 polkitd[1996]: Loading rules from directory /usr/share/polkit-1/rules.d Apr 24 23:37:49.278653 polkitd[1996]: Finished loading, compiling and executing 2 rules Apr 24 23:37:49.279782 dbus-daemon[1904]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Apr 24 23:37:49.280140 systemd[1]: Started polkit.service - Authorization Manager. Apr 24 23:37:49.283970 polkitd[1996]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Apr 24 23:37:49.377126 systemd-resolved[1838]: System hostname changed to 'ip-172-31-19-73'. Apr 24 23:37:49.377377 systemd-hostnamed[1931]: Hostname set to (transient) Apr 24 23:37:49.427728 coreos-metadata[1992]: Apr 24 23:37:49.424 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Apr 24 23:37:49.427728 coreos-metadata[1992]: Apr 24 23:37:49.427 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Apr 24 23:37:49.433962 coreos-metadata[1992]: Apr 24 23:37:49.431 INFO Fetch successful Apr 24 23:37:49.433962 coreos-metadata[1992]: Apr 24 23:37:49.431 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Apr 24 23:37:49.433962 coreos-metadata[1992]: Apr 24 23:37:49.433 INFO Fetch successful Apr 24 23:37:49.438699 unknown[1992]: wrote ssh authorized keys file for user: core Apr 24 23:37:49.508201 update-ssh-keys[2059]: Updated "/home/core/.ssh/authorized_keys" Apr 24 23:37:49.512689 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Apr 24 23:37:49.529233 systemd[1]: Finished sshkeys.service. Apr 24 23:37:49.544749 ntpd[1908]: bind(24) AF_INET6 fe80::441:f1ff:fe85:5a23%2#123 flags 0x11 failed: Cannot assign requested address Apr 24 23:37:49.545912 ntpd[1908]: 24 Apr 23:37:49 ntpd[1908]: bind(24) AF_INET6 fe80::441:f1ff:fe85:5a23%2#123 flags 0x11 failed: Cannot assign requested address Apr 24 23:37:49.545912 ntpd[1908]: 24 Apr 23:37:49 ntpd[1908]: unable to create socket on eth0 (6) for fe80::441:f1ff:fe85:5a23%2#123 Apr 24 23:37:49.545912 ntpd[1908]: 24 Apr 23:37:49 ntpd[1908]: failed to init interface for address fe80::441:f1ff:fe85:5a23%2 Apr 24 23:37:49.544813 ntpd[1908]: unable to create socket on eth0 (6) for fe80::441:f1ff:fe85:5a23%2#123 Apr 24 23:37:49.544844 ntpd[1908]: failed to init interface for address fe80::441:f1ff:fe85:5a23%2 Apr 24 23:37:49.560773 systemd-networkd[1837]: eth0: Gained IPv6LL Apr 24 23:37:49.576408 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Apr 24 23:37:49.580944 systemd[1]: Reached target network-online.target - Network is Online. Apr 24 23:37:49.623621 containerd[1941]: time="2026-04-24T23:37:49.622013016Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Apr 24 23:37:49.661902 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Apr 24 23:37:49.669098 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 23:37:49.679754 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Apr 24 23:37:49.831933 containerd[1941]: time="2026-04-24T23:37:49.831833233Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.840921 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849023161Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.127-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849105925Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849150145Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849473941Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849519421Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849673645Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.849717169Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.850054189Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.850089913Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.850123477Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Apr 24 23:37:49.855697 containerd[1941]: time="2026-04-24T23:37:49.850149925Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.857419 containerd[1941]: time="2026-04-24T23:37:49.850326781Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.858658 containerd[1941]: time="2026-04-24T23:37:49.858182809Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Apr 24 23:37:49.861056 containerd[1941]: time="2026-04-24T23:37:49.860985061Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Apr 24 23:37:49.861056 containerd[1941]: time="2026-04-24T23:37:49.861041929Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Apr 24 23:37:49.861346 containerd[1941]: time="2026-04-24T23:37:49.861291481Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Apr 24 23:37:49.861501 containerd[1941]: time="2026-04-24T23:37:49.861452041Z" level=info msg="metadata content store policy set" policy=shared Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872443897Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872538049Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872601913Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872643277Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872694349Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.872996569Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Apr 24 23:37:49.875081 containerd[1941]: time="2026-04-24T23:37:49.873415933Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Apr 24 23:37:49.877863 containerd[1941]: time="2026-04-24T23:37:49.877798417Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878020357Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878066233Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878102005Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878138497Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878171509Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878208097Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878243197Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878290573Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878353237Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878383141Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878428093Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878460649Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878490829Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.878625 containerd[1941]: time="2026-04-24T23:37:49.878523301Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879307 containerd[1941]: time="2026-04-24T23:37:49.878555149Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879510445Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879567013Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879629425Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879667429Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879704917Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879734449Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879768241Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879798193Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.879971 containerd[1941]: time="2026-04-24T23:37:49.879854185Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Apr 24 23:37:49.883079 containerd[1941]: time="2026-04-24T23:37:49.882648265Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.883079 containerd[1941]: time="2026-04-24T23:37:49.882702457Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.883079 containerd[1941]: time="2026-04-24T23:37:49.882754273Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Apr 24 23:37:49.883951 containerd[1941]: time="2026-04-24T23:37:49.883464841Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Apr 24 23:37:49.884320 containerd[1941]: time="2026-04-24T23:37:49.884196193Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Apr 24 23:37:49.884320 containerd[1941]: time="2026-04-24T23:37:49.884241013Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Apr 24 23:37:49.884571 containerd[1941]: time="2026-04-24T23:37:49.884532337Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Apr 24 23:37:49.884698 containerd[1941]: time="2026-04-24T23:37:49.884670973Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.884838 containerd[1941]: time="2026-04-24T23:37:49.884809873Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Apr 24 23:37:49.885118 containerd[1941]: time="2026-04-24T23:37:49.885081793Z" level=info msg="NRI interface is disabled by configuration." Apr 24 23:37:49.886399 containerd[1941]: time="2026-04-24T23:37:49.885659257Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Apr 24 23:37:49.888758 containerd[1941]: time="2026-04-24T23:37:49.888098173Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Apr 24 23:37:49.888758 containerd[1941]: time="2026-04-24T23:37:49.888258565Z" level=info msg="Connect containerd service" Apr 24 23:37:49.888758 containerd[1941]: time="2026-04-24T23:37:49.888332761Z" level=info msg="using legacy CRI server" Apr 24 23:37:49.888758 containerd[1941]: time="2026-04-24T23:37:49.888353341Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Apr 24 23:37:49.888758 containerd[1941]: time="2026-04-24T23:37:49.888549661Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Apr 24 23:37:49.899126 containerd[1941]: time="2026-04-24T23:37:49.899062297Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Apr 24 23:37:49.903791 containerd[1941]: time="2026-04-24T23:37:49.903688405Z" level=info msg="Start subscribing containerd event" Apr 24 23:37:49.903926 containerd[1941]: time="2026-04-24T23:37:49.903810505Z" level=info msg="Start recovering state" Apr 24 23:37:49.903978 containerd[1941]: time="2026-04-24T23:37:49.903950965Z" level=info msg="Start event monitor" Apr 24 23:37:49.904060 containerd[1941]: time="2026-04-24T23:37:49.903977293Z" level=info msg="Start snapshots syncer" Apr 24 23:37:49.904060 containerd[1941]: time="2026-04-24T23:37:49.904001161Z" level=info msg="Start cni network conf syncer for default" Apr 24 23:37:49.904060 containerd[1941]: time="2026-04-24T23:37:49.904020157Z" level=info msg="Start streaming server" Apr 24 23:37:49.905526 containerd[1941]: time="2026-04-24T23:37:49.904893889Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Apr 24 23:37:49.905526 containerd[1941]: time="2026-04-24T23:37:49.905041609Z" level=info msg=serving... address=/run/containerd/containerd.sock Apr 24 23:37:49.905291 systemd[1]: Started containerd.service - containerd container runtime. Apr 24 23:37:49.911276 containerd[1941]: time="2026-04-24T23:37:49.909448237Z" level=info msg="containerd successfully booted in 0.294196s" Apr 24 23:37:49.934739 amazon-ssm-agent[2084]: Initializing new seelog logger Apr 24 23:37:49.935228 amazon-ssm-agent[2084]: New Seelog Logger Creation Complete Apr 24 23:37:49.935228 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.935228 amazon-ssm-agent[2084]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.936497 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 processing appconfig overrides Apr 24 23:37:49.936497 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.936497 amazon-ssm-agent[2084]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.936497 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 processing appconfig overrides Apr 24 23:37:49.937785 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.937785 amazon-ssm-agent[2084]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.937785 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 processing appconfig overrides Apr 24 23:37:49.939501 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO Proxy environment variables: Apr 24 23:37:49.947093 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.947093 amazon-ssm-agent[2084]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Apr 24 23:37:49.947296 amazon-ssm-agent[2084]: 2026/04/24 23:37:49 processing appconfig overrides Apr 24 23:37:49.965273 locksmithd[1951]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Apr 24 23:37:50.046189 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO https_proxy: Apr 24 23:37:50.146690 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO http_proxy: Apr 24 23:37:50.244776 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO no_proxy: Apr 24 23:37:50.342992 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO Checking if agent identity type OnPrem can be assumed Apr 24 23:37:50.441218 amazon-ssm-agent[2084]: 2026-04-24 23:37:49 INFO Checking if agent identity type EC2 can be assumed Apr 24 23:37:50.519172 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Apr 24 23:37:50.540686 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO Agent will take identity from EC2 Apr 24 23:37:50.640018 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 24 23:37:50.738783 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 24 23:37:50.838789 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] using named pipe channel for IPC Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] Starting Core Agent Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [amazon-ssm-agent] registrar detected. Attempting registration Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [Registrar] Starting registrar module Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [EC2Identity] EC2 registration was successful. Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [CredentialRefresher] credentialRefresher has started Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [CredentialRefresher] Starting credentials refresher loop Apr 24 23:37:50.845657 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO EC2RoleProvider Successfully connected with instance profile role credentials Apr 24 23:37:50.939191 amazon-ssm-agent[2084]: 2026-04-24 23:37:50 INFO [CredentialRefresher] Next credential rotation will be in 31.4999872221 minutes Apr 24 23:37:51.020250 sshd_keygen[1940]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Apr 24 23:37:51.072690 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Apr 24 23:37:51.084296 systemd[1]: Starting issuegen.service - Generate /run/issue... Apr 24 23:37:51.096945 systemd[1]: Started sshd@0-172.31.19.73:22-20.229.252.112:37824.service - OpenSSH per-connection server daemon (20.229.252.112:37824). Apr 24 23:37:51.110500 systemd[1]: issuegen.service: Deactivated successfully. Apr 24 23:37:51.112174 systemd[1]: Finished issuegen.service - Generate /run/issue. Apr 24 23:37:51.124945 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Apr 24 23:37:51.151661 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Apr 24 23:37:51.164153 systemd[1]: Started getty@tty1.service - Getty on tty1. Apr 24 23:37:51.177132 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Apr 24 23:37:51.181074 systemd[1]: Reached target getty.target - Login Prompts. Apr 24 23:37:51.880095 amazon-ssm-agent[2084]: 2026-04-24 23:37:51 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Apr 24 23:37:51.979284 amazon-ssm-agent[2084]: 2026-04-24 23:37:51 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2144) started Apr 24 23:37:52.081616 amazon-ssm-agent[2084]: 2026-04-24 23:37:51 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Apr 24 23:37:52.086018 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 23:37:52.094109 systemd[1]: Reached target multi-user.target - Multi-User System. Apr 24 23:37:52.100131 systemd[1]: Startup finished in 1.270s (kernel) + 8.694s (initrd) + 9.629s (userspace) = 19.594s. Apr 24 23:37:52.111651 (kubelet)[2154]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Apr 24 23:37:52.204419 sshd[2134]: Accepted publickey for core from 20.229.252.112 port 37824 ssh2: RSA SHA256:EpOBCscCvamodiF49drNiIRDMxdv0LtYbixE7WaoRrA Apr 24 23:37:52.208823 sshd[2134]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 23:37:52.230172 systemd-logind[1915]: New session 1 of user core. Apr 24 23:37:52.234738 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Apr 24 23:37:52.243130 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Apr 24 23:37:52.280363 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Apr 24 23:37:52.291167 systemd[1]: Starting user@500.service - User Manager for UID 500... Apr 24 23:37:52.304335 (systemd)[2166]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Apr 24 23:37:52.543811 ntpd[1908]: Listen normally on 7 eth0 [fe80::441:f1ff:fe85:5a23%2]:123 Apr 24 23:37:52.544306 ntpd[1908]: 24 Apr 23:37:52 ntpd[1908]: Listen normally on 7 eth0 [fe80::441:f1ff:fe85:5a23%2]:123 Apr 24 23:37:52.547938 systemd[2166]: Queued start job for default target default.target. Apr 24 23:37:52.554813 systemd[2166]: Created slice app.slice - User Application Slice. Apr 24 23:37:52.554883 systemd[2166]: Reached target paths.target - Paths. Apr 24 23:37:52.554918 systemd[2166]: Reached target timers.target - Timers. Apr 24 23:37:52.557888 systemd[2166]: Starting dbus.socket - D-Bus User Message Bus Socket... Apr 24 23:37:52.584183 systemd[2166]: Listening on dbus.socket - D-Bus User Message Bus Socket. Apr 24 23:37:52.584451 systemd[2166]: Reached target sockets.target - Sockets. Apr 24 23:37:52.584500 systemd[2166]: Reached target basic.target - Basic System. Apr 24 23:37:52.584629 systemd[2166]: Reached target default.target - Main User Target. Apr 24 23:37:52.584699 systemd[2166]: Startup finished in 267ms. Apr 24 23:37:52.584978 systemd[1]: Started user@500.service - User Manager for UID 500. Apr 24 23:37:52.592865 systemd[1]: Started session-1.scope - Session 1 of User core. Apr 24 23:37:53.318124 systemd[1]: Started sshd@1-172.31.19.73:22-20.229.252.112:37836.service - OpenSSH per-connection server daemon (20.229.252.112:37836). Apr 24 23:37:53.430106 kubelet[2154]: E0424 23:37:53.430046 2154 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Apr 24 23:37:53.435656 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Apr 24 23:37:53.436114 systemd[1]: kubelet.service: Failed with result 'exit-code'. Apr 24 23:37:53.436817 systemd[1]: kubelet.service: Consumed 1.403s CPU time. Apr 24 23:37:54.365120 sshd[2181]: Accepted publickey for core from 20.229.252.112 port 37836 ssh2: RSA SHA256:EpOBCscCvamodiF49drNiIRDMxdv0LtYbixE7WaoRrA Apr 24 23:37:54.366803 sshd[2181]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 23:37:54.375069 systemd-logind[1915]: New session 2 of user core. Apr 24 23:37:54.383925 systemd[1]: Started session-2.scope - Session 2 of User core. Apr 24 23:37:55.078372 sshd[2181]: pam_unix(sshd:session): session closed for user core Apr 24 23:37:55.087493 systemd[1]: sshd@1-172.31.19.73:22-20.229.252.112:37836.service: Deactivated successfully. Apr 24 23:37:55.093604 systemd[1]: session-2.scope: Deactivated successfully. Apr 24 23:37:55.098090 systemd-logind[1915]: Session 2 logged out. Waiting for processes to exit. Apr 24 23:37:55.100922 systemd-logind[1915]: Removed session 2. Apr 24 23:37:55.247145 systemd[1]: Started sshd@2-172.31.19.73:22-20.229.252.112:37852.service - OpenSSH per-connection server daemon (20.229.252.112:37852). Apr 24 23:37:55.056060 systemd-resolved[1838]: Clock change detected. Flushing caches. Apr 24 23:37:55.062823 systemd-journald[1486]: Time jumped backwards, rotating. Apr 24 23:37:55.759247 sshd[2190]: Accepted publickey for core from 20.229.252.112 port 37852 ssh2: RSA SHA256:EpOBCscCvamodiF49drNiIRDMxdv0LtYbixE7WaoRrA Apr 24 23:37:55.761144 sshd[2190]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 23:37:55.770585 systemd-logind[1915]: New session 3 of user core. Apr 24 23:37:55.780482 systemd[1]: Started session-3.scope - Session 3 of User core. Apr 24 23:37:56.433233 sshd[2190]: pam_unix(sshd:session): session closed for user core Apr 24 23:37:56.440040 systemd[1]: sshd@2-172.31.19.73:22-20.229.252.112:37852.service: Deactivated successfully. Apr 24 23:37:56.443759 systemd[1]: session-3.scope: Deactivated successfully. Apr 24 23:37:56.445442 systemd-logind[1915]: Session 3 logged out. Waiting for processes to exit. Apr 24 23:37:56.447319 systemd-logind[1915]: Removed session 3. Apr 24 23:37:56.630721 systemd[1]: Started sshd@3-172.31.19.73:22-20.229.252.112:54518.service - OpenSSH per-connection server daemon (20.229.252.112:54518). Apr 24 23:37:57.647246 sshd[2198]: Accepted publickey for core from 20.229.252.112 port 54518 ssh2: RSA SHA256:EpOBCscCvamodiF49drNiIRDMxdv0LtYbixE7WaoRrA Apr 24 23:37:57.649144 sshd[2198]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 23:37:57.659555 systemd-logind[1915]: New session 4 of user core. Apr 24 23:37:57.671477 systemd[1]: Started session-4.scope - Session 4 of User core. Apr 24 23:37:58.353083 sshd[2198]: pam_unix(sshd:session): session closed for user core Apr 24 23:37:58.359605 systemd[1]: sshd@3-172.31.19.73:22-20.229.252.112:54518.service: Deactivated successfully. Apr 24 23:37:58.360458 systemd-logind[1915]: Session 4 logged out. Waiting for processes to exit. Apr 24 23:37:58.363712 systemd[1]: session-4.scope: Deactivated successfully. Apr 24 23:37:58.369015 systemd-logind[1915]: Removed session 4. Apr 24 23:37:58.526719 systemd[1]: Started sshd@4-172.31.19.73:22-20.229.252.112:54528.service - OpenSSH per-connection server daemon (20.229.252.112:54528). Apr 24 23:37:59.515235 sshd[2205]: Accepted publickey for core from 20.229.252.112 port 54528 ssh2: RSA SHA256:EpOBCscCvamodiF49drNiIRDMxdv0LtYbixE7WaoRrA Apr 24 23:37:59.517305 sshd[2205]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Apr 24 23:37:59.525033 systemd-logind[1915]: New session 5 of user core. Apr 24 23:37:59.538460 systemd[1]: Started session-5.scope - Session 5 of User core. Apr 24 23:38:00.056342 sudo[2208]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Apr 24 23:38:00.057621 sudo[2208]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Apr 24 23:38:01.246640 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 23:38:01.248129 systemd[1]: kubelet.service: Consumed 1.403s CPU time. Apr 24 23:38:01.265075 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 23:38:01.328381 systemd[1]: Reloading requested from client PID 2242 ('systemctl') (unit session-5.scope)... Apr 24 23:38:01.328419 systemd[1]: Reloading... Apr 24 23:38:01.601234 zram_generator::config[2285]: No configuration found. Apr 24 23:38:01.868191 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Apr 24 23:38:02.047303 systemd[1]: Reloading finished in 718 ms. Apr 24 23:38:02.146472 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Apr 24 23:38:02.146670 systemd[1]: kubelet.service: Failed with result 'signal'. Apr 24 23:38:02.147360 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 23:38:02.156891 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Apr 24 23:38:02.513506 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Apr 24 23:38:02.522797 (kubelet)[2345]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Apr 24 23:38:02.597221 kubelet[2345]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Apr 24 23:38:02.597221 kubelet[2345]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Apr 24 23:38:02.597221 kubelet[2345]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Apr 24 23:38:02.597221 kubelet[2345]: I0424 23:38:02.596738 2345 server.go:212] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Apr 24 23:38:03.572262 kubelet[2345]: I0424 23:38:03.572142 2345 server.go:530] "Kubelet version" kubeletVersion="v1.33.8" Apr 24 23:38:03.572262 kubelet[2345]: I0424 23:38:03.572241 2345 server.go:532] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Apr 24 23:38:03.572783 kubelet[2345]: I0424 23:38:03.572715 2345 server.go:956] "Client rotation is on, will bootstrap in background" Apr 24 23:38:03.632783 kubelet[2345]: I0424 23:38:03.632707 2345 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Apr 24 23:38:03.650210 kubelet[2345]: E0424 23:38:03.650139 2345 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Apr 24 23:38:03.650210 kubelet[2345]: I0424 23:38:03.650211 2345 server.go:1423] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Apr 24 23:38:03.656113 kubelet[2345]: I0424 23:38:03.656048 2345 server.go:782] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Apr 24 23:38:03.656630 kubelet[2345]: I0424 23:38:03.656567 2345 container_manager_linux.go:267] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Apr 24 23:38:03.656977 kubelet[2345]: I0424 23:38:03.656625 2345 container_manager_linux.go:272] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.19.73","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Apr 24 23:38:03.656977 kubelet[2345]: I0424 23:38:03.656920 2345 topology_manager.go:138] "Creating topology manager with none policy" Apr 24 23:38:03.656977 kubelet[2345]: I0424 23:38:03.656941 2345 container_manager_linux.go:303] "Creating device plugin manager" Apr 24 23:38:03.657365 kubelet[2345]: I0424 23:38:03.657321 2345 state_mem.go:36] "Initialized new in-memory state store" Apr 24 23:38:03.663382 kubelet[2345]: I0424 23:38:03.663312 2345 kubelet.go:480] "Attempting to sync node with API server" Apr 24 23:38:03.663382 kubelet[2345]: I0424 23:38:03.663374 2345 kubelet.go:375] "Adding static pod path" path="/etc/kubernetes/manifests" Apr 24 23:38:03.664406 kubelet[2345]: I0424 23:38:03.664355 2345 kubelet.go:386] "Adding apiserver pod source" Apr 24 23:38:03.664577 kubelet[2345]: I0424 23:38:03.664420 2345 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Apr 24 23:38:03.666203 kubelet[2345]: E0424 23:38:03.665999 2345 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:03.666203 kubelet[2345]: E0424 23:38:03.666107 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:03.668249 kubelet[2345]: I0424 23:38:03.668159 2345 kuberuntime_manager.go:279] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Apr 24 23:38:03.669689 kubelet[2345]: I0424 23:38:03.669659 2345 kubelet.go:935] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Apr 24 23:38:03.670205 kubelet[2345]: W0424 23:38:03.670018 2345 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Apr 24 23:38:03.676327 kubelet[2345]: I0424 23:38:03.676222 2345 watchdog_linux.go:99] "Systemd watchdog is not enabled" Apr 24 23:38:03.676761 kubelet[2345]: I0424 23:38:03.676487 2345 server.go:1289] "Started kubelet" Apr 24 23:38:03.679284 kubelet[2345]: I0424 23:38:03.679095 2345 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Apr 24 23:38:03.680996 kubelet[2345]: I0424 23:38:03.680936 2345 server.go:317] "Adding debug handlers to kubelet server" Apr 24 23:38:03.683214 kubelet[2345]: I0424 23:38:03.682549 2345 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Apr 24 23:38:03.683214 kubelet[2345]: I0424 23:38:03.683107 2345 server.go:255] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Apr 24 23:38:03.686154 kubelet[2345]: E0424 23:38:03.686095 2345 reflector.go:200] "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" Apr 24 23:38:03.686637 kubelet[2345]: E0424 23:38:03.686592 2345 reflector.go:200] "Failed to watch" err="failed to list *v1.Node: nodes \"172.31.19.73\" 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" Apr 24 23:38:03.690685 kubelet[2345]: I0424 23:38:03.690645 2345 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Apr 24 23:38:03.701493 kubelet[2345]: I0424 23:38:03.701337 2345 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Apr 24 23:38:03.702556 kubelet[2345]: E0424 23:38:03.702507 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:03.707323 kubelet[2345]: I0424 23:38:03.703872 2345 volume_manager.go:297] "Starting Kubelet Volume Manager" Apr 24 23:38:03.707738 kubelet[2345]: I0424 23:38:03.703885 2345 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Apr 24 23:38:03.707976 kubelet[2345]: I0424 23:38:03.707954 2345 reconciler.go:26] "Reconciler: start to sync state" Apr 24 23:38:03.709726 kubelet[2345]: I0424 23:38:03.709687 2345 factory.go:223] Registration of the systemd container factory successfully Apr 24 23:38:03.710201 kubelet[2345]: I0424 23:38:03.710033 2345 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Apr 24 23:38:03.714732 kubelet[2345]: E0424 23:38:03.714692 2345 kubelet.go:1600] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Apr 24 23:38:03.716462 kubelet[2345]: E0424 23:38:03.715509 2345 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"172.31.19.73\" not found" node="172.31.19.73" Apr 24 23:38:03.718962 kubelet[2345]: I0424 23:38:03.718906 2345 factory.go:223] Registration of the containerd container factory successfully Apr 24 23:38:03.757938 kubelet[2345]: I0424 23:38:03.757341 2345 cpu_manager.go:221] "Starting CPU manager" policy="none" Apr 24 23:38:03.757938 kubelet[2345]: I0424 23:38:03.757378 2345 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Apr 24 23:38:03.757938 kubelet[2345]: I0424 23:38:03.757411 2345 state_mem.go:36] "Initialized new in-memory state store" Apr 24 23:38:03.760488 kubelet[2345]: I0424 23:38:03.760431 2345 policy_none.go:49] "None policy: Start" Apr 24 23:38:03.760488 kubelet[2345]: I0424 23:38:03.760482 2345 memory_manager.go:186] "Starting memorymanager" policy="None" Apr 24 23:38:03.760663 kubelet[2345]: I0424 23:38:03.760556 2345 state_mem.go:35] "Initializing new in-memory state store" Apr 24 23:38:03.775706 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Apr 24 23:38:03.798374 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Apr 24 23:38:03.808604 kubelet[2345]: E0424 23:38:03.808538 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:03.810701 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Apr 24 23:38:03.824343 kubelet[2345]: E0424 23:38:03.823645 2345 manager.go:517] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Apr 24 23:38:03.824343 kubelet[2345]: I0424 23:38:03.823953 2345 eviction_manager.go:189] "Eviction manager: starting control loop" Apr 24 23:38:03.824343 kubelet[2345]: I0424 23:38:03.823973 2345 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Apr 24 23:38:03.825242 kubelet[2345]: I0424 23:38:03.825093 2345 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Apr 24 23:38:03.834602 kubelet[2345]: I0424 23:38:03.834525 2345 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv4" Apr 24 23:38:03.835110 kubelet[2345]: E0424 23:38:03.835053 2345 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Apr 24 23:38:03.835277 kubelet[2345]: E0424 23:38:03.835129 2345 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.19.73\" not found" Apr 24 23:38:03.838506 kubelet[2345]: I0424 23:38:03.838459 2345 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv6" Apr 24 23:38:03.838676 kubelet[2345]: I0424 23:38:03.838653 2345 status_manager.go:230] "Starting to sync pod status with apiserver" Apr 24 23:38:03.838805 kubelet[2345]: I0424 23:38:03.838781 2345 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Apr 24 23:38:03.839958 kubelet[2345]: I0424 23:38:03.839890 2345 kubelet.go:2436] "Starting kubelet main sync loop" Apr 24 23:38:03.840073 kubelet[2345]: E0424 23:38:03.840000 2345 kubelet.go:2460] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Apr 24 23:38:03.925958 kubelet[2345]: I0424 23:38:03.925908 2345 kubelet_node_status.go:75] "Attempting to register node" node="172.31.19.73" Apr 24 23:38:03.936925 kubelet[2345]: I0424 23:38:03.936884 2345 kubelet_node_status.go:78] "Successfully registered node" node="172.31.19.73" Apr 24 23:38:03.937114 kubelet[2345]: E0424 23:38:03.937091 2345 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"172.31.19.73\": node \"172.31.19.73\" not found" Apr 24 23:38:03.971218 kubelet[2345]: E0424 23:38:03.971142 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.071426 kubelet[2345]: E0424 23:38:04.071338 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.072514 sudo[2208]: pam_unix(sudo:session): session closed for user root Apr 24 23:38:04.171609 kubelet[2345]: E0424 23:38:04.171450 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.232488 sshd[2205]: pam_unix(sshd:session): session closed for user core Apr 24 23:38:04.240682 systemd-logind[1915]: Session 5 logged out. Waiting for processes to exit. Apr 24 23:38:04.241653 systemd[1]: sshd@4-172.31.19.73:22-20.229.252.112:54528.service: Deactivated successfully. Apr 24 23:38:04.246221 systemd[1]: session-5.scope: Deactivated successfully. Apr 24 23:38:04.248460 systemd-logind[1915]: Removed session 5. Apr 24 23:38:04.272286 kubelet[2345]: E0424 23:38:04.272224 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.373024 kubelet[2345]: E0424 23:38:04.372949 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.473826 kubelet[2345]: E0424 23:38:04.473749 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.574673 kubelet[2345]: E0424 23:38:04.574602 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.575943 kubelet[2345]: I0424 23:38:04.575747 2345 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Apr 24 23:38:04.576059 kubelet[2345]: I0424 23:38:04.575968 2345 reflector.go:556] "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" Apr 24 23:38:04.576386 kubelet[2345]: I0424 23:38:04.576329 2345 reflector.go:556] "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" Apr 24 23:38:04.666397 kubelet[2345]: E0424 23:38:04.666326 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:04.675816 kubelet[2345]: E0424 23:38:04.675759 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.776540 kubelet[2345]: E0424 23:38:04.776369 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.877351 kubelet[2345]: E0424 23:38:04.877265 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:04.978063 kubelet[2345]: E0424 23:38:04.977990 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:05.078982 kubelet[2345]: E0424 23:38:05.078832 2345 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"172.31.19.73\" not found" Apr 24 23:38:05.180908 kubelet[2345]: I0424 23:38:05.180854 2345 kuberuntime_manager.go:1746] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Apr 24 23:38:05.181881 containerd[1941]: time="2026-04-24T23:38:05.181810130Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Apr 24 23:38:05.182460 kubelet[2345]: I0424 23:38:05.182154 2345 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Apr 24 23:38:05.667251 kubelet[2345]: E0424 23:38:05.667027 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:05.667251 kubelet[2345]: I0424 23:38:05.667104 2345 apiserver.go:52] "Watching apiserver" Apr 24 23:38:05.688946 systemd[1]: Created slice kubepods-besteffort-podede5474f_40f3_4d28_9f7c_b6b12e579b8d.slice - libcontainer container kubepods-besteffort-podede5474f_40f3_4d28_9f7c_b6b12e579b8d.slice. Apr 24 23:38:05.709452 kubelet[2345]: I0424 23:38:05.708750 2345 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Apr 24 23:38:05.710426 systemd[1]: Created slice kubepods-burstable-pod0f6331e4_d772_44d4_a954_7a283517750a.slice - libcontainer container kubepods-burstable-pod0f6331e4_d772_44d4_a954_7a283517750a.slice. Apr 24 23:38:05.720924 kubelet[2345]: I0424 23:38:05.720878 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/ede5474f-40f3-4d28-9f7c-b6b12e579b8d-xtables-lock\") pod \"kube-proxy-frf5g\" (UID: \"ede5474f-40f3-4d28-9f7c-b6b12e579b8d\") " pod="kube-system/kube-proxy-frf5g" Apr 24 23:38:05.721131 kubelet[2345]: I0424 23:38:05.721102 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0f6331e4-d772-44d4-a954-7a283517750a-run\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:05.721636 kubelet[2345]: I0424 23:38:05.721282 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0f6331e4-d772-44d4-a954-7a283517750a-cni-plugin\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:05.721636 kubelet[2345]: I0424 23:38:05.721327 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0f6331e4-d772-44d4-a954-7a283517750a-cni\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:05.721636 kubelet[2345]: I0424 23:38:05.721364 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0f6331e4-d772-44d4-a954-7a283517750a-flannel-cfg\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:05.721636 kubelet[2345]: I0424 23:38:05.721400 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8dx7j\" (UniqueName: \"kubernetes.io/projected/0f6331e4-d772-44d4-a954-7a283517750a-kube-api-access-8dx7j\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:05.721636 kubelet[2345]: I0424 23:38:05.721438 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/ede5474f-40f3-4d28-9f7c-b6b12e579b8d-kube-proxy\") pod \"kube-proxy-frf5g\" (UID: \"ede5474f-40f3-4d28-9f7c-b6b12e579b8d\") " pod="kube-system/kube-proxy-frf5g" Apr 24 23:38:05.721912 kubelet[2345]: I0424 23:38:05.721474 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/ede5474f-40f3-4d28-9f7c-b6b12e579b8d-lib-modules\") pod \"kube-proxy-frf5g\" (UID: \"ede5474f-40f3-4d28-9f7c-b6b12e579b8d\") " pod="kube-system/kube-proxy-frf5g" Apr 24 23:38:05.721912 kubelet[2345]: I0424 23:38:05.721514 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-7qcxk\" (UniqueName: \"kubernetes.io/projected/ede5474f-40f3-4d28-9f7c-b6b12e579b8d-kube-api-access-7qcxk\") pod \"kube-proxy-frf5g\" (UID: \"ede5474f-40f3-4d28-9f7c-b6b12e579b8d\") " pod="kube-system/kube-proxy-frf5g" Apr 24 23:38:05.721912 kubelet[2345]: I0424 23:38:05.721547 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0f6331e4-d772-44d4-a954-7a283517750a-xtables-lock\") pod \"kube-flannel-ds-jq2f8\" (UID: \"0f6331e4-d772-44d4-a954-7a283517750a\") " pod="kube-flannel/kube-flannel-ds-jq2f8" Apr 24 23:38:06.004933 containerd[1941]: time="2026-04-24T23:38:06.004856546Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-frf5g,Uid:ede5474f-40f3-4d28-9f7c-b6b12e579b8d,Namespace:kube-system,Attempt:0,}" Apr 24 23:38:06.026567 containerd[1941]: time="2026-04-24T23:38:06.026515454Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-jq2f8,Uid:0f6331e4-d772-44d4-a954-7a283517750a,Namespace:kube-flannel,Attempt:0,}" Apr 24 23:38:06.557478 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1642292335.mount: Deactivated successfully. Apr 24 23:38:06.567313 containerd[1941]: time="2026-04-24T23:38:06.567227441Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 23:38:06.569158 containerd[1941]: time="2026-04-24T23:38:06.569071805Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 23:38:06.570325 containerd[1941]: time="2026-04-24T23:38:06.570260789Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Apr 24 23:38:06.571215 containerd[1941]: time="2026-04-24T23:38:06.570877553Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269173" Apr 24 23:38:06.573655 containerd[1941]: time="2026-04-24T23:38:06.572251625Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 23:38:06.578553 containerd[1941]: time="2026-04-24T23:38:06.578465765Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Apr 24 23:38:06.580586 containerd[1941]: time="2026-04-24T23:38:06.580282277Z" 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 575.302443ms" Apr 24 23:38:06.585012 containerd[1941]: time="2026-04-24T23:38:06.584934041Z" 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 557.983851ms" Apr 24 23:38:06.669400 kubelet[2345]: E0424 23:38:06.669310 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:06.751539 containerd[1941]: time="2026-04-24T23:38:06.751330530Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 24 23:38:06.751539 containerd[1941]: time="2026-04-24T23:38:06.751466742Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 24 23:38:06.751865 containerd[1941]: time="2026-04-24T23:38:06.751539234Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:06.752442 containerd[1941]: time="2026-04-24T23:38:06.752205390Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:06.760269 containerd[1941]: time="2026-04-24T23:38:06.760095366Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 24 23:38:06.760269 containerd[1941]: time="2026-04-24T23:38:06.760214514Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 24 23:38:06.761430 containerd[1941]: time="2026-04-24T23:38:06.761242290Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:06.761977 containerd[1941]: time="2026-04-24T23:38:06.761883114Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:06.895531 systemd[1]: Started cri-containerd-15a0743124f3ab4be90c294e1f7ec02f2392f65f54f3ab36fbd2c72ac3d9ea2e.scope - libcontainer container 15a0743124f3ab4be90c294e1f7ec02f2392f65f54f3ab36fbd2c72ac3d9ea2e. Apr 24 23:38:06.900459 systemd[1]: Started cri-containerd-4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba.scope - libcontainer container 4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba. Apr 24 23:38:06.971667 containerd[1941]: time="2026-04-24T23:38:06.971614387Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-frf5g,Uid:ede5474f-40f3-4d28-9f7c-b6b12e579b8d,Namespace:kube-system,Attempt:0,} returns sandbox id \"15a0743124f3ab4be90c294e1f7ec02f2392f65f54f3ab36fbd2c72ac3d9ea2e\"" Apr 24 23:38:06.976905 containerd[1941]: time="2026-04-24T23:38:06.976842775Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.11\"" Apr 24 23:38:06.989681 containerd[1941]: time="2026-04-24T23:38:06.989616199Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-jq2f8,Uid:0f6331e4-d772-44d4-a954-7a283517750a,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\"" Apr 24 23:38:07.669486 kubelet[2345]: E0424 23:38:07.669415 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:08.323386 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3303833271.mount: Deactivated successfully. Apr 24 23:38:08.670751 kubelet[2345]: E0424 23:38:08.670310 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:08.940305 containerd[1941]: time="2026-04-24T23:38:08.939824636Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.33.11\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:08.941482 containerd[1941]: time="2026-04-24T23:38:08.941402984Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.33.11: active requests=0, bytes read=28040508" Apr 24 23:38:08.942900 containerd[1941]: time="2026-04-24T23:38:08.942814352Z" level=info msg="ImageCreate event name:\"sha256:7ce14d6fb1e5134a578d2aaa327fd701273e3d222b9b8d88054dd86b87a7dc36\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:08.946777 containerd[1941]: time="2026-04-24T23:38:08.946699016Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:8d18637b5c5f58a4ca0163d3cf184e53d4c522963c242860562be7cb25e9303e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:08.949021 containerd[1941]: time="2026-04-24T23:38:08.948549561Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.33.11\" with image id \"sha256:7ce14d6fb1e5134a578d2aaa327fd701273e3d222b9b8d88054dd86b87a7dc36\", repo tag \"registry.k8s.io/kube-proxy:v1.33.11\", repo digest \"registry.k8s.io/kube-proxy@sha256:8d18637b5c5f58a4ca0163d3cf184e53d4c522963c242860562be7cb25e9303e\", size \"28039527\" in 1.971395494s" Apr 24 23:38:08.949021 containerd[1941]: time="2026-04-24T23:38:08.948616881Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.11\" returns image reference \"sha256:7ce14d6fb1e5134a578d2aaa327fd701273e3d222b9b8d88054dd86b87a7dc36\"" Apr 24 23:38:08.951033 containerd[1941]: time="2026-04-24T23:38:08.950919933Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Apr 24 23:38:08.955992 containerd[1941]: time="2026-04-24T23:38:08.955451277Z" level=info msg="CreateContainer within sandbox \"15a0743124f3ab4be90c294e1f7ec02f2392f65f54f3ab36fbd2c72ac3d9ea2e\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Apr 24 23:38:08.976470 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2241043482.mount: Deactivated successfully. Apr 24 23:38:08.985348 containerd[1941]: time="2026-04-24T23:38:08.985072509Z" level=info msg="CreateContainer within sandbox \"15a0743124f3ab4be90c294e1f7ec02f2392f65f54f3ab36fbd2c72ac3d9ea2e\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd\"" Apr 24 23:38:08.988545 containerd[1941]: time="2026-04-24T23:38:08.986610369Z" level=info msg="StartContainer for \"4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd\"" Apr 24 23:38:09.052540 systemd[1]: Started cri-containerd-4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd.scope - libcontainer container 4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd. Apr 24 23:38:09.108142 containerd[1941]: time="2026-04-24T23:38:09.106828457Z" level=info msg="StartContainer for \"4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd\" returns successfully" Apr 24 23:38:09.323625 systemd[1]: run-containerd-runc-k8s.io-4d2e5582a165b10e18d8cd65a924a1c871e57e767b171b24dd886bddb881eafd-runc.bpxYK1.mount: Deactivated successfully. Apr 24 23:38:09.671331 kubelet[2345]: E0424 23:38:09.670479 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:10.264160 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3091790993.mount: Deactivated successfully. Apr 24 23:38:10.323255 containerd[1941]: time="2026-04-24T23:38:10.322440199Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:10.325091 containerd[1941]: time="2026-04-24T23:38:10.325018327Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Apr 24 23:38:10.327210 containerd[1941]: time="2026-04-24T23:38:10.325970491Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:10.332548 containerd[1941]: time="2026-04-24T23:38:10.332477023Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:10.335143 containerd[1941]: time="2026-04-24T23:38:10.335078071Z" 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.384082298s" Apr 24 23:38:10.335334 containerd[1941]: time="2026-04-24T23:38:10.335138635Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Apr 24 23:38:10.349781 containerd[1941]: time="2026-04-24T23:38:10.349697863Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Apr 24 23:38:10.370953 containerd[1941]: time="2026-04-24T23:38:10.370762016Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3\"" Apr 24 23:38:10.372157 containerd[1941]: time="2026-04-24T23:38:10.372094976Z" level=info msg="StartContainer for \"5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3\"" Apr 24 23:38:10.439572 systemd[1]: Started cri-containerd-5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3.scope - libcontainer container 5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3. Apr 24 23:38:10.501542 containerd[1941]: time="2026-04-24T23:38:10.501342344Z" level=info msg="StartContainer for \"5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3\" returns successfully" Apr 24 23:38:10.503026 systemd[1]: cri-containerd-5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3.scope: Deactivated successfully. Apr 24 23:38:10.544930 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3-rootfs.mount: Deactivated successfully. Apr 24 23:38:10.671019 kubelet[2345]: E0424 23:38:10.670904 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:10.717141 containerd[1941]: time="2026-04-24T23:38:10.716798229Z" level=info msg="shim disconnected" id=5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3 namespace=k8s.io Apr 24 23:38:10.717141 containerd[1941]: time="2026-04-24T23:38:10.716877513Z" level=warning msg="cleaning up after shim disconnected" id=5368ef1889994b1a49621222bdc49904ad0837b9841bdb430d09d18409a9cfa3 namespace=k8s.io Apr 24 23:38:10.717141 containerd[1941]: time="2026-04-24T23:38:10.716897901Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 24 23:38:10.892343 containerd[1941]: time="2026-04-24T23:38:10.892022206Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Apr 24 23:38:10.911217 kubelet[2345]: I0424 23:38:10.910127 2345 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-frf5g" podStartSLOduration=5.935516348 podStartE2EDuration="7.910103374s" podCreationTimestamp="2026-04-24 23:38:03 +0000 UTC" firstStartedPulling="2026-04-24 23:38:06.975785227 +0000 UTC m=+4.442794271" lastFinishedPulling="2026-04-24 23:38:08.950372241 +0000 UTC m=+6.417381297" observedRunningTime="2026-04-24 23:38:09.901300245 +0000 UTC m=+7.368309301" watchObservedRunningTime="2026-04-24 23:38:10.910103374 +0000 UTC m=+8.377112430" Apr 24 23:38:11.672013 kubelet[2345]: E0424 23:38:11.671925 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:12.672954 kubelet[2345]: E0424 23:38:12.672878 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:13.281230 containerd[1941]: time="2026-04-24T23:38:13.279728458Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:13.283831 containerd[1941]: time="2026-04-24T23:38:13.283765582Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Apr 24 23:38:13.284287 containerd[1941]: time="2026-04-24T23:38:13.284241334Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:13.293611 containerd[1941]: time="2026-04-24T23:38:13.293532526Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:13.298392 containerd[1941]: time="2026-04-24T23:38:13.298074526Z" 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.405982528s" Apr 24 23:38:13.298392 containerd[1941]: time="2026-04-24T23:38:13.298155970Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Apr 24 23:38:13.307002 containerd[1941]: time="2026-04-24T23:38:13.306302182Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Apr 24 23:38:13.331264 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2863007963.mount: Deactivated successfully. Apr 24 23:38:13.341905 containerd[1941]: time="2026-04-24T23:38:13.341533954Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c\"" Apr 24 23:38:13.343673 containerd[1941]: time="2026-04-24T23:38:13.343429990Z" level=info msg="StartContainer for \"bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c\"" Apr 24 23:38:13.404589 systemd[1]: Started cri-containerd-bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c.scope - libcontainer container bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c. Apr 24 23:38:13.460037 containerd[1941]: time="2026-04-24T23:38:13.459969755Z" level=info msg="StartContainer for \"bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c\" returns successfully" Apr 24 23:38:13.460380 systemd[1]: cri-containerd-bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c.scope: Deactivated successfully. Apr 24 23:38:13.554442 kubelet[2345]: I0424 23:38:13.553474 2345 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Apr 24 23:38:13.615416 containerd[1941]: time="2026-04-24T23:38:13.615044964Z" level=info msg="shim disconnected" id=bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c namespace=k8s.io Apr 24 23:38:13.615416 containerd[1941]: time="2026-04-24T23:38:13.615118812Z" level=warning msg="cleaning up after shim disconnected" id=bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c namespace=k8s.io Apr 24 23:38:13.615416 containerd[1941]: time="2026-04-24T23:38:13.615139068Z" level=info msg="cleaning up dead shim" namespace=k8s.io Apr 24 23:38:13.637589 containerd[1941]: time="2026-04-24T23:38:13.637276548Z" level=warning msg="cleanup warnings time=\"2026-04-24T23:38:13Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=k8s.io Apr 24 23:38:13.673472 kubelet[2345]: E0424 23:38:13.673385 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:13.907776 containerd[1941]: time="2026-04-24T23:38:13.907608901Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Apr 24 23:38:13.927656 containerd[1941]: time="2026-04-24T23:38:13.927558109Z" level=info msg="CreateContainer within sandbox \"4bca80c73ccb0447761aec62b4ea2b1700c0f5f186e2bdd6c970aa5b0470eeba\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"94dd18137d19898e1208f74dd16923cf631845c8f89a776eb3c1d30c02dfe9b6\"" Apr 24 23:38:13.929511 containerd[1941]: time="2026-04-24T23:38:13.928556041Z" level=info msg="StartContainer for \"94dd18137d19898e1208f74dd16923cf631845c8f89a776eb3c1d30c02dfe9b6\"" Apr 24 23:38:13.975955 systemd[1]: Started cri-containerd-94dd18137d19898e1208f74dd16923cf631845c8f89a776eb3c1d30c02dfe9b6.scope - libcontainer container 94dd18137d19898e1208f74dd16923cf631845c8f89a776eb3c1d30c02dfe9b6. Apr 24 23:38:14.032449 containerd[1941]: time="2026-04-24T23:38:14.032235910Z" level=info msg="StartContainer for \"94dd18137d19898e1208f74dd16923cf631845c8f89a776eb3c1d30c02dfe9b6\" returns successfully" Apr 24 23:38:14.321081 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-bc64f6678be0f39290b718764c7ce54c24610f6f3afce6e81ca378ee8865125c-rootfs.mount: Deactivated successfully. Apr 24 23:38:14.673869 kubelet[2345]: E0424 23:38:14.673721 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:14.927892 kubelet[2345]: I0424 23:38:14.927698 2345 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-jq2f8" podStartSLOduration=5.617588503 podStartE2EDuration="11.927676142s" podCreationTimestamp="2026-04-24 23:38:03 +0000 UTC" firstStartedPulling="2026-04-24 23:38:06.991818175 +0000 UTC m=+4.458827243" lastFinishedPulling="2026-04-24 23:38:13.301905838 +0000 UTC m=+10.768914882" observedRunningTime="2026-04-24 23:38:14.92683481 +0000 UTC m=+12.393843866" watchObservedRunningTime="2026-04-24 23:38:14.927676142 +0000 UTC m=+12.394685198" Apr 24 23:38:15.140666 (udev-worker)[2851]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:38:15.162604 systemd-networkd[1837]: flannel.1: Link UP Apr 24 23:38:15.162626 systemd-networkd[1837]: flannel.1: Gained carrier Apr 24 23:38:15.674546 kubelet[2345]: E0424 23:38:15.674460 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:16.675583 kubelet[2345]: E0424 23:38:16.675507 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:16.848634 systemd-networkd[1837]: flannel.1: Gained IPv6LL Apr 24 23:38:17.675757 kubelet[2345]: E0424 23:38:17.675679 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:18.676512 kubelet[2345]: E0424 23:38:18.676411 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:18.901908 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Apr 24 23:38:19.055504 ntpd[1908]: Listen normally on 8 flannel.1 192.168.1.0:123 Apr 24 23:38:19.055641 ntpd[1908]: Listen normally on 9 flannel.1 [fe80::543e:81ff:fee4:7ae1%3]:123 Apr 24 23:38:19.056112 ntpd[1908]: 24 Apr 23:38:19 ntpd[1908]: Listen normally on 8 flannel.1 192.168.1.0:123 Apr 24 23:38:19.056112 ntpd[1908]: 24 Apr 23:38:19 ntpd[1908]: Listen normally on 9 flannel.1 [fe80::543e:81ff:fee4:7ae1%3]:123 Apr 24 23:38:19.677272 kubelet[2345]: E0424 23:38:19.677210 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:20.677744 kubelet[2345]: E0424 23:38:20.677676 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:21.678308 kubelet[2345]: E0424 23:38:21.678233 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:22.383833 systemd[1]: Created slice kubepods-besteffort-podf1e7a7c2_e002_4527_b8d2_0020bdcb8828.slice - libcontainer container kubepods-besteffort-podf1e7a7c2_e002_4527_b8d2_0020bdcb8828.slice. Apr 24 23:38:22.440902 kubelet[2345]: I0424 23:38:22.440805 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2wsx4\" (UniqueName: \"kubernetes.io/projected/f1e7a7c2-e002-4527-b8d2-0020bdcb8828-kube-api-access-2wsx4\") pod \"nginx-deployment-7fcdb87857-qqwxv\" (UID: \"f1e7a7c2-e002-4527-b8d2-0020bdcb8828\") " pod="default/nginx-deployment-7fcdb87857-qqwxv" Apr 24 23:38:22.678823 kubelet[2345]: E0424 23:38:22.678666 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:22.690210 containerd[1941]: time="2026-04-24T23:38:22.689712333Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-qqwxv,Uid:f1e7a7c2-e002-4527-b8d2-0020bdcb8828,Namespace:default,Attempt:0,}" Apr 24 23:38:22.734093 systemd-networkd[1837]: cni0: Link UP Apr 24 23:38:22.734109 systemd-networkd[1837]: cni0: Gained carrier Apr 24 23:38:22.743417 (udev-worker)[2945]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:38:22.746139 systemd-networkd[1837]: cni0: Lost carrier Apr 24 23:38:22.750546 (udev-worker)[2946]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:38:22.752797 systemd-networkd[1837]: vethe703f84b: Link UP Apr 24 23:38:22.758596 kernel: cni0: port 1(vethe703f84b) entered blocking state Apr 24 23:38:22.758737 kernel: cni0: port 1(vethe703f84b) entered disabled state Apr 24 23:38:22.762352 kernel: vethe703f84b: entered allmulticast mode Apr 24 23:38:22.763726 kernel: vethe703f84b: entered promiscuous mode Apr 24 23:38:22.770444 kernel: cni0: port 1(vethe703f84b) entered blocking state Apr 24 23:38:22.770516 kernel: cni0: port 1(vethe703f84b) entered forwarding state Apr 24 23:38:22.773243 kernel: cni0: port 1(vethe703f84b) entered disabled state Apr 24 23:38:22.791851 kernel: cni0: port 1(vethe703f84b) entered blocking state Apr 24 23:38:22.791932 kernel: cni0: port 1(vethe703f84b) entered forwarding state Apr 24 23:38:22.792158 systemd-networkd[1837]: vethe703f84b: Gained carrier Apr 24 23:38:22.794108 systemd-networkd[1837]: cni0: Gained carrier Apr 24 23:38:22.799338 containerd[1941]: 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)(0x4000084950), "name":"cbr0", "type":"bridge"} Apr 24 23:38:22.799338 containerd[1941]: delegateAdd: netconf sent to delegate plugin: Apr 24 23:38:22.836553 containerd[1941]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-04-24T23:38:22.835906929Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 24 23:38:22.836553 containerd[1941]: time="2026-04-24T23:38:22.836112705Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 24 23:38:22.836553 containerd[1941]: time="2026-04-24T23:38:22.836161149Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:22.836553 containerd[1941]: time="2026-04-24T23:38:22.836367933Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:22.884539 systemd[1]: Started cri-containerd-78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88.scope - libcontainer container 78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88. Apr 24 23:38:22.946341 containerd[1941]: time="2026-04-24T23:38:22.946207870Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-qqwxv,Uid:f1e7a7c2-e002-4527-b8d2-0020bdcb8828,Namespace:default,Attempt:0,} returns sandbox id \"78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88\"" Apr 24 23:38:22.949767 containerd[1941]: time="2026-04-24T23:38:22.949587634Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 24 23:38:23.559370 systemd[1]: run-containerd-runc-k8s.io-78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88-runc.AQqTb2.mount: Deactivated successfully. Apr 24 23:38:23.665582 kubelet[2345]: E0424 23:38:23.665476 2345 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:23.679209 kubelet[2345]: E0424 23:38:23.679133 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:23.952345 systemd-networkd[1837]: vethe703f84b: Gained IPv6LL Apr 24 23:38:24.144368 systemd-networkd[1837]: cni0: Gained IPv6LL Apr 24 23:38:24.680064 kubelet[2345]: E0424 23:38:24.679998 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:25.681810 kubelet[2345]: E0424 23:38:25.680594 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:25.920578 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2881636064.mount: Deactivated successfully. Apr 24 23:38:26.680850 kubelet[2345]: E0424 23:38:26.680748 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:27.055399 ntpd[1908]: Listen normally on 10 cni0 192.168.1.1:123 Apr 24 23:38:27.056649 ntpd[1908]: 24 Apr 23:38:27 ntpd[1908]: Listen normally on 10 cni0 192.168.1.1:123 Apr 24 23:38:27.056649 ntpd[1908]: 24 Apr 23:38:27 ntpd[1908]: Listen normally on 11 cni0 [fe80::74d5:28ff:febd:ac65%4]:123 Apr 24 23:38:27.056649 ntpd[1908]: 24 Apr 23:38:27 ntpd[1908]: Listen normally on 12 vethe703f84b [fe80::ec13:9eff:fe2c:1e6b%5]:123 Apr 24 23:38:27.055543 ntpd[1908]: Listen normally on 11 cni0 [fe80::74d5:28ff:febd:ac65%4]:123 Apr 24 23:38:27.055625 ntpd[1908]: Listen normally on 12 vethe703f84b [fe80::ec13:9eff:fe2c:1e6b%5]:123 Apr 24 23:38:27.336550 containerd[1941]: time="2026-04-24T23:38:27.336359892Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:27.339228 containerd[1941]: time="2026-04-24T23:38:27.338840352Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=65841543" Apr 24 23:38:27.340234 containerd[1941]: time="2026-04-24T23:38:27.339409092Z" level=info msg="ImageCreate event name:\"sha256:4e83b0a153edcfe297a96c14b2b93b7730f0a5dbb64dcf4efd27b58460fd74d1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:27.345223 containerd[1941]: time="2026-04-24T23:38:27.345023316Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:27.348088 containerd[1941]: time="2026-04-24T23:38:27.347359932Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:4e83b0a153edcfe297a96c14b2b93b7730f0a5dbb64dcf4efd27b58460fd74d1\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\", size \"65841421\" in 4.397708806s" Apr 24 23:38:27.348088 containerd[1941]: time="2026-04-24T23:38:27.347562264Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:4e83b0a153edcfe297a96c14b2b93b7730f0a5dbb64dcf4efd27b58460fd74d1\"" Apr 24 23:38:27.353988 containerd[1941]: time="2026-04-24T23:38:27.353892012Z" level=info msg="CreateContainer within sandbox \"78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Apr 24 23:38:27.378218 containerd[1941]: time="2026-04-24T23:38:27.376144812Z" level=info msg="CreateContainer within sandbox \"78f12cd1a84b3860a1554b031c6c49c04ae575ccd006d7face14b28e17a99d88\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"55c09a243d821826c8818fc9931ce43138b6e5aa9b7e0d972cf7af2da7ff003b\"" Apr 24 23:38:27.379891 containerd[1941]: time="2026-04-24T23:38:27.379835376Z" level=info msg="StartContainer for \"55c09a243d821826c8818fc9931ce43138b6e5aa9b7e0d972cf7af2da7ff003b\"" Apr 24 23:38:27.441524 systemd[1]: Started cri-containerd-55c09a243d821826c8818fc9931ce43138b6e5aa9b7e0d972cf7af2da7ff003b.scope - libcontainer container 55c09a243d821826c8818fc9931ce43138b6e5aa9b7e0d972cf7af2da7ff003b. Apr 24 23:38:27.487124 containerd[1941]: time="2026-04-24T23:38:27.487055737Z" level=info msg="StartContainer for \"55c09a243d821826c8818fc9931ce43138b6e5aa9b7e0d972cf7af2da7ff003b\" returns successfully" Apr 24 23:38:27.681538 kubelet[2345]: E0424 23:38:27.681350 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:28.682446 kubelet[2345]: E0424 23:38:28.682380 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:29.682829 kubelet[2345]: E0424 23:38:29.682756 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:30.683129 kubelet[2345]: E0424 23:38:30.683060 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:31.683475 kubelet[2345]: E0424 23:38:31.683397 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:32.684015 kubelet[2345]: E0424 23:38:32.683947 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:33.023526 update_engine[1918]: I20260424 23:38:33.023444 1918 update_attempter.cc:509] Updating boot flags... Apr 24 23:38:33.117594 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (3144) Apr 24 23:38:33.372356 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (3135) Apr 24 23:38:33.643227 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 36 scanned by (udev-worker) (3135) Apr 24 23:38:33.684428 kubelet[2345]: E0424 23:38:33.684339 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:34.685445 kubelet[2345]: E0424 23:38:34.685381 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:35.686723 kubelet[2345]: E0424 23:38:35.686622 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:36.250648 kubelet[2345]: I0424 23:38:36.250558 2345 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-qqwxv" podStartSLOduration=9.849849054 podStartE2EDuration="14.250508984s" podCreationTimestamp="2026-04-24 23:38:22 +0000 UTC" firstStartedPulling="2026-04-24 23:38:22.948790138 +0000 UTC m=+20.415799194" lastFinishedPulling="2026-04-24 23:38:27.349450068 +0000 UTC m=+24.816459124" observedRunningTime="2026-04-24 23:38:27.953572203 +0000 UTC m=+25.420581283" watchObservedRunningTime="2026-04-24 23:38:36.250508984 +0000 UTC m=+33.717518052" Apr 24 23:38:36.268534 systemd[1]: Created slice kubepods-besteffort-poda37312ec_d7b6_4723_b9a1_489f97e40522.slice - libcontainer container kubepods-besteffort-poda37312ec_d7b6_4723_b9a1_489f97e40522.slice. Apr 24 23:38:36.332779 kubelet[2345]: I0424 23:38:36.332705 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/a37312ec-d7b6-4723-b9a1-489f97e40522-data\") pod \"nfs-server-provisioner-0\" (UID: \"a37312ec-d7b6-4723-b9a1-489f97e40522\") " pod="default/nfs-server-provisioner-0" Apr 24 23:38:36.332947 kubelet[2345]: I0424 23:38:36.332788 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-6kglc\" (UniqueName: \"kubernetes.io/projected/a37312ec-d7b6-4723-b9a1-489f97e40522-kube-api-access-6kglc\") pod \"nfs-server-provisioner-0\" (UID: \"a37312ec-d7b6-4723-b9a1-489f97e40522\") " pod="default/nfs-server-provisioner-0" Apr 24 23:38:36.575390 containerd[1941]: time="2026-04-24T23:38:36.575107678Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a37312ec-d7b6-4723-b9a1-489f97e40522,Namespace:default,Attempt:0,}" Apr 24 23:38:36.623820 (udev-worker)[3144]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:38:36.626568 systemd-networkd[1837]: veth87dd12d0: Link UP Apr 24 23:38:36.633370 kernel: cni0: port 2(veth87dd12d0) entered blocking state Apr 24 23:38:36.633561 kernel: cni0: port 2(veth87dd12d0) entered disabled state Apr 24 23:38:36.633630 kernel: veth87dd12d0: entered allmulticast mode Apr 24 23:38:36.635193 kernel: veth87dd12d0: entered promiscuous mode Apr 24 23:38:36.655098 kernel: cni0: port 2(veth87dd12d0) entered blocking state Apr 24 23:38:36.655260 kernel: cni0: port 2(veth87dd12d0) entered forwarding state Apr 24 23:38:36.656738 systemd-networkd[1837]: veth87dd12d0: Gained carrier Apr 24 23:38:36.660902 containerd[1941]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000082950), "name":"cbr0", "type":"bridge"} Apr 24 23:38:36.660902 containerd[1941]: delegateAdd: netconf sent to delegate plugin: Apr 24 23:38:36.687877 kubelet[2345]: E0424 23:38:36.687800 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:36.703109 containerd[1941]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-04-24T23:38:36.702341038Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 24 23:38:36.703109 containerd[1941]: time="2026-04-24T23:38:36.702534094Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 24 23:38:36.703109 containerd[1941]: time="2026-04-24T23:38:36.702568918Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:36.703109 containerd[1941]: time="2026-04-24T23:38:36.702779254Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:36.754581 systemd[1]: Started cri-containerd-0a8cc310cae22aac1526612fc597e84562afb510f0c578c97f84260e82a8779c.scope - libcontainer container 0a8cc310cae22aac1526612fc597e84562afb510f0c578c97f84260e82a8779c. Apr 24 23:38:36.827996 containerd[1941]: time="2026-04-24T23:38:36.827024855Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a37312ec-d7b6-4723-b9a1-489f97e40522,Namespace:default,Attempt:0,} returns sandbox id \"0a8cc310cae22aac1526612fc597e84562afb510f0c578c97f84260e82a8779c\"" Apr 24 23:38:36.831365 containerd[1941]: time="2026-04-24T23:38:36.831061151Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Apr 24 23:38:37.688442 kubelet[2345]: E0424 23:38:37.688372 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:37.713344 systemd-networkd[1837]: veth87dd12d0: Gained IPv6LL Apr 24 23:38:38.689280 kubelet[2345]: E0424 23:38:38.689162 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:39.395934 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1764867636.mount: Deactivated successfully. Apr 24 23:38:39.690939 kubelet[2345]: E0424 23:38:39.690159 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:40.055831 ntpd[1908]: Listen normally on 13 veth87dd12d0 [fe80::28a0:9fff:fe83:2a4e%6]:123 Apr 24 23:38:40.056522 ntpd[1908]: 24 Apr 23:38:40 ntpd[1908]: Listen normally on 13 veth87dd12d0 [fe80::28a0:9fff:fe83:2a4e%6]:123 Apr 24 23:38:40.690779 kubelet[2345]: E0424 23:38:40.690731 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:41.691624 kubelet[2345]: E0424 23:38:41.691579 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:42.407016 containerd[1941]: time="2026-04-24T23:38:42.406948791Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:42.411298 containerd[1941]: time="2026-04-24T23:38:42.410355507Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373623" Apr 24 23:38:42.411461 containerd[1941]: time="2026-04-24T23:38:42.411391527Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:42.418288 containerd[1941]: time="2026-04-24T23:38:42.418225323Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:42.419675 containerd[1941]: time="2026-04-24T23:38:42.419618979Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 5.588485504s" Apr 24 23:38:42.420264 containerd[1941]: time="2026-04-24T23:38:42.420230103Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Apr 24 23:38:42.427011 containerd[1941]: time="2026-04-24T23:38:42.426803907Z" level=info msg="CreateContainer within sandbox \"0a8cc310cae22aac1526612fc597e84562afb510f0c578c97f84260e82a8779c\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Apr 24 23:38:42.455899 containerd[1941]: time="2026-04-24T23:38:42.455786259Z" level=info msg="CreateContainer within sandbox \"0a8cc310cae22aac1526612fc597e84562afb510f0c578c97f84260e82a8779c\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"ab72a26deecbe4a3fcd5b0f574e2a377de456beaa44b402cbc6bc99ff5bab693\"" Apr 24 23:38:42.457106 containerd[1941]: time="2026-04-24T23:38:42.457042911Z" level=info msg="StartContainer for \"ab72a26deecbe4a3fcd5b0f574e2a377de456beaa44b402cbc6bc99ff5bab693\"" Apr 24 23:38:42.460651 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3911875574.mount: Deactivated successfully. Apr 24 23:38:42.512529 systemd[1]: Started cri-containerd-ab72a26deecbe4a3fcd5b0f574e2a377de456beaa44b402cbc6bc99ff5bab693.scope - libcontainer container ab72a26deecbe4a3fcd5b0f574e2a377de456beaa44b402cbc6bc99ff5bab693. Apr 24 23:38:42.565381 containerd[1941]: time="2026-04-24T23:38:42.564098655Z" level=info msg="StartContainer for \"ab72a26deecbe4a3fcd5b0f574e2a377de456beaa44b402cbc6bc99ff5bab693\" returns successfully" Apr 24 23:38:42.693442 kubelet[2345]: E0424 23:38:42.693069 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:43.665287 kubelet[2345]: E0424 23:38:43.665224 2345 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:43.694289 kubelet[2345]: E0424 23:38:43.694225 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:44.694856 kubelet[2345]: E0424 23:38:44.694767 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:45.695123 kubelet[2345]: E0424 23:38:45.695059 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:46.695554 kubelet[2345]: E0424 23:38:46.695503 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:47.696622 kubelet[2345]: E0424 23:38:47.696556 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:47.968168 kubelet[2345]: I0424 23:38:47.968071 2345 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.376364642 podStartE2EDuration="11.96804853s" podCreationTimestamp="2026-04-24 23:38:36 +0000 UTC" firstStartedPulling="2026-04-24 23:38:36.830310659 +0000 UTC m=+34.297319703" lastFinishedPulling="2026-04-24 23:38:42.421994535 +0000 UTC m=+39.889003591" observedRunningTime="2026-04-24 23:38:42.994293678 +0000 UTC m=+40.461302770" watchObservedRunningTime="2026-04-24 23:38:47.96804853 +0000 UTC m=+45.435057586" Apr 24 23:38:47.982774 systemd[1]: Created slice kubepods-besteffort-pod811f9546_bc47_48da_8904_1aa8a2276a6b.slice - libcontainer container kubepods-besteffort-pod811f9546_bc47_48da_8904_1aa8a2276a6b.slice. Apr 24 23:38:48.010236 kubelet[2345]: I0424 23:38:48.009965 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-vgb5d\" (UniqueName: \"kubernetes.io/projected/811f9546-bc47-48da-8904-1aa8a2276a6b-kube-api-access-vgb5d\") pod \"test-pod-1\" (UID: \"811f9546-bc47-48da-8904-1aa8a2276a6b\") " pod="default/test-pod-1" Apr 24 23:38:48.010236 kubelet[2345]: I0424 23:38:48.010028 2345 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-b1bf7656-c618-4016-8e47-61f4351c7512\" (UniqueName: \"kubernetes.io/nfs/811f9546-bc47-48da-8904-1aa8a2276a6b-pvc-b1bf7656-c618-4016-8e47-61f4351c7512\") pod \"test-pod-1\" (UID: \"811f9546-bc47-48da-8904-1aa8a2276a6b\") " pod="default/test-pod-1" Apr 24 23:38:48.146226 kernel: FS-Cache: Loaded Apr 24 23:38:48.189577 kernel: RPC: Registered named UNIX socket transport module. Apr 24 23:38:48.189763 kernel: RPC: Registered udp transport module. Apr 24 23:38:48.189806 kernel: RPC: Registered tcp transport module. Apr 24 23:38:48.191933 kernel: RPC: Registered tcp-with-tls transport module. Apr 24 23:38:48.192060 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Apr 24 23:38:48.536345 kernel: NFS: Registering the id_resolver key type Apr 24 23:38:48.536459 kernel: Key type id_resolver registered Apr 24 23:38:48.536523 kernel: Key type id_legacy registered Apr 24 23:38:48.579814 nfsidmap[3651]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Apr 24 23:38:48.586975 nfsidmap[3652]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Apr 24 23:38:48.697631 kubelet[2345]: E0424 23:38:48.697552 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:48.889772 containerd[1941]: time="2026-04-24T23:38:48.889017587Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:811f9546-bc47-48da-8904-1aa8a2276a6b,Namespace:default,Attempt:0,}" Apr 24 23:38:48.941509 (udev-worker)[3643]: Network interface NamePolicy= disabled on kernel command line. Apr 24 23:38:48.942567 systemd-networkd[1837]: veth65a91c48: Link UP Apr 24 23:38:48.949326 kernel: cni0: port 3(veth65a91c48) entered blocking state Apr 24 23:38:48.949515 kernel: cni0: port 3(veth65a91c48) entered disabled state Apr 24 23:38:48.949593 kernel: veth65a91c48: entered allmulticast mode Apr 24 23:38:48.951166 kernel: veth65a91c48: entered promiscuous mode Apr 24 23:38:48.969562 kernel: cni0: port 3(veth65a91c48) entered blocking state Apr 24 23:38:48.969784 kernel: cni0: port 3(veth65a91c48) entered forwarding state Apr 24 23:38:48.970153 systemd-networkd[1837]: veth65a91c48: Gained carrier Apr 24 23:38:48.973966 containerd[1941]: 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)(0x40001067f0), "name":"cbr0", "type":"bridge"} Apr 24 23:38:48.973966 containerd[1941]: delegateAdd: netconf sent to delegate plugin: Apr 24 23:38:49.013414 containerd[1941]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-04-24T23:38:49.011716808Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Apr 24 23:38:49.013414 containerd[1941]: time="2026-04-24T23:38:49.011806712Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Apr 24 23:38:49.013414 containerd[1941]: time="2026-04-24T23:38:49.011832884Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:49.013414 containerd[1941]: time="2026-04-24T23:38:49.011976500Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Apr 24 23:38:49.051481 systemd[1]: Started cri-containerd-f74c46471a4c08151168083a7e59629d3d1c060fb75fffea5bf47e9b64da7122.scope - libcontainer container f74c46471a4c08151168083a7e59629d3d1c060fb75fffea5bf47e9b64da7122. Apr 24 23:38:49.115803 containerd[1941]: time="2026-04-24T23:38:49.115706492Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:811f9546-bc47-48da-8904-1aa8a2276a6b,Namespace:default,Attempt:0,} returns sandbox id \"f74c46471a4c08151168083a7e59629d3d1c060fb75fffea5bf47e9b64da7122\"" Apr 24 23:38:49.118159 containerd[1941]: time="2026-04-24T23:38:49.118101044Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Apr 24 23:38:49.437239 containerd[1941]: time="2026-04-24T23:38:49.436837666Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Apr 24 23:38:49.439223 containerd[1941]: time="2026-04-24T23:38:49.438832318Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Apr 24 23:38:49.444698 containerd[1941]: time="2026-04-24T23:38:49.444622042Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:4e83b0a153edcfe297a96c14b2b93b7730f0a5dbb64dcf4efd27b58460fd74d1\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\", size \"65841421\" in 326.458142ms" Apr 24 23:38:49.444698 containerd[1941]: time="2026-04-24T23:38:49.444688102Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:4e83b0a153edcfe297a96c14b2b93b7730f0a5dbb64dcf4efd27b58460fd74d1\"" Apr 24 23:38:49.452255 containerd[1941]: time="2026-04-24T23:38:49.451957714Z" level=info msg="CreateContainer within sandbox \"f74c46471a4c08151168083a7e59629d3d1c060fb75fffea5bf47e9b64da7122\" for container &ContainerMetadata{Name:test,Attempt:0,}" Apr 24 23:38:49.482093 containerd[1941]: time="2026-04-24T23:38:49.481776298Z" level=info msg="CreateContainer within sandbox \"f74c46471a4c08151168083a7e59629d3d1c060fb75fffea5bf47e9b64da7122\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"8bc84986500fe8ab9fd89559b324f3aa6f584361c45689bd7fa5d776561fb9dc\"" Apr 24 23:38:49.483012 containerd[1941]: time="2026-04-24T23:38:49.482947330Z" level=info msg="StartContainer for \"8bc84986500fe8ab9fd89559b324f3aa6f584361c45689bd7fa5d776561fb9dc\"" Apr 24 23:38:49.541511 systemd[1]: Started cri-containerd-8bc84986500fe8ab9fd89559b324f3aa6f584361c45689bd7fa5d776561fb9dc.scope - libcontainer container 8bc84986500fe8ab9fd89559b324f3aa6f584361c45689bd7fa5d776561fb9dc. Apr 24 23:38:49.587883 containerd[1941]: time="2026-04-24T23:38:49.587801002Z" level=info msg="StartContainer for \"8bc84986500fe8ab9fd89559b324f3aa6f584361c45689bd7fa5d776561fb9dc\" returns successfully" Apr 24 23:38:49.698607 kubelet[2345]: E0424 23:38:49.698415 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:50.016250 kubelet[2345]: I0424 23:38:50.015985 2345 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=11.687590146 podStartE2EDuration="12.015966428s" podCreationTimestamp="2026-04-24 23:38:38 +0000 UTC" firstStartedPulling="2026-04-24 23:38:49.11730602 +0000 UTC m=+46.584315076" lastFinishedPulling="2026-04-24 23:38:49.445682302 +0000 UTC m=+46.912691358" observedRunningTime="2026-04-24 23:38:50.015809432 +0000 UTC m=+47.482818476" watchObservedRunningTime="2026-04-24 23:38:50.015966428 +0000 UTC m=+47.482975484" Apr 24 23:38:50.699204 kubelet[2345]: E0424 23:38:50.699126 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:50.960922 systemd-networkd[1837]: veth65a91c48: Gained IPv6LL Apr 24 23:38:51.700235 kubelet[2345]: E0424 23:38:51.700143 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:52.701270 kubelet[2345]: E0424 23:38:52.701208 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:53.701990 kubelet[2345]: E0424 23:38:53.701928 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:54.055537 ntpd[1908]: Listen normally on 14 veth65a91c48 [fe80::cc1b:2aff:fe3d:32f%7]:123 Apr 24 23:38:54.056205 ntpd[1908]: 24 Apr 23:38:54 ntpd[1908]: Listen normally on 14 veth65a91c48 [fe80::cc1b:2aff:fe3d:32f%7]:123 Apr 24 23:38:54.702620 kubelet[2345]: E0424 23:38:54.702554 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:55.703716 kubelet[2345]: E0424 23:38:55.703651 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:56.704508 kubelet[2345]: E0424 23:38:56.704439 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:57.705163 kubelet[2345]: E0424 23:38:57.705099 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:58.706065 kubelet[2345]: E0424 23:38:58.706003 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:38:59.707230 kubelet[2345]: E0424 23:38:59.707139 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:00.708338 kubelet[2345]: E0424 23:39:00.708265 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:01.708792 kubelet[2345]: E0424 23:39:01.708733 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:02.709063 kubelet[2345]: E0424 23:39:02.709007 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:03.664959 kubelet[2345]: E0424 23:39:03.664897 2345 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:03.709696 kubelet[2345]: E0424 23:39:03.709624 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:04.710627 kubelet[2345]: E0424 23:39:04.710567 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:05.710847 kubelet[2345]: E0424 23:39:05.710798 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:06.711476 kubelet[2345]: E0424 23:39:06.711406 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:07.712108 kubelet[2345]: E0424 23:39:07.712051 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:08.712687 kubelet[2345]: E0424 23:39:08.712608 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:09.713525 kubelet[2345]: E0424 23:39:09.713458 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:10.714212 kubelet[2345]: E0424 23:39:10.714139 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:11.714904 kubelet[2345]: E0424 23:39:11.714838 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:12.715309 kubelet[2345]: E0424 23:39:12.715254 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:13.716261 kubelet[2345]: E0424 23:39:13.716206 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:14.716448 kubelet[2345]: E0424 23:39:14.716364 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:15.046369 kubelet[2345]: E0424 23:39:15.045454 2345 kubelet_node_status.go:548] "Error updating node status, will retry" err="failed to patch status \"{\\\"status\\\":{\\\"$setElementOrder/conditions\\\":[{\\\"type\\\":\\\"NetworkUnavailable\\\"},{\\\"type\\\":\\\"MemoryPressure\\\"},{\\\"type\\\":\\\"DiskPressure\\\"},{\\\"type\\\":\\\"PIDPressure\\\"},{\\\"type\\\":\\\"Ready\\\"}],\\\"conditions\\\":[{\\\"lastHeartbeatTime\\\":\\\"2026-04-24T23:39:05Z\\\",\\\"type\\\":\\\"MemoryPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-04-24T23:39:05Z\\\",\\\"type\\\":\\\"DiskPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-04-24T23:39:05Z\\\",\\\"type\\\":\\\"PIDPressure\\\"},{\\\"lastHeartbeatTime\\\":\\\"2026-04-24T23:39:05Z\\\",\\\"type\\\":\\\"Ready\\\"}],\\\"images\\\":[{\\\"names\\\":[\\\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\\\",\\\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\\\"],\\\"sizeBytes\\\":87371201},{\\\"names\\\":[\\\"ghcr.io/flatcar/nginx@sha256:6f170eb5f8ea893d94fe3c05cef69270f16614a99d3d922ce8a320efc43b8591\\\",\\\"ghcr.io/flatcar/nginx:latest\\\"],\\\"sizeBytes\\\":65841421},{\\\"names\\\":[\\\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\\\",\\\"ghcr.io/flannel-io/flannel:v0.26.7\\\"],\\\"sizeBytes\\\":32412118},{\\\"names\\\":[\\\"registry.k8s.io/kube-proxy@sha256:8d18637b5c5f58a4ca0163d3cf184e53d4c522963c242860562be7cb25e9303e\\\",\\\"registry.k8s.io/kube-proxy:v1.33.11\\\"],\\\"sizeBytes\\\":28039527},{\\\"names\\\":[\\\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\\\",\\\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\\\"],\\\"sizeBytes\\\":5125394},{\\\"names\\\":[\\\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\\\",\\\"registry.k8s.io/pause:3.8\\\"],\\\"sizeBytes\\\":268403}]}}\" for node \"172.31.19.73\": Patch \"https://172.31.25.4:6443/api/v1/nodes/172.31.19.73/status?timeout=10s\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)" Apr 24 23:39:15.046369 kubelet[2345]: E0424 23:39:15.045726 2345 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)" Apr 24 23:39:15.716987 kubelet[2345]: E0424 23:39:15.716908 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:16.717258 kubelet[2345]: E0424 23:39:16.717205 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:17.717627 kubelet[2345]: E0424 23:39:17.717566 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:18.718309 kubelet[2345]: E0424 23:39:18.718253 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:19.719316 kubelet[2345]: E0424 23:39:19.719254 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:20.719967 kubelet[2345]: E0424 23:39:20.719886 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:21.720677 kubelet[2345]: E0424 23:39:21.720601 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:22.721556 kubelet[2345]: E0424 23:39:22.721495 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:23.664529 kubelet[2345]: E0424 23:39:23.664469 2345 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:23.722129 kubelet[2345]: E0424 23:39:23.722074 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:24.723195 kubelet[2345]: E0424 23:39:24.723124 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:25.046751 kubelet[2345]: E0424 23:39:25.046413 2345 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)" Apr 24 23:39:25.046751 kubelet[2345]: E0424 23:39:25.046440 2345 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"172.31.19.73\": Get \"https://172.31.25.4:6443/api/v1/nodes/172.31.19.73?timeout=10s\": net/http: request canceled (Client.Timeout exceeded while awaiting headers)" Apr 24 23:39:25.074208 kubelet[2345]: E0424 23:39:25.069353 2345 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": unexpected EOF" Apr 24 23:39:25.079152 kubelet[2345]: E0424 23:39:25.078027 2345 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": read tcp 172.31.19.73:40940->172.31.25.4:6443: read: connection reset by peer" Apr 24 23:39:25.080949 kubelet[2345]: E0424 23:39:25.080645 2345 controller.go:195] "Failed to update lease" err="Put \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": dial tcp 172.31.25.4:6443: connect: connection refused" Apr 24 23:39:25.081837 kubelet[2345]: I0424 23:39:25.081162 2345 controller.go:115] "failed to update lease using latest lease, fallback to ensure lease" err="failed 5 attempts to update lease" Apr 24 23:39:25.082270 kubelet[2345]: E0424 23:39:25.082225 2345 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": dial tcp 172.31.25.4:6443: connect: connection refused" interval="200ms" Apr 24 23:39:25.283441 kubelet[2345]: E0424 23:39:25.283392 2345 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": dial tcp 172.31.25.4:6443: connect: connection refused" interval="400ms" Apr 24 23:39:25.723318 kubelet[2345]: E0424 23:39:25.723255 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:26.724152 kubelet[2345]: E0424 23:39:26.724090 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:27.724459 kubelet[2345]: E0424 23:39:27.724391 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:28.724978 kubelet[2345]: E0424 23:39:28.724920 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:29.725439 kubelet[2345]: E0424 23:39:29.725380 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:30.725798 kubelet[2345]: E0424 23:39:30.725736 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:31.726519 kubelet[2345]: E0424 23:39:31.726451 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:32.727008 kubelet[2345]: E0424 23:39:32.726948 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:33.727808 kubelet[2345]: E0424 23:39:33.727748 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:34.728251 kubelet[2345]: E0424 23:39:34.728169 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:35.047336 kubelet[2345]: E0424 23:39:35.047203 2345 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"172.31.19.73\": Get \"https://172.31.25.4:6443/api/v1/nodes/172.31.19.73?timeout=10s\": context deadline exceeded - error from a previous attempt: unexpected EOF" Apr 24 23:39:35.684766 kubelet[2345]: E0424 23:39:35.684693 2345 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": net/http: request canceled while waiting for connection (Client.Timeout exceeded while awaiting headers)" interval="800ms" Apr 24 23:39:35.729366 kubelet[2345]: E0424 23:39:35.729317 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:36.730086 kubelet[2345]: E0424 23:39:36.730021 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:37.730705 kubelet[2345]: E0424 23:39:37.730648 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:38.731506 kubelet[2345]: E0424 23:39:38.731392 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:39.731821 kubelet[2345]: E0424 23:39:39.731734 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:40.732117 kubelet[2345]: E0424 23:39:40.732041 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:41.732476 kubelet[2345]: E0424 23:39:41.732420 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:42.733660 kubelet[2345]: E0424 23:39:42.733587 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:43.664875 kubelet[2345]: E0424 23:39:43.664819 2345 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:43.734473 kubelet[2345]: E0424 23:39:43.734422 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:44.735270 kubelet[2345]: E0424 23:39:44.735198 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:45.048535 kubelet[2345]: E0424 23:39:45.048364 2345 kubelet_node_status.go:548] "Error updating node status, will retry" err="error getting node \"172.31.19.73\": Get \"https://172.31.25.4:6443/api/v1/nodes/172.31.19.73?timeout=10s\": net/http: request canceled while waiting for connection (Client.Timeout exceeded while awaiting headers)" Apr 24 23:39:45.735705 kubelet[2345]: E0424 23:39:45.735641 2345 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Apr 24 23:39:46.486145 kubelet[2345]: E0424 23:39:46.486080 2345 controller.go:145] "Failed to ensure lease exists, will retry" err="Get \"https://172.31.25.4:6443/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/172.31.19.73?timeout=10s\": context deadline exceeded" interval="1.6s"