May 15 10:04:13.746556 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 15 10:04:13.746576 kernel: Linux version 5.15.182-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Thu May 15 09:09:56 -00 2025 May 15 10:04:13.746584 kernel: efi: EFI v2.70 by EDK II May 15 10:04:13.746589 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 May 15 10:04:13.746594 kernel: random: crng init done May 15 10:04:13.746600 kernel: ACPI: Early table checksum verification disabled May 15 10:04:13.746606 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) May 15 10:04:13.746612 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) May 15 10:04:13.746618 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746623 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746628 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746634 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746639 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746645 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746653 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746658 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746664 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 15 10:04:13.746670 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 15 10:04:13.746675 kernel: NUMA: Failed to initialise from firmware May 15 10:04:13.746681 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 15 10:04:13.746686 kernel: NUMA: NODE_DATA [mem 0xdcb0b900-0xdcb10fff] May 15 10:04:13.746692 kernel: Zone ranges: May 15 10:04:13.746698 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 15 10:04:13.746704 kernel: DMA32 empty May 15 10:04:13.746710 kernel: Normal empty May 15 10:04:13.746715 kernel: Movable zone start for each node May 15 10:04:13.746721 kernel: Early memory node ranges May 15 10:04:13.746726 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] May 15 10:04:13.746732 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] May 15 10:04:13.746737 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] May 15 10:04:13.746743 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] May 15 10:04:13.746749 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] May 15 10:04:13.746754 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] May 15 10:04:13.746760 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] May 15 10:04:13.746766 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 15 10:04:13.746773 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 15 10:04:13.746778 kernel: psci: probing for conduit method from ACPI. May 15 10:04:13.746784 kernel: psci: PSCIv1.1 detected in firmware. May 15 10:04:13.746790 kernel: psci: Using standard PSCI v0.2 function IDs May 15 10:04:13.746796 kernel: psci: Trusted OS migration not required May 15 10:04:13.746804 kernel: psci: SMC Calling Convention v1.1 May 15 10:04:13.746810 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 15 10:04:13.746817 kernel: ACPI: SRAT not present May 15 10:04:13.746824 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 May 15 10:04:13.746830 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 May 15 10:04:13.746836 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 15 10:04:13.746842 kernel: Detected PIPT I-cache on CPU0 May 15 10:04:13.746848 kernel: CPU features: detected: GIC system register CPU interface May 15 10:04:13.746854 kernel: CPU features: detected: Hardware dirty bit management May 15 10:04:13.746860 kernel: CPU features: detected: Spectre-v4 May 15 10:04:13.746866 kernel: CPU features: detected: Spectre-BHB May 15 10:04:13.746874 kernel: CPU features: kernel page table isolation forced ON by KASLR May 15 10:04:13.746879 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 15 10:04:13.746886 kernel: CPU features: detected: ARM erratum 1418040 May 15 10:04:13.746891 kernel: CPU features: detected: SSBS not fully self-synchronizing May 15 10:04:13.746898 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 May 15 10:04:13.746904 kernel: Policy zone: DMA May 15 10:04:13.746911 kernel: Kernel command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=aa29d2e9841b6b978238db9eff73afa5af149616ae25608914babb265d82dda7 May 15 10:04:13.746917 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 15 10:04:13.746923 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 15 10:04:13.746929 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 15 10:04:13.746936 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 15 10:04:13.746943 kernel: Memory: 2457404K/2572288K available (9792K kernel code, 2094K rwdata, 7584K rodata, 36416K init, 777K bss, 114884K reserved, 0K cma-reserved) May 15 10:04:13.746949 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 15 10:04:13.746955 kernel: trace event string verifier disabled May 15 10:04:13.746977 kernel: rcu: Preemptible hierarchical RCU implementation. May 15 10:04:13.746984 kernel: rcu: RCU event tracing is enabled. May 15 10:04:13.746990 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 15 10:04:13.746996 kernel: Trampoline variant of Tasks RCU enabled. May 15 10:04:13.747003 kernel: Tracing variant of Tasks RCU enabled. May 15 10:04:13.747009 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 15 10:04:13.747015 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 15 10:04:13.747021 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 15 10:04:13.747029 kernel: GICv3: 256 SPIs implemented May 15 10:04:13.747035 kernel: GICv3: 0 Extended SPIs implemented May 15 10:04:13.747041 kernel: GICv3: Distributor has no Range Selector support May 15 10:04:13.747047 kernel: Root IRQ handler: gic_handle_irq May 15 10:04:13.747053 kernel: GICv3: 16 PPIs implemented May 15 10:04:13.747059 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 15 10:04:13.747065 kernel: ACPI: SRAT not present May 15 10:04:13.747071 kernel: ITS [mem 0x08080000-0x0809ffff] May 15 10:04:13.747077 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) May 15 10:04:13.747083 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) May 15 10:04:13.747089 kernel: GICv3: using LPI property table @0x00000000400d0000 May 15 10:04:13.747095 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 May 15 10:04:13.747103 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 10:04:13.747109 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 15 10:04:13.747115 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 15 10:04:13.747122 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 15 10:04:13.747128 kernel: arm-pv: using stolen time PV May 15 10:04:13.747134 kernel: Console: colour dummy device 80x25 May 15 10:04:13.747141 kernel: ACPI: Core revision 20210730 May 15 10:04:13.747151 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 15 10:04:13.747158 kernel: pid_max: default: 32768 minimum: 301 May 15 10:04:13.747164 kernel: LSM: Security Framework initializing May 15 10:04:13.747172 kernel: SELinux: Initializing. May 15 10:04:13.747178 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 15 10:04:13.747184 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 15 10:04:13.747190 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3) May 15 10:04:13.747196 kernel: rcu: Hierarchical SRCU implementation. May 15 10:04:13.747203 kernel: Platform MSI: ITS@0x8080000 domain created May 15 10:04:13.747209 kernel: PCI/MSI: ITS@0x8080000 domain created May 15 10:04:13.747220 kernel: Remapping and enabling EFI services. May 15 10:04:13.747227 kernel: smp: Bringing up secondary CPUs ... May 15 10:04:13.747235 kernel: Detected PIPT I-cache on CPU1 May 15 10:04:13.747241 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 15 10:04:13.747248 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 May 15 10:04:13.747254 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 10:04:13.747260 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 15 10:04:13.747267 kernel: Detected PIPT I-cache on CPU2 May 15 10:04:13.747273 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 15 10:04:13.747279 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 May 15 10:04:13.747285 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 10:04:13.747291 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 15 10:04:13.747299 kernel: Detected PIPT I-cache on CPU3 May 15 10:04:13.747305 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 15 10:04:13.747312 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 May 15 10:04:13.747318 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 15 10:04:13.747329 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 15 10:04:13.747336 kernel: smp: Brought up 1 node, 4 CPUs May 15 10:04:13.747343 kernel: SMP: Total of 4 processors activated. May 15 10:04:13.747349 kernel: CPU features: detected: 32-bit EL0 Support May 15 10:04:13.747356 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 15 10:04:13.747363 kernel: CPU features: detected: Common not Private translations May 15 10:04:13.747369 kernel: CPU features: detected: CRC32 instructions May 15 10:04:13.747376 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 15 10:04:13.747383 kernel: CPU features: detected: LSE atomic instructions May 15 10:04:13.747390 kernel: CPU features: detected: Privileged Access Never May 15 10:04:13.747396 kernel: CPU features: detected: RAS Extension Support May 15 10:04:13.747403 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 15 10:04:13.747410 kernel: CPU: All CPU(s) started at EL1 May 15 10:04:13.747417 kernel: alternatives: patching kernel code May 15 10:04:13.747424 kernel: devtmpfs: initialized May 15 10:04:13.747430 kernel: KASLR enabled May 15 10:04:13.747437 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 15 10:04:13.747444 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 15 10:04:13.747450 kernel: pinctrl core: initialized pinctrl subsystem May 15 10:04:13.747456 kernel: SMBIOS 3.0.0 present. May 15 10:04:13.747463 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 May 15 10:04:13.747469 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 15 10:04:13.747477 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 15 10:04:13.747484 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 15 10:04:13.747491 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 15 10:04:13.747497 kernel: audit: initializing netlink subsys (disabled) May 15 10:04:13.747504 kernel: audit: type=2000 audit(0.032:1): state=initialized audit_enabled=0 res=1 May 15 10:04:13.747510 kernel: thermal_sys: Registered thermal governor 'step_wise' May 15 10:04:13.747517 kernel: cpuidle: using governor menu May 15 10:04:13.747524 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 15 10:04:13.747530 kernel: ASID allocator initialised with 32768 entries May 15 10:04:13.747538 kernel: ACPI: bus type PCI registered May 15 10:04:13.747545 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 15 10:04:13.747551 kernel: Serial: AMBA PL011 UART driver May 15 10:04:13.747558 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages May 15 10:04:13.747564 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages May 15 10:04:13.747571 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages May 15 10:04:13.747577 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages May 15 10:04:13.747584 kernel: cryptd: max_cpu_qlen set to 1000 May 15 10:04:13.747591 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 15 10:04:13.747598 kernel: ACPI: Added _OSI(Module Device) May 15 10:04:13.747605 kernel: ACPI: Added _OSI(Processor Device) May 15 10:04:13.747611 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 15 10:04:13.747618 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 15 10:04:13.747624 kernel: ACPI: Added _OSI(Linux-Dell-Video) May 15 10:04:13.747631 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) May 15 10:04:13.747638 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) May 15 10:04:13.747644 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 15 10:04:13.747651 kernel: ACPI: Interpreter enabled May 15 10:04:13.747659 kernel: ACPI: Using GIC for interrupt routing May 15 10:04:13.747665 kernel: ACPI: MCFG table detected, 1 entries May 15 10:04:13.747672 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 15 10:04:13.747679 kernel: printk: console [ttyAMA0] enabled May 15 10:04:13.747685 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 15 10:04:13.747822 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 15 10:04:13.747884 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 15 10:04:13.752517 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 15 10:04:13.752622 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 15 10:04:13.752690 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 15 10:04:13.752700 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 15 10:04:13.752707 kernel: PCI host bridge to bus 0000:00 May 15 10:04:13.752777 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 15 10:04:13.752832 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 15 10:04:13.752885 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 15 10:04:13.752944 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 15 10:04:13.753052 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 May 15 10:04:13.753131 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 May 15 10:04:13.753194 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] May 15 10:04:13.753297 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] May 15 10:04:13.753375 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] May 15 10:04:13.753446 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] May 15 10:04:13.753516 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] May 15 10:04:13.753593 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] May 15 10:04:13.753651 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 15 10:04:13.753708 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 15 10:04:13.753764 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 15 10:04:13.753773 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 15 10:04:13.753781 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 15 10:04:13.753790 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 15 10:04:13.753797 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 15 10:04:13.753805 kernel: iommu: Default domain type: Translated May 15 10:04:13.753812 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 15 10:04:13.753819 kernel: vgaarb: loaded May 15 10:04:13.753826 kernel: pps_core: LinuxPPS API ver. 1 registered May 15 10:04:13.753833 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti May 15 10:04:13.753840 kernel: PTP clock support registered May 15 10:04:13.753847 kernel: Registered efivars operations May 15 10:04:13.753856 kernel: clocksource: Switched to clocksource arch_sys_counter May 15 10:04:13.753863 kernel: VFS: Disk quotas dquot_6.6.0 May 15 10:04:13.753871 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 15 10:04:13.753878 kernel: pnp: PnP ACPI init May 15 10:04:13.753955 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 15 10:04:13.753975 kernel: pnp: PnP ACPI: found 1 devices May 15 10:04:13.753983 kernel: NET: Registered PF_INET protocol family May 15 10:04:13.753990 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 15 10:04:13.753999 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 15 10:04:13.754006 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 15 10:04:13.754013 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 15 10:04:13.754020 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) May 15 10:04:13.754027 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 15 10:04:13.754034 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 15 10:04:13.754041 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 15 10:04:13.754048 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 15 10:04:13.754055 kernel: PCI: CLS 0 bytes, default 64 May 15 10:04:13.754063 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available May 15 10:04:13.754070 kernel: kvm [1]: HYP mode not available May 15 10:04:13.754077 kernel: Initialise system trusted keyrings May 15 10:04:13.754084 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 15 10:04:13.754091 kernel: Key type asymmetric registered May 15 10:04:13.754098 kernel: Asymmetric key parser 'x509' registered May 15 10:04:13.754104 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) May 15 10:04:13.754111 kernel: io scheduler mq-deadline registered May 15 10:04:13.754118 kernel: io scheduler kyber registered May 15 10:04:13.754126 kernel: io scheduler bfq registered May 15 10:04:13.754133 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 15 10:04:13.754140 kernel: ACPI: button: Power Button [PWRB] May 15 10:04:13.754151 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 15 10:04:13.754224 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 15 10:04:13.754234 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 15 10:04:13.754243 kernel: thunder_xcv, ver 1.0 May 15 10:04:13.754250 kernel: thunder_bgx, ver 1.0 May 15 10:04:13.754256 kernel: nicpf, ver 1.0 May 15 10:04:13.754265 kernel: nicvf, ver 1.0 May 15 10:04:13.754337 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 15 10:04:13.754396 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-15T10:04:13 UTC (1747303453) May 15 10:04:13.754405 kernel: hid: raw HID events driver (C) Jiri Kosina May 15 10:04:13.754412 kernel: NET: Registered PF_INET6 protocol family May 15 10:04:13.754480 kernel: Segment Routing with IPv6 May 15 10:04:13.754487 kernel: In-situ OAM (IOAM) with IPv6 May 15 10:04:13.754494 kernel: NET: Registered PF_PACKET protocol family May 15 10:04:13.754505 kernel: Key type dns_resolver registered May 15 10:04:13.754511 kernel: registered taskstats version 1 May 15 10:04:13.754518 kernel: Loading compiled-in X.509 certificates May 15 10:04:13.754525 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.182-flatcar: 3679cbfb4d4756a2ddc177f0eaedea33fb5fdf2e' May 15 10:04:13.754532 kernel: Key type .fscrypt registered May 15 10:04:13.754540 kernel: Key type fscrypt-provisioning registered May 15 10:04:13.754557 kernel: ima: No TPM chip found, activating TPM-bypass! May 15 10:04:13.754563 kernel: ima: Allocated hash algorithm: sha1 May 15 10:04:13.754570 kernel: ima: No architecture policies found May 15 10:04:13.754579 kernel: clk: Disabling unused clocks May 15 10:04:13.754586 kernel: Freeing unused kernel memory: 36416K May 15 10:04:13.754593 kernel: Run /init as init process May 15 10:04:13.754599 kernel: with arguments: May 15 10:04:13.754606 kernel: /init May 15 10:04:13.754613 kernel: with environment: May 15 10:04:13.754620 kernel: HOME=/ May 15 10:04:13.754628 kernel: TERM=linux May 15 10:04:13.754635 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 15 10:04:13.754646 systemd[1]: systemd 252 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) May 15 10:04:13.754655 systemd[1]: Detected virtualization kvm. May 15 10:04:13.754663 systemd[1]: Detected architecture arm64. May 15 10:04:13.754670 systemd[1]: Running in initrd. May 15 10:04:13.754677 systemd[1]: No hostname configured, using default hostname. May 15 10:04:13.754684 systemd[1]: Hostname set to . May 15 10:04:13.754695 systemd[1]: Initializing machine ID from VM UUID. May 15 10:04:13.754798 systemd[1]: Queued start job for default target initrd.target. May 15 10:04:13.754808 systemd[1]: Started systemd-ask-password-console.path. May 15 10:04:13.754815 systemd[1]: Reached target cryptsetup.target. May 15 10:04:13.754822 systemd[1]: Reached target paths.target. May 15 10:04:13.754830 systemd[1]: Reached target slices.target. May 15 10:04:13.754837 systemd[1]: Reached target swap.target. May 15 10:04:13.754845 systemd[1]: Reached target timers.target. May 15 10:04:13.754853 systemd[1]: Listening on iscsid.socket. May 15 10:04:13.754864 systemd[1]: Listening on iscsiuio.socket. May 15 10:04:13.754871 systemd[1]: Listening on systemd-journald-audit.socket. May 15 10:04:13.754878 systemd[1]: Listening on systemd-journald-dev-log.socket. May 15 10:04:13.754885 systemd[1]: Listening on systemd-journald.socket. May 15 10:04:13.754892 systemd[1]: Listening on systemd-networkd.socket. May 15 10:04:13.754900 systemd[1]: Listening on systemd-udevd-control.socket. May 15 10:04:13.754907 systemd[1]: Listening on systemd-udevd-kernel.socket. May 15 10:04:13.754914 systemd[1]: Reached target sockets.target. May 15 10:04:13.754922 systemd[1]: Starting kmod-static-nodes.service... May 15 10:04:13.754929 systemd[1]: Finished network-cleanup.service. May 15 10:04:13.754937 systemd[1]: Starting systemd-fsck-usr.service... May 15 10:04:13.754944 systemd[1]: Starting systemd-journald.service... May 15 10:04:13.754951 systemd[1]: Starting systemd-modules-load.service... May 15 10:04:13.754970 systemd[1]: Starting systemd-resolved.service... May 15 10:04:13.754977 systemd[1]: Starting systemd-vconsole-setup.service... May 15 10:04:13.754985 systemd[1]: Finished kmod-static-nodes.service. May 15 10:04:13.754992 systemd[1]: Finished systemd-fsck-usr.service. May 15 10:04:13.755001 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... May 15 10:04:13.755009 systemd[1]: Finished systemd-vconsole-setup.service. May 15 10:04:13.755017 kernel: audit: type=1130 audit(1747303453.747:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.755024 systemd[1]: Starting dracut-cmdline-ask.service... May 15 10:04:13.755032 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 15 10:04:13.755042 systemd-journald[290]: Journal started May 15 10:04:13.755097 systemd-journald[290]: Runtime Journal (/run/log/journal/ff163abb303c4936b83b010dbf8fe5f9) is 6.0M, max 48.7M, 42.6M free. May 15 10:04:13.747000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.734544 systemd-modules-load[291]: Inserted module 'overlay' May 15 10:04:13.758080 systemd[1]: Started systemd-journald.service. May 15 10:04:13.752342 systemd-resolved[292]: Positive Trust Anchors: May 15 10:04:13.757000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.761992 kernel: audit: type=1130 audit(1747303453.757:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.752349 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 15 10:04:13.763972 kernel: Bridge firewalling registered May 15 10:04:13.752377 systemd-resolved[292]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test May 15 10:04:13.772285 kernel: audit: type=1130 audit(1747303453.764:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.764000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.757531 systemd-resolved[292]: Defaulting to hostname 'linux'. May 15 10:04:13.773000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.762330 systemd[1]: Started systemd-resolved.service. May 15 10:04:13.777519 kernel: audit: type=1130 audit(1747303453.773:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.764068 systemd-modules-load[291]: Inserted module 'br_netfilter' May 15 10:04:13.778000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.767357 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. May 15 10:04:13.782838 kernel: audit: type=1130 audit(1747303453.778:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.782856 kernel: SCSI subsystem initialized May 15 10:04:13.777061 systemd[1]: Finished dracut-cmdline-ask.service. May 15 10:04:13.781568 systemd[1]: Reached target nss-lookup.target. May 15 10:04:13.784393 systemd[1]: Starting dracut-cmdline.service... May 15 10:04:13.791709 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 15 10:04:13.791747 kernel: device-mapper: uevent: version 1.0.3 May 15 10:04:13.793202 dracut-cmdline[307]: dracut-dracut-053 May 15 10:04:13.794087 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com May 15 10:04:13.795344 dracut-cmdline[307]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected acpi=force verity.usrhash=aa29d2e9841b6b978238db9eff73afa5af149616ae25608914babb265d82dda7 May 15 10:04:13.799923 systemd-modules-load[291]: Inserted module 'dm_multipath' May 15 10:04:13.800706 systemd[1]: Finished systemd-modules-load.service. May 15 10:04:13.801000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.804984 kernel: audit: type=1130 audit(1747303453.801:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.805450 systemd[1]: Starting systemd-sysctl.service... May 15 10:04:13.812728 systemd[1]: Finished systemd-sysctl.service. May 15 10:04:13.813000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.816984 kernel: audit: type=1130 audit(1747303453.813:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.852982 kernel: Loading iSCSI transport class v2.0-870. May 15 10:04:13.865990 kernel: iscsi: registered transport (tcp) May 15 10:04:13.882278 kernel: iscsi: registered transport (qla4xxx) May 15 10:04:13.882322 kernel: QLogic iSCSI HBA Driver May 15 10:04:13.915428 systemd[1]: Finished dracut-cmdline.service. May 15 10:04:13.916000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.917154 systemd[1]: Starting dracut-pre-udev.service... May 15 10:04:13.920973 kernel: audit: type=1130 audit(1747303453.916:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:13.964991 kernel: raid6: neonx8 gen() 13728 MB/s May 15 10:04:13.981980 kernel: raid6: neonx8 xor() 10686 MB/s May 15 10:04:13.998993 kernel: raid6: neonx4 gen() 13406 MB/s May 15 10:04:14.015988 kernel: raid6: neonx4 xor() 11071 MB/s May 15 10:04:14.032989 kernel: raid6: neonx2 gen() 12845 MB/s May 15 10:04:14.049983 kernel: raid6: neonx2 xor() 10391 MB/s May 15 10:04:14.066985 kernel: raid6: neonx1 gen() 10437 MB/s May 15 10:04:14.083985 kernel: raid6: neonx1 xor() 8656 MB/s May 15 10:04:14.100982 kernel: raid6: int64x8 gen() 6187 MB/s May 15 10:04:14.117992 kernel: raid6: int64x8 xor() 3508 MB/s May 15 10:04:14.134981 kernel: raid6: int64x4 gen() 7151 MB/s May 15 10:04:14.151982 kernel: raid6: int64x4 xor() 3818 MB/s May 15 10:04:14.168984 kernel: raid6: int64x2 gen() 6121 MB/s May 15 10:04:14.185981 kernel: raid6: int64x2 xor() 3296 MB/s May 15 10:04:14.202981 kernel: raid6: int64x1 gen() 5027 MB/s May 15 10:04:14.220271 kernel: raid6: int64x1 xor() 2642 MB/s May 15 10:04:14.220285 kernel: raid6: using algorithm neonx8 gen() 13728 MB/s May 15 10:04:14.220293 kernel: raid6: .... xor() 10686 MB/s, rmw enabled May 15 10:04:14.221498 kernel: raid6: using neon recovery algorithm May 15 10:04:14.234997 kernel: xor: measuring software checksum speed May 15 10:04:14.236425 kernel: 8regs : 15423 MB/sec May 15 10:04:14.236459 kernel: 32regs : 20363 MB/sec May 15 10:04:14.237049 kernel: arm64_neon : 27654 MB/sec May 15 10:04:14.237065 kernel: xor: using function: arm64_neon (27654 MB/sec) May 15 10:04:14.295995 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no May 15 10:04:14.307310 systemd[1]: Finished dracut-pre-udev.service. May 15 10:04:14.307000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:14.310000 audit: BPF prog-id=7 op=LOAD May 15 10:04:14.310000 audit: BPF prog-id=8 op=LOAD May 15 10:04:14.311984 kernel: audit: type=1130 audit(1747303454.307:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:14.312013 systemd[1]: Starting systemd-udevd.service... May 15 10:04:14.324676 systemd-udevd[490]: Using default interface naming scheme 'v252'. May 15 10:04:14.328180 systemd[1]: Started systemd-udevd.service. May 15 10:04:14.328000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:14.330666 systemd[1]: Starting dracut-pre-trigger.service... May 15 10:04:14.341815 dracut-pre-trigger[498]: rd.md=0: removing MD RAID activation May 15 10:04:14.377996 systemd[1]: Finished dracut-pre-trigger.service. May 15 10:04:14.377000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:14.379691 systemd[1]: Starting systemd-udev-trigger.service... May 15 10:04:14.417604 systemd[1]: Finished systemd-udev-trigger.service. May 15 10:04:14.418000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:14.451294 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) May 15 10:04:14.456563 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. May 15 10:04:14.456579 kernel: GPT:9289727 != 19775487 May 15 10:04:14.456588 kernel: GPT:Alternate GPT header not at the end of the disk. May 15 10:04:14.456596 kernel: GPT:9289727 != 19775487 May 15 10:04:14.456604 kernel: GPT: Use GNU Parted to correct GPT errors. May 15 10:04:14.456620 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 10:04:14.472972 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (539) May 15 10:04:14.472941 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. May 15 10:04:14.474079 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. May 15 10:04:14.481142 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. May 15 10:04:14.484797 systemd[1]: Starting disk-uuid.service... May 15 10:04:14.488045 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. May 15 10:04:14.491755 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. May 15 10:04:14.493740 disk-uuid[562]: Primary Header is updated. May 15 10:04:14.493740 disk-uuid[562]: Secondary Entries is updated. May 15 10:04:14.493740 disk-uuid[562]: Secondary Header is updated. May 15 10:04:14.496984 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 10:04:15.509865 disk-uuid[563]: The operation has completed successfully. May 15 10:04:15.511188 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 15 10:04:15.536906 systemd[1]: disk-uuid.service: Deactivated successfully. May 15 10:04:15.536000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.536000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.537032 systemd[1]: Finished disk-uuid.service. May 15 10:04:15.538769 systemd[1]: Starting verity-setup.service... May 15 10:04:15.555077 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 15 10:04:15.591007 systemd[1]: Found device dev-mapper-usr.device. May 15 10:04:15.593048 systemd[1]: Mounting sysusr-usr.mount... May 15 10:04:15.594053 systemd[1]: Finished verity-setup.service. May 15 10:04:15.594000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.665972 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. May 15 10:04:15.666295 systemd[1]: Mounted sysusr-usr.mount. May 15 10:04:15.667143 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. May 15 10:04:15.667909 systemd[1]: Starting ignition-setup.service... May 15 10:04:15.670682 systemd[1]: Starting parse-ip-for-networkd.service... May 15 10:04:15.681725 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 15 10:04:15.681779 kernel: BTRFS info (device vda6): using free space tree May 15 10:04:15.681795 kernel: BTRFS info (device vda6): has skinny extents May 15 10:04:15.691173 systemd[1]: mnt-oem.mount: Deactivated successfully. May 15 10:04:15.701102 systemd[1]: Finished ignition-setup.service. May 15 10:04:15.702768 systemd[1]: Starting ignition-fetch-offline.service... May 15 10:04:15.700000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.779860 systemd[1]: Finished parse-ip-for-networkd.service. May 15 10:04:15.780000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.780000 audit: BPF prog-id=9 op=LOAD May 15 10:04:15.782062 systemd[1]: Starting systemd-networkd.service... May 15 10:04:15.801107 ignition[651]: Ignition 2.14.0 May 15 10:04:15.801116 ignition[651]: Stage: fetch-offline May 15 10:04:15.801154 ignition[651]: no configs at "/usr/lib/ignition/base.d" May 15 10:04:15.801163 ignition[651]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:15.801298 ignition[651]: parsed url from cmdline: "" May 15 10:04:15.801301 ignition[651]: no config URL provided May 15 10:04:15.801305 ignition[651]: reading system config file "/usr/lib/ignition/user.ign" May 15 10:04:15.801312 ignition[651]: no config at "/usr/lib/ignition/user.ign" May 15 10:04:15.801333 ignition[651]: op(1): [started] loading QEMU firmware config module May 15 10:04:15.801338 ignition[651]: op(1): executing: "modprobe" "qemu_fw_cfg" May 15 10:04:15.808546 systemd-networkd[740]: lo: Link UP May 15 10:04:15.808321 ignition[651]: op(1): [finished] loading QEMU firmware config module May 15 10:04:15.810000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.808549 systemd-networkd[740]: lo: Gained carrier May 15 10:04:15.808881 systemd-networkd[740]: Enumeration completed May 15 10:04:15.809073 systemd-networkd[740]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 15 10:04:15.809190 systemd[1]: Started systemd-networkd.service. May 15 10:04:15.810115 systemd-networkd[740]: eth0: Link UP May 15 10:04:15.810118 systemd-networkd[740]: eth0: Gained carrier May 15 10:04:15.811134 systemd[1]: Reached target network.target. May 15 10:04:15.813632 systemd[1]: Starting iscsiuio.service... May 15 10:04:15.822688 ignition[651]: parsing config with SHA512: 1e390bf7a4457eb5feeedaedcf846d4511367059a182ca27318aa62b6c4c15d811c8e4d294b4798f630cec2286d699083e4c7067769ce5b227c01a59cf2e32f6 May 15 10:04:15.824000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.824250 systemd[1]: Started iscsiuio.service. May 15 10:04:15.826107 systemd[1]: Starting iscsid.service... May 15 10:04:15.827044 systemd-networkd[740]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 15 10:04:15.829432 iscsid[746]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi May 15 10:04:15.829432 iscsid[746]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. May 15 10:04:15.829432 iscsid[746]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. May 15 10:04:15.829432 iscsid[746]: If using hardware iscsi like qla4xxx this message can be ignored. May 15 10:04:15.829432 iscsid[746]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi May 15 10:04:15.836000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.841265 iscsid[746]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf May 15 10:04:15.832217 systemd[1]: Started iscsid.service. May 15 10:04:15.838006 systemd[1]: Starting dracut-initqueue.service... May 15 10:04:15.843716 unknown[651]: fetched base config from "system" May 15 10:04:15.844112 ignition[651]: fetch-offline: fetch-offline passed May 15 10:04:15.845000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.843727 unknown[651]: fetched user config from "qemu" May 15 10:04:15.844163 ignition[651]: Ignition finished successfully May 15 10:04:15.845561 systemd[1]: Finished ignition-fetch-offline.service. May 15 10:04:15.849000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.846836 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 15 10:04:15.847746 systemd[1]: Starting ignition-kargs.service... May 15 10:04:15.849255 systemd[1]: Finished dracut-initqueue.service. May 15 10:04:15.850611 systemd[1]: Reached target remote-fs-pre.target. May 15 10:04:15.852056 systemd[1]: Reached target remote-cryptsetup.target. May 15 10:04:15.856892 ignition[757]: Ignition 2.14.0 May 15 10:04:15.854420 systemd[1]: Reached target remote-fs.target. May 15 10:04:15.863000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.856898 ignition[757]: Stage: kargs May 15 10:04:15.856681 systemd[1]: Starting dracut-pre-mount.service... May 15 10:04:15.858787 ignition[757]: no configs at "/usr/lib/ignition/base.d" May 15 10:04:15.868000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.863486 systemd[1]: Finished ignition-kargs.service. May 15 10:04:15.858798 ignition[757]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:15.865800 systemd[1]: Starting ignition-disks.service... May 15 10:04:15.859546 ignition[757]: kargs: kargs passed May 15 10:04:15.869021 systemd[1]: Finished dracut-pre-mount.service. May 15 10:04:15.859593 ignition[757]: Ignition finished successfully May 15 10:04:15.875000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.874689 systemd[1]: Finished ignition-disks.service. May 15 10:04:15.872883 ignition[765]: Ignition 2.14.0 May 15 10:04:15.876018 systemd[1]: Reached target initrd-root-device.target. May 15 10:04:15.872888 ignition[765]: Stage: disks May 15 10:04:15.877513 systemd[1]: Reached target local-fs-pre.target. May 15 10:04:15.873065 ignition[765]: no configs at "/usr/lib/ignition/base.d" May 15 10:04:15.878953 systemd[1]: Reached target local-fs.target. May 15 10:04:15.873121 ignition[765]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:15.880305 systemd[1]: Reached target sysinit.target. May 15 10:04:15.873950 ignition[765]: disks: disks passed May 15 10:04:15.881882 systemd[1]: Reached target basic.target. May 15 10:04:15.874016 ignition[765]: Ignition finished successfully May 15 10:04:15.884164 systemd[1]: Starting systemd-fsck-root.service... May 15 10:04:15.895812 systemd-fsck[775]: ROOT: clean, 623/553520 files, 56022/553472 blocks May 15 10:04:15.899932 systemd[1]: Finished systemd-fsck-root.service. May 15 10:04:15.899000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.901843 systemd[1]: Mounting sysroot.mount... May 15 10:04:15.912988 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. May 15 10:04:15.913243 systemd[1]: Mounted sysroot.mount. May 15 10:04:15.914052 systemd[1]: Reached target initrd-root-fs.target. May 15 10:04:15.916845 systemd[1]: Mounting sysroot-usr.mount... May 15 10:04:15.917778 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. May 15 10:04:15.917818 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 15 10:04:15.917843 systemd[1]: Reached target ignition-diskful.target. May 15 10:04:15.919800 systemd[1]: Mounted sysroot-usr.mount. May 15 10:04:15.921694 systemd[1]: Starting initrd-setup-root.service... May 15 10:04:15.925837 initrd-setup-root[785]: cut: /sysroot/etc/passwd: No such file or directory May 15 10:04:15.929346 initrd-setup-root[793]: cut: /sysroot/etc/group: No such file or directory May 15 10:04:15.932984 initrd-setup-root[801]: cut: /sysroot/etc/shadow: No such file or directory May 15 10:04:15.937007 initrd-setup-root[809]: cut: /sysroot/etc/gshadow: No such file or directory May 15 10:04:15.966431 systemd[1]: Finished initrd-setup-root.service. May 15 10:04:15.966000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.968035 systemd[1]: Starting ignition-mount.service... May 15 10:04:15.969340 systemd[1]: Starting sysroot-boot.service... May 15 10:04:15.973288 bash[826]: umount: /sysroot/usr/share/oem: not mounted. May 15 10:04:15.981897 ignition[827]: INFO : Ignition 2.14.0 May 15 10:04:15.981897 ignition[827]: INFO : Stage: mount May 15 10:04:15.983587 ignition[827]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 10:04:15.983587 ignition[827]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:15.983587 ignition[827]: INFO : mount: mount passed May 15 10:04:15.983587 ignition[827]: INFO : Ignition finished successfully May 15 10:04:15.984000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:15.983450 systemd[1]: Finished ignition-mount.service. May 15 10:04:15.991606 systemd[1]: Finished sysroot-boot.service. May 15 10:04:15.992000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:16.603006 systemd[1]: Mounting sysroot-usr-share-oem.mount... May 15 10:04:16.609758 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (837) May 15 10:04:16.609794 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 15 10:04:16.609804 kernel: BTRFS info (device vda6): using free space tree May 15 10:04:16.610462 kernel: BTRFS info (device vda6): has skinny extents May 15 10:04:16.616001 systemd[1]: Mounted sysroot-usr-share-oem.mount. May 15 10:04:16.617660 systemd[1]: Starting ignition-files.service... May 15 10:04:16.631982 ignition[857]: INFO : Ignition 2.14.0 May 15 10:04:16.631982 ignition[857]: INFO : Stage: files May 15 10:04:16.633658 ignition[857]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 10:04:16.633658 ignition[857]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:16.633658 ignition[857]: DEBUG : files: compiled without relabeling support, skipping May 15 10:04:16.643157 ignition[857]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 15 10:04:16.643157 ignition[857]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 15 10:04:16.647277 ignition[857]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 15 10:04:16.648677 ignition[857]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 15 10:04:16.650145 unknown[857]: wrote ssh authorized keys file for user: core May 15 10:04:16.651384 ignition[857]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 15 10:04:16.651384 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw" May 15 10:04:16.666157 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw" May 15 10:04:16.666157 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw" May 15 10:04:16.666157 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://github.com/flatcar/sysext-bakery/releases/download/latest/kubernetes-v1.30.1-arm64.raw: attempt #1 May 15 10:04:16.854275 systemd-networkd[740]: eth0: Gained IPv6LL May 15 10:04:16.934277 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK May 15 10:04:17.155294 ignition[857]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw" May 15 10:04:17.155294 ignition[857]: INFO : files: op(8): [started] processing unit "containerd.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" May 15 10:04:17.159277 ignition[857]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" May 15 10:04:17.159277 ignition[857]: INFO : files: op(8): [finished] processing unit "containerd.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" May 15 10:04:17.159277 ignition[857]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" May 15 10:04:17.195119 ignition[857]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 15 10:04:17.196804 ignition[857]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" May 15 10:04:17.196804 ignition[857]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" May 15 10:04:17.196804 ignition[857]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" May 15 10:04:17.196804 ignition[857]: INFO : files: files passed May 15 10:04:17.196804 ignition[857]: INFO : Ignition finished successfully May 15 10:04:17.196000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.204000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.204000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.196502 systemd[1]: Finished ignition-files.service. May 15 10:04:17.198487 systemd[1]: Starting initrd-setup-root-after-ignition.service... May 15 10:04:17.199911 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). May 15 10:04:17.210138 initrd-setup-root-after-ignition[883]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory May 15 10:04:17.209000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.200580 systemd[1]: Starting ignition-quench.service... May 15 10:04:17.213922 initrd-setup-root-after-ignition[885]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 15 10:04:17.204170 systemd[1]: ignition-quench.service: Deactivated successfully. May 15 10:04:17.204262 systemd[1]: Finished ignition-quench.service. May 15 10:04:17.208403 systemd[1]: Finished initrd-setup-root-after-ignition.service. May 15 10:04:17.211115 systemd[1]: Reached target ignition-complete.target. May 15 10:04:17.213947 systemd[1]: Starting initrd-parse-etc.service... May 15 10:04:17.227463 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 15 10:04:17.227576 systemd[1]: Finished initrd-parse-etc.service. May 15 10:04:17.228000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.228000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.229444 systemd[1]: Reached target initrd-fs.target. May 15 10:04:17.230737 systemd[1]: Reached target initrd.target. May 15 10:04:17.232167 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. May 15 10:04:17.233033 systemd[1]: Starting dracut-pre-pivot.service... May 15 10:04:17.245407 systemd[1]: Finished dracut-pre-pivot.service. May 15 10:04:17.245000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.247319 systemd[1]: Starting initrd-cleanup.service... May 15 10:04:17.256827 systemd[1]: Stopped target nss-lookup.target. May 15 10:04:17.257825 systemd[1]: Stopped target remote-cryptsetup.target. May 15 10:04:17.259353 systemd[1]: Stopped target timers.target. May 15 10:04:17.260741 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 15 10:04:17.260855 systemd[1]: Stopped dracut-pre-pivot.service. May 15 10:04:17.262278 systemd[1]: Stopped target initrd.target. May 15 10:04:17.261000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.263696 systemd[1]: Stopped target basic.target. May 15 10:04:17.265197 systemd[1]: Stopped target ignition-complete.target. May 15 10:04:17.266724 systemd[1]: Stopped target ignition-diskful.target. May 15 10:04:17.268274 systemd[1]: Stopped target initrd-root-device.target. May 15 10:04:17.269921 systemd[1]: Stopped target remote-fs.target. May 15 10:04:17.271593 systemd[1]: Stopped target remote-fs-pre.target. May 15 10:04:17.273311 systemd[1]: Stopped target sysinit.target. May 15 10:04:17.274770 systemd[1]: Stopped target local-fs.target. May 15 10:04:17.276203 systemd[1]: Stopped target local-fs-pre.target. May 15 10:04:17.277664 systemd[1]: Stopped target swap.target. May 15 10:04:17.279000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.279079 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 15 10:04:17.279224 systemd[1]: Stopped dracut-pre-mount.service. May 15 10:04:17.282000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.280688 systemd[1]: Stopped target cryptsetup.target. May 15 10:04:17.284000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.281921 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 15 10:04:17.282040 systemd[1]: Stopped dracut-initqueue.service. May 15 10:04:17.283640 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 15 10:04:17.283734 systemd[1]: Stopped ignition-fetch-offline.service. May 15 10:04:17.285172 systemd[1]: Stopped target paths.target. May 15 10:04:17.286425 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 15 10:04:17.290703 systemd[1]: Stopped systemd-ask-password-console.path. May 15 10:04:17.292722 systemd[1]: Stopped target slices.target. May 15 10:04:17.294220 systemd[1]: Stopped target sockets.target. May 15 10:04:17.295571 systemd[1]: iscsid.socket: Deactivated successfully. May 15 10:04:17.295642 systemd[1]: Closed iscsid.socket. May 15 10:04:17.296809 systemd[1]: iscsiuio.socket: Deactivated successfully. May 15 10:04:17.299000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.296870 systemd[1]: Closed iscsiuio.socket. May 15 10:04:17.300000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.298169 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 15 10:04:17.298277 systemd[1]: Stopped initrd-setup-root-after-ignition.service. May 15 10:04:17.299671 systemd[1]: ignition-files.service: Deactivated successfully. May 15 10:04:17.299762 systemd[1]: Stopped ignition-files.service. May 15 10:04:17.302018 systemd[1]: Stopping ignition-mount.service... May 15 10:04:17.306000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.308000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.304183 systemd[1]: Stopping sysroot-boot.service... May 15 10:04:17.304904 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 15 10:04:17.311683 ignition[898]: INFO : Ignition 2.14.0 May 15 10:04:17.311683 ignition[898]: INFO : Stage: umount May 15 10:04:17.311683 ignition[898]: INFO : no configs at "/usr/lib/ignition/base.d" May 15 10:04:17.311683 ignition[898]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 15 10:04:17.311683 ignition[898]: INFO : umount: umount passed May 15 10:04:17.311683 ignition[898]: INFO : Ignition finished successfully May 15 10:04:17.316000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.316000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.319000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.305044 systemd[1]: Stopped systemd-udev-trigger.service. May 15 10:04:17.321000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.306719 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 15 10:04:17.323000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.306809 systemd[1]: Stopped dracut-pre-trigger.service. May 15 10:04:17.311769 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 15 10:04:17.311855 systemd[1]: Finished initrd-cleanup.service. May 15 10:04:17.324000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.318283 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 15 10:04:17.318714 systemd[1]: ignition-mount.service: Deactivated successfully. May 15 10:04:17.318790 systemd[1]: Stopped ignition-mount.service. May 15 10:04:17.320109 systemd[1]: Stopped target network.target. May 15 10:04:17.321246 systemd[1]: ignition-disks.service: Deactivated successfully. May 15 10:04:17.321308 systemd[1]: Stopped ignition-disks.service. May 15 10:04:17.322773 systemd[1]: ignition-kargs.service: Deactivated successfully. May 15 10:04:17.322816 systemd[1]: Stopped ignition-kargs.service. May 15 10:04:17.336000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.324207 systemd[1]: ignition-setup.service: Deactivated successfully. May 15 10:04:17.337000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.324254 systemd[1]: Stopped ignition-setup.service. May 15 10:04:17.340000 audit: BPF prog-id=6 op=UNLOAD May 15 10:04:17.326082 systemd[1]: Stopping systemd-networkd.service... May 15 10:04:17.327373 systemd[1]: Stopping systemd-resolved.service... May 15 10:04:17.343000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.334039 systemd-networkd[740]: eth0: DHCPv6 lease lost May 15 10:04:17.344000 audit: BPF prog-id=9 op=UNLOAD May 15 10:04:17.345000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.335394 systemd[1]: systemd-resolved.service: Deactivated successfully. May 15 10:04:17.347000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.335509 systemd[1]: Stopped systemd-resolved.service. May 15 10:04:17.338029 systemd[1]: systemd-networkd.service: Deactivated successfully. May 15 10:04:17.338126 systemd[1]: Stopped systemd-networkd.service. May 15 10:04:17.353000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.339226 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 15 10:04:17.339256 systemd[1]: Closed systemd-networkd.socket. May 15 10:04:17.355000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.342130 systemd[1]: Stopping network-cleanup.service... May 15 10:04:17.342952 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 15 10:04:17.343082 systemd[1]: Stopped parse-ip-for-networkd.service. May 15 10:04:17.344812 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 15 10:04:17.359000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.344855 systemd[1]: Stopped systemd-sysctl.service. May 15 10:04:17.361000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.347241 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 15 10:04:17.347284 systemd[1]: Stopped systemd-modules-load.service. May 15 10:04:17.350218 systemd[1]: Stopping systemd-udevd.service... May 15 10:04:17.363000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.352762 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. May 15 10:04:17.367000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.353294 systemd[1]: sysroot-boot.service: Deactivated successfully. May 15 10:04:17.369000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.353374 systemd[1]: Stopped sysroot-boot.service. May 15 10:04:17.355120 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 15 10:04:17.355167 systemd[1]: Stopped initrd-setup-root.service. May 15 10:04:17.359622 systemd[1]: systemd-udevd.service: Deactivated successfully. May 15 10:04:17.372000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.374000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.359742 systemd[1]: Stopped systemd-udevd.service. May 15 10:04:17.377000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.361258 systemd[1]: network-cleanup.service: Deactivated successfully. May 15 10:04:17.361337 systemd[1]: Stopped network-cleanup.service. May 15 10:04:17.378000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.378000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:17.362659 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 15 10:04:17.362691 systemd[1]: Closed systemd-udevd-control.socket. May 15 10:04:17.363908 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 15 10:04:17.363939 systemd[1]: Closed systemd-udevd-kernel.socket. May 15 10:04:17.365512 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 15 10:04:17.365557 systemd[1]: Stopped dracut-pre-udev.service. May 15 10:04:17.366879 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 15 10:04:17.366918 systemd[1]: Stopped dracut-cmdline.service. May 15 10:04:17.368305 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 15 10:04:17.388000 audit: BPF prog-id=8 op=UNLOAD May 15 10:04:17.388000 audit: BPF prog-id=7 op=UNLOAD May 15 10:04:17.368345 systemd[1]: Stopped dracut-cmdline-ask.service. May 15 10:04:17.370875 systemd[1]: Starting initrd-udevadm-cleanup-db.service... May 15 10:04:17.371770 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 15 10:04:17.390000 audit: BPF prog-id=5 op=UNLOAD May 15 10:04:17.390000 audit: BPF prog-id=4 op=UNLOAD May 15 10:04:17.390000 audit: BPF prog-id=3 op=UNLOAD May 15 10:04:17.371837 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. May 15 10:04:17.374082 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 15 10:04:17.374122 systemd[1]: Stopped kmod-static-nodes.service. May 15 10:04:17.375584 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 15 10:04:17.375622 systemd[1]: Stopped systemd-vconsole-setup.service. May 15 10:04:17.377874 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. May 15 10:04:17.378323 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 15 10:04:17.378411 systemd[1]: Finished initrd-udevadm-cleanup-db.service. May 15 10:04:17.379663 systemd[1]: Reached target initrd-switch-root.target. May 15 10:04:17.381673 systemd[1]: Starting initrd-switch-root.service... May 15 10:04:17.388559 systemd[1]: Switching root. May 15 10:04:17.406581 iscsid[746]: iscsid shutting down. May 15 10:04:17.407266 systemd-journald[290]: Received SIGTERM from PID 1 (systemd). May 15 10:04:17.407296 systemd-journald[290]: Journal stopped May 15 10:04:19.474681 kernel: SELinux: Class mctp_socket not defined in policy. May 15 10:04:19.474735 kernel: SELinux: Class anon_inode not defined in policy. May 15 10:04:19.474747 kernel: SELinux: the above unknown classes and permissions will be allowed May 15 10:04:19.474759 kernel: SELinux: policy capability network_peer_controls=1 May 15 10:04:19.474781 kernel: SELinux: policy capability open_perms=1 May 15 10:04:19.474798 kernel: SELinux: policy capability extended_socket_class=1 May 15 10:04:19.474815 kernel: SELinux: policy capability always_check_network=0 May 15 10:04:19.474827 kernel: SELinux: policy capability cgroup_seclabel=1 May 15 10:04:19.474836 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 15 10:04:19.474846 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 15 10:04:19.474856 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 15 10:04:19.474871 systemd[1]: Successfully loaded SELinux policy in 34.867ms. May 15 10:04:19.474891 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 7.172ms. May 15 10:04:19.474903 systemd[1]: systemd 252 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) May 15 10:04:19.474914 systemd[1]: Detected virtualization kvm. May 15 10:04:19.474925 systemd[1]: Detected architecture arm64. May 15 10:04:19.474935 systemd[1]: Detected first boot. May 15 10:04:19.474946 systemd[1]: Initializing machine ID from VM UUID. May 15 10:04:19.475000 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). May 15 10:04:19.475019 systemd[1]: Populated /etc with preset unit settings. May 15 10:04:19.475031 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. May 15 10:04:19.475042 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. May 15 10:04:19.475054 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 15 10:04:19.475065 systemd[1]: Queued start job for default target multi-user.target. May 15 10:04:19.475076 systemd[1]: Unnecessary job was removed for dev-vda6.device. May 15 10:04:19.475086 systemd[1]: Created slice system-addon\x2dconfig.slice. May 15 10:04:19.475102 systemd[1]: Created slice system-addon\x2drun.slice. May 15 10:04:19.475115 systemd[1]: Created slice system-getty.slice. May 15 10:04:19.475126 systemd[1]: Created slice system-modprobe.slice. May 15 10:04:19.475137 systemd[1]: Created slice system-serial\x2dgetty.slice. May 15 10:04:19.475147 systemd[1]: Created slice system-system\x2dcloudinit.slice. May 15 10:04:19.475158 systemd[1]: Created slice system-systemd\x2dfsck.slice. May 15 10:04:19.475169 systemd[1]: Created slice user.slice. May 15 10:04:19.475179 systemd[1]: Started systemd-ask-password-console.path. May 15 10:04:19.475189 systemd[1]: Started systemd-ask-password-wall.path. May 15 10:04:19.475199 systemd[1]: Set up automount boot.automount. May 15 10:04:19.475217 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. May 15 10:04:19.475232 systemd[1]: Reached target integritysetup.target. May 15 10:04:19.475243 systemd[1]: Reached target remote-cryptsetup.target. May 15 10:04:19.475254 systemd[1]: Reached target remote-fs.target. May 15 10:04:19.475264 systemd[1]: Reached target slices.target. May 15 10:04:19.475276 systemd[1]: Reached target swap.target. May 15 10:04:19.475286 systemd[1]: Reached target torcx.target. May 15 10:04:19.475298 systemd[1]: Reached target veritysetup.target. May 15 10:04:19.475313 systemd[1]: Listening on systemd-coredump.socket. May 15 10:04:19.475325 systemd[1]: Listening on systemd-initctl.socket. May 15 10:04:19.475336 kernel: kauditd_printk_skb: 79 callbacks suppressed May 15 10:04:19.475346 kernel: audit: type=1400 audit(1747303459.363:83): avc: denied { audit_read } for pid=1 comm="systemd" capability=37 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 May 15 10:04:19.475356 systemd[1]: Listening on systemd-journald-audit.socket. May 15 10:04:19.475367 kernel: audit: type=1335 audit(1747303459.363:84): pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 May 15 10:04:19.475379 systemd[1]: Listening on systemd-journald-dev-log.socket. May 15 10:04:19.475389 systemd[1]: Listening on systemd-journald.socket. May 15 10:04:19.475400 systemd[1]: Listening on systemd-networkd.socket. May 15 10:04:19.475410 systemd[1]: Listening on systemd-udevd-control.socket. May 15 10:04:19.475421 systemd[1]: Listening on systemd-udevd-kernel.socket. May 15 10:04:19.475431 systemd[1]: Listening on systemd-userdbd.socket. May 15 10:04:19.475442 systemd[1]: Mounting dev-hugepages.mount... May 15 10:04:19.475452 systemd[1]: Mounting dev-mqueue.mount... May 15 10:04:19.475463 systemd[1]: Mounting media.mount... May 15 10:04:19.475475 systemd[1]: Mounting sys-kernel-debug.mount... May 15 10:04:19.475486 systemd[1]: Mounting sys-kernel-tracing.mount... May 15 10:04:19.475499 systemd[1]: Mounting tmp.mount... May 15 10:04:19.475510 systemd[1]: Starting flatcar-tmpfiles.service... May 15 10:04:19.475525 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. May 15 10:04:19.475535 systemd[1]: Starting kmod-static-nodes.service... May 15 10:04:19.475550 systemd[1]: Starting modprobe@configfs.service... May 15 10:04:19.475561 systemd[1]: Starting modprobe@dm_mod.service... May 15 10:04:19.475571 systemd[1]: Starting modprobe@drm.service... May 15 10:04:19.475584 systemd[1]: Starting modprobe@efi_pstore.service... May 15 10:04:19.475594 systemd[1]: Starting modprobe@fuse.service... May 15 10:04:19.475605 systemd[1]: Starting modprobe@loop.service... May 15 10:04:19.475616 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 15 10:04:19.475626 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. May 15 10:04:19.475637 systemd[1]: (This warning is only shown for the first unit using IP firewalling.) May 15 10:04:19.475647 systemd[1]: Starting systemd-journald.service... May 15 10:04:19.475657 kernel: fuse: init (API version 7.34) May 15 10:04:19.475669 systemd[1]: Starting systemd-modules-load.service... May 15 10:04:19.475679 systemd[1]: Starting systemd-network-generator.service... May 15 10:04:19.475690 systemd[1]: Starting systemd-remount-fs.service... May 15 10:04:19.475701 systemd[1]: Starting systemd-udev-trigger.service... May 15 10:04:19.475712 kernel: loop: module loaded May 15 10:04:19.475722 systemd[1]: Mounted dev-hugepages.mount. May 15 10:04:19.475732 systemd[1]: Mounted dev-mqueue.mount. May 15 10:04:19.475742 systemd[1]: Mounted media.mount. May 15 10:04:19.475752 systemd[1]: Mounted sys-kernel-debug.mount. May 15 10:04:19.475762 systemd[1]: Mounted sys-kernel-tracing.mount. May 15 10:04:19.475773 kernel: audit: type=1305 audit(1747303459.472:85): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 May 15 10:04:19.475787 systemd-journald[1034]: Journal started May 15 10:04:19.475828 systemd-journald[1034]: Runtime Journal (/run/log/journal/ff163abb303c4936b83b010dbf8fe5f9) is 6.0M, max 48.7M, 42.6M free. May 15 10:04:19.363000 audit[1]: AVC avc: denied { audit_read } for pid=1 comm="systemd" capability=37 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 May 15 10:04:19.363000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 May 15 10:04:19.472000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 May 15 10:04:19.472000 audit[1034]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffefbf8100 a2=4000 a3=1 items=0 ppid=1 pid=1034 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) May 15 10:04:19.480357 kernel: audit: type=1300 audit(1747303459.472:85): arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=ffffefbf8100 a2=4000 a3=1 items=0 ppid=1 pid=1034 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) May 15 10:04:19.480412 systemd[1]: Started systemd-journald.service. May 15 10:04:19.480430 kernel: audit: type=1327 audit(1747303459.472:85): proctitle="/usr/lib/systemd/systemd-journald" May 15 10:04:19.472000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" May 15 10:04:19.482000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.483826 systemd[1]: Mounted tmp.mount. May 15 10:04:19.485993 kernel: audit: type=1130 audit(1747303459.482:86): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.489381 systemd[1]: Finished kmod-static-nodes.service. May 15 10:04:19.489000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.490583 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 15 10:04:19.490814 systemd[1]: Finished modprobe@configfs.service. May 15 10:04:19.493000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.494451 systemd[1]: Finished flatcar-tmpfiles.service. May 15 10:04:19.496715 kernel: audit: type=1130 audit(1747303459.489:87): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.500059 kernel: audit: type=1130 audit(1747303459.493:88): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.500084 kernel: audit: type=1131 audit(1747303459.493:89): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.493000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.499000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.501016 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 10:04:19.501239 systemd[1]: Finished modprobe@dm_mod.service. May 15 10:04:19.503976 kernel: audit: type=1130 audit(1747303459.499:90): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.503000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.503000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.504259 systemd[1]: modprobe@drm.service: Deactivated successfully. May 15 10:04:19.504475 systemd[1]: Finished modprobe@drm.service. May 15 10:04:19.504000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.504000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.505716 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 10:04:19.505871 systemd[1]: Finished modprobe@efi_pstore.service. May 15 10:04:19.505000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.505000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.507040 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 15 10:04:19.507195 systemd[1]: Finished modprobe@fuse.service. May 15 10:04:19.507000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.507000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.508248 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 10:04:19.508414 systemd[1]: Finished modprobe@loop.service. May 15 10:04:19.508000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.508000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.509920 systemd[1]: Finished systemd-modules-load.service. May 15 10:04:19.509000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.511310 systemd[1]: Finished systemd-network-generator.service. May 15 10:04:19.512000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.512765 systemd[1]: Finished systemd-remount-fs.service. May 15 10:04:19.513000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.514020 systemd[1]: Reached target network-pre.target. May 15 10:04:19.516107 systemd[1]: Mounting sys-fs-fuse-connections.mount... May 15 10:04:19.517996 systemd[1]: Mounting sys-kernel-config.mount... May 15 10:04:19.518766 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 15 10:04:19.520613 systemd[1]: Starting systemd-hwdb-update.service... May 15 10:04:19.523092 systemd[1]: Starting systemd-journal-flush.service... May 15 10:04:19.524037 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 10:04:19.525432 systemd[1]: Starting systemd-random-seed.service... May 15 10:04:19.526469 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. May 15 10:04:19.527579 systemd[1]: Starting systemd-sysctl.service... May 15 10:04:19.529723 systemd[1]: Starting systemd-sysusers.service... May 15 10:04:19.533387 systemd[1]: Finished systemd-udev-trigger.service. May 15 10:04:19.534000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.534717 systemd[1]: Mounted sys-fs-fuse-connections.mount. May 15 10:04:19.535916 systemd[1]: Mounted sys-kernel-config.mount. May 15 10:04:19.539000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.538230 systemd[1]: Finished systemd-random-seed.service. May 15 10:04:19.539372 systemd[1]: Reached target first-boot-complete.target. May 15 10:04:19.547985 systemd-journald[1034]: Time spent on flushing to /var/log/journal/ff163abb303c4936b83b010dbf8fe5f9 is 13.935ms for 921 entries. May 15 10:04:19.547985 systemd-journald[1034]: System Journal (/var/log/journal/ff163abb303c4936b83b010dbf8fe5f9) is 8.0M, max 195.6M, 187.6M free. May 15 10:04:19.581504 systemd-journald[1034]: Received client request to flush runtime journal. May 15 10:04:19.558000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.575000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.541792 systemd[1]: Starting systemd-udev-settle.service... May 15 10:04:19.557772 systemd[1]: Finished systemd-sysctl.service. May 15 10:04:19.583000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.583703 udevadm[1079]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. May 15 10:04:19.571370 systemd[1]: Finished systemd-sysusers.service. May 15 10:04:19.577760 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... May 15 10:04:19.582456 systemd[1]: Finished systemd-journal-flush.service. May 15 10:04:19.599000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.598996 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. May 15 10:04:19.903000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.903183 systemd[1]: Finished systemd-hwdb-update.service. May 15 10:04:19.905353 systemd[1]: Starting systemd-udevd.service... May 15 10:04:19.928482 systemd-udevd[1089]: Using default interface naming scheme 'v252'. May 15 10:04:19.940091 systemd[1]: Started systemd-udevd.service. May 15 10:04:19.939000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:19.942507 systemd[1]: Starting systemd-networkd.service... May 15 10:04:19.950320 systemd[1]: Starting systemd-userdbd.service... May 15 10:04:19.968573 systemd[1]: Found device dev-ttyAMA0.device. May 15 10:04:19.992319 systemd[1]: Started systemd-userdbd.service. May 15 10:04:19.992000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.045238 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. May 15 10:04:20.050556 systemd-networkd[1091]: lo: Link UP May 15 10:04:20.050565 systemd-networkd[1091]: lo: Gained carrier May 15 10:04:20.050910 systemd-networkd[1091]: Enumeration completed May 15 10:04:20.051027 systemd-networkd[1091]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 15 10:04:20.051042 systemd[1]: Started systemd-networkd.service. May 15 10:04:20.051000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.052870 systemd-networkd[1091]: eth0: Link UP May 15 10:04:20.052881 systemd-networkd[1091]: eth0: Gained carrier May 15 10:04:20.078135 systemd-networkd[1091]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 15 10:04:20.081530 systemd[1]: Finished systemd-udev-settle.service. May 15 10:04:20.081000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.083715 systemd[1]: Starting lvm2-activation-early.service... May 15 10:04:20.099099 lvm[1123]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 15 10:04:20.126910 systemd[1]: Finished lvm2-activation-early.service. May 15 10:04:20.126000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.128021 systemd[1]: Reached target cryptsetup.target. May 15 10:04:20.130020 systemd[1]: Starting lvm2-activation.service... May 15 10:04:20.133599 lvm[1125]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 15 10:04:20.161943 systemd[1]: Finished lvm2-activation.service. May 15 10:04:20.161000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.162920 systemd[1]: Reached target local-fs-pre.target. May 15 10:04:20.163818 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). May 15 10:04:20.163850 systemd[1]: Reached target local-fs.target. May 15 10:04:20.164654 systemd[1]: Reached target machines.target. May 15 10:04:20.166723 systemd[1]: Starting ldconfig.service... May 15 10:04:20.168000 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. May 15 10:04:20.168063 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.169251 systemd[1]: Starting systemd-boot-update.service... May 15 10:04:20.171220 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... May 15 10:04:20.173527 systemd[1]: Starting systemd-machine-id-commit.service... May 15 10:04:20.175756 systemd[1]: Starting systemd-sysext.service... May 15 10:04:20.177058 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1128 (bootctl) May 15 10:04:20.178159 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... May 15 10:04:20.192333 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. May 15 10:04:20.193000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.197572 systemd[1]: Unmounting usr-share-oem.mount... May 15 10:04:20.203334 systemd[1]: usr-share-oem.mount: Deactivated successfully. May 15 10:04:20.203603 systemd[1]: Unmounted usr-share-oem.mount. May 15 10:04:20.267992 kernel: loop0: detected capacity change from 0 to 194096 May 15 10:04:20.281633 systemd-fsck[1138]: fsck.fat 4.2 (2021-01-31) May 15 10:04:20.281633 systemd-fsck[1138]: /dev/vda1: 236 files, 117182/258078 clusters May 15 10:04:20.283417 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. May 15 10:04:20.283982 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 15 10:04:20.283000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.301828 systemd[1]: Finished systemd-machine-id-commit.service. May 15 10:04:20.302000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.306980 kernel: loop1: detected capacity change from 0 to 194096 May 15 10:04:20.311844 (sd-sysext)[1146]: Using extensions 'kubernetes'. May 15 10:04:20.312510 (sd-sysext)[1146]: Merged extensions into '/usr'. May 15 10:04:20.327668 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. May 15 10:04:20.329103 systemd[1]: Starting modprobe@dm_mod.service... May 15 10:04:20.331193 systemd[1]: Starting modprobe@efi_pstore.service... May 15 10:04:20.333084 systemd[1]: Starting modprobe@loop.service... May 15 10:04:20.333884 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. May 15 10:04:20.334046 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.334716 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 10:04:20.334861 systemd[1]: Finished modprobe@dm_mod.service. May 15 10:04:20.335000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.335000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.336394 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 10:04:20.336529 systemd[1]: Finished modprobe@efi_pstore.service. May 15 10:04:20.336000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.336000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.338004 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 10:04:20.338200 systemd[1]: Finished modprobe@loop.service. May 15 10:04:20.338000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.338000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.339438 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 10:04:20.339540 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. May 15 10:04:20.391625 ldconfig[1127]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 15 10:04:20.395265 systemd[1]: Finished ldconfig.service. May 15 10:04:20.395000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ldconfig comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.464387 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 15 10:04:20.466290 systemd[1]: Mounting boot.mount... May 15 10:04:20.468297 systemd[1]: Mounting usr-share-oem.mount... May 15 10:04:20.474859 systemd[1]: Mounted boot.mount. May 15 10:04:20.475888 systemd[1]: Mounted usr-share-oem.mount. May 15 10:04:20.478009 systemd[1]: Finished systemd-sysext.service. May 15 10:04:20.477000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.480403 systemd[1]: Starting ensure-sysext.service... May 15 10:04:20.482449 systemd[1]: Starting systemd-tmpfiles-setup.service... May 15 10:04:20.485632 systemd[1]: Finished systemd-boot-update.service. May 15 10:04:20.486000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.488279 systemd[1]: Reloading. May 15 10:04:20.491897 systemd-tmpfiles[1164]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. May 15 10:04:20.493109 systemd-tmpfiles[1164]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 15 10:04:20.494424 systemd-tmpfiles[1164]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 15 10:04:20.512813 /usr/lib/systemd/system-generators/torcx-generator[1187]: time="2025-05-15T10:04:20Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.100 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.100 /var/lib/torcx/store]" May 15 10:04:20.513372 /usr/lib/systemd/system-generators/torcx-generator[1187]: time="2025-05-15T10:04:20Z" level=info msg="torcx already run" May 15 10:04:20.598317 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. May 15 10:04:20.598337 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. May 15 10:04:20.615578 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 15 10:04:20.657243 systemd[1]: Finished systemd-tmpfiles-setup.service. May 15 10:04:20.658000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.661452 systemd[1]: Starting audit-rules.service... May 15 10:04:20.663545 systemd[1]: Starting clean-ca-certificates.service... May 15 10:04:20.665733 systemd[1]: Starting systemd-journal-catalog-update.service... May 15 10:04:20.668220 systemd[1]: Starting systemd-resolved.service... May 15 10:04:20.670489 systemd[1]: Starting systemd-timesyncd.service... May 15 10:04:20.674493 systemd[1]: Starting systemd-update-utmp.service... May 15 10:04:20.676126 systemd[1]: Finished clean-ca-certificates.service. May 15 10:04:20.677000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.679715 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 15 10:04:20.680000 audit[1242]: SYSTEM_BOOT pid=1242 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' May 15 10:04:20.684307 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. May 15 10:04:20.686053 systemd[1]: Starting modprobe@dm_mod.service... May 15 10:04:20.688255 systemd[1]: Starting modprobe@efi_pstore.service... May 15 10:04:20.690566 systemd[1]: Starting modprobe@loop.service... May 15 10:04:20.691515 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. May 15 10:04:20.691730 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.691917 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 15 10:04:20.693081 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 10:04:20.693000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.693000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.693271 systemd[1]: Finished modprobe@dm_mod.service. May 15 10:04:20.694712 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 10:04:20.694865 systemd[1]: Finished modprobe@loop.service. May 15 10:04:20.695000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.695000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.696162 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. May 15 10:04:20.697402 systemd[1]: Finished systemd-update-utmp.service. May 15 10:04:20.698000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.700106 systemd[1]: Finished systemd-journal-catalog-update.service. May 15 10:04:20.701000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.702327 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. May 15 10:04:20.703668 systemd[1]: Starting modprobe@dm_mod.service... May 15 10:04:20.707345 systemd[1]: Starting modprobe@loop.service... May 15 10:04:20.708274 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. May 15 10:04:20.708422 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.719746 systemd[1]: Starting systemd-update-done.service... May 15 10:04:20.722000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.722000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.720787 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 15 10:04:20.721854 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 10:04:20.722072 systemd[1]: Finished modprobe@efi_pstore.service. May 15 10:04:20.723426 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 10:04:20.723571 systemd[1]: Finished modprobe@dm_mod.service. May 15 10:04:20.724000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.724000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.724000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.724000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.724880 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 10:04:20.725041 systemd[1]: Finished modprobe@loop.service. May 15 10:04:20.726238 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 10:04:20.726335 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. May 15 10:04:20.729253 systemd[1]: Finished systemd-update-done.service. May 15 10:04:20.730000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-done comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.732820 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. May 15 10:04:20.734504 systemd[1]: Starting modprobe@dm_mod.service... May 15 10:04:20.738474 systemd[1]: Starting modprobe@drm.service... May 15 10:04:20.740693 systemd[1]: Starting modprobe@efi_pstore.service... May 15 10:04:20.742814 systemd[1]: Starting modprobe@loop.service... May 15 10:04:20.743775 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. May 15 10:04:20.743909 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.745356 systemd[1]: Starting systemd-networkd-wait-online.service... May 15 10:04:20.746794 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). May 15 10:04:20.748214 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 15 10:04:20.748395 systemd[1]: Finished modprobe@dm_mod.service. May 15 10:04:20.749000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.749000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.749811 systemd[1]: modprobe@drm.service: Deactivated successfully. May 15 10:04:20.749983 systemd[1]: Finished modprobe@drm.service. May 15 10:04:20.757097 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 15 10:04:20.757290 systemd[1]: Finished modprobe@efi_pstore.service. May 15 10:04:20.758760 systemd[1]: modprobe@loop.service: Deactivated successfully. May 15 10:04:20.758934 systemd[1]: Finished modprobe@loop.service. May 15 10:04:20.756000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.756000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.758000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.758000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.758000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.758000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.760355 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 15 10:04:20.760449 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. May 15 10:04:20.761908 systemd[1]: Finished ensure-sysext.service. May 15 10:04:20.762000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=ensure-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.774200 systemd[1]: Started systemd-timesyncd.service. May 15 10:04:20.774904 systemd-timesyncd[1241]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 15 10:04:20.774997 systemd-timesyncd[1241]: Initial clock synchronization to Thu 2025-05-15 10:04:21.098139 UTC. May 15 10:04:20.775000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-timesyncd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' May 15 10:04:20.775658 systemd[1]: Reached target time-set.target. May 15 10:04:20.775000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 May 15 10:04:20.775000 audit[1278]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffedd53b50 a2=420 a3=0 items=0 ppid=1230 pid=1278 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) May 15 10:04:20.775000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 May 15 10:04:20.776256 augenrules[1278]: No rules May 15 10:04:20.777201 systemd[1]: Finished audit-rules.service. May 15 10:04:20.782723 systemd-resolved[1235]: Positive Trust Anchors: May 15 10:04:20.786581 systemd-resolved[1235]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 15 10:04:20.786669 systemd-resolved[1235]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test May 15 10:04:20.796904 systemd-resolved[1235]: Defaulting to hostname 'linux'. May 15 10:04:20.800186 systemd[1]: Started systemd-resolved.service. May 15 10:04:20.801133 systemd[1]: Reached target network.target. May 15 10:04:20.801906 systemd[1]: Reached target nss-lookup.target. May 15 10:04:20.802744 systemd[1]: Reached target sysinit.target. May 15 10:04:20.803649 systemd[1]: Started motdgen.path. May 15 10:04:20.804560 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. May 15 10:04:20.805859 systemd[1]: Started logrotate.timer. May 15 10:04:20.806797 systemd[1]: Started mdadm.timer. May 15 10:04:20.807546 systemd[1]: Started systemd-tmpfiles-clean.timer. May 15 10:04:20.808446 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 15 10:04:20.808478 systemd[1]: Reached target paths.target. May 15 10:04:20.809257 systemd[1]: Reached target timers.target. May 15 10:04:20.810373 systemd[1]: Listening on dbus.socket. May 15 10:04:20.812357 systemd[1]: Starting docker.socket... May 15 10:04:20.814116 systemd[1]: Listening on sshd.socket. May 15 10:04:20.814935 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.815311 systemd[1]: Listening on docker.socket. May 15 10:04:20.816093 systemd[1]: Reached target sockets.target. May 15 10:04:20.816843 systemd[1]: Reached target basic.target. May 15 10:04:20.817751 systemd[1]: System is tainted: cgroupsv1 May 15 10:04:20.817801 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. May 15 10:04:20.817826 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. May 15 10:04:20.818880 systemd[1]: Starting containerd.service... May 15 10:04:20.820724 systemd[1]: Starting dbus.service... May 15 10:04:20.822638 systemd[1]: Starting enable-oem-cloudinit.service... May 15 10:04:20.825065 systemd[1]: Starting extend-filesystems.service... May 15 10:04:20.825978 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). May 15 10:04:20.827441 systemd[1]: Starting motdgen.service... May 15 10:04:20.830980 jq[1290]: false May 15 10:04:20.830257 systemd[1]: Starting ssh-key-proc-cmdline.service... May 15 10:04:20.832373 systemd[1]: Starting sshd-keygen.service... May 15 10:04:20.837855 systemd[1]: Starting systemd-logind.service... May 15 10:04:20.838690 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). May 15 10:04:20.838802 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 15 10:04:20.840301 systemd[1]: Starting update-engine.service... May 15 10:04:20.842303 systemd[1]: Starting update-ssh-keys-after-ignition.service... May 15 10:04:20.846827 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 15 10:04:20.847103 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. May 15 10:04:20.847403 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 15 10:04:20.847606 systemd[1]: Finished ssh-key-proc-cmdline.service. May 15 10:04:20.848555 jq[1306]: true May 15 10:04:20.858583 jq[1314]: true May 15 10:04:20.861537 dbus-daemon[1289]: [system] SELinux support is enabled May 15 10:04:20.862256 systemd[1]: Started dbus.service. May 15 10:04:20.865314 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). May 15 10:04:20.865355 systemd[1]: Reached target system-config.target. May 15 10:04:20.866511 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). May 15 10:04:20.866538 systemd[1]: Reached target user-config.target. May 15 10:04:20.868911 systemd[1]: motdgen.service: Deactivated successfully. May 15 10:04:20.870540 systemd[1]: Finished motdgen.service. May 15 10:04:20.871446 extend-filesystems[1291]: Found loop1 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda May 15 10:04:20.872502 extend-filesystems[1291]: Found vda1 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda2 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda3 May 15 10:04:20.872502 extend-filesystems[1291]: Found usr May 15 10:04:20.872502 extend-filesystems[1291]: Found vda4 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda6 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda7 May 15 10:04:20.872502 extend-filesystems[1291]: Found vda9 May 15 10:04:20.872502 extend-filesystems[1291]: Checking size of /dev/vda9 May 15 10:04:20.905655 extend-filesystems[1291]: Resized partition /dev/vda9 May 15 10:04:20.913136 extend-filesystems[1342]: resize2fs 1.46.5 (30-Dec-2021) May 15 10:04:20.921010 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks May 15 10:04:20.921906 systemd-logind[1301]: Watching system buttons on /dev/input/event0 (Power Button) May 15 10:04:20.923591 systemd-logind[1301]: New seat seat0. May 15 10:04:20.928407 systemd[1]: Started systemd-logind.service. May 15 10:04:20.935427 update_engine[1305]: I0515 10:04:20.935140 1305 main.cc:92] Flatcar Update Engine starting May 15 10:04:20.939852 systemd[1]: Started update-engine.service. May 15 10:04:20.942839 systemd[1]: Started locksmithd.service. May 15 10:04:20.944753 update_engine[1305]: I0515 10:04:20.939877 1305 update_check_scheduler.cc:74] Next update check in 4m13s May 15 10:04:20.946330 bash[1340]: Updated "/home/core/.ssh/authorized_keys" May 15 10:04:20.947220 systemd[1]: Finished update-ssh-keys-after-ignition.service. May 15 10:04:20.949978 kernel: EXT4-fs (vda9): resized filesystem to 1864699 May 15 10:04:20.964178 extend-filesystems[1342]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required May 15 10:04:20.964178 extend-filesystems[1342]: old_desc_blocks = 1, new_desc_blocks = 1 May 15 10:04:20.964178 extend-filesystems[1342]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. May 15 10:04:20.969304 extend-filesystems[1291]: Resized filesystem in /dev/vda9 May 15 10:04:20.965078 systemd[1]: extend-filesystems.service: Deactivated successfully. May 15 10:04:20.965339 systemd[1]: Finished extend-filesystems.service. May 15 10:04:20.974162 env[1313]: time="2025-05-15T10:04:20.974108040Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 May 15 10:04:20.992228 env[1313]: time="2025-05-15T10:04:20.991630840Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 15 10:04:20.992228 env[1313]: time="2025-05-15T10:04:20.991807120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997168200Z" 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/5.15.182-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997221040Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997518200Z" 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 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997536760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997550560Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997560280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997628120Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.997845880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.998010600Z" 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 May 15 10:04:20.998012 env[1313]: time="2025-05-15T10:04:20.998027840Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 15 10:04:20.998329 env[1313]: time="2025-05-15T10:04:20.998085560Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" May 15 10:04:20.998329 env[1313]: time="2025-05-15T10:04:20.998097960Z" level=info msg="metadata content store policy set" policy=shared May 15 10:04:21.003598 env[1313]: time="2025-05-15T10:04:21.003549796Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 15 10:04:21.003598 env[1313]: time="2025-05-15T10:04:21.003597821Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 15 10:04:21.003744 env[1313]: time="2025-05-15T10:04:21.003613469Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 15 10:04:21.003744 env[1313]: time="2025-05-15T10:04:21.003648968Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 15 10:04:21.003744 env[1313]: time="2025-05-15T10:04:21.003664116Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 15 10:04:21.003744 env[1313]: time="2025-05-15T10:04:21.003679515Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 15 10:04:21.003744 env[1313]: time="2025-05-15T10:04:21.003694372Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004125 env[1313]: time="2025-05-15T10:04:21.004104503Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004164 env[1313]: time="2025-05-15T10:04:21.004129556Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004164 env[1313]: time="2025-05-15T10:04:21.004146369Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004164 env[1313]: time="2025-05-15T10:04:21.004159853Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004227 env[1313]: time="2025-05-15T10:04:21.004173961Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 15 10:04:21.004324 env[1313]: time="2025-05-15T10:04:21.004306634Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 15 10:04:21.004415 env[1313]: time="2025-05-15T10:04:21.004400646Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 15 10:04:21.004778 env[1313]: time="2025-05-15T10:04:21.004748893Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 15 10:04:21.004815 env[1313]: time="2025-05-15T10:04:21.004797335Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 15 10:04:21.004838 env[1313]: time="2025-05-15T10:04:21.004813399Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 15 10:04:21.005007 env[1313]: time="2025-05-15T10:04:21.004993932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005041 env[1313]: time="2025-05-15T10:04:21.005019775Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005041 env[1313]: time="2025-05-15T10:04:21.005034924Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005082 env[1313]: time="2025-05-15T10:04:21.005046701Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005082 env[1313]: time="2025-05-15T10:04:21.005060268Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005082 env[1313]: time="2025-05-15T10:04:21.005073169Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005148 env[1313]: time="2025-05-15T10:04:21.005086071Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005148 env[1313]: time="2025-05-15T10:04:21.005098639Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005148 env[1313]: time="2025-05-15T10:04:21.005116659Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 15 10:04:21.005288 env[1313]: time="2025-05-15T10:04:21.005269391Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005311 env[1313]: time="2025-05-15T10:04:21.005293238Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005311 env[1313]: time="2025-05-15T10:04:21.005307845Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005352 env[1313]: time="2025-05-15T10:04:21.005321038Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 15 10:04:21.005352 env[1313]: time="2025-05-15T10:04:21.005336020Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 May 15 10:04:21.005352 env[1313]: time="2025-05-15T10:04:21.005348588Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 15 10:04:21.005424 env[1313]: time="2025-05-15T10:04:21.005367190Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" May 15 10:04:21.005424 env[1313]: time="2025-05-15T10:04:21.005409473Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 15 10:04:21.005663 env[1313]: time="2025-05-15T10:04:21.005614101Z" 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 BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:false] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 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:false SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 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} 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}" May 15 10:04:21.006684 env[1313]: time="2025-05-15T10:04:21.005673779Z" level=info msg="Connect containerd service" May 15 10:04:21.006684 env[1313]: time="2025-05-15T10:04:21.005705200Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 15 10:04:21.006684 env[1313]: time="2025-05-15T10:04:21.006634414Z" 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" May 15 10:04:21.007050 env[1313]: time="2025-05-15T10:04:21.007014873Z" level=info msg="Start subscribing containerd event" May 15 10:04:21.007079 env[1313]: time="2025-05-15T10:04:21.007070972Z" level=info msg="Start recovering state" May 15 10:04:21.007164 env[1313]: time="2025-05-15T10:04:21.007151250Z" level=info msg="Start event monitor" May 15 10:04:21.007187 env[1313]: time="2025-05-15T10:04:21.007158075Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 15 10:04:21.007187 env[1313]: time="2025-05-15T10:04:21.007178592Z" level=info msg="Start snapshots syncer" May 15 10:04:21.007234 env[1313]: time="2025-05-15T10:04:21.007189829Z" level=info msg="Start cni network conf syncer for default" May 15 10:04:21.007234 env[1313]: time="2025-05-15T10:04:21.007199109Z" level=info msg="Start streaming server" May 15 10:04:21.007234 env[1313]: time="2025-05-15T10:04:21.007215381Z" level=info msg=serving... address=/run/containerd/containerd.sock May 15 10:04:21.008543 env[1313]: time="2025-05-15T10:04:21.007265654Z" level=info msg="containerd successfully booted in 0.034773s" May 15 10:04:21.007381 systemd[1]: Started containerd.service. May 15 10:04:21.018460 locksmithd[1344]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" May 15 10:04:21.590169 systemd-networkd[1091]: eth0: Gained IPv6LL May 15 10:04:21.591899 systemd[1]: Finished systemd-networkd-wait-online.service. May 15 10:04:21.593228 systemd[1]: Reached target network-online.target. May 15 10:04:21.595650 systemd[1]: Starting kubelet.service... May 15 10:04:22.130272 systemd[1]: Started kubelet.service. May 15 10:04:22.278758 sshd_keygen[1315]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 15 10:04:22.297474 systemd[1]: Finished sshd-keygen.service. May 15 10:04:22.300027 systemd[1]: Starting issuegen.service... May 15 10:04:22.305315 systemd[1]: issuegen.service: Deactivated successfully. May 15 10:04:22.305537 systemd[1]: Finished issuegen.service. May 15 10:04:22.307834 systemd[1]: Starting systemd-user-sessions.service... May 15 10:04:22.314572 systemd[1]: Finished systemd-user-sessions.service. May 15 10:04:22.317082 systemd[1]: Started getty@tty1.service. May 15 10:04:22.319172 systemd[1]: Started serial-getty@ttyAMA0.service. May 15 10:04:22.320317 systemd[1]: Reached target getty.target. May 15 10:04:22.321340 systemd[1]: Reached target multi-user.target. May 15 10:04:22.323725 systemd[1]: Starting systemd-update-utmp-runlevel.service... May 15 10:04:22.331029 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. May 15 10:04:22.331244 systemd[1]: Finished systemd-update-utmp-runlevel.service. May 15 10:04:22.332469 systemd[1]: Startup finished in 4.496s (kernel) + 4.853s (userspace) = 9.349s. May 15 10:04:22.652800 kubelet[1368]: E0515 10:04:22.652743 1368 run.go:74] "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" May 15 10:04:22.654852 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE May 15 10:04:22.655021 systemd[1]: kubelet.service: Failed with result 'exit-code'. May 15 10:04:26.026757 systemd[1]: Created slice system-sshd.slice. May 15 10:04:26.027951 systemd[1]: Started sshd@0-10.0.0.19:22-10.0.0.1:44516.service. May 15 10:04:26.078312 sshd[1395]: Accepted publickey for core from 10.0.0.1 port 44516 ssh2: RSA SHA256:I/C30/eWBhvgAgcCboY0f9pk+vr1TzGX+qBjeoJjilE May 15 10:04:26.080270 sshd[1395]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.091273 systemd[1]: Created slice user-500.slice. May 15 10:04:26.092290 systemd[1]: Starting user-runtime-dir@500.service... May 15 10:04:26.095553 systemd-logind[1301]: New session 1 of user core. May 15 10:04:26.108582 systemd[1]: Finished user-runtime-dir@500.service. May 15 10:04:26.109916 systemd[1]: Starting user@500.service... May 15 10:04:26.118396 (systemd)[1400]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.184586 systemd[1400]: Queued start job for default target default.target. May 15 10:04:26.184962 systemd[1400]: Reached target paths.target. May 15 10:04:26.185671 systemd[1400]: Reached target sockets.target. May 15 10:04:26.185684 systemd[1400]: Reached target timers.target. May 15 10:04:26.185694 systemd[1400]: Reached target basic.target. May 15 10:04:26.185741 systemd[1400]: Reached target default.target. May 15 10:04:26.185763 systemd[1400]: Startup finished in 61ms. May 15 10:04:26.185853 systemd[1]: Started user@500.service. May 15 10:04:26.186821 systemd[1]: Started session-1.scope. May 15 10:04:26.238483 systemd[1]: Started sshd@1-10.0.0.19:22-10.0.0.1:44532.service. May 15 10:04:26.279452 sshd[1409]: Accepted publickey for core from 10.0.0.1 port 44532 ssh2: RSA SHA256:I/C30/eWBhvgAgcCboY0f9pk+vr1TzGX+qBjeoJjilE May 15 10:04:26.280687 sshd[1409]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.284968 systemd-logind[1301]: New session 2 of user core. May 15 10:04:26.285710 systemd[1]: Started session-2.scope. May 15 10:04:26.342907 sshd[1409]: pam_unix(sshd:session): session closed for user core May 15 10:04:26.345143 systemd[1]: Started sshd@2-10.0.0.19:22-10.0.0.1:44536.service. May 15 10:04:26.345938 systemd[1]: sshd@1-10.0.0.19:22-10.0.0.1:44532.service: Deactivated successfully. May 15 10:04:26.346843 systemd[1]: session-2.scope: Deactivated successfully. May 15 10:04:26.346868 systemd-logind[1301]: Session 2 logged out. Waiting for processes to exit. May 15 10:04:26.347940 systemd-logind[1301]: Removed session 2. May 15 10:04:26.380655 sshd[1414]: Accepted publickey for core from 10.0.0.1 port 44536 ssh2: RSA SHA256:I/C30/eWBhvgAgcCboY0f9pk+vr1TzGX+qBjeoJjilE May 15 10:04:26.381894 sshd[1414]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.385181 systemd-logind[1301]: New session 3 of user core. May 15 10:04:26.386151 systemd[1]: Started session-3.scope. May 15 10:04:26.437382 sshd[1414]: pam_unix(sshd:session): session closed for user core May 15 10:04:26.440007 systemd[1]: Started sshd@3-10.0.0.19:22-10.0.0.1:44552.service. May 15 10:04:26.440741 systemd[1]: sshd@2-10.0.0.19:22-10.0.0.1:44536.service: Deactivated successfully. May 15 10:04:26.441661 systemd-logind[1301]: Session 3 logged out. Waiting for processes to exit. May 15 10:04:26.441868 systemd[1]: session-3.scope: Deactivated successfully. May 15 10:04:26.442797 systemd-logind[1301]: Removed session 3. May 15 10:04:26.476457 sshd[1422]: Accepted publickey for core from 10.0.0.1 port 44552 ssh2: RSA SHA256:I/C30/eWBhvgAgcCboY0f9pk+vr1TzGX+qBjeoJjilE May 15 10:04:26.477768 sshd[1422]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.481135 systemd-logind[1301]: New session 4 of user core. May 15 10:04:26.482099 systemd[1]: Started session-4.scope. May 15 10:04:26.541397 sshd[1422]: pam_unix(sshd:session): session closed for user core May 15 10:04:26.544262 systemd[1]: Started sshd@4-10.0.0.19:22-10.0.0.1:44568.service. May 15 10:04:26.545938 systemd[1]: sshd@3-10.0.0.19:22-10.0.0.1:44552.service: Deactivated successfully. May 15 10:04:26.547106 systemd-logind[1301]: Session 4 logged out. Waiting for processes to exit. May 15 10:04:26.547273 systemd[1]: session-4.scope: Deactivated successfully. May 15 10:04:26.548061 systemd-logind[1301]: Removed session 4. May 15 10:04:26.579942 sshd[1428]: Accepted publickey for core from 10.0.0.1 port 44568 ssh2: RSA SHA256:I/C30/eWBhvgAgcCboY0f9pk+vr1TzGX+qBjeoJjilE May 15 10:04:26.581397 sshd[1428]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) May 15 10:04:26.584753 systemd-logind[1301]: New session 5 of user core. May 15 10:04:26.585788 systemd[1]: Started session-5.scope. May 15 10:04:26.656377 sudo[1434]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh May 15 10:04:26.656600 sudo[1434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) May 15 10:04:26.668851 systemd[1]: Starting coreos-metadata.service... May 15 10:04:26.675731 systemd[1]: coreos-metadata.service: Deactivated successfully. May 15 10:04:26.675965 systemd[1]: Finished coreos-metadata.service. May 15 10:04:27.263063 systemd[1]: Stopped kubelet.service. May 15 10:04:27.265878 systemd[1]: Starting kubelet.service... May 15 10:04:27.285671 systemd[1]: Reloading. May 15 10:04:27.336586 /usr/lib/systemd/system-generators/torcx-generator[1503]: time="2025-05-15T10:04:27Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.100 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.100 /var/lib/torcx/store]" May 15 10:04:27.336620 /usr/lib/systemd/system-generators/torcx-generator[1503]: time="2025-05-15T10:04:27Z" level=info msg="torcx already run" May 15 10:04:27.414578 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. May 15 10:04:27.414597 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. May 15 10:04:27.432558 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. May 15 10:04:27.495165 systemd[1]: Started kubelet.service. May 15 10:04:27.496789 systemd[1]: Stopping kubelet.service... May 15 10:04:27.497120 systemd[1]: kubelet.service: Deactivated successfully. May 15 10:04:27.497362 systemd[1]: Stopped kubelet.service. May 15 10:04:27.498918 systemd[1]: Starting kubelet.service... May 15 10:04:27.579670 systemd[1]: Started kubelet.service. May 15 10:04:27.616002 kubelet[1561]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. May 15 10:04:27.616002 kubelet[1561]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI. May 15 10:04:27.616002 kubelet[1561]: 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. May 15 10:04:27.617093 kubelet[1561]: I0515 10:04:27.617045 1561 server.go:205] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" May 15 10:04:28.824508 kubelet[1561]: I0515 10:04:28.824459 1561 server.go:484] "Kubelet version" kubeletVersion="v1.30.1" May 15 10:04:28.824508 kubelet[1561]: I0515 10:04:28.824494 1561 server.go:486] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" May 15 10:04:28.824865 kubelet[1561]: I0515 10:04:28.824695 1561 server.go:927] "Client rotation is on, will bootstrap in background" May 15 10:04:28.867418 kubelet[1561]: I0515 10:04:28.867385 1561 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" May 15 10:04:28.877000 kubelet[1561]: I0515 10:04:28.876937 1561 server.go:742] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" May 15 10:04:28.877573 kubelet[1561]: I0515 10:04:28.877530 1561 container_manager_linux.go:265] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] May 15 10:04:28.877746 kubelet[1561]: I0515 10:04:28.877569 1561 container_manager_linux.go:270] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.19","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null} May 15 10:04:28.877823 kubelet[1561]: I0515 10:04:28.877814 1561 topology_manager.go:138] "Creating topology manager with none policy" May 15 10:04:28.877846 kubelet[1561]: I0515 10:04:28.877825 1561 container_manager_linux.go:301] "Creating device plugin manager" May 15 10:04:28.878812 kubelet[1561]: I0515 10:04:28.878784 1561 state_mem.go:36] "Initialized new in-memory state store" May 15 10:04:28.881948 kubelet[1561]: I0515 10:04:28.881924 1561 kubelet.go:400] "Attempting to sync node with API server" May 15 10:04:28.881948 kubelet[1561]: I0515 10:04:28.881950 1561 kubelet.go:301] "Adding static pod path" path="/etc/kubernetes/manifests" May 15 10:04:28.882129 kubelet[1561]: I0515 10:04:28.882113 1561 kubelet.go:312] "Adding apiserver pod source" May 15 10:04:28.882169 kubelet[1561]: I0515 10:04:28.882133 1561 apiserver.go:42] "Waiting for node sync before watching apiserver pods" May 15 10:04:28.882709 kubelet[1561]: E0515 10:04:28.882689 1561 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:28.882867 kubelet[1561]: E0515 10:04:28.882854 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:28.883384 kubelet[1561]: I0515 10:04:28.883349 1561 kuberuntime_manager.go:261] "Container runtime initialized" containerRuntime="containerd" version="1.6.16" apiVersion="v1" May 15 10:04:28.883761 kubelet[1561]: I0515 10:04:28.883736 1561 kubelet.go:815] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" May 15 10:04:28.883860 kubelet[1561]: W0515 10:04:28.883847 1561 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. May 15 10:04:28.885084 kubelet[1561]: I0515 10:04:28.885063 1561 server.go:1264] "Started kubelet" May 15 10:04:28.886444 kubelet[1561]: I0515 10:04:28.886394 1561 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 May 15 10:04:28.887555 kernel: SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). May 15 10:04:28.889250 kubelet[1561]: I0515 10:04:28.889203 1561 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 May 15 10:04:28.889539 kubelet[1561]: I0515 10:04:28.889514 1561 server.go:227] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" May 15 10:04:28.889667 kubelet[1561]: I0515 10:04:28.889652 1561 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" May 15 10:04:28.891003 kubelet[1561]: I0515 10:04:28.890981 1561 server.go:455] "Adding debug handlers to kubelet server" May 15 10:04:28.892161 kubelet[1561]: I0515 10:04:28.892138 1561 volume_manager.go:291] "Starting Kubelet Volume Manager" May 15 10:04:28.893189 kubelet[1561]: I0515 10:04:28.893162 1561 desired_state_of_world_populator.go:149] "Desired state populator starts to run" May 15 10:04:28.893395 kubelet[1561]: I0515 10:04:28.893376 1561 reconciler.go:26] "Reconciler: start to sync state" May 15 10:04:28.895038 kubelet[1561]: I0515 10:04:28.895012 1561 factory.go:221] Registration of the systemd container factory successfully May 15 10:04:28.895162 kubelet[1561]: I0515 10:04:28.895137 1561 factory.go:219] 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 May 15 10:04:28.896543 kubelet[1561]: W0515 10:04:28.896513 1561 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope May 15 10:04:28.896607 kubelet[1561]: E0515 10:04:28.896546 1561 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope May 15 10:04:28.896631 kubelet[1561]: W0515 10:04:28.896622 1561 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.19" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope May 15 10:04:28.896660 kubelet[1561]: E0515 10:04:28.896633 1561 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes "10.0.0.19" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope May 15 10:04:28.896940 kubelet[1561]: W0515 10:04:28.896917 1561 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope May 15 10:04:28.897006 kubelet[1561]: E0515 10:04:28.896955 1561 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope May 15 10:04:28.897039 kubelet[1561]: E0515 10:04:28.897015 1561 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.19\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms" May 15 10:04:28.897672 kubelet[1561]: E0515 10:04:28.897639 1561 kubelet.go:1467] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" May 15 10:04:28.899972 kubelet[1561]: I0515 10:04:28.899101 1561 factory.go:221] Registration of the containerd container factory successfully May 15 10:04:28.905344 kubelet[1561]: E0515 10:04:28.905143 1561 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.19.183fab3f51b35864 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.19,UID:10.0.0.19,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.19,},FirstTimestamp:2025-05-15 10:04:28.885039204 +0000 UTC m=+1.301615667,LastTimestamp:2025-05-15 10:04:28.885039204 +0000 UTC m=+1.301615667,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.19,}" May 15 10:04:28.910003 kubelet[1561]: E0515 10:04:28.909827 1561 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.19.183fab3f52736ae4 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.19,UID:10.0.0.19,APIVersion:,ResourceVersion:,FieldPath:,},Reason:InvalidDiskCapacity,Message:invalid capacity 0 on image filesystem,Source:EventSource{Component:kubelet,Host:10.0.0.19,},FirstTimestamp:2025-05-15 10:04:28.897626852 +0000 UTC m=+1.314203316,LastTimestamp:2025-05-15 10:04:28.897626852 +0000 UTC m=+1.314203316,Count:1,Type:Warning,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.19,}" May 15 10:04:28.920499 kubelet[1561]: I0515 10:04:28.920463 1561 cpu_manager.go:214] "Starting CPU manager" policy="none" May 15 10:04:28.920499 kubelet[1561]: I0515 10:04:28.920487 1561 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" May 15 10:04:28.920635 kubelet[1561]: I0515 10:04:28.920512 1561 state_mem.go:36] "Initialized new in-memory state store" May 15 10:04:28.921125 kubelet[1561]: E0515 10:04:28.921037 1561 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.19.183fab3f53c3621e default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.19,UID:10.0.0.19,APIVersion:,ResourceVersion:,FieldPath:,},Reason:NodeHasSufficientMemory,Message:Node 10.0.0.19 status is now: NodeHasSufficientMemory,Source:EventSource{Component:kubelet,Host:10.0.0.19,},FirstTimestamp:2025-05-15 10:04:28.919644702 +0000 UTC m=+1.336221166,LastTimestamp:2025-05-15 10:04:28.919644702 +0000 UTC m=+1.336221166,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.19,}" May 15 10:04:28.993005 kubelet[1561]: I0515 10:04:28.992938 1561 policy_none.go:49] "None policy: Start" May 15 10:04:28.993341 kubelet[1561]: I0515 10:04:28.993321 1561 kubelet_node_status.go:73] "Attempting to register node" node="10.0.0.19" May 15 10:04:28.993607 kubelet[1561]: I0515 10:04:28.993587 1561 memory_manager.go:170] "Starting memorymanager" policy="None" May 15 10:04:28.993646 kubelet[1561]: I0515 10:04:28.993614 1561 state_mem.go:35] "Initializing new in-memory state store" May 15 10:04:28.999191 kubelet[1561]: I0515 10:04:28.998988 1561 manager.go:479] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" May 15 10:04:28.999191 kubelet[1561]: I0515 10:04:28.999156 1561 container_log_manager.go:186] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" May 15 10:04:28.999622 kubelet[1561]: I0515 10:04:28.999561 1561 plugin_manager.go:118] "Starting Kubelet Plugin Manager" May 15 10:04:29.000225 kubelet[1561]: I0515 10:04:29.000209 1561 kubelet_node_status.go:76] "Successfully registered node" node="10.0.0.19" May 15 10:04:29.002694 kubelet[1561]: E0515 10:04:29.002670 1561 eviction_manager.go:282] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.19\" not found" May 15 10:04:29.019821 kubelet[1561]: E0515 10:04:29.019787 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.040915 kubelet[1561]: I0515 10:04:29.040854 1561 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" May 15 10:04:29.041841 kubelet[1561]: I0515 10:04:29.041815 1561 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" May 15 10:04:29.042020 kubelet[1561]: I0515 10:04:29.041985 1561 status_manager.go:217] "Starting to sync pod status with apiserver" May 15 10:04:29.042020 kubelet[1561]: I0515 10:04:29.042007 1561 kubelet.go:2337] "Starting kubelet main sync loop" May 15 10:04:29.042095 kubelet[1561]: E0515 10:04:29.042050 1561 kubelet.go:2361] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" May 15 10:04:29.106607 sudo[1434]: pam_unix(sudo:session): session closed for user root May 15 10:04:29.109214 sshd[1428]: pam_unix(sshd:session): session closed for user core May 15 10:04:29.112717 systemd[1]: sshd@4-10.0.0.19:22-10.0.0.1:44568.service: Deactivated successfully. May 15 10:04:29.113697 systemd[1]: session-5.scope: Deactivated successfully. May 15 10:04:29.113720 systemd-logind[1301]: Session 5 logged out. Waiting for processes to exit. May 15 10:04:29.114636 systemd-logind[1301]: Removed session 5. May 15 10:04:29.120311 kubelet[1561]: E0515 10:04:29.120279 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.221355 kubelet[1561]: E0515 10:04:29.221311 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.322361 kubelet[1561]: E0515 10:04:29.322324 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.423449 kubelet[1561]: E0515 10:04:29.423343 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.523719 kubelet[1561]: E0515 10:04:29.523673 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.624446 kubelet[1561]: E0515 10:04:29.624412 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.725434 kubelet[1561]: E0515 10:04:29.725336 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.826448 kubelet[1561]: I0515 10:04:29.826383 1561 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" May 15 10:04:29.826792 kubelet[1561]: W0515 10:04:29.826547 1561 reflector.go:470] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received May 15 10:04:29.826792 kubelet[1561]: E0515 10:04:29.826600 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:29.883635 kubelet[1561]: E0515 10:04:29.883591 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:29.927054 kubelet[1561]: E0515 10:04:29.927023 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:30.028300 kubelet[1561]: E0515 10:04:30.028199 1561 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.19\" not found" May 15 10:04:30.129838 kubelet[1561]: I0515 10:04:30.129802 1561 kuberuntime_manager.go:1523] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" May 15 10:04:30.130259 env[1313]: time="2025-05-15T10:04:30.130145844Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." May 15 10:04:30.130564 kubelet[1561]: I0515 10:04:30.130304 1561 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" May 15 10:04:30.883952 kubelet[1561]: I0515 10:04:30.883918 1561 apiserver.go:52] "Watching apiserver" May 15 10:04:30.884298 kubelet[1561]: E0515 10:04:30.883946 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:30.888476 kubelet[1561]: I0515 10:04:30.888441 1561 topology_manager.go:215] "Topology Admit Handler" podUID="a75b7bab-685c-4ecd-9aab-aa735b87a6a1" podNamespace="kube-flannel" podName="kube-flannel-ds-44cm5" May 15 10:04:30.888612 kubelet[1561]: I0515 10:04:30.888590 1561 topology_manager.go:215] "Topology Admit Handler" podUID="d3f092cc-3f3b-44c9-ae5b-3c0664e02b09" podNamespace="kube-system" podName="kube-proxy-p9jb4" May 15 10:04:30.893974 kubelet[1561]: I0515 10:04:30.893919 1561 desired_state_of_world_populator.go:157] "Finished populating initial desired state of world" May 15 10:04:30.902142 kubelet[1561]: I0515 10:04:30.902106 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-jz5qb\" (UniqueName: \"kubernetes.io/projected/d3f092cc-3f3b-44c9-ae5b-3c0664e02b09-kube-api-access-jz5qb\") pod \"kube-proxy-p9jb4\" (UID: \"d3f092cc-3f3b-44c9-ae5b-3c0664e02b09\") " pod="kube-system/kube-proxy-p9jb4" May 15 10:04:30.902326 kubelet[1561]: I0515 10:04:30.902305 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-cni-plugin\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:30.902457 kubelet[1561]: I0515 10:04:30.902407 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-cni\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:30.902499 kubelet[1561]: I0515 10:04:30.902460 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-xtables-lock\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:30.902499 kubelet[1561]: I0515 10:04:30.902490 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/d3f092cc-3f3b-44c9-ae5b-3c0664e02b09-kube-proxy\") pod \"kube-proxy-p9jb4\" (UID: \"d3f092cc-3f3b-44c9-ae5b-3c0664e02b09\") " pod="kube-system/kube-proxy-p9jb4" May 15 10:04:30.902542 kubelet[1561]: I0515 10:04:30.902509 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d3f092cc-3f3b-44c9-ae5b-3c0664e02b09-xtables-lock\") pod \"kube-proxy-p9jb4\" (UID: \"d3f092cc-3f3b-44c9-ae5b-3c0664e02b09\") " pod="kube-system/kube-proxy-p9jb4" May 15 10:04:30.902542 kubelet[1561]: I0515 10:04:30.902525 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/d3f092cc-3f3b-44c9-ae5b-3c0664e02b09-lib-modules\") pod \"kube-proxy-p9jb4\" (UID: \"d3f092cc-3f3b-44c9-ae5b-3c0664e02b09\") " pod="kube-system/kube-proxy-p9jb4" May 15 10:04:30.902593 kubelet[1561]: I0515 10:04:30.902545 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-run\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:30.902593 kubelet[1561]: I0515 10:04:30.902560 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-flannel-cfg\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:30.902635 kubelet[1561]: I0515 10:04:30.902590 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-9zj79\" (UniqueName: \"kubernetes.io/projected/a75b7bab-685c-4ecd-9aab-aa735b87a6a1-kube-api-access-9zj79\") pod \"kube-flannel-ds-44cm5\" (UID: \"a75b7bab-685c-4ecd-9aab-aa735b87a6a1\") " pod="kube-flannel/kube-flannel-ds-44cm5" May 15 10:04:31.193377 kubelet[1561]: E0515 10:04:31.193259 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:31.193657 kubelet[1561]: E0515 10:04:31.193636 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:31.194419 env[1313]: time="2025-05-15T10:04:31.194383401Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-p9jb4,Uid:d3f092cc-3f3b-44c9-ae5b-3c0664e02b09,Namespace:kube-system,Attempt:0,}" May 15 10:04:31.195100 env[1313]: time="2025-05-15T10:04:31.194815952Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-44cm5,Uid:a75b7bab-685c-4ecd-9aab-aa735b87a6a1,Namespace:kube-flannel,Attempt:0,}" May 15 10:04:31.785279 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1756870284.mount: Deactivated successfully. May 15 10:04:31.789678 env[1313]: time="2025-05-15T10:04:31.789641227Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.792172 env[1313]: time="2025-05-15T10:04:31.792133445Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.793038 env[1313]: time="2025-05-15T10:04:31.793009663Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.793966 env[1313]: time="2025-05-15T10:04:31.793933380Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.798081 env[1313]: time="2025-05-15T10:04:31.798047097Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.803433 env[1313]: time="2025-05-15T10:04:31.803393703Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.806351 env[1313]: time="2025-05-15T10:04:31.806303959Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.810809 env[1313]: time="2025-05-15T10:04:31.810763109Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:31.842480 env[1313]: time="2025-05-15T10:04:31.842223835Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 15 10:04:31.842480 env[1313]: time="2025-05-15T10:04:31.842263291Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 15 10:04:31.842480 env[1313]: time="2025-05-15T10:04:31.842273316Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 15 10:04:31.842633 env[1313]: time="2025-05-15T10:04:31.842534827Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/018d5fad7c64bbb1cc17f947adae6baff585dbd1f3c8d6488863f1c9582b1da2 pid=1624 runtime=io.containerd.runc.v2 May 15 10:04:31.842633 env[1313]: time="2025-05-15T10:04:31.842523306Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 15 10:04:31.842633 env[1313]: time="2025-05-15T10:04:31.842557829Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 15 10:04:31.842633 env[1313]: time="2025-05-15T10:04:31.842567976Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 15 10:04:31.843088 env[1313]: time="2025-05-15T10:04:31.843042447Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e pid=1623 runtime=io.containerd.runc.v2 May 15 10:04:31.886120 kubelet[1561]: E0515 10:04:31.884974 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:31.918942 env[1313]: time="2025-05-15T10:04:31.918899139Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-p9jb4,Uid:d3f092cc-3f3b-44c9-ae5b-3c0664e02b09,Namespace:kube-system,Attempt:0,} returns sandbox id \"018d5fad7c64bbb1cc17f947adae6baff585dbd1f3c8d6488863f1c9582b1da2\"" May 15 10:04:31.919357 env[1313]: time="2025-05-15T10:04:31.919328091Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-44cm5,Uid:a75b7bab-685c-4ecd-9aab-aa735b87a6a1,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\"" May 15 10:04:31.919926 kubelet[1561]: E0515 10:04:31.919902 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:31.920174 kubelet[1561]: E0515 10:04:31.920159 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:31.921465 env[1313]: time="2025-05-15T10:04:31.921431903Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" May 15 10:04:32.885161 kubelet[1561]: E0515 10:04:32.885115 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:32.984206 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2234262214.mount: Deactivated successfully. May 15 10:04:33.018876 env[1313]: time="2025-05-15T10:04:33.018827363Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel-cni-plugin:v1.1.2,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:33.020218 env[1313]: time="2025-05-15T10:04:33.020185328Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:33.021439 env[1313]: time="2025-05-15T10:04:33.021408565Z" level=info msg="ImageUpdate event &ImageUpdate{Name:docker.io/flannel/flannel-cni-plugin:v1.1.2,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:33.022650 env[1313]: time="2025-05-15T10:04:33.022619623Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:33.023269 env[1313]: time="2025-05-15T10:04:33.023242855Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" May 15 10:04:33.025022 env[1313]: time="2025-05-15T10:04:33.024995366Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.12\"" May 15 10:04:33.028602 env[1313]: time="2025-05-15T10:04:33.028576884Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" May 15 10:04:33.037172 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3566382088.mount: Deactivated successfully. May 15 10:04:33.042010 env[1313]: time="2025-05-15T10:04:33.041956998Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027\"" May 15 10:04:33.042961 env[1313]: time="2025-05-15T10:04:33.042927716Z" level=info msg="StartContainer for \"34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027\"" May 15 10:04:33.096123 env[1313]: time="2025-05-15T10:04:33.096080325Z" level=info msg="StartContainer for \"34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027\" returns successfully" May 15 10:04:33.157691 env[1313]: time="2025-05-15T10:04:33.157555694Z" level=info msg="shim disconnected" id=34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027 May 15 10:04:33.157691 env[1313]: time="2025-05-15T10:04:33.157604851Z" level=warning msg="cleaning up after shim disconnected" id=34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027 namespace=k8s.io May 15 10:04:33.157691 env[1313]: time="2025-05-15T10:04:33.157613803Z" level=info msg="cleaning up dead shim" May 15 10:04:33.164446 env[1313]: time="2025-05-15T10:04:33.164400400Z" level=warning msg="cleanup warnings time=\"2025-05-15T10:04:33Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1732 runtime=io.containerd.runc.v2\n" May 15 10:04:33.885581 kubelet[1561]: E0515 10:04:33.885540 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:34.035131 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-34ff606a0f42931622bdb2ab511824e501ff69cb329036cbfe5b68349171c027-rootfs.mount: Deactivated successfully. May 15 10:04:34.055778 kubelet[1561]: E0515 10:04:34.055751 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:34.445494 env[1313]: time="2025-05-15T10:04:34.445446521Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy:v1.30.12,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:34.446678 env[1313]: time="2025-05-15T10:04:34.446648180Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b4250a9efcae16f8d20358e204a159844e2b7e854edad08aee8791774acbdaed,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:34.448456 env[1313]: time="2025-05-15T10:04:34.448427483Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/kube-proxy:v1.30.12,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:34.449525 env[1313]: time="2025-05-15T10:04:34.449500713Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy@sha256:ea8c7d5392acf6b0c11ebba78301e1a6c2dc6abcd7544102ed578e49d1c82f15,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:34.449925 env[1313]: time="2025-05-15T10:04:34.449898164Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.12\" returns image reference \"sha256:b4250a9efcae16f8d20358e204a159844e2b7e854edad08aee8791774acbdaed\"" May 15 10:04:34.451087 env[1313]: time="2025-05-15T10:04:34.451059981Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" May 15 10:04:34.452209 env[1313]: time="2025-05-15T10:04:34.452180505Z" level=info msg="CreateContainer within sandbox \"018d5fad7c64bbb1cc17f947adae6baff585dbd1f3c8d6488863f1c9582b1da2\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" May 15 10:04:34.465622 env[1313]: time="2025-05-15T10:04:34.465553762Z" level=info msg="CreateContainer within sandbox \"018d5fad7c64bbb1cc17f947adae6baff585dbd1f3c8d6488863f1c9582b1da2\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"b692a1c4ace72310189a0920470b0226d84bdae4786b52c3c04ece7adf4e5abe\"" May 15 10:04:34.466213 env[1313]: time="2025-05-15T10:04:34.466094708Z" level=info msg="StartContainer for \"b692a1c4ace72310189a0920470b0226d84bdae4786b52c3c04ece7adf4e5abe\"" May 15 10:04:34.526296 env[1313]: time="2025-05-15T10:04:34.526044158Z" level=info msg="StartContainer for \"b692a1c4ace72310189a0920470b0226d84bdae4786b52c3c04ece7adf4e5abe\" returns successfully" May 15 10:04:34.886474 kubelet[1561]: E0515 10:04:34.886363 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:35.059114 kubelet[1561]: E0515 10:04:35.059087 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:35.069390 kubelet[1561]: I0515 10:04:35.069240 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-p9jb4" podStartSLOduration=3.539528226 podStartE2EDuration="6.069222584s" podCreationTimestamp="2025-05-15 10:04:29 +0000 UTC" firstStartedPulling="2025-05-15 10:04:31.921208069 +0000 UTC m=+4.337784532" lastFinishedPulling="2025-05-15 10:04:34.450902386 +0000 UTC m=+6.867478890" observedRunningTime="2025-05-15 10:04:35.068704536 +0000 UTC m=+7.485280999" watchObservedRunningTime="2025-05-15 10:04:35.069222584 +0000 UTC m=+7.485799048" May 15 10:04:35.625664 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1696678644.mount: Deactivated successfully. May 15 10:04:35.886720 kubelet[1561]: E0515 10:04:35.886602 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:36.060818 kubelet[1561]: E0515 10:04:36.060791 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:36.290022 env[1313]: time="2025-05-15T10:04:36.289844697Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel:v0.22.0,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:36.291451 env[1313]: time="2025-05-15T10:04:36.291413486Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:36.293456 env[1313]: time="2025-05-15T10:04:36.292940287Z" level=info msg="ImageUpdate event &ImageUpdate{Name:docker.io/flannel/flannel:v0.22.0,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:36.295318 env[1313]: time="2025-05-15T10:04:36.295275110Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:36.296024 env[1313]: time="2025-05-15T10:04:36.295977921Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" May 15 10:04:36.298557 env[1313]: time="2025-05-15T10:04:36.298496179Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" May 15 10:04:36.307826 env[1313]: time="2025-05-15T10:04:36.307764407Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d\"" May 15 10:04:36.308378 env[1313]: time="2025-05-15T10:04:36.308303410Z" level=info msg="StartContainer for \"78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d\"" May 15 10:04:36.369160 env[1313]: time="2025-05-15T10:04:36.367186005Z" level=info msg="StartContainer for \"78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d\" returns successfully" May 15 10:04:36.434998 kubelet[1561]: I0515 10:04:36.434672 1561 kubelet_node_status.go:497] "Fast updating node status as it just became ready" May 15 10:04:36.483627 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d-rootfs.mount: Deactivated successfully. May 15 10:04:36.698222 env[1313]: time="2025-05-15T10:04:36.698112936Z" level=info msg="shim disconnected" id=78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d May 15 10:04:36.698458 env[1313]: time="2025-05-15T10:04:36.698433595Z" level=warning msg="cleaning up after shim disconnected" id=78efbdcd85a27120f4f2f3fc49a55d61a36f7afab7264a3b02270171921b074d namespace=k8s.io May 15 10:04:36.698709 env[1313]: time="2025-05-15T10:04:36.698689181Z" level=info msg="cleaning up dead shim" May 15 10:04:36.705102 env[1313]: time="2025-05-15T10:04:36.705062508Z" level=warning msg="cleanup warnings time=\"2025-05-15T10:04:36Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1948 runtime=io.containerd.runc.v2\n" May 15 10:04:36.887682 kubelet[1561]: E0515 10:04:36.887631 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:37.063569 kubelet[1561]: E0515 10:04:37.063465 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:37.065451 env[1313]: time="2025-05-15T10:04:37.065414537Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" May 15 10:04:37.075020 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1255462770.mount: Deactivated successfully. May 15 10:04:37.077970 env[1313]: time="2025-05-15T10:04:37.077916507Z" level=info msg="CreateContainer within sandbox \"bdb2cdbba368046994862823a3499bcaef46dd133fb8d3e68050c7ef9c43b34e\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"d753ed3d445a1154472d76c03d299b3960a97d16230954b01b7b3495ba2e298a\"" May 15 10:04:37.078588 env[1313]: time="2025-05-15T10:04:37.078553050Z" level=info msg="StartContainer for \"d753ed3d445a1154472d76c03d299b3960a97d16230954b01b7b3495ba2e298a\"" May 15 10:04:37.164034 env[1313]: time="2025-05-15T10:04:37.163952640Z" level=info msg="StartContainer for \"d753ed3d445a1154472d76c03d299b3960a97d16230954b01b7b3495ba2e298a\" returns successfully" May 15 10:04:37.888214 kubelet[1561]: E0515 10:04:37.888163 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:38.067381 kubelet[1561]: E0515 10:04:38.067160 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:38.236889 systemd-networkd[1091]: flannel.1: Link UP May 15 10:04:38.236896 systemd-networkd[1091]: flannel.1: Gained carrier May 15 10:04:38.888540 kubelet[1561]: E0515 10:04:38.888500 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:39.068433 kubelet[1561]: E0515 10:04:39.068398 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" May 15 10:04:39.869773 kubelet[1561]: I0515 10:04:39.869711 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-44cm5" podStartSLOduration=6.493448435 podStartE2EDuration="10.869694134s" podCreationTimestamp="2025-05-15 10:04:29 +0000 UTC" firstStartedPulling="2025-05-15 10:04:31.92101144 +0000 UTC m=+4.337587904" lastFinishedPulling="2025-05-15 10:04:36.29725718 +0000 UTC m=+8.713833603" observedRunningTime="2025-05-15 10:04:38.093396071 +0000 UTC m=+10.509972534" watchObservedRunningTime="2025-05-15 10:04:39.869694134 +0000 UTC m=+12.286270597" May 15 10:04:39.869943 kubelet[1561]: I0515 10:04:39.869873 1561 topology_manager.go:215] "Topology Admit Handler" podUID="acacb78c-3811-4843-b4f0-26fb70d325c0" podNamespace="default" podName="nginx-deployment-85f456d6dd-bgpc7" May 15 10:04:39.889335 kubelet[1561]: E0515 10:04:39.889300 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:39.963925 kubelet[1561]: I0515 10:04:39.963879 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8ptv7\" (UniqueName: \"kubernetes.io/projected/acacb78c-3811-4843-b4f0-26fb70d325c0-kube-api-access-8ptv7\") pod \"nginx-deployment-85f456d6dd-bgpc7\" (UID: \"acacb78c-3811-4843-b4f0-26fb70d325c0\") " pod="default/nginx-deployment-85f456d6dd-bgpc7" May 15 10:04:40.022151 systemd-networkd[1091]: flannel.1: Gained IPv6LL May 15 10:04:40.173432 env[1313]: time="2025-05-15T10:04:40.173329614Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-bgpc7,Uid:acacb78c-3811-4843-b4f0-26fb70d325c0,Namespace:default,Attempt:0,}" May 15 10:04:40.204822 systemd-networkd[1091]: cni0: Link UP May 15 10:04:40.212659 systemd-networkd[1091]: veth146101ee: Link UP May 15 10:04:40.214678 kernel: cni0: port 1(veth146101ee) entered blocking state May 15 10:04:40.214765 kernel: cni0: port 1(veth146101ee) entered disabled state May 15 10:04:40.214787 kernel: device veth146101ee entered promiscuous mode May 15 10:04:40.216391 kernel: cni0: port 1(veth146101ee) entered blocking state May 15 10:04:40.216474 kernel: cni0: port 1(veth146101ee) entered forwarding state May 15 10:04:40.219015 kernel: cni0: port 1(veth146101ee) entered disabled state May 15 10:04:40.230581 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth146101ee: link becomes ready May 15 10:04:40.230701 kernel: cni0: port 1(veth146101ee) entered blocking state May 15 10:04:40.230719 kernel: cni0: port 1(veth146101ee) entered forwarding state May 15 10:04:40.231441 systemd-networkd[1091]: veth146101ee: Gained carrier May 15 10:04:40.232102 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): cni0: link becomes ready May 15 10:04:40.232205 systemd-networkd[1091]: cni0: Gained carrier May 15 10:04:40.234515 env[1313]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400009e8e8), "name":"cbr0", "type":"bridge"} May 15 10:04:40.234515 env[1313]: delegateAdd: netconf sent to delegate plugin: May 15 10:04:40.249415 env[1313]: {"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":1450,"name":"cbr0","type":"bridge"}time="2025-05-15T10:04:40.249338565Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 15 10:04:40.249415 env[1313]: time="2025-05-15T10:04:40.249376406Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 15 10:04:40.249594 env[1313]: time="2025-05-15T10:04:40.249390892Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 15 10:04:40.249594 env[1313]: time="2025-05-15T10:04:40.249567334Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/71929c2370ef2a6fd817031ccc2259f6424ff2ef6aa749a8b6e30c9319946128 pid=2131 runtime=io.containerd.runc.v2 May 15 10:04:40.282644 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 10:04:40.299250 env[1313]: time="2025-05-15T10:04:40.299191455Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-bgpc7,Uid:acacb78c-3811-4843-b4f0-26fb70d325c0,Namespace:default,Attempt:0,} returns sandbox id \"71929c2370ef2a6fd817031ccc2259f6424ff2ef6aa749a8b6e30c9319946128\"" May 15 10:04:40.300920 env[1313]: time="2025-05-15T10:04:40.300891431Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" May 15 10:04:40.889436 kubelet[1561]: E0515 10:04:40.889396 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:41.750109 systemd-networkd[1091]: veth146101ee: Gained IPv6LL May 15 10:04:41.889671 kubelet[1561]: E0515 10:04:41.889632 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:42.070088 systemd-networkd[1091]: cni0: Gained IPv6LL May 15 10:04:42.375467 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3729097549.mount: Deactivated successfully. May 15 10:04:42.890268 kubelet[1561]: E0515 10:04:42.890233 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:43.645316 env[1313]: time="2025-05-15T10:04:43.645262079Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:43.646553 env[1313]: time="2025-05-15T10:04:43.646523133Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:43.648141 env[1313]: time="2025-05-15T10:04:43.648109443Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:43.650370 env[1313]: time="2025-05-15T10:04:43.650332674Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx@sha256:beabce8f1782671ba500ddff99dd260fbf9c5ec85fb9c3162e35a3c40bafd023,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:43.651158 env[1313]: time="2025-05-15T10:04:43.651129296Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\"" May 15 10:04:43.653424 env[1313]: time="2025-05-15T10:04:43.653390247Z" level=info msg="CreateContainer within sandbox \"71929c2370ef2a6fd817031ccc2259f6424ff2ef6aa749a8b6e30c9319946128\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" May 15 10:04:43.662699 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3149031854.mount: Deactivated successfully. May 15 10:04:43.665741 env[1313]: time="2025-05-15T10:04:43.665701715Z" level=info msg="CreateContainer within sandbox \"71929c2370ef2a6fd817031ccc2259f6424ff2ef6aa749a8b6e30c9319946128\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"c81f7d6e47d060817381dda0760b397eaf7efe36becc82431f7badbe07a8ceed\"" May 15 10:04:43.666484 env[1313]: time="2025-05-15T10:04:43.666454724Z" level=info msg="StartContainer for \"c81f7d6e47d060817381dda0760b397eaf7efe36becc82431f7badbe07a8ceed\"" May 15 10:04:43.724666 env[1313]: time="2025-05-15T10:04:43.724610034Z" level=info msg="StartContainer for \"c81f7d6e47d060817381dda0760b397eaf7efe36becc82431f7badbe07a8ceed\" returns successfully" May 15 10:04:43.890974 kubelet[1561]: E0515 10:04:43.890921 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:44.892373 kubelet[1561]: E0515 10:04:44.892335 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:45.893114 kubelet[1561]: E0515 10:04:45.893070 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:46.678818 kubelet[1561]: I0515 10:04:46.678739 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-85f456d6dd-bgpc7" podStartSLOduration=4.327107215 podStartE2EDuration="7.678718745s" podCreationTimestamp="2025-05-15 10:04:39 +0000 UTC" firstStartedPulling="2025-05-15 10:04:40.300500867 +0000 UTC m=+12.717077330" lastFinishedPulling="2025-05-15 10:04:43.652112397 +0000 UTC m=+16.068688860" observedRunningTime="2025-05-15 10:04:44.109673571 +0000 UTC m=+16.526250034" watchObservedRunningTime="2025-05-15 10:04:46.678718745 +0000 UTC m=+19.095295208" May 15 10:04:46.679043 kubelet[1561]: I0515 10:04:46.679024 1561 topology_manager.go:215] "Topology Admit Handler" podUID="ce853c78-dfb8-4380-9ade-b33c494bc833" podNamespace="default" podName="nfs-server-provisioner-0" May 15 10:04:46.702843 kubelet[1561]: I0515 10:04:46.702798 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/ce853c78-dfb8-4380-9ade-b33c494bc833-data\") pod \"nfs-server-provisioner-0\" (UID: \"ce853c78-dfb8-4380-9ade-b33c494bc833\") " pod="default/nfs-server-provisioner-0" May 15 10:04:46.702843 kubelet[1561]: I0515 10:04:46.702844 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zgmvl\" (UniqueName: \"kubernetes.io/projected/ce853c78-dfb8-4380-9ade-b33c494bc833-kube-api-access-zgmvl\") pod \"nfs-server-provisioner-0\" (UID: \"ce853c78-dfb8-4380-9ade-b33c494bc833\") " pod="default/nfs-server-provisioner-0" May 15 10:04:46.894025 kubelet[1561]: E0515 10:04:46.893992 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:46.982256 env[1313]: time="2025-05-15T10:04:46.982154269Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:ce853c78-dfb8-4380-9ade-b33c494bc833,Namespace:default,Attempt:0,}" May 15 10:04:47.001595 systemd-networkd[1091]: veth5d14fe26: Link UP May 15 10:04:47.004365 kernel: cni0: port 2(veth5d14fe26) entered blocking state May 15 10:04:47.004458 kernel: cni0: port 2(veth5d14fe26) entered disabled state May 15 10:04:47.005175 kernel: device veth5d14fe26 entered promiscuous mode May 15 10:04:47.010125 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready May 15 10:04:47.010189 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth5d14fe26: link becomes ready May 15 10:04:47.010211 kernel: cni0: port 2(veth5d14fe26) entered blocking state May 15 10:04:47.011483 kernel: cni0: port 2(veth5d14fe26) entered forwarding state May 15 10:04:47.012120 systemd-networkd[1091]: veth5d14fe26: Gained carrier May 15 10:04:47.015131 env[1313]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x4000018928), "name":"cbr0", "type":"bridge"} May 15 10:04:47.015131 env[1313]: delegateAdd: netconf sent to delegate plugin: May 15 10:04:47.024182 env[1313]: {"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":1450,"name":"cbr0","type":"bridge"}time="2025-05-15T10:04:47.024102663Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 15 10:04:47.024182 env[1313]: time="2025-05-15T10:04:47.024143674Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 15 10:04:47.024182 env[1313]: time="2025-05-15T10:04:47.024154167Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 15 10:04:47.024489 env[1313]: time="2025-05-15T10:04:47.024435881Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/d6c2e8135707c6384ef6fc457869cfcbb6dbe4ab95afdf7404fb2be817611fef pid=2298 runtime=io.containerd.runc.v2 May 15 10:04:47.057842 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 10:04:47.073172 env[1313]: time="2025-05-15T10:04:47.073129648Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:ce853c78-dfb8-4380-9ade-b33c494bc833,Namespace:default,Attempt:0,} returns sandbox id \"d6c2e8135707c6384ef6fc457869cfcbb6dbe4ab95afdf7404fb2be817611fef\"" May 15 10:04:47.074537 env[1313]: time="2025-05-15T10:04:47.074511300Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" May 15 10:04:47.894156 kubelet[1561]: E0515 10:04:47.894114 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:48.790100 systemd-networkd[1091]: veth5d14fe26: Gained IPv6LL May 15 10:04:48.883047 kubelet[1561]: E0515 10:04:48.883003 1561 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:48.895204 kubelet[1561]: E0515 10:04:48.895164 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:49.089399 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount780487069.mount: Deactivated successfully. May 15 10:04:49.896136 kubelet[1561]: E0515 10:04:49.896090 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:50.839779 env[1313]: time="2025-05-15T10:04:50.839722196Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:50.841212 env[1313]: time="2025-05-15T10:04:50.841174937Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:50.843617 env[1313]: time="2025-05-15T10:04:50.843567908Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:50.845236 env[1313]: time="2025-05-15T10:04:50.845192072Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:04:50.846072 env[1313]: time="2025-05-15T10:04:50.846044068Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" May 15 10:04:50.849208 env[1313]: time="2025-05-15T10:04:50.849173578Z" level=info msg="CreateContainer within sandbox \"d6c2e8135707c6384ef6fc457869cfcbb6dbe4ab95afdf7404fb2be817611fef\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" May 15 10:04:50.859420 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2547915427.mount: Deactivated successfully. May 15 10:04:50.866270 env[1313]: time="2025-05-15T10:04:50.866214256Z" level=info msg="CreateContainer within sandbox \"d6c2e8135707c6384ef6fc457869cfcbb6dbe4ab95afdf7404fb2be817611fef\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"2691aa5fd6549867213a17d6e34b3d4ff5bf5dfb7aadc154ac5fc29972c08583\"" May 15 10:04:50.867103 env[1313]: time="2025-05-15T10:04:50.867079623Z" level=info msg="StartContainer for \"2691aa5fd6549867213a17d6e34b3d4ff5bf5dfb7aadc154ac5fc29972c08583\"" May 15 10:04:50.896884 kubelet[1561]: E0515 10:04:50.896842 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:50.926430 env[1313]: time="2025-05-15T10:04:50.926379568Z" level=info msg="StartContainer for \"2691aa5fd6549867213a17d6e34b3d4ff5bf5dfb7aadc154ac5fc29972c08583\" returns successfully" May 15 10:04:51.855560 systemd[1]: run-containerd-runc-k8s.io-2691aa5fd6549867213a17d6e34b3d4ff5bf5dfb7aadc154ac5fc29972c08583-runc.8MvpCB.mount: Deactivated successfully. May 15 10:04:51.897279 kubelet[1561]: E0515 10:04:51.897223 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:52.898308 kubelet[1561]: E0515 10:04:52.898271 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:53.899657 kubelet[1561]: E0515 10:04:53.899573 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:54.899812 kubelet[1561]: E0515 10:04:54.899753 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:55.900427 kubelet[1561]: E0515 10:04:55.900363 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:56.900875 kubelet[1561]: E0515 10:04:56.900795 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:57.901356 kubelet[1561]: E0515 10:04:57.901309 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:58.901633 kubelet[1561]: E0515 10:04:58.901605 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:04:59.902693 kubelet[1561]: E0515 10:04:59.902637 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:05:00.903711 kubelet[1561]: E0515 10:05:00.903635 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:05:00.914076 kubelet[1561]: I0515 10:05:00.914015 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=11.140929174 podStartE2EDuration="14.914001976s" podCreationTimestamp="2025-05-15 10:04:46 +0000 UTC" firstStartedPulling="2025-05-15 10:04:47.074269477 +0000 UTC m=+19.490845940" lastFinishedPulling="2025-05-15 10:04:50.847342279 +0000 UTC m=+23.263918742" observedRunningTime="2025-05-15 10:04:51.10206181 +0000 UTC m=+23.518638273" watchObservedRunningTime="2025-05-15 10:05:00.914001976 +0000 UTC m=+33.330578399" May 15 10:05:00.914233 kubelet[1561]: I0515 10:05:00.914196 1561 topology_manager.go:215] "Topology Admit Handler" podUID="6a2e0b33-7810-4180-870a-5cbe055e1772" podNamespace="default" podName="test-pod-1" May 15 10:05:00.988712 kubelet[1561]: I0515 10:05:00.988632 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-2084fb81-5d58-46d3-b38d-a6ab1a859459\" (UniqueName: \"kubernetes.io/nfs/6a2e0b33-7810-4180-870a-5cbe055e1772-pvc-2084fb81-5d58-46d3-b38d-a6ab1a859459\") pod \"test-pod-1\" (UID: \"6a2e0b33-7810-4180-870a-5cbe055e1772\") " pod="default/test-pod-1" May 15 10:05:00.988712 kubelet[1561]: I0515 10:05:00.988687 1561 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-kpkft\" (UniqueName: \"kubernetes.io/projected/6a2e0b33-7810-4180-870a-5cbe055e1772-kube-api-access-kpkft\") pod \"test-pod-1\" (UID: \"6a2e0b33-7810-4180-870a-5cbe055e1772\") " pod="default/test-pod-1" May 15 10:05:01.122306 kernel: FS-Cache: Loaded May 15 10:05:01.152167 kernel: RPC: Registered named UNIX socket transport module. May 15 10:05:01.152267 kernel: RPC: Registered udp transport module. May 15 10:05:01.152290 kernel: RPC: Registered tcp transport module. May 15 10:05:01.153501 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. May 15 10:05:01.199987 kernel: FS-Cache: Netfs 'nfs' registered for caching May 15 10:05:01.340006 kernel: NFS: Registering the id_resolver key type May 15 10:05:01.340143 kernel: Key type id_resolver registered May 15 10:05:01.340178 kernel: Key type id_legacy registered May 15 10:05:01.377478 nfsidmap[2479]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' May 15 10:05:01.380993 nfsidmap[2482]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' May 15 10:05:01.518655 env[1313]: time="2025-05-15T10:05:01.518605929Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:6a2e0b33-7810-4180-870a-5cbe055e1772,Namespace:default,Attempt:0,}" May 15 10:05:01.534282 systemd-networkd[1091]: veth0f9c51b4: Link UP May 15 10:05:01.536405 kernel: cni0: port 3(veth0f9c51b4) entered blocking state May 15 10:05:01.536498 kernel: cni0: port 3(veth0f9c51b4) entered disabled state May 15 10:05:01.536534 kernel: device veth0f9c51b4 entered promiscuous mode May 15 10:05:01.543073 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready May 15 10:05:01.543182 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth0f9c51b4: link becomes ready May 15 10:05:01.543210 kernel: cni0: port 3(veth0f9c51b4) entered blocking state May 15 10:05:01.543235 kernel: cni0: port 3(veth0f9c51b4) entered forwarding state May 15 10:05:01.543995 systemd-networkd[1091]: veth0f9c51b4: Gained carrier May 15 10:05:01.549232 env[1313]: 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)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400001c928), "name":"cbr0", "type":"bridge"} May 15 10:05:01.549232 env[1313]: delegateAdd: netconf sent to delegate plugin: May 15 10:05:01.559874 env[1313]: {"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":1450,"name":"cbr0","type":"bridge"}time="2025-05-15T10:05:01.559789912Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 15 10:05:01.560051 env[1313]: time="2025-05-15T10:05:01.559885524Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 15 10:05:01.560051 env[1313]: time="2025-05-15T10:05:01.559915940Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 15 10:05:01.560317 env[1313]: time="2025-05-15T10:05:01.560268610Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/b74ede64e362421eba81a4a0efeafeae09d987005041e8bf15da87b538fa728e pid=2528 runtime=io.containerd.runc.v2 May 15 10:05:01.616235 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 15 10:05:01.639668 env[1313]: time="2025-05-15T10:05:01.639593256Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:6a2e0b33-7810-4180-870a-5cbe055e1772,Namespace:default,Attempt:0,} returns sandbox id \"b74ede64e362421eba81a4a0efeafeae09d987005041e8bf15da87b538fa728e\"" May 15 10:05:01.641442 env[1313]: time="2025-05-15T10:05:01.641403191Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" May 15 10:05:01.904843 kubelet[1561]: E0515 10:05:01.904725 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:05:01.923685 env[1313]: time="2025-05-15T10:05:01.923629005Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:05:01.924940 env[1313]: time="2025-05-15T10:05:01.924905852Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:05:01.927031 env[1313]: time="2025-05-15T10:05:01.927001501Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:05:01.928829 env[1313]: time="2025-05-15T10:05:01.928789344Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx@sha256:beabce8f1782671ba500ddff99dd260fbf9c5ec85fb9c3162e35a3c40bafd023,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" May 15 10:05:01.929619 env[1313]: time="2025-05-15T10:05:01.929585213Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\"" May 15 10:05:01.932627 env[1313]: time="2025-05-15T10:05:01.932593753Z" level=info msg="CreateContainer within sandbox \"b74ede64e362421eba81a4a0efeafeae09d987005041e8bf15da87b538fa728e\" for container &ContainerMetadata{Name:test,Attempt:0,}" May 15 10:05:01.947350 env[1313]: time="2025-05-15T10:05:01.947274421Z" level=info msg="CreateContainer within sandbox \"b74ede64e362421eba81a4a0efeafeae09d987005041e8bf15da87b538fa728e\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"cf8c0d8c254a74f4b256d1b502de902974846e2bd247db50e82b7243048455ef\"" May 15 10:05:01.947886 env[1313]: time="2025-05-15T10:05:01.947796662Z" level=info msg="StartContainer for \"cf8c0d8c254a74f4b256d1b502de902974846e2bd247db50e82b7243048455ef\"" May 15 10:05:02.004975 env[1313]: time="2025-05-15T10:05:02.004908593Z" level=info msg="StartContainer for \"cf8c0d8c254a74f4b256d1b502de902974846e2bd247db50e82b7243048455ef\" returns successfully" May 15 10:05:02.904898 kubelet[1561]: E0515 10:05:02.904816 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" May 15 10:05:03.446149 systemd-networkd[1091]: veth0f9c51b4: Gained IPv6LL May 15 10:05:03.905798 kubelet[1561]: E0515 10:05:03.905741 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"