Sep 4 23:48:30.222932 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 4 23:48:30.222978 kernel: Linux version 6.6.156-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Sep 4 22:23:35 -00 2026 Sep 4 23:48:30.223005 kernel: KASLR disabled due to lack of seed Sep 4 23:48:30.223022 kernel: efi: EFI v2.7 by EDK II Sep 4 23:48:30.223040 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7b009a98 MEMRESERVE=0x7852ee18 Sep 4 23:48:30.223058 kernel: ACPI: Early table checksum verification disabled Sep 4 23:48:30.223076 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 4 23:48:30.223091 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 4 23:48:30.223127 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 4 23:48:30.223145 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Sep 4 23:48:30.223167 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 4 23:48:30.223184 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 4 23:48:30.223200 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 4 23:48:30.223216 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 4 23:48:30.223235 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 4 23:48:30.223256 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 4 23:48:30.223273 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 4 23:48:30.223290 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 4 23:48:30.223306 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 4 23:48:30.223323 kernel: printk: bootconsole [uart0] enabled Sep 4 23:48:30.223340 kernel: NUMA: Failed to initialise from firmware Sep 4 23:48:30.223356 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 4 23:48:30.223373 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Sep 4 23:48:30.223390 kernel: Zone ranges: Sep 4 23:48:30.223406 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 4 23:48:30.223423 kernel: DMA32 empty Sep 4 23:48:30.223443 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 4 23:48:30.223460 kernel: Movable zone start for each node Sep 4 23:48:30.223476 kernel: Early memory node ranges Sep 4 23:48:30.223493 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 4 23:48:30.223509 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 4 23:48:30.223526 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 4 23:48:30.223542 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 4 23:48:30.223559 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 4 23:48:30.223575 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 4 23:48:30.223592 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 4 23:48:30.223609 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 4 23:48:30.223625 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 4 23:48:30.223645 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 4 23:48:30.223663 kernel: psci: probing for conduit method from ACPI. Sep 4 23:48:30.223687 kernel: psci: PSCIv1.0 detected in firmware. Sep 4 23:48:30.223705 kernel: psci: Using standard PSCI v0.2 function IDs Sep 4 23:48:30.223723 kernel: psci: Trusted OS migration not required Sep 4 23:48:30.223811 kernel: psci: SMC Calling Convention v1.1 Sep 4 23:48:30.223835 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 4 23:48:30.223854 kernel: percpu: Embedded 30 pages/cpu s85800 r8192 d28888 u122880 Sep 4 23:48:30.223872 kernel: pcpu-alloc: s85800 r8192 d28888 u122880 alloc=30*4096 Sep 4 23:48:30.223890 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 4 23:48:30.223908 kernel: Detected PIPT I-cache on CPU0 Sep 4 23:48:30.223926 kernel: CPU features: detected: GIC system register CPU interface Sep 4 23:48:30.223944 kernel: CPU features: detected: Spectre-v2 Sep 4 23:48:30.223962 kernel: CPU features: detected: Spectre-v3a Sep 4 23:48:30.223980 kernel: CPU features: detected: Spectre-BHB Sep 4 23:48:30.223997 kernel: CPU features: detected: ARM erratum 1742098 Sep 4 23:48:30.224021 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 4 23:48:30.224040 kernel: alternatives: applying boot alternatives Sep 4 23:48:30.224060 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=b93d003b43d5ab98ae420f26cabb0cb9807dda45afde2a6503d15bee14b842f0 Sep 4 23:48:30.224079 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 23:48:30.224097 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 23:48:30.224114 kernel: Fallback order for Node 0: 0 Sep 4 23:48:30.224132 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Sep 4 23:48:30.224149 kernel: Policy zone: Normal Sep 4 23:48:30.224167 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 23:48:30.224184 kernel: software IO TLB: area num 2. Sep 4 23:48:30.224202 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Sep 4 23:48:30.224225 kernel: Memory: 3819968K/4030464K available (10304K kernel code, 2180K rwdata, 8132K rodata, 39488K init, 901K bss, 210496K reserved, 0K cma-reserved) Sep 4 23:48:30.224243 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 4 23:48:30.224261 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 23:48:30.224279 kernel: rcu: RCU event tracing is enabled. Sep 4 23:48:30.224297 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 4 23:48:30.224315 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 23:48:30.224333 kernel: Tracing variant of Tasks RCU enabled. Sep 4 23:48:30.224351 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 23:48:30.224368 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 4 23:48:30.224386 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 4 23:48:30.224403 kernel: GICv3: 96 SPIs implemented Sep 4 23:48:30.224425 kernel: GICv3: 0 Extended SPIs implemented Sep 4 23:48:30.224443 kernel: Root IRQ handler: gic_handle_irq Sep 4 23:48:30.224461 kernel: GICv3: GICv3 features: 16 PPIs Sep 4 23:48:30.224478 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 4 23:48:30.224495 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 4 23:48:30.224513 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Sep 4 23:48:30.224532 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Sep 4 23:48:30.224549 kernel: GICv3: using LPI property table @0x00000004000d0000 Sep 4 23:48:30.224567 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 4 23:48:30.224585 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Sep 4 23:48:30.224603 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 23:48:30.224620 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 4 23:48:30.224643 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 4 23:48:30.224661 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 4 23:48:30.224679 kernel: Console: colour dummy device 80x25 Sep 4 23:48:30.224697 kernel: printk: console [tty1] enabled Sep 4 23:48:30.224715 kernel: ACPI: Core revision 20230628 Sep 4 23:48:30.224733 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 4 23:48:30.224776 kernel: pid_max: default: 32768 minimum: 301 Sep 4 23:48:30.224796 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 4 23:48:30.224815 kernel: landlock: Up and running. Sep 4 23:48:30.224840 kernel: SELinux: Initializing. Sep 4 23:48:30.224859 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.224878 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.224896 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 23:48:30.231185 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 4 23:48:30.231215 kernel: rcu: Hierarchical SRCU implementation. Sep 4 23:48:30.231235 kernel: rcu: Max phase no-delay instances is 400. Sep 4 23:48:30.231253 kernel: Platform MSI: ITS@0x10080000 domain created Sep 4 23:48:30.231272 kernel: PCI/MSI: ITS@0x10080000 domain created Sep 4 23:48:30.231302 kernel: Remapping and enabling EFI services. Sep 4 23:48:30.231321 kernel: smp: Bringing up secondary CPUs ... Sep 4 23:48:30.231339 kernel: Detected PIPT I-cache on CPU1 Sep 4 23:48:30.231358 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 4 23:48:30.231376 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Sep 4 23:48:30.231395 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 4 23:48:30.231413 kernel: smp: Brought up 1 node, 2 CPUs Sep 4 23:48:30.231431 kernel: SMP: Total of 2 processors activated. Sep 4 23:48:30.231449 kernel: CPU features: detected: 32-bit EL0 Support Sep 4 23:48:30.231475 kernel: CPU features: detected: 32-bit EL1 Support Sep 4 23:48:30.231519 kernel: CPU features: detected: CRC32 instructions Sep 4 23:48:30.231563 kernel: CPU: All CPU(s) started at EL1 Sep 4 23:48:30.231646 kernel: alternatives: applying system-wide alternatives Sep 4 23:48:30.231670 kernel: devtmpfs: initialized Sep 4 23:48:30.231690 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 23:48:30.231709 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 4 23:48:30.231728 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 23:48:30.231779 kernel: SMBIOS 3.0.0 present. Sep 4 23:48:30.231807 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 4 23:48:30.231826 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 23:48:30.231845 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 4 23:48:30.231864 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 4 23:48:30.231884 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 4 23:48:30.231903 kernel: audit: initializing netlink subsys (disabled) Sep 4 23:48:30.231921 kernel: audit: type=2000 audit(0.304:1): state=initialized audit_enabled=0 res=1 Sep 4 23:48:30.231940 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 23:48:30.231964 kernel: cpuidle: using governor menu Sep 4 23:48:30.231992 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 4 23:48:30.232011 kernel: ASID allocator initialised with 65536 entries Sep 4 23:48:30.232030 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 23:48:30.232048 kernel: Serial: AMBA PL011 UART driver Sep 4 23:48:30.232067 kernel: Modules: 17456 pages in range for non-PLT usage Sep 4 23:48:30.232091 kernel: Modules: 508976 pages in range for PLT usage Sep 4 23:48:30.232110 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 23:48:30.232128 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 23:48:30.232151 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 4 23:48:30.232171 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 4 23:48:30.232189 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 23:48:30.232208 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 23:48:30.232227 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 4 23:48:30.232245 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 4 23:48:30.232264 kernel: ACPI: Added _OSI(Module Device) Sep 4 23:48:30.232282 kernel: ACPI: Added _OSI(Processor Device) Sep 4 23:48:30.232301 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 23:48:30.232324 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 23:48:30.232343 kernel: ACPI: Interpreter enabled Sep 4 23:48:30.232361 kernel: ACPI: Using GIC for interrupt routing Sep 4 23:48:30.232380 kernel: ACPI: MCFG table detected, 1 entries Sep 4 23:48:30.232398 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Sep 4 23:48:30.232714 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 23:48:30.232969 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 4 23:48:30.233173 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 4 23:48:30.233389 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Sep 4 23:48:30.233597 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Sep 4 23:48:30.233645 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 4 23:48:30.233686 kernel: acpiphp: Slot [1] registered Sep 4 23:48:30.233722 kernel: acpiphp: Slot [2] registered Sep 4 23:48:30.233761 kernel: acpiphp: Slot [3] registered Sep 4 23:48:30.233784 kernel: acpiphp: Slot [4] registered Sep 4 23:48:30.233803 kernel: acpiphp: Slot [5] registered Sep 4 23:48:30.233830 kernel: acpiphp: Slot [6] registered Sep 4 23:48:30.233849 kernel: acpiphp: Slot [7] registered Sep 4 23:48:30.233868 kernel: acpiphp: Slot [8] registered Sep 4 23:48:30.233887 kernel: acpiphp: Slot [9] registered Sep 4 23:48:30.233905 kernel: acpiphp: Slot [10] registered Sep 4 23:48:30.233924 kernel: acpiphp: Slot [11] registered Sep 4 23:48:30.233943 kernel: acpiphp: Slot [12] registered Sep 4 23:48:30.233961 kernel: acpiphp: Slot [13] registered Sep 4 23:48:30.233980 kernel: acpiphp: Slot [14] registered Sep 4 23:48:30.233998 kernel: acpiphp: Slot [15] registered Sep 4 23:48:30.234021 kernel: acpiphp: Slot [16] registered Sep 4 23:48:30.234039 kernel: acpiphp: Slot [17] registered Sep 4 23:48:30.234058 kernel: acpiphp: Slot [18] registered Sep 4 23:48:30.234076 kernel: acpiphp: Slot [19] registered Sep 4 23:48:30.234095 kernel: acpiphp: Slot [20] registered Sep 4 23:48:30.234114 kernel: acpiphp: Slot [21] registered Sep 4 23:48:30.234132 kernel: acpiphp: Slot [22] registered Sep 4 23:48:30.234150 kernel: acpiphp: Slot [23] registered Sep 4 23:48:30.234169 kernel: acpiphp: Slot [24] registered Sep 4 23:48:30.234192 kernel: acpiphp: Slot [25] registered Sep 4 23:48:30.234211 kernel: acpiphp: Slot [26] registered Sep 4 23:48:30.234230 kernel: acpiphp: Slot [27] registered Sep 4 23:48:30.234248 kernel: acpiphp: Slot [28] registered Sep 4 23:48:30.234266 kernel: acpiphp: Slot [29] registered Sep 4 23:48:30.234285 kernel: acpiphp: Slot [30] registered Sep 4 23:48:30.234303 kernel: acpiphp: Slot [31] registered Sep 4 23:48:30.234321 kernel: PCI host bridge to bus 0000:00 Sep 4 23:48:30.234546 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 4 23:48:30.234760 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 4 23:48:30.234960 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 4 23:48:30.235272 kernel: pci_bus 0000:00: root bus resource [bus 00] Sep 4 23:48:30.235522 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Sep 4 23:48:30.235776 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Sep 4 23:48:30.236001 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Sep 4 23:48:30.236234 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Sep 4 23:48:30.236446 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Sep 4 23:48:30.236657 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 4 23:48:30.236930 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Sep 4 23:48:30.237156 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Sep 4 23:48:30.237369 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Sep 4 23:48:30.237585 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Sep 4 23:48:30.237847 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 4 23:48:30.238069 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 4 23:48:30.238262 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 4 23:48:30.238452 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 4 23:48:30.238478 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 4 23:48:30.238498 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 4 23:48:30.238517 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 4 23:48:30.238536 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 4 23:48:30.238562 kernel: iommu: Default domain type: Translated Sep 4 23:48:30.238582 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 4 23:48:30.238601 kernel: efivars: Registered efivars operations Sep 4 23:48:30.238620 kernel: vgaarb: loaded Sep 4 23:48:30.238638 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 4 23:48:30.238657 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 23:48:30.238676 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 23:48:30.238694 kernel: pnp: PnP ACPI init Sep 4 23:48:30.239048 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 4 23:48:30.239092 kernel: pnp: PnP ACPI: found 1 devices Sep 4 23:48:30.239130 kernel: NET: Registered PF_INET protocol family Sep 4 23:48:30.239151 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 23:48:30.239170 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 23:48:30.239190 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 23:48:30.239209 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 23:48:30.239228 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 23:48:30.239247 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 23:48:30.239272 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.239292 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 23:48:30.239311 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 23:48:30.239330 kernel: PCI: CLS 0 bytes, default 64 Sep 4 23:48:30.239349 kernel: kvm [1]: HYP mode not available Sep 4 23:48:30.239368 kernel: Initialise system trusted keyrings Sep 4 23:48:30.239386 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 23:48:30.239405 kernel: Key type asymmetric registered Sep 4 23:48:30.239424 kernel: Asymmetric key parser 'x509' registered Sep 4 23:48:30.239447 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 4 23:48:30.239467 kernel: io scheduler mq-deadline registered Sep 4 23:48:30.239486 kernel: io scheduler kyber registered Sep 4 23:48:30.239504 kernel: io scheduler bfq registered Sep 4 23:48:30.240263 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 4 23:48:30.240311 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 4 23:48:30.240331 kernel: ACPI: button: Power Button [PWRB] Sep 4 23:48:30.240350 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 4 23:48:30.240370 kernel: ACPI: button: Sleep Button [SLPB] Sep 4 23:48:30.240400 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 23:48:30.240421 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 4 23:48:30.240686 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 4 23:48:30.240714 kernel: printk: console [ttyS0] disabled Sep 4 23:48:30.240734 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 4 23:48:30.246672 kernel: printk: console [ttyS0] enabled Sep 4 23:48:30.246694 kernel: printk: bootconsole [uart0] disabled Sep 4 23:48:30.246714 kernel: thunder_xcv, ver 1.0 Sep 4 23:48:30.246733 kernel: thunder_bgx, ver 1.0 Sep 4 23:48:30.246813 kernel: nicpf, ver 1.0 Sep 4 23:48:30.246835 kernel: nicvf, ver 1.0 Sep 4 23:48:30.247501 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 4 23:48:30.247713 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-04T23:48:29 UTC (1788565709) Sep 4 23:48:30.248162 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 4 23:48:30.248192 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Sep 4 23:48:30.248213 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 4 23:48:30.248233 kernel: watchdog: Hard watchdog permanently disabled Sep 4 23:48:30.248265 kernel: NET: Registered PF_INET6 protocol family Sep 4 23:48:30.248284 kernel: Segment Routing with IPv6 Sep 4 23:48:30.248303 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 23:48:30.248323 kernel: NET: Registered PF_PACKET protocol family Sep 4 23:48:30.248342 kernel: Key type dns_resolver registered Sep 4 23:48:30.248362 kernel: registered taskstats version 1 Sep 4 23:48:30.248382 kernel: Loading compiled-in X.509 certificates Sep 4 23:48:30.248402 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.156-flatcar: 3c163392e47099ee9cc38295227f8cfbbfe8b690' Sep 4 23:48:30.248421 kernel: Key type .fscrypt registered Sep 4 23:48:30.248447 kernel: Key type fscrypt-provisioning registered Sep 4 23:48:30.248467 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 23:48:30.248486 kernel: ima: Allocated hash algorithm: sha1 Sep 4 23:48:30.248506 kernel: ima: No architecture policies found Sep 4 23:48:30.248525 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 4 23:48:30.248544 kernel: clk: Disabling unused clocks Sep 4 23:48:30.248563 kernel: Freeing unused kernel memory: 39488K Sep 4 23:48:30.248582 kernel: Run /init as init process Sep 4 23:48:30.248661 kernel: with arguments: Sep 4 23:48:30.248692 kernel: /init Sep 4 23:48:30.248711 kernel: with environment: Sep 4 23:48:30.248730 kernel: HOME=/ Sep 4 23:48:30.248808 kernel: TERM=linux Sep 4 23:48:30.248834 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 4 23:48:30.248859 systemd[1]: Detected virtualization amazon. Sep 4 23:48:30.248880 systemd[1]: Detected architecture arm64. Sep 4 23:48:30.248900 systemd[1]: Running in initrd. Sep 4 23:48:30.248926 systemd[1]: No hostname configured, using default hostname. Sep 4 23:48:30.248946 systemd[1]: Hostname set to . Sep 4 23:48:30.248967 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:48:30.248987 systemd[1]: Queued start job for default target initrd.target. Sep 4 23:48:30.249008 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:30.249029 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:30.249051 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 23:48:30.249072 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:48:30.249097 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 23:48:30.249127 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 23:48:30.249161 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 23:48:30.249190 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 23:48:30.249218 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:30.249239 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:30.249269 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:48:30.249296 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:48:30.249318 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:48:30.249338 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:48:30.249359 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:48:30.249379 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:48:30.249400 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 23:48:30.249423 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 23:48:30.249448 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:30.249473 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:30.249494 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:30.249515 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:48:30.249536 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 23:48:30.249558 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:48:30.249579 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 23:48:30.249599 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 23:48:30.249620 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:48:30.249641 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:48:30.249667 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:30.249766 systemd-journald[251]: Collecting audit messages is disabled. Sep 4 23:48:30.249847 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 23:48:30.249871 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:30.249900 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 23:48:30.249923 systemd-journald[251]: Journal started Sep 4 23:48:30.249965 systemd-journald[251]: Runtime Journal (/run/log/journal/ec231e42e2f8c8e8dcb7c73ec47d82c0) is 8.0M, max 75.3M, 67.3M free. Sep 4 23:48:30.232052 systemd-modules-load[252]: Inserted module 'overlay' Sep 4 23:48:30.267236 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:48:30.267282 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 23:48:30.270792 kernel: Bridge firewalling registered Sep 4 23:48:30.269666 systemd-modules-load[252]: Inserted module 'br_netfilter' Sep 4 23:48:30.278567 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 23:48:30.287006 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:48:30.299473 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:30.316037 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:30.328563 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 23:48:30.352128 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:30.366581 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:48:30.375315 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:48:30.382785 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:30.413904 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:30.423421 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:30.440033 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:48:30.447924 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:30.467222 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 23:48:30.504604 dracut-cmdline[288]: dracut-dracut-053 Sep 4 23:48:30.508843 systemd-resolved[286]: Positive Trust Anchors: Sep 4 23:48:30.508878 systemd-resolved[286]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:48:30.508941 systemd-resolved[286]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 4 23:48:30.530808 dracut-cmdline[288]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=b93d003b43d5ab98ae420f26cabb0cb9807dda45afde2a6503d15bee14b842f0 Sep 4 23:48:30.667776 kernel: SCSI subsystem initialized Sep 4 23:48:30.677763 kernel: Loading iSCSI transport class v2.0-870. Sep 4 23:48:30.688782 kernel: iscsi: registered transport (tcp) Sep 4 23:48:30.711412 kernel: iscsi: registered transport (qla4xxx) Sep 4 23:48:30.711485 kernel: QLogic iSCSI HBA Driver Sep 4 23:48:30.767776 kernel: random: crng init done Sep 4 23:48:30.768253 systemd-resolved[286]: Defaulting to hostname 'linux'. Sep 4 23:48:30.772261 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:48:30.776982 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:30.800992 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 23:48:30.812079 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 23:48:30.852901 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 23:48:30.852985 kernel: device-mapper: uevent: version 1.0.3 Sep 4 23:48:30.853014 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 23:48:30.936773 kernel: raid6: neonx8 gen() 6723 MB/s Sep 4 23:48:30.938786 kernel: raid6: neonx4 gen() 6571 MB/s Sep 4 23:48:30.954789 kernel: raid6: neonx2 gen() 5471 MB/s Sep 4 23:48:30.972778 kernel: raid6: neonx1 gen() 3955 MB/s Sep 4 23:48:30.989778 kernel: raid6: int64x8 gen() 3791 MB/s Sep 4 23:48:31.006782 kernel: raid6: int64x4 gen() 3698 MB/s Sep 4 23:48:31.023776 kernel: raid6: int64x2 gen() 3583 MB/s Sep 4 23:48:31.041666 kernel: raid6: int64x1 gen() 2755 MB/s Sep 4 23:48:31.041709 kernel: raid6: using algorithm neonx8 gen() 6723 MB/s Sep 4 23:48:31.059691 kernel: raid6: .... xor() 4808 MB/s, rmw enabled Sep 4 23:48:31.059784 kernel: raid6: using neon recovery algorithm Sep 4 23:48:31.067786 kernel: xor: measuring software checksum speed Sep 4 23:48:31.069908 kernel: 8regs : 10086 MB/sec Sep 4 23:48:31.069941 kernel: 32regs : 11913 MB/sec Sep 4 23:48:31.071147 kernel: arm64_neon : 9550 MB/sec Sep 4 23:48:31.071179 kernel: xor: using function: 32regs (11913 MB/sec) Sep 4 23:48:31.157807 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 23:48:31.177678 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:48:31.192117 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:31.235242 systemd-udevd[471]: Using default interface naming scheme 'v255'. Sep 4 23:48:31.243631 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:31.267241 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 23:48:31.302784 dracut-pre-trigger[483]: rd.md=0: removing MD RAID activation Sep 4 23:48:31.363042 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:48:31.379013 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:48:31.490982 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:31.506059 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 23:48:31.558560 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 23:48:31.563497 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:48:31.569896 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:31.579593 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:48:31.604054 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 23:48:31.634655 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:48:31.693773 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 4 23:48:31.693840 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 4 23:48:31.694316 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:48:31.694562 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:31.703438 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:31.711260 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:48:31.725606 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 4 23:48:31.725967 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 4 23:48:31.711576 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:31.720977 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:31.737788 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:99:59:66:17:6d Sep 4 23:48:31.740228 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:31.743600 (udev-worker)[524]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:48:31.775755 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 4 23:48:31.775825 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 4 23:48:31.783270 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:31.791794 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 4 23:48:31.795142 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 23:48:31.807809 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 4 23:48:31.807881 kernel: GPT:9289727 != 33554431 Sep 4 23:48:31.807908 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 4 23:48:31.807934 kernel: GPT:9289727 != 33554431 Sep 4 23:48:31.809586 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 4 23:48:31.809650 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:31.828854 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:31.933144 kernel: BTRFS: device fsid b87ddc53-b6de-4050-b98d-680db2334337 devid 1 transid 32 /dev/nvme0n1p3 scanned by (udev-worker) (518) Sep 4 23:48:31.951778 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (542) Sep 4 23:48:32.006074 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 4 23:48:32.046548 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 4 23:48:32.063908 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Sep 4 23:48:32.066690 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 4 23:48:32.095936 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 4 23:48:32.108163 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 23:48:32.123021 disk-uuid[664]: Primary Header is updated. Sep 4 23:48:32.123021 disk-uuid[664]: Secondary Entries is updated. Sep 4 23:48:32.123021 disk-uuid[664]: Secondary Header is updated. Sep 4 23:48:32.135884 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:33.157781 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 4 23:48:33.158672 disk-uuid[665]: The operation has completed successfully. Sep 4 23:48:33.340940 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 23:48:33.341166 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 23:48:33.405068 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 23:48:33.416691 sh[1010]: Success Sep 4 23:48:33.439277 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 4 23:48:33.562629 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 23:48:33.573600 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 23:48:33.582802 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 23:48:33.633625 kernel: BTRFS info (device dm-0): first mount of filesystem b87ddc53-b6de-4050-b98d-680db2334337 Sep 4 23:48:33.633687 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:33.633715 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 23:48:33.635509 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 23:48:33.636856 kernel: BTRFS info (device dm-0): using free space tree Sep 4 23:48:33.706799 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 4 23:48:33.718462 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 23:48:33.722457 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 23:48:33.732175 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 23:48:33.740246 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 23:48:33.778096 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:33.778166 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:33.779470 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:33.788773 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:33.808455 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 4 23:48:33.811239 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:33.821896 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 23:48:33.838145 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 23:48:33.936254 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:48:33.959202 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:48:34.018217 systemd-networkd[1216]: lo: Link UP Sep 4 23:48:34.018239 systemd-networkd[1216]: lo: Gained carrier Sep 4 23:48:34.021360 systemd-networkd[1216]: Enumeration completed Sep 4 23:48:34.021536 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:48:34.022600 systemd-networkd[1216]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:34.022607 systemd-networkd[1216]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:48:34.029955 systemd[1]: Reached target network.target - Network. Sep 4 23:48:34.039248 systemd-networkd[1216]: eth0: Link UP Sep 4 23:48:34.039256 systemd-networkd[1216]: eth0: Gained carrier Sep 4 23:48:34.039275 systemd-networkd[1216]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:34.062883 systemd-networkd[1216]: eth0: DHCPv4 address 172.31.30.168/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 4 23:48:34.169591 ignition[1143]: Ignition 2.19.0 Sep 4 23:48:34.169619 ignition[1143]: Stage: fetch-offline Sep 4 23:48:34.173895 ignition[1143]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.173988 ignition[1143]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.179119 ignition[1143]: Ignition finished successfully Sep 4 23:48:34.182984 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:48:34.193051 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 4 23:48:34.230164 ignition[1226]: Ignition 2.19.0 Sep 4 23:48:34.230185 ignition[1226]: Stage: fetch Sep 4 23:48:34.231327 ignition[1226]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.231354 ignition[1226]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.231517 ignition[1226]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.250247 ignition[1226]: PUT result: OK Sep 4 23:48:34.253010 ignition[1226]: parsed url from cmdline: "" Sep 4 23:48:34.253036 ignition[1226]: no config URL provided Sep 4 23:48:34.253052 ignition[1226]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 23:48:34.253080 ignition[1226]: no config at "/usr/lib/ignition/user.ign" Sep 4 23:48:34.253114 ignition[1226]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.257338 ignition[1226]: PUT result: OK Sep 4 23:48:34.257471 ignition[1226]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 4 23:48:34.265608 ignition[1226]: GET result: OK Sep 4 23:48:34.265760 ignition[1226]: parsing config with SHA512: ea5c5bb29f2438060ce8de58ff45c9233450d9dd621de5d134a1fd4efaec2ab8fd975736e9eb94d047f9846780e3263cdeb5186036499a3dffb3e35d92ba9675 Sep 4 23:48:34.272644 unknown[1226]: fetched base config from "system" Sep 4 23:48:34.272816 unknown[1226]: fetched base config from "system" Sep 4 23:48:34.273841 ignition[1226]: fetch: fetch complete Sep 4 23:48:34.272831 unknown[1226]: fetched user config from "aws" Sep 4 23:48:34.273853 ignition[1226]: fetch: fetch passed Sep 4 23:48:34.273939 ignition[1226]: Ignition finished successfully Sep 4 23:48:34.286209 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 4 23:48:34.298232 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 23:48:34.325209 ignition[1233]: Ignition 2.19.0 Sep 4 23:48:34.325230 ignition[1233]: Stage: kargs Sep 4 23:48:34.326373 ignition[1233]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.326398 ignition[1233]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.326554 ignition[1233]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.335912 ignition[1233]: PUT result: OK Sep 4 23:48:34.340047 ignition[1233]: kargs: kargs passed Sep 4 23:48:34.340194 ignition[1233]: Ignition finished successfully Sep 4 23:48:34.344060 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 23:48:34.357054 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 23:48:34.383014 ignition[1239]: Ignition 2.19.0 Sep 4 23:48:34.383035 ignition[1239]: Stage: disks Sep 4 23:48:34.384263 ignition[1239]: no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:34.384289 ignition[1239]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:34.384450 ignition[1239]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:34.392865 ignition[1239]: PUT result: OK Sep 4 23:48:34.397242 ignition[1239]: disks: disks passed Sep 4 23:48:34.397377 ignition[1239]: Ignition finished successfully Sep 4 23:48:34.399164 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 23:48:34.407169 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 23:48:34.410157 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 23:48:34.417283 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:48:34.421335 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:48:34.423585 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:48:34.438108 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 23:48:34.480207 systemd-fsck[1248]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 4 23:48:34.486992 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 23:48:34.499268 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 23:48:34.595783 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 4bc94a1f-f803-467d-b7c6-f015244e0af4 r/w with ordered data mode. Quota mode: none. Sep 4 23:48:34.596982 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 23:48:34.601090 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 23:48:34.614905 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:48:34.621003 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 23:48:34.626784 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 23:48:34.626876 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 23:48:34.626926 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:48:34.655477 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 23:48:34.667933 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1267) Sep 4 23:48:34.669119 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 23:48:34.674841 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:34.675212 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:34.675462 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:34.689821 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:34.692221 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:48:34.912019 initrd-setup-root[1291]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 23:48:34.939368 initrd-setup-root[1298]: cut: /sysroot/etc/group: No such file or directory Sep 4 23:48:34.949137 initrd-setup-root[1305]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 23:48:34.958558 initrd-setup-root[1312]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 23:48:35.189773 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 23:48:35.202070 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 23:48:35.207476 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 23:48:35.227815 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 23:48:35.232030 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:35.282216 ignition[1380]: INFO : Ignition 2.19.0 Sep 4 23:48:35.284179 ignition[1380]: INFO : Stage: mount Sep 4 23:48:35.283601 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 23:48:35.292853 ignition[1380]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:35.292853 ignition[1380]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:35.292853 ignition[1380]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:35.292853 ignition[1380]: INFO : PUT result: OK Sep 4 23:48:35.303012 ignition[1380]: INFO : mount: mount passed Sep 4 23:48:35.303012 ignition[1380]: INFO : Ignition finished successfully Sep 4 23:48:35.309859 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 23:48:35.320918 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 23:48:35.335333 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 23:48:35.366777 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1391) Sep 4 23:48:35.370992 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1145cff3-0e2e-4542-82cf-6ce25c557bb5 Sep 4 23:48:35.371040 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 4 23:48:35.371084 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 4 23:48:35.378769 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 4 23:48:35.383353 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 23:48:35.420061 ignition[1408]: INFO : Ignition 2.19.0 Sep 4 23:48:35.420061 ignition[1408]: INFO : Stage: files Sep 4 23:48:35.424559 ignition[1408]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:35.424559 ignition[1408]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:35.424559 ignition[1408]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:35.424559 ignition[1408]: INFO : PUT result: OK Sep 4 23:48:35.436652 ignition[1408]: DEBUG : files: compiled without relabeling support, skipping Sep 4 23:48:35.439401 ignition[1408]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 23:48:35.439401 ignition[1408]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 23:48:35.447859 systemd-networkd[1216]: eth0: Gained IPv6LL Sep 4 23:48:35.469055 ignition[1408]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 23:48:35.472255 ignition[1408]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 23:48:35.475535 unknown[1408]: wrote ssh authorized keys file for user: core Sep 4 23:48:35.477944 ignition[1408]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Sep 4 23:48:35.484671 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.35.1-arm64.raw: attempt #1 Sep 4 23:48:35.963410 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Sep 4 23:48:36.350607 ignition[1408]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-arm64.raw" Sep 4 23:48:36.355215 ignition[1408]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:48:36.355215 ignition[1408]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 23:48:36.355215 ignition[1408]: INFO : files: files passed Sep 4 23:48:36.355215 ignition[1408]: INFO : Ignition finished successfully Sep 4 23:48:36.368923 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 23:48:36.380084 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 23:48:36.399988 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 23:48:36.411510 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 23:48:36.414433 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 23:48:36.428004 initrd-setup-root-after-ignition[1437]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.428004 initrd-setup-root-after-ignition[1437]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.438089 initrd-setup-root-after-ignition[1441]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 23:48:36.444232 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:48:36.450042 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 23:48:36.463028 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 23:48:36.514482 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 23:48:36.514823 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 23:48:36.522843 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 23:48:36.527534 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 23:48:36.530013 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 23:48:36.543146 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 23:48:36.569796 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:48:36.581073 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 23:48:36.616871 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:36.617239 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:36.627524 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 23:48:36.631854 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 23:48:36.632103 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 23:48:36.635391 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 23:48:36.645428 systemd[1]: Stopped target basic.target - Basic System. Sep 4 23:48:36.648119 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 23:48:36.654853 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 23:48:36.657862 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 23:48:36.660968 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 23:48:36.665640 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 23:48:36.675713 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 23:48:36.678348 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 23:48:36.683392 systemd[1]: Stopped target swap.target - Swaps. Sep 4 23:48:36.685136 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 23:48:36.685440 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 23:48:36.699523 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:36.699957 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:36.706606 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 23:48:36.710065 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:36.715388 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 23:48:36.715695 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 23:48:36.725716 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 23:48:36.726214 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 23:48:36.731100 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 23:48:36.731418 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 23:48:36.755420 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 23:48:36.757529 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 23:48:36.758064 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:36.776278 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 23:48:36.781782 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 23:48:36.782124 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:36.786968 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 23:48:36.787242 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 23:48:36.809630 ignition[1461]: INFO : Ignition 2.19.0 Sep 4 23:48:36.814821 ignition[1461]: INFO : Stage: umount Sep 4 23:48:36.814821 ignition[1461]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 23:48:36.814821 ignition[1461]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 4 23:48:36.814821 ignition[1461]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 4 23:48:36.829654 ignition[1461]: INFO : PUT result: OK Sep 4 23:48:36.816323 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 23:48:36.818615 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 23:48:36.843912 ignition[1461]: INFO : umount: umount passed Sep 4 23:48:36.843912 ignition[1461]: INFO : Ignition finished successfully Sep 4 23:48:36.846397 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 23:48:36.846634 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 23:48:36.852278 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 23:48:36.852371 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 23:48:36.854718 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 23:48:36.854843 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 23:48:36.859444 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 4 23:48:36.859541 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 4 23:48:36.871546 systemd[1]: Stopped target network.target - Network. Sep 4 23:48:36.885866 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 23:48:36.885987 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 23:48:36.889235 systemd[1]: Stopped target paths.target - Path Units. Sep 4 23:48:36.894553 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 23:48:36.901240 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:36.905110 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 23:48:36.912853 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 23:48:36.915528 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 23:48:36.916614 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 23:48:36.919149 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 23:48:36.919228 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 23:48:36.921541 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 23:48:36.922727 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 23:48:36.925950 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 23:48:36.926034 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 23:48:36.930652 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 23:48:36.935891 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 23:48:36.941812 systemd-networkd[1216]: eth0: DHCPv6 lease lost Sep 4 23:48:36.952298 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 23:48:36.960203 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 23:48:36.961257 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 23:48:36.966368 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 23:48:36.966640 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 23:48:36.971320 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 23:48:36.971418 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:36.994157 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 23:48:36.994305 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 23:48:36.994414 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 23:48:37.007456 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 23:48:37.007830 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:37.014500 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 23:48:37.019098 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:37.026665 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 23:48:37.026801 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:37.034024 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:37.057195 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 23:48:37.061078 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 23:48:37.065460 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 23:48:37.065628 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 23:48:37.079646 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 23:48:37.081689 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:37.086069 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 23:48:37.086313 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 23:48:37.098346 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 23:48:37.098504 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:37.101322 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 23:48:37.101411 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:37.104293 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 23:48:37.104394 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 23:48:37.120023 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 23:48:37.120139 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 23:48:37.127432 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 23:48:37.127529 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 23:48:37.142170 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 23:48:37.147152 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 23:48:37.147426 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:37.155961 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 23:48:37.156071 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:37.171109 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 23:48:37.173130 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 23:48:37.178914 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 23:48:37.188242 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 23:48:37.208076 systemd[1]: Switching root. Sep 4 23:48:37.247537 systemd-journald[251]: Journal stopped Sep 4 23:48:39.150030 systemd-journald[251]: Received SIGTERM from PID 1 (systemd). Sep 4 23:48:39.150176 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 23:48:39.150228 kernel: SELinux: policy capability open_perms=1 Sep 4 23:48:39.150270 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 23:48:39.150302 kernel: SELinux: policy capability always_check_network=0 Sep 4 23:48:39.150333 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 23:48:39.150364 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 23:48:39.150395 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 23:48:39.150426 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 23:48:39.150458 kernel: audit: type=1403 audit(1788565717.482:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 23:48:39.150492 systemd[1]: Successfully loaded SELinux policy in 50.780ms. Sep 4 23:48:39.150533 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.534ms. Sep 4 23:48:39.150567 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 4 23:48:39.150598 systemd[1]: Detected virtualization amazon. Sep 4 23:48:39.150630 systemd[1]: Detected architecture arm64. Sep 4 23:48:39.150661 systemd[1]: Detected first boot. Sep 4 23:48:39.150694 systemd[1]: Initializing machine ID from VM UUID. Sep 4 23:48:39.150725 zram_generator::config[1505]: No configuration found. Sep 4 23:48:39.150810 systemd[1]: Populated /etc with preset unit settings. Sep 4 23:48:39.150852 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 23:48:39.150889 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 23:48:39.150921 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 23:48:39.150954 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 23:48:39.150988 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 23:48:39.151044 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 23:48:39.151077 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 23:48:39.151112 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 23:48:39.151145 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 23:48:39.151177 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 23:48:39.151207 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 23:48:39.151242 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 23:48:39.151274 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 23:48:39.151305 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 23:48:39.151339 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 23:48:39.151369 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 23:48:39.151399 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 23:48:39.151430 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 23:48:39.151462 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 23:48:39.151494 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 23:48:39.151529 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 23:48:39.151560 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 23:48:39.151632 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 23:48:39.151664 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 23:48:39.151698 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 23:48:39.151778 systemd[1]: Reached target slices.target - Slice Units. Sep 4 23:48:39.151816 systemd[1]: Reached target swap.target - Swaps. Sep 4 23:48:39.151847 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 23:48:39.151879 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 23:48:39.151910 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 23:48:39.151940 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 23:48:39.151976 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 23:48:39.152005 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 23:48:39.152036 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 23:48:39.152066 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 23:48:39.152098 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 23:48:39.152130 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 23:48:39.152160 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 23:48:39.152192 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 23:48:39.152223 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Sep 4 23:48:39.152273 systemd[1]: Reached target machines.target - Containers. Sep 4 23:48:39.152303 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 23:48:39.152332 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:48:39.152362 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 23:48:39.152391 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 23:48:39.152420 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:48:39.152451 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:48:39.152483 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:48:39.152519 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 23:48:39.152549 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:48:39.152583 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 23:48:39.152626 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 23:48:39.152661 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 23:48:39.152691 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 23:48:39.152720 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 23:48:39.152779 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 23:48:39.152815 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 23:48:39.152849 kernel: loop: module loaded Sep 4 23:48:39.152879 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 23:48:39.152911 kernel: ACPI: bus type drm_connector registered Sep 4 23:48:39.152940 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 23:48:39.152972 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 23:48:39.153016 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 23:48:39.153049 systemd[1]: Stopped verity-setup.service. Sep 4 23:48:39.153080 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 23:48:39.153109 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 23:48:39.153144 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 23:48:39.153173 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 23:48:39.153205 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 23:48:39.153234 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 23:48:39.153266 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 23:48:39.153301 kernel: fuse: init (API version 7.39) Sep 4 23:48:39.153330 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 23:48:39.153362 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 23:48:39.153395 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:48:39.153424 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:48:39.153454 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:48:39.153483 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:48:39.153514 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:48:39.153549 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:48:39.153581 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 23:48:39.153616 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 23:48:39.153646 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 23:48:39.153678 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:48:39.153803 systemd-journald[1594]: Collecting audit messages is disabled. Sep 4 23:48:39.153866 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:48:39.153897 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 23:48:39.153926 systemd-journald[1594]: Journal started Sep 4 23:48:39.153972 systemd-journald[1594]: Runtime Journal (/run/log/journal/ec231e42e2f8c8e8dcb7c73ec47d82c0) is 8.0M, max 75.3M, 67.3M free. Sep 4 23:48:38.530311 systemd[1]: Queued start job for default target multi-user.target. Sep 4 23:48:38.557950 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 4 23:48:38.558772 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 23:48:39.167167 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 23:48:39.167871 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 23:48:39.176796 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 23:48:39.200571 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 23:48:39.215118 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 23:48:39.229968 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 23:48:39.233646 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 23:48:39.233701 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 23:48:39.242037 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 23:48:39.255154 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 23:48:39.274063 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 23:48:39.285450 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:48:39.300105 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 23:48:39.319144 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 23:48:39.324933 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:48:39.328783 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 23:48:39.335696 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:48:39.339797 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 23:48:39.351913 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 23:48:39.362505 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 23:48:39.373714 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 23:48:39.379880 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 23:48:39.384512 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 23:48:39.409781 kernel: loop0: detected capacity change from 0 to 52536 Sep 4 23:48:39.413337 systemd-journald[1594]: Time spent on flushing to /var/log/journal/ec231e42e2f8c8e8dcb7c73ec47d82c0 is 76.319ms for 882 entries. Sep 4 23:48:39.413337 systemd-journald[1594]: System Journal (/var/log/journal/ec231e42e2f8c8e8dcb7c73ec47d82c0) is 8.0M, max 195.6M, 187.6M free. Sep 4 23:48:39.499333 systemd-journald[1594]: Received client request to flush runtime journal. Sep 4 23:48:39.439597 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 23:48:39.454246 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 23:48:39.478708 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 23:48:39.483427 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 23:48:39.500067 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 4 23:48:39.507820 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 23:48:39.518528 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 23:48:39.521962 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 23:48:39.567783 kernel: loop1: detected capacity change from 0 to 197488 Sep 4 23:48:39.570241 udevadm[1642]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Sep 4 23:48:39.600274 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 23:48:39.604605 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 4 23:48:39.620985 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 23:48:39.636227 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 23:48:39.688336 systemd-tmpfiles[1656]: ACLs are not supported, ignoring. Sep 4 23:48:39.688377 systemd-tmpfiles[1656]: ACLs are not supported, ignoring. Sep 4 23:48:39.698894 kernel: loop2: detected capacity change from 0 to 114432 Sep 4 23:48:39.703216 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 23:48:39.770791 kernel: loop3: detected capacity change from 0 to 114328 Sep 4 23:48:39.823925 kernel: loop4: detected capacity change from 0 to 52536 Sep 4 23:48:39.850959 kernel: loop5: detected capacity change from 0 to 197488 Sep 4 23:48:39.900771 kernel: loop6: detected capacity change from 0 to 114432 Sep 4 23:48:39.928797 kernel: loop7: detected capacity change from 0 to 114328 Sep 4 23:48:39.966597 (sd-merge)[1663]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Sep 4 23:48:39.970925 (sd-merge)[1663]: Merged extensions into '/usr'. Sep 4 23:48:39.982158 systemd[1]: Reloading requested from client PID 1634 ('systemd-sysext') (unit systemd-sysext.service)... Sep 4 23:48:39.982372 systemd[1]: Reloading... Sep 4 23:48:40.241815 zram_generator::config[1695]: No configuration found. Sep 4 23:48:40.304766 ldconfig[1629]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 23:48:40.525559 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Sep 4 23:48:40.641399 systemd[1]: Reloading finished in 657 ms. Sep 4 23:48:40.683801 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 23:48:40.687207 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 23:48:40.691379 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 23:48:40.707133 systemd[1]: Starting ensure-sysext.service... Sep 4 23:48:40.726003 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 4 23:48:40.736309 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 23:48:40.752972 systemd[1]: Reloading requested from client PID 1742 ('systemctl') (unit ensure-sysext.service)... Sep 4 23:48:40.753005 systemd[1]: Reloading... Sep 4 23:48:40.793992 systemd-tmpfiles[1743]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 23:48:40.794677 systemd-tmpfiles[1743]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 23:48:40.801314 systemd-tmpfiles[1743]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 23:48:40.802607 systemd-tmpfiles[1743]: ACLs are not supported, ignoring. Sep 4 23:48:40.802801 systemd-tmpfiles[1743]: ACLs are not supported, ignoring. Sep 4 23:48:40.817393 systemd-tmpfiles[1743]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:48:40.817420 systemd-tmpfiles[1743]: Skipping /boot Sep 4 23:48:40.820559 systemd-udevd[1744]: Using default interface naming scheme 'v255'. Sep 4 23:48:40.852625 systemd-tmpfiles[1743]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 23:48:40.852658 systemd-tmpfiles[1743]: Skipping /boot Sep 4 23:48:40.942782 zram_generator::config[1773]: No configuration found. Sep 4 23:48:41.128004 (udev-worker)[1781]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:48:41.314770 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (1795) Sep 4 23:48:41.379248 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Sep 4 23:48:41.557087 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 23:48:41.559512 systemd[1]: Reloading finished in 805 ms. Sep 4 23:48:41.593870 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 23:48:41.598823 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 4 23:48:41.670805 systemd[1]: Finished ensure-sysext.service. Sep 4 23:48:41.685655 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 23:48:41.714087 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 4 23:48:41.724056 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 23:48:41.738006 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 23:48:41.741598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 23:48:41.747108 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 23:48:41.752847 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 23:48:41.768175 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 23:48:41.774708 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 23:48:41.781297 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 23:48:41.784121 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 23:48:41.786460 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 23:48:41.794297 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 23:48:41.803112 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 23:48:41.812901 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 23:48:41.815292 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 23:48:41.823136 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 23:48:41.829072 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 23:48:41.846377 lvm[1941]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:48:41.863115 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 23:48:41.863473 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 23:48:41.896109 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 23:48:41.897834 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 23:48:41.919297 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 23:48:41.933306 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 23:48:41.936458 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 23:48:41.958344 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 23:48:41.982998 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 23:48:41.995488 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 23:48:41.995933 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 23:48:42.011332 lvm[1965]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 23:48:42.015263 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 23:48:42.020109 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 23:48:42.036019 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 23:48:42.050556 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 23:48:42.054214 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 23:48:42.056972 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 23:48:42.063439 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 23:48:42.069891 augenrules[1979]: No rules Sep 4 23:48:42.075154 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 23:48:42.102040 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 23:48:42.105392 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Sep 4 23:48:42.119577 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 23:48:42.125329 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 23:48:42.155417 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 23:48:42.211336 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 23:48:42.285200 systemd-networkd[1954]: lo: Link UP Sep 4 23:48:42.285732 systemd-networkd[1954]: lo: Gained carrier Sep 4 23:48:42.288841 systemd-networkd[1954]: Enumeration completed Sep 4 23:48:42.289234 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 23:48:42.292640 systemd-networkd[1954]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:42.292661 systemd-networkd[1954]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 23:48:42.295226 systemd-networkd[1954]: eth0: Link UP Sep 4 23:48:42.295768 systemd-networkd[1954]: eth0: Gained carrier Sep 4 23:48:42.295950 systemd-networkd[1954]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 23:48:42.299301 systemd-resolved[1955]: Positive Trust Anchors: Sep 4 23:48:42.299338 systemd-resolved[1955]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 23:48:42.299403 systemd-resolved[1955]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Sep 4 23:48:42.302115 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 23:48:42.314321 systemd-resolved[1955]: Defaulting to hostname 'linux'. Sep 4 23:48:42.314851 systemd-networkd[1954]: eth0: DHCPv4 address 172.31.30.168/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 4 23:48:42.318028 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 23:48:42.320695 systemd[1]: Reached target network.target - Network. Sep 4 23:48:42.323945 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 23:48:42.326553 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 23:48:42.329036 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 23:48:42.331819 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 23:48:42.334802 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 23:48:42.337461 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 23:48:42.341678 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 23:48:42.346277 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 23:48:42.346329 systemd[1]: Reached target paths.target - Path Units. Sep 4 23:48:42.349683 systemd[1]: Reached target timers.target - Timer Units. Sep 4 23:48:42.352796 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 23:48:42.357717 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 23:48:42.368088 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 23:48:42.371541 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 23:48:42.374161 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 23:48:42.376488 systemd[1]: Reached target basic.target - Basic System. Sep 4 23:48:42.378550 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:48:42.378605 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 23:48:42.387973 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 23:48:42.397992 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 4 23:48:42.410274 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 23:48:42.419006 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 23:48:42.436236 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 23:48:42.438516 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Sep 4 23:48:42.441830 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 23:48:42.448848 systemd[1]: Started ntpd.service - Network Time Service. Sep 4 23:48:42.465929 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 4 23:48:42.476626 jq[2005]: false Sep 4 23:48:42.472334 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 23:48:42.481168 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 23:48:42.489715 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 23:48:42.495114 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 23:48:42.495991 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 23:48:42.524264 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 23:48:42.530771 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 23:48:42.537079 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 23:48:42.537442 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 23:48:42.562787 extend-filesystems[2006]: Found loop4 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found loop5 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found loop6 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found loop7 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p1 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p2 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p3 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found usr Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p4 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p6 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p7 Sep 4 23:48:42.570923 extend-filesystems[2006]: Found nvme0n1p9 Sep 4 23:48:42.570923 extend-filesystems[2006]: Checking size of /dev/nvme0n1p9 Sep 4 23:48:42.573084 dbus-daemon[2004]: [system] SELinux support is enabled Sep 4 23:48:42.573373 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 23:48:42.597932 dbus-daemon[2004]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1954 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 4 23:48:42.585887 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Sep 4 23:48:42.651523 dbus-daemon[2004]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 4 23:48:42.586711 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 23:48:42.600501 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Sep 4 23:48:42.661213 ntpd[2008]: ntpd 4.2.8p17@1.4004-o Fri Sep 4 21:54:26 UTC 2026 (1): Starting Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: ntpd 4.2.8p17@1.4004-o Fri Sep 4 21:54:26 UTC 2026 (1): Starting Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: ---------------------------------------------------- Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: ntp-4 is maintained by Network Time Foundation, Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: corporation. Support and training for ntp-4 are Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: available at https://www.nwtime.org/support Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: ---------------------------------------------------- Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: proto: precision = 0.108 usec (-23) Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: basedate set to 2026-08-23 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: gps base set to 2026-08-23 (week 2433) Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listen and drop on 0 v6wildcard [::]:123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listen normally on 2 lo 127.0.0.1:123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listen normally on 3 eth0 172.31.30.168:123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listen normally on 4 lo [::1]:123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: bind(21) AF_INET6 fe80::499:59ff:fe66:176d%2#123 flags 0x11 failed: Cannot assign requested address Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: unable to create socket on eth0 (5) for fe80::499:59ff:fe66:176d%2#123 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: failed to init interface for address fe80::499:59ff:fe66:176d%2 Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: Listening on routing socket on fd #21 for interface updates Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:42.680385 ntpd[2008]: 4 Sep 23:48:42 ntpd[2008]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:42.600547 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 23:48:42.661264 ntpd[2008]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 4 23:48:42.642025 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 23:48:42.704014 extend-filesystems[2006]: Resized partition /dev/nvme0n1p9 Sep 4 23:48:42.661286 ntpd[2008]: ---------------------------------------------------- Sep 4 23:48:42.643843 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 23:48:42.711546 extend-filesystems[2038]: resize2fs 1.47.1 (20-May-2024) Sep 4 23:48:42.661305 ntpd[2008]: ntp-4 is maintained by Network Time Foundation, Sep 4 23:48:42.679191 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 4 23:48:42.661324 ntpd[2008]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 4 23:48:42.722079 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 23:48:42.661343 ntpd[2008]: corporation. Support and training for ntp-4 are Sep 4 23:48:42.723844 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 23:48:42.661362 ntpd[2008]: available at https://www.nwtime.org/support Sep 4 23:48:42.661380 ntpd[2008]: ---------------------------------------------------- Sep 4 23:48:42.668118 ntpd[2008]: proto: precision = 0.108 usec (-23) Sep 4 23:48:42.668539 ntpd[2008]: basedate set to 2026-08-23 Sep 4 23:48:42.668564 ntpd[2008]: gps base set to 2026-08-23 (week 2433) Sep 4 23:48:42.671218 ntpd[2008]: Listen and drop on 0 v6wildcard [::]:123 Sep 4 23:48:42.671324 ntpd[2008]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 4 23:48:42.671662 ntpd[2008]: Listen normally on 2 lo 127.0.0.1:123 Sep 4 23:48:42.671732 ntpd[2008]: Listen normally on 3 eth0 172.31.30.168:123 Sep 4 23:48:42.671834 ntpd[2008]: Listen normally on 4 lo [::1]:123 Sep 4 23:48:42.671918 ntpd[2008]: bind(21) AF_INET6 fe80::499:59ff:fe66:176d%2#123 flags 0x11 failed: Cannot assign requested address Sep 4 23:48:42.671959 ntpd[2008]: unable to create socket on eth0 (5) for fe80::499:59ff:fe66:176d%2#123 Sep 4 23:48:42.671987 ntpd[2008]: failed to init interface for address fe80::499:59ff:fe66:176d%2 Sep 4 23:48:42.672048 ntpd[2008]: Listening on routing socket on fd #21 for interface updates Sep 4 23:48:42.738688 jq[2017]: true Sep 4 23:48:42.677330 ntpd[2008]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:42.677382 ntpd[2008]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 4 23:48:42.757871 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Sep 4 23:48:42.800946 (ntainerd)[2042]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 23:48:42.822941 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 4 23:48:42.826610 jq[2044]: true Sep 4 23:48:42.864149 coreos-metadata[2003]: Sep 04 23:48:42.862 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 4 23:48:42.873094 coreos-metadata[2003]: Sep 04 23:48:42.872 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 4 23:48:42.874176 update_engine[2015]: I20260904 23:48:42.872733 2015 main.cc:92] Flatcar Update Engine starting Sep 4 23:48:42.875847 coreos-metadata[2003]: Sep 04 23:48:42.875 INFO Fetch successful Sep 4 23:48:42.875847 coreos-metadata[2003]: Sep 04 23:48:42.875 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 4 23:48:42.883262 coreos-metadata[2003]: Sep 04 23:48:42.882 INFO Fetch successful Sep 4 23:48:42.883262 coreos-metadata[2003]: Sep 04 23:48:42.882 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 4 23:48:42.885229 coreos-metadata[2003]: Sep 04 23:48:42.885 INFO Fetch successful Sep 4 23:48:42.885229 coreos-metadata[2003]: Sep 04 23:48:42.885 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 4 23:48:42.887778 coreos-metadata[2003]: Sep 04 23:48:42.887 INFO Fetch successful Sep 4 23:48:42.887778 coreos-metadata[2003]: Sep 04 23:48:42.887 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 4 23:48:42.890019 coreos-metadata[2003]: Sep 04 23:48:42.889 INFO Fetch failed with 404: resource not found Sep 4 23:48:42.890019 coreos-metadata[2003]: Sep 04 23:48:42.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 4 23:48:42.890489 systemd[1]: Started update-engine.service - Update Engine. Sep 4 23:48:42.902813 update_engine[2015]: I20260904 23:48:42.900687 2015 update_check_scheduler.cc:74] Next update check in 5m35s Sep 4 23:48:42.902987 coreos-metadata[2003]: Sep 04 23:48:42.901 INFO Fetch successful Sep 4 23:48:42.902987 coreos-metadata[2003]: Sep 04 23:48:42.901 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 4 23:48:42.906896 coreos-metadata[2003]: Sep 04 23:48:42.906 INFO Fetch successful Sep 4 23:48:42.906896 coreos-metadata[2003]: Sep 04 23:48:42.906 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 4 23:48:42.907118 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 23:48:42.917807 coreos-metadata[2003]: Sep 04 23:48:42.915 INFO Fetch successful Sep 4 23:48:42.917807 coreos-metadata[2003]: Sep 04 23:48:42.915 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 4 23:48:42.921120 coreos-metadata[2003]: Sep 04 23:48:42.919 INFO Fetch successful Sep 4 23:48:42.921120 coreos-metadata[2003]: Sep 04 23:48:42.920 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 4 23:48:42.929772 coreos-metadata[2003]: Sep 04 23:48:42.928 INFO Fetch successful Sep 4 23:48:43.012826 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (1771) Sep 4 23:48:43.016254 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Sep 4 23:48:43.051792 extend-filesystems[2038]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 4 23:48:43.051792 extend-filesystems[2038]: old_desc_blocks = 1, new_desc_blocks = 2 Sep 4 23:48:43.051792 extend-filesystems[2038]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Sep 4 23:48:43.060097 extend-filesystems[2006]: Resized filesystem in /dev/nvme0n1p9 Sep 4 23:48:43.072928 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 23:48:43.073874 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 23:48:43.092947 bash[2079]: Updated "/home/core/.ssh/authorized_keys" Sep 4 23:48:43.100448 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 23:48:43.106868 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 4 23:48:43.112058 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 23:48:43.131196 systemd-logind[2013]: Watching system buttons on /dev/input/event0 (Power Button) Sep 4 23:48:43.134866 systemd-logind[2013]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 4 23:48:43.137308 systemd-logind[2013]: New seat seat0. Sep 4 23:48:43.185405 systemd[1]: Starting sshkeys.service... Sep 4 23:48:43.187418 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 23:48:43.220309 locksmithd[2062]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 23:48:43.221483 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 4 23:48:43.247385 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 4 23:48:43.313584 dbus-daemon[2004]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 4 23:48:43.314646 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 4 23:48:43.323077 dbus-daemon[2004]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=2032 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 4 23:48:43.359712 systemd[1]: Starting polkit.service - Authorization Manager... Sep 4 23:48:43.424199 polkitd[2157]: Started polkitd version 121 Sep 4 23:48:43.460201 polkitd[2157]: Loading rules from directory /etc/polkit-1/rules.d Sep 4 23:48:43.460329 polkitd[2157]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 4 23:48:43.469817 polkitd[2157]: Finished loading, compiling and executing 2 rules Sep 4 23:48:43.471407 dbus-daemon[2004]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 4 23:48:43.471812 systemd[1]: Started polkit.service - Authorization Manager. Sep 4 23:48:43.476420 polkitd[2157]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 4 23:48:43.558465 systemd-hostnamed[2032]: Hostname set to (transient) Sep 4 23:48:43.559112 systemd-resolved[1955]: System hostname changed to 'ip-172-31-30-168'. Sep 4 23:48:43.587021 coreos-metadata[2123]: Sep 04 23:48:43.586 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 4 23:48:43.590818 coreos-metadata[2123]: Sep 04 23:48:43.590 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 4 23:48:43.590818 coreos-metadata[2123]: Sep 04 23:48:43.590 INFO Fetch successful Sep 4 23:48:43.590818 coreos-metadata[2123]: Sep 04 23:48:43.590 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 4 23:48:43.593897 coreos-metadata[2123]: Sep 04 23:48:43.593 INFO Fetch successful Sep 4 23:48:43.598057 unknown[2123]: wrote ssh authorized keys file for user: core Sep 4 23:48:43.613771 sshd_keygen[2048]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 23:48:43.623824 containerd[2042]: time="2026-09-04T23:48:43.622065022Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 4 23:48:43.639957 systemd-networkd[1954]: eth0: Gained IPv6LL Sep 4 23:48:43.658276 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 23:48:43.662932 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 23:48:43.667245 update-ssh-keys[2197]: Updated "/home/core/.ssh/authorized_keys" Sep 4 23:48:43.677659 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 4 23:48:43.690400 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:43.695799 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 23:48:43.701790 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 4 23:48:43.716824 systemd[1]: Finished sshkeys.service. Sep 4 23:48:43.778880 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 23:48:43.792277 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 23:48:43.809791 containerd[2042]: time="2026-09-04T23:48:43.808326359Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.815990039Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.156-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816062639Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816100991Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816406967Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816441515Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816560891Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816589403Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816907811Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816950195Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.816983639Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.817779 containerd[2042]: time="2026-09-04T23:48:43.817009343Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.818388 containerd[2042]: time="2026-09-04T23:48:43.817225319Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.818388 containerd[2042]: time="2026-09-04T23:48:43.817642787Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 23:48:43.818805 containerd[2042]: time="2026-09-04T23:48:43.818687459Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 23:48:43.818928 containerd[2042]: time="2026-09-04T23:48:43.818898419Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 23:48:43.819253 containerd[2042]: time="2026-09-04T23:48:43.819211667Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 23:48:43.819497 containerd[2042]: time="2026-09-04T23:48:43.819463655Z" level=info msg="metadata content store policy set" policy=shared Sep 4 23:48:43.830608 containerd[2042]: time="2026-09-04T23:48:43.830218511Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 23:48:43.830608 containerd[2042]: time="2026-09-04T23:48:43.830378603Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 23:48:43.830608 containerd[2042]: time="2026-09-04T23:48:43.830535107Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 23:48:43.831073 containerd[2042]: time="2026-09-04T23:48:43.830577179Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 23:48:43.831073 containerd[2042]: time="2026-09-04T23:48:43.830947307Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 23:48:43.831563 containerd[2042]: time="2026-09-04T23:48:43.831510899Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 23:48:43.833073 containerd[2042]: time="2026-09-04T23:48:43.833011679Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 23:48:43.833651 containerd[2042]: time="2026-09-04T23:48:43.833597843Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833784467Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833822591Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833893823Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833929247Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833962499Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.833994791Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834029459Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834070787Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834100727Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834128351Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834169151Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834201215Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834230351Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.834878 containerd[2042]: time="2026-09-04T23:48:43.834261743Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834290711Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834327119Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834359051Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834390683Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834420311Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834453251Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834491555Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834522419Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834551867Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834585503Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834629507Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834658979Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.835521 containerd[2042]: time="2026-09-04T23:48:43.834685667Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.837298439Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839264147Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839308439Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839439011Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839468915Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839713607Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839775455Z" level=info msg="NRI interface is disabled by configuration." Sep 4 23:48:43.840195 containerd[2042]: time="2026-09-04T23:48:43.839822303Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 23:48:43.842612 containerd[2042]: time="2026-09-04T23:48:43.841462595Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 4 23:48:43.842612 containerd[2042]: time="2026-09-04T23:48:43.841605587Z" level=info msg="Connect containerd service" Sep 4 23:48:43.842612 containerd[2042]: time="2026-09-04T23:48:43.841708403Z" level=info msg="using legacy CRI server" Sep 4 23:48:43.842612 containerd[2042]: time="2026-09-04T23:48:43.841729295Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 23:48:43.842612 containerd[2042]: time="2026-09-04T23:48:43.841933295Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.846388019Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847029803Z" level=info msg="Start subscribing containerd event" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847128983Z" level=info msg="Start recovering state" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847247651Z" level=info msg="Start event monitor" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847271063Z" level=info msg="Start snapshots syncer" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847292195Z" level=info msg="Start cni network conf syncer for default" Sep 4 23:48:43.847770 containerd[2042]: time="2026-09-04T23:48:43.847313207Z" level=info msg="Start streaming server" Sep 4 23:48:43.847882 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 23:48:43.863584 containerd[2042]: time="2026-09-04T23:48:43.858063551Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 23:48:43.863584 containerd[2042]: time="2026-09-04T23:48:43.858391175Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 23:48:43.863584 containerd[2042]: time="2026-09-04T23:48:43.858494255Z" level=info msg="containerd successfully booted in 0.242643s" Sep 4 23:48:43.858597 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 23:48:43.863137 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 23:48:43.863514 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 23:48:43.878343 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 23:48:43.904773 amazon-ssm-agent[2203]: Initializing new seelog logger Sep 4 23:48:43.904773 amazon-ssm-agent[2203]: New Seelog Logger Creation Complete Sep 4 23:48:43.904773 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.904773 amazon-ssm-agent[2203]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.906004 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 processing appconfig overrides Sep 4 23:48:43.907517 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 processing appconfig overrides Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.917343 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 processing appconfig overrides Sep 4 23:48:43.918521 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 23:48:43.922343 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO Proxy environment variables: Sep 4 23:48:43.930474 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 23:48:43.936951 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.936951 amazon-ssm-agent[2203]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 4 23:48:43.936951 amazon-ssm-agent[2203]: 2026/09/04 23:48:43 processing appconfig overrides Sep 4 23:48:43.933410 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 23:48:44.021726 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO https_proxy: Sep 4 23:48:44.120909 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO http_proxy: Sep 4 23:48:44.219338 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO no_proxy: Sep 4 23:48:44.317286 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO Checking if agent identity type OnPrem can be assumed Sep 4 23:48:44.416121 amazon-ssm-agent[2203]: 2026-09-04 23:48:43 INFO Checking if agent identity type EC2 can be assumed Sep 4 23:48:44.514807 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO Agent will take identity from EC2 Sep 4 23:48:44.614503 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.713420 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.812647 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 4 23:48:44.911855 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Sep 4 23:48:45.012202 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 4 23:48:45.112891 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] Starting Core Agent Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [amazon-ssm-agent] registrar detected. Attempting registration Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [Registrar] Starting registrar module Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:44 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:45 INFO [EC2Identity] EC2 registration was successful. Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:45 INFO [CredentialRefresher] credentialRefresher has started Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:45 INFO [CredentialRefresher] Starting credentials refresher loop Sep 4 23:48:45.156468 amazon-ssm-agent[2203]: 2026-09-04 23:48:45 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 4 23:48:45.213928 amazon-ssm-agent[2203]: 2026-09-04 23:48:45 INFO [CredentialRefresher] Next credential rotation will be in 30.324991557 minutes Sep 4 23:48:45.546553 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:45.550201 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 23:48:45.555108 systemd[1]: Startup finished in 1.196s (kernel) + 7.667s (initrd) + 8.123s (userspace) = 16.986s. Sep 4 23:48:45.576424 (kubelet)[2243]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Sep 4 23:48:45.662351 ntpd[2008]: Listen normally on 6 eth0 [fe80::499:59ff:fe66:176d%2]:123 Sep 4 23:48:45.662840 ntpd[2008]: 4 Sep 23:48:45 ntpd[2008]: Listen normally on 6 eth0 [fe80::499:59ff:fe66:176d%2]:123 Sep 4 23:48:45.802434 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 23:48:45.811373 systemd[1]: Started sshd@0-172.31.30.168:22-20.61.25.254:55698.service - OpenSSH per-connection server daemon (20.61.25.254:55698). Sep 4 23:48:46.189994 amazon-ssm-agent[2203]: 2026-09-04 23:48:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 4 23:48:46.292711 amazon-ssm-agent[2203]: 2026-09-04 23:48:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2256) started Sep 4 23:48:46.371285 kubelet[2243]: E0904 23:48:46.371228 2243 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Sep 4 23:48:46.375770 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Sep 4 23:48:46.376112 systemd[1]: kubelet.service: Failed with result 'exit-code'. Sep 4 23:48:46.378119 systemd[1]: kubelet.service: Consumed 1.261s CPU time. Sep 4 23:48:46.391381 amazon-ssm-agent[2203]: 2026-09-04 23:48:46 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 4 23:48:46.797771 sshd[2253]: Accepted publickey for core from 20.61.25.254 port 55698 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:46.800562 sshd[2253]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:46.819074 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 23:48:46.826278 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 23:48:46.831762 systemd-logind[2013]: New session 1 of user core. Sep 4 23:48:46.860916 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 23:48:46.869359 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 23:48:46.890339 (systemd)[2270]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 23:48:47.122964 systemd[2270]: Queued start job for default target default.target. Sep 4 23:48:47.135885 systemd[2270]: Created slice app.slice - User Application Slice. Sep 4 23:48:47.135953 systemd[2270]: Reached target paths.target - Paths. Sep 4 23:48:47.135987 systemd[2270]: Reached target timers.target - Timers. Sep 4 23:48:47.138436 systemd[2270]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 23:48:47.170023 systemd[2270]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 23:48:47.170807 systemd[2270]: Reached target sockets.target - Sockets. Sep 4 23:48:47.171001 systemd[2270]: Reached target basic.target - Basic System. Sep 4 23:48:47.171191 systemd[2270]: Reached target default.target - Main User Target. Sep 4 23:48:47.171353 systemd[2270]: Startup finished in 268ms. Sep 4 23:48:47.171558 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 23:48:47.184184 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 23:48:47.871310 systemd[1]: Started sshd@1-172.31.30.168:22-20.61.25.254:41768.service - OpenSSH per-connection server daemon (20.61.25.254:41768). Sep 4 23:48:48.849549 sshd[2281]: Accepted publickey for core from 20.61.25.254 port 41768 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:48.852227 sshd[2281]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:48.859630 systemd-logind[2013]: New session 2 of user core. Sep 4 23:48:48.872009 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 23:48:49.520892 sshd[2281]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:49.527496 systemd[1]: sshd@1-172.31.30.168:22-20.61.25.254:41768.service: Deactivated successfully. Sep 4 23:48:49.531823 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 23:48:49.533622 systemd-logind[2013]: Session 2 logged out. Waiting for processes to exit. Sep 4 23:48:49.536793 systemd-logind[2013]: Removed session 2. Sep 4 23:48:49.803566 systemd-resolved[1955]: Clock change detected. Flushing caches. Sep 4 23:48:49.836324 systemd[1]: Started sshd@2-172.31.30.168:22-20.61.25.254:41780.service - OpenSSH per-connection server daemon (20.61.25.254:41780). Sep 4 23:48:50.815331 sshd[2288]: Accepted publickey for core from 20.61.25.254 port 41780 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:50.817122 sshd[2288]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:50.826096 systemd-logind[2013]: New session 3 of user core. Sep 4 23:48:50.834017 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 23:48:51.477332 sshd[2288]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:51.483726 systemd[1]: sshd@2-172.31.30.168:22-20.61.25.254:41780.service: Deactivated successfully. Sep 4 23:48:51.487332 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 23:48:51.489313 systemd-logind[2013]: Session 3 logged out. Waiting for processes to exit. Sep 4 23:48:51.491463 systemd-logind[2013]: Removed session 3. Sep 4 23:48:51.655311 systemd[1]: Started sshd@3-172.31.30.168:22-20.61.25.254:41790.service - OpenSSH per-connection server daemon (20.61.25.254:41790). Sep 4 23:48:52.644818 sshd[2295]: Accepted publickey for core from 20.61.25.254 port 41790 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:52.646460 sshd[2295]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:52.655989 systemd-logind[2013]: New session 4 of user core. Sep 4 23:48:52.662050 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 23:48:53.323650 sshd[2295]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:53.331140 systemd[1]: sshd@3-172.31.30.168:22-20.61.25.254:41790.service: Deactivated successfully. Sep 4 23:48:53.334701 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 23:48:53.335962 systemd-logind[2013]: Session 4 logged out. Waiting for processes to exit. Sep 4 23:48:53.338393 systemd-logind[2013]: Removed session 4. Sep 4 23:48:53.488942 systemd[1]: Started sshd@4-172.31.30.168:22-20.61.25.254:41802.service - OpenSSH per-connection server daemon (20.61.25.254:41802). Sep 4 23:48:54.467480 sshd[2302]: Accepted publickey for core from 20.61.25.254 port 41802 ssh2: RSA SHA256:Kc+bWeBWTrMRWHyVzcYgV4kqs2gcD6nA0nSghq6yQHE Sep 4 23:48:54.470076 sshd[2302]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 4 23:48:54.479090 systemd-logind[2013]: New session 5 of user core. Sep 4 23:48:54.486043 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 23:48:54.998511 sudo[2305]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Sep 4 23:48:54.999162 sudo[2305]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Sep 4 23:48:56.051011 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:56.051357 systemd[1]: kubelet.service: Consumed 1.261s CPU time. Sep 4 23:48:56.068136 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:56.111618 systemd[1]: Reloading requested from client PID 2344 ('systemctl') (unit session-5.scope)... Sep 4 23:48:56.111656 systemd[1]: Reloading... Sep 4 23:48:56.321814 zram_generator::config[2384]: No configuration found. Sep 4 23:48:56.608012 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Sep 4 23:48:56.781716 systemd[1]: Reloading finished in 669 ms. Sep 4 23:48:56.871316 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Sep 4 23:48:56.871836 systemd[1]: kubelet.service: Failed with result 'signal'. Sep 4 23:48:56.872474 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:56.878310 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Sep 4 23:48:57.224112 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Sep 4 23:48:57.236289 (kubelet)[2448]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Sep 4 23:48:57.314489 kubelet[2448]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Sep 4 23:48:57.910665 kubelet[2448]: I0904 23:48:57.910476 2448 server.go:525] "Kubelet version" kubeletVersion="v1.35.1" Sep 4 23:48:57.910665 kubelet[2448]: I0904 23:48:57.910547 2448 server.go:527] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Sep 4 23:48:57.913311 kubelet[2448]: I0904 23:48:57.913279 2448 watchdog_linux.go:95] "Systemd watchdog is not enabled" Sep 4 23:48:57.914834 kubelet[2448]: I0904 23:48:57.913420 2448 watchdog_linux.go:138] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Sep 4 23:48:57.914834 kubelet[2448]: I0904 23:48:57.913928 2448 server.go:951] "Client rotation is on, will bootstrap in background" Sep 4 23:48:57.919819 kubelet[2448]: I0904 23:48:57.919587 2448 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Sep 4 23:48:57.926188 kubelet[2448]: E0904 23:48:57.926123 2448 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Sep 4 23:48:57.926338 kubelet[2448]: I0904 23:48:57.926224 2448 server.go:1395] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Sep 4 23:48:57.931925 kubelet[2448]: I0904 23:48:57.931274 2448 server.go:775] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Sep 4 23:48:57.933128 kubelet[2448]: I0904 23:48:57.933063 2448 container_manager_linux.go:272] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Sep 4 23:48:57.933490 kubelet[2448]: I0904 23:48:57.933222 2448 container_manager_linux.go:277] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.30.168","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Sep 4 23:48:57.933787 kubelet[2448]: I0904 23:48:57.933677 2448 topology_manager.go:143] "Creating topology manager with none policy" Sep 4 23:48:57.933919 kubelet[2448]: I0904 23:48:57.933900 2448 container_manager_linux.go:308] "Creating device plugin manager" Sep 4 23:48:57.934165 kubelet[2448]: I0904 23:48:57.934141 2448 container_manager_linux.go:317] "Creating Dynamic Resource Allocation (DRA) manager" Sep 4 23:48:57.952309 kubelet[2448]: I0904 23:48:57.952271 2448 state_mem.go:41] "Initialized" logger="CPUManager state memory" Sep 4 23:48:57.953016 kubelet[2448]: I0904 23:48:57.952954 2448 kubelet.go:482] "Attempting to sync node with API server" Sep 4 23:48:57.953327 kubelet[2448]: I0904 23:48:57.953163 2448 kubelet.go:383] "Adding static pod path" path="/etc/kubernetes/manifests" Sep 4 23:48:57.953327 kubelet[2448]: I0904 23:48:57.953202 2448 kubelet.go:394] "Adding apiserver pod source" Sep 4 23:48:57.953327 kubelet[2448]: I0904 23:48:57.953268 2448 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Sep 4 23:48:57.954198 kubelet[2448]: E0904 23:48:57.954156 2448 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:57.954361 kubelet[2448]: E0904 23:48:57.954244 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:57.960248 kubelet[2448]: I0904 23:48:57.960196 2448 kuberuntime_manager.go:294] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Sep 4 23:48:57.962507 kubelet[2448]: I0904 23:48:57.962347 2448 kubelet.go:943] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Sep 4 23:48:57.962507 kubelet[2448]: I0904 23:48:57.962412 2448 kubelet.go:970] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Sep 4 23:48:57.962507 kubelet[2448]: W0904 23:48:57.962483 2448 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Sep 4 23:48:57.967168 kubelet[2448]: I0904 23:48:57.966869 2448 server.go:1257] "Started kubelet" Sep 4 23:48:57.969676 kubelet[2448]: I0904 23:48:57.969619 2448 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Sep 4 23:48:57.970818 kubelet[2448]: I0904 23:48:57.970352 2448 server.go:182] "Starting to listen" address="0.0.0.0" port=10250 Sep 4 23:48:57.971936 kubelet[2448]: I0904 23:48:57.971372 2448 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Sep 4 23:48:57.971936 kubelet[2448]: I0904 23:48:57.971471 2448 server_v1.go:49] "podresources" method="list" useActivePods=true Sep 4 23:48:57.971936 kubelet[2448]: I0904 23:48:57.971897 2448 server.go:254] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Sep 4 23:48:57.974136 kubelet[2448]: I0904 23:48:57.974092 2448 server.go:317] "Adding debug handlers to kubelet server" Sep 4 23:48:57.985102 kubelet[2448]: I0904 23:48:57.985047 2448 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Sep 4 23:48:57.986091 kubelet[2448]: I0904 23:48:57.986047 2448 volume_manager.go:311] "Starting Kubelet Volume Manager" Sep 4 23:48:57.994944 kubelet[2448]: I0904 23:48:57.986257 2448 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Sep 4 23:48:57.995786 kubelet[2448]: E0904 23:48:57.986462 2448 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"172.31.30.168\" not found" Sep 4 23:48:57.995914 kubelet[2448]: I0904 23:48:57.995877 2448 reconciler.go:29] "Reconciler: start to sync state" Sep 4 23:48:58.005593 kubelet[2448]: E0904 23:48:58.005550 2448 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"172.31.30.168\" not found" node="172.31.30.168" Sep 4 23:48:58.011601 kubelet[2448]: E0904 23:48:58.011548 2448 kubelet.go:1656] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Sep 4 23:48:58.013688 kubelet[2448]: I0904 23:48:58.013653 2448 factory.go:223] Registration of the containerd container factory successfully Sep 4 23:48:58.013945 kubelet[2448]: I0904 23:48:58.013925 2448 factory.go:223] Registration of the systemd container factory successfully Sep 4 23:48:58.014358 kubelet[2448]: I0904 23:48:58.014320 2448 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Sep 4 23:48:58.042573 kubelet[2448]: I0904 23:48:58.042520 2448 cpu_manager.go:225] "Starting" policy="none" Sep 4 23:48:58.042573 kubelet[2448]: I0904 23:48:58.042553 2448 cpu_manager.go:226] "Reconciling" reconcilePeriod="10s" Sep 4 23:48:58.042737 kubelet[2448]: I0904 23:48:58.042591 2448 state_mem.go:41] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Sep 4 23:48:58.048341 kubelet[2448]: I0904 23:48:58.048299 2448 policy_none.go:50] "Start" Sep 4 23:48:58.048341 kubelet[2448]: I0904 23:48:58.048341 2448 memory_manager.go:187] "Starting memorymanager" policy="None" Sep 4 23:48:58.048515 kubelet[2448]: I0904 23:48:58.048367 2448 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Sep 4 23:48:58.056040 kubelet[2448]: I0904 23:48:58.055095 2448 policy_none.go:44] "Start" Sep 4 23:48:58.065745 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Sep 4 23:48:58.084612 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Sep 4 23:48:58.094101 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Sep 4 23:48:58.096182 kubelet[2448]: E0904 23:48:58.096109 2448 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"172.31.30.168\" not found" Sep 4 23:48:58.107540 kubelet[2448]: E0904 23:48:58.107481 2448 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Sep 4 23:48:58.108789 kubelet[2448]: I0904 23:48:58.107821 2448 eviction_manager.go:194] "Eviction manager: starting control loop" Sep 4 23:48:58.108789 kubelet[2448]: I0904 23:48:58.107878 2448 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Sep 4 23:48:58.109044 kubelet[2448]: I0904 23:48:58.109002 2448 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Sep 4 23:48:58.117630 kubelet[2448]: E0904 23:48:58.116051 2448 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Sep 4 23:48:58.117881 kubelet[2448]: E0904 23:48:58.117676 2448 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.30.168\" not found" Sep 4 23:48:58.124815 kubelet[2448]: I0904 23:48:58.124677 2448 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Sep 4 23:48:58.128316 kubelet[2448]: I0904 23:48:58.128251 2448 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Sep 4 23:48:58.128436 kubelet[2448]: I0904 23:48:58.128309 2448 status_manager.go:249] "Starting to sync pod status with apiserver" Sep 4 23:48:58.128436 kubelet[2448]: I0904 23:48:58.128374 2448 kubelet.go:2501] "Starting kubelet main sync loop" Sep 4 23:48:58.128577 kubelet[2448]: E0904 23:48:58.128468 2448 kubelet.go:2525] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Sep 4 23:48:58.217567 kubelet[2448]: I0904 23:48:58.217432 2448 kubelet_node_status.go:74] "Attempting to register node" node="172.31.30.168" Sep 4 23:48:58.225375 kubelet[2448]: I0904 23:48:58.225311 2448 kubelet_node_status.go:77] "Successfully registered node" node="172.31.30.168" Sep 4 23:48:58.258646 sudo[2305]: pam_unix(sudo:session): session closed for user root Sep 4 23:48:58.341338 kubelet[2448]: I0904 23:48:58.341157 2448 kuberuntime_manager.go:2062] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Sep 4 23:48:58.341947 containerd[2042]: time="2026-09-04T23:48:58.341630046Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Sep 4 23:48:58.342880 kubelet[2448]: I0904 23:48:58.342562 2448 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Sep 4 23:48:58.416155 sshd[2302]: pam_unix(sshd:session): session closed for user core Sep 4 23:48:58.423289 systemd[1]: sshd@4-172.31.30.168:22-20.61.25.254:41802.service: Deactivated successfully. Sep 4 23:48:58.427560 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 23:48:58.430144 systemd-logind[2013]: Session 5 logged out. Waiting for processes to exit. Sep 4 23:48:58.432048 systemd-logind[2013]: Removed session 5. Sep 4 23:48:58.917204 kubelet[2448]: I0904 23:48:58.916609 2448 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Sep 4 23:48:58.917204 kubelet[2448]: I0904 23:48:58.916892 2448 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:48:58.917204 kubelet[2448]: I0904 23:48:58.917054 2448 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:48:58.917204 kubelet[2448]: I0904 23:48:58.917121 2448 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Sep 4 23:48:58.954602 kubelet[2448]: E0904 23:48:58.954562 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:48:58.955799 kubelet[2448]: I0904 23:48:58.955757 2448 apiserver.go:52] "Watching apiserver" Sep 4 23:48:58.985749 systemd[1]: Created slice kubepods-burstable-pod3ab5bfb3_c03e_4e12_9a02_70720c0ec779.slice - libcontainer container kubepods-burstable-pod3ab5bfb3_c03e_4e12_9a02_70720c0ec779.slice. Sep 4 23:48:58.999495 kubelet[2448]: I0904 23:48:58.999425 2448 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Sep 4 23:48:59.002693 kubelet[2448]: I0904 23:48:59.001597 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-9kvkw\" (UniqueName: \"kubernetes.io/projected/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-kube-api-access-9kvkw\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.002693 kubelet[2448]: I0904 23:48:59.001661 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/5c21418a-8d24-456c-96df-9a3f48a4c2a8-kube-proxy\") pod \"kube-proxy-w2sz4\" (UID: \"5c21418a-8d24-456c-96df-9a3f48a4c2a8\") " pod="kube-system/kube-proxy-w2sz4" Sep 4 23:48:59.002693 kubelet[2448]: I0904 23:48:59.001705 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/5c21418a-8d24-456c-96df-9a3f48a4c2a8-xtables-lock\") pod \"kube-proxy-w2sz4\" (UID: \"5c21418a-8d24-456c-96df-9a3f48a4c2a8\") " pod="kube-system/kube-proxy-w2sz4" Sep 4 23:48:59.002693 kubelet[2448]: I0904 23:48:59.001741 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/5c21418a-8d24-456c-96df-9a3f48a4c2a8-lib-modules\") pod \"kube-proxy-w2sz4\" (UID: \"5c21418a-8d24-456c-96df-9a3f48a4c2a8\") " pod="kube-system/kube-proxy-w2sz4" Sep 4 23:48:59.002693 kubelet[2448]: I0904 23:48:59.001802 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2z8c7\" (UniqueName: \"kubernetes.io/projected/5c21418a-8d24-456c-96df-9a3f48a4c2a8-kube-api-access-2z8c7\") pod \"kube-proxy-w2sz4\" (UID: \"5c21418a-8d24-456c-96df-9a3f48a4c2a8\") " pod="kube-system/kube-proxy-w2sz4" Sep 4 23:48:59.003054 kubelet[2448]: I0904 23:48:59.001840 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-run\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.003054 kubelet[2448]: I0904 23:48:59.001877 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-cni-plugin\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.003054 kubelet[2448]: I0904 23:48:59.001912 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-flannel-cfg\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.003054 kubelet[2448]: I0904 23:48:59.001946 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-cni\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.003054 kubelet[2448]: I0904 23:48:59.001978 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/3ab5bfb3-c03e-4e12-9a02-70720c0ec779-xtables-lock\") pod \"kube-flannel-ds-5h9pt\" (UID: \"3ab5bfb3-c03e-4e12-9a02-70720c0ec779\") " pod="kube-flannel/kube-flannel-ds-5h9pt" Sep 4 23:48:59.005945 systemd[1]: Created slice kubepods-besteffort-pod5c21418a_8d24_456c_96df_9a3f48a4c2a8.slice - libcontainer container kubepods-besteffort-pod5c21418a_8d24_456c_96df_9a3f48a4c2a8.slice. Sep 4 23:48:59.310737 containerd[2042]: time="2026-09-04T23:48:59.310667707Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5h9pt,Uid:3ab5bfb3-c03e-4e12-9a02-70720c0ec779,Namespace:kube-flannel,Attempt:0,}" Sep 4 23:48:59.325547 containerd[2042]: time="2026-09-04T23:48:59.324992683Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-w2sz4,Uid:5c21418a-8d24-456c-96df-9a3f48a4c2a8,Namespace:kube-system,Attempt:0,}" Sep 4 23:48:59.955335 kubelet[2448]: E0904 23:48:59.955260 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:00.450668 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount877367750.mount: Deactivated successfully. Sep 4 23:49:00.468936 containerd[2042]: time="2026-09-04T23:49:00.468855140Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:49:00.475147 containerd[2042]: time="2026-09-04T23:49:00.475075809Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:49:00.478315 containerd[2042]: time="2026-09-04T23:49:00.478255473Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269327" Sep 4 23:49:00.481308 containerd[2042]: time="2026-09-04T23:49:00.481236693Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:49:00.483301 containerd[2042]: time="2026-09-04T23:49:00.483241425Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Sep 4 23:49:00.491646 containerd[2042]: time="2026-09-04T23:49:00.491570169Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Sep 4 23:49:00.496115 containerd[2042]: time="2026-09-04T23:49:00.495791793Z" 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 1.170654282s" Sep 4 23:49:00.498569 containerd[2042]: time="2026-09-04T23:49:00.498479541Z" 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 1.187667666s" Sep 4 23:49:00.690114 containerd[2042]: time="2026-09-04T23:49:00.689841886Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:00.690114 containerd[2042]: time="2026-09-04T23:49:00.689945866Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:00.690114 containerd[2042]: time="2026-09-04T23:49:00.689985502Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:00.690440 containerd[2042]: time="2026-09-04T23:49:00.690160810Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:00.697108 containerd[2042]: time="2026-09-04T23:49:00.696063274Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:00.697108 containerd[2042]: time="2026-09-04T23:49:00.696171634Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:00.697108 containerd[2042]: time="2026-09-04T23:49:00.696201406Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:00.697108 containerd[2042]: time="2026-09-04T23:49:00.696372286Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:00.832102 systemd[1]: Started cri-containerd-7602efa50fe771d846f65282858b07f919d24d208391c3835d8f80967e151a7f.scope - libcontainer container 7602efa50fe771d846f65282858b07f919d24d208391c3835d8f80967e151a7f. Sep 4 23:49:00.845075 systemd[1]: Started cri-containerd-633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310.scope - libcontainer container 633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310. Sep 4 23:49:00.893321 containerd[2042]: time="2026-09-04T23:49:00.893262083Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-w2sz4,Uid:5c21418a-8d24-456c-96df-9a3f48a4c2a8,Namespace:kube-system,Attempt:0,} returns sandbox id \"7602efa50fe771d846f65282858b07f919d24d208391c3835d8f80967e151a7f\"" Sep 4 23:49:00.898959 containerd[2042]: time="2026-09-04T23:49:00.898652627Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.8\"" Sep 4 23:49:00.929078 containerd[2042]: time="2026-09-04T23:49:00.928918079Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-5h9pt,Uid:3ab5bfb3-c03e-4e12-9a02-70720c0ec779,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\"" Sep 4 23:49:00.956492 kubelet[2448]: E0904 23:49:00.956409 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:01.957316 kubelet[2448]: E0904 23:49:01.957161 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:02.473149 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3502887026.mount: Deactivated successfully. Sep 4 23:49:02.884145 containerd[2042]: time="2026-09-04T23:49:02.884062452Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.35.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:02.886845 containerd[2042]: time="2026-09-04T23:49:02.886779960Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.35.8: active requests=0, bytes read=23717972" Sep 4 23:49:02.889066 containerd[2042]: time="2026-09-04T23:49:02.888989268Z" level=info msg="ImageCreate event name:\"sha256:b244ad040ab498c3110f00acc2348847687e0de18fa9ee5a319a89620f1cc13a\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:02.894794 containerd[2042]: time="2026-09-04T23:49:02.893554981Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:5d641d163114b212229b8bceba9f859cff1265ba40e02a2bb0ec8743f56c1033\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:02.895155 containerd[2042]: time="2026-09-04T23:49:02.895107001Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.35.8\" with image id \"sha256:b244ad040ab498c3110f00acc2348847687e0de18fa9ee5a319a89620f1cc13a\", repo tag \"registry.k8s.io/kube-proxy:v1.35.8\", repo digest \"registry.k8s.io/kube-proxy@sha256:5d641d163114b212229b8bceba9f859cff1265ba40e02a2bb0ec8743f56c1033\", size \"23716806\" in 1.99639447s" Sep 4 23:49:02.895286 containerd[2042]: time="2026-09-04T23:49:02.895256509Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.8\" returns image reference \"sha256:b244ad040ab498c3110f00acc2348847687e0de18fa9ee5a319a89620f1cc13a\"" Sep 4 23:49:02.897149 containerd[2042]: time="2026-09-04T23:49:02.897102373Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Sep 4 23:49:02.905076 containerd[2042]: time="2026-09-04T23:49:02.905025049Z" level=info msg="CreateContainer within sandbox \"7602efa50fe771d846f65282858b07f919d24d208391c3835d8f80967e151a7f\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Sep 4 23:49:02.933976 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3293285034.mount: Deactivated successfully. Sep 4 23:49:02.940363 containerd[2042]: time="2026-09-04T23:49:02.940219465Z" level=info msg="CreateContainer within sandbox \"7602efa50fe771d846f65282858b07f919d24d208391c3835d8f80967e151a7f\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"6ba3bc723ad8b9cfcd3d9a4eb1743b3cc538d83237dacc3b85d751f6d0ab6034\"" Sep 4 23:49:02.941703 containerd[2042]: time="2026-09-04T23:49:02.941600089Z" level=info msg="StartContainer for \"6ba3bc723ad8b9cfcd3d9a4eb1743b3cc538d83237dacc3b85d751f6d0ab6034\"" Sep 4 23:49:02.958262 kubelet[2448]: E0904 23:49:02.958214 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:02.996124 systemd[1]: Started cri-containerd-6ba3bc723ad8b9cfcd3d9a4eb1743b3cc538d83237dacc3b85d751f6d0ab6034.scope - libcontainer container 6ba3bc723ad8b9cfcd3d9a4eb1743b3cc538d83237dacc3b85d751f6d0ab6034. Sep 4 23:49:03.047908 containerd[2042]: time="2026-09-04T23:49:03.046188993Z" level=info msg="StartContainer for \"6ba3bc723ad8b9cfcd3d9a4eb1743b3cc538d83237dacc3b85d751f6d0ab6034\" returns successfully" Sep 4 23:49:03.175320 kubelet[2448]: I0904 23:49:03.174548 2448 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-system/kube-proxy-w2sz4" podStartSLOduration=3.175389428 podStartE2EDuration="5.174532006s" podCreationTimestamp="2026-09-04 23:48:58 +0000 UTC" firstStartedPulling="2026-09-04 23:49:00.897651035 +0000 UTC m=+3.650164844" lastFinishedPulling="2026-09-04 23:49:02.896793565 +0000 UTC m=+5.649307422" observedRunningTime="2026-09-04 23:49:03.173053138 +0000 UTC m=+5.925566935" watchObservedRunningTime="2026-09-04 23:49:03.174532006 +0000 UTC m=+5.927045827" Sep 4 23:49:03.958412 kubelet[2448]: E0904 23:49:03.958360 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:04.303485 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3603555142.mount: Deactivated successfully. Sep 4 23:49:04.384392 containerd[2042]: time="2026-09-04T23:49:04.383561736Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:04.386585 containerd[2042]: time="2026-09-04T23:49:04.385975764Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=5125564" Sep 4 23:49:04.388911 containerd[2042]: time="2026-09-04T23:49:04.388852380Z" level=info msg="ImageCreate event name:\"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:04.395465 containerd[2042]: time="2026-09-04T23:49:04.395379864Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:04.397871 containerd[2042]: time="2026-09-04T23:49:04.397819728Z" 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.500089479s" Sep 4 23:49:04.398549 containerd[2042]: time="2026-09-04T23:49:04.398019660Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:bf6e087b7c89143a757bb62f368860d2454e71afe59ae44ecb1ab473fd00b759\"" Sep 4 23:49:04.406496 containerd[2042]: time="2026-09-04T23:49:04.406290180Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Sep 4 23:49:04.438230 containerd[2042]: time="2026-09-04T23:49:04.438055776Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6\"" Sep 4 23:49:04.439824 containerd[2042]: time="2026-09-04T23:49:04.438827496Z" level=info msg="StartContainer for \"eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6\"" Sep 4 23:49:04.491061 systemd[1]: Started cri-containerd-eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6.scope - libcontainer container eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6. Sep 4 23:49:04.539254 containerd[2042]: time="2026-09-04T23:49:04.539192593Z" level=info msg="StartContainer for \"eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6\" returns successfully" Sep 4 23:49:04.541979 systemd[1]: cri-containerd-eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6.scope: Deactivated successfully. Sep 4 23:49:04.578554 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6-rootfs.mount: Deactivated successfully. Sep 4 23:49:04.734385 containerd[2042]: time="2026-09-04T23:49:04.734142662Z" level=info msg="shim disconnected" id=eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6 namespace=k8s.io Sep 4 23:49:04.734385 containerd[2042]: time="2026-09-04T23:49:04.734238974Z" level=warning msg="cleaning up after shim disconnected" id=eeac83835f1926e78586d4df134ac33e00f06d59838c5f763ae7df9211d12fa6 namespace=k8s.io Sep 4 23:49:04.734385 containerd[2042]: time="2026-09-04T23:49:04.734259950Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:49:04.959575 kubelet[2448]: E0904 23:49:04.959416 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:05.164590 containerd[2042]: time="2026-09-04T23:49:05.164193144Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Sep 4 23:49:05.960158 kubelet[2448]: E0904 23:49:05.960094 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:06.960313 kubelet[2448]: E0904 23:49:06.960230 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:07.690800 containerd[2042]: time="2026-09-04T23:49:07.688797508Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:07.692192 containerd[2042]: time="2026-09-04T23:49:07.692143984Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=28419854" Sep 4 23:49:07.693470 containerd[2042]: time="2026-09-04T23:49:07.693425668Z" level=info msg="ImageCreate event name:\"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:07.701208 containerd[2042]: time="2026-09-04T23:49:07.701143336Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:07.704439 containerd[2042]: time="2026-09-04T23:49:07.704379448Z" 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.540124528s" Sep 4 23:49:07.704623 containerd[2042]: time="2026-09-04T23:49:07.704592856Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:253e2cac1f011511dce473642669aa3b75987d78cb108ecc51c8c2fa69f3e587\"" Sep 4 23:49:07.713675 containerd[2042]: time="2026-09-04T23:49:07.713584912Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Sep 4 23:49:07.739804 containerd[2042]: time="2026-09-04T23:49:07.739707449Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69\"" Sep 4 23:49:07.740894 containerd[2042]: time="2026-09-04T23:49:07.740845625Z" level=info msg="StartContainer for \"e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69\"" Sep 4 23:49:07.795091 systemd[1]: Started cri-containerd-e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69.scope - libcontainer container e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69. Sep 4 23:49:07.844567 systemd[1]: cri-containerd-e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69.scope: Deactivated successfully. Sep 4 23:49:07.849994 containerd[2042]: time="2026-09-04T23:49:07.849615881Z" level=info msg="StartContainer for \"e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69\" returns successfully" Sep 4 23:49:07.880685 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69-rootfs.mount: Deactivated successfully. Sep 4 23:49:07.936354 kubelet[2448]: I0904 23:49:07.936311 2448 kubelet_node_status.go:427] "Fast updating node status as it just became ready" Sep 4 23:49:07.961017 kubelet[2448]: E0904 23:49:07.960842 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:07.993158 containerd[2042]: time="2026-09-04T23:49:07.993073494Z" level=info msg="shim disconnected" id=e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69 namespace=k8s.io Sep 4 23:49:07.993158 containerd[2042]: time="2026-09-04T23:49:07.993149670Z" level=warning msg="cleaning up after shim disconnected" id=e380aeb082016a722ca2c384b8e3713c1ee3eb1a2b2275215b37d7ec84c2fb69 namespace=k8s.io Sep 4 23:49:07.993390 containerd[2042]: time="2026-09-04T23:49:07.993171450Z" level=info msg="cleaning up dead shim" namespace=k8s.io Sep 4 23:49:08.185446 containerd[2042]: time="2026-09-04T23:49:08.185374323Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Sep 4 23:49:08.217250 containerd[2042]: time="2026-09-04T23:49:08.216637251Z" level=info msg="CreateContainer within sandbox \"633411760a37b97c23fff0927033f90bcba6d9b94aa3804cddc5ab7410f67310\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"7e5797a2bbaa0d508b87f95229115da9d388f68af3708c36d51b6dacf6b3cd8f\"" Sep 4 23:49:08.219600 containerd[2042]: time="2026-09-04T23:49:08.218080275Z" level=info msg="StartContainer for \"7e5797a2bbaa0d508b87f95229115da9d388f68af3708c36d51b6dacf6b3cd8f\"" Sep 4 23:49:08.260082 systemd[1]: Started cri-containerd-7e5797a2bbaa0d508b87f95229115da9d388f68af3708c36d51b6dacf6b3cd8f.scope - libcontainer container 7e5797a2bbaa0d508b87f95229115da9d388f68af3708c36d51b6dacf6b3cd8f. Sep 4 23:49:08.307389 containerd[2042]: time="2026-09-04T23:49:08.307316427Z" level=info msg="StartContainer for \"7e5797a2bbaa0d508b87f95229115da9d388f68af3708c36d51b6dacf6b3cd8f\" returns successfully" Sep 4 23:49:08.961701 kubelet[2448]: E0904 23:49:08.961635 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:09.416044 (udev-worker)[2956]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:09.434072 systemd-networkd[1954]: flannel.1: Link UP Sep 4 23:49:09.434092 systemd-networkd[1954]: flannel.1: Gained carrier Sep 4 23:49:09.962246 kubelet[2448]: E0904 23:49:09.962180 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:10.661005 systemd-networkd[1954]: flannel.1: Gained IPv6LL Sep 4 23:49:10.962527 kubelet[2448]: E0904 23:49:10.962357 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:11.963261 kubelet[2448]: E0904 23:49:11.963196 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:12.803306 ntpd[2008]: Listen normally on 7 flannel.1 192.168.1.0:123 Sep 4 23:49:12.803444 ntpd[2008]: Listen normally on 8 flannel.1 [fe80::9470:4aff:fe8b:33dc%3]:123 Sep 4 23:49:12.803994 ntpd[2008]: 4 Sep 23:49:12 ntpd[2008]: Listen normally on 7 flannel.1 192.168.1.0:123 Sep 4 23:49:12.803994 ntpd[2008]: 4 Sep 23:49:12 ntpd[2008]: Listen normally on 8 flannel.1 [fe80::9470:4aff:fe8b:33dc%3]:123 Sep 4 23:49:12.963538 kubelet[2448]: E0904 23:49:12.963474 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:13.735443 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 4 23:49:13.964614 kubelet[2448]: E0904 23:49:13.964547 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:14.965112 kubelet[2448]: E0904 23:49:14.965046 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:15.965919 kubelet[2448]: E0904 23:49:15.965855 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:16.170804 kubelet[2448]: I0904 23:49:16.170174 2448 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-5h9pt" podStartSLOduration=10.929496522 podStartE2EDuration="18.170157166s" podCreationTimestamp="2026-09-04 23:48:58 +0000 UTC" firstStartedPulling="2026-09-04 23:49:00.932277431 +0000 UTC m=+3.684791240" lastFinishedPulling="2026-09-04 23:49:08.172938075 +0000 UTC m=+10.925451884" observedRunningTime="2026-09-04 23:49:09.19657336 +0000 UTC m=+11.949087193" watchObservedRunningTime="2026-09-04 23:49:16.170157166 +0000 UTC m=+18.922670975" Sep 4 23:49:16.187043 systemd[1]: Created slice kubepods-besteffort-pod9029d165_fee7_4d66_afdf_74e8cb178a1a.slice - libcontainer container kubepods-besteffort-pod9029d165_fee7_4d66_afdf_74e8cb178a1a.slice. Sep 4 23:49:16.207874 kubelet[2448]: I0904 23:49:16.207786 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-nssw8\" (UniqueName: \"kubernetes.io/projected/9029d165-fee7-4d66-afdf-74e8cb178a1a-kube-api-access-nssw8\") pod \"nginx-deployment-6cc69d4fc7-644qz\" (UID: \"9029d165-fee7-4d66-afdf-74e8cb178a1a\") " pod="default/nginx-deployment-6cc69d4fc7-644qz" Sep 4 23:49:16.495713 containerd[2042]: time="2026-09-04T23:49:16.495640500Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-644qz,Uid:9029d165-fee7-4d66-afdf-74e8cb178a1a,Namespace:default,Attempt:0,}" Sep 4 23:49:16.550261 systemd-networkd[1954]: cni0: Link UP Sep 4 23:49:16.550277 systemd-networkd[1954]: cni0: Gained carrier Sep 4 23:49:16.558558 (udev-worker)[3050]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:16.558792 systemd-networkd[1954]: cni0: Lost carrier Sep 4 23:49:16.567704 systemd-networkd[1954]: veth0f85907c: Link UP Sep 4 23:49:16.571189 kernel: cni0: port 1(veth0f85907c) entered blocking state Sep 4 23:49:16.571330 kernel: cni0: port 1(veth0f85907c) entered disabled state Sep 4 23:49:16.571374 kernel: veth0f85907c: entered allmulticast mode Sep 4 23:49:16.573671 kernel: veth0f85907c: entered promiscuous mode Sep 4 23:49:16.576334 kernel: cni0: port 1(veth0f85907c) entered blocking state Sep 4 23:49:16.576613 kernel: cni0: port 1(veth0f85907c) entered forwarding state Sep 4 23:49:16.584322 kernel: cni0: port 1(veth0f85907c) entered disabled state Sep 4 23:49:16.584933 (udev-worker)[3053]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:16.594948 kernel: cni0: port 1(veth0f85907c) entered blocking state Sep 4 23:49:16.595091 kernel: cni0: port 1(veth0f85907c) entered forwarding state Sep 4 23:49:16.595318 systemd-networkd[1954]: veth0f85907c: Gained carrier Sep 4 23:49:16.596452 systemd-networkd[1954]: cni0: Gained carrier Sep 4 23:49:16.603918 containerd[2042]: 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"} Sep 4 23:49:16.603918 containerd[2042]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:16.646576 containerd[2042]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-09-04T23:49:16.645737809Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:16.646576 containerd[2042]: time="2026-09-04T23:49:16.646493077Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:16.646576 containerd[2042]: time="2026-09-04T23:49:16.646522849Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:16.648723 containerd[2042]: time="2026-09-04T23:49:16.646738129Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:16.683209 systemd[1]: Started cri-containerd-1aee3f875f812b688e893903a26940bdb50b9da243af5fceb6a13598aa8279bb.scope - libcontainer container 1aee3f875f812b688e893903a26940bdb50b9da243af5fceb6a13598aa8279bb. Sep 4 23:49:16.744069 containerd[2042]: time="2026-09-04T23:49:16.743999797Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-644qz,Uid:9029d165-fee7-4d66-afdf-74e8cb178a1a,Namespace:default,Attempt:0,} returns sandbox id \"1aee3f875f812b688e893903a26940bdb50b9da243af5fceb6a13598aa8279bb\"" Sep 4 23:49:16.746484 containerd[2042]: time="2026-09-04T23:49:16.746325253Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 4 23:49:16.966908 kubelet[2448]: E0904 23:49:16.966829 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:17.765374 systemd-networkd[1954]: veth0f85907c: Gained IPv6LL Sep 4 23:49:17.954413 kubelet[2448]: E0904 23:49:17.954354 2448 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:17.967588 kubelet[2448]: E0904 23:49:17.967531 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:18.341396 systemd-networkd[1954]: cni0: Gained IPv6LL Sep 4 23:49:18.968700 kubelet[2448]: E0904 23:49:18.968587 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:19.829320 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount264197370.mount: Deactivated successfully. Sep 4 23:49:19.969674 kubelet[2448]: E0904 23:49:19.969606 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:20.803327 ntpd[2008]: Listen normally on 9 cni0 192.168.1.1:123 Sep 4 23:49:20.803931 ntpd[2008]: 4 Sep 23:49:20 ntpd[2008]: Listen normally on 9 cni0 192.168.1.1:123 Sep 4 23:49:20.803931 ntpd[2008]: 4 Sep 23:49:20 ntpd[2008]: Listen normally on 10 cni0 [fe80::507e:a7ff:fe62:92e9%4]:123 Sep 4 23:49:20.803931 ntpd[2008]: 4 Sep 23:49:20 ntpd[2008]: Listen normally on 11 veth0f85907c [fe80::1891:72ff:fe36:b965%5]:123 Sep 4 23:49:20.803471 ntpd[2008]: Listen normally on 10 cni0 [fe80::507e:a7ff:fe62:92e9%4]:123 Sep 4 23:49:20.803555 ntpd[2008]: Listen normally on 11 veth0f85907c [fe80::1891:72ff:fe36:b965%5]:123 Sep 4 23:49:20.970805 kubelet[2448]: E0904 23:49:20.970632 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:21.131901 containerd[2042]: time="2026-09-04T23:49:21.131574819Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.134486 containerd[2042]: time="2026-09-04T23:49:21.134076027Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=62663441" Sep 4 23:49:21.136856 containerd[2042]: time="2026-09-04T23:49:21.136734651Z" level=info msg="ImageCreate event name:\"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.148815 containerd[2042]: time="2026-09-04T23:49:21.148682199Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:21.151213 containerd[2042]: time="2026-09-04T23:49:21.150884823Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"62663319\" in 4.403837746s" Sep 4 23:49:21.151213 containerd[2042]: time="2026-09-04T23:49:21.150939675Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\"" Sep 4 23:49:21.159359 containerd[2042]: time="2026-09-04T23:49:21.159289623Z" level=info msg="CreateContainer within sandbox \"1aee3f875f812b688e893903a26940bdb50b9da243af5fceb6a13598aa8279bb\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Sep 4 23:49:21.188540 containerd[2042]: time="2026-09-04T23:49:21.188362743Z" level=info msg="CreateContainer within sandbox \"1aee3f875f812b688e893903a26940bdb50b9da243af5fceb6a13598aa8279bb\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"a9b574266296a826a2fc1a123b3d2cf1c47243a98ddb538fd888d84f93e7ace1\"" Sep 4 23:49:21.189414 containerd[2042]: time="2026-09-04T23:49:21.189358347Z" level=info msg="StartContainer for \"a9b574266296a826a2fc1a123b3d2cf1c47243a98ddb538fd888d84f93e7ace1\"" Sep 4 23:49:21.245072 systemd[1]: Started cri-containerd-a9b574266296a826a2fc1a123b3d2cf1c47243a98ddb538fd888d84f93e7ace1.scope - libcontainer container a9b574266296a826a2fc1a123b3d2cf1c47243a98ddb538fd888d84f93e7ace1. Sep 4 23:49:21.294299 containerd[2042]: time="2026-09-04T23:49:21.293903584Z" level=info msg="StartContainer for \"a9b574266296a826a2fc1a123b3d2cf1c47243a98ddb538fd888d84f93e7ace1\" returns successfully" Sep 4 23:49:21.971190 kubelet[2448]: E0904 23:49:21.971116 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:22.251015 kubelet[2448]: I0904 23:49:22.250811 2448 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nginx-deployment-6cc69d4fc7-644qz" podStartSLOduration=1.843375759 podStartE2EDuration="6.250794965s" podCreationTimestamp="2026-09-04 23:49:16 +0000 UTC" firstStartedPulling="2026-09-04 23:49:16.745548985 +0000 UTC m=+19.498062794" lastFinishedPulling="2026-09-04 23:49:21.152968191 +0000 UTC m=+23.905482000" observedRunningTime="2026-09-04 23:49:22.250737197 +0000 UTC m=+25.003251018" watchObservedRunningTime="2026-09-04 23:49:22.250794965 +0000 UTC m=+25.003308810" Sep 4 23:49:22.971323 kubelet[2448]: E0904 23:49:22.971244 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:23.971869 kubelet[2448]: E0904 23:49:23.971802 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:24.972539 kubelet[2448]: E0904 23:49:24.972465 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:25.973148 kubelet[2448]: E0904 23:49:25.973087 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:26.973249 kubelet[2448]: E0904 23:49:26.973191 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:27.973391 kubelet[2448]: E0904 23:49:27.973335 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:28.717461 update_engine[2015]: I20260904 23:49:28.717357 2015 update_attempter.cc:509] Updating boot flags... Sep 4 23:49:28.792836 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (3251) Sep 4 23:49:28.973917 kubelet[2448]: E0904 23:49:28.973515 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:29.051848 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 32 scanned by (udev-worker) (3254) Sep 4 23:49:29.772464 systemd[1]: Created slice kubepods-besteffort-pod9981550d_e163_4658_9cf7_f385b73e8357.slice - libcontainer container kubepods-besteffort-pod9981550d_e163_4658_9cf7_f385b73e8357.slice. Sep 4 23:49:29.795110 kubelet[2448]: I0904 23:49:29.794912 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/9981550d-e163-4658-9cf7-f385b73e8357-data\") pod \"nfs-server-provisioner-0\" (UID: \"9981550d-e163-4658-9cf7-f385b73e8357\") " pod="default/nfs-server-provisioner-0" Sep 4 23:49:29.795110 kubelet[2448]: I0904 23:49:29.794979 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5n2br\" (UniqueName: \"kubernetes.io/projected/9981550d-e163-4658-9cf7-f385b73e8357-kube-api-access-5n2br\") pod \"nfs-server-provisioner-0\" (UID: \"9981550d-e163-4658-9cf7-f385b73e8357\") " pod="default/nfs-server-provisioner-0" Sep 4 23:49:29.975504 kubelet[2448]: E0904 23:49:29.975441 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:30.082838 containerd[2042]: time="2026-09-04T23:49:30.082318752Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:9981550d-e163-4658-9cf7-f385b73e8357,Namespace:default,Attempt:0,}" Sep 4 23:49:30.131497 (udev-worker)[3253]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:30.132989 systemd-networkd[1954]: veth309253c2: Link UP Sep 4 23:49:30.136190 kernel: cni0: port 2(veth309253c2) entered blocking state Sep 4 23:49:30.136267 kernel: cni0: port 2(veth309253c2) entered disabled state Sep 4 23:49:30.139968 kernel: veth309253c2: entered allmulticast mode Sep 4 23:49:30.140089 kernel: veth309253c2: entered promiscuous mode Sep 4 23:49:30.151604 kernel: cni0: port 2(veth309253c2) entered blocking state Sep 4 23:49:30.151732 kernel: cni0: port 2(veth309253c2) entered forwarding state Sep 4 23:49:30.151724 systemd-networkd[1954]: veth309253c2: Gained carrier Sep 4 23:49:30.157542 containerd[2042]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Sep 4 23:49:30.157542 containerd[2042]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:30.197562 containerd[2042]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-09-04T23:49:30.197301456Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:30.198791 containerd[2042]: time="2026-09-04T23:49:30.198680928Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:30.198893 containerd[2042]: time="2026-09-04T23:49:30.198827412Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:30.199417 containerd[2042]: time="2026-09-04T23:49:30.199150956Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:30.236066 systemd[1]: Started cri-containerd-da4477750c42e5949cead7c4d2dc5f51635c2961ef6d89e11b6a0722069876ef.scope - libcontainer container da4477750c42e5949cead7c4d2dc5f51635c2961ef6d89e11b6a0722069876ef. Sep 4 23:49:30.301117 containerd[2042]: time="2026-09-04T23:49:30.301057165Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:9981550d-e163-4658-9cf7-f385b73e8357,Namespace:default,Attempt:0,} returns sandbox id \"da4477750c42e5949cead7c4d2dc5f51635c2961ef6d89e11b6a0722069876ef\"" Sep 4 23:49:30.304587 containerd[2042]: time="2026-09-04T23:49:30.304488169Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Sep 4 23:49:30.976552 kubelet[2448]: E0904 23:49:30.976484 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:31.654317 systemd-networkd[1954]: veth309253c2: Gained IPv6LL Sep 4 23:49:31.977293 kubelet[2448]: E0904 23:49:31.977146 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:32.978799 kubelet[2448]: E0904 23:49:32.978646 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:33.212752 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount973341113.mount: Deactivated successfully. Sep 4 23:49:33.803393 ntpd[2008]: Listen normally on 12 veth309253c2 [fe80::4016:67ff:fe19:7d%6]:123 Sep 4 23:49:33.804951 ntpd[2008]: 4 Sep 23:49:33 ntpd[2008]: Listen normally on 12 veth309253c2 [fe80::4016:67ff:fe19:7d%6]:123 Sep 4 23:49:33.979170 kubelet[2448]: E0904 23:49:33.979110 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:34.979881 kubelet[2448]: E0904 23:49:34.979538 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:35.980743 kubelet[2448]: E0904 23:49:35.980682 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:36.199819 containerd[2042]: time="2026-09-04T23:49:36.198507678Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:36.200808 containerd[2042]: time="2026-09-04T23:49:36.200665770Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87374067" Sep 4 23:49:36.203614 containerd[2042]: time="2026-09-04T23:49:36.203520078Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:36.210880 containerd[2042]: time="2026-09-04T23:49:36.210476286Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:36.212474 containerd[2042]: time="2026-09-04T23:49:36.211838994Z" 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.907255989s" Sep 4 23:49:36.212474 containerd[2042]: time="2026-09-04T23:49:36.211897386Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Sep 4 23:49:36.220889 containerd[2042]: time="2026-09-04T23:49:36.220824102Z" level=info msg="CreateContainer within sandbox \"da4477750c42e5949cead7c4d2dc5f51635c2961ef6d89e11b6a0722069876ef\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Sep 4 23:49:36.254533 containerd[2042]: time="2026-09-04T23:49:36.254288058Z" level=info msg="CreateContainer within sandbox \"da4477750c42e5949cead7c4d2dc5f51635c2961ef6d89e11b6a0722069876ef\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"88576f80b3f0a92a2db0179162c5eef1b76cff2a04df5de9d1c5e7cfe1aad82f\"" Sep 4 23:49:36.256079 containerd[2042]: time="2026-09-04T23:49:36.256020174Z" level=info msg="StartContainer for \"88576f80b3f0a92a2db0179162c5eef1b76cff2a04df5de9d1c5e7cfe1aad82f\"" Sep 4 23:49:36.314077 systemd[1]: Started cri-containerd-88576f80b3f0a92a2db0179162c5eef1b76cff2a04df5de9d1c5e7cfe1aad82f.scope - libcontainer container 88576f80b3f0a92a2db0179162c5eef1b76cff2a04df5de9d1c5e7cfe1aad82f. Sep 4 23:49:36.365300 containerd[2042]: time="2026-09-04T23:49:36.365137411Z" level=info msg="StartContainer for \"88576f80b3f0a92a2db0179162c5eef1b76cff2a04df5de9d1c5e7cfe1aad82f\" returns successfully" Sep 4 23:49:36.980917 kubelet[2448]: E0904 23:49:36.980838 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:37.317267 kubelet[2448]: I0904 23:49:37.317174 2448 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.406943223 podStartE2EDuration="8.317158868s" podCreationTimestamp="2026-09-04 23:49:29 +0000 UTC" firstStartedPulling="2026-09-04 23:49:30.303697825 +0000 UTC m=+33.056211634" lastFinishedPulling="2026-09-04 23:49:36.213913458 +0000 UTC m=+38.966427279" observedRunningTime="2026-09-04 23:49:37.316824296 +0000 UTC m=+40.069338129" watchObservedRunningTime="2026-09-04 23:49:37.317158868 +0000 UTC m=+40.069672761" Sep 4 23:49:37.954108 kubelet[2448]: E0904 23:49:37.954050 2448 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:37.981565 kubelet[2448]: E0904 23:49:37.981513 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:38.982143 kubelet[2448]: E0904 23:49:38.982078 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:39.982925 kubelet[2448]: E0904 23:49:39.982847 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:40.983050 kubelet[2448]: E0904 23:49:40.982984 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:41.770752 systemd[1]: Created slice kubepods-besteffort-podc2fe19a8_607b_4bbe_a691_c8aa903859d4.slice - libcontainer container kubepods-besteffort-podc2fe19a8_607b_4bbe_a691_c8aa903859d4.slice. Sep 4 23:49:41.877779 kubelet[2448]: I0904 23:49:41.877708 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-69a6ad37-29a7-4fa1-b963-1839de8c9497\" (UniqueName: \"kubernetes.io/nfs/c2fe19a8-607b-4bbe-a691-c8aa903859d4-pvc-69a6ad37-29a7-4fa1-b963-1839de8c9497\") pod \"test-pod-1\" (UID: \"c2fe19a8-607b-4bbe-a691-c8aa903859d4\") " pod="default/test-pod-1" Sep 4 23:49:41.877946 kubelet[2448]: I0904 23:49:41.877793 2448 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-ddfsp\" (UniqueName: \"kubernetes.io/projected/c2fe19a8-607b-4bbe-a691-c8aa903859d4-kube-api-access-ddfsp\") pod \"test-pod-1\" (UID: \"c2fe19a8-607b-4bbe-a691-c8aa903859d4\") " pod="default/test-pod-1" Sep 4 23:49:41.983267 kubelet[2448]: E0904 23:49:41.983225 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:42.016824 kernel: FS-Cache: Loaded Sep 4 23:49:42.060382 kernel: RPC: Registered named UNIX socket transport module. Sep 4 23:49:42.060593 kernel: RPC: Registered udp transport module. Sep 4 23:49:42.060634 kernel: RPC: Registered tcp transport module. Sep 4 23:49:42.061412 kernel: RPC: Registered tcp-with-tls transport module. Sep 4 23:49:42.062499 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Sep 4 23:49:42.395478 kernel: NFS: Registering the id_resolver key type Sep 4 23:49:42.395623 kernel: Key type id_resolver registered Sep 4 23:49:42.395664 kernel: Key type id_legacy registered Sep 4 23:49:42.436563 nfsidmap[3681]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Sep 4 23:49:42.442688 nfsidmap[3682]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Sep 4 23:49:42.681603 containerd[2042]: time="2026-09-04T23:49:42.681529574Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:c2fe19a8-607b-4bbe-a691-c8aa903859d4,Namespace:default,Attempt:0,}" Sep 4 23:49:42.732583 kernel: cni0: port 3(veth3141c9c8) entered blocking state Sep 4 23:49:42.732711 kernel: cni0: port 3(veth3141c9c8) entered disabled state Sep 4 23:49:42.732758 kernel: veth3141c9c8: entered allmulticast mode Sep 4 23:49:42.732815 kernel: veth3141c9c8: entered promiscuous mode Sep 4 23:49:42.730575 systemd-networkd[1954]: veth3141c9c8: Link UP Sep 4 23:49:42.735510 (udev-worker)[3668]: Network interface NamePolicy= disabled on kernel command line. Sep 4 23:49:42.744129 kernel: cni0: port 3(veth3141c9c8) entered blocking state Sep 4 23:49:42.744231 kernel: cni0: port 3(veth3141c9c8) entered forwarding state Sep 4 23:49:42.743460 systemd-networkd[1954]: veth3141c9c8: Gained carrier Sep 4 23:49:42.747928 containerd[2042]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400000e9a0), "name":"cbr0", "type":"bridge"} Sep 4 23:49:42.747928 containerd[2042]: delegateAdd: netconf sent to delegate plugin: Sep 4 23:49:42.793244 containerd[2042]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":8951,"name":"cbr0","type":"bridge"}time="2026-09-04T23:49:42.792844227Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 23:49:42.793244 containerd[2042]: time="2026-09-04T23:49:42.793042071Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 23:49:42.793244 containerd[2042]: time="2026-09-04T23:49:42.793128063Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:42.793890 containerd[2042]: time="2026-09-04T23:49:42.793707783Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 23:49:42.828103 systemd[1]: Started cri-containerd-d675c018b666aa501640bc5503e4b3f0ae2630d4b8fca538b4d5e346a202e225.scope - libcontainer container d675c018b666aa501640bc5503e4b3f0ae2630d4b8fca538b4d5e346a202e225. Sep 4 23:49:42.894712 containerd[2042]: time="2026-09-04T23:49:42.894545967Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:c2fe19a8-607b-4bbe-a691-c8aa903859d4,Namespace:default,Attempt:0,} returns sandbox id \"d675c018b666aa501640bc5503e4b3f0ae2630d4b8fca538b4d5e346a202e225\"" Sep 4 23:49:42.897453 containerd[2042]: time="2026-09-04T23:49:42.897372483Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Sep 4 23:49:42.984974 kubelet[2448]: E0904 23:49:42.984830 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:43.233213 containerd[2042]: time="2026-09-04T23:49:43.233137981Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Sep 4 23:49:43.235902 containerd[2042]: time="2026-09-04T23:49:43.235144501Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Sep 4 23:49:43.241169 containerd[2042]: time="2026-09-04T23:49:43.240976717Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:922a5603984560970f4e265613fdc25077f4826efbaf4a082670f2a86a3849f0\", size \"62663319\" in 343.417142ms" Sep 4 23:49:43.241169 containerd[2042]: time="2026-09-04T23:49:43.241039849Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:36cde7007f72dc8406cf539ba3e16afd0f47ab04b2ed0f098a14637f716f2441\"" Sep 4 23:49:43.249276 containerd[2042]: time="2026-09-04T23:49:43.249034273Z" level=info msg="CreateContainer within sandbox \"d675c018b666aa501640bc5503e4b3f0ae2630d4b8fca538b4d5e346a202e225\" for container &ContainerMetadata{Name:test,Attempt:0,}" Sep 4 23:49:43.280299 containerd[2042]: time="2026-09-04T23:49:43.280242889Z" level=info msg="CreateContainer within sandbox \"d675c018b666aa501640bc5503e4b3f0ae2630d4b8fca538b4d5e346a202e225\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"69f18b2ac57fe375a76a261c90092e05fc428862c4f34b3a75cc3a5fecdcc4eb\"" Sep 4 23:49:43.282840 containerd[2042]: time="2026-09-04T23:49:43.281498209Z" level=info msg="StartContainer for \"69f18b2ac57fe375a76a261c90092e05fc428862c4f34b3a75cc3a5fecdcc4eb\"" Sep 4 23:49:43.336086 systemd[1]: Started cri-containerd-69f18b2ac57fe375a76a261c90092e05fc428862c4f34b3a75cc3a5fecdcc4eb.scope - libcontainer container 69f18b2ac57fe375a76a261c90092e05fc428862c4f34b3a75cc3a5fecdcc4eb. Sep 4 23:49:43.383037 containerd[2042]: time="2026-09-04T23:49:43.382966106Z" level=info msg="StartContainer for \"69f18b2ac57fe375a76a261c90092e05fc428862c4f34b3a75cc3a5fecdcc4eb\" returns successfully" Sep 4 23:49:43.985519 kubelet[2448]: E0904 23:49:43.985451 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:44.133208 systemd-networkd[1954]: veth3141c9c8: Gained IPv6LL Sep 4 23:49:44.986298 kubelet[2448]: E0904 23:49:44.986231 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:45.987542 kubelet[2448]: E0904 23:49:45.987464 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:46.988489 kubelet[2448]: E0904 23:49:46.988433 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:47.803551 ntpd[2008]: Listen normally on 13 veth3141c9c8 [fe80::c067:afff:fe9a:5f5f%7]:123 Sep 4 23:49:47.804747 ntpd[2008]: 4 Sep 23:49:47 ntpd[2008]: Listen normally on 13 veth3141c9c8 [fe80::c067:afff:fe9a:5f5f%7]:123 Sep 4 23:49:47.989432 kubelet[2448]: E0904 23:49:47.989367 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:48.990216 kubelet[2448]: E0904 23:49:48.990151 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:49.990731 kubelet[2448]: E0904 23:49:49.990675 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:50.991664 kubelet[2448]: E0904 23:49:50.991596 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:51.992642 kubelet[2448]: E0904 23:49:51.992576 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:52.993385 kubelet[2448]: E0904 23:49:52.993322 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:53.994722 kubelet[2448]: E0904 23:49:53.994640 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:54.994933 kubelet[2448]: E0904 23:49:54.994862 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:55.995346 kubelet[2448]: E0904 23:49:55.995266 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:56.995881 kubelet[2448]: E0904 23:49:56.995816 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:57.954396 kubelet[2448]: E0904 23:49:57.954308 2448 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:57.996665 kubelet[2448]: E0904 23:49:57.996594 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:58.996810 kubelet[2448]: E0904 23:49:58.996735 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:49:59.997309 kubelet[2448]: E0904 23:49:59.997234 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:00.998316 kubelet[2448]: E0904 23:50:00.998229 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:01.999027 kubelet[2448]: E0904 23:50:01.998961 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:02.999788 kubelet[2448]: E0904 23:50:02.999714 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:03.999976 kubelet[2448]: E0904 23:50:03.999897 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:05.000834 kubelet[2448]: E0904 23:50:05.000742 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:06.001895 kubelet[2448]: E0904 23:50:06.001825 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:07.002646 kubelet[2448]: E0904 23:50:07.002595 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:08.003876 kubelet[2448]: E0904 23:50:08.003808 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:09.004628 kubelet[2448]: E0904 23:50:09.004561 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:10.005788 kubelet[2448]: E0904 23:50:10.005629 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:11.006170 kubelet[2448]: E0904 23:50:11.006102 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:12.006591 kubelet[2448]: E0904 23:50:12.006529 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:13.007361 kubelet[2448]: E0904 23:50:13.007297 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:14.007511 kubelet[2448]: E0904 23:50:14.007442 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Sep 4 23:50:15.008102 kubelet[2448]: E0904 23:50:15.008035 2448 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"