Aug 13 00:03:19.726508 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 13 00:03:19.726535 kernel: Linux version 5.15.189-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 Tue Aug 12 22:50:30 -00 2025 Aug 13 00:03:19.726546 kernel: efi: EFI v2.70 by EDK II Aug 13 00:03:19.726556 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Aug 13 00:03:19.726562 kernel: random: crng init done Aug 13 00:03:19.726571 kernel: ACPI: Early table checksum verification disabled Aug 13 00:03:19.726580 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Aug 13 00:03:19.726591 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 13 00:03:19.726600 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726608 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726625 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726632 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726640 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726648 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726661 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726669 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726678 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 13 00:03:19.726686 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 13 00:03:19.726694 kernel: NUMA: Failed to initialise from firmware Aug 13 00:03:19.726702 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 13 00:03:19.726711 kernel: NUMA: NODE_DATA [mem 0xdcb0c900-0xdcb11fff] Aug 13 00:03:19.726719 kernel: Zone ranges: Aug 13 00:03:19.726727 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 13 00:03:19.726739 kernel: DMA32 empty Aug 13 00:03:19.726747 kernel: Normal empty Aug 13 00:03:19.726754 kernel: Movable zone start for each node Aug 13 00:03:19.726760 kernel: Early memory node ranges Aug 13 00:03:19.726766 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Aug 13 00:03:19.726772 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Aug 13 00:03:19.726778 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Aug 13 00:03:19.726786 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Aug 13 00:03:19.726794 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Aug 13 00:03:19.726802 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Aug 13 00:03:19.726811 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Aug 13 00:03:19.726819 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 13 00:03:19.726829 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 13 00:03:19.726837 kernel: psci: probing for conduit method from ACPI. Aug 13 00:03:19.726844 kernel: psci: PSCIv1.1 detected in firmware. Aug 13 00:03:19.726853 kernel: psci: Using standard PSCI v0.2 function IDs Aug 13 00:03:19.726862 kernel: psci: Trusted OS migration not required Aug 13 00:03:19.726873 kernel: psci: SMC Calling Convention v1.1 Aug 13 00:03:19.726882 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 13 00:03:19.726893 kernel: ACPI: SRAT not present Aug 13 00:03:19.726901 kernel: percpu: Embedded 30 pages/cpu s82968 r8192 d31720 u122880 Aug 13 00:03:19.726910 kernel: pcpu-alloc: s82968 r8192 d31720 u122880 alloc=30*4096 Aug 13 00:03:19.726919 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 13 00:03:19.726928 kernel: Detected PIPT I-cache on CPU0 Aug 13 00:03:19.726937 kernel: CPU features: detected: GIC system register CPU interface Aug 13 00:03:19.726946 kernel: CPU features: detected: Hardware dirty bit management Aug 13 00:03:19.726956 kernel: CPU features: detected: Spectre-v4 Aug 13 00:03:19.726964 kernel: CPU features: detected: Spectre-BHB Aug 13 00:03:19.726975 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 13 00:03:19.726984 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 13 00:03:19.726993 kernel: CPU features: detected: ARM erratum 1418040 Aug 13 00:03:19.727002 kernel: CPU features: detected: SSBS not fully self-synchronizing Aug 13 00:03:19.727011 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 13 00:03:19.727019 kernel: Policy zone: DMA Aug 13 00:03:19.727029 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=32404c0887e5b8a80b0f069916a8040bfd969c7a8f47a2db1168b24bc04220cc Aug 13 00:03:19.727038 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 13 00:03:19.727047 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 13 00:03:19.727056 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 13 00:03:19.727065 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 13 00:03:19.727077 kernel: Memory: 2457344K/2572288K available (9792K kernel code, 2094K rwdata, 7588K rodata, 36416K init, 777K bss, 114944K reserved, 0K cma-reserved) Aug 13 00:03:19.727085 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 13 00:03:19.727091 kernel: trace event string verifier disabled Aug 13 00:03:19.727097 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 13 00:03:19.727104 kernel: rcu: RCU event tracing is enabled. Aug 13 00:03:19.727111 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 13 00:03:19.727117 kernel: Trampoline variant of Tasks RCU enabled. Aug 13 00:03:19.727123 kernel: Tracing variant of Tasks RCU enabled. Aug 13 00:03:19.727130 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 13 00:03:19.727136 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 13 00:03:19.727142 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 13 00:03:19.727150 kernel: GICv3: 256 SPIs implemented Aug 13 00:03:19.727176 kernel: GICv3: 0 Extended SPIs implemented Aug 13 00:03:19.727185 kernel: GICv3: Distributor has no Range Selector support Aug 13 00:03:19.727191 kernel: Root IRQ handler: gic_handle_irq Aug 13 00:03:19.727198 kernel: GICv3: 16 PPIs implemented Aug 13 00:03:19.727204 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 13 00:03:19.727210 kernel: ACPI: SRAT not present Aug 13 00:03:19.727216 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 13 00:03:19.727222 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Aug 13 00:03:19.727228 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Aug 13 00:03:19.727235 kernel: GICv3: using LPI property table @0x00000000400d0000 Aug 13 00:03:19.727241 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Aug 13 00:03:19.727249 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 00:03:19.727255 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 13 00:03:19.727261 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 13 00:03:19.727267 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 13 00:03:19.727273 kernel: arm-pv: using stolen time PV Aug 13 00:03:19.727280 kernel: Console: colour dummy device 80x25 Aug 13 00:03:19.727286 kernel: ACPI: Core revision 20210730 Aug 13 00:03:19.727293 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 13 00:03:19.727300 kernel: pid_max: default: 32768 minimum: 301 Aug 13 00:03:19.727306 kernel: LSM: Security Framework initializing Aug 13 00:03:19.727313 kernel: SELinux: Initializing. Aug 13 00:03:19.727320 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 00:03:19.727326 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 13 00:03:19.727332 kernel: rcu: Hierarchical SRCU implementation. Aug 13 00:03:19.727338 kernel: Platform MSI: ITS@0x8080000 domain created Aug 13 00:03:19.727359 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 13 00:03:19.727367 kernel: Remapping and enabling EFI services. Aug 13 00:03:19.727374 kernel: smp: Bringing up secondary CPUs ... Aug 13 00:03:19.727381 kernel: Detected PIPT I-cache on CPU1 Aug 13 00:03:19.727389 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 13 00:03:19.727396 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Aug 13 00:03:19.727402 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 00:03:19.727409 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 13 00:03:19.727415 kernel: Detected PIPT I-cache on CPU2 Aug 13 00:03:19.727421 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 13 00:03:19.727428 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Aug 13 00:03:19.727435 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 00:03:19.727441 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 13 00:03:19.727447 kernel: Detected PIPT I-cache on CPU3 Aug 13 00:03:19.727454 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 13 00:03:19.727461 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Aug 13 00:03:19.727467 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 13 00:03:19.727473 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 13 00:03:19.727484 kernel: smp: Brought up 1 node, 4 CPUs Aug 13 00:03:19.727492 kernel: SMP: Total of 4 processors activated. Aug 13 00:03:19.727499 kernel: CPU features: detected: 32-bit EL0 Support Aug 13 00:03:19.727506 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 13 00:03:19.727512 kernel: CPU features: detected: Common not Private translations Aug 13 00:03:19.727519 kernel: CPU features: detected: CRC32 instructions Aug 13 00:03:19.727526 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 13 00:03:19.727532 kernel: CPU features: detected: LSE atomic instructions Aug 13 00:03:19.727540 kernel: CPU features: detected: Privileged Access Never Aug 13 00:03:19.727547 kernel: CPU features: detected: RAS Extension Support Aug 13 00:03:19.727554 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 13 00:03:19.727561 kernel: CPU: All CPU(s) started at EL1 Aug 13 00:03:19.727567 kernel: alternatives: patching kernel code Aug 13 00:03:19.727576 kernel: devtmpfs: initialized Aug 13 00:03:19.727582 kernel: KASLR enabled Aug 13 00:03:19.727589 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 13 00:03:19.727596 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 13 00:03:19.727602 kernel: pinctrl core: initialized pinctrl subsystem Aug 13 00:03:19.727609 kernel: SMBIOS 3.0.0 present. Aug 13 00:03:19.727621 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Aug 13 00:03:19.727628 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 13 00:03:19.727635 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 13 00:03:19.727643 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 13 00:03:19.727650 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 13 00:03:19.727657 kernel: audit: initializing netlink subsys (disabled) Aug 13 00:03:19.727663 kernel: audit: type=2000 audit(0.035:1): state=initialized audit_enabled=0 res=1 Aug 13 00:03:19.727670 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 13 00:03:19.727676 kernel: cpuidle: using governor menu Aug 13 00:03:19.727683 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 13 00:03:19.727690 kernel: ASID allocator initialised with 32768 entries Aug 13 00:03:19.727697 kernel: ACPI: bus type PCI registered Aug 13 00:03:19.727705 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 13 00:03:19.727712 kernel: Serial: AMBA PL011 UART driver Aug 13 00:03:19.727718 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Aug 13 00:03:19.727725 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Aug 13 00:03:19.727732 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Aug 13 00:03:19.727738 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Aug 13 00:03:19.727745 kernel: cryptd: max_cpu_qlen set to 1000 Aug 13 00:03:19.727752 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 13 00:03:19.727759 kernel: ACPI: Added _OSI(Module Device) Aug 13 00:03:19.727767 kernel: ACPI: Added _OSI(Processor Device) Aug 13 00:03:19.727774 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 13 00:03:19.727781 kernel: ACPI: Added _OSI(Linux-Dell-Video) Aug 13 00:03:19.727787 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Aug 13 00:03:19.727794 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Aug 13 00:03:19.727800 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 13 00:03:19.727807 kernel: ACPI: Interpreter enabled Aug 13 00:03:19.727813 kernel: ACPI: Using GIC for interrupt routing Aug 13 00:03:19.727820 kernel: ACPI: MCFG table detected, 1 entries Aug 13 00:03:19.727828 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 13 00:03:19.727834 kernel: printk: console [ttyAMA0] enabled Aug 13 00:03:19.727841 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 13 00:03:19.727980 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 13 00:03:19.728047 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 13 00:03:19.728106 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 13 00:03:19.728164 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 13 00:03:19.728226 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 13 00:03:19.728235 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 13 00:03:19.728242 kernel: PCI host bridge to bus 0000:00 Aug 13 00:03:19.728310 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 13 00:03:19.728380 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 13 00:03:19.728437 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 13 00:03:19.728490 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 13 00:03:19.728567 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 13 00:03:19.728647 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 13 00:03:19.728712 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 13 00:03:19.728774 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 13 00:03:19.728841 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 13 00:03:19.728960 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 13 00:03:19.729022 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 13 00:03:19.729088 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 13 00:03:19.729143 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 13 00:03:19.729196 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 13 00:03:19.729250 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 13 00:03:19.729259 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 13 00:03:19.729265 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 13 00:03:19.729273 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 13 00:03:19.729281 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 13 00:03:19.729287 kernel: iommu: Default domain type: Translated Aug 13 00:03:19.729294 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 13 00:03:19.729300 kernel: vgaarb: loaded Aug 13 00:03:19.729307 kernel: pps_core: LinuxPPS API ver. 1 registered Aug 13 00:03:19.729314 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Aug 13 00:03:19.729321 kernel: PTP clock support registered Aug 13 00:03:19.729328 kernel: Registered efivars operations Aug 13 00:03:19.729335 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 13 00:03:19.729342 kernel: VFS: Disk quotas dquot_6.6.0 Aug 13 00:03:19.729361 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 13 00:03:19.729368 kernel: pnp: PnP ACPI init Aug 13 00:03:19.729442 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 13 00:03:19.729452 kernel: pnp: PnP ACPI: found 1 devices Aug 13 00:03:19.729459 kernel: NET: Registered PF_INET protocol family Aug 13 00:03:19.729465 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 13 00:03:19.729472 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 13 00:03:19.729479 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 13 00:03:19.729488 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 13 00:03:19.729495 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Aug 13 00:03:19.729502 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 13 00:03:19.729508 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 00:03:19.729515 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 13 00:03:19.729522 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 13 00:03:19.729528 kernel: PCI: CLS 0 bytes, default 64 Aug 13 00:03:19.729534 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 13 00:03:19.729541 kernel: kvm [1]: HYP mode not available Aug 13 00:03:19.729549 kernel: Initialise system trusted keyrings Aug 13 00:03:19.729556 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 13 00:03:19.729562 kernel: Key type asymmetric registered Aug 13 00:03:19.729569 kernel: Asymmetric key parser 'x509' registered Aug 13 00:03:19.729575 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Aug 13 00:03:19.729582 kernel: io scheduler mq-deadline registered Aug 13 00:03:19.729589 kernel: io scheduler kyber registered Aug 13 00:03:19.729595 kernel: io scheduler bfq registered Aug 13 00:03:19.729602 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 13 00:03:19.729610 kernel: ACPI: button: Power Button [PWRB] Aug 13 00:03:19.729625 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 13 00:03:19.729690 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 13 00:03:19.729699 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 13 00:03:19.729706 kernel: thunder_xcv, ver 1.0 Aug 13 00:03:19.729712 kernel: thunder_bgx, ver 1.0 Aug 13 00:03:19.729719 kernel: nicpf, ver 1.0 Aug 13 00:03:19.729725 kernel: nicvf, ver 1.0 Aug 13 00:03:19.729795 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 13 00:03:19.729854 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-13T00:03:19 UTC (1755043399) Aug 13 00:03:19.729863 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 13 00:03:19.729870 kernel: NET: Registered PF_INET6 protocol family Aug 13 00:03:19.729876 kernel: Segment Routing with IPv6 Aug 13 00:03:19.729883 kernel: In-situ OAM (IOAM) with IPv6 Aug 13 00:03:19.729890 kernel: NET: Registered PF_PACKET protocol family Aug 13 00:03:19.729896 kernel: Key type dns_resolver registered Aug 13 00:03:19.729903 kernel: registered taskstats version 1 Aug 13 00:03:19.729911 kernel: Loading compiled-in X.509 certificates Aug 13 00:03:19.729918 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.189-flatcar: 72b807ae6dac6ab18c2f4ab9460d3472cf28c19d' Aug 13 00:03:19.729925 kernel: Key type .fscrypt registered Aug 13 00:03:19.729931 kernel: Key type fscrypt-provisioning registered Aug 13 00:03:19.729938 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 13 00:03:19.729945 kernel: ima: Allocated hash algorithm: sha1 Aug 13 00:03:19.729952 kernel: ima: No architecture policies found Aug 13 00:03:19.729959 kernel: clk: Disabling unused clocks Aug 13 00:03:19.729965 kernel: Freeing unused kernel memory: 36416K Aug 13 00:03:19.729973 kernel: Run /init as init process Aug 13 00:03:19.729980 kernel: with arguments: Aug 13 00:03:19.729986 kernel: /init Aug 13 00:03:19.729993 kernel: with environment: Aug 13 00:03:19.729999 kernel: HOME=/ Aug 13 00:03:19.730006 kernel: TERM=linux Aug 13 00:03:19.730014 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 13 00:03:19.730023 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) Aug 13 00:03:19.730034 systemd[1]: Detected virtualization kvm. Aug 13 00:03:19.730041 systemd[1]: Detected architecture arm64. Aug 13 00:03:19.730048 systemd[1]: Running in initrd. Aug 13 00:03:19.730055 systemd[1]: No hostname configured, using default hostname. Aug 13 00:03:19.730062 systemd[1]: Hostname set to . Aug 13 00:03:19.730070 systemd[1]: Initializing machine ID from VM UUID. Aug 13 00:03:19.730077 systemd[1]: Queued start job for default target initrd.target. Aug 13 00:03:19.730084 systemd[1]: Started systemd-ask-password-console.path. Aug 13 00:03:19.730093 systemd[1]: Reached target cryptsetup.target. Aug 13 00:03:19.730100 systemd[1]: Reached target paths.target. Aug 13 00:03:19.730107 systemd[1]: Reached target slices.target. Aug 13 00:03:19.730114 systemd[1]: Reached target swap.target. Aug 13 00:03:19.730121 systemd[1]: Reached target timers.target. Aug 13 00:03:19.730128 systemd[1]: Listening on iscsid.socket. Aug 13 00:03:19.730136 systemd[1]: Listening on iscsiuio.socket. Aug 13 00:03:19.730144 systemd[1]: Listening on systemd-journald-audit.socket. Aug 13 00:03:19.730152 systemd[1]: Listening on systemd-journald-dev-log.socket. Aug 13 00:03:19.730160 systemd[1]: Listening on systemd-journald.socket. Aug 13 00:03:19.730167 systemd[1]: Listening on systemd-networkd.socket. Aug 13 00:03:19.730174 systemd[1]: Listening on systemd-udevd-control.socket. Aug 13 00:03:19.730181 systemd[1]: Listening on systemd-udevd-kernel.socket. Aug 13 00:03:19.730188 systemd[1]: Reached target sockets.target. Aug 13 00:03:19.730196 systemd[1]: Starting kmod-static-nodes.service... Aug 13 00:03:19.730203 systemd[1]: Finished network-cleanup.service. Aug 13 00:03:19.730212 systemd[1]: Starting systemd-fsck-usr.service... Aug 13 00:03:19.730219 systemd[1]: Starting systemd-journald.service... Aug 13 00:03:19.730226 systemd[1]: Starting systemd-modules-load.service... Aug 13 00:03:19.730233 systemd[1]: Starting systemd-resolved.service... Aug 13 00:03:19.730240 systemd[1]: Starting systemd-vconsole-setup.service... Aug 13 00:03:19.730247 systemd[1]: Finished kmod-static-nodes.service. Aug 13 00:03:19.730254 systemd[1]: Finished systemd-fsck-usr.service. Aug 13 00:03:19.730261 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Aug 13 00:03:19.730268 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Aug 13 00:03:19.730277 kernel: audit: type=1130 audit(1755043399.728:2): 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' Aug 13 00:03:19.730284 systemd[1]: Finished systemd-vconsole-setup.service. Aug 13 00:03:19.730296 systemd-journald[290]: Journal started Aug 13 00:03:19.730338 systemd-journald[290]: Runtime Journal (/run/log/journal/0f822f1042984ef495ea86307d3b50a9) is 6.0M, max 48.7M, 42.6M free. Aug 13 00:03:19.728000 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' Aug 13 00:03:19.722121 systemd-modules-load[291]: Inserted module 'overlay' Aug 13 00:03:19.731000 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' Aug 13 00:03:19.734396 kernel: audit: type=1130 audit(1755043399.731:3): 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' Aug 13 00:03:19.734422 systemd[1]: Started systemd-journald.service. Aug 13 00:03:19.734000 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' Aug 13 00:03:19.735358 kernel: audit: type=1130 audit(1755043399.734:4): 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' Aug 13 00:03:19.736332 systemd[1]: Starting dracut-cmdline-ask.service... Aug 13 00:03:19.754019 systemd[1]: Finished dracut-cmdline-ask.service. Aug 13 00:03:19.756000 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' Aug 13 00:03:19.757377 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 13 00:03:19.757410 kernel: audit: type=1130 audit(1755043399.756:5): 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' Aug 13 00:03:19.758443 systemd-resolved[292]: Positive Trust Anchors: Aug 13 00:03:19.758457 systemd-resolved[292]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 00:03:19.758484 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 Aug 13 00:03:19.764522 kernel: Bridge firewalling registered Aug 13 00:03:19.763607 systemd-resolved[292]: Defaulting to hostname 'linux'. Aug 13 00:03:19.764555 systemd-modules-load[291]: Inserted module 'br_netfilter' Aug 13 00:03:19.766123 systemd[1]: Starting dracut-cmdline.service... Aug 13 00:03:19.767429 systemd[1]: Started systemd-resolved.service. Aug 13 00:03:19.768000 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' Aug 13 00:03:19.768692 systemd[1]: Reached target nss-lookup.target. Aug 13 00:03:19.771399 kernel: audit: type=1130 audit(1755043399.768:6): 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' Aug 13 00:03:19.771421 dracut-cmdline[307]: dracut-dracut-053 Aug 13 00:03:19.772860 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=32404c0887e5b8a80b0f069916a8040bfd969c7a8f47a2db1168b24bc04220cc Aug 13 00:03:19.778500 kernel: SCSI subsystem initialized Aug 13 00:03:19.785917 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 13 00:03:19.785985 kernel: device-mapper: uevent: version 1.0.3 Aug 13 00:03:19.785996 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Aug 13 00:03:19.788360 systemd-modules-load[291]: Inserted module 'dm_multipath' Aug 13 00:03:19.789147 systemd[1]: Finished systemd-modules-load.service. Aug 13 00:03:19.789000 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' Aug 13 00:03:19.790710 systemd[1]: Starting systemd-sysctl.service... Aug 13 00:03:19.793946 kernel: audit: type=1130 audit(1755043399.789: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' Aug 13 00:03:19.798109 systemd[1]: Finished systemd-sysctl.service. Aug 13 00:03:19.798000 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' Aug 13 00:03:19.801370 kernel: audit: type=1130 audit(1755043399.798: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' Aug 13 00:03:19.845372 kernel: Loading iSCSI transport class v2.0-870. Aug 13 00:03:19.858376 kernel: iscsi: registered transport (tcp) Aug 13 00:03:19.874375 kernel: iscsi: registered transport (qla4xxx) Aug 13 00:03:19.874429 kernel: QLogic iSCSI HBA Driver Aug 13 00:03:19.909674 systemd[1]: Finished dracut-cmdline.service. Aug 13 00:03:19.914446 kernel: audit: type=1130 audit(1755043399.909: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' Aug 13 00:03:19.909000 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' Aug 13 00:03:19.911190 systemd[1]: Starting dracut-pre-udev.service... Aug 13 00:03:19.954380 kernel: raid6: neonx8 gen() 13601 MB/s Aug 13 00:03:19.971366 kernel: raid6: neonx8 xor() 10774 MB/s Aug 13 00:03:19.988361 kernel: raid6: neonx4 gen() 13533 MB/s Aug 13 00:03:20.005376 kernel: raid6: neonx4 xor() 10853 MB/s Aug 13 00:03:20.023162 kernel: raid6: neonx2 gen() 12934 MB/s Aug 13 00:03:20.039403 kernel: raid6: neonx2 xor() 10175 MB/s Aug 13 00:03:20.056373 kernel: raid6: neonx1 gen() 10517 MB/s Aug 13 00:03:20.073371 kernel: raid6: neonx1 xor() 8743 MB/s Aug 13 00:03:20.090370 kernel: raid6: int64x8 gen() 5548 MB/s Aug 13 00:03:20.107369 kernel: raid6: int64x8 xor() 3532 MB/s Aug 13 00:03:20.124366 kernel: raid6: int64x4 gen() 7212 MB/s Aug 13 00:03:20.141372 kernel: raid6: int64x4 xor() 3842 MB/s Aug 13 00:03:20.158363 kernel: raid6: int64x2 gen() 6137 MB/s Aug 13 00:03:20.175376 kernel: raid6: int64x2 xor() 3314 MB/s Aug 13 00:03:20.192371 kernel: raid6: int64x1 gen() 5034 MB/s Aug 13 00:03:20.209629 kernel: raid6: int64x1 xor() 2644 MB/s Aug 13 00:03:20.209680 kernel: raid6: using algorithm neonx8 gen() 13601 MB/s Aug 13 00:03:20.209690 kernel: raid6: .... xor() 10774 MB/s, rmw enabled Aug 13 00:03:20.209699 kernel: raid6: using neon recovery algorithm Aug 13 00:03:20.220747 kernel: xor: measuring software checksum speed Aug 13 00:03:20.220796 kernel: 8regs : 17217 MB/sec Aug 13 00:03:20.221365 kernel: 32regs : 20712 MB/sec Aug 13 00:03:20.221380 kernel: arm64_neon : 26163 MB/sec Aug 13 00:03:20.222365 kernel: xor: using function: arm64_neon (26163 MB/sec) Aug 13 00:03:20.277389 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Aug 13 00:03:20.287298 systemd[1]: Finished dracut-pre-udev.service. Aug 13 00:03:20.287000 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' Aug 13 00:03:20.289102 systemd[1]: Starting systemd-udevd.service... Aug 13 00:03:20.291827 kernel: audit: type=1130 audit(1755043400.287: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' Aug 13 00:03:20.288000 audit: BPF prog-id=7 op=LOAD Aug 13 00:03:20.288000 audit: BPF prog-id=8 op=LOAD Aug 13 00:03:20.307399 systemd-udevd[491]: Using default interface naming scheme 'v252'. Aug 13 00:03:20.312025 systemd[1]: Started systemd-udevd.service. Aug 13 00:03:20.312000 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' Aug 13 00:03:20.313655 systemd[1]: Starting dracut-pre-trigger.service... Aug 13 00:03:20.327772 dracut-pre-trigger[495]: rd.md=0: removing MD RAID activation Aug 13 00:03:20.361927 systemd[1]: Finished dracut-pre-trigger.service. Aug 13 00:03:20.362000 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' Aug 13 00:03:20.363608 systemd[1]: Starting systemd-udev-trigger.service... Aug 13 00:03:20.414559 systemd[1]: Finished systemd-udev-trigger.service. Aug 13 00:03:20.414000 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' Aug 13 00:03:20.441681 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 13 00:03:20.451166 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 13 00:03:20.451182 kernel: GPT:9289727 != 19775487 Aug 13 00:03:20.451191 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 13 00:03:20.451200 kernel: GPT:9289727 != 19775487 Aug 13 00:03:20.451208 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 13 00:03:20.451216 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 00:03:20.463681 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Aug 13 00:03:20.465844 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by (udev-worker) (554) Aug 13 00:03:20.472243 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Aug 13 00:03:20.473126 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Aug 13 00:03:20.479454 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Aug 13 00:03:20.482078 systemd[1]: Starting disk-uuid.service... Aug 13 00:03:20.485792 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Aug 13 00:03:20.517941 disk-uuid[563]: Primary Header is updated. Aug 13 00:03:20.517941 disk-uuid[563]: Secondary Entries is updated. Aug 13 00:03:20.517941 disk-uuid[563]: Secondary Header is updated. Aug 13 00:03:20.520874 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 00:03:21.540380 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 13 00:03:21.540807 disk-uuid[564]: The operation has completed successfully. Aug 13 00:03:21.585962 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 13 00:03:21.586000 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' Aug 13 00:03:21.586000 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' Aug 13 00:03:21.586053 systemd[1]: Finished disk-uuid.service. Aug 13 00:03:21.587593 systemd[1]: Starting verity-setup.service... Aug 13 00:03:21.615378 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 13 00:03:21.649170 systemd[1]: Found device dev-mapper-usr.device. Aug 13 00:03:21.651366 systemd[1]: Mounting sysusr-usr.mount... Aug 13 00:03:21.653462 systemd[1]: Finished verity-setup.service. Aug 13 00:03:21.653000 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' Aug 13 00:03:21.707370 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Aug 13 00:03:21.708377 systemd[1]: Mounted sysusr-usr.mount. Aug 13 00:03:21.709085 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Aug 13 00:03:21.709874 systemd[1]: Starting ignition-setup.service... Aug 13 00:03:21.712505 systemd[1]: Starting parse-ip-for-networkd.service... Aug 13 00:03:21.724502 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:03:21.724553 kernel: BTRFS info (device vda6): using free space tree Aug 13 00:03:21.724563 kernel: BTRFS info (device vda6): has skinny extents Aug 13 00:03:21.749012 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 13 00:03:21.763833 systemd[1]: Finished ignition-setup.service. Aug 13 00:03:21.765558 systemd[1]: Starting ignition-fetch-offline.service... Aug 13 00:03:21.764000 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' Aug 13 00:03:21.831512 systemd[1]: Finished parse-ip-for-networkd.service. Aug 13 00:03:21.831000 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' Aug 13 00:03:21.832000 audit: BPF prog-id=9 op=LOAD Aug 13 00:03:21.833580 systemd[1]: Starting systemd-networkd.service... Aug 13 00:03:21.876921 systemd-networkd[736]: lo: Link UP Aug 13 00:03:21.876937 systemd-networkd[736]: lo: Gained carrier Aug 13 00:03:21.877862 systemd-networkd[736]: Enumeration completed Aug 13 00:03:21.878177 systemd-networkd[736]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 00:03:21.880038 systemd[1]: Started systemd-networkd.service. Aug 13 00:03:21.881000 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' Aug 13 00:03:21.881476 systemd[1]: Reached target network.target. Aug 13 00:03:21.882302 systemd-networkd[736]: eth0: Link UP Aug 13 00:03:21.882307 systemd-networkd[736]: eth0: Gained carrier Aug 13 00:03:21.884273 systemd[1]: Starting iscsiuio.service... Aug 13 00:03:21.895782 systemd[1]: Started iscsiuio.service. Aug 13 00:03:21.896000 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' Aug 13 00:03:21.897500 systemd[1]: Starting iscsid.service... Aug 13 00:03:21.901507 iscsid[746]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Aug 13 00:03:21.901507 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]. Aug 13 00:03:21.901507 iscsid[746]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Aug 13 00:03:21.901507 iscsid[746]: If using hardware iscsi like qla4xxx this message can be ignored. Aug 13 00:03:21.901507 iscsid[746]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Aug 13 00:03:21.901507 iscsid[746]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Aug 13 00:03:21.907000 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' Aug 13 00:03:21.904665 systemd[1]: Started iscsid.service. Aug 13 00:03:21.908636 systemd[1]: Starting dracut-initqueue.service... Aug 13 00:03:21.908960 systemd-networkd[736]: eth0: DHCPv4 address 10.0.0.81/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 00:03:21.921367 systemd[1]: Finished dracut-initqueue.service. Aug 13 00:03:21.921000 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' Aug 13 00:03:21.922176 systemd[1]: Reached target remote-fs-pre.target. Aug 13 00:03:21.923482 systemd[1]: Reached target remote-cryptsetup.target. Aug 13 00:03:21.924938 systemd[1]: Reached target remote-fs.target. Aug 13 00:03:21.927277 systemd[1]: Starting dracut-pre-mount.service... Aug 13 00:03:21.936045 systemd[1]: Finished dracut-pre-mount.service. Aug 13 00:03:21.936000 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' Aug 13 00:03:21.942860 ignition[674]: Ignition 2.14.0 Aug 13 00:03:21.942870 ignition[674]: Stage: fetch-offline Aug 13 00:03:21.942915 ignition[674]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:21.942924 ignition[674]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:21.943072 ignition[674]: parsed url from cmdline: "" Aug 13 00:03:21.943076 ignition[674]: no config URL provided Aug 13 00:03:21.943081 ignition[674]: reading system config file "/usr/lib/ignition/user.ign" Aug 13 00:03:21.943088 ignition[674]: no config at "/usr/lib/ignition/user.ign" Aug 13 00:03:21.943108 ignition[674]: op(1): [started] loading QEMU firmware config module Aug 13 00:03:21.943114 ignition[674]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 13 00:03:21.949777 ignition[674]: op(1): [finished] loading QEMU firmware config module Aug 13 00:03:21.956690 ignition[674]: parsing config with SHA512: ec3912264af85875be7ee2f48c23cc1d75c5ab5545ddf1940b05ce04202c7f8c373801785031f6d2159a0b0293383c6b9a1697255a094da2b552f4a752099765 Aug 13 00:03:21.963482 unknown[674]: fetched base config from "system" Aug 13 00:03:21.963498 unknown[674]: fetched user config from "qemu" Aug 13 00:03:21.963996 ignition[674]: fetch-offline: fetch-offline passed Aug 13 00:03:21.965000 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' Aug 13 00:03:21.965015 systemd[1]: Finished ignition-fetch-offline.service. Aug 13 00:03:21.964057 ignition[674]: Ignition finished successfully Aug 13 00:03:21.966262 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 13 00:03:21.967094 systemd[1]: Starting ignition-kargs.service... Aug 13 00:03:21.976939 ignition[762]: Ignition 2.14.0 Aug 13 00:03:21.976950 ignition[762]: Stage: kargs Aug 13 00:03:21.977059 ignition[762]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:21.979134 systemd[1]: Finished ignition-kargs.service. Aug 13 00:03:21.980000 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' Aug 13 00:03:21.977070 ignition[762]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:21.977853 ignition[762]: kargs: kargs passed Aug 13 00:03:21.981299 systemd[1]: Starting ignition-disks.service... Aug 13 00:03:21.977902 ignition[762]: Ignition finished successfully Aug 13 00:03:21.988410 ignition[768]: Ignition 2.14.0 Aug 13 00:03:21.988421 ignition[768]: Stage: disks Aug 13 00:03:21.988526 ignition[768]: no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:21.990356 systemd[1]: Finished ignition-disks.service. Aug 13 00:03:21.988536 ignition[768]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:21.991000 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' Aug 13 00:03:21.991779 systemd[1]: Reached target initrd-root-device.target. Aug 13 00:03:21.989237 ignition[768]: disks: disks passed Aug 13 00:03:21.992847 systemd[1]: Reached target local-fs-pre.target. Aug 13 00:03:21.989278 ignition[768]: Ignition finished successfully Aug 13 00:03:21.994122 systemd[1]: Reached target local-fs.target. Aug 13 00:03:21.995293 systemd[1]: Reached target sysinit.target. Aug 13 00:03:21.996309 systemd[1]: Reached target basic.target. Aug 13 00:03:21.998587 systemd[1]: Starting systemd-fsck-root.service... Aug 13 00:03:22.014159 systemd-fsck[776]: ROOT: clean, 629/553520 files, 56026/553472 blocks Aug 13 00:03:22.018466 systemd[1]: Finished systemd-fsck-root.service. Aug 13 00:03:22.018000 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' Aug 13 00:03:22.020175 systemd[1]: Mounting sysroot.mount... Aug 13 00:03:22.033276 systemd[1]: Mounted sysroot.mount. Aug 13 00:03:22.034285 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Aug 13 00:03:22.033935 systemd[1]: Reached target initrd-root-fs.target. Aug 13 00:03:22.036368 systemd[1]: Mounting sysroot-usr.mount... Aug 13 00:03:22.037132 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Aug 13 00:03:22.037173 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 13 00:03:22.037196 systemd[1]: Reached target ignition-diskful.target. Aug 13 00:03:22.039393 systemd[1]: Mounted sysroot-usr.mount. Aug 13 00:03:22.041759 systemd[1]: Starting initrd-setup-root.service... Aug 13 00:03:22.046779 initrd-setup-root[786]: cut: /sysroot/etc/passwd: No such file or directory Aug 13 00:03:22.050721 initrd-setup-root[794]: cut: /sysroot/etc/group: No such file or directory Aug 13 00:03:22.054000 initrd-setup-root[802]: cut: /sysroot/etc/shadow: No such file or directory Aug 13 00:03:22.058108 initrd-setup-root[810]: cut: /sysroot/etc/gshadow: No such file or directory Aug 13 00:03:22.092259 systemd[1]: Finished initrd-setup-root.service. Aug 13 00:03:22.092000 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' Aug 13 00:03:22.094185 systemd[1]: Starting ignition-mount.service... Aug 13 00:03:22.095807 systemd[1]: Starting sysroot-boot.service... Aug 13 00:03:22.101266 bash[827]: umount: /sysroot/usr/share/oem: not mounted. Aug 13 00:03:22.111912 ignition[828]: INFO : Ignition 2.14.0 Aug 13 00:03:22.111912 ignition[828]: INFO : Stage: mount Aug 13 00:03:22.114453 ignition[828]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:22.114453 ignition[828]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:22.114453 ignition[828]: INFO : mount: mount passed Aug 13 00:03:22.114453 ignition[828]: INFO : Ignition finished successfully Aug 13 00:03:22.114000 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' Aug 13 00:03:22.114107 systemd[1]: Finished ignition-mount.service. Aug 13 00:03:22.121709 systemd[1]: Finished sysroot-boot.service. Aug 13 00:03:22.121000 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' Aug 13 00:03:22.664574 systemd[1]: Mounting sysroot-usr-share-oem.mount... Aug 13 00:03:22.681392 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (839) Aug 13 00:03:22.683584 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 13 00:03:22.683618 kernel: BTRFS info (device vda6): using free space tree Aug 13 00:03:22.683630 kernel: BTRFS info (device vda6): has skinny extents Aug 13 00:03:22.693671 systemd[1]: Mounted sysroot-usr-share-oem.mount. Aug 13 00:03:22.695490 systemd[1]: Starting ignition-files.service... Aug 13 00:03:22.719074 ignition[859]: INFO : Ignition 2.14.0 Aug 13 00:03:22.719074 ignition[859]: INFO : Stage: files Aug 13 00:03:22.720720 ignition[859]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:22.720720 ignition[859]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:22.720720 ignition[859]: DEBUG : files: compiled without relabeling support, skipping Aug 13 00:03:22.725388 ignition[859]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 13 00:03:22.725388 ignition[859]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 13 00:03:22.732538 ignition[859]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 13 00:03:22.733628 ignition[859]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 13 00:03:22.734784 ignition[859]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 13 00:03:22.734443 unknown[859]: wrote ssh authorized keys file for user: core Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:03:22.736907 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.31.8-arm64.raw: attempt #1 Aug 13 00:03:23.097640 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Aug 13 00:03:23.452234 systemd-networkd[736]: eth0: Gained IPv6LL Aug 13 00:03:23.585153 ignition[859]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.8-arm64.raw" Aug 13 00:03:23.586990 ignition[859]: INFO : files: op(8): [started] processing unit "containerd.service" Aug 13 00:03:23.588143 ignition[859]: 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" Aug 13 00:03:23.588143 ignition[859]: 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" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(8): [finished] processing unit "containerd.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Aug 13 00:03:23.588143 ignition[859]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 00:03:23.658643 ignition[859]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 13 00:03:23.660975 ignition[859]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Aug 13 00:03:23.660975 ignition[859]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 13 00:03:23.660975 ignition[859]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 13 00:03:23.660975 ignition[859]: INFO : files: files passed Aug 13 00:03:23.660975 ignition[859]: INFO : Ignition finished successfully Aug 13 00:03:23.662000 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' Aug 13 00:03:23.660986 systemd[1]: Finished ignition-files.service. Aug 13 00:03:23.664147 systemd[1]: Starting initrd-setup-root-after-ignition.service... Aug 13 00:03:23.670553 initrd-setup-root-after-ignition[884]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Aug 13 00:03:23.670000 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' Aug 13 00:03:23.670000 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' Aug 13 00:03:23.665193 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Aug 13 00:03:23.673931 initrd-setup-root-after-ignition[886]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 13 00:03:23.674000 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' Aug 13 00:03:23.666121 systemd[1]: Starting ignition-quench.service... Aug 13 00:03:23.669596 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 13 00:03:23.669722 systemd[1]: Finished ignition-quench.service. Aug 13 00:03:23.673086 systemd[1]: Finished initrd-setup-root-after-ignition.service. Aug 13 00:03:23.674793 systemd[1]: Reached target ignition-complete.target. Aug 13 00:03:23.677512 systemd[1]: Starting initrd-parse-etc.service... Aug 13 00:03:23.695036 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 13 00:03:23.695167 systemd[1]: Finished initrd-parse-etc.service. Aug 13 00:03:23.696000 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' Aug 13 00:03:23.696000 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' Aug 13 00:03:23.696793 systemd[1]: Reached target initrd-fs.target. Aug 13 00:03:23.697618 systemd[1]: Reached target initrd.target. Aug 13 00:03:23.698749 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Aug 13 00:03:23.700190 systemd[1]: Starting dracut-pre-pivot.service... Aug 13 00:03:23.721725 systemd[1]: Finished dracut-pre-pivot.service. Aug 13 00:03:23.722000 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' Aug 13 00:03:23.723924 systemd[1]: Starting initrd-cleanup.service... Aug 13 00:03:23.736356 systemd[1]: Stopped target nss-lookup.target. Aug 13 00:03:23.737211 systemd[1]: Stopped target remote-cryptsetup.target. Aug 13 00:03:23.738399 systemd[1]: Stopped target timers.target. Aug 13 00:03:23.739533 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 13 00:03:23.740000 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' Aug 13 00:03:23.739676 systemd[1]: Stopped dracut-pre-pivot.service. Aug 13 00:03:23.740848 systemd[1]: Stopped target initrd.target. Aug 13 00:03:23.741959 systemd[1]: Stopped target basic.target. Aug 13 00:03:23.743065 systemd[1]: Stopped target ignition-complete.target. Aug 13 00:03:23.744224 systemd[1]: Stopped target ignition-diskful.target. Aug 13 00:03:23.745379 systemd[1]: Stopped target initrd-root-device.target. Aug 13 00:03:23.746648 systemd[1]: Stopped target remote-fs.target. Aug 13 00:03:23.747774 systemd[1]: Stopped target remote-fs-pre.target. Aug 13 00:03:23.748979 systemd[1]: Stopped target sysinit.target. Aug 13 00:03:23.749994 systemd[1]: Stopped target local-fs.target. Aug 13 00:03:23.751002 systemd[1]: Stopped target local-fs-pre.target. Aug 13 00:03:23.752017 systemd[1]: Stopped target swap.target. Aug 13 00:03:23.753000 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' Aug 13 00:03:23.753014 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 13 00:03:23.753149 systemd[1]: Stopped dracut-pre-mount.service. Aug 13 00:03:23.756000 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' Aug 13 00:03:23.754273 systemd[1]: Stopped target cryptsetup.target. Aug 13 00:03:23.757000 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' Aug 13 00:03:23.755225 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 13 00:03:23.755336 systemd[1]: Stopped dracut-initqueue.service. Aug 13 00:03:23.756660 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 13 00:03:23.756760 systemd[1]: Stopped ignition-fetch-offline.service. Aug 13 00:03:23.757849 systemd[1]: Stopped target paths.target. Aug 13 00:03:23.758941 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 13 00:03:23.762412 systemd[1]: Stopped systemd-ask-password-console.path. Aug 13 00:03:23.763929 systemd[1]: Stopped target slices.target. Aug 13 00:03:23.765117 systemd[1]: Stopped target sockets.target. Aug 13 00:03:23.766208 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 13 00:03:23.766000 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' Aug 13 00:03:23.766357 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Aug 13 00:03:23.768000 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' Aug 13 00:03:23.767426 systemd[1]: ignition-files.service: Deactivated successfully. Aug 13 00:03:23.767529 systemd[1]: Stopped ignition-files.service. Aug 13 00:03:23.770579 systemd[1]: Stopping ignition-mount.service... Aug 13 00:03:23.771888 iscsid[746]: iscsid shutting down. Aug 13 00:03:23.774102 systemd[1]: Stopping iscsid.service... Aug 13 00:03:23.776154 systemd[1]: Stopping sysroot-boot.service... Aug 13 00:03:23.776945 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 13 00:03:23.777000 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' Aug 13 00:03:23.777140 systemd[1]: Stopped systemd-udev-trigger.service. Aug 13 00:03:23.779000 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' Aug 13 00:03:23.778430 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 13 00:03:23.778533 systemd[1]: Stopped dracut-pre-trigger.service. Aug 13 00:03:23.782300 systemd[1]: iscsid.service: Deactivated successfully. Aug 13 00:03:23.782000 audit[1]: SERVICE_STOP 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' Aug 13 00:03:23.782477 systemd[1]: Stopped iscsid.service. Aug 13 00:03:23.783773 systemd[1]: iscsid.socket: Deactivated successfully. Aug 13 00:03:23.783876 systemd[1]: Closed iscsid.socket. Aug 13 00:03:23.784690 systemd[1]: Stopping iscsiuio.service... Aug 13 00:03:23.788564 systemd[1]: iscsiuio.service: Deactivated successfully. Aug 13 00:03:23.789000 audit[1]: SERVICE_STOP 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' Aug 13 00:03:23.788713 systemd[1]: Stopped iscsiuio.service. Aug 13 00:03:23.790000 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' Aug 13 00:03:23.790000 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' Aug 13 00:03:23.790201 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 13 00:03:23.790284 systemd[1]: Finished initrd-cleanup.service. Aug 13 00:03:23.791491 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 13 00:03:23.791573 systemd[1]: Closed iscsiuio.socket. Aug 13 00:03:23.793652 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 13 00:03:23.801916 ignition[899]: INFO : Ignition 2.14.0 Aug 13 00:03:23.801916 ignition[899]: INFO : Stage: umount Aug 13 00:03:23.803413 ignition[899]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 13 00:03:23.803413 ignition[899]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 13 00:03:23.803413 ignition[899]: INFO : umount: umount passed Aug 13 00:03:23.803413 ignition[899]: INFO : Ignition finished successfully Aug 13 00:03:23.805000 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' Aug 13 00:03:23.804364 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 13 00:03:23.807000 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' Aug 13 00:03:23.804476 systemd[1]: Stopped ignition-mount.service. Aug 13 00:03:23.808000 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' Aug 13 00:03:23.805824 systemd[1]: Stopped target network.target. Aug 13 00:03:23.809000 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' Aug 13 00:03:23.806855 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 13 00:03:23.806913 systemd[1]: Stopped ignition-disks.service. Aug 13 00:03:23.808143 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 13 00:03:23.808182 systemd[1]: Stopped ignition-kargs.service. Aug 13 00:03:23.809390 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 13 00:03:23.809426 systemd[1]: Stopped ignition-setup.service. Aug 13 00:03:23.810466 systemd[1]: Stopping systemd-networkd.service... Aug 13 00:03:23.811712 systemd[1]: Stopping systemd-resolved.service... Aug 13 00:03:23.820172 systemd-networkd[736]: eth0: DHCPv6 lease lost Aug 13 00:03:23.821590 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 13 00:03:23.822000 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' Aug 13 00:03:23.821771 systemd[1]: Stopped systemd-networkd.service. Aug 13 00:03:23.823669 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 13 00:03:23.825000 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' Aug 13 00:03:23.823784 systemd[1]: Stopped systemd-resolved.service. Aug 13 00:03:23.826666 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 13 00:03:23.826750 systemd[1]: Closed systemd-networkd.socket. Aug 13 00:03:23.829030 systemd[1]: Stopping network-cleanup.service... Aug 13 00:03:23.830445 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 13 00:03:23.830587 systemd[1]: Stopped parse-ip-for-networkd.service. Aug 13 00:03:23.831000 audit: BPF prog-id=9 op=UNLOAD Aug 13 00:03:23.832000 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' Aug 13 00:03:23.832678 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 13 00:03:23.833000 audit: BPF prog-id=6 op=UNLOAD Aug 13 00:03:23.832794 systemd[1]: Stopped systemd-sysctl.service. Aug 13 00:03:23.833000 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' Aug 13 00:03:23.835061 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 13 00:03:23.835148 systemd[1]: Stopped systemd-modules-load.service. Aug 13 00:03:23.836000 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' Aug 13 00:03:23.839252 systemd[1]: Stopping systemd-udevd.service... Aug 13 00:03:23.847962 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Aug 13 00:03:23.849260 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 13 00:03:23.849386 systemd[1]: Stopped sysroot-boot.service. Aug 13 00:03:23.850000 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' Aug 13 00:03:23.855434 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 13 00:03:23.855544 systemd[1]: Stopped initrd-setup-root.service. Aug 13 00:03:23.856000 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' Aug 13 00:03:23.857636 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 13 00:03:23.858157 systemd[1]: Stopped systemd-udevd.service. Aug 13 00:03:23.858000 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' Aug 13 00:03:23.859843 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 13 00:03:23.859935 systemd[1]: Stopped network-cleanup.service. Aug 13 00:03:23.860000 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' Aug 13 00:03:23.861404 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 13 00:03:23.861467 systemd[1]: Closed systemd-udevd-control.socket. Aug 13 00:03:23.862519 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 13 00:03:23.864000 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' Aug 13 00:03:23.862584 systemd[1]: Closed systemd-udevd-kernel.socket. Aug 13 00:03:23.865000 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' Aug 13 00:03:23.863744 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 13 00:03:23.867000 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' Aug 13 00:03:23.863830 systemd[1]: Stopped dracut-pre-udev.service. Aug 13 00:03:23.865191 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 13 00:03:23.865227 systemd[1]: Stopped dracut-cmdline.service. Aug 13 00:03:23.866476 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 13 00:03:23.871000 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' Aug 13 00:03:23.866519 systemd[1]: Stopped dracut-cmdline-ask.service. Aug 13 00:03:23.869258 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Aug 13 00:03:23.872000 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' Aug 13 00:03:23.870068 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 13 00:03:23.873000 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' Aug 13 00:03:23.870162 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service. Aug 13 00:03:23.872061 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 13 00:03:23.872104 systemd[1]: Stopped kmod-static-nodes.service. Aug 13 00:03:23.873248 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 13 00:03:23.873285 systemd[1]: Stopped systemd-vconsole-setup.service. Aug 13 00:03:23.877045 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Aug 13 00:03:23.878000 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' Aug 13 00:03:23.878000 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' Aug 13 00:03:23.878080 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 13 00:03:23.878172 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Aug 13 00:03:23.879046 systemd[1]: Reached target initrd-switch-root.target. Aug 13 00:03:23.881615 systemd[1]: Starting initrd-switch-root.service... Aug 13 00:03:23.890848 systemd[1]: Switching root. Aug 13 00:03:23.894000 audit: BPF prog-id=8 op=UNLOAD Aug 13 00:03:23.894000 audit: BPF prog-id=7 op=UNLOAD Aug 13 00:03:23.896000 audit: BPF prog-id=5 op=UNLOAD Aug 13 00:03:23.896000 audit: BPF prog-id=4 op=UNLOAD Aug 13 00:03:23.896000 audit: BPF prog-id=3 op=UNLOAD Aug 13 00:03:23.905033 systemd-journald[290]: Journal stopped Aug 13 00:03:26.250977 systemd-journald[290]: Received SIGTERM from PID 1 (systemd). Aug 13 00:03:26.251037 kernel: SELinux: Class mctp_socket not defined in policy. Aug 13 00:03:26.251049 kernel: SELinux: Class anon_inode not defined in policy. Aug 13 00:03:26.251063 kernel: SELinux: the above unknown classes and permissions will be allowed Aug 13 00:03:26.251073 kernel: SELinux: policy capability network_peer_controls=1 Aug 13 00:03:26.251083 kernel: SELinux: policy capability open_perms=1 Aug 13 00:03:26.251092 kernel: SELinux: policy capability extended_socket_class=1 Aug 13 00:03:26.251104 kernel: SELinux: policy capability always_check_network=0 Aug 13 00:03:26.251135 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 13 00:03:26.251145 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 13 00:03:26.251158 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 13 00:03:26.251168 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 13 00:03:26.251178 kernel: kauditd_printk_skb: 71 callbacks suppressed Aug 13 00:03:26.251188 kernel: audit: type=1403 audit(1755043404.071:82): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 13 00:03:26.251199 systemd[1]: Successfully loaded SELinux policy in 35.142ms. Aug 13 00:03:26.251216 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.416ms. Aug 13 00:03:26.251228 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) Aug 13 00:03:26.251240 systemd[1]: Detected virtualization kvm. Aug 13 00:03:26.251251 systemd[1]: Detected architecture arm64. Aug 13 00:03:26.251261 systemd[1]: Detected first boot. Aug 13 00:03:26.251271 systemd[1]: Initializing machine ID from VM UUID. Aug 13 00:03:26.251282 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Aug 13 00:03:26.251293 kernel: audit: type=1400 audit(1755043404.341:83): avc: denied { associate } for pid=949 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Aug 13 00:03:26.251305 kernel: audit: type=1300 audit(1755043404.341:83): arch=c00000b7 syscall=5 success=yes exit=0 a0=40001c767c a1=40000caae0 a2=40000d0a00 a3=32 items=0 ppid=932 pid=949 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Aug 13 00:03:26.251317 kernel: audit: type=1327 audit(1755043404.341:83): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Aug 13 00:03:26.251328 kernel: audit: type=1400 audit(1755043404.342:84): avc: denied { associate } for pid=949 comm="torcx-generator" name="lib" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Aug 13 00:03:26.251339 kernel: audit: type=1300 audit(1755043404.342:84): arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=40001c7755 a2=1ed a3=0 items=2 ppid=932 pid=949 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Aug 13 00:03:26.251360 kernel: audit: type=1307 audit(1755043404.342:84): cwd="/" Aug 13 00:03:26.251372 kernel: audit: type=1302 audit(1755043404.342:84): item=0 name=(null) inode=2 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Aug 13 00:03:26.251383 kernel: audit: type=1302 audit(1755043404.342:84): item=1 name=(null) inode=3 dev=00:29 mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Aug 13 00:03:26.251404 kernel: audit: type=1327 audit(1755043404.342:84): proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Aug 13 00:03:26.251415 systemd[1]: Populated /etc with preset unit settings. Aug 13 00:03:26.251426 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Aug 13 00:03:26.251437 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Aug 13 00:03:26.251448 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. Aug 13 00:03:26.251459 systemd[1]: Queued start job for default target multi-user.target. Aug 13 00:03:26.251471 systemd[1]: Unnecessary job was removed for dev-vda6.device. Aug 13 00:03:26.251482 systemd[1]: Created slice system-addon\x2dconfig.slice. Aug 13 00:03:26.251493 systemd[1]: Created slice system-addon\x2drun.slice. Aug 13 00:03:26.251503 systemd[1]: Created slice system-getty.slice. Aug 13 00:03:26.251514 systemd[1]: Created slice system-modprobe.slice. Aug 13 00:03:26.251524 systemd[1]: Created slice system-serial\x2dgetty.slice. Aug 13 00:03:26.251535 systemd[1]: Created slice system-system\x2dcloudinit.slice. Aug 13 00:03:26.251547 systemd[1]: Created slice system-systemd\x2dfsck.slice. Aug 13 00:03:26.251558 systemd[1]: Created slice user.slice. Aug 13 00:03:26.251570 systemd[1]: Started systemd-ask-password-console.path. Aug 13 00:03:26.251581 systemd[1]: Started systemd-ask-password-wall.path. Aug 13 00:03:26.251591 systemd[1]: Set up automount boot.automount. Aug 13 00:03:26.251609 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Aug 13 00:03:26.251621 systemd[1]: Reached target integritysetup.target. Aug 13 00:03:26.251632 systemd[1]: Reached target remote-cryptsetup.target. Aug 13 00:03:26.251642 systemd[1]: Reached target remote-fs.target. Aug 13 00:03:26.251653 systemd[1]: Reached target slices.target. Aug 13 00:03:26.251663 systemd[1]: Reached target swap.target. Aug 13 00:03:26.251674 systemd[1]: Reached target torcx.target. Aug 13 00:03:26.251684 systemd[1]: Reached target veritysetup.target. Aug 13 00:03:26.251698 systemd[1]: Listening on systemd-coredump.socket. Aug 13 00:03:26.251709 systemd[1]: Listening on systemd-initctl.socket. Aug 13 00:03:26.251721 systemd[1]: Listening on systemd-journald-audit.socket. Aug 13 00:03:26.251732 systemd[1]: Listening on systemd-journald-dev-log.socket. Aug 13 00:03:26.251743 systemd[1]: Listening on systemd-journald.socket. Aug 13 00:03:26.251753 systemd[1]: Listening on systemd-networkd.socket. Aug 13 00:03:26.251764 systemd[1]: Listening on systemd-udevd-control.socket. Aug 13 00:03:26.251774 systemd[1]: Listening on systemd-udevd-kernel.socket. Aug 13 00:03:26.251791 systemd[1]: Listening on systemd-userdbd.socket. Aug 13 00:03:26.251802 systemd[1]: Mounting dev-hugepages.mount... Aug 13 00:03:26.251812 systemd[1]: Mounting dev-mqueue.mount... Aug 13 00:03:26.251823 systemd[1]: Mounting media.mount... Aug 13 00:03:26.251834 systemd[1]: Mounting sys-kernel-debug.mount... Aug 13 00:03:26.251845 systemd[1]: Mounting sys-kernel-tracing.mount... Aug 13 00:03:26.251869 systemd[1]: Mounting tmp.mount... Aug 13 00:03:26.251880 systemd[1]: Starting flatcar-tmpfiles.service... Aug 13 00:03:26.251902 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Aug 13 00:03:26.251913 systemd[1]: Starting kmod-static-nodes.service... Aug 13 00:03:26.251930 systemd[1]: Starting modprobe@configfs.service... Aug 13 00:03:26.251947 systemd[1]: Starting modprobe@dm_mod.service... Aug 13 00:03:26.251958 systemd[1]: Starting modprobe@drm.service... Aug 13 00:03:26.251970 systemd[1]: Starting modprobe@efi_pstore.service... Aug 13 00:03:26.251981 systemd[1]: Starting modprobe@fuse.service... Aug 13 00:03:26.251992 systemd[1]: Starting modprobe@loop.service... Aug 13 00:03:26.252004 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 13 00:03:26.252015 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Aug 13 00:03:26.252026 systemd[1]: (This warning is only shown for the first unit using IP firewalling.) Aug 13 00:03:26.252036 systemd[1]: Starting systemd-journald.service... Aug 13 00:03:26.252047 systemd[1]: Starting systemd-modules-load.service... Aug 13 00:03:26.252058 systemd[1]: Starting systemd-network-generator.service... Aug 13 00:03:26.252070 systemd[1]: Starting systemd-remount-fs.service... Aug 13 00:03:26.252080 systemd[1]: Starting systemd-udev-trigger.service... Aug 13 00:03:26.252091 systemd[1]: Mounted dev-hugepages.mount. Aug 13 00:03:26.252104 systemd[1]: Mounted dev-mqueue.mount. Aug 13 00:03:26.252118 systemd[1]: Mounted media.mount. Aug 13 00:03:26.252136 systemd[1]: Mounted sys-kernel-debug.mount. Aug 13 00:03:26.252150 systemd[1]: Mounted sys-kernel-tracing.mount. Aug 13 00:03:26.252160 systemd[1]: Mounted tmp.mount. Aug 13 00:03:26.252171 systemd[1]: Finished kmod-static-nodes.service. Aug 13 00:03:26.252182 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 13 00:03:26.252192 systemd[1]: Finished modprobe@configfs.service. Aug 13 00:03:26.252203 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:03:26.252213 systemd[1]: Finished modprobe@dm_mod.service. Aug 13 00:03:26.252224 kernel: loop: module loaded Aug 13 00:03:26.252236 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 00:03:26.252248 kernel: fuse: init (API version 7.34) Aug 13 00:03:26.252258 systemd[1]: Finished modprobe@drm.service. Aug 13 00:03:26.252268 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:03:26.252278 systemd[1]: Finished modprobe@efi_pstore.service. Aug 13 00:03:26.252289 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 13 00:03:26.252301 systemd[1]: Finished modprobe@fuse.service. Aug 13 00:03:26.252313 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:03:26.252323 systemd[1]: Finished modprobe@loop.service. Aug 13 00:03:26.252333 systemd[1]: Finished systemd-modules-load.service. Aug 13 00:03:26.252361 systemd[1]: Finished systemd-network-generator.service. Aug 13 00:03:26.252373 systemd[1]: Finished systemd-remount-fs.service. Aug 13 00:03:26.252392 systemd-journald[1023]: Journal started Aug 13 00:03:26.252436 systemd-journald[1023]: Runtime Journal (/run/log/journal/0f822f1042984ef495ea86307d3b50a9) is 6.0M, max 48.7M, 42.6M free. Aug 13 00:03:26.137000 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 Aug 13 00:03:26.137000 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 Aug 13 00:03:26.228000 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' Aug 13 00:03:26.230000 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' Aug 13 00:03:26.230000 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' Aug 13 00:03:26.233000 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' Aug 13 00:03:26.233000 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' Aug 13 00:03:26.236000 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' Aug 13 00:03:26.237000 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' Aug 13 00:03:26.242000 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' Aug 13 00:03:26.242000 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' Aug 13 00:03:26.244000 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' Aug 13 00:03:26.244000 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' Aug 13 00:03:26.246000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Aug 13 00:03:26.246000 audit[1023]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=6 a1=ffffc4c699b0 a2=4000 a3=1 items=0 ppid=1 pid=1023 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) Aug 13 00:03:26.246000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Aug 13 00:03:26.247000 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' Aug 13 00:03:26.247000 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' Aug 13 00:03:26.249000 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' Aug 13 00:03:26.251000 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' Aug 13 00:03:26.253000 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' Aug 13 00:03:26.254816 systemd[1]: Started systemd-journald.service. Aug 13 00:03:26.254000 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' Aug 13 00:03:26.255895 systemd[1]: Reached target network-pre.target. Aug 13 00:03:26.258018 systemd[1]: Mounting sys-fs-fuse-connections.mount... Aug 13 00:03:26.260410 systemd[1]: Mounting sys-kernel-config.mount... Aug 13 00:03:26.262720 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 13 00:03:26.264616 systemd[1]: Starting systemd-hwdb-update.service... Aug 13 00:03:26.266768 systemd[1]: Starting systemd-journal-flush.service... Aug 13 00:03:26.267511 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:03:26.268711 systemd[1]: Starting systemd-random-seed.service... Aug 13 00:03:26.269458 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Aug 13 00:03:26.270708 systemd[1]: Starting systemd-sysctl.service... Aug 13 00:03:26.273873 systemd[1]: Mounted sys-fs-fuse-connections.mount. Aug 13 00:03:26.274914 systemd[1]: Mounted sys-kernel-config.mount. Aug 13 00:03:26.279075 systemd-journald[1023]: Time spent on flushing to /var/log/journal/0f822f1042984ef495ea86307d3b50a9 is 11.622ms for 919 entries. Aug 13 00:03:26.279075 systemd-journald[1023]: System Journal (/var/log/journal/0f822f1042984ef495ea86307d3b50a9) is 8.0M, max 195.6M, 187.6M free. Aug 13 00:03:26.299719 systemd-journald[1023]: Received client request to flush runtime journal. Aug 13 00:03:26.288000 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' Aug 13 00:03:26.289000 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' Aug 13 00:03:26.294000 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' Aug 13 00:03:26.287726 systemd[1]: Finished systemd-random-seed.service. Aug 13 00:03:26.288468 systemd[1]: Reached target first-boot-complete.target. Aug 13 00:03:26.289470 systemd[1]: Finished flatcar-tmpfiles.service. Aug 13 00:03:26.291452 systemd[1]: Starting systemd-sysusers.service... Aug 13 00:03:26.294295 systemd[1]: Finished systemd-sysctl.service. Aug 13 00:03:26.300784 systemd[1]: Finished systemd-journal-flush.service. Aug 13 00:03:26.301000 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' Aug 13 00:03:26.304020 systemd[1]: Finished systemd-udev-trigger.service. Aug 13 00:03:26.306036 systemd[1]: Starting systemd-udev-settle.service... Aug 13 00:03:26.304000 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' Aug 13 00:03:26.312726 udevadm[1083]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Aug 13 00:03:26.321646 systemd[1]: Finished systemd-sysusers.service. Aug 13 00:03:26.321000 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' Aug 13 00:03:26.323590 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Aug 13 00:03:26.341341 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Aug 13 00:03:26.341000 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' Aug 13 00:03:26.743000 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' Aug 13 00:03:26.743463 systemd[1]: Finished systemd-hwdb-update.service. Aug 13 00:03:26.745490 systemd[1]: Starting systemd-udevd.service... Aug 13 00:03:26.765507 systemd-udevd[1090]: Using default interface naming scheme 'v252'. Aug 13 00:03:26.782111 systemd[1]: Started systemd-udevd.service. Aug 13 00:03:26.782000 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' Aug 13 00:03:26.784369 systemd[1]: Starting systemd-networkd.service... Aug 13 00:03:26.791764 systemd[1]: Starting systemd-userdbd.service... Aug 13 00:03:26.820447 systemd[1]: Found device dev-ttyAMA0.device. Aug 13 00:03:26.844906 systemd[1]: Started systemd-userdbd.service. Aug 13 00:03:26.845000 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' Aug 13 00:03:26.869849 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Aug 13 00:03:26.912896 systemd[1]: Finished systemd-udev-settle.service. Aug 13 00:03:26.913000 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' Aug 13 00:03:26.915147 systemd[1]: Starting lvm2-activation-early.service... Aug 13 00:03:26.920091 systemd-networkd[1098]: lo: Link UP Aug 13 00:03:26.920099 systemd-networkd[1098]: lo: Gained carrier Aug 13 00:03:26.920831 systemd-networkd[1098]: Enumeration completed Aug 13 00:03:26.921155 systemd-networkd[1098]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 13 00:03:26.921169 systemd[1]: Started systemd-networkd.service. Aug 13 00:03:26.921000 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' Aug 13 00:03:26.925030 systemd-networkd[1098]: eth0: Link UP Aug 13 00:03:26.925037 systemd-networkd[1098]: eth0: Gained carrier Aug 13 00:03:26.928029 lvm[1124]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 00:03:26.948495 systemd-networkd[1098]: eth0: DHCPv4 address 10.0.0.81/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 13 00:03:26.953314 systemd[1]: Finished lvm2-activation-early.service. Aug 13 00:03:26.953000 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' Aug 13 00:03:26.954100 systemd[1]: Reached target cryptsetup.target. Aug 13 00:03:26.955914 systemd[1]: Starting lvm2-activation.service... Aug 13 00:03:26.959672 lvm[1126]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 13 00:03:26.994477 systemd[1]: Finished lvm2-activation.service. Aug 13 00:03:26.994000 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' Aug 13 00:03:26.995310 systemd[1]: Reached target local-fs-pre.target. Aug 13 00:03:26.996046 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Aug 13 00:03:26.996073 systemd[1]: Reached target local-fs.target. Aug 13 00:03:26.996667 systemd[1]: Reached target machines.target. Aug 13 00:03:26.998667 systemd[1]: Starting ldconfig.service... Aug 13 00:03:26.999577 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Aug 13 00:03:26.999676 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). Aug 13 00:03:27.001386 systemd[1]: Starting systemd-boot-update.service... Aug 13 00:03:27.003985 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Aug 13 00:03:27.007055 systemd[1]: Starting systemd-machine-id-commit.service... Aug 13 00:03:27.009951 systemd[1]: Starting systemd-sysext.service... Aug 13 00:03:27.015377 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1129 (bootctl) Aug 13 00:03:27.016775 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Aug 13 00:03:27.026815 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Aug 13 00:03:27.027000 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' Aug 13 00:03:27.033304 systemd[1]: Unmounting usr-share-oem.mount... Aug 13 00:03:27.037227 systemd[1]: usr-share-oem.mount: Deactivated successfully. Aug 13 00:03:27.037523 systemd[1]: Unmounted usr-share-oem.mount. Aug 13 00:03:27.051388 kernel: loop0: detected capacity change from 0 to 203944 Aug 13 00:03:27.096868 systemd[1]: Finished systemd-machine-id-commit.service. Aug 13 00:03:27.097000 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' Aug 13 00:03:27.103377 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 13 00:03:27.115920 systemd-fsck[1141]: fsck.fat 4.2 (2021-01-31) Aug 13 00:03:27.115920 systemd-fsck[1141]: /dev/vda1: 236 files, 117307/258078 clusters Aug 13 00:03:27.117365 kernel: loop1: detected capacity change from 0 to 203944 Aug 13 00:03:27.119317 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Aug 13 00:03:27.119000 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' Aug 13 00:03:27.126220 (sd-sysext)[1145]: Using extensions 'kubernetes'. Aug 13 00:03:27.126602 (sd-sysext)[1145]: Merged extensions into '/usr'. Aug 13 00:03:27.147185 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.149113 systemd[1]: Starting modprobe@dm_mod.service... Aug 13 00:03:27.151314 systemd[1]: Starting modprobe@efi_pstore.service... Aug 13 00:03:27.153289 systemd[1]: Starting modprobe@loop.service... Aug 13 00:03:27.153963 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.154088 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). Aug 13 00:03:27.154859 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:03:27.155022 systemd[1]: Finished modprobe@dm_mod.service. Aug 13 00:03:27.155000 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' Aug 13 00:03:27.155000 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' Aug 13 00:03:27.156606 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:03:27.156770 systemd[1]: Finished modprobe@efi_pstore.service. Aug 13 00:03:27.157000 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' Aug 13 00:03:27.157000 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' Aug 13 00:03:27.158111 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:03:27.158338 systemd[1]: Finished modprobe@loop.service. Aug 13 00:03:27.158000 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' Aug 13 00:03:27.158000 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' Aug 13 00:03:27.159299 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:03:27.159519 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.217432 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 13 00:03:27.219962 systemd[1]: Mounting boot.mount... Aug 13 00:03:27.222216 systemd[1]: Mounting usr-share-oem.mount... Aug 13 00:03:27.230333 systemd[1]: Mounted boot.mount. Aug 13 00:03:27.231395 systemd[1]: Mounted usr-share-oem.mount. Aug 13 00:03:27.233694 systemd[1]: Finished systemd-sysext.service. Aug 13 00:03:27.234000 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' Aug 13 00:03:27.236682 systemd[1]: Starting ensure-sysext.service... Aug 13 00:03:27.238885 systemd[1]: Starting systemd-tmpfiles-setup.service... Aug 13 00:03:27.244000 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' Aug 13 00:03:27.246501 ldconfig[1128]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 13 00:03:27.243932 systemd[1]: Finished systemd-boot-update.service. Aug 13 00:03:27.246337 systemd[1]: Reloading. Aug 13 00:03:27.250411 systemd-tmpfiles[1163]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Aug 13 00:03:27.251889 systemd-tmpfiles[1163]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 13 00:03:27.253417 systemd-tmpfiles[1163]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 13 00:03:27.288549 /usr/lib/systemd/system-generators/torcx-generator[1185]: time="2025-08-13T00:03: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.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Aug 13 00:03:27.288581 /usr/lib/systemd/system-generators/torcx-generator[1185]: time="2025-08-13T00:03:27Z" level=info msg="torcx already run" Aug 13 00:03:27.362143 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Aug 13 00:03:27.362163 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Aug 13 00:03:27.381310 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. Aug 13 00:03:27.427384 systemd[1]: Finished ldconfig.service. Aug 13 00:03:27.427000 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' Aug 13 00:03:27.429364 systemd[1]: Finished systemd-tmpfiles-setup.service. Aug 13 00:03:27.429000 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' Aug 13 00:03:27.432441 systemd[1]: Starting audit-rules.service... Aug 13 00:03:27.434777 systemd[1]: Starting clean-ca-certificates.service... Aug 13 00:03:27.437036 systemd[1]: Starting systemd-journal-catalog-update.service... Aug 13 00:03:27.439508 systemd[1]: Starting systemd-resolved.service... Aug 13 00:03:27.441634 systemd[1]: Starting systemd-timesyncd.service... Aug 13 00:03:27.443872 systemd[1]: Starting systemd-update-utmp.service... Aug 13 00:03:27.445724 systemd[1]: Finished clean-ca-certificates.service. Aug 13 00:03:27.446000 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' Aug 13 00:03:27.450000 audit[1243]: SYSTEM_BOOT pid=1243 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' Aug 13 00:03:27.448768 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 13 00:03:27.454092 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.455720 systemd[1]: Starting modprobe@dm_mod.service... Aug 13 00:03:27.457856 systemd[1]: Starting modprobe@efi_pstore.service... Aug 13 00:03:27.459757 systemd[1]: Starting modprobe@loop.service... Aug 13 00:03:27.460556 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.460712 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). Aug 13 00:03:27.460816 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 13 00:03:27.461776 systemd[1]: Finished systemd-update-utmp.service. Aug 13 00:03:27.462000 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' Aug 13 00:03:27.463000 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' Aug 13 00:03:27.463000 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' Aug 13 00:03:27.462963 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:03:27.463125 systemd[1]: Finished modprobe@efi_pstore.service. Aug 13 00:03:27.464287 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:03:27.464508 systemd[1]: Finished modprobe@loop.service. Aug 13 00:03:27.465000 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' Aug 13 00:03:27.465000 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' Aug 13 00:03:27.467412 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:03:27.469013 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.470909 systemd[1]: Starting modprobe@efi_pstore.service... Aug 13 00:03:27.473821 systemd[1]: Starting modprobe@loop.service... Aug 13 00:03:27.474532 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.474767 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). Aug 13 00:03:27.474959 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 13 00:03:27.476000 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' Aug 13 00:03:27.478000 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' Aug 13 00:03:27.478000 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' Aug 13 00:03:27.479000 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' Aug 13 00:03:27.479000 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' Aug 13 00:03:27.476080 systemd[1]: Finished systemd-journal-catalog-update.service. Aug 13 00:03:27.477477 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:03:27.477642 systemd[1]: Finished modprobe@dm_mod.service. Aug 13 00:03:27.478809 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:03:27.478969 systemd[1]: Finished modprobe@efi_pstore.service. Aug 13 00:03:27.480014 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:03:27.484746 systemd[1]: Starting systemd-update-done.service... Aug 13 00:03:27.486000 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' Aug 13 00:03:27.486000 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' Aug 13 00:03:27.486055 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:03:27.486254 systemd[1]: Finished modprobe@loop.service. Aug 13 00:03:27.489553 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.490939 systemd[1]: Starting modprobe@dm_mod.service... Aug 13 00:03:27.492909 systemd[1]: Starting modprobe@drm.service... Aug 13 00:03:27.494773 systemd[1]: Starting modprobe@efi_pstore.service... Aug 13 00:03:27.496816 systemd[1]: Starting modprobe@loop.service... Aug 13 00:03:27.497583 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.497750 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). Aug 13 00:03:27.499220 systemd[1]: Starting systemd-networkd-wait-online.service... Aug 13 00:03:27.502312 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 13 00:03:27.503911 systemd[1]: Finished systemd-update-done.service. Aug 13 00:03:27.504000 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' Aug 13 00:03:27.505158 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 13 00:03:27.505873 systemd[1]: Finished modprobe@drm.service. Aug 13 00:03:27.506000 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' Aug 13 00:03:27.506000 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' Aug 13 00:03:27.507000 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' Aug 13 00:03:27.507000 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' Aug 13 00:03:27.509000 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' Aug 13 00:03:27.509000 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' Aug 13 00:03:27.507034 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 13 00:03:27.507192 systemd[1]: Finished modprobe@efi_pstore.service. Aug 13 00:03:27.508539 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 13 00:03:27.508704 systemd[1]: Finished modprobe@loop.service. Aug 13 00:03:27.509912 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 13 00:03:27.510112 systemd[1]: Finished modprobe@dm_mod.service. Aug 13 00:03:27.510000 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' Aug 13 00:03:27.510000 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' Aug 13 00:03:27.511635 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 13 00:03:27.511733 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.513000 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' Aug 13 00:03:27.512903 systemd[1]: Finished ensure-sysext.service. Aug 13 00:03:27.539000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Aug 13 00:03:27.539000 audit[1281]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffad91090 a2=420 a3=0 items=0 ppid=1231 pid=1281 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) Aug 13 00:03:27.539000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Aug 13 00:03:27.543491 augenrules[1281]: No rules Aug 13 00:03:27.541556 systemd[1]: Finished audit-rules.service. Aug 13 00:03:27.547991 systemd[1]: Started systemd-timesyncd.service. Aug 13 00:03:27.549145 systemd-timesyncd[1239]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 13 00:03:27.549246 systemd[1]: Reached target time-set.target. Aug 13 00:03:27.549606 systemd-timesyncd[1239]: Initial clock synchronization to Wed 2025-08-13 00:03:27.539054 UTC. Aug 13 00:03:27.550042 systemd-resolved[1235]: Positive Trust Anchors: Aug 13 00:03:27.550056 systemd-resolved[1235]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 13 00:03:27.550084 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 Aug 13 00:03:27.563128 systemd-resolved[1235]: Defaulting to hostname 'linux'. Aug 13 00:03:27.564705 systemd[1]: Started systemd-resolved.service. Aug 13 00:03:27.565484 systemd[1]: Reached target network.target. Aug 13 00:03:27.566111 systemd[1]: Reached target nss-lookup.target. Aug 13 00:03:27.566773 systemd[1]: Reached target sysinit.target. Aug 13 00:03:27.567471 systemd[1]: Started motdgen.path. Aug 13 00:03:27.568068 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Aug 13 00:03:27.569163 systemd[1]: Started logrotate.timer. Aug 13 00:03:27.569895 systemd[1]: Started mdadm.timer. Aug 13 00:03:27.570474 systemd[1]: Started systemd-tmpfiles-clean.timer. Aug 13 00:03:27.571164 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 13 00:03:27.571197 systemd[1]: Reached target paths.target. Aug 13 00:03:27.571861 systemd[1]: Reached target timers.target. Aug 13 00:03:27.573042 systemd[1]: Listening on dbus.socket. Aug 13 00:03:27.575119 systemd[1]: Starting docker.socket... Aug 13 00:03:27.580251 systemd[1]: Listening on sshd.socket. Aug 13 00:03:27.581105 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). Aug 13 00:03:27.581688 systemd[1]: Listening on docker.socket. Aug 13 00:03:27.582402 systemd[1]: Reached target sockets.target. Aug 13 00:03:27.583081 systemd[1]: Reached target basic.target. Aug 13 00:03:27.583917 systemd[1]: System is tainted: cgroupsv1 Aug 13 00:03:27.583963 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.583984 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Aug 13 00:03:27.585153 systemd[1]: Starting containerd.service... Aug 13 00:03:27.586954 systemd[1]: Starting dbus.service... Aug 13 00:03:27.588946 systemd[1]: Starting enable-oem-cloudinit.service... Aug 13 00:03:27.591097 systemd[1]: Starting extend-filesystems.service... Aug 13 00:03:27.592078 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Aug 13 00:03:27.593513 systemd[1]: Starting motdgen.service... Aug 13 00:03:27.595581 systemd[1]: Starting ssh-key-proc-cmdline.service... Aug 13 00:03:27.599014 systemd[1]: Starting sshd-keygen.service... Aug 13 00:03:27.602751 systemd[1]: Starting systemd-logind.service... Aug 13 00:03:27.603665 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Aug 13 00:03:27.603776 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 13 00:03:27.605097 systemd[1]: Starting update-engine.service... Aug 13 00:03:27.606944 systemd[1]: Starting update-ssh-keys-after-ignition.service... Aug 13 00:03:27.609329 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 13 00:03:27.609865 systemd[1]: Finished ssh-key-proc-cmdline.service. Aug 13 00:03:27.611179 jq[1293]: false Aug 13 00:03:27.612995 jq[1311]: true Aug 13 00:03:27.616971 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 13 00:03:27.617281 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Aug 13 00:03:27.627807 systemd[1]: motdgen.service: Deactivated successfully. Aug 13 00:03:27.628044 jq[1318]: true Aug 13 00:03:27.628953 systemd[1]: Finished motdgen.service. Aug 13 00:03:27.633854 extend-filesystems[1294]: Found loop1 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda1 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda2 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda3 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found usr Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda4 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda6 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda7 Aug 13 00:03:27.635182 extend-filesystems[1294]: Found vda9 Aug 13 00:03:27.635182 extend-filesystems[1294]: Checking size of /dev/vda9 Aug 13 00:03:27.658303 dbus-daemon[1292]: [system] SELinux support is enabled Aug 13 00:03:27.660394 systemd[1]: Started dbus.service. Aug 13 00:03:27.663108 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). Aug 13 00:03:27.663151 systemd[1]: Reached target system-config.target. Aug 13 00:03:27.663984 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Aug 13 00:03:27.664014 systemd[1]: Reached target user-config.target. Aug 13 00:03:27.679955 extend-filesystems[1294]: Resized partition /dev/vda9 Aug 13 00:03:27.693820 extend-filesystems[1346]: resize2fs 1.46.5 (30-Dec-2021) Aug 13 00:03:27.699542 systemd-logind[1303]: Watching system buttons on /dev/input/event0 (Power Button) Aug 13 00:03:27.707001 systemd-logind[1303]: New seat seat0. Aug 13 00:03:27.708368 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 13 00:03:27.709640 systemd[1]: Started systemd-logind.service. Aug 13 00:03:27.710990 bash[1343]: Updated "/home/core/.ssh/authorized_keys" Aug 13 00:03:27.712088 systemd[1]: Finished update-ssh-keys-after-ignition.service. Aug 13 00:03:27.732855 update_engine[1310]: I0813 00:03:27.732602 1310 main.cc:92] Flatcar Update Engine starting Aug 13 00:03:27.738683 systemd[1]: Started update-engine.service. Aug 13 00:03:27.741362 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 13 00:03:27.741802 systemd[1]: Started locksmithd.service. Aug 13 00:03:27.742880 update_engine[1310]: I0813 00:03:27.742674 1310 update_check_scheduler.cc:74] Next update check in 9m49s Aug 13 00:03:27.762414 extend-filesystems[1346]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 13 00:03:27.762414 extend-filesystems[1346]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 13 00:03:27.762414 extend-filesystems[1346]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 13 00:03:27.765365 extend-filesystems[1294]: Resized filesystem in /dev/vda9 Aug 13 00:03:27.764014 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 13 00:03:27.766613 env[1315]: time="2025-08-13T00:03:27.762741720Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Aug 13 00:03:27.764265 systemd[1]: Finished extend-filesystems.service. Aug 13 00:03:27.781185 env[1315]: time="2025-08-13T00:03:27.781137400Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 13 00:03:27.781605 env[1315]: time="2025-08-13T00:03:27.781305800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.782667 env[1315]: time="2025-08-13T00:03:27.782629840Z" 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.189-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 13 00:03:27.782667 env[1315]: time="2025-08-13T00:03:27.782668200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.782987 env[1315]: time="2025-08-13T00:03:27.782965760Z" 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 Aug 13 00:03:27.782987 env[1315]: time="2025-08-13T00:03:27.782986720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.783038 env[1315]: time="2025-08-13T00:03:27.783000840Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 13 00:03:27.783038 env[1315]: time="2025-08-13T00:03:27.783011000Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.783097 env[1315]: time="2025-08-13T00:03:27.783083160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.783418 env[1315]: time="2025-08-13T00:03:27.783399600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 13 00:03:27.783571 env[1315]: time="2025-08-13T00:03:27.783552440Z" 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 Aug 13 00:03:27.783605 env[1315]: time="2025-08-13T00:03:27.783571520Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 13 00:03:27.783651 env[1315]: time="2025-08-13T00:03:27.783635600Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 13 00:03:27.783685 env[1315]: time="2025-08-13T00:03:27.783651680Z" level=info msg="metadata content store policy set" policy=shared Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788491800Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788537360Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788557400Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788596000Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788611760Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788626600Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.788650 env[1315]: time="2025-08-13T00:03:27.788641560Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789014 env[1315]: time="2025-08-13T00:03:27.788996760Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789061 env[1315]: time="2025-08-13T00:03:27.789018040Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789061 env[1315]: time="2025-08-13T00:03:27.789031160Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789061 env[1315]: time="2025-08-13T00:03:27.789044000Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789061 env[1315]: time="2025-08-13T00:03:27.789057720Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 13 00:03:27.789194 env[1315]: time="2025-08-13T00:03:27.789175760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 13 00:03:27.789270 env[1315]: time="2025-08-13T00:03:27.789255560Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 13 00:03:27.789601 env[1315]: time="2025-08-13T00:03:27.789574840Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 13 00:03:27.789636 env[1315]: time="2025-08-13T00:03:27.789616240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789636 env[1315]: time="2025-08-13T00:03:27.789633520Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 13 00:03:27.789750 env[1315]: time="2025-08-13T00:03:27.789737880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789786 env[1315]: time="2025-08-13T00:03:27.789753360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789786 env[1315]: time="2025-08-13T00:03:27.789765400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789786 env[1315]: time="2025-08-13T00:03:27.789776600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789853 env[1315]: time="2025-08-13T00:03:27.789788080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789853 env[1315]: time="2025-08-13T00:03:27.789800320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789853 env[1315]: time="2025-08-13T00:03:27.789811360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789853 env[1315]: time="2025-08-13T00:03:27.789822720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.789853 env[1315]: time="2025-08-13T00:03:27.789836480Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 13 00:03:27.790012 env[1315]: time="2025-08-13T00:03:27.789953560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.790012 env[1315]: time="2025-08-13T00:03:27.789999520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.790012 env[1315]: time="2025-08-13T00:03:27.790013440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.790097 env[1315]: time="2025-08-13T00:03:27.790030200Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 13 00:03:27.790097 env[1315]: time="2025-08-13T00:03:27.790045240Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Aug 13 00:03:27.790097 env[1315]: time="2025-08-13T00:03:27.790062120Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 13 00:03:27.790097 env[1315]: time="2025-08-13T00:03:27.790078760Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Aug 13 00:03:27.790173 env[1315]: time="2025-08-13T00:03:27.790111120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 13 00:03:27.790361 env[1315]: time="2025-08-13T00:03:27.790302280Z" 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}" Aug 13 00:03:27.790958 env[1315]: time="2025-08-13T00:03:27.790373920Z" level=info msg="Connect containerd service" Aug 13 00:03:27.790958 env[1315]: time="2025-08-13T00:03:27.790404960Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 13 00:03:27.791025 env[1315]: time="2025-08-13T00:03:27.790988720Z" 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" Aug 13 00:03:27.791259 env[1315]: time="2025-08-13T00:03:27.791227840Z" level=info msg="Start subscribing containerd event" Aug 13 00:03:27.791290 env[1315]: time="2025-08-13T00:03:27.791277840Z" level=info msg="Start recovering state" Aug 13 00:03:27.791353 env[1315]: time="2025-08-13T00:03:27.791332960Z" level=info msg="Start event monitor" Aug 13 00:03:27.791404 env[1315]: time="2025-08-13T00:03:27.791392280Z" level=info msg="Start snapshots syncer" Aug 13 00:03:27.791428 env[1315]: time="2025-08-13T00:03:27.791406240Z" level=info msg="Start cni network conf syncer for default" Aug 13 00:03:27.791428 env[1315]: time="2025-08-13T00:03:27.791414400Z" level=info msg="Start streaming server" Aug 13 00:03:27.791848 env[1315]: time="2025-08-13T00:03:27.791792800Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 13 00:03:27.791848 env[1315]: time="2025-08-13T00:03:27.791832720Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 13 00:03:27.791925 env[1315]: time="2025-08-13T00:03:27.791887240Z" level=info msg="containerd successfully booted in 0.051365s" Aug 13 00:03:27.791990 systemd[1]: Started containerd.service. Aug 13 00:03:27.814076 locksmithd[1350]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 13 00:03:28.507604 systemd-networkd[1098]: eth0: Gained IPv6LL Aug 13 00:03:28.509360 systemd[1]: Finished systemd-networkd-wait-online.service. Aug 13 00:03:28.510324 systemd[1]: Reached target network-online.target. Aug 13 00:03:28.512710 systemd[1]: Starting kubelet.service... Aug 13 00:03:28.802105 sshd_keygen[1313]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 13 00:03:28.821013 systemd[1]: Finished sshd-keygen.service. Aug 13 00:03:28.823497 systemd[1]: Starting issuegen.service... Aug 13 00:03:28.828794 systemd[1]: issuegen.service: Deactivated successfully. Aug 13 00:03:28.829026 systemd[1]: Finished issuegen.service. Aug 13 00:03:28.831490 systemd[1]: Starting systemd-user-sessions.service... Aug 13 00:03:28.838202 systemd[1]: Finished systemd-user-sessions.service. Aug 13 00:03:28.840952 systemd[1]: Started getty@tty1.service. Aug 13 00:03:28.843815 systemd[1]: Started serial-getty@ttyAMA0.service. Aug 13 00:03:28.844745 systemd[1]: Reached target getty.target. Aug 13 00:03:29.198926 systemd[1]: Started kubelet.service. Aug 13 00:03:29.200796 systemd[1]: Reached target multi-user.target. Aug 13 00:03:29.206052 systemd[1]: Starting systemd-update-utmp-runlevel.service... Aug 13 00:03:29.217296 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Aug 13 00:03:29.217566 systemd[1]: Finished systemd-update-utmp-runlevel.service. Aug 13 00:03:29.218786 systemd[1]: Startup finished in 5.088s (kernel) + 5.190s (userspace) = 10.278s. Aug 13 00:03:29.737493 kubelet[1386]: E0813 00:03:29.737435 1386 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Aug 13 00:03:29.739319 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 13 00:03:29.739501 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 13 00:03:32.699107 systemd[1]: Created slice system-sshd.slice. Aug 13 00:03:32.700659 systemd[1]: Started sshd@0-10.0.0.81:22-10.0.0.1:41744.service. Aug 13 00:03:32.745553 sshd[1396]: Accepted publickey for core from 10.0.0.1 port 41744 ssh2: RSA SHA256:4jnu15cGk13pD8KfkQFNgDiqBqiu/IV3MiTKKCAhqJg Aug 13 00:03:32.748358 sshd[1396]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:32.759342 systemd[1]: Created slice user-500.slice. Aug 13 00:03:32.760450 systemd[1]: Starting user-runtime-dir@500.service... Aug 13 00:03:32.762789 systemd-logind[1303]: New session 1 of user core. Aug 13 00:03:32.772084 systemd[1]: Finished user-runtime-dir@500.service. Aug 13 00:03:32.773682 systemd[1]: Starting user@500.service... Aug 13 00:03:32.777139 (systemd)[1401]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:32.843764 systemd[1401]: Queued start job for default target default.target. Aug 13 00:03:32.844033 systemd[1401]: Reached target paths.target. Aug 13 00:03:32.844048 systemd[1401]: Reached target sockets.target. Aug 13 00:03:32.844060 systemd[1401]: Reached target timers.target. Aug 13 00:03:32.844070 systemd[1401]: Reached target basic.target. Aug 13 00:03:32.844121 systemd[1401]: Reached target default.target. Aug 13 00:03:32.844145 systemd[1401]: Startup finished in 61ms. Aug 13 00:03:32.844359 systemd[1]: Started user@500.service. Aug 13 00:03:32.845402 systemd[1]: Started session-1.scope. Aug 13 00:03:32.896007 systemd[1]: Started sshd@1-10.0.0.81:22-10.0.0.1:41756.service. Aug 13 00:03:32.940412 sshd[1410]: Accepted publickey for core from 10.0.0.1 port 41756 ssh2: RSA SHA256:4jnu15cGk13pD8KfkQFNgDiqBqiu/IV3MiTKKCAhqJg Aug 13 00:03:32.941767 sshd[1410]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:32.945326 systemd-logind[1303]: New session 2 of user core. Aug 13 00:03:32.946125 systemd[1]: Started session-2.scope. Aug 13 00:03:33.000014 sshd[1410]: pam_unix(sshd:session): session closed for user core Aug 13 00:03:33.002488 systemd[1]: Started sshd@2-10.0.0.81:22-10.0.0.1:41762.service. Aug 13 00:03:33.003207 systemd[1]: sshd@1-10.0.0.81:22-10.0.0.1:41756.service: Deactivated successfully. Aug 13 00:03:33.004405 systemd-logind[1303]: Session 2 logged out. Waiting for processes to exit. Aug 13 00:03:33.004472 systemd[1]: session-2.scope: Deactivated successfully. Aug 13 00:03:33.005176 systemd-logind[1303]: Removed session 2. Aug 13 00:03:33.040821 sshd[1415]: Accepted publickey for core from 10.0.0.1 port 41762 ssh2: RSA SHA256:4jnu15cGk13pD8KfkQFNgDiqBqiu/IV3MiTKKCAhqJg Aug 13 00:03:33.042120 sshd[1415]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:33.045560 systemd-logind[1303]: New session 3 of user core. Aug 13 00:03:33.046383 systemd[1]: Started session-3.scope. Aug 13 00:03:33.097890 sshd[1415]: pam_unix(sshd:session): session closed for user core Aug 13 00:03:33.101513 systemd[1]: Started sshd@3-10.0.0.81:22-10.0.0.1:41776.service. Aug 13 00:03:33.105175 systemd[1]: sshd@2-10.0.0.81:22-10.0.0.1:41762.service: Deactivated successfully. Aug 13 00:03:33.106315 systemd[1]: session-3.scope: Deactivated successfully. Aug 13 00:03:33.106319 systemd-logind[1303]: Session 3 logged out. Waiting for processes to exit. Aug 13 00:03:33.107879 systemd-logind[1303]: Removed session 3. Aug 13 00:03:33.142100 sshd[1422]: Accepted publickey for core from 10.0.0.1 port 41776 ssh2: RSA SHA256:4jnu15cGk13pD8KfkQFNgDiqBqiu/IV3MiTKKCAhqJg Aug 13 00:03:33.143879 sshd[1422]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:33.147943 systemd-logind[1303]: New session 4 of user core. Aug 13 00:03:33.148371 systemd[1]: Started session-4.scope. Aug 13 00:03:33.204755 sshd[1422]: pam_unix(sshd:session): session closed for user core Aug 13 00:03:33.207075 systemd[1]: Started sshd@4-10.0.0.81:22-10.0.0.1:41792.service. Aug 13 00:03:33.207816 systemd-logind[1303]: Session 4 logged out. Waiting for processes to exit. Aug 13 00:03:33.208012 systemd[1]: sshd@3-10.0.0.81:22-10.0.0.1:41776.service: Deactivated successfully. Aug 13 00:03:33.208799 systemd[1]: session-4.scope: Deactivated successfully. Aug 13 00:03:33.209220 systemd-logind[1303]: Removed session 4. Aug 13 00:03:33.247892 sshd[1429]: Accepted publickey for core from 10.0.0.1 port 41792 ssh2: RSA SHA256:4jnu15cGk13pD8KfkQFNgDiqBqiu/IV3MiTKKCAhqJg Aug 13 00:03:33.249644 sshd[1429]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 13 00:03:33.253245 systemd-logind[1303]: New session 5 of user core. Aug 13 00:03:33.254158 systemd[1]: Started session-5.scope. Aug 13 00:03:33.317652 sudo[1435]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 13 00:03:33.317882 sudo[1435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 13 00:03:33.332628 systemd[1]: Starting coreos-metadata.service... Aug 13 00:03:33.339793 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 13 00:03:33.340027 systemd[1]: Finished coreos-metadata.service. Aug 13 00:03:33.856409 systemd[1]: Stopped kubelet.service. Aug 13 00:03:33.860396 systemd[1]: Starting kubelet.service... Aug 13 00:03:33.898207 systemd[1]: Reloading. Aug 13 00:03:33.959361 /usr/lib/systemd/system-generators/torcx-generator[1498]: time="2025-08-13T00:03:33Z" 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.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Aug 13 00:03:33.959735 /usr/lib/systemd/system-generators/torcx-generator[1498]: time="2025-08-13T00:03:33Z" level=info msg="torcx already run" Aug 13 00:03:34.072285 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Aug 13 00:03:34.072491 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Aug 13 00:03:34.091276 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. Aug 13 00:03:34.169617 systemd[1]: Started kubelet.service. Aug 13 00:03:34.171355 systemd[1]: Stopping kubelet.service... Aug 13 00:03:34.171840 systemd[1]: kubelet.service: Deactivated successfully. Aug 13 00:03:34.172177 systemd[1]: Stopped kubelet.service. Aug 13 00:03:34.174282 systemd[1]: Starting kubelet.service... Aug 13 00:03:34.286041 systemd[1]: Started kubelet.service. Aug 13 00:03:34.325243 kubelet[1558]: 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. Aug 13 00:03:34.325243 kubelet[1558]: 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. Aug 13 00:03:34.325243 kubelet[1558]: 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. Aug 13 00:03:34.325691 kubelet[1558]: I0813 00:03:34.325286 1558 server.go:211] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Aug 13 00:03:35.413142 kubelet[1558]: I0813 00:03:35.413087 1558 server.go:491] "Kubelet version" kubeletVersion="v1.31.8" Aug 13 00:03:35.413142 kubelet[1558]: I0813 00:03:35.413124 1558 server.go:493] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 13 00:03:35.413520 kubelet[1558]: I0813 00:03:35.413382 1558 server.go:934] "Client rotation is on, will bootstrap in background" Aug 13 00:03:35.475595 kubelet[1558]: I0813 00:03:35.475554 1558 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 13 00:03:35.487391 kubelet[1558]: E0813 00:03:35.487342 1558 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Aug 13 00:03:35.487391 kubelet[1558]: I0813 00:03:35.487389 1558 server.go:1408] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Aug 13 00:03:35.497794 kubelet[1558]: I0813 00:03:35.497761 1558 server.go:749] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 13 00:03:35.498248 kubelet[1558]: I0813 00:03:35.498225 1558 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority" Aug 13 00:03:35.498377 kubelet[1558]: I0813 00:03:35.498334 1558 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 13 00:03:35.498550 kubelet[1558]: I0813 00:03:35.498379 1558 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.81","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,"CgroupVersion":1} Aug 13 00:03:35.498630 kubelet[1558]: I0813 00:03:35.498552 1558 topology_manager.go:138] "Creating topology manager with none policy" Aug 13 00:03:35.498630 kubelet[1558]: I0813 00:03:35.498561 1558 container_manager_linux.go:300] "Creating device plugin manager" Aug 13 00:03:35.498829 kubelet[1558]: I0813 00:03:35.498807 1558 state_mem.go:36] "Initialized new in-memory state store" Aug 13 00:03:35.501898 kubelet[1558]: I0813 00:03:35.501867 1558 kubelet.go:408] "Attempting to sync node with API server" Aug 13 00:03:35.501936 kubelet[1558]: I0813 00:03:35.501903 1558 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 13 00:03:35.501936 kubelet[1558]: I0813 00:03:35.501926 1558 kubelet.go:314] "Adding apiserver pod source" Aug 13 00:03:35.501976 kubelet[1558]: I0813 00:03:35.501940 1558 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 13 00:03:35.502179 kubelet[1558]: E0813 00:03:35.502152 1558 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:35.502282 kubelet[1558]: E0813 00:03:35.502269 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:35.509036 kubelet[1558]: I0813 00:03:35.508992 1558 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="1.6.16" apiVersion="v1" Aug 13 00:03:35.509962 kubelet[1558]: I0813 00:03:35.509919 1558 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Aug 13 00:03:35.510147 kubelet[1558]: W0813 00:03:35.510133 1558 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 13 00:03:35.511209 kubelet[1558]: I0813 00:03:35.511174 1558 server.go:1274] "Started kubelet" Aug 13 00:03:35.530887 kubelet[1558]: I0813 00:03:35.530579 1558 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Aug 13 00:03:35.531114 kubelet[1558]: I0813 00:03:35.531025 1558 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 13 00:03:35.531262 kubelet[1558]: I0813 00:03:35.531235 1558 server.go:163] "Starting to listen" address="0.0.0.0" port=10250 Aug 13 00:03:35.532931 kubelet[1558]: I0813 00:03:35.532900 1558 server.go:449] "Adding debug handlers to kubelet server" Aug 13 00:03:35.537070 kernel: SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). Aug 13 00:03:35.537202 kubelet[1558]: I0813 00:03:35.537179 1558 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 13 00:03:35.538002 kubelet[1558]: I0813 00:03:35.537962 1558 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Aug 13 00:03:35.538157 kubelet[1558]: I0813 00:03:35.538138 1558 volume_manager.go:289] "Starting Kubelet Volume Manager" Aug 13 00:03:35.538370 kubelet[1558]: E0813 00:03:35.538340 1558 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.81\" not found" Aug 13 00:03:35.538862 kubelet[1558]: I0813 00:03:35.538830 1558 desired_state_of_world_populator.go:147] "Desired state populator starts to run" Aug 13 00:03:35.538918 kubelet[1558]: I0813 00:03:35.538906 1558 reconciler.go:26] "Reconciler: start to sync state" Aug 13 00:03:35.549298 kubelet[1558]: E0813 00:03:35.549263 1558 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.81\" not found" node="10.0.0.81" Aug 13 00:03:35.549805 kubelet[1558]: I0813 00:03:35.549462 1558 factory.go:221] Registration of the systemd container factory successfully Aug 13 00:03:35.549805 kubelet[1558]: I0813 00:03:35.549585 1558 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 Aug 13 00:03:35.550227 kubelet[1558]: E0813 00:03:35.550197 1558 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 13 00:03:35.551342 kubelet[1558]: I0813 00:03:35.551197 1558 factory.go:221] Registration of the containerd container factory successfully Aug 13 00:03:35.568494 kubelet[1558]: I0813 00:03:35.568462 1558 cpu_manager.go:214] "Starting CPU manager" policy="none" Aug 13 00:03:35.568494 kubelet[1558]: I0813 00:03:35.568486 1558 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Aug 13 00:03:35.568494 kubelet[1558]: I0813 00:03:35.568506 1558 state_mem.go:36] "Initialized new in-memory state store" Aug 13 00:03:35.637723 kubelet[1558]: I0813 00:03:35.637686 1558 policy_none.go:49] "None policy: Start" Aug 13 00:03:35.638450 kubelet[1558]: E0813 00:03:35.638422 1558 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.81\" not found" Aug 13 00:03:35.638525 kubelet[1558]: I0813 00:03:35.638506 1558 memory_manager.go:170] "Starting memorymanager" policy="None" Aug 13 00:03:35.638551 kubelet[1558]: I0813 00:03:35.638526 1558 state_mem.go:35] "Initializing new in-memory state store" Aug 13 00:03:35.643029 kubelet[1558]: I0813 00:03:35.642972 1558 manager.go:513] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 13 00:03:35.643146 kubelet[1558]: I0813 00:03:35.643128 1558 eviction_manager.go:189] "Eviction manager: starting control loop" Aug 13 00:03:35.643179 kubelet[1558]: I0813 00:03:35.643145 1558 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Aug 13 00:03:35.645132 kubelet[1558]: I0813 00:03:35.645098 1558 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 13 00:03:35.646328 kubelet[1558]: E0813 00:03:35.646304 1558 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.81\" not found" Aug 13 00:03:35.688476 kubelet[1558]: I0813 00:03:35.688369 1558 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 13 00:03:35.689275 kubelet[1558]: I0813 00:03:35.689256 1558 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 13 00:03:35.689275 kubelet[1558]: I0813 00:03:35.689277 1558 status_manager.go:217] "Starting to sync pod status with apiserver" Aug 13 00:03:35.689275 kubelet[1558]: I0813 00:03:35.689298 1558 kubelet.go:2321] "Starting kubelet main sync loop" Aug 13 00:03:35.689416 kubelet[1558]: E0813 00:03:35.689341 1558 kubelet.go:2345] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Aug 13 00:03:35.746151 kubelet[1558]: I0813 00:03:35.746119 1558 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.81" Aug 13 00:03:35.753203 kubelet[1558]: I0813 00:03:35.753168 1558 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.81" Aug 13 00:03:35.763352 kubelet[1558]: I0813 00:03:35.763311 1558 kuberuntime_manager.go:1635] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 13 00:03:35.763684 env[1315]: time="2025-08-13T00:03:35.763623391Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 13 00:03:35.763956 kubelet[1558]: I0813 00:03:35.763861 1558 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 13 00:03:35.815493 sudo[1435]: pam_unix(sudo:session): session closed for user root Aug 13 00:03:35.818294 sshd[1429]: pam_unix(sshd:session): session closed for user core Aug 13 00:03:35.820506 systemd[1]: sshd@4-10.0.0.81:22-10.0.0.1:41792.service: Deactivated successfully. Aug 13 00:03:35.821426 systemd-logind[1303]: Session 5 logged out. Waiting for processes to exit. Aug 13 00:03:35.821478 systemd[1]: session-5.scope: Deactivated successfully. Aug 13 00:03:35.822468 systemd-logind[1303]: Removed session 5. Aug 13 00:03:36.416441 kubelet[1558]: I0813 00:03:36.416406 1558 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 13 00:03:36.417034 kubelet[1558]: W0813 00:03:36.417012 1558 reflector.go:484] 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 Aug 13 00:03:36.417312 kubelet[1558]: W0813 00:03:36.417060 1558 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver 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 Aug 13 00:03:36.417312 kubelet[1558]: W0813 00:03:36.417085 1558 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.Service 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 Aug 13 00:03:36.502770 kubelet[1558]: I0813 00:03:36.502682 1558 apiserver.go:52] "Watching apiserver" Aug 13 00:03:36.503128 kubelet[1558]: E0813 00:03:36.502965 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:36.540233 kubelet[1558]: I0813 00:03:36.540173 1558 desired_state_of_world_populator.go:155] "Finished populating initial desired state of world" Aug 13 00:03:36.543414 kubelet[1558]: I0813 00:03:36.543376 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/0dc0eed0-1896-4479-9898-aad62a37def4-run\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.543414 kubelet[1558]: I0813 00:03:36.543417 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/0dc0eed0-1896-4479-9898-aad62a37def4-cni\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.543506 kubelet[1558]: I0813 00:03:36.543438 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/fd799cc7-8d57-415f-847f-ce80e34e2981-kube-proxy\") pod \"kube-proxy-9n7qh\" (UID: \"fd799cc7-8d57-415f-847f-ce80e34e2981\") " pod="kube-system/kube-proxy-9n7qh" Aug 13 00:03:36.543506 kubelet[1558]: I0813 00:03:36.543455 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/fd799cc7-8d57-415f-847f-ce80e34e2981-xtables-lock\") pod \"kube-proxy-9n7qh\" (UID: \"fd799cc7-8d57-415f-847f-ce80e34e2981\") " pod="kube-system/kube-proxy-9n7qh" Aug 13 00:03:36.543506 kubelet[1558]: I0813 00:03:36.543469 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/fd799cc7-8d57-415f-847f-ce80e34e2981-lib-modules\") pod \"kube-proxy-9n7qh\" (UID: \"fd799cc7-8d57-415f-847f-ce80e34e2981\") " pod="kube-system/kube-proxy-9n7qh" Aug 13 00:03:36.543506 kubelet[1558]: I0813 00:03:36.543484 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-htdc8\" (UniqueName: \"kubernetes.io/projected/fd799cc7-8d57-415f-847f-ce80e34e2981-kube-api-access-htdc8\") pod \"kube-proxy-9n7qh\" (UID: \"fd799cc7-8d57-415f-847f-ce80e34e2981\") " pod="kube-system/kube-proxy-9n7qh" Aug 13 00:03:36.543506 kubelet[1558]: I0813 00:03:36.543499 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/0dc0eed0-1896-4479-9898-aad62a37def4-cni-plugin\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.543617 kubelet[1558]: I0813 00:03:36.543512 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/0dc0eed0-1896-4479-9898-aad62a37def4-flannel-cfg\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.543617 kubelet[1558]: I0813 00:03:36.543528 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/0dc0eed0-1896-4479-9898-aad62a37def4-xtables-lock\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.543617 kubelet[1558]: I0813 00:03:36.543542 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-qswtb\" (UniqueName: \"kubernetes.io/projected/0dc0eed0-1896-4479-9898-aad62a37def4-kube-api-access-qswtb\") pod \"kube-flannel-ds-49wfq\" (UID: \"0dc0eed0-1896-4479-9898-aad62a37def4\") " pod="kube-flannel/kube-flannel-ds-49wfq" Aug 13 00:03:36.655167 kubelet[1558]: I0813 00:03:36.655125 1558 swap_util.go:74] "error creating dir to test if tmpfs noswap is enabled. Assuming not supported" mount path="" error="stat /var/lib/kubelet/plugins/kubernetes.io/empty-dir: no such file or directory" Aug 13 00:03:36.812744 kubelet[1558]: E0813 00:03:36.812637 1558 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" Aug 13 00:03:36.813840 env[1315]: time="2025-08-13T00:03:36.813534309Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-9n7qh,Uid:fd799cc7-8d57-415f-847f-ce80e34e2981,Namespace:kube-system,Attempt:0,}" Aug 13 00:03:36.814513 kubelet[1558]: E0813 00:03:36.814492 1558 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" Aug 13 00:03:36.817127 env[1315]: time="2025-08-13T00:03:36.817085945Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-49wfq,Uid:0dc0eed0-1896-4479-9898-aad62a37def4,Namespace:kube-flannel,Attempt:0,}" Aug 13 00:03:37.417488 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1293846978.mount: Deactivated successfully. Aug 13 00:03:37.428616 env[1315]: time="2025-08-13T00:03:37.428563516Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.431390 env[1315]: time="2025-08-13T00:03:37.431341225Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.432611 env[1315]: time="2025-08-13T00:03:37.432534848Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.434367 env[1315]: time="2025-08-13T00:03:37.434317305Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.436034 env[1315]: time="2025-08-13T00:03:37.435984562Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.437545 env[1315]: time="2025-08-13T00:03:37.437517987Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.440055 env[1315]: time="2025-08-13T00:03:37.440018793Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.441175 env[1315]: time="2025-08-13T00:03:37.441131604Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:37.475668 env[1315]: time="2025-08-13T00:03:37.475597558Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:03:37.475801 env[1315]: time="2025-08-13T00:03:37.475686007Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:03:37.475801 env[1315]: time="2025-08-13T00:03:37.475714677Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:03:37.476147 env[1315]: time="2025-08-13T00:03:37.476078950Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:03:37.476147 env[1315]: time="2025-08-13T00:03:37.476113498Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:03:37.476147 env[1315]: time="2025-08-13T00:03:37.476124454Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:03:37.476311 env[1315]: time="2025-08-13T00:03:37.476261766Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6 pid=1619 runtime=io.containerd.runc.v2 Aug 13 00:03:37.476391 env[1315]: time="2025-08-13T00:03:37.476328023Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/f082538253b802421e572607afcc5f57f6821638c36af870d297158a36b4aba3 pid=1624 runtime=io.containerd.runc.v2 Aug 13 00:03:37.504034 kubelet[1558]: E0813 00:03:37.503996 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:37.558675 env[1315]: time="2025-08-13T00:03:37.558615385Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-9n7qh,Uid:fd799cc7-8d57-415f-847f-ce80e34e2981,Namespace:kube-system,Attempt:0,} returns sandbox id \"f082538253b802421e572607afcc5f57f6821638c36af870d297158a36b4aba3\"" Aug 13 00:03:37.559835 kubelet[1558]: E0813 00:03:37.559804 1558 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" Aug 13 00:03:37.561415 env[1315]: time="2025-08-13T00:03:37.561358266Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\"" Aug 13 00:03:37.571292 env[1315]: time="2025-08-13T00:03:37.571236854Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-49wfq,Uid:0dc0eed0-1896-4479-9898-aad62a37def4,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\"" Aug 13 00:03:37.571922 kubelet[1558]: E0813 00:03:37.571890 1558 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" Aug 13 00:03:38.504647 kubelet[1558]: E0813 00:03:38.504599 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:38.614634 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2133453810.mount: Deactivated successfully. Aug 13 00:03:39.065524 env[1315]: time="2025-08-13T00:03:39.065468745Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy:v1.31.11,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:39.066765 env[1315]: time="2025-08-13T00:03:39.066740794Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:39.068049 env[1315]: time="2025-08-13T00:03:39.068015523Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/kube-proxy:v1.31.11,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:39.069121 env[1315]: time="2025-08-13T00:03:39.069092832Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy@sha256:a31da847792c5e7e92e91b78da1ad21d693e4b2b48d0e9f4610c8764dc2a5d79,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:39.069625 env[1315]: time="2025-08-13T00:03:39.069599076Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.11\" returns image reference \"sha256:7d1e7db6660181423f98acbe3a495b3fe5cec9b85cdef245540cc2cb3b180ab0\"" Aug 13 00:03:39.070703 env[1315]: time="2025-08-13T00:03:39.070675666Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 13 00:03:39.071900 env[1315]: time="2025-08-13T00:03:39.071866660Z" level=info msg="CreateContainer within sandbox \"f082538253b802421e572607afcc5f57f6821638c36af870d297158a36b4aba3\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 13 00:03:39.085522 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1213816230.mount: Deactivated successfully. Aug 13 00:03:39.089695 env[1315]: time="2025-08-13T00:03:39.089654516Z" level=info msg="CreateContainer within sandbox \"f082538253b802421e572607afcc5f57f6821638c36af870d297158a36b4aba3\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"f34734f2089d6a1ac20df661adce0c5dd9f8c27225634f9313c98c2a1ebc57ff\"" Aug 13 00:03:39.090720 env[1315]: time="2025-08-13T00:03:39.090695316Z" level=info msg="StartContainer for \"f34734f2089d6a1ac20df661adce0c5dd9f8c27225634f9313c98c2a1ebc57ff\"" Aug 13 00:03:39.154448 env[1315]: time="2025-08-13T00:03:39.154396550Z" level=info msg="StartContainer for \"f34734f2089d6a1ac20df661adce0c5dd9f8c27225634f9313c98c2a1ebc57ff\" returns successfully" Aug 13 00:03:39.505059 kubelet[1558]: E0813 00:03:39.504955 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:39.699457 kubelet[1558]: E0813 00:03:39.699380 1558 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" Aug 13 00:03:39.708167 kubelet[1558]: I0813 00:03:39.708087 1558 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-9n7qh" podStartSLOduration=3.198443084 podStartE2EDuration="4.708070008s" podCreationTimestamp="2025-08-13 00:03:35 +0000 UTC" firstStartedPulling="2025-08-13 00:03:37.560895988 +0000 UTC m=+3.270418497" lastFinishedPulling="2025-08-13 00:03:39.070522912 +0000 UTC m=+4.780045421" observedRunningTime="2025-08-13 00:03:39.707548128 +0000 UTC m=+5.417070637" watchObservedRunningTime="2025-08-13 00:03:39.708070008 +0000 UTC m=+5.417592517" Aug 13 00:03:40.180277 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount647643417.mount: Deactivated successfully. Aug 13 00:03:40.219421 env[1315]: time="2025-08-13T00:03:40.219365125Z" 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:[],}" Aug 13 00:03:40.220810 env[1315]: time="2025-08-13T00:03:40.220779958Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:40.222320 env[1315]: time="2025-08-13T00:03:40.221952100Z" 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:[],}" Aug 13 00:03:40.223207 env[1315]: time="2025-08-13T00:03:40.223171149Z" 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:[],}" Aug 13 00:03:40.224444 env[1315]: time="2025-08-13T00:03:40.224399795Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Aug 13 00:03:40.226465 env[1315]: time="2025-08-13T00:03:40.226426892Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 13 00:03:40.237698 env[1315]: time="2025-08-13T00:03:40.237649780Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"a238aee00129d97f3ac7a5564dbb8b8090070c3a60d54f394d60b3b2667f2b13\"" Aug 13 00:03:40.238494 env[1315]: time="2025-08-13T00:03:40.238363374Z" level=info msg="StartContainer for \"a238aee00129d97f3ac7a5564dbb8b8090070c3a60d54f394d60b3b2667f2b13\"" Aug 13 00:03:40.292839 env[1315]: time="2025-08-13T00:03:40.292781665Z" level=info msg="StartContainer for \"a238aee00129d97f3ac7a5564dbb8b8090070c3a60d54f394d60b3b2667f2b13\" returns successfully" Aug 13 00:03:40.458200 env[1315]: time="2025-08-13T00:03:40.458090304Z" level=info msg="shim disconnected" id=a238aee00129d97f3ac7a5564dbb8b8090070c3a60d54f394d60b3b2667f2b13 Aug 13 00:03:40.458532 env[1315]: time="2025-08-13T00:03:40.458511503Z" level=warning msg="cleaning up after shim disconnected" id=a238aee00129d97f3ac7a5564dbb8b8090070c3a60d54f394d60b3b2667f2b13 namespace=k8s.io Aug 13 00:03:40.458611 env[1315]: time="2025-08-13T00:03:40.458597518Z" level=info msg="cleaning up dead shim" Aug 13 00:03:40.465612 env[1315]: time="2025-08-13T00:03:40.465575948Z" level=warning msg="cleanup warnings time=\"2025-08-13T00:03:40Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1901 runtime=io.containerd.runc.v2\n" Aug 13 00:03:40.505857 kubelet[1558]: E0813 00:03:40.505790 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:40.702186 kubelet[1558]: E0813 00:03:40.702140 1558 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" Aug 13 00:03:40.702186 kubelet[1558]: E0813 00:03:40.702148 1558 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" Aug 13 00:03:40.703164 env[1315]: time="2025-08-13T00:03:40.703130664Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 13 00:03:41.507001 kubelet[1558]: E0813 00:03:41.506947 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:42.083397 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4148810571.mount: Deactivated successfully. Aug 13 00:03:42.507454 kubelet[1558]: E0813 00:03:42.507325 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:42.814760 env[1315]: time="2025-08-13T00:03:42.814626812Z" 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:[],}" Aug 13 00:03:42.817151 env[1315]: time="2025-08-13T00:03:42.817115782Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:42.818849 env[1315]: time="2025-08-13T00:03:42.818820951Z" 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:[],}" Aug 13 00:03:42.821105 env[1315]: time="2025-08-13T00:03:42.821067502Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:42.821944 env[1315]: time="2025-08-13T00:03:42.821909649Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Aug 13 00:03:42.824718 env[1315]: time="2025-08-13T00:03:42.824678708Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 13 00:03:42.837721 env[1315]: time="2025-08-13T00:03:42.837669341Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad\"" Aug 13 00:03:42.838219 env[1315]: time="2025-08-13T00:03:42.838185490Z" level=info msg="StartContainer for \"a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad\"" Aug 13 00:03:42.897829 env[1315]: time="2025-08-13T00:03:42.897768131Z" level=info msg="StartContainer for \"a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad\" returns successfully" Aug 13 00:03:42.904815 kubelet[1558]: I0813 00:03:42.904766 1558 kubelet_node_status.go:488] "Fast updating node status as it just became ready" Aug 13 00:03:43.041583 env[1315]: time="2025-08-13T00:03:43.041533434Z" level=info msg="shim disconnected" id=a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad Aug 13 00:03:43.041583 env[1315]: time="2025-08-13T00:03:43.041586621Z" level=warning msg="cleaning up after shim disconnected" id=a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad namespace=k8s.io Aug 13 00:03:43.041836 env[1315]: time="2025-08-13T00:03:43.041597779Z" level=info msg="cleaning up dead shim" Aug 13 00:03:43.049334 env[1315]: time="2025-08-13T00:03:43.049272678Z" level=warning msg="cleanup warnings time=\"2025-08-13T00:03:43Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1956 runtime=io.containerd.runc.v2\n" Aug 13 00:03:43.083370 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-a90fcc0ac71b197ae576e094bebd6eaed53a64f8c09bb12b6a49087b408af5ad-rootfs.mount: Deactivated successfully. Aug 13 00:03:43.508522 kubelet[1558]: E0813 00:03:43.508383 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:43.709026 kubelet[1558]: E0813 00:03:43.708971 1558 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" Aug 13 00:03:43.710970 env[1315]: time="2025-08-13T00:03:43.710936377Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 13 00:03:43.722461 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount287886561.mount: Deactivated successfully. Aug 13 00:03:43.724693 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2250739386.mount: Deactivated successfully. Aug 13 00:03:43.728426 env[1315]: time="2025-08-13T00:03:43.728321972Z" level=info msg="CreateContainer within sandbox \"42ce4706f63f0503a227e8f919cf38265266172061ac88e8a028e341697d11a6\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"216d842f1f7aabad1823a2d7c49ce01d2747b08910af038779af8fb08483fcfd\"" Aug 13 00:03:43.729164 env[1315]: time="2025-08-13T00:03:43.729135819Z" level=info msg="StartContainer for \"216d842f1f7aabad1823a2d7c49ce01d2747b08910af038779af8fb08483fcfd\"" Aug 13 00:03:43.786804 env[1315]: time="2025-08-13T00:03:43.783109214Z" level=info msg="StartContainer for \"216d842f1f7aabad1823a2d7c49ce01d2747b08910af038779af8fb08483fcfd\" returns successfully" Aug 13 00:03:44.508974 kubelet[1558]: E0813 00:03:44.508898 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:44.711914 kubelet[1558]: E0813 00:03:44.711848 1558 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" Aug 13 00:03:44.878069 systemd-networkd[1098]: flannel.1: Link UP Aug 13 00:03:44.878079 systemd-networkd[1098]: flannel.1: Gained carrier Aug 13 00:03:45.509939 kubelet[1558]: E0813 00:03:45.509893 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:45.713775 kubelet[1558]: E0813 00:03:45.712901 1558 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" Aug 13 00:03:46.043487 systemd-networkd[1098]: flannel.1: Gained IPv6LL Aug 13 00:03:46.510792 kubelet[1558]: E0813 00:03:46.510675 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:46.556111 kubelet[1558]: I0813 00:03:46.556051 1558 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-49wfq" podStartSLOduration=6.305494326 podStartE2EDuration="11.556030533s" podCreationTimestamp="2025-08-13 00:03:35 +0000 UTC" firstStartedPulling="2025-08-13 00:03:37.572657037 +0000 UTC m=+3.282179546" lastFinishedPulling="2025-08-13 00:03:42.823193244 +0000 UTC m=+8.532715753" observedRunningTime="2025-08-13 00:03:44.729740254 +0000 UTC m=+10.439262723" watchObservedRunningTime="2025-08-13 00:03:46.556030533 +0000 UTC m=+12.265553002" Aug 13 00:03:46.711683 kubelet[1558]: I0813 00:03:46.711633 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-87k9j\" (UniqueName: \"kubernetes.io/projected/ff25fda0-d012-4eec-952a-747e387263df-kube-api-access-87k9j\") pod \"nginx-deployment-8587fbcb89-vbdgh\" (UID: \"ff25fda0-d012-4eec-952a-747e387263df\") " pod="default/nginx-deployment-8587fbcb89-vbdgh" Aug 13 00:03:46.860018 env[1315]: time="2025-08-13T00:03:46.859606549Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-vbdgh,Uid:ff25fda0-d012-4eec-952a-747e387263df,Namespace:default,Attempt:0,}" Aug 13 00:03:46.896652 systemd-networkd[1098]: cni0: Link UP Aug 13 00:03:46.896658 systemd-networkd[1098]: cni0: Gained carrier Aug 13 00:03:46.897444 systemd-networkd[1098]: cni0: Lost carrier Aug 13 00:03:46.902650 systemd-networkd[1098]: vethdb210b1d: Link UP Aug 13 00:03:46.904991 kernel: cni0: port 1(vethdb210b1d) entered blocking state Aug 13 00:03:46.905128 kernel: cni0: port 1(vethdb210b1d) entered disabled state Aug 13 00:03:46.905153 kernel: device vethdb210b1d entered promiscuous mode Aug 13 00:03:46.907691 kernel: cni0: port 1(vethdb210b1d) entered blocking state Aug 13 00:03:46.907774 kernel: cni0: port 1(vethdb210b1d) entered forwarding state Aug 13 00:03:46.908364 kernel: cni0: port 1(vethdb210b1d) entered disabled state Aug 13 00:03:46.920562 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): vethdb210b1d: link becomes ready Aug 13 00:03:46.920675 kernel: cni0: port 1(vethdb210b1d) entered blocking state Aug 13 00:03:46.920704 kernel: cni0: port 1(vethdb210b1d) entered forwarding state Aug 13 00:03:46.921116 systemd-networkd[1098]: vethdb210b1d: Gained carrier Aug 13 00:03:46.921405 systemd-networkd[1098]: cni0: Gained carrier Aug 13 00:03:46.922972 env[1315]: 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"} Aug 13 00:03:46.922972 env[1315]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:03:46.947107 env[1315]: {"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-08-13T00:03:46.947008144Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:03:46.947107 env[1315]: time="2025-08-13T00:03:46.947065533Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:03:46.947107 env[1315]: time="2025-08-13T00:03:46.947077371Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:03:46.947379 env[1315]: time="2025-08-13T00:03:46.947325482Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/88ba6775d2b44ab9b499cfe8459dc1986300ad3495158648f4f5c26ae375cac5 pid=2140 runtime=io.containerd.runc.v2 Aug 13 00:03:46.983823 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 00:03:47.001000 env[1315]: time="2025-08-13T00:03:47.000955758Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-vbdgh,Uid:ff25fda0-d012-4eec-952a-747e387263df,Namespace:default,Attempt:0,} returns sandbox id \"88ba6775d2b44ab9b499cfe8459dc1986300ad3495158648f4f5c26ae375cac5\"" Aug 13 00:03:47.002491 env[1315]: time="2025-08-13T00:03:47.002419285Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 00:03:47.511158 kubelet[1558]: E0813 00:03:47.511104 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:48.219478 systemd-networkd[1098]: cni0: Gained IPv6LL Aug 13 00:03:48.511622 kubelet[1558]: E0813 00:03:48.511293 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:48.923457 systemd-networkd[1098]: vethdb210b1d: Gained IPv6LL Aug 13 00:03:49.062909 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1997965966.mount: Deactivated successfully. Aug 13 00:03:49.512256 kubelet[1558]: E0813 00:03:49.512039 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:50.365176 env[1315]: time="2025-08-13T00:03:50.365096861Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:50.367373 env[1315]: time="2025-08-13T00:03:50.367328604Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:50.369248 env[1315]: time="2025-08-13T00:03:50.369212439Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:50.371748 env[1315]: time="2025-08-13T00:03:50.371710262Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:50.372426 env[1315]: time="2025-08-13T00:03:50.372400678Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 13 00:03:50.375071 env[1315]: time="2025-08-13T00:03:50.375034600Z" level=info msg="CreateContainer within sandbox \"88ba6775d2b44ab9b499cfe8459dc1986300ad3495158648f4f5c26ae375cac5\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 13 00:03:50.389277 env[1315]: time="2025-08-13T00:03:50.389222378Z" level=info msg="CreateContainer within sandbox \"88ba6775d2b44ab9b499cfe8459dc1986300ad3495158648f4f5c26ae375cac5\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"9e4242ba9a5926868328eb2af05998ebd6f2a48381a266ec66d08e2fbed86b25\"" Aug 13 00:03:50.390017 env[1315]: time="2025-08-13T00:03:50.389979023Z" level=info msg="StartContainer for \"9e4242ba9a5926868328eb2af05998ebd6f2a48381a266ec66d08e2fbed86b25\"" Aug 13 00:03:50.450006 env[1315]: time="2025-08-13T00:03:50.449954447Z" level=info msg="StartContainer for \"9e4242ba9a5926868328eb2af05998ebd6f2a48381a266ec66d08e2fbed86b25\" returns successfully" Aug 13 00:03:50.513151 kubelet[1558]: E0813 00:03:50.513068 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:51.513420 kubelet[1558]: E0813 00:03:51.513367 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:52.514158 kubelet[1558]: E0813 00:03:52.514113 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:53.307215 kubelet[1558]: I0813 00:03:53.307143 1558 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-vbdgh" podStartSLOduration=3.935501312 podStartE2EDuration="7.307124728s" podCreationTimestamp="2025-08-13 00:03:46 +0000 UTC" firstStartedPulling="2025-08-13 00:03:47.002144855 +0000 UTC m=+12.711667364" lastFinishedPulling="2025-08-13 00:03:50.373768311 +0000 UTC m=+16.083290780" observedRunningTime="2025-08-13 00:03:50.731383032 +0000 UTC m=+16.440905541" watchObservedRunningTime="2025-08-13 00:03:53.307124728 +0000 UTC m=+19.016647237" Aug 13 00:03:53.350921 kubelet[1558]: I0813 00:03:53.350821 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-ddlhv\" (UniqueName: \"kubernetes.io/projected/a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b-kube-api-access-ddlhv\") pod \"nfs-server-provisioner-0\" (UID: \"a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b\") " pod="default/nfs-server-provisioner-0" Aug 13 00:03:53.350921 kubelet[1558]: I0813 00:03:53.350869 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b-data\") pod \"nfs-server-provisioner-0\" (UID: \"a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b\") " pod="default/nfs-server-provisioner-0" Aug 13 00:03:53.514733 kubelet[1558]: E0813 00:03:53.514681 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:53.610835 env[1315]: time="2025-08-13T00:03:53.610725795Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b,Namespace:default,Attempt:0,}" Aug 13 00:03:53.650396 kernel: cni0: port 2(veth7ef05839) entered blocking state Aug 13 00:03:53.650507 kernel: cni0: port 2(veth7ef05839) entered disabled state Aug 13 00:03:53.651379 kernel: device veth7ef05839 entered promiscuous mode Aug 13 00:03:53.651543 systemd-networkd[1098]: veth7ef05839: Link UP Aug 13 00:03:53.663513 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Aug 13 00:03:53.663610 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth7ef05839: link becomes ready Aug 13 00:03:53.663635 kernel: cni0: port 2(veth7ef05839) entered blocking state Aug 13 00:03:53.664633 kernel: cni0: port 2(veth7ef05839) entered forwarding state Aug 13 00:03:53.665038 systemd-networkd[1098]: veth7ef05839: Gained carrier Aug 13 00:03:53.667522 env[1315]: 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)(0x40000a68e8), "name":"cbr0", "type":"bridge"} Aug 13 00:03:53.667522 env[1315]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:03:53.679872 env[1315]: {"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-08-13T00:03:53.679802601Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:03:53.679872 env[1315]: time="2025-08-13T00:03:53.679844955Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:03:53.679872 env[1315]: time="2025-08-13T00:03:53.679856434Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:03:53.680186 env[1315]: time="2025-08-13T00:03:53.680152757Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/46e56e26f4e32a7afabc92bc4d38319c97cd1227652db296de38841fe0c3e1e4 pid=2310 runtime=io.containerd.runc.v2 Aug 13 00:03:53.735570 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 00:03:53.755441 env[1315]: time="2025-08-13T00:03:53.755389077Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a9720dc7-7ec8-42a0-909d-ae8cac8c5d6b,Namespace:default,Attempt:0,} returns sandbox id \"46e56e26f4e32a7afabc92bc4d38319c97cd1227652db296de38841fe0c3e1e4\"" Aug 13 00:03:53.757212 env[1315]: time="2025-08-13T00:03:53.757180014Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 13 00:03:54.515077 kubelet[1558]: E0813 00:03:54.515006 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:54.939486 systemd-networkd[1098]: veth7ef05839: Gained IPv6LL Aug 13 00:03:55.502214 kubelet[1558]: E0813 00:03:55.502155 1558 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:55.515619 kubelet[1558]: E0813 00:03:55.515578 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:55.837638 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3271015685.mount: Deactivated successfully. Aug 13 00:03:56.516552 kubelet[1558]: E0813 00:03:56.516499 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:57.517162 kubelet[1558]: E0813 00:03:57.517114 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:57.782175 env[1315]: time="2025-08-13T00:03:57.782068345Z" 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:[],}" Aug 13 00:03:57.783714 env[1315]: time="2025-08-13T00:03:57.783680230Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:03:57.785527 env[1315]: time="2025-08-13T00:03:57.785498415Z" 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:[],}" Aug 13 00:03:57.787826 env[1315]: time="2025-08-13T00:03:57.787798794Z" 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:[],}" Aug 13 00:03:57.788553 env[1315]: time="2025-08-13T00:03:57.788518885Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Aug 13 00:03:57.792500 env[1315]: time="2025-08-13T00:03:57.792454467Z" level=info msg="CreateContainer within sandbox \"46e56e26f4e32a7afabc92bc4d38319c97cd1227652db296de38841fe0c3e1e4\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 13 00:03:57.803536 env[1315]: time="2025-08-13T00:03:57.803475048Z" level=info msg="CreateContainer within sandbox \"46e56e26f4e32a7afabc92bc4d38319c97cd1227652db296de38841fe0c3e1e4\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"f8ab40eda4bd6f9dc3ef2b1cb73ed2ec05540617adfb178e59fe499663421904\"" Aug 13 00:03:57.804038 env[1315]: time="2025-08-13T00:03:57.804008637Z" level=info msg="StartContainer for \"f8ab40eda4bd6f9dc3ef2b1cb73ed2ec05540617adfb178e59fe499663421904\"" Aug 13 00:03:57.896495 env[1315]: time="2025-08-13T00:03:57.896448713Z" level=info msg="StartContainer for \"f8ab40eda4bd6f9dc3ef2b1cb73ed2ec05540617adfb178e59fe499663421904\" returns successfully" Aug 13 00:03:58.518273 kubelet[1558]: E0813 00:03:58.518195 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:03:58.755113 kubelet[1558]: I0813 00:03:58.754998 1558 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.7221888060000001 podStartE2EDuration="5.75498153s" podCreationTimestamp="2025-08-13 00:03:53 +0000 UTC" firstStartedPulling="2025-08-13 00:03:53.756904328 +0000 UTC m=+19.466426797" lastFinishedPulling="2025-08-13 00:03:57.789697012 +0000 UTC m=+23.499219521" observedRunningTime="2025-08-13 00:03:58.754897538 +0000 UTC m=+24.464420047" watchObservedRunningTime="2025-08-13 00:03:58.75498153 +0000 UTC m=+24.464504039" Aug 13 00:03:59.518690 kubelet[1558]: E0813 00:03:59.518620 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:00.519500 kubelet[1558]: E0813 00:04:00.519395 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:01.520704 kubelet[1558]: E0813 00:04:01.520584 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:02.521704 kubelet[1558]: E0813 00:04:02.521638 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:03.521770 kubelet[1558]: E0813 00:04:03.521729 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:04.522730 kubelet[1558]: E0813 00:04:04.522668 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:05.523335 kubelet[1558]: E0813 00:04:05.523281 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:06.524268 kubelet[1558]: E0813 00:04:06.524227 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:07.525115 kubelet[1558]: E0813 00:04:07.525073 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:07.852323 kubelet[1558]: I0813 00:04:07.851882 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-zpzz6\" (UniqueName: \"kubernetes.io/projected/35b216c8-40b0-4d99-8a97-5aaac43eaf44-kube-api-access-zpzz6\") pod \"test-pod-1\" (UID: \"35b216c8-40b0-4d99-8a97-5aaac43eaf44\") " pod="default/test-pod-1" Aug 13 00:04:07.852323 kubelet[1558]: I0813 00:04:07.851933 1558 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-d7791b83-a98d-4bfd-b561-a6457c8ca0fa\" (UniqueName: \"kubernetes.io/nfs/35b216c8-40b0-4d99-8a97-5aaac43eaf44-pvc-d7791b83-a98d-4bfd-b561-a6457c8ca0fa\") pod \"test-pod-1\" (UID: \"35b216c8-40b0-4d99-8a97-5aaac43eaf44\") " pod="default/test-pod-1" Aug 13 00:04:07.976377 kernel: FS-Cache: Loaded Aug 13 00:04:08.005764 kernel: RPC: Registered named UNIX socket transport module. Aug 13 00:04:08.005887 kernel: RPC: Registered udp transport module. Aug 13 00:04:08.005957 kernel: RPC: Registered tcp transport module. Aug 13 00:04:08.006678 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 13 00:04:08.048384 kernel: FS-Cache: Netfs 'nfs' registered for caching Aug 13 00:04:08.198504 kernel: NFS: Registering the id_resolver key type Aug 13 00:04:08.198646 kernel: Key type id_resolver registered Aug 13 00:04:08.198667 kernel: Key type id_legacy registered Aug 13 00:04:08.228634 nfsidmap[2487]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 13 00:04:08.232026 nfsidmap[2490]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 13 00:04:08.417729 env[1315]: time="2025-08-13T00:04:08.417665336Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:35b216c8-40b0-4d99-8a97-5aaac43eaf44,Namespace:default,Attempt:0,}" Aug 13 00:04:08.435764 systemd-networkd[1098]: veth6d71e459: Link UP Aug 13 00:04:08.436733 kernel: cni0: port 3(veth6d71e459) entered blocking state Aug 13 00:04:08.436797 kernel: cni0: port 3(veth6d71e459) entered disabled state Aug 13 00:04:08.436826 kernel: device veth6d71e459 entered promiscuous mode Aug 13 00:04:08.444689 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Aug 13 00:04:08.444785 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth6d71e459: link becomes ready Aug 13 00:04:08.444807 kernel: cni0: port 3(veth6d71e459) entered blocking state Aug 13 00:04:08.444824 kernel: cni0: port 3(veth6d71e459) entered forwarding state Aug 13 00:04:08.445283 systemd-networkd[1098]: veth6d71e459: Gained carrier Aug 13 00:04:08.447854 env[1315]: 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"} Aug 13 00:04:08.447854 env[1315]: delegateAdd: netconf sent to delegate plugin: Aug 13 00:04:08.460495 env[1315]: {"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-08-13T00:04:08.460411197Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 13 00:04:08.460495 env[1315]: time="2025-08-13T00:04:08.460452475Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 13 00:04:08.460495 env[1315]: time="2025-08-13T00:04:08.460473194Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 13 00:04:08.460692 env[1315]: time="2025-08-13T00:04:08.460625067Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/0b79b50e8e4dc342edbdb9109e07476f859eb9eff848863caeca8ee9999ce510 pid=2541 runtime=io.containerd.runc.v2 Aug 13 00:04:08.493097 systemd-resolved[1235]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 13 00:04:08.510571 env[1315]: time="2025-08-13T00:04:08.510526069Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:35b216c8-40b0-4d99-8a97-5aaac43eaf44,Namespace:default,Attempt:0,} returns sandbox id \"0b79b50e8e4dc342edbdb9109e07476f859eb9eff848863caeca8ee9999ce510\"" Aug 13 00:04:08.512006 env[1315]: time="2025-08-13T00:04:08.511973840Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 13 00:04:08.525790 kubelet[1558]: E0813 00:04:08.525739 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:08.786593 env[1315]: time="2025-08-13T00:04:08.786181604Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:04:08.788827 env[1315]: time="2025-08-13T00:04:08.788793480Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:04:08.791001 env[1315]: time="2025-08-13T00:04:08.790960858Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:04:08.793979 env[1315]: time="2025-08-13T00:04:08.793926278Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx@sha256:a6969d434cb816d30787e9f7ab16b632e12dc05a2c8f4dae701d83ef2199c985,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Aug 13 00:04:08.794299 env[1315]: time="2025-08-13T00:04:08.794265942Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:07abd578947db789c018f907bed24fcc55d80455e9614b35a065bf3af4f3ac27\"" Aug 13 00:04:08.799343 env[1315]: time="2025-08-13T00:04:08.799297704Z" level=info msg="CreateContainer within sandbox \"0b79b50e8e4dc342edbdb9109e07476f859eb9eff848863caeca8ee9999ce510\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 13 00:04:08.814085 env[1315]: time="2025-08-13T00:04:08.814034088Z" level=info msg="CreateContainer within sandbox \"0b79b50e8e4dc342edbdb9109e07476f859eb9eff848863caeca8ee9999ce510\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"fbf93b5dea07aa8182209ea6f46ac8c31d9736e054b88f31e5957803b0a064f8\"" Aug 13 00:04:08.814823 env[1315]: time="2025-08-13T00:04:08.814795932Z" level=info msg="StartContainer for \"fbf93b5dea07aa8182209ea6f46ac8c31d9736e054b88f31e5957803b0a064f8\"" Aug 13 00:04:08.883706 env[1315]: time="2025-08-13T00:04:08.883667597Z" level=info msg="StartContainer for \"fbf93b5dea07aa8182209ea6f46ac8c31d9736e054b88f31e5957803b0a064f8\" returns successfully" Aug 13 00:04:09.526874 kubelet[1558]: E0813 00:04:09.526741 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:09.531495 systemd-networkd[1098]: veth6d71e459: Gained IPv6LL Aug 13 00:04:10.527579 kubelet[1558]: E0813 00:04:10.527527 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:11.528500 kubelet[1558]: E0813 00:04:11.528406 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:12.529372 kubelet[1558]: E0813 00:04:12.529320 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:12.974027 update_engine[1310]: I0813 00:04:12.973763 1310 update_attempter.cc:509] Updating boot flags... Aug 13 00:04:13.531902 kubelet[1558]: E0813 00:04:13.531847 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:14.532636 kubelet[1558]: E0813 00:04:14.532581 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:15.502974 kubelet[1558]: E0813 00:04:15.502923 1558 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 13 00:04:15.533993 kubelet[1558]: E0813 00:04:15.533898 1558 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"