Jun 12 17:48:20.942652 kernel: Linux version 6.6.142-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-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_DYNAMIC Fri Jun 12 16:13:17 -00 2026 Jun 12 17:48:20.942688 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=53295dd371a2fa12674d3928414fb25cd38d8ba1867a63a0f4c9702feb60b9a1 Jun 12 17:48:20.942706 kernel: BIOS-provided physical RAM map: Jun 12 17:48:20.942717 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Jun 12 17:48:20.942727 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000786cdfff] usable Jun 12 17:48:20.942737 kernel: BIOS-e820: [mem 0x00000000786ce000-0x00000000787cdfff] type 20 Jun 12 17:48:20.942750 kernel: BIOS-e820: [mem 0x00000000787ce000-0x000000007894dfff] reserved Jun 12 17:48:20.942762 kernel: BIOS-e820: [mem 0x000000007894e000-0x000000007895dfff] ACPI data Jun 12 17:48:20.942773 kernel: BIOS-e820: [mem 0x000000007895e000-0x00000000789ddfff] ACPI NVS Jun 12 17:48:20.942786 kernel: BIOS-e820: [mem 0x00000000789de000-0x000000007c97bfff] usable Jun 12 17:48:20.942798 kernel: BIOS-e820: [mem 0x000000007c97c000-0x000000007c9fffff] reserved Jun 12 17:48:20.942809 kernel: NX (Execute Disable) protection: active Jun 12 17:48:20.942820 kernel: APIC: Static calls initialized Jun 12 17:48:20.942831 kernel: efi: EFI v2.7 by EDK II Jun 12 17:48:20.942845 kernel: efi: SMBIOS=0x7886a000 ACPI=0x7895d000 ACPI 2.0=0x7895d014 MEMATTR=0x7701a018 Jun 12 17:48:20.942861 kernel: SMBIOS 2.7 present. Jun 12 17:48:20.942873 kernel: DMI: Amazon EC2 t3.small/, BIOS 1.0 10/16/2017 Jun 12 17:48:20.942885 kernel: Hypervisor detected: KVM Jun 12 17:48:20.942897 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jun 12 17:48:20.942909 kernel: kvm-clock: using sched offset of 3732988633 cycles Jun 12 17:48:20.942921 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jun 12 17:48:20.942934 kernel: tsc: Detected 2499.998 MHz processor Jun 12 17:48:20.942947 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jun 12 17:48:20.942960 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jun 12 17:48:20.942973 kernel: last_pfn = 0x7c97c max_arch_pfn = 0x400000000 Jun 12 17:48:20.942988 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Jun 12 17:48:20.943000 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jun 12 17:48:20.943013 kernel: Using GB pages for direct mapping Jun 12 17:48:20.943025 kernel: Secure boot disabled Jun 12 17:48:20.943038 kernel: ACPI: Early table checksum verification disabled Jun 12 17:48:20.943050 kernel: ACPI: RSDP 0x000000007895D014 000024 (v02 AMAZON) Jun 12 17:48:20.943063 kernel: ACPI: XSDT 0x000000007895C0E8 00006C (v01 AMAZON AMZNFACP 00000001 01000013) Jun 12 17:48:20.943075 kernel: ACPI: FACP 0x0000000078955000 000114 (v01 AMAZON AMZNFACP 00000001 AMZN 00000001) Jun 12 17:48:20.943101 kernel: ACPI: DSDT 0x0000000078956000 00115A (v01 AMAZON AMZNDSDT 00000001 AMZN 00000001) Jun 12 17:48:20.943118 kernel: ACPI: FACS 0x00000000789D0000 000040 Jun 12 17:48:20.943130 kernel: ACPI: WAET 0x000000007895B000 000028 (v01 AMAZON AMZNWAET 00000001 AMZN 00000001) Jun 12 17:48:20.943142 kernel: ACPI: SLIT 0x000000007895A000 00006C (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Jun 12 17:48:20.943155 kernel: ACPI: APIC 0x0000000078959000 000076 (v01 AMAZON AMZNAPIC 00000001 AMZN 00000001) Jun 12 17:48:20.943168 kernel: ACPI: SRAT 0x0000000078958000 0000A0 (v01 AMAZON AMZNSRAT 00000001 AMZN 00000001) Jun 12 17:48:20.943181 kernel: ACPI: HPET 0x0000000078954000 000038 (v01 AMAZON AMZNHPET 00000001 AMZN 00000001) Jun 12 17:48:20.943199 kernel: ACPI: SSDT 0x0000000078953000 000759 (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Jun 12 17:48:20.943215 kernel: ACPI: SSDT 0x0000000078952000 0000D1 (v01 AMAZON AMZNSSDT 00000001 AMZN 00000001) Jun 12 17:48:20.943228 kernel: ACPI: BGRT 0x0000000078951000 000038 (v01 AMAZON AMAZON 00000002 01000013) Jun 12 17:48:20.943241 kernel: ACPI: Reserving FACP table memory at [mem 0x78955000-0x78955113] Jun 12 17:48:20.943254 kernel: ACPI: Reserving DSDT table memory at [mem 0x78956000-0x78957159] Jun 12 17:48:20.943268 kernel: ACPI: Reserving FACS table memory at [mem 0x789d0000-0x789d003f] Jun 12 17:48:20.943300 kernel: ACPI: Reserving WAET table memory at [mem 0x7895b000-0x7895b027] Jun 12 17:48:20.943316 kernel: ACPI: Reserving SLIT table memory at [mem 0x7895a000-0x7895a06b] Jun 12 17:48:20.943334 kernel: ACPI: Reserving APIC table memory at [mem 0x78959000-0x78959075] Jun 12 17:48:20.943350 kernel: ACPI: Reserving SRAT table memory at [mem 0x78958000-0x7895809f] Jun 12 17:48:20.943365 kernel: ACPI: Reserving HPET table memory at [mem 0x78954000-0x78954037] Jun 12 17:48:20.943380 kernel: ACPI: Reserving SSDT table memory at [mem 0x78953000-0x78953758] Jun 12 17:48:20.943396 kernel: ACPI: Reserving SSDT table memory at [mem 0x78952000-0x789520d0] Jun 12 17:48:20.943411 kernel: ACPI: Reserving BGRT table memory at [mem 0x78951000-0x78951037] Jun 12 17:48:20.943426 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Jun 12 17:48:20.943441 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Jun 12 17:48:20.943456 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x7fffffff] Jun 12 17:48:20.943475 kernel: NUMA: Initialized distance table, cnt=1 Jun 12 17:48:20.943489 kernel: NODE_DATA(0) allocated [mem 0x7a8f0000-0x7a8f5fff] Jun 12 17:48:20.943503 kernel: Zone ranges: Jun 12 17:48:20.943518 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jun 12 17:48:20.943533 kernel: DMA32 [mem 0x0000000001000000-0x000000007c97bfff] Jun 12 17:48:20.943548 kernel: Normal empty Jun 12 17:48:20.943563 kernel: Movable zone start for each node Jun 12 17:48:20.943579 kernel: Early memory node ranges Jun 12 17:48:20.943594 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Jun 12 17:48:20.943612 kernel: node 0: [mem 0x0000000000100000-0x00000000786cdfff] Jun 12 17:48:20.943627 kernel: node 0: [mem 0x00000000789de000-0x000000007c97bfff] Jun 12 17:48:20.943642 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007c97bfff] Jun 12 17:48:20.943657 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jun 12 17:48:20.943672 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Jun 12 17:48:20.943687 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Jun 12 17:48:20.943703 kernel: On node 0, zone DMA32: 13956 pages in unavailable ranges Jun 12 17:48:20.943718 kernel: ACPI: PM-Timer IO Port: 0xb008 Jun 12 17:48:20.943733 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jun 12 17:48:20.943749 kernel: IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23 Jun 12 17:48:20.943765 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jun 12 17:48:20.943781 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jun 12 17:48:20.943796 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jun 12 17:48:20.943811 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jun 12 17:48:20.943826 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jun 12 17:48:20.943841 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Jun 12 17:48:20.943857 kernel: TSC deadline timer available Jun 12 17:48:20.943872 kernel: smpboot: Allowing 2 CPUs, 0 hotplug CPUs Jun 12 17:48:20.943887 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jun 12 17:48:20.943906 kernel: [mem 0x7ca00000-0xffffffff] available for PCI devices Jun 12 17:48:20.943921 kernel: Booting paravirtualized kernel on KVM Jun 12 17:48:20.943937 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jun 12 17:48:20.943952 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 Jun 12 17:48:20.943968 kernel: percpu: Embedded 57 pages/cpu s196392 r8192 d28888 u1048576 Jun 12 17:48:20.943983 kernel: pcpu-alloc: s196392 r8192 d28888 u1048576 alloc=1*2097152 Jun 12 17:48:20.943998 kernel: pcpu-alloc: [0] 0 1 Jun 12 17:48:20.944013 kernel: kvm-guest: PV spinlocks enabled Jun 12 17:48:20.944028 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jun 12 17:48:20.944048 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=53295dd371a2fa12674d3928414fb25cd38d8ba1867a63a0f4c9702feb60b9a1 Jun 12 17:48:20.944064 kernel: random: crng init done Jun 12 17:48:20.944079 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jun 12 17:48:20.944112 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jun 12 17:48:20.944125 kernel: Fallback order for Node 0: 0 Jun 12 17:48:20.944138 kernel: Built 1 zonelists, mobility grouping on. Total pages: 501318 Jun 12 17:48:20.944152 kernel: Policy zone: DMA32 Jun 12 17:48:20.944167 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jun 12 17:48:20.944187 kernel: Memory: 1874644K/2037804K available (12288K kernel code, 2288K rwdata, 22760K rodata, 42896K init, 2296K bss, 162900K reserved, 0K cma-reserved) Jun 12 17:48:20.944203 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jun 12 17:48:20.944218 kernel: Kernel/User page tables isolation: enabled Jun 12 17:48:20.944234 kernel: ftrace: allocating 38023 entries in 149 pages Jun 12 17:48:20.944249 kernel: ftrace: allocated 149 pages with 4 groups Jun 12 17:48:20.944264 kernel: Dynamic Preempt: voluntary Jun 12 17:48:20.944279 kernel: rcu: Preemptible hierarchical RCU implementation. Jun 12 17:48:20.944301 kernel: rcu: RCU event tracing is enabled. Jun 12 17:48:20.944317 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jun 12 17:48:20.944335 kernel: Trampoline variant of Tasks RCU enabled. Jun 12 17:48:20.944350 kernel: Rude variant of Tasks RCU enabled. Jun 12 17:48:20.944365 kernel: Tracing variant of Tasks RCU enabled. Jun 12 17:48:20.944380 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jun 12 17:48:20.944396 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jun 12 17:48:20.944412 kernel: NR_IRQS: 33024, nr_irqs: 440, preallocated irqs: 16 Jun 12 17:48:20.944428 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jun 12 17:48:20.944458 kernel: Console: colour dummy device 80x25 Jun 12 17:48:20.944474 kernel: printk: console [tty0] enabled Jun 12 17:48:20.944490 kernel: printk: console [ttyS0] enabled Jun 12 17:48:20.944507 kernel: ACPI: Core revision 20230628 Jun 12 17:48:20.944523 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 30580167144 ns Jun 12 17:48:20.944543 kernel: APIC: Switch to symmetric I/O mode setup Jun 12 17:48:20.944559 kernel: x2apic enabled Jun 12 17:48:20.944576 kernel: APIC: Switched APIC routing to: physical x2apic Jun 12 17:48:20.944592 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Jun 12 17:48:20.944609 kernel: Calibrating delay loop (skipped) preset value.. 4999.99 BogoMIPS (lpj=2499998) Jun 12 17:48:20.944629 kernel: Last level iTLB entries: 4KB 64, 2MB 8, 4MB 8 Jun 12 17:48:20.944645 kernel: Last level dTLB entries: 4KB 64, 2MB 32, 4MB 32, 1GB 4 Jun 12 17:48:20.944662 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jun 12 17:48:20.944677 kernel: Spectre V2 : Mitigation: Retpolines Jun 12 17:48:20.944694 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jun 12 17:48:20.944710 kernel: RETBleed: WARNING: Spectre v2 mitigation leaves CPU vulnerable to RETBleed attacks, data leaks possible! Jun 12 17:48:20.944727 kernel: RETBleed: Vulnerable Jun 12 17:48:20.944743 kernel: Speculative Store Bypass: Vulnerable Jun 12 17:48:20.944759 kernel: MDS: Vulnerable: Clear CPU buffers attempted, no microcode Jun 12 17:48:20.944776 kernel: MMIO Stale Data: Vulnerable: Clear CPU buffers attempted, no microcode Jun 12 17:48:20.944794 kernel: GDS: Unknown: Dependent on hypervisor status Jun 12 17:48:20.944810 kernel: active return thunk: its_return_thunk Jun 12 17:48:20.944827 kernel: ITS: Mitigation: Aligned branch/return thunks Jun 12 17:48:20.944843 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jun 12 17:48:20.944860 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jun 12 17:48:20.944876 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jun 12 17:48:20.944892 kernel: x86/fpu: Supporting XSAVE feature 0x008: 'MPX bounds registers' Jun 12 17:48:20.944908 kernel: x86/fpu: Supporting XSAVE feature 0x010: 'MPX CSR' Jun 12 17:48:20.944924 kernel: x86/fpu: Supporting XSAVE feature 0x020: 'AVX-512 opmask' Jun 12 17:48:20.944941 kernel: x86/fpu: Supporting XSAVE feature 0x040: 'AVX-512 Hi256' Jun 12 17:48:20.944957 kernel: x86/fpu: Supporting XSAVE feature 0x080: 'AVX-512 ZMM_Hi256' Jun 12 17:48:20.944976 kernel: x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' Jun 12 17:48:20.944992 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jun 12 17:48:20.945008 kernel: x86/fpu: xstate_offset[3]: 832, xstate_sizes[3]: 64 Jun 12 17:48:20.945024 kernel: x86/fpu: xstate_offset[4]: 896, xstate_sizes[4]: 64 Jun 12 17:48:20.945041 kernel: x86/fpu: xstate_offset[5]: 960, xstate_sizes[5]: 64 Jun 12 17:48:20.945057 kernel: x86/fpu: xstate_offset[6]: 1024, xstate_sizes[6]: 512 Jun 12 17:48:20.945073 kernel: x86/fpu: xstate_offset[7]: 1536, xstate_sizes[7]: 1024 Jun 12 17:48:20.945128 kernel: x86/fpu: xstate_offset[9]: 2560, xstate_sizes[9]: 8 Jun 12 17:48:20.945145 kernel: x86/fpu: Enabled xstate features 0x2ff, context size is 2568 bytes, using 'compacted' format. Jun 12 17:48:20.945159 kernel: Freeing SMP alternatives memory: 32K Jun 12 17:48:20.945182 kernel: pid_max: default: 32768 minimum: 301 Jun 12 17:48:20.945201 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jun 12 17:48:20.945216 kernel: landlock: Up and running. Jun 12 17:48:20.945230 kernel: SELinux: Initializing. Jun 12 17:48:20.945245 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jun 12 17:48:20.945261 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jun 12 17:48:20.945276 kernel: smpboot: CPU0: Intel(R) Xeon(R) Platinum 8259CL CPU @ 2.50GHz (family: 0x6, model: 0x55, stepping: 0x7) Jun 12 17:48:20.945291 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jun 12 17:48:20.945307 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jun 12 17:48:20.945323 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jun 12 17:48:20.945338 kernel: Performance Events: unsupported p6 CPU model 85 no PMU driver, software events only. Jun 12 17:48:20.945357 kernel: signal: max sigframe size: 3632 Jun 12 17:48:20.945372 kernel: rcu: Hierarchical SRCU implementation. Jun 12 17:48:20.945386 kernel: rcu: Max phase no-delay instances is 400. Jun 12 17:48:20.945401 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jun 12 17:48:20.945415 kernel: smp: Bringing up secondary CPUs ... Jun 12 17:48:20.945430 kernel: smpboot: x86: Booting SMP configuration: Jun 12 17:48:20.945447 kernel: .... node #0, CPUs: #1 Jun 12 17:48:20.945462 kernel: MDS CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/mds.html for more details. Jun 12 17:48:20.945479 kernel: MMIO Stale Data CPU bug present and SMT on, data leak possible. See https://www.kernel.org/doc/html/latest/admin-guide/hw-vuln/processor_mmio_stale_data.html for more details. Jun 12 17:48:20.945498 kernel: smp: Brought up 1 node, 2 CPUs Jun 12 17:48:20.945513 kernel: smpboot: Max logical packages: 1 Jun 12 17:48:20.945527 kernel: smpboot: Total of 2 processors activated (9999.99 BogoMIPS) Jun 12 17:48:20.945543 kernel: devtmpfs: initialized Jun 12 17:48:20.945559 kernel: x86/mm: Memory block size: 128MB Jun 12 17:48:20.945575 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x7895e000-0x789ddfff] (524288 bytes) Jun 12 17:48:20.945591 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jun 12 17:48:20.945609 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jun 12 17:48:20.945621 kernel: pinctrl core: initialized pinctrl subsystem Jun 12 17:48:20.945639 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jun 12 17:48:20.945654 kernel: audit: initializing netlink subsys (disabled) Jun 12 17:48:20.945668 kernel: audit: type=2000 audit(1781286501.704:1): state=initialized audit_enabled=0 res=1 Jun 12 17:48:20.945684 kernel: thermal_sys: Registered thermal governor 'step_wise' Jun 12 17:48:20.945700 kernel: thermal_sys: Registered thermal governor 'user_space' Jun 12 17:48:20.945716 kernel: cpuidle: using governor menu Jun 12 17:48:20.945731 kernel: efi: Freeing EFI boot services memory: 37748K Jun 12 17:48:20.945746 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jun 12 17:48:20.945759 kernel: dca service started, version 1.12.1 Jun 12 17:48:20.945775 kernel: PCI: Using configuration type 1 for base access Jun 12 17:48:20.945789 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jun 12 17:48:20.945802 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jun 12 17:48:20.945817 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jun 12 17:48:20.945833 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jun 12 17:48:20.945849 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jun 12 17:48:20.945864 kernel: ACPI: Added _OSI(Module Device) Jun 12 17:48:20.945880 kernel: ACPI: Added _OSI(Processor Device) Jun 12 17:48:20.945896 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jun 12 17:48:20.945915 kernel: ACPI: 3 ACPI AML tables successfully acquired and loaded Jun 12 17:48:20.945932 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jun 12 17:48:20.945948 kernel: ACPI: Interpreter enabled Jun 12 17:48:20.945964 kernel: ACPI: PM: (supports S0 S5) Jun 12 17:48:20.945980 kernel: ACPI: Using IOAPIC for interrupt routing Jun 12 17:48:20.945996 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jun 12 17:48:20.946012 kernel: PCI: Using E820 reservations for host bridge windows Jun 12 17:48:20.946029 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Jun 12 17:48:20.946044 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jun 12 17:48:20.946278 kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI HPX-Type3] Jun 12 17:48:20.946429 kernel: acpi PNP0A03:00: _OSC: not requesting OS control; OS requires [ExtendedConfig ASPM ClockPM MSI] Jun 12 17:48:20.946567 kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended configuration space under this bridge Jun 12 17:48:20.946588 kernel: acpiphp: Slot [3] registered Jun 12 17:48:20.946605 kernel: acpiphp: Slot [4] registered Jun 12 17:48:20.946621 kernel: acpiphp: Slot [5] registered Jun 12 17:48:20.946638 kernel: acpiphp: Slot [6] registered Jun 12 17:48:20.946658 kernel: acpiphp: Slot [7] registered Jun 12 17:48:20.946674 kernel: acpiphp: Slot [8] registered Jun 12 17:48:20.946690 kernel: acpiphp: Slot [9] registered Jun 12 17:48:20.946707 kernel: acpiphp: Slot [10] registered Jun 12 17:48:20.946723 kernel: acpiphp: Slot [11] registered Jun 12 17:48:20.946739 kernel: acpiphp: Slot [12] registered Jun 12 17:48:20.946756 kernel: acpiphp: Slot [13] registered Jun 12 17:48:20.946772 kernel: acpiphp: Slot [14] registered Jun 12 17:48:20.946788 kernel: acpiphp: Slot [15] registered Jun 12 17:48:20.946804 kernel: acpiphp: Slot [16] registered Jun 12 17:48:20.946823 kernel: acpiphp: Slot [17] registered Jun 12 17:48:20.946839 kernel: acpiphp: Slot [18] registered Jun 12 17:48:20.946855 kernel: acpiphp: Slot [19] registered Jun 12 17:48:20.946871 kernel: acpiphp: Slot [20] registered Jun 12 17:48:20.946887 kernel: acpiphp: Slot [21] registered Jun 12 17:48:20.946904 kernel: acpiphp: Slot [22] registered Jun 12 17:48:20.946920 kernel: acpiphp: Slot [23] registered Jun 12 17:48:20.946936 kernel: acpiphp: Slot [24] registered Jun 12 17:48:20.946952 kernel: acpiphp: Slot [25] registered Jun 12 17:48:20.946971 kernel: acpiphp: Slot [26] registered Jun 12 17:48:20.946988 kernel: acpiphp: Slot [27] registered Jun 12 17:48:20.947004 kernel: acpiphp: Slot [28] registered Jun 12 17:48:20.947021 kernel: acpiphp: Slot [29] registered Jun 12 17:48:20.947036 kernel: acpiphp: Slot [30] registered Jun 12 17:48:20.947053 kernel: acpiphp: Slot [31] registered Jun 12 17:48:20.947069 kernel: PCI host bridge to bus 0000:00 Jun 12 17:48:20.947236 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jun 12 17:48:20.947367 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jun 12 17:48:20.947497 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jun 12 17:48:20.947622 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xfebfffff window] Jun 12 17:48:20.947746 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x2000ffffffff window] Jun 12 17:48:20.947870 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jun 12 17:48:20.948038 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Jun 12 17:48:20.948204 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Jun 12 17:48:20.948364 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x000000 Jun 12 17:48:20.948506 kernel: pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI Jun 12 17:48:20.948649 kernel: pci 0000:00:01.3: PIIX4 devres E PIO at fff0-ffff Jun 12 17:48:20.948789 kernel: pci 0000:00:01.3: PIIX4 devres F MMIO at ffc00000-ffffffff Jun 12 17:48:20.948923 kernel: pci 0000:00:01.3: PIIX4 devres G PIO at fff0-ffff Jun 12 17:48:20.949057 kernel: pci 0000:00:01.3: PIIX4 devres H MMIO at ffc00000-ffffffff Jun 12 17:48:20.951206 kernel: pci 0000:00:01.3: PIIX4 devres I PIO at fff0-ffff Jun 12 17:48:20.951372 kernel: pci 0000:00:01.3: PIIX4 devres J PIO at fff0-ffff Jun 12 17:48:20.951528 kernel: pci 0000:00:03.0: [1d0f:1111] type 00 class 0x030000 Jun 12 17:48:20.951672 kernel: pci 0000:00:03.0: BAR 0 [mem 0x80000000-0x803fffff pref] Jun 12 17:48:20.951816 kernel: pci 0000:00:03.0: ROM [mem 0xffff0000-0xffffffff pref] Jun 12 17:48:20.951956 kernel: pci 0000:00:03.0: BAR 0: assigned to efifb Jun 12 17:48:20.952130 kernel: pci 0000:00:03.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jun 12 17:48:20.952284 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Jun 12 17:48:20.952431 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80404000-0x80407fff] Jun 12 17:48:20.952581 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Jun 12 17:48:20.952725 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80400000-0x80403fff] Jun 12 17:48:20.952746 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jun 12 17:48:20.952762 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jun 12 17:48:20.952780 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jun 12 17:48:20.952796 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jun 12 17:48:20.952816 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Jun 12 17:48:20.952831 kernel: iommu: Default domain type: Translated Jun 12 17:48:20.952848 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jun 12 17:48:20.952864 kernel: efivars: Registered efivars operations Jun 12 17:48:20.952880 kernel: PCI: Using ACPI for IRQ routing Jun 12 17:48:20.952897 kernel: PCI: pci_cache_line_size set to 64 bytes Jun 12 17:48:20.952913 kernel: e820: reserve RAM buffer [mem 0x786ce000-0x7bffffff] Jun 12 17:48:20.952929 kernel: e820: reserve RAM buffer [mem 0x7c97c000-0x7fffffff] Jun 12 17:48:20.953069 kernel: pci 0000:00:03.0: vgaarb: setting as boot VGA device Jun 12 17:48:20.954380 kernel: pci 0000:00:03.0: vgaarb: bridge control possible Jun 12 17:48:20.954535 kernel: pci 0000:00:03.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jun 12 17:48:20.954557 kernel: vgaarb: loaded Jun 12 17:48:20.954575 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0 Jun 12 17:48:20.954593 kernel: hpet0: 8 comparators, 32-bit 62.500000 MHz counter Jun 12 17:48:20.954609 kernel: clocksource: Switched to clocksource kvm-clock Jun 12 17:48:20.954624 kernel: VFS: Disk quotas dquot_6.6.0 Jun 12 17:48:20.954638 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jun 12 17:48:20.954651 kernel: pnp: PnP ACPI init Jun 12 17:48:20.954671 kernel: pnp: PnP ACPI: found 5 devices Jun 12 17:48:20.954685 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jun 12 17:48:20.954699 kernel: NET: Registered PF_INET protocol family Jun 12 17:48:20.954714 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Jun 12 17:48:20.954729 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Jun 12 17:48:20.954745 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jun 12 17:48:20.954759 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Jun 12 17:48:20.956122 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Jun 12 17:48:20.956149 kernel: TCP: Hash tables configured (established 16384 bind 16384) Jun 12 17:48:20.956166 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Jun 12 17:48:20.956184 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Jun 12 17:48:20.956200 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jun 12 17:48:20.956217 kernel: NET: Registered PF_XDP protocol family Jun 12 17:48:20.956379 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jun 12 17:48:20.956508 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jun 12 17:48:20.956633 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jun 12 17:48:20.956759 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xfebfffff window] Jun 12 17:48:20.956887 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x2000ffffffff window] Jun 12 17:48:20.957037 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Jun 12 17:48:20.957060 kernel: PCI: CLS 0 bytes, default 64 Jun 12 17:48:20.957077 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jun 12 17:48:20.957108 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Jun 12 17:48:20.957124 kernel: clocksource: Switched to clocksource tsc Jun 12 17:48:20.957141 kernel: Initialise system trusted keyrings Jun 12 17:48:20.957158 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Jun 12 17:48:20.957189 kernel: Key type asymmetric registered Jun 12 17:48:20.957206 kernel: Asymmetric key parser 'x509' registered Jun 12 17:48:20.957222 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jun 12 17:48:20.957238 kernel: io scheduler mq-deadline registered Jun 12 17:48:20.957254 kernel: io scheduler kyber registered Jun 12 17:48:20.957271 kernel: io scheduler bfq registered Jun 12 17:48:20.957288 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jun 12 17:48:20.957304 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jun 12 17:48:20.957321 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jun 12 17:48:20.957340 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jun 12 17:48:20.957357 kernel: i8042: Warning: Keylock active Jun 12 17:48:20.957373 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jun 12 17:48:20.957390 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jun 12 17:48:20.957542 kernel: rtc_cmos 00:00: RTC can wake from S4 Jun 12 17:48:20.957678 kernel: rtc_cmos 00:00: registered as rtc0 Jun 12 17:48:20.957808 kernel: rtc_cmos 00:00: setting system clock to 2026-06-12T17:48:20 UTC (1781286500) Jun 12 17:48:20.957937 kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Jun 12 17:48:20.957960 kernel: intel_pstate: CPU model not supported Jun 12 17:48:20.957978 kernel: efifb: probing for efifb Jun 12 17:48:20.957995 kernel: efifb: framebuffer at 0x80000000, using 1920k, total 1920k Jun 12 17:48:20.958011 kernel: efifb: mode is 800x600x32, linelength=3200, pages=1 Jun 12 17:48:20.958028 kernel: efifb: scrolling: redraw Jun 12 17:48:20.958045 kernel: efifb: Truecolor: size=8:8:8:8, shift=24:16:8:0 Jun 12 17:48:20.958061 kernel: Console: switching to colour frame buffer device 100x37 Jun 12 17:48:20.958078 kernel: fb0: EFI VGA frame buffer device Jun 12 17:48:20.959249 kernel: pstore: Using crash dump compression: deflate Jun 12 17:48:20.959276 kernel: pstore: Registered efi_pstore as persistent store backend Jun 12 17:48:20.959294 kernel: NET: Registered PF_INET6 protocol family Jun 12 17:48:20.959311 kernel: Segment Routing with IPv6 Jun 12 17:48:20.959328 kernel: In-situ OAM (IOAM) with IPv6 Jun 12 17:48:20.959345 kernel: NET: Registered PF_PACKET protocol family Jun 12 17:48:20.959362 kernel: Key type dns_resolver registered Jun 12 17:48:20.959406 kernel: IPI shorthand broadcast: enabled Jun 12 17:48:20.959427 kernel: sched_clock: Marking stable (482111046, 134308536)->(681317481, -64897899) Jun 12 17:48:20.959445 kernel: registered taskstats version 1 Jun 12 17:48:20.959466 kernel: Loading compiled-in X.509 certificates Jun 12 17:48:20.959483 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.142-flatcar: ee6269f1d342bdb8a8b9f0b315b52e14c94b1fc7' Jun 12 17:48:20.959501 kernel: Key type .fscrypt registered Jun 12 17:48:20.959518 kernel: Key type fscrypt-provisioning registered Jun 12 17:48:20.959535 kernel: ima: No TPM chip found, activating TPM-bypass! Jun 12 17:48:20.959552 kernel: ima: Allocated hash algorithm: sha1 Jun 12 17:48:20.959570 kernel: ima: No architecture policies found Jun 12 17:48:20.959588 kernel: clk: Disabling unused clocks Jun 12 17:48:20.959605 kernel: Freeing unused kernel image (initmem) memory: 42896K Jun 12 17:48:20.959627 kernel: Write protecting the kernel read-only data: 36864k Jun 12 17:48:20.959644 kernel: Freeing unused kernel image (rodata/data gap) memory: 1816K Jun 12 17:48:20.959662 kernel: Run /init as init process Jun 12 17:48:20.959679 kernel: with arguments: Jun 12 17:48:20.959696 kernel: /init Jun 12 17:48:20.959714 kernel: with environment: Jun 12 17:48:20.959731 kernel: HOME=/ Jun 12 17:48:20.959749 kernel: TERM=linux Jun 12 17:48:20.959770 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) Jun 12 17:48:20.959795 systemd[1]: Detected virtualization amazon. Jun 12 17:48:20.959814 systemd[1]: Detected architecture x86-64. Jun 12 17:48:20.959835 systemd[1]: Running in initrd. Jun 12 17:48:20.959853 systemd[1]: No hostname configured, using default hostname. Jun 12 17:48:20.959871 systemd[1]: Hostname set to . Jun 12 17:48:20.959890 systemd[1]: Initializing machine ID from VM UUID. Jun 12 17:48:20.959909 systemd[1]: Queued start job for default target initrd.target. Jun 12 17:48:20.959930 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 12 17:48:20.959948 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 12 17:48:20.959969 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jun 12 17:48:20.959988 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 12 17:48:20.960009 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jun 12 17:48:20.960029 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jun 12 17:48:20.960053 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jun 12 17:48:20.960072 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jun 12 17:48:20.961114 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 12 17:48:20.961139 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 12 17:48:20.961157 systemd[1]: Reached target paths.target - Path Units. Jun 12 17:48:20.961184 systemd[1]: Reached target slices.target - Slice Units. Jun 12 17:48:20.961208 systemd[1]: Reached target swap.target - Swaps. Jun 12 17:48:20.961225 systemd[1]: Reached target timers.target - Timer Units. Jun 12 17:48:20.961243 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jun 12 17:48:20.961260 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 12 17:48:20.961279 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jun 12 17:48:20.961296 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jun 12 17:48:20.961313 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 12 17:48:20.961331 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 12 17:48:20.961349 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 12 17:48:20.961371 systemd[1]: Reached target sockets.target - Socket Units. Jun 12 17:48:20.961391 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jun 12 17:48:20.961410 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 12 17:48:20.961428 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jun 12 17:48:20.961446 systemd[1]: Starting systemd-fsck-usr.service... Jun 12 17:48:20.961464 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 12 17:48:20.961484 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 12 17:48:20.961502 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 12 17:48:20.961520 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jun 12 17:48:20.961581 systemd-journald[179]: Collecting audit messages is disabled. Jun 12 17:48:20.961623 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 12 17:48:20.961643 systemd[1]: Finished systemd-fsck-usr.service. Jun 12 17:48:20.961667 systemd-journald[179]: Journal started Jun 12 17:48:20.961706 systemd-journald[179]: Runtime Journal (/run/log/journal/ec28d8dea666a4c3f62a7567f4a3e83c) is 4.7M, max 38.2M, 33.4M free. Jun 12 17:48:20.938415 systemd-modules-load[180]: Inserted module 'overlay' Jun 12 17:48:20.985116 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jun 12 17:48:20.989624 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jun 12 17:48:20.989694 kernel: Bridge firewalling registered Jun 12 17:48:20.990724 systemd-modules-load[180]: Inserted module 'br_netfilter' Jun 12 17:48:20.994686 systemd[1]: Started systemd-journald.service - Journal Service. Jun 12 17:48:20.995984 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 12 17:48:20.997564 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:20.998228 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jun 12 17:48:21.007435 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 12 17:48:21.013160 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jun 12 17:48:21.012777 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 12 17:48:21.023513 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 12 17:48:21.031246 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 12 17:48:21.042388 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 12 17:48:21.043358 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 12 17:48:21.046663 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 12 17:48:21.053462 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jun 12 17:48:21.055698 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 12 17:48:21.064323 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 12 17:48:21.078605 dracut-cmdline[213]: dracut-dracut-053 Jun 12 17:48:21.083862 dracut-cmdline[213]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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=ttyS0,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=53295dd371a2fa12674d3928414fb25cd38d8ba1867a63a0f4c9702feb60b9a1 Jun 12 17:48:21.116975 systemd-resolved[216]: Positive Trust Anchors: Jun 12 17:48:21.116991 systemd-resolved[216]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 12 17:48:21.117054 systemd-resolved[216]: 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 Jun 12 17:48:21.125749 systemd-resolved[216]: Defaulting to hostname 'linux'. Jun 12 17:48:21.128693 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 12 17:48:21.129275 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 12 17:48:21.174128 kernel: SCSI subsystem initialized Jun 12 17:48:21.185124 kernel: Loading iSCSI transport class v2.0-870. Jun 12 17:48:21.196115 kernel: iscsi: registered transport (tcp) Jun 12 17:48:21.218567 kernel: iscsi: registered transport (qla4xxx) Jun 12 17:48:21.218649 kernel: QLogic iSCSI HBA Driver Jun 12 17:48:21.257632 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jun 12 17:48:21.262316 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jun 12 17:48:21.291809 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jun 12 17:48:21.291890 kernel: device-mapper: uevent: version 1.0.3 Jun 12 17:48:21.291913 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jun 12 17:48:21.335126 kernel: raid6: avx512x4 gen() 18292 MB/s Jun 12 17:48:21.353146 kernel: raid6: avx512x2 gen() 18376 MB/s Jun 12 17:48:21.371152 kernel: raid6: avx512x1 gen() 17878 MB/s Jun 12 17:48:21.389148 kernel: raid6: avx2x4 gen() 18238 MB/s Jun 12 17:48:21.407145 kernel: raid6: avx2x2 gen() 18404 MB/s Jun 12 17:48:21.425376 kernel: raid6: avx2x1 gen() 14176 MB/s Jun 12 17:48:21.425433 kernel: raid6: using algorithm avx2x2 gen() 18404 MB/s Jun 12 17:48:21.444287 kernel: raid6: .... xor() 17740 MB/s, rmw enabled Jun 12 17:48:21.444343 kernel: raid6: using avx512x2 recovery algorithm Jun 12 17:48:21.466133 kernel: xor: automatically using best checksumming function avx Jun 12 17:48:21.631123 kernel: Btrfs loaded, zoned=no, fsverity=no Jun 12 17:48:21.641930 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jun 12 17:48:21.651360 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 12 17:48:21.664948 systemd-udevd[399]: Using default interface naming scheme 'v255'. Jun 12 17:48:21.669997 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 12 17:48:21.677395 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jun 12 17:48:21.696357 dracut-pre-trigger[404]: rd.md=0: removing MD RAID activation Jun 12 17:48:21.726066 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jun 12 17:48:21.730291 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 12 17:48:21.783433 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 12 17:48:21.794309 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jun 12 17:48:21.822394 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jun 12 17:48:21.825986 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jun 12 17:48:21.827018 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 12 17:48:21.827615 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 12 17:48:21.839389 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jun 12 17:48:21.862882 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jun 12 17:48:21.887853 kernel: cryptd: max_cpu_qlen set to 1000 Jun 12 17:48:21.893370 kernel: ena 0000:00:05.0: ENA device version: 0.10 Jun 12 17:48:21.893659 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Jun 12 17:48:21.903150 kernel: ena 0000:00:05.0: LLQ is not supported Fallback to host mode policy. Jun 12 17:48:21.921132 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80400000, mac addr 06:ad:55:97:bc:cd Jun 12 17:48:21.922382 (udev-worker)[453]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:48:21.924447 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 12 17:48:21.924609 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 12 17:48:21.930540 kernel: AVX2 version of gcm_enc/dec engaged. Jun 12 17:48:21.930574 kernel: AES CTR mode by8 optimization enabled Jun 12 17:48:21.929365 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 12 17:48:21.939862 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 12 17:48:21.940166 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:21.941789 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jun 12 17:48:21.950075 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 12 17:48:21.956189 kernel: nvme nvme0: pci function 0000:00:04.0 Jun 12 17:48:21.959591 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 11 Jun 12 17:48:21.962161 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 12 17:48:21.963033 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:21.975137 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jun 12 17:48:21.976325 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 12 17:48:21.984596 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jun 12 17:48:21.984665 kernel: GPT:9289727 != 33554431 Jun 12 17:48:21.984693 kernel: GPT:Alternate GPT header not at the end of the disk. Jun 12 17:48:21.984713 kernel: GPT:9289727 != 33554431 Jun 12 17:48:21.984732 kernel: GPT: Use GNU Parted to correct GPT errors. Jun 12 17:48:21.984752 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jun 12 17:48:22.000400 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:22.006288 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jun 12 17:48:22.024279 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 12 17:48:22.079123 kernel: BTRFS: device fsid 435d962e-da4c-432c-a793-e627de428f9e devid 1 transid 30 /dev/nvme0n1p3 scanned by (udev-worker) (442) Jun 12 17:48:22.084138 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (446) Jun 12 17:48:22.125611 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Jun 12 17:48:22.154850 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Jun 12 17:48:22.175600 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jun 12 17:48:22.181520 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Jun 12 17:48:22.182110 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Jun 12 17:48:22.198436 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jun 12 17:48:22.206559 disk-uuid[629]: Primary Header is updated. Jun 12 17:48:22.206559 disk-uuid[629]: Secondary Entries is updated. Jun 12 17:48:22.206559 disk-uuid[629]: Secondary Header is updated. Jun 12 17:48:22.214116 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jun 12 17:48:22.223125 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jun 12 17:48:22.231140 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jun 12 17:48:23.233116 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jun 12 17:48:23.233916 disk-uuid[630]: The operation has completed successfully. Jun 12 17:48:23.373568 systemd[1]: disk-uuid.service: Deactivated successfully. Jun 12 17:48:23.373696 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jun 12 17:48:23.396288 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jun 12 17:48:23.400817 sh[973]: Success Jun 12 17:48:23.419118 kernel: device-mapper: verity: sha256 using implementation "sha256-avx2" Jun 12 17:48:23.517495 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jun 12 17:48:23.525601 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jun 12 17:48:23.530020 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jun 12 17:48:23.566167 kernel: BTRFS info (device dm-0): first mount of filesystem 435d962e-da4c-432c-a793-e627de428f9e Jun 12 17:48:23.566246 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jun 12 17:48:23.569461 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jun 12 17:48:23.569532 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jun 12 17:48:23.570807 kernel: BTRFS info (device dm-0): using free space tree Jun 12 17:48:23.638130 kernel: BTRFS info (device dm-0): enabling ssd optimizations Jun 12 17:48:23.640693 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jun 12 17:48:23.642109 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jun 12 17:48:23.647302 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jun 12 17:48:23.651277 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jun 12 17:48:23.676698 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f2a13b6e-1665-44cc-8a52-3b9366aea7be Jun 12 17:48:23.676777 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Jun 12 17:48:23.676802 kernel: BTRFS info (device nvme0n1p6): using free space tree Jun 12 17:48:23.691121 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jun 12 17:48:23.703021 systemd[1]: mnt-oem.mount: Deactivated successfully. Jun 12 17:48:23.706195 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem f2a13b6e-1665-44cc-8a52-3b9366aea7be Jun 12 17:48:23.713517 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jun 12 17:48:23.720337 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jun 12 17:48:23.761668 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 12 17:48:23.771789 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 12 17:48:23.793341 systemd-networkd[1165]: lo: Link UP Jun 12 17:48:23.793353 systemd-networkd[1165]: lo: Gained carrier Jun 12 17:48:23.798783 systemd-networkd[1165]: Enumeration completed Jun 12 17:48:23.799267 systemd-networkd[1165]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 12 17:48:23.799272 systemd-networkd[1165]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 12 17:48:23.800511 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 12 17:48:23.801981 systemd[1]: Reached target network.target - Network. Jun 12 17:48:23.803239 systemd-networkd[1165]: eth0: Link UP Jun 12 17:48:23.803243 systemd-networkd[1165]: eth0: Gained carrier Jun 12 17:48:23.803254 systemd-networkd[1165]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 12 17:48:23.813243 systemd-networkd[1165]: eth0: DHCPv4 address 172.31.16.193/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jun 12 17:48:23.998970 ignition[1105]: Ignition 2.19.0 Jun 12 17:48:23.998982 ignition[1105]: Stage: fetch-offline Jun 12 17:48:23.999323 ignition[1105]: no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:23.999338 ignition[1105]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:23.999692 ignition[1105]: Ignition finished successfully Jun 12 17:48:24.002225 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jun 12 17:48:24.007325 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jun 12 17:48:24.024127 ignition[1173]: Ignition 2.19.0 Jun 12 17:48:24.024765 ignition[1173]: Stage: fetch Jun 12 17:48:24.025219 ignition[1173]: no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:24.025235 ignition[1173]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:24.025359 ignition[1173]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.034762 ignition[1173]: PUT result: OK Jun 12 17:48:24.037137 ignition[1173]: parsed url from cmdline: "" Jun 12 17:48:24.037317 ignition[1173]: no config URL provided Jun 12 17:48:24.037329 ignition[1173]: reading system config file "/usr/lib/ignition/user.ign" Jun 12 17:48:24.037359 ignition[1173]: no config at "/usr/lib/ignition/user.ign" Jun 12 17:48:24.037385 ignition[1173]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.038405 ignition[1173]: PUT result: OK Jun 12 17:48:24.038467 ignition[1173]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Jun 12 17:48:24.039187 ignition[1173]: GET result: OK Jun 12 17:48:24.039258 ignition[1173]: parsing config with SHA512: e6144b70bd9dcb6e271ce3767df09345abcb0e8ee96e3692114b011776b262d36756eecdeebb14c60a808e6f853276811ed56760b9eb36c59b3c756b5163c17f Jun 12 17:48:24.043188 unknown[1173]: fetched base config from "system" Jun 12 17:48:24.043203 unknown[1173]: fetched base config from "system" Jun 12 17:48:24.043601 ignition[1173]: fetch: fetch complete Jun 12 17:48:24.043219 unknown[1173]: fetched user config from "aws" Jun 12 17:48:24.043608 ignition[1173]: fetch: fetch passed Jun 12 17:48:24.043661 ignition[1173]: Ignition finished successfully Jun 12 17:48:24.046971 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jun 12 17:48:24.052342 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jun 12 17:48:24.068792 ignition[1179]: Ignition 2.19.0 Jun 12 17:48:24.068806 ignition[1179]: Stage: kargs Jun 12 17:48:24.069456 ignition[1179]: no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:24.069482 ignition[1179]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:24.069594 ignition[1179]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.070459 ignition[1179]: PUT result: OK Jun 12 17:48:24.073088 ignition[1179]: kargs: kargs passed Jun 12 17:48:24.073256 ignition[1179]: Ignition finished successfully Jun 12 17:48:24.074629 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jun 12 17:48:24.080312 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jun 12 17:48:24.096070 ignition[1185]: Ignition 2.19.0 Jun 12 17:48:24.096084 ignition[1185]: Stage: disks Jun 12 17:48:24.096571 ignition[1185]: no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:24.096584 ignition[1185]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:24.096699 ignition[1185]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.097712 ignition[1185]: PUT result: OK Jun 12 17:48:24.100500 ignition[1185]: disks: disks passed Jun 12 17:48:24.100593 ignition[1185]: Ignition finished successfully Jun 12 17:48:24.102570 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jun 12 17:48:24.103236 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jun 12 17:48:24.103613 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jun 12 17:48:24.104183 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 12 17:48:24.104738 systemd[1]: Reached target sysinit.target - System Initialization. Jun 12 17:48:24.105462 systemd[1]: Reached target basic.target - Basic System. Jun 12 17:48:24.116414 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jun 12 17:48:24.147332 systemd-fsck[1193]: ROOT: clean, 14/553520 files, 52654/553472 blocks Jun 12 17:48:24.150912 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jun 12 17:48:24.158255 systemd[1]: Mounting sysroot.mount - /sysroot... Jun 12 17:48:24.264132 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 7d8459ac-8d34-48e9-8919-32af3e13d598 r/w with ordered data mode. Quota mode: none. Jun 12 17:48:24.264597 systemd[1]: Mounted sysroot.mount - /sysroot. Jun 12 17:48:24.265917 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jun 12 17:48:24.278271 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 12 17:48:24.281340 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jun 12 17:48:24.283217 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jun 12 17:48:24.284396 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jun 12 17:48:24.284433 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jun 12 17:48:24.295709 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jun 12 17:48:24.300131 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1212) Jun 12 17:48:24.304458 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jun 12 17:48:24.309106 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f2a13b6e-1665-44cc-8a52-3b9366aea7be Jun 12 17:48:24.309135 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Jun 12 17:48:24.309222 kernel: BTRFS info (device nvme0n1p6): using free space tree Jun 12 17:48:24.319680 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jun 12 17:48:24.320905 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 12 17:48:24.545902 initrd-setup-root[1236]: cut: /sysroot/etc/passwd: No such file or directory Jun 12 17:48:24.559630 initrd-setup-root[1243]: cut: /sysroot/etc/group: No such file or directory Jun 12 17:48:24.565308 initrd-setup-root[1250]: cut: /sysroot/etc/shadow: No such file or directory Jun 12 17:48:24.570124 initrd-setup-root[1257]: cut: /sysroot/etc/gshadow: No such file or directory Jun 12 17:48:24.762133 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jun 12 17:48:24.774265 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jun 12 17:48:24.779374 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jun 12 17:48:24.786863 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jun 12 17:48:24.789118 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem f2a13b6e-1665-44cc-8a52-3b9366aea7be Jun 12 17:48:24.826463 ignition[1324]: INFO : Ignition 2.19.0 Jun 12 17:48:24.826463 ignition[1324]: INFO : Stage: mount Jun 12 17:48:24.828254 ignition[1324]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:24.828254 ignition[1324]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:24.828254 ignition[1324]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.830614 ignition[1324]: INFO : PUT result: OK Jun 12 17:48:24.831712 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jun 12 17:48:24.835171 ignition[1324]: INFO : mount: mount passed Jun 12 17:48:24.836361 ignition[1324]: INFO : Ignition finished successfully Jun 12 17:48:24.837040 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jun 12 17:48:24.848277 systemd[1]: Starting ignition-files.service - Ignition (files)... Jun 12 17:48:24.866391 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jun 12 17:48:24.885301 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1336) Jun 12 17:48:24.888361 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem f2a13b6e-1665-44cc-8a52-3b9366aea7be Jun 12 17:48:24.888429 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-intel) checksum algorithm Jun 12 17:48:24.890988 kernel: BTRFS info (device nvme0n1p6): using free space tree Jun 12 17:48:24.897298 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Jun 12 17:48:24.899648 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jun 12 17:48:24.927866 ignition[1353]: INFO : Ignition 2.19.0 Jun 12 17:48:24.928572 ignition[1353]: INFO : Stage: files Jun 12 17:48:24.929553 ignition[1353]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:24.930087 ignition[1353]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:24.930087 ignition[1353]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:24.937248 ignition[1353]: INFO : PUT result: OK Jun 12 17:48:24.944760 ignition[1353]: DEBUG : files: compiled without relabeling support, skipping Jun 12 17:48:24.946532 ignition[1353]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jun 12 17:48:24.946532 ignition[1353]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jun 12 17:48:24.972632 ignition[1353]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jun 12 17:48:24.973888 ignition[1353]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jun 12 17:48:24.973888 ignition[1353]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jun 12 17:48:24.973802 unknown[1353]: wrote ssh authorized keys file for user: core Jun 12 17:48:24.977593 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Jun 12 17:48:24.978628 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.36.1-x86-64.raw: attempt #1 Jun 12 17:48:25.295693 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jun 12 17:48:25.805572 ignition[1353]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.36.1-x86-64.raw" Jun 12 17:48:25.807950 ignition[1353]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Jun 12 17:48:25.807950 ignition[1353]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Jun 12 17:48:25.807950 ignition[1353]: INFO : files: files passed Jun 12 17:48:25.807950 ignition[1353]: INFO : Ignition finished successfully Jun 12 17:48:25.807855 systemd[1]: Finished ignition-files.service - Ignition (files). Jun 12 17:48:25.815396 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jun 12 17:48:25.818811 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jun 12 17:48:25.822734 systemd[1]: ignition-quench.service: Deactivated successfully. Jun 12 17:48:25.823169 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jun 12 17:48:25.840641 initrd-setup-root-after-ignition[1382]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 12 17:48:25.840641 initrd-setup-root-after-ignition[1382]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jun 12 17:48:25.844220 initrd-setup-root-after-ignition[1386]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jun 12 17:48:25.846397 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 12 17:48:25.847156 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jun 12 17:48:25.852294 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jun 12 17:48:25.862261 systemd-networkd[1165]: eth0: Gained IPv6LL Jun 12 17:48:25.891174 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jun 12 17:48:25.891321 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jun 12 17:48:25.892591 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jun 12 17:48:25.894082 systemd[1]: Reached target initrd.target - Initrd Default Target. Jun 12 17:48:25.894953 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jun 12 17:48:25.900321 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jun 12 17:48:25.915724 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 12 17:48:25.924429 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jun 12 17:48:25.936749 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jun 12 17:48:25.937572 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 12 17:48:25.938564 systemd[1]: Stopped target timers.target - Timer Units. Jun 12 17:48:25.939424 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jun 12 17:48:25.939613 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jun 12 17:48:25.940754 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jun 12 17:48:25.941731 systemd[1]: Stopped target basic.target - Basic System. Jun 12 17:48:25.942519 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jun 12 17:48:25.943279 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jun 12 17:48:25.944029 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jun 12 17:48:25.944805 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jun 12 17:48:25.945725 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jun 12 17:48:25.946548 systemd[1]: Stopped target sysinit.target - System Initialization. Jun 12 17:48:25.947676 systemd[1]: Stopped target local-fs.target - Local File Systems. Jun 12 17:48:25.948450 systemd[1]: Stopped target swap.target - Swaps. Jun 12 17:48:25.949344 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jun 12 17:48:25.949530 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jun 12 17:48:25.950574 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jun 12 17:48:25.951413 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 12 17:48:25.952113 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jun 12 17:48:25.952256 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 12 17:48:25.952907 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jun 12 17:48:25.953081 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jun 12 17:48:25.954582 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jun 12 17:48:25.954767 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jun 12 17:48:25.955495 systemd[1]: ignition-files.service: Deactivated successfully. Jun 12 17:48:25.955652 systemd[1]: Stopped ignition-files.service - Ignition (files). Jun 12 17:48:25.961482 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jun 12 17:48:25.962920 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jun 12 17:48:25.963847 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jun 12 17:48:25.971852 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jun 12 17:48:25.974209 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jun 12 17:48:25.975274 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jun 12 17:48:25.976788 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jun 12 17:48:25.976965 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jun 12 17:48:25.984590 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jun 12 17:48:25.985337 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jun 12 17:48:25.996173 ignition[1406]: INFO : Ignition 2.19.0 Jun 12 17:48:25.996173 ignition[1406]: INFO : Stage: umount Jun 12 17:48:25.996173 ignition[1406]: INFO : no configs at "/usr/lib/ignition/base.d" Jun 12 17:48:25.996173 ignition[1406]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jun 12 17:48:26.000840 ignition[1406]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jun 12 17:48:26.000840 ignition[1406]: INFO : PUT result: OK Jun 12 17:48:26.002370 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jun 12 17:48:26.004076 ignition[1406]: INFO : umount: umount passed Jun 12 17:48:26.004663 ignition[1406]: INFO : Ignition finished successfully Jun 12 17:48:26.005557 systemd[1]: ignition-mount.service: Deactivated successfully. Jun 12 17:48:26.005693 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jun 12 17:48:26.006987 systemd[1]: ignition-disks.service: Deactivated successfully. Jun 12 17:48:26.007134 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jun 12 17:48:26.007628 systemd[1]: ignition-kargs.service: Deactivated successfully. Jun 12 17:48:26.007690 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jun 12 17:48:26.008334 systemd[1]: ignition-fetch.service: Deactivated successfully. Jun 12 17:48:26.008390 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jun 12 17:48:26.009007 systemd[1]: Stopped target network.target - Network. Jun 12 17:48:26.009725 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jun 12 17:48:26.009787 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jun 12 17:48:26.010462 systemd[1]: Stopped target paths.target - Path Units. Jun 12 17:48:26.011042 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jun 12 17:48:26.011206 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 12 17:48:26.011727 systemd[1]: Stopped target slices.target - Slice Units. Jun 12 17:48:26.012344 systemd[1]: Stopped target sockets.target - Socket Units. Jun 12 17:48:26.013004 systemd[1]: iscsid.socket: Deactivated successfully. Jun 12 17:48:26.013057 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jun 12 17:48:26.013778 systemd[1]: iscsiuio.socket: Deactivated successfully. Jun 12 17:48:26.013831 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jun 12 17:48:26.014471 systemd[1]: ignition-setup.service: Deactivated successfully. Jun 12 17:48:26.014533 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jun 12 17:48:26.015140 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jun 12 17:48:26.015197 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jun 12 17:48:26.016351 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jun 12 17:48:26.017012 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jun 12 17:48:26.020157 systemd-networkd[1165]: eth0: DHCPv6 lease lost Jun 12 17:48:26.022853 systemd[1]: systemd-networkd.service: Deactivated successfully. Jun 12 17:48:26.023020 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jun 12 17:48:26.024074 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jun 12 17:48:26.024293 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jun 12 17:48:26.031262 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jun 12 17:48:26.031780 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jun 12 17:48:26.031867 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jun 12 17:48:26.032999 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 12 17:48:26.037858 systemd[1]: systemd-resolved.service: Deactivated successfully. Jun 12 17:48:26.038008 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jun 12 17:48:26.042933 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jun 12 17:48:26.043073 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jun 12 17:48:26.043816 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jun 12 17:48:26.043882 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jun 12 17:48:26.045480 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jun 12 17:48:26.045548 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 12 17:48:26.050584 systemd[1]: systemd-udevd.service: Deactivated successfully. Jun 12 17:48:26.050830 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 12 17:48:26.052215 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jun 12 17:48:26.052309 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jun 12 17:48:26.053409 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jun 12 17:48:26.053464 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jun 12 17:48:26.054064 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jun 12 17:48:26.055169 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jun 12 17:48:26.056773 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jun 12 17:48:26.056837 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jun 12 17:48:26.057512 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jun 12 17:48:26.057567 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jun 12 17:48:26.064231 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jun 12 17:48:26.067143 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jun 12 17:48:26.067228 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 12 17:48:26.068173 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jun 12 17:48:26.068241 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:26.069272 systemd[1]: network-cleanup.service: Deactivated successfully. Jun 12 17:48:26.069413 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jun 12 17:48:26.081013 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jun 12 17:48:26.081228 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jun 12 17:48:26.123177 systemd[1]: sysroot-boot.service: Deactivated successfully. Jun 12 17:48:26.123331 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jun 12 17:48:26.124873 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jun 12 17:48:26.125510 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jun 12 17:48:26.125616 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jun 12 17:48:26.130287 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jun 12 17:48:26.147701 systemd[1]: Switching root. Jun 12 17:48:26.180962 systemd-journald[179]: Journal stopped Jun 12 17:48:27.601675 systemd-journald[179]: Received SIGTERM from PID 1 (systemd). Jun 12 17:48:27.601780 kernel: SELinux: policy capability network_peer_controls=1 Jun 12 17:48:27.601806 kernel: SELinux: policy capability open_perms=1 Jun 12 17:48:27.601832 kernel: SELinux: policy capability extended_socket_class=1 Jun 12 17:48:27.601851 kernel: SELinux: policy capability always_check_network=0 Jun 12 17:48:27.601868 kernel: SELinux: policy capability cgroup_seclabel=1 Jun 12 17:48:27.601895 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jun 12 17:48:27.601912 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jun 12 17:48:27.601936 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jun 12 17:48:27.601956 kernel: audit: type=1403 audit(1781286506.442:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jun 12 17:48:27.601981 systemd[1]: Successfully loaded SELinux policy in 53.695ms. Jun 12 17:48:27.602008 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 11.262ms. Jun 12 17:48:27.602029 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) Jun 12 17:48:27.602049 systemd[1]: Detected virtualization amazon. Jun 12 17:48:27.602068 systemd[1]: Detected architecture x86-64. Jun 12 17:48:27.603288 systemd[1]: Detected first boot. Jun 12 17:48:27.603324 systemd[1]: Initializing machine ID from VM UUID. Jun 12 17:48:27.603343 zram_generator::config[1449]: No configuration found. Jun 12 17:48:27.603363 systemd[1]: Populated /etc with preset unit settings. Jun 12 17:48:27.603386 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jun 12 17:48:27.603404 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jun 12 17:48:27.603429 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jun 12 17:48:27.603449 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jun 12 17:48:27.603469 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jun 12 17:48:27.603489 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jun 12 17:48:27.603510 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jun 12 17:48:27.603531 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jun 12 17:48:27.603552 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jun 12 17:48:27.603578 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jun 12 17:48:27.603599 systemd[1]: Created slice user.slice - User and Session Slice. Jun 12 17:48:27.603619 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jun 12 17:48:27.603642 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jun 12 17:48:27.603663 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jun 12 17:48:27.603685 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jun 12 17:48:27.603706 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jun 12 17:48:27.603728 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jun 12 17:48:27.603750 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jun 12 17:48:27.603775 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jun 12 17:48:27.603796 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jun 12 17:48:27.603817 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jun 12 17:48:27.603839 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jun 12 17:48:27.603860 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jun 12 17:48:27.603883 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jun 12 17:48:27.603904 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jun 12 17:48:27.603928 systemd[1]: Reached target slices.target - Slice Units. Jun 12 17:48:27.603949 systemd[1]: Reached target swap.target - Swaps. Jun 12 17:48:27.603971 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jun 12 17:48:27.603993 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jun 12 17:48:27.604014 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jun 12 17:48:27.604033 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jun 12 17:48:27.604050 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jun 12 17:48:27.604068 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jun 12 17:48:27.604086 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jun 12 17:48:27.604138 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jun 12 17:48:27.604164 systemd[1]: Mounting media.mount - External Media Directory... Jun 12 17:48:27.604183 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:27.604201 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jun 12 17:48:27.604225 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jun 12 17:48:27.604245 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jun 12 17:48:27.604267 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). Jun 12 17:48:27.604289 systemd[1]: Reached target machines.target - Containers. Jun 12 17:48:27.604308 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jun 12 17:48:27.604334 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 12 17:48:27.604353 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jun 12 17:48:27.604375 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jun 12 17:48:27.604397 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 12 17:48:27.604418 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 12 17:48:27.604440 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 12 17:48:27.604460 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jun 12 17:48:27.604478 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 12 17:48:27.604499 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jun 12 17:48:27.606770 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jun 12 17:48:27.606796 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jun 12 17:48:27.606818 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jun 12 17:48:27.606839 systemd[1]: Stopped systemd-fsck-usr.service. Jun 12 17:48:27.606861 systemd[1]: Starting systemd-journald.service - Journal Service... Jun 12 17:48:27.606884 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jun 12 17:48:27.606906 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jun 12 17:48:27.606927 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jun 12 17:48:27.606953 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jun 12 17:48:27.606975 systemd[1]: verity-setup.service: Deactivated successfully. Jun 12 17:48:27.606997 systemd[1]: Stopped verity-setup.service. Jun 12 17:48:27.607019 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:27.607040 kernel: ACPI: bus type drm_connector registered Jun 12 17:48:27.607062 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jun 12 17:48:27.607084 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jun 12 17:48:27.608254 kernel: loop: module loaded Jun 12 17:48:27.608285 systemd[1]: Mounted media.mount - External Media Directory. Jun 12 17:48:27.608313 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jun 12 17:48:27.608335 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jun 12 17:48:27.608356 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jun 12 17:48:27.608377 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jun 12 17:48:27.608400 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jun 12 17:48:27.608424 kernel: fuse: init (API version 7.39) Jun 12 17:48:27.608446 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jun 12 17:48:27.608469 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 12 17:48:27.608490 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 12 17:48:27.608511 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 12 17:48:27.608533 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 12 17:48:27.608556 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 12 17:48:27.608583 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 12 17:48:27.608605 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jun 12 17:48:27.608626 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jun 12 17:48:27.608648 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 12 17:48:27.608669 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 12 17:48:27.608730 systemd-journald[1534]: Collecting audit messages is disabled. Jun 12 17:48:27.608771 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jun 12 17:48:27.608792 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jun 12 17:48:27.608811 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jun 12 17:48:27.608830 systemd[1]: Reached target network-pre.target - Preparation for Network. Jun 12 17:48:27.608852 systemd-journald[1534]: Journal started Jun 12 17:48:27.608889 systemd-journald[1534]: Runtime Journal (/run/log/journal/ec28d8dea666a4c3f62a7567f4a3e83c) is 4.7M, max 38.2M, 33.4M free. Jun 12 17:48:27.205682 systemd[1]: Queued start job for default target multi-user.target. Jun 12 17:48:27.227669 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jun 12 17:48:27.228156 systemd[1]: systemd-journald.service: Deactivated successfully. Jun 12 17:48:27.619109 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jun 12 17:48:27.631203 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jun 12 17:48:27.637116 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jun 12 17:48:27.639408 systemd[1]: Reached target local-fs.target - Local File Systems. Jun 12 17:48:27.650266 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jun 12 17:48:27.657211 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jun 12 17:48:27.667109 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jun 12 17:48:27.671503 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 12 17:48:27.681183 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jun 12 17:48:27.692119 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 12 17:48:27.700114 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jun 12 17:48:27.709024 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 12 17:48:27.709152 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jun 12 17:48:27.725799 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jun 12 17:48:27.733116 systemd[1]: Started systemd-journald.service - Journal Service. Jun 12 17:48:27.738049 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jun 12 17:48:27.739606 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jun 12 17:48:27.742472 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jun 12 17:48:27.743676 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jun 12 17:48:27.744878 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jun 12 17:48:27.746598 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jun 12 17:48:27.771743 kernel: loop0: detected capacity change from 0 to 142488 Jun 12 17:48:27.781432 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jun 12 17:48:27.791505 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jun 12 17:48:27.796305 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jun 12 17:48:27.802396 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jun 12 17:48:27.812803 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jun 12 17:48:27.815532 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jun 12 17:48:27.817985 systemd-journald[1534]: Time spent on flushing to /var/log/journal/ec28d8dea666a4c3f62a7567f4a3e83c is 106.268ms for 974 entries. Jun 12 17:48:27.817985 systemd-journald[1534]: System Journal (/var/log/journal/ec28d8dea666a4c3f62a7567f4a3e83c) is 8.0M, max 195.6M, 187.6M free. Jun 12 17:48:27.940802 systemd-journald[1534]: Received client request to flush runtime journal. Jun 12 17:48:27.940877 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jun 12 17:48:27.901553 udevadm[1590]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jun 12 17:48:27.935852 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jun 12 17:48:27.938546 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jun 12 17:48:27.943616 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jun 12 17:48:27.952463 kernel: loop1: detected capacity change from 0 to 61336 Jun 12 17:48:27.963799 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jun 12 17:48:27.979303 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jun 12 17:48:28.049396 systemd-tmpfiles[1600]: ACLs are not supported, ignoring. Jun 12 17:48:28.049425 systemd-tmpfiles[1600]: ACLs are not supported, ignoring. Jun 12 17:48:28.057121 kernel: loop2: detected capacity change from 0 to 140768 Jun 12 17:48:28.063767 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jun 12 17:48:28.192152 kernel: loop3: detected capacity change from 0 to 219840 Jun 12 17:48:28.312727 kernel: loop4: detected capacity change from 0 to 142488 Jun 12 17:48:28.376116 kernel: loop5: detected capacity change from 0 to 61336 Jun 12 17:48:28.416145 kernel: loop6: detected capacity change from 0 to 140768 Jun 12 17:48:28.469202 kernel: loop7: detected capacity change from 0 to 219840 Jun 12 17:48:28.513326 (sd-merge)[1607]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-ami'. Jun 12 17:48:28.515447 (sd-merge)[1607]: Merged extensions into '/usr'. Jun 12 17:48:28.525066 systemd[1]: Reloading requested from client PID 1560 ('systemd-sysext') (unit systemd-sysext.service)... Jun 12 17:48:28.525288 systemd[1]: Reloading... Jun 12 17:48:28.615143 zram_generator::config[1629]: No configuration found. Jun 12 17:48:28.787125 ldconfig[1556]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jun 12 17:48:28.846236 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. Jun 12 17:48:28.901308 systemd[1]: Reloading finished in 374 ms. Jun 12 17:48:28.930796 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jun 12 17:48:28.931701 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jun 12 17:48:28.932502 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jun 12 17:48:28.943326 systemd[1]: Starting ensure-sysext.service... Jun 12 17:48:28.945340 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jun 12 17:48:28.949427 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jun 12 17:48:28.971287 systemd[1]: Reloading requested from client PID 1686 ('systemctl') (unit ensure-sysext.service)... Jun 12 17:48:28.971312 systemd[1]: Reloading... Jun 12 17:48:28.977058 systemd-tmpfiles[1687]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jun 12 17:48:28.978076 systemd-tmpfiles[1687]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jun 12 17:48:28.979606 systemd-tmpfiles[1687]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jun 12 17:48:28.980226 systemd-tmpfiles[1687]: ACLs are not supported, ignoring. Jun 12 17:48:28.980409 systemd-tmpfiles[1687]: ACLs are not supported, ignoring. Jun 12 17:48:28.999773 systemd-tmpfiles[1687]: Detected autofs mount point /boot during canonicalization of boot. Jun 12 17:48:28.999795 systemd-tmpfiles[1687]: Skipping /boot Jun 12 17:48:29.019071 systemd-udevd[1688]: Using default interface naming scheme 'v255'. Jun 12 17:48:29.021552 systemd-tmpfiles[1687]: Detected autofs mount point /boot during canonicalization of boot. Jun 12 17:48:29.021566 systemd-tmpfiles[1687]: Skipping /boot Jun 12 17:48:29.077132 zram_generator::config[1715]: No configuration found. Jun 12 17:48:29.241713 (udev-worker)[1727]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:48:29.324115 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Jun 12 17:48:29.341139 kernel: piix4_smbus 0000:00:01.3: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr Jun 12 17:48:29.359113 kernel: ACPI: button: Power Button [PWRF] Jun 12 17:48:29.359209 kernel: input: ImPS/2 Generic Wheel Mouse as /devices/platform/i8042/serio1/input/input3 Jun 12 17:48:29.365061 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input4 Jun 12 17:48:29.372130 kernel: ACPI: button: Sleep Button [SLPF] Jun 12 17:48:29.382539 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. Jun 12 17:48:29.439119 kernel: mousedev: PS/2 mouse device common for all mice Jun 12 17:48:29.473155 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 30 scanned by (udev-worker) (1724) Jun 12 17:48:29.524460 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jun 12 17:48:29.525048 systemd[1]: Reloading finished in 553 ms. Jun 12 17:48:29.545729 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jun 12 17:48:29.552191 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jun 12 17:48:29.607997 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:29.614235 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jun 12 17:48:29.621729 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jun 12 17:48:29.623464 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 12 17:48:29.633619 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jun 12 17:48:29.639540 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jun 12 17:48:29.641793 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jun 12 17:48:29.642637 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 12 17:48:29.645318 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jun 12 17:48:29.653984 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jun 12 17:48:29.663445 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jun 12 17:48:29.669473 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jun 12 17:48:29.677527 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jun 12 17:48:29.679176 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:29.690814 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:29.691602 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jun 12 17:48:29.703617 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jun 12 17:48:29.704836 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jun 12 17:48:29.705381 systemd[1]: Reached target time-set.target - System Time Set. Jun 12 17:48:29.706711 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jun 12 17:48:29.708965 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jun 12 17:48:29.709211 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jun 12 17:48:29.715646 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jun 12 17:48:29.717203 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jun 12 17:48:29.723143 systemd[1]: Finished ensure-sysext.service. Jun 12 17:48:29.724352 systemd[1]: modprobe@loop.service: Deactivated successfully. Jun 12 17:48:29.724974 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jun 12 17:48:29.739601 systemd[1]: modprobe@drm.service: Deactivated successfully. Jun 12 17:48:29.739815 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jun 12 17:48:29.766894 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jun 12 17:48:29.767121 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jun 12 17:48:29.779811 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jun 12 17:48:29.780867 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jun 12 17:48:29.792072 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jun 12 17:48:29.794363 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jun 12 17:48:29.804234 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jun 12 17:48:29.811916 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jun 12 17:48:29.818597 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jun 12 17:48:29.826420 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jun 12 17:48:29.851994 lvm[1909]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 12 17:48:29.879343 augenrules[1917]: No rules Jun 12 17:48:29.882745 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jun 12 17:48:29.884560 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jun 12 17:48:29.890528 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jun 12 17:48:29.893482 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jun 12 17:48:29.895635 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). Jun 12 17:48:29.902736 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jun 12 17:48:29.903565 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jun 12 17:48:29.904764 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jun 12 17:48:29.912386 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jun 12 17:48:29.935987 lvm[1931]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jun 12 17:48:29.955206 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jun 12 17:48:29.976675 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jun 12 17:48:30.023042 systemd-networkd[1883]: lo: Link UP Jun 12 17:48:30.023436 systemd-networkd[1883]: lo: Gained carrier Jun 12 17:48:30.025421 systemd-networkd[1883]: Enumeration completed Jun 12 17:48:30.026395 systemd[1]: Started systemd-networkd.service - Network Configuration. Jun 12 17:48:30.028269 systemd-networkd[1883]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 12 17:48:30.028349 systemd-networkd[1883]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jun 12 17:48:30.028540 systemd-resolved[1884]: Positive Trust Anchors: Jun 12 17:48:30.028558 systemd-resolved[1884]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jun 12 17:48:30.028612 systemd-resolved[1884]: 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 Jun 12 17:48:30.032732 systemd-networkd[1883]: eth0: Link UP Jun 12 17:48:30.033611 systemd-networkd[1883]: eth0: Gained carrier Jun 12 17:48:30.033639 systemd-networkd[1883]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jun 12 17:48:30.034421 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jun 12 17:48:30.039660 systemd-resolved[1884]: Defaulting to hostname 'linux'. Jun 12 17:48:30.042127 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jun 12 17:48:30.042303 systemd-networkd[1883]: eth0: DHCPv4 address 172.31.16.193/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jun 12 17:48:30.044450 systemd[1]: Reached target network.target - Network. Jun 12 17:48:30.045106 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jun 12 17:48:30.045744 systemd[1]: Reached target sysinit.target - System Initialization. Jun 12 17:48:30.046452 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jun 12 17:48:30.047017 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jun 12 17:48:30.047758 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jun 12 17:48:30.048268 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jun 12 17:48:30.048649 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 12 17:48:30.049034 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jun 12 17:48:30.049079 systemd[1]: Reached target paths.target - Path Units. Jun 12 17:48:30.049484 systemd[1]: Reached target timers.target - Timer Units. Jun 12 17:48:30.050308 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jun 12 17:48:30.052072 systemd[1]: Starting docker.socket - Docker Socket for the API... Jun 12 17:48:30.060266 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jun 12 17:48:30.061667 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jun 12 17:48:30.062258 systemd[1]: Reached target sockets.target - Socket Units. Jun 12 17:48:30.062737 systemd[1]: Reached target basic.target - Basic System. Jun 12 17:48:30.063200 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jun 12 17:48:30.063237 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jun 12 17:48:30.064430 systemd[1]: Starting containerd.service - containerd container runtime... Jun 12 17:48:30.069335 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jun 12 17:48:30.072464 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jun 12 17:48:30.082819 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jun 12 17:48:30.086319 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jun 12 17:48:30.089196 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). Jun 12 17:48:30.090713 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jun 12 17:48:30.100848 systemd[1]: Started ntpd.service - Network Time Service. Jun 12 17:48:30.102025 jq[1945]: false Jun 12 17:48:30.137416 systemd[1]: Starting setup-oem.service - Setup OEM... Jun 12 17:48:30.140536 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jun 12 17:48:30.144535 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jun 12 17:48:30.156389 systemd[1]: Starting systemd-logind.service - User Login Management... Jun 12 17:48:30.157620 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jun 12 17:48:30.159057 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jun 12 17:48:30.163517 systemd[1]: Starting update-engine.service - Update Engine... Jun 12 17:48:30.177283 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jun 12 17:48:30.183626 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jun 12 17:48:30.183869 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jun 12 17:48:30.186615 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jun 12 17:48:30.187362 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jun 12 17:48:30.214629 dbus-daemon[1944]: [system] SELinux support is enabled Jun 12 17:48:30.217335 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jun 12 17:48:30.225301 dbus-daemon[1944]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1883 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jun 12 17:48:30.228854 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). Jun 12 17:48:30.228916 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jun 12 17:48:30.232267 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). Jun 12 17:48:30.232439 dbus-daemon[1944]: [system] Successfully activated service 'org.freedesktop.systemd1' Jun 12 17:48:30.232304 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jun 12 17:48:30.243183 extend-filesystems[1946]: Found loop4 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found loop5 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found loop6 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found loop7 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found nvme0n1 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found nvme0n1p1 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found nvme0n1p2 Jun 12 17:48:30.243183 extend-filesystems[1946]: Found nvme0n1p3 Jun 12 17:48:30.253374 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jun 12 17:48:30.289535 update_engine[1959]: I20260612 17:48:30.288630 1959 main.cc:92] Flatcar Update Engine starting Jun 12 17:48:30.290245 extend-filesystems[1946]: Found usr Jun 12 17:48:30.290245 extend-filesystems[1946]: Found nvme0n1p4 Jun 12 17:48:30.290245 extend-filesystems[1946]: Found nvme0n1p6 Jun 12 17:48:30.290245 extend-filesystems[1946]: Found nvme0n1p7 Jun 12 17:48:30.290245 extend-filesystems[1946]: Found nvme0n1p9 Jun 12 17:48:30.290245 extend-filesystems[1946]: Checking size of /dev/nvme0n1p9 Jun 12 17:48:30.269500 systemd[1]: motdgen.service: Deactivated successfully. Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: ntpd 4.2.8p17@1.4004-o Fri Jun 12 15:32:20 UTC 2026 (1): Starting Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: ---------------------------------------------------- Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: ntp-4 is maintained by Network Time Foundation, Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: corporation. Support and training for ntp-4 are Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: available at https://www.nwtime.org/support Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: ---------------------------------------------------- Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: proto: precision = 0.061 usec (-24) Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: basedate set to 2026-05-31 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: gps base set to 2026-05-31 (week 2421) Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listen and drop on 0 v6wildcard [::]:123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listen normally on 2 lo 127.0.0.1:123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listen normally on 3 eth0 172.31.16.193:123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listen normally on 4 lo [::1]:123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: bind(21) AF_INET6 fe80::4ad:55ff:fe97:bccd%2#123 flags 0x11 failed: Cannot assign requested address Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: unable to create socket on eth0 (5) for fe80::4ad:55ff:fe97:bccd%2#123 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: failed to init interface for address fe80::4ad:55ff:fe97:bccd%2 Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: Listening on routing socket on fd #21 for interface updates Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 12 17:48:30.329596 ntpd[1948]: 12 Jun 17:48:30 ntpd[1948]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 12 17:48:30.332661 update_engine[1959]: I20260612 17:48:30.299678 1959 update_check_scheduler.cc:74] Next update check in 9m49s Jun 12 17:48:30.299754 ntpd[1948]: ntpd 4.2.8p17@1.4004-o Fri Jun 12 15:32:20 UTC 2026 (1): Starting Jun 12 17:48:30.269736 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jun 12 17:48:30.333086 jq[1965]: true Jun 12 17:48:30.299782 ntpd[1948]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jun 12 17:48:30.296499 systemd[1]: Started update-engine.service - Update Engine. Jun 12 17:48:30.299793 ntpd[1948]: ---------------------------------------------------- Jun 12 17:48:30.316294 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jun 12 17:48:30.299803 ntpd[1948]: ntp-4 is maintained by Network Time Foundation, Jun 12 17:48:30.318603 (ntainerd)[1981]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jun 12 17:48:30.299813 ntpd[1948]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jun 12 17:48:30.299824 ntpd[1948]: corporation. Support and training for ntp-4 are Jun 12 17:48:30.299833 ntpd[1948]: available at https://www.nwtime.org/support Jun 12 17:48:30.299842 ntpd[1948]: ---------------------------------------------------- Jun 12 17:48:30.302648 ntpd[1948]: proto: precision = 0.061 usec (-24) Jun 12 17:48:30.306324 ntpd[1948]: basedate set to 2026-05-31 Jun 12 17:48:30.306347 ntpd[1948]: gps base set to 2026-05-31 (week 2421) Jun 12 17:48:30.310593 ntpd[1948]: Listen and drop on 0 v6wildcard [::]:123 Jun 12 17:48:30.310652 ntpd[1948]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jun 12 17:48:30.310849 ntpd[1948]: Listen normally on 2 lo 127.0.0.1:123 Jun 12 17:48:30.310892 ntpd[1948]: Listen normally on 3 eth0 172.31.16.193:123 Jun 12 17:48:30.310938 ntpd[1948]: Listen normally on 4 lo [::1]:123 Jun 12 17:48:30.310984 ntpd[1948]: bind(21) AF_INET6 fe80::4ad:55ff:fe97:bccd%2#123 flags 0x11 failed: Cannot assign requested address Jun 12 17:48:30.311008 ntpd[1948]: unable to create socket on eth0 (5) for fe80::4ad:55ff:fe97:bccd%2#123 Jun 12 17:48:30.311024 ntpd[1948]: failed to init interface for address fe80::4ad:55ff:fe97:bccd%2 Jun 12 17:48:30.311055 ntpd[1948]: Listening on routing socket on fd #21 for interface updates Jun 12 17:48:30.317001 ntpd[1948]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 12 17:48:30.317035 ntpd[1948]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jun 12 17:48:30.350731 systemd[1]: Finished setup-oem.service - Setup OEM. Jun 12 17:48:30.362462 extend-filesystems[1946]: Resized partition /dev/nvme0n1p9 Jun 12 17:48:30.365000 jq[1984]: true Jun 12 17:48:30.365355 extend-filesystems[1995]: resize2fs 1.47.1 (20-May-2024) Jun 12 17:48:30.386125 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.458 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.459 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.460 INFO Fetch successful Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.460 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.461 INFO Fetch successful Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.461 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.462 INFO Fetch successful Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.462 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.463 INFO Fetch successful Jun 12 17:48:30.464160 coreos-metadata[1943]: Jun 12 17:48:30.463 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Jun 12 17:48:30.468725 systemd-logind[1957]: Watching system buttons on /dev/input/event1 (Power Button) Jun 12 17:48:30.471588 coreos-metadata[1943]: Jun 12 17:48:30.468 INFO Fetch failed with 404: resource not found Jun 12 17:48:30.471588 coreos-metadata[1943]: Jun 12 17:48:30.468 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Jun 12 17:48:30.471951 coreos-metadata[1943]: Jun 12 17:48:30.471 INFO Fetch successful Jun 12 17:48:30.471951 coreos-metadata[1943]: Jun 12 17:48:30.471 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Jun 12 17:48:30.473506 coreos-metadata[1943]: Jun 12 17:48:30.473 INFO Fetch successful Jun 12 17:48:30.473506 coreos-metadata[1943]: Jun 12 17:48:30.473 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Jun 12 17:48:30.473786 systemd-logind[1957]: Watching system buttons on /dev/input/event3 (Sleep Button) Jun 12 17:48:30.473821 systemd-logind[1957]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jun 12 17:48:30.474374 coreos-metadata[1943]: Jun 12 17:48:30.474 INFO Fetch successful Jun 12 17:48:30.474374 coreos-metadata[1943]: Jun 12 17:48:30.474 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Jun 12 17:48:30.480669 coreos-metadata[1943]: Jun 12 17:48:30.475 INFO Fetch successful Jun 12 17:48:30.480669 coreos-metadata[1943]: Jun 12 17:48:30.475 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Jun 12 17:48:30.475944 systemd-logind[1957]: New seat seat0. Jun 12 17:48:30.483782 systemd[1]: Started systemd-logind.service - User Login Management. Jun 12 17:48:30.485827 coreos-metadata[1943]: Jun 12 17:48:30.484 INFO Fetch successful Jun 12 17:48:30.563129 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 30 scanned by (udev-worker) (1744) Jun 12 17:48:30.569322 dbus-daemon[1944]: [system] Successfully activated service 'org.freedesktop.hostname1' Jun 12 17:48:30.573775 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jun 12 17:48:30.572913 dbus-daemon[1944]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1978 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jun 12 17:48:30.588663 systemd[1]: Starting polkit.service - Authorization Manager... Jun 12 17:48:30.592148 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jun 12 17:48:30.595347 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jun 12 17:48:30.654119 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Jun 12 17:48:30.654214 bash[2019]: Updated "/home/core/.ssh/authorized_keys" Jun 12 17:48:30.681477 polkitd[2041]: Started polkitd version 121 Jun 12 17:48:30.655791 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jun 12 17:48:30.666467 systemd[1]: Starting sshkeys.service... Jun 12 17:48:30.692819 sshd_keygen[1976]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jun 12 17:48:30.696717 extend-filesystems[1995]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jun 12 17:48:30.696717 extend-filesystems[1995]: old_desc_blocks = 1, new_desc_blocks = 2 Jun 12 17:48:30.696717 extend-filesystems[1995]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Jun 12 17:48:30.702563 extend-filesystems[1946]: Resized filesystem in /dev/nvme0n1p9 Jun 12 17:48:30.702222 systemd[1]: extend-filesystems.service: Deactivated successfully. Jun 12 17:48:30.703197 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jun 12 17:48:30.718849 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jun 12 17:48:30.732078 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jun 12 17:48:30.736474 polkitd[2041]: Loading rules from directory /etc/polkit-1/rules.d Jun 12 17:48:30.736561 polkitd[2041]: Loading rules from directory /usr/share/polkit-1/rules.d Jun 12 17:48:30.739994 polkitd[2041]: Finished loading, compiling and executing 2 rules Jun 12 17:48:30.743988 dbus-daemon[1944]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jun 12 17:48:30.746376 systemd[1]: Started polkit.service - Authorization Manager. Jun 12 17:48:30.748999 polkitd[2041]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jun 12 17:48:30.787821 locksmithd[1986]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jun 12 17:48:30.798311 systemd-hostnamed[1978]: Hostname set to (transient) Jun 12 17:48:30.798926 systemd-resolved[1884]: System hostname changed to 'ip-172-31-16-193'. Jun 12 17:48:30.816173 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jun 12 17:48:30.852530 systemd[1]: Starting issuegen.service - Generate /run/issue... Jun 12 17:48:30.882888 coreos-metadata[2077]: Jun 12 17:48:30.882 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jun 12 17:48:30.891274 coreos-metadata[2077]: Jun 12 17:48:30.889 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Jun 12 17:48:30.891274 coreos-metadata[2077]: Jun 12 17:48:30.891 INFO Fetch successful Jun 12 17:48:30.891274 coreos-metadata[2077]: Jun 12 17:48:30.891 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Jun 12 17:48:30.896729 coreos-metadata[2077]: Jun 12 17:48:30.896 INFO Fetch successful Jun 12 17:48:30.899837 systemd[1]: issuegen.service: Deactivated successfully. Jun 12 17:48:30.900079 systemd[1]: Finished issuegen.service - Generate /run/issue. Jun 12 17:48:30.909150 unknown[2077]: wrote ssh authorized keys file for user: core Jun 12 17:48:30.915616 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jun 12 17:48:30.976473 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jun 12 17:48:30.982902 update-ssh-keys[2140]: Updated "/home/core/.ssh/authorized_keys" Jun 12 17:48:30.991320 systemd[1]: Started getty@tty1.service - Getty on tty1. Jun 12 17:48:31.002621 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jun 12 17:48:31.004301 systemd[1]: Reached target getty.target - Login Prompts. Jun 12 17:48:31.007525 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jun 12 17:48:31.016154 systemd[1]: Finished sshkeys.service. Jun 12 17:48:31.024084 containerd[1981]: time="2026-06-12T17:48:31.023978837Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jun 12 17:48:31.060211 containerd[1981]: time="2026-06-12T17:48:31.060141624Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.061837 containerd[1981]: time="2026-06-12T17:48:31.061793765Z" 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.142-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jun 12 17:48:31.061837 containerd[1981]: time="2026-06-12T17:48:31.061830230Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jun 12 17:48:31.061973 containerd[1981]: time="2026-06-12T17:48:31.061852164Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jun 12 17:48:31.062071 containerd[1981]: time="2026-06-12T17:48:31.062045145Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jun 12 17:48:31.062134 containerd[1981]: time="2026-06-12T17:48:31.062074357Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062204 containerd[1981]: time="2026-06-12T17:48:31.062177996Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062246 containerd[1981]: time="2026-06-12T17:48:31.062201511Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062420 containerd[1981]: time="2026-06-12T17:48:31.062392437Z" 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 Jun 12 17:48:31.062420 containerd[1981]: time="2026-06-12T17:48:31.062415037Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062512 containerd[1981]: time="2026-06-12T17:48:31.062437736Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062512 containerd[1981]: time="2026-06-12T17:48:31.062455516Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062584 containerd[1981]: time="2026-06-12T17:48:31.062564998Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062820 containerd[1981]: time="2026-06-12T17:48:31.062790842Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jun 12 17:48:31.062959 containerd[1981]: time="2026-06-12T17:48:31.062934214Z" 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 Jun 12 17:48:31.063004 containerd[1981]: time="2026-06-12T17:48:31.062955713Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jun 12 17:48:31.063108 containerd[1981]: time="2026-06-12T17:48:31.063066502Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jun 12 17:48:31.063182 containerd[1981]: time="2026-06-12T17:48:31.063161438Z" level=info msg="metadata content store policy set" policy=shared Jun 12 17:48:31.076710 containerd[1981]: time="2026-06-12T17:48:31.076656361Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jun 12 17:48:31.076876 containerd[1981]: time="2026-06-12T17:48:31.076735167Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jun 12 17:48:31.076876 containerd[1981]: time="2026-06-12T17:48:31.076760530Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jun 12 17:48:31.076876 containerd[1981]: time="2026-06-12T17:48:31.076810253Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jun 12 17:48:31.076876 containerd[1981]: time="2026-06-12T17:48:31.076834019Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jun 12 17:48:31.077282 containerd[1981]: time="2026-06-12T17:48:31.077065486Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jun 12 17:48:31.077597 containerd[1981]: time="2026-06-12T17:48:31.077569394Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jun 12 17:48:31.077750 containerd[1981]: time="2026-06-12T17:48:31.077724945Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jun 12 17:48:31.077815 containerd[1981]: time="2026-06-12T17:48:31.077765150Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jun 12 17:48:31.077815 containerd[1981]: time="2026-06-12T17:48:31.077791374Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jun 12 17:48:31.077887 containerd[1981]: time="2026-06-12T17:48:31.077812131Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.077887 containerd[1981]: time="2026-06-12T17:48:31.077832525Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.077887 containerd[1981]: time="2026-06-12T17:48:31.077852468Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.077887 containerd[1981]: time="2026-06-12T17:48:31.077879994Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.077902212Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.077924068Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.077943404Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.077964434Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.077992895Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078035 containerd[1981]: time="2026-06-12T17:48:31.078015161Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078034658Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078056079Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078075027Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078120289Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078139855Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078160610Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078181986Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078217575Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078238867Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078268 containerd[1981]: time="2026-06-12T17:48:31.078257539Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078278737Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078302106Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078333319Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078353174Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078370134Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078428999Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078455684Z" 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 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078472617Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078492486Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078508398Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078532607Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078547965Z" level=info msg="NRI interface is disabled by configuration." Jun 12 17:48:31.078642 containerd[1981]: time="2026-06-12T17:48:31.078563560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jun 12 17:48:31.079121 containerd[1981]: time="2026-06-12T17:48:31.078974853Z" 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}" Jun 12 17:48:31.079121 containerd[1981]: time="2026-06-12T17:48:31.079057639Z" level=info msg="Connect containerd service" Jun 12 17:48:31.079368 containerd[1981]: time="2026-06-12T17:48:31.079181735Z" level=info msg="using legacy CRI server" Jun 12 17:48:31.079368 containerd[1981]: time="2026-06-12T17:48:31.079268848Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jun 12 17:48:31.079458 containerd[1981]: time="2026-06-12T17:48:31.079429070Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jun 12 17:48:31.080176 containerd[1981]: time="2026-06-12T17:48:31.080144983Z" 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" Jun 12 17:48:31.080384 containerd[1981]: time="2026-06-12T17:48:31.080336555Z" level=info msg="Start subscribing containerd event" Jun 12 17:48:31.080449 containerd[1981]: time="2026-06-12T17:48:31.080403768Z" level=info msg="Start recovering state" Jun 12 17:48:31.080550 containerd[1981]: time="2026-06-12T17:48:31.080482067Z" level=info msg="Start event monitor" Jun 12 17:48:31.080550 containerd[1981]: time="2026-06-12T17:48:31.080503744Z" level=info msg="Start snapshots syncer" Jun 12 17:48:31.080550 containerd[1981]: time="2026-06-12T17:48:31.080517474Z" level=info msg="Start cni network conf syncer for default" Jun 12 17:48:31.080550 containerd[1981]: time="2026-06-12T17:48:31.080530629Z" level=info msg="Start streaming server" Jun 12 17:48:31.081049 containerd[1981]: time="2026-06-12T17:48:31.081024900Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jun 12 17:48:31.081247 containerd[1981]: time="2026-06-12T17:48:31.081222168Z" level=info msg=serving... address=/run/containerd/containerd.sock Jun 12 17:48:31.081419 systemd[1]: Started containerd.service - containerd container runtime. Jun 12 17:48:31.085653 containerd[1981]: time="2026-06-12T17:48:31.084929747Z" level=info msg="containerd successfully booted in 0.062082s" Jun 12 17:48:31.300294 ntpd[1948]: bind(24) AF_INET6 fe80::4ad:55ff:fe97:bccd%2#123 flags 0x11 failed: Cannot assign requested address Jun 12 17:48:31.300345 ntpd[1948]: unable to create socket on eth0 (6) for fe80::4ad:55ff:fe97:bccd%2#123 Jun 12 17:48:31.300689 ntpd[1948]: 12 Jun 17:48:31 ntpd[1948]: bind(24) AF_INET6 fe80::4ad:55ff:fe97:bccd%2#123 flags 0x11 failed: Cannot assign requested address Jun 12 17:48:31.300689 ntpd[1948]: 12 Jun 17:48:31 ntpd[1948]: unable to create socket on eth0 (6) for fe80::4ad:55ff:fe97:bccd%2#123 Jun 12 17:48:31.300689 ntpd[1948]: 12 Jun 17:48:31 ntpd[1948]: failed to init interface for address fe80::4ad:55ff:fe97:bccd%2 Jun 12 17:48:31.300361 ntpd[1948]: failed to init interface for address fe80::4ad:55ff:fe97:bccd%2 Jun 12 17:48:31.686355 systemd-networkd[1883]: eth0: Gained IPv6LL Jun 12 17:48:31.689847 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jun 12 17:48:31.691041 systemd[1]: Reached target network-online.target - Network is Online. Jun 12 17:48:31.701628 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Jun 12 17:48:31.704722 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 12 17:48:31.716593 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jun 12 17:48:31.749712 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jun 12 17:48:31.772717 amazon-ssm-agent[2162]: Initializing new seelog logger Jun 12 17:48:31.773201 amazon-ssm-agent[2162]: New Seelog Logger Creation Complete Jun 12 17:48:31.773201 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.773201 amazon-ssm-agent[2162]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.773520 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 processing appconfig overrides Jun 12 17:48:31.773805 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.773805 amazon-ssm-agent[2162]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.773910 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 processing appconfig overrides Jun 12 17:48:31.774661 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.774661 amazon-ssm-agent[2162]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.774661 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 processing appconfig overrides Jun 12 17:48:31.774661 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO Proxy environment variables: Jun 12 17:48:31.776712 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.776772 amazon-ssm-agent[2162]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jun 12 17:48:31.776885 amazon-ssm-agent[2162]: 2026/06/12 17:48:31 processing appconfig overrides Jun 12 17:48:31.874466 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO https_proxy: Jun 12 17:48:31.972814 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO http_proxy: Jun 12 17:48:32.043390 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO no_proxy: Jun 12 17:48:32.043390 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO Checking if agent identity type OnPrem can be assumed Jun 12 17:48:32.043390 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO Checking if agent identity type EC2 can be assumed Jun 12 17:48:32.043390 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO Agent will take identity from EC2 Jun 12 17:48:32.043390 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] using named pipe channel for IPC Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] OS: linux, Arch: amd64 Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] Starting Core Agent Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [amazon-ssm-agent] registrar detected. Attempting registration Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [Registrar] Starting registrar module Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:31 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:32 INFO [EC2Identity] EC2 registration was successful. Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:32 INFO [CredentialRefresher] credentialRefresher has started Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:32 INFO [CredentialRefresher] Starting credentials refresher loop Jun 12 17:48:32.043656 amazon-ssm-agent[2162]: 2026-06-12 17:48:32 INFO EC2RoleProvider Successfully connected with instance profile role credentials Jun 12 17:48:32.071311 amazon-ssm-agent[2162]: 2026-06-12 17:48:32 INFO [CredentialRefresher] Next credential rotation will be in 31.658325967683332 minutes Jun 12 17:48:33.058904 amazon-ssm-agent[2162]: 2026-06-12 17:48:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Jun 12 17:48:33.162188 amazon-ssm-agent[2162]: 2026-06-12 17:48:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2181) started Jun 12 17:48:33.262881 amazon-ssm-agent[2162]: 2026-06-12 17:48:33 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Jun 12 17:48:33.500488 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 12 17:48:33.502691 systemd[1]: Reached target multi-user.target - Multi-User System. Jun 12 17:48:33.504737 systemd[1]: Startup finished in 611ms (kernel) + 5.733s (initrd) + 7.115s (userspace) = 13.460s. Jun 12 17:48:33.507842 (kubelet)[2196]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jun 12 17:48:34.300263 ntpd[1948]: Listen normally on 7 eth0 [fe80::4ad:55ff:fe97:bccd%2]:123 Jun 12 17:48:34.300747 ntpd[1948]: 12 Jun 17:48:34 ntpd[1948]: Listen normally on 7 eth0 [fe80::4ad:55ff:fe97:bccd%2]:123 Jun 12 17:48:34.399268 kubelet[2196]: E0612 17:48:34.399174 2196 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" Jun 12 17:48:34.401887 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jun 12 17:48:34.402116 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jun 12 17:48:34.402713 systemd[1]: kubelet.service: Consumed 1.045s CPU time. Jun 12 17:48:35.959139 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jun 12 17:48:35.965542 systemd[1]: Started sshd@0-172.31.16.193:22-4.175.71.9:33838.service - OpenSSH per-connection server daemon (4.175.71.9:33838). Jun 12 17:48:36.944519 sshd[2208]: Accepted publickey for core from 4.175.71.9 port 33838 ssh2: RSA SHA256:dXLdH26f0UAeqcN2EM1LjQljrpX24/bRa2Gx4QjOWZQ Jun 12 17:48:36.946194 sshd[2208]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 12 17:48:36.958512 systemd-logind[1957]: New session 1 of user core. Jun 12 17:48:36.960645 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jun 12 17:48:36.968300 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jun 12 17:48:36.982829 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jun 12 17:48:36.992464 systemd[1]: Starting user@500.service - User Manager for UID 500... Jun 12 17:48:36.996749 (systemd)[2212]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jun 12 17:48:37.118276 systemd[2212]: Queued start job for default target default.target. Jun 12 17:48:37.129634 systemd[2212]: Created slice app.slice - User Application Slice. Jun 12 17:48:37.129681 systemd[2212]: Reached target paths.target - Paths. Jun 12 17:48:37.129704 systemd[2212]: Reached target timers.target - Timers. Jun 12 17:48:37.131218 systemd[2212]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 12 17:48:37.144071 systemd[2212]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 12 17:48:37.144256 systemd[2212]: Reached target sockets.target - Sockets. Jun 12 17:48:37.144278 systemd[2212]: Reached target basic.target - Basic System. Jun 12 17:48:37.144329 systemd[2212]: Reached target default.target - Main User Target. Jun 12 17:48:37.144366 systemd[2212]: Startup finished in 140ms. Jun 12 17:48:37.144952 systemd[1]: Started user@500.service - User Manager for UID 500. Jun 12 17:48:37.157509 systemd[1]: Started session-1.scope - Session 1 of User core. Jun 12 17:48:39.110692 systemd-resolved[1884]: Clock change detected. Flushing caches. Jun 12 17:48:39.656814 systemd[1]: Started sshd@1-172.31.16.193:22-4.175.71.9:33852.service - OpenSSH per-connection server daemon (4.175.71.9:33852). Jun 12 17:48:40.624205 sshd[2223]: Accepted publickey for core from 4.175.71.9 port 33852 ssh2: RSA SHA256:dXLdH26f0UAeqcN2EM1LjQljrpX24/bRa2Gx4QjOWZQ Jun 12 17:48:40.625706 sshd[2223]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 12 17:48:40.630820 systemd-logind[1957]: New session 2 of user core. Jun 12 17:48:40.637639 systemd[1]: Started session-2.scope - Session 2 of User core. Jun 12 17:48:41.298639 sshd[2223]: pam_unix(sshd:session): session closed for user core Jun 12 17:48:41.302101 systemd[1]: sshd@1-172.31.16.193:22-4.175.71.9:33852.service: Deactivated successfully. Jun 12 17:48:41.304163 systemd[1]: session-2.scope: Deactivated successfully. Jun 12 17:48:41.305858 systemd-logind[1957]: Session 2 logged out. Waiting for processes to exit. Jun 12 17:48:41.306974 systemd-logind[1957]: Removed session 2. Jun 12 17:48:41.474769 systemd[1]: Started sshd@2-172.31.16.193:22-4.175.71.9:36338.service - OpenSSH per-connection server daemon (4.175.71.9:36338). Jun 12 17:48:42.451618 sshd[2230]: Accepted publickey for core from 4.175.71.9 port 36338 ssh2: RSA SHA256:dXLdH26f0UAeqcN2EM1LjQljrpX24/bRa2Gx4QjOWZQ Jun 12 17:48:42.453035 sshd[2230]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 12 17:48:42.457794 systemd-logind[1957]: New session 3 of user core. Jun 12 17:48:42.465681 systemd[1]: Started session-3.scope - Session 3 of User core. Jun 12 17:48:43.123666 sshd[2230]: pam_unix(sshd:session): session closed for user core Jun 12 17:48:43.127789 systemd-logind[1957]: Session 3 logged out. Waiting for processes to exit. Jun 12 17:48:43.128656 systemd[1]: sshd@2-172.31.16.193:22-4.175.71.9:36338.service: Deactivated successfully. Jun 12 17:48:43.130651 systemd[1]: session-3.scope: Deactivated successfully. Jun 12 17:48:43.131724 systemd-logind[1957]: Removed session 3. Jun 12 17:48:43.294769 systemd[1]: Started sshd@3-172.31.16.193:22-4.175.71.9:36354.service - OpenSSH per-connection server daemon (4.175.71.9:36354). Jun 12 17:48:44.266607 sshd[2237]: Accepted publickey for core from 4.175.71.9 port 36354 ssh2: RSA SHA256:dXLdH26f0UAeqcN2EM1LjQljrpX24/bRa2Gx4QjOWZQ Jun 12 17:48:44.268264 sshd[2237]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 12 17:48:44.273467 systemd-logind[1957]: New session 4 of user core. Jun 12 17:48:44.281761 systemd[1]: Started session-4.scope - Session 4 of User core. Jun 12 17:48:44.945794 sshd[2237]: pam_unix(sshd:session): session closed for user core Jun 12 17:48:44.950371 systemd[1]: sshd@3-172.31.16.193:22-4.175.71.9:36354.service: Deactivated successfully. Jun 12 17:48:44.952665 systemd[1]: session-4.scope: Deactivated successfully. Jun 12 17:48:44.953385 systemd-logind[1957]: Session 4 logged out. Waiting for processes to exit. Jun 12 17:48:44.954453 systemd-logind[1957]: Removed session 4. Jun 12 17:48:45.116820 systemd[1]: Started sshd@4-172.31.16.193:22-4.175.71.9:36356.service - OpenSSH per-connection server daemon (4.175.71.9:36356). Jun 12 17:48:46.094462 sshd[2244]: Accepted publickey for core from 4.175.71.9 port 36356 ssh2: RSA SHA256:dXLdH26f0UAeqcN2EM1LjQljrpX24/bRa2Gx4QjOWZQ Jun 12 17:48:46.095703 sshd[2244]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jun 12 17:48:46.101031 systemd-logind[1957]: New session 5 of user core. Jun 12 17:48:46.106661 systemd[1]: Started session-5.scope - Session 5 of User core. Jun 12 17:48:46.262016 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 1. Jun 12 17:48:46.267704 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 12 17:48:46.470734 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 12 17:48:46.476345 (kubelet)[2255]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jun 12 17:48:46.521673 kubelet[2255]: E0612 17:48:46.521618 2255 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" Jun 12 17:48:46.524788 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jun 12 17:48:46.524922 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jun 12 17:48:46.626316 sudo[2262]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jun 12 17:48:46.626771 sudo[2262]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jun 12 17:48:47.658196 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 12 17:48:47.672549 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 12 17:48:47.715261 systemd[1]: Reloading requested from client PID 2300 ('systemctl') (unit session-5.scope)... Jun 12 17:48:47.715283 systemd[1]: Reloading... Jun 12 17:48:47.852560 zram_generator::config[2340]: No configuration found. Jun 12 17:48:47.997933 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. Jun 12 17:48:48.085977 systemd[1]: Reloading finished in 370 ms. Jun 12 17:48:48.140475 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jun 12 17:48:48.140555 systemd[1]: kubelet.service: Failed with result 'signal'. Jun 12 17:48:48.140749 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jun 12 17:48:48.144584 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jun 12 17:48:48.365263 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jun 12 17:48:48.376870 (kubelet)[2403]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jun 12 17:48:48.424096 kubelet[2403]: 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. Jun 12 17:48:48.607459 kubelet[2403]: I0612 17:48:48.606401 2403 server.go:545] "Kubelet version" kubeletVersion="v1.36.1" Jun 12 17:48:48.607459 kubelet[2403]: I0612 17:48:48.606493 2403 server.go:547] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jun 12 17:48:48.608581 kubelet[2403]: I0612 17:48:48.608554 2403 watchdog_linux.go:94] "Systemd watchdog is not enabled" Jun 12 17:48:48.608684 kubelet[2403]: I0612 17:48:48.608595 2403 watchdog_linux.go:137] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jun 12 17:48:48.609763 kubelet[2403]: I0612 17:48:48.609741 2403 server.go:985] "Client rotation is on, will bootstrap in background" Jun 12 17:48:48.614904 kubelet[2403]: I0612 17:48:48.614866 2403 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jun 12 17:48:48.618444 kubelet[2403]: E0612 17:48:48.618290 2403 remote_runtime.go:1177] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Jun 12 17:48:48.618444 kubelet[2403]: I0612 17:48:48.618345 2403 server.go:1425] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Jun 12 17:48:48.623937 kubelet[2403]: I0612 17:48:48.623899 2403 server.go:808] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Jun 12 17:48:48.628795 kubelet[2403]: I0612 17:48:48.628739 2403 container_manager_linux.go:273] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jun 12 17:48:48.628981 kubelet[2403]: I0612 17:48:48.628789 2403 container_manager_linux.go:278] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"172.31.16.193","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"MemoryReservationPolicy":"None","PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Jun 12 17:48:48.629111 kubelet[2403]: I0612 17:48:48.628982 2403 topology_manager.go:172] "Creating topology manager with none policy" Jun 12 17:48:48.629111 kubelet[2403]: I0612 17:48:48.628996 2403 container_manager_linux.go:309] "Creating device plugin manager" Jun 12 17:48:48.629201 kubelet[2403]: I0612 17:48:48.629115 2403 container_manager_linux.go:318] "Creating Dynamic Resource Allocation (DRA) manager" Jun 12 17:48:48.634548 kubelet[2403]: I0612 17:48:48.634518 2403 state_mem.go:45] "Initialized" logger="CPUManager state memory" Jun 12 17:48:48.634757 kubelet[2403]: I0612 17:48:48.634727 2403 kubelet.go:485] "Attempting to sync node with API server" Jun 12 17:48:48.634757 kubelet[2403]: I0612 17:48:48.634755 2403 kubelet.go:386] "Adding static pod path" path="/etc/kubernetes/manifests" Jun 12 17:48:48.634855 kubelet[2403]: I0612 17:48:48.634778 2403 kubelet.go:397] "Adding apiserver pod source" Jun 12 17:48:48.634855 kubelet[2403]: I0612 17:48:48.634789 2403 apiserver.go:41] "Waiting for node sync before watching apiserver pods" Jun 12 17:48:48.638271 kubelet[2403]: E0612 17:48:48.638178 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:48.638375 kubelet[2403]: I0612 17:48:48.638334 2403 kuberuntime_manager.go:308] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Jun 12 17:48:48.639795 kubelet[2403]: E0612 17:48:48.639666 2403 file.go:97] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:48.640014 kubelet[2403]: I0612 17:48:48.639949 2403 kubelet.go:1002] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Jun 12 17:48:48.640014 kubelet[2403]: I0612 17:48:48.640011 2403 kubelet.go:1029] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Jun 12 17:48:48.640125 kubelet[2403]: W0612 17:48:48.640073 2403 probe.go:275] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jun 12 17:48:48.644674 kubelet[2403]: I0612 17:48:48.644507 2403 server.go:1285] "Started kubelet" Jun 12 17:48:48.650984 kubelet[2403]: I0612 17:48:48.650834 2403 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Jun 12 17:48:48.660391 kubelet[2403]: I0612 17:48:48.660301 2403 server.go:193] "Starting to listen" address="0.0.0.0" port=10250 Jun 12 17:48:48.663928 kubelet[2403]: I0612 17:48:48.663274 2403 volume_manager.go:310] "Starting Kubelet Volume Manager" Jun 12 17:48:48.663928 kubelet[2403]: E0612 17:48:48.663838 2403 kubelet_node_status.go:396] "Error getting the current node from lister" err="node \"172.31.16.193\" not found" Jun 12 17:48:48.664885 kubelet[2403]: E0612 17:48:48.664851 2403 kubelet.go:3516] "Unable to register mirror pod because node is not registered yet" err="node \"172.31.16.193\" not found" node="172.31.16.193" Jun 12 17:48:48.665076 kubelet[2403]: I0612 17:48:48.664963 2403 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Jun 12 17:48:48.665166 kubelet[2403]: I0612 17:48:48.665153 2403 server.go:354] "Adding debug handlers to kubelet server" Jun 12 17:48:48.665234 kubelet[2403]: I0612 17:48:48.665218 2403 reconciler.go:29] "Reconciler: start to sync state" Jun 12 17:48:48.672535 kubelet[2403]: I0612 17:48:48.672380 2403 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jun 12 17:48:48.672673 kubelet[2403]: I0612 17:48:48.672561 2403 server_v1.go:49] "podresources" method="list" useActivePods=true Jun 12 17:48:48.674743 kubelet[2403]: I0612 17:48:48.674708 2403 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jun 12 17:48:48.675260 kubelet[2403]: I0612 17:48:48.675239 2403 tlsconfig.go:243] "Starting DynamicServingCertificateController" Jun 12 17:48:48.675577 kubelet[2403]: I0612 17:48:48.675539 2403 factory.go:222] Registration of the systemd container factory successfully Jun 12 17:48:48.675725 kubelet[2403]: I0612 17:48:48.675702 2403 factory.go:220] 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 Jun 12 17:48:48.686593 kubelet[2403]: E0612 17:48:48.685989 2403 kubelet.go:1725] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jun 12 17:48:48.687513 kubelet[2403]: I0612 17:48:48.687034 2403 server.go:264] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jun 12 17:48:48.687513 kubelet[2403]: E0612 17:48:48.687175 2403 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"172.31.16.193\" not found" node="172.31.16.193" Jun 12 17:48:48.688423 kubelet[2403]: I0612 17:48:48.687944 2403 factory.go:222] Registration of the containerd container factory successfully Jun 12 17:48:48.705755 kubelet[2403]: I0612 17:48:48.705733 2403 cpu_manager.go:235] "Starting" policy="none" Jun 12 17:48:48.706420 kubelet[2403]: I0612 17:48:48.706390 2403 cpu_manager.go:236] "Reconciling" reconcilePeriod="10s" Jun 12 17:48:48.706584 kubelet[2403]: I0612 17:48:48.706572 2403 state_mem.go:45] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Jun 12 17:48:48.712859 kubelet[2403]: I0612 17:48:48.712831 2403 policy_none.go:50] "Start" Jun 12 17:48:48.713119 kubelet[2403]: I0612 17:48:48.713097 2403 memory_manager.go:190] "Starting memorymanager" policy="None" Jun 12 17:48:48.713232 kubelet[2403]: I0612 17:48:48.713219 2403 state_mem.go:40] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Jun 12 17:48:48.718676 kubelet[2403]: I0612 17:48:48.718539 2403 policy_none.go:44] "Start" Jun 12 17:48:48.725185 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jun 12 17:48:48.737615 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jun 12 17:48:48.744549 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jun 12 17:48:48.753881 kubelet[2403]: E0612 17:48:48.753693 2403 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Jun 12 17:48:48.753992 kubelet[2403]: I0612 17:48:48.753931 2403 eviction_manager.go:194] "Eviction manager: starting control loop" Jun 12 17:48:48.753992 kubelet[2403]: I0612 17:48:48.753943 2403 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jun 12 17:48:48.756621 kubelet[2403]: I0612 17:48:48.756042 2403 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Jun 12 17:48:48.759012 kubelet[2403]: E0612 17:48:48.758733 2403 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jun 12 17:48:48.759012 kubelet[2403]: E0612 17:48:48.758988 2403 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"172.31.16.193\" not found" Jun 12 17:48:48.766289 kubelet[2403]: E0612 17:48:48.765747 2403 kubelet.go:3516] "Unable to register mirror pod because node is not registered yet" err="node \"172.31.16.193\" not found" node="172.31.16.193" Jun 12 17:48:48.766400 kubelet[2403]: I0612 17:48:48.766332 2403 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv4" Jun 12 17:48:48.769556 kubelet[2403]: I0612 17:48:48.768796 2403 kubelet_network_linux.go:53] "Initialized iptables rules." protocol="IPv6" Jun 12 17:48:48.769556 kubelet[2403]: I0612 17:48:48.768828 2403 status_manager.go:277] "Starting to sync pod status with apiserver" Jun 12 17:48:48.769556 kubelet[2403]: I0612 17:48:48.768862 2403 kubelet.go:2622] "Starting kubelet main sync loop" Jun 12 17:48:48.769556 kubelet[2403]: E0612 17:48:48.768925 2403 kubelet.go:2646] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jun 12 17:48:48.855771 kubelet[2403]: I0612 17:48:48.855735 2403 kubelet_node_status.go:75] "Attempting to register node" node="172.31.16.193" Jun 12 17:48:48.864926 kubelet[2403]: E0612 17:48:48.864873 2403 kubelet.go:3516] "Unable to register mirror pod because node is not registered yet" err="node \"172.31.16.193\" not found" node="172.31.16.193" Jun 12 17:48:48.867545 kubelet[2403]: I0612 17:48:48.867509 2403 kubelet_node_status.go:78] "Successfully registered node" node="172.31.16.193" Jun 12 17:48:48.895259 sudo[2262]: pam_unix(sudo:session): session closed for user root Jun 12 17:48:48.981959 kubelet[2403]: I0612 17:48:48.981922 2403 kuberuntime_manager.go:2146] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jun 12 17:48:48.982347 containerd[1981]: time="2026-06-12T17:48:48.982300617Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jun 12 17:48:48.982870 kubelet[2403]: I0612 17:48:48.982844 2403 kubelet_network.go:48] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jun 12 17:48:49.053854 sshd[2244]: pam_unix(sshd:session): session closed for user core Jun 12 17:48:49.057698 systemd[1]: sshd@4-172.31.16.193:22-4.175.71.9:36356.service: Deactivated successfully. Jun 12 17:48:49.060295 systemd[1]: session-5.scope: Deactivated successfully. Jun 12 17:48:49.062047 systemd-logind[1957]: Session 5 logged out. Waiting for processes to exit. Jun 12 17:48:49.063927 systemd-logind[1957]: Removed session 5. Jun 12 17:48:49.612211 kubelet[2403]: I0612 17:48:49.612135 2403 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jun 12 17:48:49.612944 kubelet[2403]: I0612 17:48:49.612336 2403 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Jun 12 17:48:49.612944 kubelet[2403]: I0612 17:48:49.612397 2403 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Jun 12 17:48:49.612944 kubelet[2403]: I0612 17:48:49.612453 2403 reflector.go:664] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:177" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:177: Unexpected watch close - watch lasted less than a second and no items received" Jun 12 17:48:49.637466 kubelet[2403]: I0612 17:48:49.637402 2403 apiserver.go:51] "Watching apiserver" Jun 12 17:48:49.638513 kubelet[2403]: E0612 17:48:49.638472 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:49.658728 systemd[1]: Created slice kubepods-burstable-pod86220cab_4530_462c_a436_f0af75c5fa0b.slice - libcontainer container kubepods-burstable-pod86220cab_4530_462c_a436_f0af75c5fa0b.slice. Jun 12 17:48:49.665286 kubelet[2403]: I0612 17:48:49.665243 2403 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Jun 12 17:48:49.671909 kubelet[2403]: I0612 17:48:49.671863 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/4880b269-6644-44a4-85e6-b7b374fcf953-lib-modules\") pod \"kube-proxy-jzsnf\" (UID: \"4880b269-6644-44a4-85e6-b7b374fcf953\") " pod="kube-system/kube-proxy-jzsnf" Jun 12 17:48:49.671909 kubelet[2403]: I0612 17:48:49.671903 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hljfz\" (UniqueName: \"kubernetes.io/projected/4880b269-6644-44a4-85e6-b7b374fcf953-kube-api-access-hljfz\") pod \"kube-proxy-jzsnf\" (UID: \"4880b269-6644-44a4-85e6-b7b374fcf953\") " pod="kube-system/kube-proxy-jzsnf" Jun 12 17:48:49.672090 kubelet[2403]: I0612 17:48:49.671929 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/86220cab-4530-462c-a436-f0af75c5fa0b-run\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672090 kubelet[2403]: I0612 17:48:49.671966 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/86220cab-4530-462c-a436-f0af75c5fa0b-cni-plugin\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672090 kubelet[2403]: I0612 17:48:49.671988 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/86220cab-4530-462c-a436-f0af75c5fa0b-cni\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672090 kubelet[2403]: I0612 17:48:49.672008 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/86220cab-4530-462c-a436-f0af75c5fa0b-flannel-cfg\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672090 kubelet[2403]: I0612 17:48:49.672078 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/86220cab-4530-462c-a436-f0af75c5fa0b-xtables-lock\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672318 kubelet[2403]: I0612 17:48:49.672102 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/4880b269-6644-44a4-85e6-b7b374fcf953-xtables-lock\") pod \"kube-proxy-jzsnf\" (UID: \"4880b269-6644-44a4-85e6-b7b374fcf953\") " pod="kube-system/kube-proxy-jzsnf" Jun 12 17:48:49.672318 kubelet[2403]: I0612 17:48:49.672126 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-vgghn\" (UniqueName: \"kubernetes.io/projected/86220cab-4530-462c-a436-f0af75c5fa0b-kube-api-access-vgghn\") pod \"kube-flannel-ds-7wz6g\" (UID: \"86220cab-4530-462c-a436-f0af75c5fa0b\") " pod="kube-flannel/kube-flannel-ds-7wz6g" Jun 12 17:48:49.672318 kubelet[2403]: I0612 17:48:49.672149 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/4880b269-6644-44a4-85e6-b7b374fcf953-kube-proxy\") pod \"kube-proxy-jzsnf\" (UID: \"4880b269-6644-44a4-85e6-b7b374fcf953\") " pod="kube-system/kube-proxy-jzsnf" Jun 12 17:48:49.682244 systemd[1]: Created slice kubepods-besteffort-pod4880b269_6644_44a4_85e6_b7b374fcf953.slice - libcontainer container kubepods-besteffort-pod4880b269_6644_44a4_85e6_b7b374fcf953.slice. Jun 12 17:48:49.983045 containerd[1981]: time="2026-06-12T17:48:49.982912229Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-7wz6g,Uid:86220cab-4530-462c-a436-f0af75c5fa0b,Namespace:kube-flannel,Attempt:0,}" Jun 12 17:48:49.995039 containerd[1981]: time="2026-06-12T17:48:49.994997408Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-jzsnf,Uid:4880b269-6644-44a4-85e6-b7b374fcf953,Namespace:kube-system,Attempt:0,}" Jun 12 17:48:50.594567 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3241358113.mount: Deactivated successfully. Jun 12 17:48:50.612647 containerd[1981]: time="2026-06-12T17:48:50.612595146Z" 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\"}" Jun 12 17:48:50.614636 containerd[1981]: time="2026-06-12T17:48:50.614593131Z" 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\"}" Jun 12 17:48:50.616546 containerd[1981]: time="2026-06-12T17:48:50.616468576Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312056" Jun 12 17:48:50.618775 containerd[1981]: time="2026-06-12T17:48:50.618737667Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Jun 12 17:48:50.621164 containerd[1981]: time="2026-06-12T17:48:50.620890183Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jun 12 17:48:50.624806 containerd[1981]: time="2026-06-12T17:48:50.624617290Z" 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\"}" Jun 12 17:48:50.626396 containerd[1981]: time="2026-06-12T17:48:50.625575128Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 630.496382ms" Jun 12 17:48:50.627941 containerd[1981]: time="2026-06-12T17:48:50.627905366Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 644.899365ms" Jun 12 17:48:50.638816 kubelet[2403]: E0612 17:48:50.638737 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:50.796276 containerd[1981]: time="2026-06-12T17:48:50.795913219Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 12 17:48:50.796276 containerd[1981]: time="2026-06-12T17:48:50.796020235Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 12 17:48:50.796276 containerd[1981]: time="2026-06-12T17:48:50.796044313Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:48:50.796276 containerd[1981]: time="2026-06-12T17:48:50.796179161Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:48:50.808339 containerd[1981]: time="2026-06-12T17:48:50.806263359Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 12 17:48:50.808339 containerd[1981]: time="2026-06-12T17:48:50.806328668Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 12 17:48:50.808339 containerd[1981]: time="2026-06-12T17:48:50.806346273Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:48:50.808339 containerd[1981]: time="2026-06-12T17:48:50.806463230Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:48:50.906676 systemd[1]: Started cri-containerd-1d01acbae47252ec93edcd860953fcc49c96727af6d8684166f2320ead0f44ac.scope - libcontainer container 1d01acbae47252ec93edcd860953fcc49c96727af6d8684166f2320ead0f44ac. Jun 12 17:48:50.909665 systemd[1]: Started cri-containerd-4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1.scope - libcontainer container 4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1. Jun 12 17:48:50.947699 containerd[1981]: time="2026-06-12T17:48:50.947658199Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-jzsnf,Uid:4880b269-6644-44a4-85e6-b7b374fcf953,Namespace:kube-system,Attempt:0,} returns sandbox id \"1d01acbae47252ec93edcd860953fcc49c96727af6d8684166f2320ead0f44ac\"" Jun 12 17:48:50.953367 containerd[1981]: time="2026-06-12T17:48:50.953329489Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.36.2\"" Jun 12 17:48:50.978470 containerd[1981]: time="2026-06-12T17:48:50.978355475Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-7wz6g,Uid:86220cab-4530-462c-a436-f0af75c5fa0b,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\"" Jun 12 17:48:51.639883 kubelet[2403]: E0612 17:48:51.639687 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:52.113283 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3117484424.mount: Deactivated successfully. Jun 12 17:48:52.615210 containerd[1981]: time="2026-06-12T17:48:52.615142913Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.36.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:52.617167 containerd[1981]: time="2026-06-12T17:48:52.617007877Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.36.2: active requests=0, bytes read=28883117" Jun 12 17:48:52.619522 containerd[1981]: time="2026-06-12T17:48:52.619474901Z" level=info msg="ImageCreate event name:\"sha256:73c5cda3fae3b022050f91743f376ab416ec2cc922d1daf9d1a21d619e4d2169\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:52.623178 containerd[1981]: time="2026-06-12T17:48:52.623104320Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:620a27c742eb5ebf5be8613b7458b7ce7cd31e2804b61b98f6516e328002c4cc\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:52.624552 containerd[1981]: time="2026-06-12T17:48:52.623965841Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.36.2\" with image id \"sha256:73c5cda3fae3b022050f91743f376ab416ec2cc922d1daf9d1a21d619e4d2169\", repo tag \"registry.k8s.io/kube-proxy:v1.36.2\", repo digest \"registry.k8s.io/kube-proxy@sha256:620a27c742eb5ebf5be8613b7458b7ce7cd31e2804b61b98f6516e328002c4cc\", size \"28881935\" in 1.670449586s" Jun 12 17:48:52.624552 containerd[1981]: time="2026-06-12T17:48:52.624006510Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.36.2\" returns image reference \"sha256:73c5cda3fae3b022050f91743f376ab416ec2cc922d1daf9d1a21d619e4d2169\"" Jun 12 17:48:52.625834 containerd[1981]: time="2026-06-12T17:48:52.625805903Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Jun 12 17:48:52.630932 containerd[1981]: time="2026-06-12T17:48:52.630894574Z" level=info msg="CreateContainer within sandbox \"1d01acbae47252ec93edcd860953fcc49c96727af6d8684166f2320ead0f44ac\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jun 12 17:48:52.640824 kubelet[2403]: E0612 17:48:52.640764 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:52.663698 containerd[1981]: time="2026-06-12T17:48:52.663655777Z" level=info msg="CreateContainer within sandbox \"1d01acbae47252ec93edcd860953fcc49c96727af6d8684166f2320ead0f44ac\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"d99282a280bcb25a0dc783363e9f5f6ebbd21da1da3a88240096ecf5e0f9eb80\"" Jun 12 17:48:52.664652 containerd[1981]: time="2026-06-12T17:48:52.664616709Z" level=info msg="StartContainer for \"d99282a280bcb25a0dc783363e9f5f6ebbd21da1da3a88240096ecf5e0f9eb80\"" Jun 12 17:48:52.704681 systemd[1]: Started cri-containerd-d99282a280bcb25a0dc783363e9f5f6ebbd21da1da3a88240096ecf5e0f9eb80.scope - libcontainer container d99282a280bcb25a0dc783363e9f5f6ebbd21da1da3a88240096ecf5e0f9eb80. Jun 12 17:48:52.738677 containerd[1981]: time="2026-06-12T17:48:52.738634191Z" level=info msg="StartContainer for \"d99282a280bcb25a0dc783363e9f5f6ebbd21da1da3a88240096ecf5e0f9eb80\" returns successfully" Jun 12 17:48:53.641657 kubelet[2403]: E0612 17:48:53.641610 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:54.189102 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2630180783.mount: Deactivated successfully. Jun 12 17:48:54.280558 containerd[1981]: time="2026-06-12T17:48:54.280506527Z" 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\"}" Jun 12 17:48:54.285448 containerd[1981]: time="2026-06-12T17:48:54.284452870Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Jun 12 17:48:54.289072 containerd[1981]: time="2026-06-12T17:48:54.288219517Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:54.292525 containerd[1981]: time="2026-06-12T17:48:54.292443003Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:54.293994 containerd[1981]: time="2026-06-12T17:48:54.293706068Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\", 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 \"4856838\" in 1.667858348s" Jun 12 17:48:54.293994 containerd[1981]: time="2026-06-12T17:48:54.293754569Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Jun 12 17:48:54.300788 containerd[1981]: time="2026-06-12T17:48:54.300724050Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jun 12 17:48:54.326957 containerd[1981]: time="2026-06-12T17:48:54.326906027Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2\"" Jun 12 17:48:54.327996 containerd[1981]: time="2026-06-12T17:48:54.327774723Z" level=info msg="StartContainer for \"fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2\"" Jun 12 17:48:54.362647 systemd[1]: Started cri-containerd-fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2.scope - libcontainer container fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2. Jun 12 17:48:54.390856 systemd[1]: cri-containerd-fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2.scope: Deactivated successfully. Jun 12 17:48:54.394037 containerd[1981]: time="2026-06-12T17:48:54.393959420Z" level=info msg="StartContainer for \"fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2\" returns successfully" Jun 12 17:48:54.414951 kubelet[2403]: I0612 17:48:54.414766 2403 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="kube-system/kube-proxy-jzsnf" podStartSLOduration=4.742593926 podStartE2EDuration="6.414752221s" totalImagesPullingTime="1.672158295s" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-06-12 17:48:48 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-06-12 17:48:52.756566777 +0000 UTC m=+4.374246591" watchObservedRunningTime="2026-06-12 17:48:54.414752221 +0000 UTC m=+6.032432031" Jun 12 17:48:54.461048 containerd[1981]: time="2026-06-12T17:48:54.460877670Z" level=info msg="shim disconnected" id=fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2 namespace=k8s.io Jun 12 17:48:54.461048 containerd[1981]: time="2026-06-12T17:48:54.460940848Z" level=warning msg="cleaning up after shim disconnected" id=fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2 namespace=k8s.io Jun 12 17:48:54.461048 containerd[1981]: time="2026-06-12T17:48:54.460952589Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jun 12 17:48:54.641968 kubelet[2403]: E0612 17:48:54.641905 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:54.785855 containerd[1981]: time="2026-06-12T17:48:54.785809708Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Jun 12 17:48:55.064534 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-fbc968ef2526ffde78e64793dbbf74de6e4c30211301bff3885ed2058f6c09c2-rootfs.mount: Deactivated successfully. Jun 12 17:48:55.642267 kubelet[2403]: E0612 17:48:55.642226 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:56.642828 kubelet[2403]: E0612 17:48:56.642788 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:57.172357 containerd[1981]: time="2026-06-12T17:48:57.171670896Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:57.173804 containerd[1981]: time="2026-06-12T17:48:57.173754900Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Jun 12 17:48:57.176301 containerd[1981]: time="2026-06-12T17:48:57.176009734Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:57.180812 containerd[1981]: time="2026-06-12T17:48:57.180741918Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:48:57.182424 containerd[1981]: time="2026-06-12T17:48:57.182251625Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32996046\" in 2.39639652s" Jun 12 17:48:57.182424 containerd[1981]: time="2026-06-12T17:48:57.182299763Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Jun 12 17:48:57.189712 containerd[1981]: time="2026-06-12T17:48:57.189668616Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jun 12 17:48:57.212820 containerd[1981]: time="2026-06-12T17:48:57.212766211Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035\"" Jun 12 17:48:57.213533 containerd[1981]: time="2026-06-12T17:48:57.213499308Z" level=info msg="StartContainer for \"92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035\"" Jun 12 17:48:57.249641 systemd[1]: Started cri-containerd-92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035.scope - libcontainer container 92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035. Jun 12 17:48:57.277900 systemd[1]: cri-containerd-92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035.scope: Deactivated successfully. Jun 12 17:48:57.281025 containerd[1981]: time="2026-06-12T17:48:57.280924102Z" level=info msg="StartContainer for \"92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035\" returns successfully" Jun 12 17:48:57.304199 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035-rootfs.mount: Deactivated successfully. Jun 12 17:48:57.378198 kubelet[2403]: I0612 17:48:57.378166 2403 kubelet_node_status.go:431] "Fast updating node status as it just became ready" Jun 12 17:48:57.397382 containerd[1981]: time="2026-06-12T17:48:57.397281686Z" level=info msg="shim disconnected" id=92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035 namespace=k8s.io Jun 12 17:48:57.397382 containerd[1981]: time="2026-06-12T17:48:57.397354086Z" level=warning msg="cleaning up after shim disconnected" id=92b52866ad42d14d5c197b6d6e7d9e04a94f22f96d956d77a784a0bbee719035 namespace=k8s.io Jun 12 17:48:57.397382 containerd[1981]: time="2026-06-12T17:48:57.397367622Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jun 12 17:48:57.643959 kubelet[2403]: E0612 17:48:57.643906 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:57.797948 containerd[1981]: time="2026-06-12T17:48:57.797905625Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jun 12 17:48:57.824629 containerd[1981]: time="2026-06-12T17:48:57.824580107Z" level=info msg="CreateContainer within sandbox \"4e40d81c4b26c4832d4279b1a7ef3325b97be503551b00e3865740de48b0bcd1\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"ef1780289d53e6bfc6aabe08e1400d5e2843f6b05478f1054740c75605950991\"" Jun 12 17:48:57.825499 containerd[1981]: time="2026-06-12T17:48:57.825464788Z" level=info msg="StartContainer for \"ef1780289d53e6bfc6aabe08e1400d5e2843f6b05478f1054740c75605950991\"" Jun 12 17:48:57.853657 systemd[1]: Started cri-containerd-ef1780289d53e6bfc6aabe08e1400d5e2843f6b05478f1054740c75605950991.scope - libcontainer container ef1780289d53e6bfc6aabe08e1400d5e2843f6b05478f1054740c75605950991. Jun 12 17:48:57.882855 containerd[1981]: time="2026-06-12T17:48:57.882711207Z" level=info msg="StartContainer for \"ef1780289d53e6bfc6aabe08e1400d5e2843f6b05478f1054740c75605950991\" returns successfully" Jun 12 17:48:58.204424 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2139994307.mount: Deactivated successfully. Jun 12 17:48:58.644634 kubelet[2403]: E0612 17:48:58.644577 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:58.941142 (udev-worker)[2914]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:48:58.953064 systemd-networkd[1883]: flannel.1: Link UP Jun 12 17:48:58.953078 systemd-networkd[1883]: flannel.1: Gained carrier Jun 12 17:48:59.645021 kubelet[2403]: E0612 17:48:59.644955 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:48:59.765591 kubelet[2403]: I0612 17:48:59.765520 2403 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-7wz6g" podStartSLOduration=6.052155864 podStartE2EDuration="11.765498018s" totalImagesPullingTime="5.713342154s" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-06-12 17:48:48 +0000 UTC" imagePullSessionsCount=2 imagePullSessionsStartsCount=0 observedRunningTime="2026-06-12 17:48:57.907541048 +0000 UTC m=+9.525220861" watchObservedRunningTime="2026-06-12 17:48:59.765498018 +0000 UTC m=+11.383177824" Jun 12 17:48:59.775928 systemd[1]: Created slice kubepods-besteffort-pod063af282_1425_4e6f_bdf2_0766206b2487.slice - libcontainer container kubepods-besteffort-pod063af282_1425_4e6f_bdf2_0766206b2487.slice. Jun 12 17:48:59.845129 kubelet[2403]: I0612 17:48:59.845084 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rd645\" (UniqueName: \"kubernetes.io/projected/063af282-1425-4e6f-bdf2-0766206b2487-kube-api-access-rd645\") pod \"nginx-deployment-85fb466b-jt6cw\" (UID: \"063af282-1425-4e6f-bdf2-0766206b2487\") " pod="default/nginx-deployment-85fb466b-jt6cw" Jun 12 17:49:00.083946 containerd[1981]: time="2026-06-12T17:49:00.083905050Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85fb466b-jt6cw,Uid:063af282-1425-4e6f-bdf2-0766206b2487,Namespace:default,Attempt:0,}" Jun 12 17:49:00.128019 systemd-networkd[1883]: cni0: Link UP Jun 12 17:49:00.128031 systemd-networkd[1883]: cni0: Gained carrier Jun 12 17:49:00.128356 systemd-networkd[1883]: cni0: Lost carrier Jun 12 17:49:00.141757 (udev-worker)[2986]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:49:00.146476 kernel: cni0: port 1(vethc1528953) entered blocking state Jun 12 17:49:00.146566 kernel: cni0: port 1(vethc1528953) entered disabled state Jun 12 17:49:00.146372 systemd-networkd[1883]: vethc1528953: Link UP Jun 12 17:49:00.148045 kernel: vethc1528953: entered allmulticast mode Jun 12 17:49:00.148119 kernel: vethc1528953: entered promiscuous mode Jun 12 17:49:00.150594 kernel: cni0: port 1(vethc1528953) entered blocking state Jun 12 17:49:00.150660 kernel: cni0: port 1(vethc1528953) entered forwarding state Jun 12 17:49:00.150687 kernel: cni0: port 1(vethc1528953) entered disabled state Jun 12 17:49:00.161643 kernel: cni0: port 1(vethc1528953) entered blocking state Jun 12 17:49:00.161739 kernel: cni0: port 1(vethc1528953) entered forwarding state Jun 12 17:49:00.161957 systemd-networkd[1883]: vethc1528953: Gained carrier Jun 12 17:49:00.162388 systemd-networkd[1883]: cni0: Gained carrier Jun 12 17:49:00.165429 containerd[1981]: 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)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Jun 12 17:49:00.165429 containerd[1981]: delegateAdd: netconf sent to delegate plugin: Jun 12 17:49:00.190648 containerd[1981]: {"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-06-12T17:49:00.190360447Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 12 17:49:00.190648 containerd[1981]: time="2026-06-12T17:49:00.190459356Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 12 17:49:00.190648 containerd[1981]: time="2026-06-12T17:49:00.190484140Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:00.190648 containerd[1981]: time="2026-06-12T17:49:00.190590135Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:00.219660 systemd[1]: Started cri-containerd-9cb9ba1526f82f2de4c1ff65da0d89adde8944b4d48a230f06d494bcbf6e8e0d.scope - libcontainer container 9cb9ba1526f82f2de4c1ff65da0d89adde8944b4d48a230f06d494bcbf6e8e0d. Jun 12 17:49:00.260380 containerd[1981]: time="2026-06-12T17:49:00.260333835Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85fb466b-jt6cw,Uid:063af282-1425-4e6f-bdf2-0766206b2487,Namespace:default,Attempt:0,} returns sandbox id \"9cb9ba1526f82f2de4c1ff65da0d89adde8944b4d48a230f06d494bcbf6e8e0d\"" Jun 12 17:49:00.262353 containerd[1981]: time="2026-06-12T17:49:00.262314679Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 12 17:49:00.645871 kubelet[2403]: E0612 17:49:00.645812 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:00.824697 systemd-networkd[1883]: flannel.1: Gained IPv6LL Jun 12 17:49:01.646817 kubelet[2403]: E0612 17:49:01.646608 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:01.784603 systemd-networkd[1883]: vethc1528953: Gained IPv6LL Jun 12 17:49:02.044118 systemd-networkd[1883]: cni0: Gained IPv6LL Jun 12 17:49:02.642650 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jun 12 17:49:02.648126 kubelet[2403]: E0612 17:49:02.648036 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:03.399285 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1609897538.mount: Deactivated successfully. Jun 12 17:49:03.648807 kubelet[2403]: E0612 17:49:03.648726 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:04.110893 ntpd[1948]: Listen normally on 8 flannel.1 192.168.1.0:123 Jun 12 17:49:04.110959 ntpd[1948]: Listen normally on 9 cni0 192.168.1.1:123 Jun 12 17:49:04.111446 ntpd[1948]: 12 Jun 17:49:04 ntpd[1948]: Listen normally on 8 flannel.1 192.168.1.0:123 Jun 12 17:49:04.111446 ntpd[1948]: 12 Jun 17:49:04 ntpd[1948]: Listen normally on 9 cni0 192.168.1.1:123 Jun 12 17:49:04.111446 ntpd[1948]: 12 Jun 17:49:04 ntpd[1948]: Listen normally on 10 flannel.1 [fe80::1cc7:44ff:fe3b:f419%3]:123 Jun 12 17:49:04.111446 ntpd[1948]: 12 Jun 17:49:04 ntpd[1948]: Listen normally on 11 cni0 [fe80::7cc5:51ff:fe7e:480e%4]:123 Jun 12 17:49:04.111446 ntpd[1948]: 12 Jun 17:49:04 ntpd[1948]: Listen normally on 12 vethc1528953 [fe80::6c75:37ff:fe39:f51e%5]:123 Jun 12 17:49:04.111019 ntpd[1948]: Listen normally on 10 flannel.1 [fe80::1cc7:44ff:fe3b:f419%3]:123 Jun 12 17:49:04.111078 ntpd[1948]: Listen normally on 11 cni0 [fe80::7cc5:51ff:fe7e:480e%4]:123 Jun 12 17:49:04.111126 ntpd[1948]: Listen normally on 12 vethc1528953 [fe80::6c75:37ff:fe39:f51e%5]:123 Jun 12 17:49:04.532750 containerd[1981]: time="2026-06-12T17:49:04.532697874Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:04.534758 containerd[1981]: time="2026-06-12T17:49:04.534573863Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=64099640" Jun 12 17:49:04.537704 containerd[1981]: time="2026-06-12T17:49:04.536825774Z" level=info msg="ImageCreate event name:\"sha256:32fcf01fc26567abd9aacf3033ef54092211cc0c3b97aec02e52b41a6c6aa120\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:04.541957 containerd[1981]: time="2026-06-12T17:49:04.541891336Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:244b60108323653955f0ab9e8b44399c4bd0843f056eb262a8c09239341d3f8f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:04.542958 containerd[1981]: time="2026-06-12T17:49:04.542919584Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:32fcf01fc26567abd9aacf3033ef54092211cc0c3b97aec02e52b41a6c6aa120\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:244b60108323653955f0ab9e8b44399c4bd0843f056eb262a8c09239341d3f8f\", size \"64099518\" in 4.28055266s" Jun 12 17:49:04.545429 containerd[1981]: time="2026-06-12T17:49:04.543462811Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:32fcf01fc26567abd9aacf3033ef54092211cc0c3b97aec02e52b41a6c6aa120\"" Jun 12 17:49:04.552228 containerd[1981]: time="2026-06-12T17:49:04.552156803Z" level=info msg="CreateContainer within sandbox \"9cb9ba1526f82f2de4c1ff65da0d89adde8944b4d48a230f06d494bcbf6e8e0d\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jun 12 17:49:04.578566 containerd[1981]: time="2026-06-12T17:49:04.578514156Z" level=info msg="CreateContainer within sandbox \"9cb9ba1526f82f2de4c1ff65da0d89adde8944b4d48a230f06d494bcbf6e8e0d\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"25a2a0cdc0be6c66e2b78dd6bb08e6017f245c04cfbe95a6397fc7020b90e54f\"" Jun 12 17:49:04.579456 containerd[1981]: time="2026-06-12T17:49:04.579398295Z" level=info msg="StartContainer for \"25a2a0cdc0be6c66e2b78dd6bb08e6017f245c04cfbe95a6397fc7020b90e54f\"" Jun 12 17:49:04.614650 systemd[1]: Started cri-containerd-25a2a0cdc0be6c66e2b78dd6bb08e6017f245c04cfbe95a6397fc7020b90e54f.scope - libcontainer container 25a2a0cdc0be6c66e2b78dd6bb08e6017f245c04cfbe95a6397fc7020b90e54f. Jun 12 17:49:04.646445 containerd[1981]: time="2026-06-12T17:49:04.645633284Z" level=info msg="StartContainer for \"25a2a0cdc0be6c66e2b78dd6bb08e6017f245c04cfbe95a6397fc7020b90e54f\" returns successfully" Jun 12 17:49:04.648911 kubelet[2403]: E0612 17:49:04.648889 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:05.650823 kubelet[2403]: E0612 17:49:05.650767 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:06.651511 kubelet[2403]: E0612 17:49:06.651447 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:07.651805 kubelet[2403]: E0612 17:49:07.651748 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:08.635430 kubelet[2403]: E0612 17:49:08.635369 2403 file.go:103] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:08.652871 kubelet[2403]: E0612 17:49:08.652811 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:09.653237 kubelet[2403]: E0612 17:49:09.653179 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:10.654093 kubelet[2403]: E0612 17:49:10.654036 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:11.654812 kubelet[2403]: E0612 17:49:11.654746 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:12.655442 kubelet[2403]: E0612 17:49:12.655383 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:13.656289 kubelet[2403]: E0612 17:49:13.656207 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:14.656762 kubelet[2403]: E0612 17:49:14.656711 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:15.657745 kubelet[2403]: E0612 17:49:15.657677 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:15.997546 kubelet[2403]: I0612 17:49:15.997365 2403 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="default/nginx-deployment-85fb466b-jt6cw" podStartSLOduration=12.712784227 podStartE2EDuration="16.997350453s" totalImagesPullingTime="4.284566226s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-06-12 17:48:59 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-06-12 17:49:04.670169474 +0000 UTC m=+16.287849286" watchObservedRunningTime="2026-06-12 17:49:15.997350453 +0000 UTC m=+27.615030264" Jun 12 17:49:16.008015 systemd[1]: Created slice kubepods-besteffort-podd856f80d_7dec_4ee6_89cf_b80fd0f2fcf5.slice - libcontainer container kubepods-besteffort-podd856f80d_7dec_4ee6_89cf_b80fd0f2fcf5.slice. Jun 12 17:49:16.063932 kubelet[2403]: I0612 17:49:16.063885 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5-data\") pod \"nfs-server-provisioner-0\" (UID: \"d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5\") " pod="default/nfs-server-provisioner-0" Jun 12 17:49:16.063932 kubelet[2403]: I0612 17:49:16.063940 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-sd7ll\" (UniqueName: \"kubernetes.io/projected/d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5-kube-api-access-sd7ll\") pod \"nfs-server-provisioner-0\" (UID: \"d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5\") " pod="default/nfs-server-provisioner-0" Jun 12 17:49:16.315690 containerd[1981]: time="2026-06-12T17:49:16.315651004Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5,Namespace:default,Attempt:0,}" Jun 12 17:49:16.354841 (udev-worker)[3195]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:49:16.357294 systemd-networkd[1883]: veth54d71461: Link UP Jun 12 17:49:16.358761 kernel: cni0: port 2(veth54d71461) entered blocking state Jun 12 17:49:16.358845 kernel: cni0: port 2(veth54d71461) entered disabled state Jun 12 17:49:16.360452 kernel: veth54d71461: entered allmulticast mode Jun 12 17:49:16.362347 kernel: veth54d71461: entered promiscuous mode Jun 12 17:49:16.371782 kernel: cni0: port 2(veth54d71461) entered blocking state Jun 12 17:49:16.371886 kernel: cni0: port 2(veth54d71461) entered forwarding state Jun 12 17:49:16.372080 systemd-networkd[1883]: veth54d71461: Gained carrier Jun 12 17:49:16.375721 containerd[1981]: 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)(0xc00008c950), "name":"cbr0", "type":"bridge"} Jun 12 17:49:16.375721 containerd[1981]: delegateAdd: netconf sent to delegate plugin: Jun 12 17:49:16.401175 containerd[1981]: {"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-06-12T17:49:16.400791881Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 12 17:49:16.401175 containerd[1981]: time="2026-06-12T17:49:16.400854447Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 12 17:49:16.401175 containerd[1981]: time="2026-06-12T17:49:16.400878918Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:16.401175 containerd[1981]: time="2026-06-12T17:49:16.401051531Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:16.432639 systemd[1]: Started cri-containerd-f1465da163d5843a04d58b54cf21d8ed394f740a299610dc634d6837c3e90b70.scope - libcontainer container f1465da163d5843a04d58b54cf21d8ed394f740a299610dc634d6837c3e90b70. Jun 12 17:49:16.475668 containerd[1981]: time="2026-06-12T17:49:16.475629082Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:d856f80d-7dec-4ee6-89cf-b80fd0f2fcf5,Namespace:default,Attempt:0,} returns sandbox id \"f1465da163d5843a04d58b54cf21d8ed394f740a299610dc634d6837c3e90b70\"" Jun 12 17:49:16.477971 containerd[1981]: time="2026-06-12T17:49:16.477874307Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jun 12 17:49:16.658447 kubelet[2403]: E0612 17:49:16.658300 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:17.658921 kubelet[2403]: E0612 17:49:17.658864 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:17.784754 systemd-networkd[1883]: veth54d71461: Gained IPv6LL Jun 12 17:49:17.856868 update_engine[1959]: I20260612 17:49:17.856441 1959 update_attempter.cc:509] Updating boot flags... Jun 12 17:49:17.932936 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 30 scanned by (udev-worker) (3196) Jun 12 17:49:18.659104 kubelet[2403]: E0612 17:49:18.659004 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:19.071286 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3855075492.mount: Deactivated successfully. Jun 12 17:49:19.660167 kubelet[2403]: E0612 17:49:19.660130 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:20.110647 ntpd[1948]: Listen normally on 13 veth54d71461 [fe80::24ee:a0ff:fed0:1c6%6]:123 Jun 12 17:49:20.111435 ntpd[1948]: 12 Jun 17:49:20 ntpd[1948]: Listen normally on 13 veth54d71461 [fe80::24ee:a0ff:fed0:1c6%6]:123 Jun 12 17:49:20.661117 kubelet[2403]: E0612 17:49:20.661072 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:21.170669 containerd[1981]: time="2026-06-12T17:49:21.170612951Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:21.172942 containerd[1981]: time="2026-06-12T17:49:21.172676176Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Jun 12 17:49:21.175461 containerd[1981]: time="2026-06-12T17:49:21.175368480Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:21.179668 containerd[1981]: time="2026-06-12T17:49:21.179596524Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:21.180925 containerd[1981]: time="2026-06-12T17:49:21.180755115Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 4.70283864s" Jun 12 17:49:21.180925 containerd[1981]: time="2026-06-12T17:49:21.180812150Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jun 12 17:49:21.188354 containerd[1981]: time="2026-06-12T17:49:21.188300890Z" level=info msg="CreateContainer within sandbox \"f1465da163d5843a04d58b54cf21d8ed394f740a299610dc634d6837c3e90b70\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jun 12 17:49:21.213264 containerd[1981]: time="2026-06-12T17:49:21.213215917Z" level=info msg="CreateContainer within sandbox \"f1465da163d5843a04d58b54cf21d8ed394f740a299610dc634d6837c3e90b70\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b\"" Jun 12 17:49:21.214102 containerd[1981]: time="2026-06-12T17:49:21.214069726Z" level=info msg="StartContainer for \"d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b\"" Jun 12 17:49:21.299391 systemd[1]: run-containerd-runc-k8s.io-d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b-runc.ERz5Cq.mount: Deactivated successfully. Jun 12 17:49:21.305595 systemd[1]: Started cri-containerd-d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b.scope - libcontainer container d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b. Jun 12 17:49:21.336899 containerd[1981]: time="2026-06-12T17:49:21.336854966Z" level=info msg="StartContainer for \"d8489e9cb69a5de52434c569b81906f806b29b0f8d3ce6855d4e827fbd6e830b\" returns successfully" Jun 12 17:49:21.662118 kubelet[2403]: E0612 17:49:21.662055 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:22.662298 kubelet[2403]: E0612 17:49:22.662248 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:23.663431 kubelet[2403]: E0612 17:49:23.663335 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:24.663875 kubelet[2403]: E0612 17:49:24.663820 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:25.664040 kubelet[2403]: E0612 17:49:25.663982 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:26.604138 kubelet[2403]: I0612 17:49:26.604073 2403 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.899498476 podStartE2EDuration="11.604059401s" totalImagesPullingTime="4.704560925s" totalInitContainerRuntime="0s" isStatefulPod=false podCreationTimestamp="2026-06-12 17:49:15 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-06-12 17:49:21.355898963 +0000 UTC m=+32.973578774" watchObservedRunningTime="2026-06-12 17:49:26.604059401 +0000 UTC m=+38.221739212" Jun 12 17:49:26.614744 systemd[1]: Created slice kubepods-besteffort-poda3fd51e6_2c31_4d28_9904_823f744eea1e.slice - libcontainer container kubepods-besteffort-poda3fd51e6_2c31_4d28_9904_823f744eea1e.slice. Jun 12 17:49:26.664209 kubelet[2403]: E0612 17:49:26.664168 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:26.731526 kubelet[2403]: I0612 17:49:26.731390 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-564a7737-72f2-485b-886d-112af796ee64\" (UniqueName: \"kubernetes.io/nfs/a3fd51e6-2c31-4d28-9904-823f744eea1e-pvc-564a7737-72f2-485b-886d-112af796ee64\") pod \"test-pod-1\" (UID: \"a3fd51e6-2c31-4d28-9904-823f744eea1e\") " pod="default/test-pod-1" Jun 12 17:49:26.731687 kubelet[2403]: I0612 17:49:26.731531 2403 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-wb49m\" (UniqueName: \"kubernetes.io/projected/a3fd51e6-2c31-4d28-9904-823f744eea1e-kube-api-access-wb49m\") pod \"test-pod-1\" (UID: \"a3fd51e6-2c31-4d28-9904-823f744eea1e\") " pod="default/test-pod-1" Jun 12 17:49:26.881445 kernel: FS-Cache: Loaded Jun 12 17:49:26.967432 kernel: RPC: Registered named UNIX socket transport module. Jun 12 17:49:26.967526 kernel: RPC: Registered udp transport module. Jun 12 17:49:26.967549 kernel: RPC: Registered tcp transport module. Jun 12 17:49:26.967564 kernel: RPC: Registered tcp-with-tls transport module. Jun 12 17:49:26.967592 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jun 12 17:49:27.267723 kernel: NFS: Registering the id_resolver key type Jun 12 17:49:27.267857 kernel: Key type id_resolver registered Jun 12 17:49:27.267892 kernel: Key type id_legacy registered Jun 12 17:49:27.303558 nfsidmap[3525]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Jun 12 17:49:27.309358 nfsidmap[3526]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'us-west-2.compute.internal' Jun 12 17:49:27.525192 containerd[1981]: time="2026-06-12T17:49:27.525069494Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:a3fd51e6-2c31-4d28-9904-823f744eea1e,Namespace:default,Attempt:0,}" Jun 12 17:49:27.591763 (udev-worker)[3514]: Network interface NamePolicy= disabled on kernel command line. Jun 12 17:49:27.592428 systemd-networkd[1883]: vethb79e5423: Link UP Jun 12 17:49:27.595694 kernel: cni0: port 3(vethb79e5423) entered blocking state Jun 12 17:49:27.595750 kernel: cni0: port 3(vethb79e5423) entered disabled state Jun 12 17:49:27.596915 kernel: vethb79e5423: entered allmulticast mode Jun 12 17:49:27.598432 kernel: vethb79e5423: entered promiscuous mode Jun 12 17:49:27.606304 kernel: cni0: port 3(vethb79e5423) entered blocking state Jun 12 17:49:27.606467 kernel: cni0: port 3(vethb79e5423) entered forwarding state Jun 12 17:49:27.606361 systemd-networkd[1883]: vethb79e5423: Gained carrier Jun 12 17:49:27.609488 containerd[1981]: 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)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Jun 12 17:49:27.609488 containerd[1981]: delegateAdd: netconf sent to delegate plugin: Jun 12 17:49:27.642203 containerd[1981]: {"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-06-12T17:49:27.642023841Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jun 12 17:49:27.642203 containerd[1981]: time="2026-06-12T17:49:27.642137209Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jun 12 17:49:27.642203 containerd[1981]: time="2026-06-12T17:49:27.642166644Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:27.642738 containerd[1981]: time="2026-06-12T17:49:27.642297423Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jun 12 17:49:27.664736 systemd[1]: Started cri-containerd-8d4463c2db8fbff24c4527ad5179f985ab685eda182c8b5f93e0f867b8a3c306.scope - libcontainer container 8d4463c2db8fbff24c4527ad5179f985ab685eda182c8b5f93e0f867b8a3c306. Jun 12 17:49:27.665517 kubelet[2403]: E0612 17:49:27.664998 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:27.710251 containerd[1981]: time="2026-06-12T17:49:27.710217507Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:a3fd51e6-2c31-4d28-9904-823f744eea1e,Namespace:default,Attempt:0,} returns sandbox id \"8d4463c2db8fbff24c4527ad5179f985ab685eda182c8b5f93e0f867b8a3c306\"" Jun 12 17:49:27.712771 containerd[1981]: time="2026-06-12T17:49:27.712579931Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jun 12 17:49:28.069498 containerd[1981]: time="2026-06-12T17:49:28.069444563Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jun 12 17:49:28.072049 containerd[1981]: time="2026-06-12T17:49:28.071437556Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jun 12 17:49:28.074419 containerd[1981]: time="2026-06-12T17:49:28.074359292Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:32fcf01fc26567abd9aacf3033ef54092211cc0c3b97aec02e52b41a6c6aa120\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:244b60108323653955f0ab9e8b44399c4bd0843f056eb262a8c09239341d3f8f\", size \"64099518\" in 361.737095ms" Jun 12 17:49:28.074419 containerd[1981]: time="2026-06-12T17:49:28.074396605Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:32fcf01fc26567abd9aacf3033ef54092211cc0c3b97aec02e52b41a6c6aa120\"" Jun 12 17:49:28.083335 containerd[1981]: time="2026-06-12T17:49:28.083290054Z" level=info msg="CreateContainer within sandbox \"8d4463c2db8fbff24c4527ad5179f985ab685eda182c8b5f93e0f867b8a3c306\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jun 12 17:49:28.111195 containerd[1981]: time="2026-06-12T17:49:28.111130270Z" level=info msg="CreateContainer within sandbox \"8d4463c2db8fbff24c4527ad5179f985ab685eda182c8b5f93e0f867b8a3c306\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"ff9cc6eab355259082c2b1e2a75056fdbcb7a8a01bf0bbc68e687f9ba509a73b\"" Jun 12 17:49:28.111938 containerd[1981]: time="2026-06-12T17:49:28.111892370Z" level=info msg="StartContainer for \"ff9cc6eab355259082c2b1e2a75056fdbcb7a8a01bf0bbc68e687f9ba509a73b\"" Jun 12 17:49:28.148607 systemd[1]: Started cri-containerd-ff9cc6eab355259082c2b1e2a75056fdbcb7a8a01bf0bbc68e687f9ba509a73b.scope - libcontainer container ff9cc6eab355259082c2b1e2a75056fdbcb7a8a01bf0bbc68e687f9ba509a73b. Jun 12 17:49:28.178771 containerd[1981]: time="2026-06-12T17:49:28.178730864Z" level=info msg="StartContainer for \"ff9cc6eab355259082c2b1e2a75056fdbcb7a8a01bf0bbc68e687f9ba509a73b\" returns successfully" Jun 12 17:49:28.194315 kubelet[2403]: I0612 17:49:28.194219 2403 pod_startup_latency_tracker.go:148] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=9.828707151 podStartE2EDuration="10.194202446s" totalImagesPullingTime="365.495295ms" totalInitContainerRuntime="0s" isStatefulPod=true podCreationTimestamp="2026-06-12 17:49:18 +0000 UTC" imagePullSessionsCount=1 imagePullSessionsStartsCount=0 observedRunningTime="2026-06-12 17:49:28.194039937 +0000 UTC m=+39.811719749" watchObservedRunningTime="2026-06-12 17:49:28.194202446 +0000 UTC m=+39.811882256" Jun 12 17:49:28.635372 kubelet[2403]: E0612 17:49:28.635305 2403 file.go:103] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:28.665547 kubelet[2403]: E0612 17:49:28.665493 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:29.240633 systemd-networkd[1883]: vethb79e5423: Gained IPv6LL Jun 12 17:49:29.665905 kubelet[2403]: E0612 17:49:29.665823 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:30.666599 kubelet[2403]: E0612 17:49:30.666543 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:31.666809 kubelet[2403]: E0612 17:49:31.666748 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:32.667285 kubelet[2403]: E0612 17:49:32.667232 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:33.668230 kubelet[2403]: E0612 17:49:33.668150 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:34.110641 ntpd[1948]: Listen normally on 14 vethb79e5423 [fe80::c0d2:adff:fedf:1801%7]:123 Jun 12 17:49:34.111442 ntpd[1948]: 12 Jun 17:49:34 ntpd[1948]: Listen normally on 14 vethb79e5423 [fe80::c0d2:adff:fedf:1801%7]:123 Jun 12 17:49:34.669182 kubelet[2403]: E0612 17:49:34.669115 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:35.670276 kubelet[2403]: E0612 17:49:35.670218 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jun 12 17:49:36.671131 kubelet[2403]: E0612 17:49:36.670967 2403 file_linux.go:59] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"