Nov 1 00:09:05.695958 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Nov 1 00:09:05.695976 kernel: Linux version 5.15.192-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 Fri Oct 31 23:12:38 -00 2025 Nov 1 00:09:05.695984 kernel: efi: EFI v2.70 by EDK II Nov 1 00:09:05.695990 kernel: efi: SMBIOS 3.0=0xd9260000 ACPI 2.0=0xd9240000 MEMATTR=0xda32b018 RNG=0xd9220018 MEMRESERVE=0xd9521c18 Nov 1 00:09:05.695995 kernel: random: crng init done Nov 1 00:09:05.696001 kernel: ACPI: Early table checksum verification disabled Nov 1 00:09:05.696007 kernel: ACPI: RSDP 0x00000000D9240000 000024 (v02 BOCHS ) Nov 1 00:09:05.696014 kernel: ACPI: XSDT 0x00000000D9230000 000064 (v01 BOCHS BXPC 00000001 01000013) Nov 1 00:09:05.696019 kernel: ACPI: FACP 0x00000000D91E0000 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696024 kernel: ACPI: DSDT 0x00000000D91F0000 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696030 kernel: ACPI: APIC 0x00000000D91D0000 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696035 kernel: ACPI: PPTT 0x00000000D91C0000 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696040 kernel: ACPI: GTDT 0x00000000D91B0000 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696046 kernel: ACPI: MCFG 0x00000000D91A0000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696054 kernel: ACPI: SPCR 0x00000000D9190000 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696060 kernel: ACPI: DBG2 0x00000000D9180000 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696066 kernel: ACPI: IORT 0x00000000D9170000 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Nov 1 00:09:05.696071 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Nov 1 00:09:05.696077 kernel: NUMA: Failed to initialise from firmware Nov 1 00:09:05.696083 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Nov 1 00:09:05.696088 kernel: NUMA: NODE_DATA [mem 0xdcb0b900-0xdcb10fff] Nov 1 00:09:05.696094 kernel: Zone ranges: Nov 1 00:09:05.696099 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Nov 1 00:09:05.696106 kernel: DMA32 empty Nov 1 00:09:05.696112 kernel: Normal empty Nov 1 00:09:05.696117 kernel: Movable zone start for each node Nov 1 00:09:05.696122 kernel: Early memory node ranges Nov 1 00:09:05.696128 kernel: node 0: [mem 0x0000000040000000-0x00000000d924ffff] Nov 1 00:09:05.696134 kernel: node 0: [mem 0x00000000d9250000-0x00000000d951ffff] Nov 1 00:09:05.696139 kernel: node 0: [mem 0x00000000d9520000-0x00000000dc7fffff] Nov 1 00:09:05.696145 kernel: node 0: [mem 0x00000000dc800000-0x00000000dc88ffff] Nov 1 00:09:05.696151 kernel: node 0: [mem 0x00000000dc890000-0x00000000dc89ffff] Nov 1 00:09:05.696156 kernel: node 0: [mem 0x00000000dc8a0000-0x00000000dc9bffff] Nov 1 00:09:05.696162 kernel: node 0: [mem 0x00000000dc9c0000-0x00000000dcffffff] Nov 1 00:09:05.696167 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Nov 1 00:09:05.696174 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Nov 1 00:09:05.696179 kernel: psci: probing for conduit method from ACPI. Nov 1 00:09:05.696185 kernel: psci: PSCIv1.1 detected in firmware. Nov 1 00:09:05.696190 kernel: psci: Using standard PSCI v0.2 function IDs Nov 1 00:09:05.696196 kernel: psci: Trusted OS migration not required Nov 1 00:09:05.696204 kernel: psci: SMC Calling Convention v1.1 Nov 1 00:09:05.696210 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Nov 1 00:09:05.696218 kernel: ACPI: SRAT not present Nov 1 00:09:05.696224 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Nov 1 00:09:05.696230 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Nov 1 00:09:05.696236 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Nov 1 00:09:05.696242 kernel: Detected PIPT I-cache on CPU0 Nov 1 00:09:05.696248 kernel: CPU features: detected: GIC system register CPU interface Nov 1 00:09:05.696254 kernel: CPU features: detected: Hardware dirty bit management Nov 1 00:09:05.696260 kernel: CPU features: detected: Spectre-v4 Nov 1 00:09:05.696266 kernel: CPU features: detected: Spectre-BHB Nov 1 00:09:05.696273 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 1 00:09:05.696279 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 1 00:09:05.696285 kernel: CPU features: detected: ARM erratum 1418040 Nov 1 00:09:05.696291 kernel: CPU features: detected: SSBS not fully self-synchronizing Nov 1 00:09:05.696297 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Nov 1 00:09:05.696302 kernel: Policy zone: DMA Nov 1 00:09:05.696315 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=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:09:05.696322 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 1 00:09:05.696328 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 1 00:09:05.696334 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 1 00:09:05.696340 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 1 00:09:05.696348 kernel: Memory: 2457340K/2572288K available (9792K kernel code, 2094K rwdata, 7592K rodata, 36416K init, 777K bss, 114948K reserved, 0K cma-reserved) Nov 1 00:09:05.696354 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Nov 1 00:09:05.696360 kernel: trace event string verifier disabled Nov 1 00:09:05.696365 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 1 00:09:05.696372 kernel: rcu: RCU event tracing is enabled. Nov 1 00:09:05.696378 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Nov 1 00:09:05.696384 kernel: Trampoline variant of Tasks RCU enabled. Nov 1 00:09:05.696390 kernel: Tracing variant of Tasks RCU enabled. Nov 1 00:09:05.696396 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 1 00:09:05.696402 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Nov 1 00:09:05.696408 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 1 00:09:05.696415 kernel: GICv3: 256 SPIs implemented Nov 1 00:09:05.696421 kernel: GICv3: 0 Extended SPIs implemented Nov 1 00:09:05.696433 kernel: GICv3: Distributor has no Range Selector support Nov 1 00:09:05.696440 kernel: Root IRQ handler: gic_handle_irq Nov 1 00:09:05.696446 kernel: GICv3: 16 PPIs implemented Nov 1 00:09:05.696452 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Nov 1 00:09:05.696458 kernel: ACPI: SRAT not present Nov 1 00:09:05.696464 kernel: ITS [mem 0x08080000-0x0809ffff] Nov 1 00:09:05.696471 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400b0000 (indirect, esz 8, psz 64K, shr 1) Nov 1 00:09:05.696477 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400c0000 (flat, esz 8, psz 64K, shr 1) Nov 1 00:09:05.696483 kernel: GICv3: using LPI property table @0x00000000400d0000 Nov 1 00:09:05.696489 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000000400e0000 Nov 1 00:09:05.696496 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:09:05.696502 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Nov 1 00:09:05.696509 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Nov 1 00:09:05.696515 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Nov 1 00:09:05.696521 kernel: arm-pv: using stolen time PV Nov 1 00:09:05.696527 kernel: Console: colour dummy device 80x25 Nov 1 00:09:05.696533 kernel: ACPI: Core revision 20210730 Nov 1 00:09:05.696540 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Nov 1 00:09:05.696546 kernel: pid_max: default: 32768 minimum: 301 Nov 1 00:09:05.696552 kernel: LSM: Security Framework initializing Nov 1 00:09:05.696559 kernel: SELinux: Initializing. Nov 1 00:09:05.696566 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:09:05.696572 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:09:05.696578 kernel: rcu: Hierarchical SRCU implementation. Nov 1 00:09:05.696584 kernel: Platform MSI: ITS@0x8080000 domain created Nov 1 00:09:05.696590 kernel: PCI/MSI: ITS@0x8080000 domain created Nov 1 00:09:05.696596 kernel: Remapping and enabling EFI services. Nov 1 00:09:05.696602 kernel: smp: Bringing up secondary CPUs ... Nov 1 00:09:05.696608 kernel: Detected PIPT I-cache on CPU1 Nov 1 00:09:05.696616 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Nov 1 00:09:05.696622 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000000400f0000 Nov 1 00:09:05.696628 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:09:05.696634 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Nov 1 00:09:05.696640 kernel: Detected PIPT I-cache on CPU2 Nov 1 00:09:05.696647 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Nov 1 00:09:05.696653 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040100000 Nov 1 00:09:05.696660 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:09:05.696666 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Nov 1 00:09:05.696672 kernel: Detected PIPT I-cache on CPU3 Nov 1 00:09:05.696680 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Nov 1 00:09:05.696686 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040110000 Nov 1 00:09:05.696692 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Nov 1 00:09:05.696698 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Nov 1 00:09:05.696709 kernel: smp: Brought up 1 node, 4 CPUs Nov 1 00:09:05.696716 kernel: SMP: Total of 4 processors activated. Nov 1 00:09:05.696723 kernel: CPU features: detected: 32-bit EL0 Support Nov 1 00:09:05.696729 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Nov 1 00:09:05.696736 kernel: CPU features: detected: Common not Private translations Nov 1 00:09:05.696742 kernel: CPU features: detected: CRC32 instructions Nov 1 00:09:05.696749 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Nov 1 00:09:05.696755 kernel: CPU features: detected: LSE atomic instructions Nov 1 00:09:05.696763 kernel: CPU features: detected: Privileged Access Never Nov 1 00:09:05.696770 kernel: CPU features: detected: RAS Extension Support Nov 1 00:09:05.696776 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Nov 1 00:09:05.696783 kernel: CPU: All CPU(s) started at EL1 Nov 1 00:09:05.696789 kernel: alternatives: patching kernel code Nov 1 00:09:05.696797 kernel: devtmpfs: initialized Nov 1 00:09:05.696803 kernel: KASLR enabled Nov 1 00:09:05.696810 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 1 00:09:05.696817 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Nov 1 00:09:05.696823 kernel: pinctrl core: initialized pinctrl subsystem Nov 1 00:09:05.696829 kernel: SMBIOS 3.0.0 present. Nov 1 00:09:05.696836 kernel: DMI: QEMU KVM Virtual Machine, BIOS 0.0.0 02/06/2015 Nov 1 00:09:05.696842 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 1 00:09:05.696849 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 1 00:09:05.696857 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 1 00:09:05.696864 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 1 00:09:05.696870 kernel: audit: initializing netlink subsys (disabled) Nov 1 00:09:05.696877 kernel: audit: type=2000 audit(0.033:1): state=initialized audit_enabled=0 res=1 Nov 1 00:09:05.696883 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 1 00:09:05.696890 kernel: cpuidle: using governor menu Nov 1 00:09:05.696896 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 1 00:09:05.696903 kernel: ASID allocator initialised with 32768 entries Nov 1 00:09:05.696909 kernel: ACPI: bus type PCI registered Nov 1 00:09:05.696917 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 1 00:09:05.696923 kernel: Serial: AMBA PL011 UART driver Nov 1 00:09:05.696930 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 1 00:09:05.696936 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 1 00:09:05.696943 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 1 00:09:05.696950 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 1 00:09:05.696956 kernel: cryptd: max_cpu_qlen set to 1000 Nov 1 00:09:05.696963 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 1 00:09:05.696969 kernel: ACPI: Added _OSI(Module Device) Nov 1 00:09:05.696977 kernel: ACPI: Added _OSI(Processor Device) Nov 1 00:09:05.696983 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 1 00:09:05.696990 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 1 00:09:05.696996 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 1 00:09:05.697003 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 1 00:09:05.697009 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 1 00:09:05.697015 kernel: ACPI: Interpreter enabled Nov 1 00:09:05.697022 kernel: ACPI: Using GIC for interrupt routing Nov 1 00:09:05.697028 kernel: ACPI: MCFG table detected, 1 entries Nov 1 00:09:05.697036 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Nov 1 00:09:05.697042 kernel: printk: console [ttyAMA0] enabled Nov 1 00:09:05.697049 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Nov 1 00:09:05.697165 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 1 00:09:05.697230 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 1 00:09:05.697288 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 1 00:09:05.697354 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Nov 1 00:09:05.697416 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Nov 1 00:09:05.697425 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Nov 1 00:09:05.697439 kernel: PCI host bridge to bus 0000:00 Nov 1 00:09:05.697509 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Nov 1 00:09:05.697565 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 1 00:09:05.697618 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Nov 1 00:09:05.697671 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Nov 1 00:09:05.697744 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Nov 1 00:09:05.697840 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Nov 1 00:09:05.697909 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Nov 1 00:09:05.697978 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Nov 1 00:09:05.698090 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Nov 1 00:09:05.698155 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Nov 1 00:09:05.698215 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Nov 1 00:09:05.698328 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Nov 1 00:09:05.698396 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Nov 1 00:09:05.698471 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 1 00:09:05.698534 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Nov 1 00:09:05.698543 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 1 00:09:05.698550 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 1 00:09:05.698556 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 1 00:09:05.698565 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 1 00:09:05.698572 kernel: iommu: Default domain type: Translated Nov 1 00:09:05.698579 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 1 00:09:05.698586 kernel: vgaarb: loaded Nov 1 00:09:05.698592 kernel: pps_core: LinuxPPS API ver. 1 registered Nov 1 00:09:05.698599 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 1 00:09:05.698606 kernel: PTP clock support registered Nov 1 00:09:05.698612 kernel: Registered efivars operations Nov 1 00:09:05.698619 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 1 00:09:05.698625 kernel: VFS: Disk quotas dquot_6.6.0 Nov 1 00:09:05.698633 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 1 00:09:05.698640 kernel: pnp: PnP ACPI init Nov 1 00:09:05.698704 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Nov 1 00:09:05.698714 kernel: pnp: PnP ACPI: found 1 devices Nov 1 00:09:05.698720 kernel: NET: Registered PF_INET protocol family Nov 1 00:09:05.698727 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 1 00:09:05.698734 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 1 00:09:05.698741 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 1 00:09:05.698749 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 1 00:09:05.698755 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 1 00:09:05.698762 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 1 00:09:05.698769 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:09:05.698775 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:09:05.698782 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 1 00:09:05.698789 kernel: PCI: CLS 0 bytes, default 64 Nov 1 00:09:05.698795 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Nov 1 00:09:05.698802 kernel: kvm [1]: HYP mode not available Nov 1 00:09:05.698810 kernel: Initialise system trusted keyrings Nov 1 00:09:05.698816 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 1 00:09:05.698823 kernel: Key type asymmetric registered Nov 1 00:09:05.698829 kernel: Asymmetric key parser 'x509' registered Nov 1 00:09:05.698836 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Nov 1 00:09:05.698842 kernel: io scheduler mq-deadline registered Nov 1 00:09:05.698849 kernel: io scheduler kyber registered Nov 1 00:09:05.698855 kernel: io scheduler bfq registered Nov 1 00:09:05.698862 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 1 00:09:05.698869 kernel: ACPI: button: Power Button [PWRB] Nov 1 00:09:05.698876 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 1 00:09:05.698936 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Nov 1 00:09:05.698945 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 1 00:09:05.698952 kernel: thunder_xcv, ver 1.0 Nov 1 00:09:05.698958 kernel: thunder_bgx, ver 1.0 Nov 1 00:09:05.698965 kernel: nicpf, ver 1.0 Nov 1 00:09:05.698971 kernel: nicvf, ver 1.0 Nov 1 00:09:05.699042 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 1 00:09:05.699100 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-01T00:09:05 UTC (1761955745) Nov 1 00:09:05.699109 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 1 00:09:05.699115 kernel: NET: Registered PF_INET6 protocol family Nov 1 00:09:05.699122 kernel: Segment Routing with IPv6 Nov 1 00:09:05.699128 kernel: In-situ OAM (IOAM) with IPv6 Nov 1 00:09:05.699135 kernel: NET: Registered PF_PACKET protocol family Nov 1 00:09:05.699141 kernel: Key type dns_resolver registered Nov 1 00:09:05.699148 kernel: registered taskstats version 1 Nov 1 00:09:05.699156 kernel: Loading compiled-in X.509 certificates Nov 1 00:09:05.699162 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.192-flatcar: 4aa5071b9a6f96878595e36d4bd5862a671c915d' Nov 1 00:09:05.699169 kernel: Key type .fscrypt registered Nov 1 00:09:05.699176 kernel: Key type fscrypt-provisioning registered Nov 1 00:09:05.699182 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 1 00:09:05.699189 kernel: ima: Allocated hash algorithm: sha1 Nov 1 00:09:05.699196 kernel: ima: No architecture policies found Nov 1 00:09:05.699202 kernel: clk: Disabling unused clocks Nov 1 00:09:05.699209 kernel: Freeing unused kernel memory: 36416K Nov 1 00:09:05.699216 kernel: Run /init as init process Nov 1 00:09:05.699223 kernel: with arguments: Nov 1 00:09:05.699229 kernel: /init Nov 1 00:09:05.699235 kernel: with environment: Nov 1 00:09:05.699242 kernel: HOME=/ Nov 1 00:09:05.699248 kernel: TERM=linux Nov 1 00:09:05.699254 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 1 00:09:05.699263 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) Nov 1 00:09:05.699273 systemd[1]: Detected virtualization kvm. Nov 1 00:09:05.699280 systemd[1]: Detected architecture arm64. Nov 1 00:09:05.699287 systemd[1]: Running in initrd. Nov 1 00:09:05.699294 systemd[1]: No hostname configured, using default hostname. Nov 1 00:09:05.699300 systemd[1]: Hostname set to . Nov 1 00:09:05.699313 systemd[1]: Initializing machine ID from VM UUID. Nov 1 00:09:05.699322 systemd[1]: Queued start job for default target initrd.target. Nov 1 00:09:05.699329 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:09:05.699338 systemd[1]: Reached target cryptsetup.target. Nov 1 00:09:05.699345 systemd[1]: Reached target paths.target. Nov 1 00:09:05.699352 systemd[1]: Reached target slices.target. Nov 1 00:09:05.699359 systemd[1]: Reached target swap.target. Nov 1 00:09:05.699366 systemd[1]: Reached target timers.target. Nov 1 00:09:05.699373 systemd[1]: Listening on iscsid.socket. Nov 1 00:09:05.699380 systemd[1]: Listening on iscsiuio.socket. Nov 1 00:09:05.699388 systemd[1]: Listening on systemd-journald-audit.socket. Nov 1 00:09:05.699395 systemd[1]: Listening on systemd-journald-dev-log.socket. Nov 1 00:09:05.699402 systemd[1]: Listening on systemd-journald.socket. Nov 1 00:09:05.699409 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:09:05.699416 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:09:05.699423 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:09:05.699437 systemd[1]: Reached target sockets.target. Nov 1 00:09:05.699445 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:09:05.699452 systemd[1]: Finished network-cleanup.service. Nov 1 00:09:05.699460 systemd[1]: Starting systemd-fsck-usr.service... Nov 1 00:09:05.699467 systemd[1]: Starting systemd-journald.service... Nov 1 00:09:05.699474 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:09:05.699481 systemd[1]: Starting systemd-resolved.service... Nov 1 00:09:05.699488 systemd[1]: Starting systemd-vconsole-setup.service... Nov 1 00:09:05.699495 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:09:05.699503 kernel: audit: type=1130 audit(1761955745.694:2): 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' Nov 1 00:09:05.699510 systemd[1]: Finished systemd-fsck-usr.service. Nov 1 00:09:05.699520 systemd-journald[291]: Journal started Nov 1 00:09:05.699560 systemd-journald[291]: Runtime Journal (/run/log/journal/81cc3328a14a406abdc8af484b44d888) is 6.0M, max 48.7M, 42.6M free. Nov 1 00:09:05.694000 audit[1]: SERVICE_START 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' Nov 1 00:09:05.698477 systemd-modules-load[292]: Inserted module 'overlay' Nov 1 00:09:05.703659 kernel: audit: type=1130 audit(1761955745.699:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:09:05.703676 systemd[1]: Started systemd-journald.service. Nov 1 00:09:05.699000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:09:05.707972 kernel: audit: type=1130 audit(1761955745.704: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' Nov 1 00:09:05.704000 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' Nov 1 00:09:05.707810 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Nov 1 00:09:05.709887 systemd[1]: Finished systemd-vconsole-setup.service. Nov 1 00:09:05.710000 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' Nov 1 00:09:05.714458 kernel: audit: type=1130 audit(1761955745.710:5): 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' Nov 1 00:09:05.714791 systemd[1]: Starting dracut-cmdline-ask.service... Nov 1 00:09:05.716616 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Nov 1 00:09:05.722683 kernel: audit: type=1130 audit(1761955745.717:6): 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' Nov 1 00:09:05.722700 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 1 00:09:05.717000 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' Nov 1 00:09:05.723493 systemd-resolved[293]: Positive Trust Anchors: Nov 1 00:09:05.723506 systemd-resolved[293]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:09:05.723533 systemd-resolved[293]: 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 Nov 1 00:09:05.727722 systemd-resolved[293]: Defaulting to hostname 'linux'. Nov 1 00:09:05.732588 kernel: Bridge firewalling registered Nov 1 00:09:05.728549 systemd[1]: Started systemd-resolved.service. Nov 1 00:09:05.731716 systemd-modules-load[292]: Inserted module 'br_netfilter' Nov 1 00:09:05.735000 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' Nov 1 00:09:05.736540 systemd[1]: Reached target nss-lookup.target. Nov 1 00:09:05.739171 kernel: audit: type=1130 audit(1761955745.735:7): 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' Nov 1 00:09:05.738695 systemd[1]: Finished dracut-cmdline-ask.service. Nov 1 00:09:05.740000 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' Nov 1 00:09:05.741182 systemd[1]: Starting dracut-cmdline.service... Nov 1 00:09:05.745672 kernel: audit: type=1130 audit(1761955745.740:8): 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' Nov 1 00:09:05.745690 kernel: SCSI subsystem initialized Nov 1 00:09:05.750914 dracut-cmdline[308]: dracut-dracut-053 Nov 1 00:09:05.753908 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 1 00:09:05.753935 kernel: device-mapper: uevent: version 1.0.3 Nov 1 00:09:05.754304 dracut-cmdline[308]: 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=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:09:05.759999 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Nov 1 00:09:05.759911 systemd-modules-load[292]: Inserted module 'dm_multipath' Nov 1 00:09:05.760811 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:09:05.765478 kernel: audit: type=1130 audit(1761955745.761:9): 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' Nov 1 00:09:05.761000 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' Nov 1 00:09:05.762730 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:09:05.771726 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:09:05.772000 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' Nov 1 00:09:05.776748 kernel: audit: type=1130 audit(1761955745.772:10): 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' Nov 1 00:09:05.820455 kernel: Loading iSCSI transport class v2.0-870. Nov 1 00:09:05.832461 kernel: iscsi: registered transport (tcp) Nov 1 00:09:05.847469 kernel: iscsi: registered transport (qla4xxx) Nov 1 00:09:05.847502 kernel: QLogic iSCSI HBA Driver Nov 1 00:09:05.879902 systemd[1]: Finished dracut-cmdline.service. Nov 1 00:09:05.880000 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' Nov 1 00:09:05.881682 systemd[1]: Starting dracut-pre-udev.service... Nov 1 00:09:05.924474 kernel: raid6: neonx8 gen() 13718 MB/s Nov 1 00:09:05.941464 kernel: raid6: neonx8 xor() 10577 MB/s Nov 1 00:09:05.958461 kernel: raid6: neonx4 gen() 13520 MB/s Nov 1 00:09:05.975459 kernel: raid6: neonx4 xor() 11136 MB/s Nov 1 00:09:05.992460 kernel: raid6: neonx2 gen() 12941 MB/s Nov 1 00:09:06.009456 kernel: raid6: neonx2 xor() 10310 MB/s Nov 1 00:09:06.026464 kernel: raid6: neonx1 gen() 10492 MB/s Nov 1 00:09:06.043462 kernel: raid6: neonx1 xor() 8764 MB/s Nov 1 00:09:06.060464 kernel: raid6: int64x8 gen() 6259 MB/s Nov 1 00:09:06.077467 kernel: raid6: int64x8 xor() 3532 MB/s Nov 1 00:09:06.094455 kernel: raid6: int64x4 gen() 7199 MB/s Nov 1 00:09:06.111456 kernel: raid6: int64x4 xor() 3834 MB/s Nov 1 00:09:06.128475 kernel: raid6: int64x2 gen() 6101 MB/s Nov 1 00:09:06.145457 kernel: raid6: int64x2 xor() 3301 MB/s Nov 1 00:09:06.162478 kernel: raid6: int64x1 gen() 5005 MB/s Nov 1 00:09:06.179607 kernel: raid6: int64x1 xor() 2622 MB/s Nov 1 00:09:06.179622 kernel: raid6: using algorithm neonx8 gen() 13718 MB/s Nov 1 00:09:06.179631 kernel: raid6: .... xor() 10577 MB/s, rmw enabled Nov 1 00:09:06.180753 kernel: raid6: using neon recovery algorithm Nov 1 00:09:06.191454 kernel: xor: measuring software checksum speed Nov 1 00:09:06.191476 kernel: 8regs : 17184 MB/sec Nov 1 00:09:06.192698 kernel: 32regs : 18374 MB/sec Nov 1 00:09:06.192711 kernel: arm64_neon : 27775 MB/sec Nov 1 00:09:06.192720 kernel: xor: using function: arm64_neon (27775 MB/sec) Nov 1 00:09:06.245459 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Nov 1 00:09:06.254841 systemd[1]: Finished dracut-pre-udev.service. Nov 1 00:09:06.255000 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' Nov 1 00:09:06.255000 audit: BPF prog-id=7 op=LOAD Nov 1 00:09:06.255000 audit: BPF prog-id=8 op=LOAD Nov 1 00:09:06.256816 systemd[1]: Starting systemd-udevd.service... Nov 1 00:09:06.268397 systemd-udevd[492]: Using default interface naming scheme 'v252'. Nov 1 00:09:06.271652 systemd[1]: Started systemd-udevd.service. Nov 1 00:09:06.274000 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' Nov 1 00:09:06.276001 systemd[1]: Starting dracut-pre-trigger.service... Nov 1 00:09:06.286470 dracut-pre-trigger[506]: rd.md=0: removing MD RAID activation Nov 1 00:09:06.310738 systemd[1]: Finished dracut-pre-trigger.service. Nov 1 00:09:06.311000 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' Nov 1 00:09:06.312292 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:09:06.345489 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:09:06.346000 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' Nov 1 00:09:06.379385 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Nov 1 00:09:06.394605 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 1 00:09:06.394626 kernel: GPT:9289727 != 19775487 Nov 1 00:09:06.394635 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 1 00:09:06.394643 kernel: GPT:9289727 != 19775487 Nov 1 00:09:06.394651 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 1 00:09:06.394659 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 00:09:06.407466 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (545) Nov 1 00:09:06.410617 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Nov 1 00:09:06.413678 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Nov 1 00:09:06.414818 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Nov 1 00:09:06.424045 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Nov 1 00:09:06.427835 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:09:06.429544 systemd[1]: Starting disk-uuid.service... Nov 1 00:09:06.436929 disk-uuid[561]: Primary Header is updated. Nov 1 00:09:06.436929 disk-uuid[561]: Secondary Entries is updated. Nov 1 00:09:06.436929 disk-uuid[561]: Secondary Header is updated. Nov 1 00:09:06.440447 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 00:09:06.443468 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 00:09:06.446774 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 00:09:07.446461 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Nov 1 00:09:07.447156 disk-uuid[562]: The operation has completed successfully. Nov 1 00:09:07.469089 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 1 00:09:07.469000 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' Nov 1 00:09:07.469000 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' Nov 1 00:09:07.469186 systemd[1]: Finished disk-uuid.service. Nov 1 00:09:07.473718 systemd[1]: Starting verity-setup.service... Nov 1 00:09:07.486446 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 1 00:09:07.509778 systemd[1]: Found device dev-mapper-usr.device. Nov 1 00:09:07.511454 systemd[1]: Mounting sysusr-usr.mount... Nov 1 00:09:07.512261 systemd[1]: Finished verity-setup.service. Nov 1 00:09:07.512000 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' Nov 1 00:09:07.556453 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Nov 1 00:09:07.556933 systemd[1]: Mounted sysusr-usr.mount. Nov 1 00:09:07.557907 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Nov 1 00:09:07.558650 systemd[1]: Starting ignition-setup.service... Nov 1 00:09:07.561088 systemd[1]: Starting parse-ip-for-networkd.service... Nov 1 00:09:07.568087 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:09:07.568121 kernel: BTRFS info (device vda6): using free space tree Nov 1 00:09:07.568130 kernel: BTRFS info (device vda6): has skinny extents Nov 1 00:09:07.577971 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 1 00:09:07.583629 systemd[1]: Finished ignition-setup.service. Nov 1 00:09:07.585215 systemd[1]: Starting ignition-fetch-offline.service... Nov 1 00:09:07.583000 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' Nov 1 00:09:07.632040 ignition[649]: Ignition 2.14.0 Nov 1 00:09:07.632978 ignition[649]: Stage: fetch-offline Nov 1 00:09:07.633771 ignition[649]: no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:07.634675 ignition[649]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:07.635925 ignition[649]: parsed url from cmdline: "" Nov 1 00:09:07.635972 ignition[649]: no config URL provided Nov 1 00:09:07.636714 ignition[649]: reading system config file "/usr/lib/ignition/user.ign" Nov 1 00:09:07.637480 ignition[649]: no config at "/usr/lib/ignition/user.ign" Nov 1 00:09:07.637504 ignition[649]: op(1): [started] loading QEMU firmware config module Nov 1 00:09:07.637509 ignition[649]: op(1): executing: "modprobe" "qemu_fw_cfg" Nov 1 00:09:07.639737 systemd[1]: Finished parse-ip-for-networkd.service. Nov 1 00:09:07.641000 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' Nov 1 00:09:07.641000 audit: BPF prog-id=9 op=LOAD Nov 1 00:09:07.642685 systemd[1]: Starting systemd-networkd.service... Nov 1 00:09:07.644404 ignition[649]: op(1): [finished] loading QEMU firmware config module Nov 1 00:09:07.653358 ignition[649]: parsing config with SHA512: 58b07dfe06e7429041a6fa59b61e8afee6134fac534d002630a773a16f978cb1a0346b8a55449a4cfa14f87976058077d1facf61d3665cd414982bf34e6ee987 Nov 1 00:09:07.659224 unknown[649]: fetched base config from "system" Nov 1 00:09:07.659234 unknown[649]: fetched user config from "qemu" Nov 1 00:09:07.659589 ignition[649]: fetch-offline: fetch-offline passed Nov 1 00:09:07.659641 ignition[649]: Ignition finished successfully Nov 1 00:09:07.662584 systemd[1]: Finished ignition-fetch-offline.service. Nov 1 00:09:07.663000 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' Nov 1 00:09:07.666047 systemd-networkd[741]: lo: Link UP Nov 1 00:09:07.666062 systemd-networkd[741]: lo: Gained carrier Nov 1 00:09:07.667000 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' Nov 1 00:09:07.666473 systemd-networkd[741]: Enumeration completed Nov 1 00:09:07.666648 systemd-networkd[741]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:09:07.666742 systemd[1]: Started systemd-networkd.service. Nov 1 00:09:07.667658 systemd-networkd[741]: eth0: Link UP Nov 1 00:09:07.667662 systemd-networkd[741]: eth0: Gained carrier Nov 1 00:09:07.667862 systemd[1]: Reached target network.target. Nov 1 00:09:07.669204 systemd[1]: ignition-fetch.service was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Nov 1 00:09:07.669907 systemd[1]: Starting ignition-kargs.service... Nov 1 00:09:07.671286 systemd[1]: Starting iscsiuio.service... Nov 1 00:09:07.678370 systemd[1]: Started iscsiuio.service. Nov 1 00:09:07.679000 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' Nov 1 00:09:07.679575 ignition[744]: Ignition 2.14.0 Nov 1 00:09:07.679581 ignition[744]: Stage: kargs Nov 1 00:09:07.680676 systemd[1]: Starting iscsid.service... Nov 1 00:09:07.682000 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' Nov 1 00:09:07.679672 ignition[744]: no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:07.681504 systemd-networkd[741]: eth0: DHCPv4 address 10.0.0.27/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 1 00:09:07.686781 iscsid[753]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:09:07.686781 iscsid[753]: 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 Nov 1 00:09:07.686781 iscsid[753]: into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 1 00:09:07.686781 iscsid[753]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 1 00:09:07.686781 iscsid[753]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 1 00:09:07.686781 iscsid[753]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:09:07.686781 iscsid[753]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 1 00:09:07.687000 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' Nov 1 00:09:07.695000 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' Nov 1 00:09:07.679681 ignition[744]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:07.682139 systemd[1]: Finished ignition-kargs.service. Nov 1 00:09:07.680329 ignition[744]: kargs: kargs passed Nov 1 00:09:07.706000 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' Nov 1 00:09:07.684070 systemd[1]: Starting ignition-disks.service... Nov 1 00:09:07.680367 ignition[744]: Ignition finished successfully Nov 1 00:09:07.686695 systemd[1]: Started iscsid.service. Nov 1 00:09:07.690530 ignition[754]: Ignition 2.14.0 Nov 1 00:09:07.688168 systemd[1]: Starting dracut-initqueue.service... Nov 1 00:09:07.690535 ignition[754]: Stage: disks Nov 1 00:09:07.693232 systemd[1]: Finished ignition-disks.service. Nov 1 00:09:07.690618 ignition[754]: no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:07.696363 systemd[1]: Reached target initrd-root-device.target. Nov 1 00:09:07.690626 ignition[754]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:07.698022 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:09:07.691264 ignition[754]: disks: disks passed Nov 1 00:09:07.699801 systemd[1]: Reached target local-fs.target. Nov 1 00:09:07.719000 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' Nov 1 00:09:07.691315 ignition[754]: Ignition finished successfully Nov 1 00:09:07.701687 systemd[1]: Reached target sysinit.target. Nov 1 00:09:07.703569 systemd[1]: Reached target basic.target. Nov 1 00:09:07.705477 systemd[1]: Finished dracut-initqueue.service. Nov 1 00:09:07.706703 systemd[1]: Reached target remote-fs-pre.target. Nov 1 00:09:07.707953 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:09:07.709455 systemd[1]: Reached target remote-fs.target. Nov 1 00:09:07.711518 systemd[1]: Starting dracut-pre-mount.service... Nov 1 00:09:07.718814 systemd[1]: Finished dracut-pre-mount.service. Nov 1 00:09:07.720528 systemd[1]: Starting systemd-fsck-root.service... Nov 1 00:09:07.732244 systemd-fsck[775]: ROOT: clean, 637/553520 files, 56031/553472 blocks Nov 1 00:09:07.735515 systemd[1]: Finished systemd-fsck-root.service. Nov 1 00:09:07.736000 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' Nov 1 00:09:07.739081 systemd[1]: Mounting sysroot.mount... Nov 1 00:09:07.745334 systemd[1]: Mounted sysroot.mount. Nov 1 00:09:07.746642 kernel: EXT4-fs (vda9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 1 00:09:07.746140 systemd[1]: Reached target initrd-root-fs.target. Nov 1 00:09:07.748241 systemd[1]: Mounting sysroot-usr.mount... Nov 1 00:09:07.749080 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Nov 1 00:09:07.749117 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 1 00:09:07.749140 systemd[1]: Reached target ignition-diskful.target. Nov 1 00:09:07.751013 systemd[1]: Mounted sysroot-usr.mount. Nov 1 00:09:07.752928 systemd[1]: Starting initrd-setup-root.service... Nov 1 00:09:07.756969 initrd-setup-root[785]: cut: /sysroot/etc/passwd: No such file or directory Nov 1 00:09:07.760271 initrd-setup-root[793]: cut: /sysroot/etc/group: No such file or directory Nov 1 00:09:07.763007 initrd-setup-root[801]: cut: /sysroot/etc/shadow: No such file or directory Nov 1 00:09:07.771817 initrd-setup-root[809]: cut: /sysroot/etc/gshadow: No such file or directory Nov 1 00:09:07.807770 systemd[1]: Finished initrd-setup-root.service. Nov 1 00:09:07.808000 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' Nov 1 00:09:07.810507 systemd[1]: Starting ignition-mount.service... Nov 1 00:09:07.812079 systemd[1]: Starting sysroot-boot.service... Nov 1 00:09:07.815469 bash[826]: umount: /sysroot/usr/share/oem: not mounted. Nov 1 00:09:07.823538 ignition[827]: INFO : Ignition 2.14.0 Nov 1 00:09:07.823538 ignition[827]: INFO : Stage: mount Nov 1 00:09:07.825733 ignition[827]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:07.825733 ignition[827]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:07.825733 ignition[827]: INFO : mount: mount passed Nov 1 00:09:07.825733 ignition[827]: INFO : Ignition finished successfully Nov 1 00:09:07.828000 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' Nov 1 00:09:07.828130 systemd[1]: Finished ignition-mount.service. Nov 1 00:09:07.841307 systemd[1]: Finished sysroot-boot.service. Nov 1 00:09:07.842000 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' Nov 1 00:09:08.519929 systemd[1]: Mounting sysroot-usr-share-oem.mount... Nov 1 00:09:08.530479 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (838) Nov 1 00:09:08.532875 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:09:08.532906 kernel: BTRFS info (device vda6): using free space tree Nov 1 00:09:08.532916 kernel: BTRFS info (device vda6): has skinny extents Nov 1 00:09:08.536760 systemd[1]: Mounted sysroot-usr-share-oem.mount. Nov 1 00:09:08.538330 systemd[1]: Starting ignition-files.service... Nov 1 00:09:08.552070 ignition[858]: INFO : Ignition 2.14.0 Nov 1 00:09:08.552070 ignition[858]: INFO : Stage: files Nov 1 00:09:08.553822 ignition[858]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:08.553822 ignition[858]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:08.553822 ignition[858]: DEBUG : files: compiled without relabeling support, skipping Nov 1 00:09:08.557338 ignition[858]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 1 00:09:08.557338 ignition[858]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 1 00:09:08.560729 ignition[858]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 1 00:09:08.562129 ignition[858]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 1 00:09:08.563754 unknown[858]: wrote ssh authorized keys file for user: core Nov 1 00:09:08.564789 ignition[858]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 1 00:09:08.564789 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Nov 1 00:09:08.564789 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Nov 1 00:09:08.564789 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Nov 1 00:09:08.564789 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Nov 1 00:09:08.573880 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://extensions.flatcar.org/extensions/kubernetes-v1.32.4-arm64.raw: attempt #1 Nov 1 00:09:08.943774 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Nov 1 00:09:09.112560 systemd-networkd[741]: eth0: Gained IPv6LL Nov 1 00:09:09.171793 ignition[858]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.32.4-arm64.raw" Nov 1 00:09:09.171793 ignition[858]: INFO : files: op(8): [started] processing unit "containerd.service" Nov 1 00:09:09.175577 ignition[858]: 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" Nov 1 00:09:09.175577 ignition[858]: 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" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(8): [finished] processing unit "containerd.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Nov 1 00:09:09.175577 ignition[858]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Nov 1 00:09:09.211448 ignition[858]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Nov 1 00:09:09.214000 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' Nov 1 00:09:09.215292 ignition[858]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Nov 1 00:09:09.215292 ignition[858]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:09:09.215292 ignition[858]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:09:09.215292 ignition[858]: INFO : files: files passed Nov 1 00:09:09.215292 ignition[858]: INFO : Ignition finished successfully Nov 1 00:09:09.214142 systemd[1]: Finished ignition-files.service. Nov 1 00:09:09.224000 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' Nov 1 00:09:09.216040 systemd[1]: Starting initrd-setup-root-after-ignition.service... Nov 1 00:09:09.226000 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' Nov 1 00:09:09.226000 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' Nov 1 00:09:09.217817 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Nov 1 00:09:09.230342 initrd-setup-root-after-ignition[883]: grep: /sysroot/usr/share/oem/oem-release: No such file or directory Nov 1 00:09:09.218525 systemd[1]: Starting ignition-quench.service... Nov 1 00:09:09.233392 initrd-setup-root-after-ignition[885]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 1 00:09:09.223678 systemd[1]: Finished initrd-setup-root-after-ignition.service. Nov 1 00:09:09.225569 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 1 00:09:09.225644 systemd[1]: Finished ignition-quench.service. Nov 1 00:09:09.226987 systemd[1]: Reached target ignition-complete.target. Nov 1 00:09:09.229207 systemd[1]: Starting initrd-parse-etc.service... Nov 1 00:09:09.241279 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 1 00:09:09.241378 systemd[1]: Finished initrd-parse-etc.service. Nov 1 00:09:09.242000 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' Nov 1 00:09:09.242000 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' Nov 1 00:09:09.243217 systemd[1]: Reached target initrd-fs.target. Nov 1 00:09:09.244580 systemd[1]: Reached target initrd.target. Nov 1 00:09:09.245241 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Nov 1 00:09:09.245951 systemd[1]: Starting dracut-pre-pivot.service... Nov 1 00:09:09.256153 systemd[1]: Finished dracut-pre-pivot.service. Nov 1 00:09:09.256000 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' Nov 1 00:09:09.257672 systemd[1]: Starting initrd-cleanup.service... Nov 1 00:09:09.265619 systemd[1]: Stopped target nss-lookup.target. Nov 1 00:09:09.266536 systemd[1]: Stopped target remote-cryptsetup.target. Nov 1 00:09:09.268077 systemd[1]: Stopped target timers.target. Nov 1 00:09:09.269462 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 1 00:09:09.270000 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' Nov 1 00:09:09.269577 systemd[1]: Stopped dracut-pre-pivot.service. Nov 1 00:09:09.270941 systemd[1]: Stopped target initrd.target. Nov 1 00:09:09.272343 systemd[1]: Stopped target basic.target. Nov 1 00:09:09.273673 systemd[1]: Stopped target ignition-complete.target. Nov 1 00:09:09.275073 systemd[1]: Stopped target ignition-diskful.target. Nov 1 00:09:09.276522 systemd[1]: Stopped target initrd-root-device.target. Nov 1 00:09:09.278129 systemd[1]: Stopped target remote-fs.target. Nov 1 00:09:09.279593 systemd[1]: Stopped target remote-fs-pre.target. Nov 1 00:09:09.281095 systemd[1]: Stopped target sysinit.target. Nov 1 00:09:09.282447 systemd[1]: Stopped target local-fs.target. Nov 1 00:09:09.283724 systemd[1]: Stopped target local-fs-pre.target. Nov 1 00:09:09.285109 systemd[1]: Stopped target swap.target. Nov 1 00:09:09.287000 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' Nov 1 00:09:09.286416 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 1 00:09:09.286578 systemd[1]: Stopped dracut-pre-mount.service. Nov 1 00:09:09.290000 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' Nov 1 00:09:09.287854 systemd[1]: Stopped target cryptsetup.target. Nov 1 00:09:09.291000 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' Nov 1 00:09:09.289104 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 1 00:09:09.289208 systemd[1]: Stopped dracut-initqueue.service. Nov 1 00:09:09.290751 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 1 00:09:09.290853 systemd[1]: Stopped ignition-fetch-offline.service. Nov 1 00:09:09.292227 systemd[1]: Stopped target paths.target. Nov 1 00:09:09.293456 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 1 00:09:09.297530 systemd[1]: Stopped systemd-ask-password-console.path. Nov 1 00:09:09.299437 systemd[1]: Stopped target slices.target. Nov 1 00:09:09.300866 systemd[1]: Stopped target sockets.target. Nov 1 00:09:09.302254 systemd[1]: iscsid.socket: Deactivated successfully. Nov 1 00:09:09.302341 systemd[1]: Closed iscsid.socket. Nov 1 00:09:09.303529 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 1 00:09:09.305000 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' Nov 1 00:09:09.303597 systemd[1]: Closed iscsiuio.socket. Nov 1 00:09:09.307000 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' Nov 1 00:09:09.304895 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 1 00:09:09.305002 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Nov 1 00:09:09.306365 systemd[1]: ignition-files.service: Deactivated successfully. Nov 1 00:09:09.311000 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' Nov 1 00:09:09.306476 systemd[1]: Stopped ignition-files.service. Nov 1 00:09:09.308931 systemd[1]: Stopping ignition-mount.service... Nov 1 00:09:09.314000 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' Nov 1 00:09:09.310309 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 1 00:09:09.310462 systemd[1]: Stopped kmod-static-nodes.service. Nov 1 00:09:09.312783 systemd[1]: Stopping sysroot-boot.service... Nov 1 00:09:09.319000 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' Nov 1 00:09:09.320221 ignition[898]: INFO : Ignition 2.14.0 Nov 1 00:09:09.320221 ignition[898]: INFO : Stage: umount Nov 1 00:09:09.320221 ignition[898]: INFO : no configs at "/usr/lib/ignition/base.d" Nov 1 00:09:09.320221 ignition[898]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Nov 1 00:09:09.320221 ignition[898]: INFO : umount: umount passed Nov 1 00:09:09.320221 ignition[898]: INFO : Ignition finished successfully Nov 1 00:09:09.324000 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' Nov 1 00:09:09.313523 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 1 00:09:09.327000 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' Nov 1 00:09:09.313656 systemd[1]: Stopped systemd-udev-trigger.service. Nov 1 00:09:09.329000 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' Nov 1 00:09:09.315106 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 1 00:09:09.331000 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' Nov 1 00:09:09.315207 systemd[1]: Stopped dracut-pre-trigger.service. Nov 1 00:09:09.323193 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 1 00:09:09.323816 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 1 00:09:09.336000 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' Nov 1 00:09:09.336000 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' Nov 1 00:09:09.323912 systemd[1]: Stopped ignition-mount.service. Nov 1 00:09:09.325770 systemd[1]: Stopped target network.target. Nov 1 00:09:09.326989 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 1 00:09:09.342000 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' Nov 1 00:09:09.327046 systemd[1]: Stopped ignition-disks.service. Nov 1 00:09:09.328521 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 1 00:09:09.328560 systemd[1]: Stopped ignition-kargs.service. Nov 1 00:09:09.330190 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 1 00:09:09.349000 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' Nov 1 00:09:09.330229 systemd[1]: Stopped ignition-setup.service. Nov 1 00:09:09.351000 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' Nov 1 00:09:09.331820 systemd[1]: Stopping systemd-networkd.service... Nov 1 00:09:09.353000 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' Nov 1 00:09:09.333769 systemd[1]: Stopping systemd-resolved.service... Nov 1 00:09:09.336180 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 1 00:09:09.336263 systemd[1]: Finished initrd-cleanup.service. Nov 1 00:09:09.358000 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' Nov 1 00:09:09.339488 systemd-networkd[741]: eth0: DHCPv6 lease lost Nov 1 00:09:09.359000 audit: BPF prog-id=9 op=UNLOAD Nov 1 00:09:09.360000 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' Nov 1 00:09:09.341230 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 1 00:09:09.362000 audit: BPF prog-id=6 op=UNLOAD Nov 1 00:09:09.362000 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' Nov 1 00:09:09.341333 systemd[1]: Stopped systemd-networkd.service. Nov 1 00:09:09.364000 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' Nov 1 00:09:09.343600 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 1 00:09:09.365000 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' Nov 1 00:09:09.343630 systemd[1]: Closed systemd-networkd.socket. Nov 1 00:09:09.346600 systemd[1]: Stopping network-cleanup.service... Nov 1 00:09:09.347472 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 1 00:09:09.370000 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' Nov 1 00:09:09.347527 systemd[1]: Stopped parse-ip-for-networkd.service. Nov 1 00:09:09.371000 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' Nov 1 00:09:09.350133 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 1 00:09:09.373000 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' Nov 1 00:09:09.350176 systemd[1]: Stopped systemd-sysctl.service. Nov 1 00:09:09.352330 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 1 00:09:09.376000 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' Nov 1 00:09:09.352371 systemd[1]: Stopped systemd-modules-load.service. Nov 1 00:09:09.353345 systemd[1]: Stopping systemd-udevd.service... Nov 1 00:09:09.357150 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 1 00:09:09.357642 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 1 00:09:09.381000 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' Nov 1 00:09:09.381000 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' Nov 1 00:09:09.357735 systemd[1]: Stopped systemd-resolved.service. Nov 1 00:09:09.359386 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 1 00:09:09.359480 systemd[1]: Stopped sysroot-boot.service. Nov 1 00:09:09.361305 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 1 00:09:09.361356 systemd[1]: Stopped initrd-setup-root.service. Nov 1 00:09:09.363366 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 1 00:09:09.363498 systemd[1]: Stopped systemd-udevd.service. Nov 1 00:09:09.365053 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 1 00:09:09.365138 systemd[1]: Stopped network-cleanup.service. Nov 1 00:09:09.391000 audit: BPF prog-id=8 op=UNLOAD Nov 1 00:09:09.391000 audit: BPF prog-id=7 op=UNLOAD Nov 1 00:09:09.366492 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 1 00:09:09.366534 systemd[1]: Closed systemd-udevd-control.socket. Nov 1 00:09:09.367966 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 1 00:09:09.394000 audit: BPF prog-id=5 op=UNLOAD Nov 1 00:09:09.394000 audit: BPF prog-id=4 op=UNLOAD Nov 1 00:09:09.394000 audit: BPF prog-id=3 op=UNLOAD Nov 1 00:09:09.367997 systemd[1]: Closed systemd-udevd-kernel.socket. Nov 1 00:09:09.369306 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 1 00:09:09.369351 systemd[1]: Stopped dracut-pre-udev.service. Nov 1 00:09:09.370793 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 1 00:09:09.370833 systemd[1]: Stopped dracut-cmdline.service. Nov 1 00:09:09.372375 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 1 00:09:09.372415 systemd[1]: Stopped dracut-cmdline-ask.service. Nov 1 00:09:09.374693 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Nov 1 00:09:09.375575 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 1 00:09:09.375630 systemd[1]: Stopped systemd-vconsole-setup.service. Nov 1 00:09:09.379825 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 1 00:09:09.379904 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Nov 1 00:09:09.381801 systemd[1]: Reached target initrd-switch-root.target. Nov 1 00:09:09.383966 systemd[1]: Starting initrd-switch-root.service... Nov 1 00:09:09.390449 systemd[1]: Switching root. Nov 1 00:09:09.411601 iscsid[753]: iscsid shutting down. Nov 1 00:09:09.412326 systemd-journald[291]: Journal stopped Nov 1 00:09:11.394358 systemd-journald[291]: Received SIGTERM from PID 1 (n/a). Nov 1 00:09:11.394415 kernel: SELinux: Class mctp_socket not defined in policy. Nov 1 00:09:11.394450 kernel: SELinux: Class anon_inode not defined in policy. Nov 1 00:09:11.394461 kernel: SELinux: the above unknown classes and permissions will be allowed Nov 1 00:09:11.394471 kernel: SELinux: policy capability network_peer_controls=1 Nov 1 00:09:11.394485 kernel: SELinux: policy capability open_perms=1 Nov 1 00:09:11.394496 kernel: SELinux: policy capability extended_socket_class=1 Nov 1 00:09:11.394506 kernel: SELinux: policy capability always_check_network=0 Nov 1 00:09:11.394516 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 1 00:09:11.394526 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 1 00:09:11.394536 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 1 00:09:11.394546 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 1 00:09:11.394556 systemd[1]: Successfully loaded SELinux policy in 35.323ms. Nov 1 00:09:11.394580 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 6.827ms. Nov 1 00:09:11.394594 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) Nov 1 00:09:11.394605 systemd[1]: Detected virtualization kvm. Nov 1 00:09:11.394616 systemd[1]: Detected architecture arm64. Nov 1 00:09:11.394626 systemd[1]: Detected first boot. Nov 1 00:09:11.394637 systemd[1]: Initializing machine ID from VM UUID. Nov 1 00:09:11.394649 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Nov 1 00:09:11.394659 systemd[1]: Populated /etc with preset unit settings. Nov 1 00:09:11.394670 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Nov 1 00:09:11.394683 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Nov 1 00:09:11.394695 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. Nov 1 00:09:11.394710 systemd[1]: Queued start job for default target multi-user.target. Nov 1 00:09:11.394721 systemd[1]: Unnecessary job was removed for dev-vda6.device. Nov 1 00:09:11.394732 systemd[1]: Created slice system-addon\x2dconfig.slice. Nov 1 00:09:11.394743 systemd[1]: Created slice system-addon\x2drun.slice. Nov 1 00:09:11.394797 systemd[1]: Created slice system-getty.slice. Nov 1 00:09:11.394814 systemd[1]: Created slice system-modprobe.slice. Nov 1 00:09:11.394827 systemd[1]: Created slice system-serial\x2dgetty.slice. Nov 1 00:09:11.394838 systemd[1]: Created slice system-system\x2dcloudinit.slice. Nov 1 00:09:11.394850 systemd[1]: Created slice system-systemd\x2dfsck.slice. Nov 1 00:09:11.394861 systemd[1]: Created slice user.slice. Nov 1 00:09:11.394872 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:09:11.394882 systemd[1]: Started systemd-ask-password-wall.path. Nov 1 00:09:11.394894 systemd[1]: Set up automount boot.automount. Nov 1 00:09:11.394905 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Nov 1 00:09:11.394915 systemd[1]: Reached target integritysetup.target. Nov 1 00:09:11.394928 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:09:11.394940 systemd[1]: Reached target remote-fs.target. Nov 1 00:09:11.394951 systemd[1]: Reached target slices.target. Nov 1 00:09:11.394966 systemd[1]: Reached target swap.target. Nov 1 00:09:11.394979 systemd[1]: Reached target torcx.target. Nov 1 00:09:11.394989 systemd[1]: Reached target veritysetup.target. Nov 1 00:09:11.395000 systemd[1]: Listening on systemd-coredump.socket. Nov 1 00:09:11.395012 systemd[1]: Listening on systemd-initctl.socket. Nov 1 00:09:11.395023 kernel: kauditd_printk_skb: 80 callbacks suppressed Nov 1 00:09:11.395033 kernel: audit: type=1400 audit(1761955751.313:84): 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 Nov 1 00:09:11.395044 systemd[1]: Listening on systemd-journald-audit.socket. Nov 1 00:09:11.395055 kernel: audit: type=1335 audit(1761955751.314:85): 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 Nov 1 00:09:11.395066 systemd[1]: Listening on systemd-journald-dev-log.socket. Nov 1 00:09:11.395078 systemd[1]: Listening on systemd-journald.socket. Nov 1 00:09:11.395089 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:09:11.395099 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:09:11.395110 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:09:11.395122 systemd[1]: Listening on systemd-userdbd.socket. Nov 1 00:09:11.395132 systemd[1]: Mounting dev-hugepages.mount... Nov 1 00:09:11.395143 systemd[1]: Mounting dev-mqueue.mount... Nov 1 00:09:11.395153 systemd[1]: Mounting media.mount... Nov 1 00:09:11.395164 systemd[1]: Mounting sys-kernel-debug.mount... Nov 1 00:09:11.395175 systemd[1]: Mounting sys-kernel-tracing.mount... Nov 1 00:09:11.395187 systemd[1]: Mounting tmp.mount... Nov 1 00:09:11.395198 systemd[1]: Starting flatcar-tmpfiles.service... Nov 1 00:09:11.395209 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:09:11.395224 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:09:11.395235 systemd[1]: Starting modprobe@configfs.service... Nov 1 00:09:11.395247 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:09:11.395258 systemd[1]: Starting modprobe@drm.service... Nov 1 00:09:11.395274 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:09:11.395288 systemd[1]: Starting modprobe@fuse.service... Nov 1 00:09:11.395300 systemd[1]: Starting modprobe@loop.service... Nov 1 00:09:11.395312 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 1 00:09:11.395323 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Nov 1 00:09:11.395334 systemd[1]: (This warning is only shown for the first unit using IP firewalling.) Nov 1 00:09:11.395344 kernel: fuse: init (API version 7.34) Nov 1 00:09:11.395355 systemd[1]: Starting systemd-journald.service... Nov 1 00:09:11.395365 kernel: loop: module loaded Nov 1 00:09:11.395375 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:09:11.395386 systemd[1]: Starting systemd-network-generator.service... Nov 1 00:09:11.395398 systemd[1]: Starting systemd-remount-fs.service... Nov 1 00:09:11.395409 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:09:11.395419 systemd[1]: Mounted dev-hugepages.mount. Nov 1 00:09:11.395439 systemd[1]: Mounted dev-mqueue.mount. Nov 1 00:09:11.395452 kernel: audit: type=1305 audit(1761955751.392:86): op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 1 00:09:11.395465 systemd-journald[1037]: Journal started Nov 1 00:09:11.395510 systemd-journald[1037]: Runtime Journal (/run/log/journal/81cc3328a14a406abdc8af484b44d888) is 6.0M, max 48.7M, 42.6M free. Nov 1 00:09:11.314000 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 Nov 1 00:09:11.392000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 1 00:09:11.392000 audit[1037]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=ffffe8c2cc20 a2=4000 a3=1 items=0 ppid=1 pid=1037 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) Nov 1 00:09:11.399709 kernel: audit: type=1300 audit(1761955751.392:86): arch=c00000b7 syscall=211 success=yes exit=60 a0=5 a1=ffffe8c2cc20 a2=4000 a3=1 items=0 ppid=1 pid=1037 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) Nov 1 00:09:11.392000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Nov 1 00:09:11.401592 kernel: audit: type=1327 audit(1761955751.392:86): proctitle="/usr/lib/systemd/systemd-journald" Nov 1 00:09:11.405848 systemd[1]: Started systemd-journald.service. Nov 1 00:09:11.405961 kernel: audit: type=1130 audit(1761955751.405:87): 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' Nov 1 00:09:11.405000 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' Nov 1 00:09:11.406416 systemd[1]: Mounted media.mount. Nov 1 00:09:11.409721 systemd[1]: Mounted sys-kernel-debug.mount. Nov 1 00:09:11.410610 systemd[1]: Mounted sys-kernel-tracing.mount. Nov 1 00:09:11.411542 systemd[1]: Mounted tmp.mount. Nov 1 00:09:11.412714 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:09:11.413000 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' Nov 1 00:09:11.413864 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 1 00:09:11.414074 systemd[1]: Finished modprobe@configfs.service. Nov 1 00:09:11.416478 kernel: audit: type=1130 audit(1761955751.413:88): 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' Nov 1 00:09:11.416000 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' Nov 1 00:09:11.417635 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:09:11.417834 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:09:11.416000 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' Nov 1 00:09:11.424087 kernel: audit: type=1130 audit(1761955751.416:89): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:09:11.424134 kernel: audit: type=1131 audit(1761955751.416:90): 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' Nov 1 00:09:11.424150 kernel: audit: type=1130 audit(1761955751.424:91): 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' Nov 1 00:09:11.424000 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' Nov 1 00:09:11.424629 systemd[1]: Finished flatcar-tmpfiles.service. Nov 1 00:09:11.424000 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' Nov 1 00:09:11.427000 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' Nov 1 00:09:11.428170 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 00:09:11.428383 systemd[1]: Finished modprobe@drm.service. Nov 1 00:09:11.429000 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' Nov 1 00:09:11.429000 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' Nov 1 00:09:11.429484 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:09:11.429682 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:09:11.430000 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' Nov 1 00:09:11.430000 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' Nov 1 00:09:11.430828 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 1 00:09:11.431025 systemd[1]: Finished modprobe@fuse.service. Nov 1 00:09:11.431000 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' Nov 1 00:09:11.431000 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' Nov 1 00:09:11.432115 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:09:11.432352 systemd[1]: Finished modprobe@loop.service. Nov 1 00:09:11.433000 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' Nov 1 00:09:11.433000 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' Nov 1 00:09:11.433683 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:09:11.434000 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' Nov 1 00:09:11.434948 systemd[1]: Finished systemd-network-generator.service. Nov 1 00:09:11.435000 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' Nov 1 00:09:11.436235 systemd[1]: Finished systemd-remount-fs.service. Nov 1 00:09:11.437000 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' Nov 1 00:09:11.437557 systemd[1]: Reached target network-pre.target. Nov 1 00:09:11.439866 systemd[1]: Mounting sys-fs-fuse-connections.mount... Nov 1 00:09:11.441724 systemd[1]: Mounting sys-kernel-config.mount... Nov 1 00:09:11.442499 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 1 00:09:11.444174 systemd[1]: Starting systemd-hwdb-update.service... Nov 1 00:09:11.446186 systemd[1]: Starting systemd-journal-flush.service... Nov 1 00:09:11.447134 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:09:11.455373 systemd-journald[1037]: Time spent on flushing to /var/log/journal/81cc3328a14a406abdc8af484b44d888 is 12.616ms for 908 entries. Nov 1 00:09:11.455373 systemd-journald[1037]: System Journal (/var/log/journal/81cc3328a14a406abdc8af484b44d888) is 8.0M, max 195.6M, 187.6M free. Nov 1 00:09:11.484089 systemd-journald[1037]: Received client request to flush runtime journal. Nov 1 00:09:11.457000 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' Nov 1 00:09:11.461000 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' Nov 1 00:09:11.477000 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' Nov 1 00:09:11.481000 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' Nov 1 00:09:11.448130 systemd[1]: Starting systemd-random-seed.service... Nov 1 00:09:11.449069 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:09:11.450068 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:09:11.452042 systemd[1]: Starting systemd-sysusers.service... Nov 1 00:09:11.485545 udevadm[1079]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 1 00:09:11.456078 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:09:11.458013 systemd[1]: Mounted sys-fs-fuse-connections.mount. Nov 1 00:09:11.459064 systemd[1]: Mounted sys-kernel-config.mount. Nov 1 00:09:11.460232 systemd[1]: Finished systemd-random-seed.service. Nov 1 00:09:11.461368 systemd[1]: Reached target first-boot-complete.target. Nov 1 00:09:11.485000 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' Nov 1 00:09:11.463948 systemd[1]: Starting systemd-udev-settle.service... Nov 1 00:09:11.476640 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:09:11.481041 systemd[1]: Finished systemd-sysusers.service. Nov 1 00:09:11.483197 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Nov 1 00:09:11.485077 systemd[1]: Finished systemd-journal-flush.service. Nov 1 00:09:11.499625 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Nov 1 00:09:11.500000 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' Nov 1 00:09:11.829465 systemd[1]: Finished systemd-hwdb-update.service. Nov 1 00:09:11.829000 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' Nov 1 00:09:11.831603 systemd[1]: Starting systemd-udevd.service... Nov 1 00:09:11.847905 systemd-udevd[1089]: Using default interface naming scheme 'v252'. Nov 1 00:09:11.861553 systemd[1]: Started systemd-udevd.service. Nov 1 00:09:11.862000 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' Nov 1 00:09:11.864423 systemd[1]: Starting systemd-networkd.service... Nov 1 00:09:11.872206 systemd[1]: Starting systemd-userdbd.service... Nov 1 00:09:11.889228 systemd[1]: Found device dev-ttyAMA0.device. Nov 1 00:09:11.906000 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' Nov 1 00:09:11.906093 systemd[1]: Started systemd-userdbd.service. Nov 1 00:09:11.927133 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:09:11.954490 systemd-networkd[1098]: lo: Link UP Nov 1 00:09:11.954786 systemd-networkd[1098]: lo: Gained carrier Nov 1 00:09:11.955224 systemd-networkd[1098]: Enumeration completed Nov 1 00:09:11.955000 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' Nov 1 00:09:11.955423 systemd[1]: Started systemd-networkd.service. Nov 1 00:09:11.956709 systemd-networkd[1098]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:09:11.957939 systemd-networkd[1098]: eth0: Link UP Nov 1 00:09:11.958031 systemd-networkd[1098]: eth0: Gained carrier Nov 1 00:09:11.979000 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' Nov 1 00:09:11.978867 systemd[1]: Finished systemd-udev-settle.service. Nov 1 00:09:11.981025 systemd[1]: Starting lvm2-activation-early.service... Nov 1 00:09:11.983569 systemd-networkd[1098]: eth0: DHCPv4 address 10.0.0.27/16, gateway 10.0.0.1 acquired from 10.0.0.1 Nov 1 00:09:11.989561 lvm[1123]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:09:12.031000 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' Nov 1 00:09:12.030532 systemd[1]: Finished lvm2-activation-early.service. Nov 1 00:09:12.031732 systemd[1]: Reached target cryptsetup.target. Nov 1 00:09:12.033583 systemd[1]: Starting lvm2-activation.service... Nov 1 00:09:12.037178 lvm[1125]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:09:12.078302 systemd[1]: Finished lvm2-activation.service. Nov 1 00:09:12.078000 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' Nov 1 00:09:12.079322 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:09:12.080240 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 1 00:09:12.080283 systemd[1]: Reached target local-fs.target. Nov 1 00:09:12.081126 systemd[1]: Reached target machines.target. Nov 1 00:09:12.083031 systemd[1]: Starting ldconfig.service... Nov 1 00:09:12.084085 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.084138 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). Nov 1 00:09:12.085154 systemd[1]: Starting systemd-boot-update.service... Nov 1 00:09:12.087093 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Nov 1 00:09:12.089300 systemd[1]: Starting systemd-machine-id-commit.service... Nov 1 00:09:12.091542 systemd[1]: Starting systemd-sysext.service... Nov 1 00:09:12.092859 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1128 (bootctl) Nov 1 00:09:12.093919 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Nov 1 00:09:12.098807 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Nov 1 00:09:12.099000 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' Nov 1 00:09:12.103502 systemd[1]: Unmounting usr-share-oem.mount... Nov 1 00:09:12.106827 systemd[1]: usr-share-oem.mount: Deactivated successfully. Nov 1 00:09:12.107058 systemd[1]: Unmounted usr-share-oem.mount. Nov 1 00:09:12.161470 kernel: loop0: detected capacity change from 0 to 207008 Nov 1 00:09:12.166402 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 1 00:09:12.167074 systemd[1]: Finished systemd-machine-id-commit.service. Nov 1 00:09:12.167000 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' Nov 1 00:09:12.172385 systemd-fsck[1138]: fsck.fat 4.2 (2021-01-31) Nov 1 00:09:12.172385 systemd-fsck[1138]: /dev/vda1: 236 files, 117310/258078 clusters Nov 1 00:09:12.172807 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Nov 1 00:09:12.177671 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Nov 1 00:09:12.178000 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' Nov 1 00:09:12.180356 systemd[1]: Mounting boot.mount... Nov 1 00:09:12.187504 systemd[1]: Mounted boot.mount. Nov 1 00:09:12.189454 kernel: loop1: detected capacity change from 0 to 207008 Nov 1 00:09:12.195204 systemd[1]: Finished systemd-boot-update.service. Nov 1 00:09:12.196000 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' Nov 1 00:09:12.197066 (sd-sysext)[1148]: Using extensions 'kubernetes'. Nov 1 00:09:12.198446 (sd-sysext)[1148]: Merged extensions into '/usr'. Nov 1 00:09:12.216778 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.217991 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:09:12.220197 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:09:12.222484 systemd[1]: Starting modprobe@loop.service... Nov 1 00:09:12.223543 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.223758 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). Nov 1 00:09:12.224918 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:09:12.225066 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:09:12.225000 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' Nov 1 00:09:12.225000 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' Nov 1 00:09:12.226750 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:09:12.226961 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:09:12.227000 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' Nov 1 00:09:12.227000 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' Nov 1 00:09:12.228403 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:09:12.228588 systemd[1]: Finished modprobe@loop.service. Nov 1 00:09:12.229000 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' Nov 1 00:09:12.229000 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' Nov 1 00:09:12.230346 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:09:12.230536 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.272560 ldconfig[1127]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 1 00:09:12.276462 systemd[1]: Finished ldconfig.service. Nov 1 00:09:12.276000 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' Nov 1 00:09:12.397718 systemd[1]: Mounting usr-share-oem.mount... Nov 1 00:09:12.402815 systemd[1]: Mounted usr-share-oem.mount. Nov 1 00:09:12.404732 systemd[1]: Finished systemd-sysext.service. Nov 1 00:09:12.405000 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' Nov 1 00:09:12.406783 systemd[1]: Starting ensure-sysext.service... Nov 1 00:09:12.408582 systemd[1]: Starting systemd-tmpfiles-setup.service... Nov 1 00:09:12.412782 systemd[1]: Reloading. Nov 1 00:09:12.417459 systemd-tmpfiles[1165]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 1 00:09:12.418588 systemd-tmpfiles[1165]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 1 00:09:12.419916 systemd-tmpfiles[1165]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 1 00:09:12.452359 /usr/lib/systemd/system-generators/torcx-generator[1185]: time="2025-11-01T00:09:12Z" 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]" Nov 1 00:09:12.452748 /usr/lib/systemd/system-generators/torcx-generator[1185]: time="2025-11-01T00:09:12Z" level=info msg="torcx already run" Nov 1 00:09:12.509231 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Nov 1 00:09:12.509253 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Nov 1 00:09:12.524582 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. Nov 1 00:09:12.570500 systemd[1]: Finished systemd-tmpfiles-setup.service. Nov 1 00:09:12.571000 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' Nov 1 00:09:12.574652 systemd[1]: Starting audit-rules.service... Nov 1 00:09:12.576729 systemd[1]: Starting clean-ca-certificates.service... Nov 1 00:09:12.578784 systemd[1]: Starting systemd-journal-catalog-update.service... Nov 1 00:09:12.581206 systemd[1]: Starting systemd-resolved.service... Nov 1 00:09:12.583554 systemd[1]: Starting systemd-timesyncd.service... Nov 1 00:09:12.585581 systemd[1]: Starting systemd-update-utmp.service... Nov 1 00:09:12.587058 systemd[1]: Finished clean-ca-certificates.service. Nov 1 00:09:12.588000 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' Nov 1 00:09:12.590000 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' Nov 1 00:09:12.590115 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:09:12.594324 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.595650 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:09:12.598514 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:09:12.600508 systemd[1]: Starting modprobe@loop.service... Nov 1 00:09:12.601399 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.601581 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). Nov 1 00:09:12.601723 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:09:12.603062 systemd[1]: Finished systemd-journal-catalog-update.service. Nov 1 00:09:12.603000 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' Nov 1 00:09:12.604770 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:09:12.604907 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:09:12.605000 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' Nov 1 00:09:12.605000 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' Nov 1 00:09:12.606351 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:09:12.606573 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:09:12.607000 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' Nov 1 00:09:12.607000 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' Nov 1 00:09:12.608039 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:09:12.608269 systemd[1]: Finished modprobe@loop.service. Nov 1 00:09:12.609000 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' Nov 1 00:09:12.609000 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' Nov 1 00:09:12.609912 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:09:12.610800 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.612070 systemd[1]: Starting systemd-update-done.service... Nov 1 00:09:12.613850 systemd[1]: Finished systemd-update-utmp.service. Nov 1 00:09:12.614000 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' Nov 1 00:09:12.616976 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.618288 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:09:12.620377 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:09:12.622370 systemd[1]: Starting modprobe@loop.service... Nov 1 00:09:12.623329 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.623481 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). Nov 1 00:09:12.623593 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:09:12.624523 systemd[1]: Finished systemd-update-done.service. Nov 1 00:09:12.625000 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' Nov 1 00:09:12.625902 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:09:12.626036 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:09:12.626000 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' Nov 1 00:09:12.626000 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' Nov 1 00:09:12.627423 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:09:12.627578 systemd[1]: Finished modprobe@loop.service. Nov 1 00:09:12.628000 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' Nov 1 00:09:12.628000 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' Nov 1 00:09:12.631769 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.633120 systemd[1]: Starting modprobe@drm.service... Nov 1 00:09:12.635855 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:09:12.637945 systemd[1]: Starting modprobe@loop.service... Nov 1 00:09:12.638845 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.638999 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). Nov 1 00:09:12.640314 systemd[1]: Starting systemd-networkd-wait-online.service... Nov 1 00:09:12.641495 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:09:12.642477 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:09:12.642659 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:09:12.643000 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' Nov 1 00:09:12.643000 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' Nov 1 00:09:12.644749 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 00:09:12.644892 systemd[1]: Finished modprobe@drm.service. Nov 1 00:09:12.645000 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' Nov 1 00:09:12.646000 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' Nov 1 00:09:12.646759 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:09:12.646897 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:09:12.647000 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' Nov 1 00:09:12.647000 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' Nov 1 00:09:12.648317 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:09:12.648489 systemd[1]: Finished modprobe@loop.service. Nov 1 00:09:12.648000 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' Nov 1 00:09:12.649000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 1 00:09:12.649000 audit[1269]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffe72fa030 a2=420 a3=0 items=0 ppid=1231 pid=1269 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) Nov 1 00:09:12.649000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Nov 1 00:09:12.649000 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' Nov 1 00:09:12.649707 augenrules[1269]: No rules Nov 1 00:09:12.649923 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:09:12.650012 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.651053 systemd[1]: Finished ensure-sysext.service. Nov 1 00:09:12.652484 systemd[1]: Finished audit-rules.service. Nov 1 00:09:12.653828 systemd[1]: Started systemd-timesyncd.service. Nov 1 00:09:12.654959 systemd-timesyncd[1242]: Contacted time server 10.0.0.1:123 (10.0.0.1). Nov 1 00:09:12.655014 systemd-timesyncd[1242]: Initial clock synchronization to Sat 2025-11-01 00:09:12.395122 UTC. Nov 1 00:09:12.655124 systemd[1]: Reached target time-set.target. Nov 1 00:09:12.661380 systemd-resolved[1241]: Positive Trust Anchors: Nov 1 00:09:12.661664 systemd-resolved[1241]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:09:12.661741 systemd-resolved[1241]: 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 Nov 1 00:09:12.670239 systemd-resolved[1241]: Defaulting to hostname 'linux'. Nov 1 00:09:12.671894 systemd[1]: Started systemd-resolved.service. Nov 1 00:09:12.672891 systemd[1]: Reached target network.target. Nov 1 00:09:12.673711 systemd[1]: Reached target nss-lookup.target. Nov 1 00:09:12.674535 systemd[1]: Reached target sysinit.target. Nov 1 00:09:12.675425 systemd[1]: Started motdgen.path. Nov 1 00:09:12.676302 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Nov 1 00:09:12.677678 systemd[1]: Started logrotate.timer. Nov 1 00:09:12.678544 systemd[1]: Started mdadm.timer. Nov 1 00:09:12.679250 systemd[1]: Started systemd-tmpfiles-clean.timer. Nov 1 00:09:12.680224 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 1 00:09:12.680268 systemd[1]: Reached target paths.target. Nov 1 00:09:12.681098 systemd[1]: Reached target timers.target. Nov 1 00:09:12.682253 systemd[1]: Listening on dbus.socket. Nov 1 00:09:12.684144 systemd[1]: Starting docker.socket... Nov 1 00:09:12.685906 systemd[1]: Listening on sshd.socket. Nov 1 00:09:12.686910 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). Nov 1 00:09:12.687220 systemd[1]: Listening on docker.socket. Nov 1 00:09:12.688107 systemd[1]: Reached target sockets.target. Nov 1 00:09:12.688978 systemd[1]: Reached target basic.target. Nov 1 00:09:12.689941 systemd[1]: System is tainted: cgroupsv1 Nov 1 00:09:12.689991 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.690013 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:09:12.691037 systemd[1]: Starting containerd.service... Nov 1 00:09:12.692893 systemd[1]: Starting dbus.service... Nov 1 00:09:12.694651 systemd[1]: Starting enable-oem-cloudinit.service... Nov 1 00:09:12.696640 systemd[1]: Starting extend-filesystems.service... Nov 1 00:09:12.697726 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Nov 1 00:09:12.699836 jq[1291]: false Nov 1 00:09:12.698803 systemd[1]: Starting motdgen.service... Nov 1 00:09:12.701042 systemd[1]: Starting ssh-key-proc-cmdline.service... Nov 1 00:09:12.703339 systemd[1]: Starting sshd-keygen.service... Nov 1 00:09:12.706100 systemd[1]: Starting systemd-logind.service... Nov 1 00:09:12.707112 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Nov 1 00:09:12.707177 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 1 00:09:12.708480 systemd[1]: Starting update-engine.service... Nov 1 00:09:12.710504 systemd[1]: Starting update-ssh-keys-after-ignition.service... Nov 1 00:09:12.715023 jq[1305]: true Nov 1 00:09:12.713045 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 1 00:09:12.713310 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Nov 1 00:09:12.713611 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 1 00:09:12.713801 systemd[1]: Finished ssh-key-proc-cmdline.service. Nov 1 00:09:12.719507 extend-filesystems[1292]: Found loop1 Nov 1 00:09:12.719507 extend-filesystems[1292]: Found vda Nov 1 00:09:12.719507 extend-filesystems[1292]: Found vda1 Nov 1 00:09:12.719507 extend-filesystems[1292]: Found vda2 Nov 1 00:09:12.719507 extend-filesystems[1292]: Found vda3 Nov 1 00:09:12.722939 systemd[1]: Started dbus.service. Nov 1 00:09:12.738571 extend-filesystems[1292]: Found usr Nov 1 00:09:12.738571 extend-filesystems[1292]: Found vda4 Nov 1 00:09:12.738571 extend-filesystems[1292]: Found vda6 Nov 1 00:09:12.738571 extend-filesystems[1292]: Found vda7 Nov 1 00:09:12.738571 extend-filesystems[1292]: Found vda9 Nov 1 00:09:12.738571 extend-filesystems[1292]: Checking size of /dev/vda9 Nov 1 00:09:12.722779 dbus-daemon[1290]: [system] SELinux support is enabled Nov 1 00:09:12.749386 jq[1312]: true Nov 1 00:09:12.728254 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). Nov 1 00:09:12.728290 systemd[1]: Reached target system-config.target. Nov 1 00:09:12.729368 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 1 00:09:12.729383 systemd[1]: Reached target user-config.target. Nov 1 00:09:12.760994 systemd[1]: motdgen.service: Deactivated successfully. Nov 1 00:09:12.761230 systemd[1]: Finished motdgen.service. Nov 1 00:09:12.766964 extend-filesystems[1292]: Resized partition /dev/vda9 Nov 1 00:09:12.776545 bash[1341]: Updated "/home/core/.ssh/authorized_keys" Nov 1 00:09:12.777236 systemd[1]: Finished update-ssh-keys-after-ignition.service. Nov 1 00:09:12.779082 extend-filesystems[1344]: resize2fs 1.46.5 (30-Dec-2021) Nov 1 00:09:12.785363 systemd-logind[1299]: Watching system buttons on /dev/input/event0 (Power Button) Nov 1 00:09:12.786029 update_engine[1302]: I1101 00:09:12.783324 1302 main.cc:92] Flatcar Update Engine starting Nov 1 00:09:12.786562 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Nov 1 00:09:12.786828 systemd-logind[1299]: New seat seat0. Nov 1 00:09:12.788283 systemd[1]: Started systemd-logind.service. Nov 1 00:09:12.795117 systemd[1]: Started update-engine.service. Nov 1 00:09:12.795568 update_engine[1302]: I1101 00:09:12.795384 1302 update_check_scheduler.cc:74] Next update check in 5m18s Nov 1 00:09:12.798113 systemd[1]: Started locksmithd.service. Nov 1 00:09:12.806330 env[1316]: time="2025-11-01T00:09:12.806277640Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Nov 1 00:09:12.807450 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Nov 1 00:09:12.818540 extend-filesystems[1344]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Nov 1 00:09:12.818540 extend-filesystems[1344]: old_desc_blocks = 1, new_desc_blocks = 1 Nov 1 00:09:12.818540 extend-filesystems[1344]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Nov 1 00:09:12.823333 extend-filesystems[1292]: Resized filesystem in /dev/vda9 Nov 1 00:09:12.819360 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 1 00:09:12.819631 systemd[1]: Finished extend-filesystems.service. Nov 1 00:09:12.829834 env[1316]: time="2025-11-01T00:09:12.829789200Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 1 00:09:12.830074 env[1316]: time="2025-11-01T00:09:12.830053520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.831403 env[1316]: time="2025-11-01T00:09:12.831368360Z" 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.192-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 1 00:09:12.831533 env[1316]: time="2025-11-01T00:09:12.831516800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.831850 env[1316]: time="2025-11-01T00:09:12.831824520Z" 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 Nov 1 00:09:12.831929 env[1316]: time="2025-11-01T00:09:12.831914400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.831997 env[1316]: time="2025-11-01T00:09:12.831982240Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 1 00:09:12.832051 env[1316]: time="2025-11-01T00:09:12.832038560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.832204 env[1316]: time="2025-11-01T00:09:12.832185800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.832601 env[1316]: time="2025-11-01T00:09:12.832577680Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:09:12.832852 env[1316]: time="2025-11-01T00:09:12.832828120Z" 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 Nov 1 00:09:12.832929 env[1316]: time="2025-11-01T00:09:12.832914160Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 1 00:09:12.833061 env[1316]: time="2025-11-01T00:09:12.833040120Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 1 00:09:12.833130 env[1316]: time="2025-11-01T00:09:12.833115160Z" level=info msg="metadata content store policy set" policy=shared Nov 1 00:09:12.836483 env[1316]: time="2025-11-01T00:09:12.836410200Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 1 00:09:12.836483 env[1316]: time="2025-11-01T00:09:12.836472040Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 1 00:09:12.836483 env[1316]: time="2025-11-01T00:09:12.836486320Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 1 00:09:12.836661 env[1316]: time="2025-11-01T00:09:12.836519520Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836661 env[1316]: time="2025-11-01T00:09:12.836536640Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836661 env[1316]: time="2025-11-01T00:09:12.836551240Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836661 env[1316]: time="2025-11-01T00:09:12.836563360Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836918 env[1316]: time="2025-11-01T00:09:12.836899000Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836956 env[1316]: time="2025-11-01T00:09:12.836921360Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836956 env[1316]: time="2025-11-01T00:09:12.836935760Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.836956 env[1316]: time="2025-11-01T00:09:12.836951640Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.837032 env[1316]: time="2025-11-01T00:09:12.836966840Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 1 00:09:12.837114 env[1316]: time="2025-11-01T00:09:12.837099200Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 1 00:09:12.837186 env[1316]: time="2025-11-01T00:09:12.837174160Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 1 00:09:12.837575 env[1316]: time="2025-11-01T00:09:12.837547240Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 1 00:09:12.837610 env[1316]: time="2025-11-01T00:09:12.837593520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837633 env[1316]: time="2025-11-01T00:09:12.837608760Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 1 00:09:12.837734 env[1316]: time="2025-11-01T00:09:12.837721440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837784 env[1316]: time="2025-11-01T00:09:12.837738040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837784 env[1316]: time="2025-11-01T00:09:12.837751560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837784 env[1316]: time="2025-11-01T00:09:12.837764080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837918 env[1316]: time="2025-11-01T00:09:12.837854880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837918 env[1316]: time="2025-11-01T00:09:12.837870640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837918 env[1316]: time="2025-11-01T00:09:12.837882360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837918 env[1316]: time="2025-11-01T00:09:12.837894200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.837918 env[1316]: time="2025-11-01T00:09:12.837908400Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 1 00:09:12.838059 env[1316]: time="2025-11-01T00:09:12.838040000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.838090 env[1316]: time="2025-11-01T00:09:12.838062760Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.838090 env[1316]: time="2025-11-01T00:09:12.838076240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.838090 env[1316]: time="2025-11-01T00:09:12.838087240Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 1 00:09:12.838167 env[1316]: time="2025-11-01T00:09:12.838113800Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Nov 1 00:09:12.838167 env[1316]: time="2025-11-01T00:09:12.838125840Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 1 00:09:12.838167 env[1316]: time="2025-11-01T00:09:12.838143360Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Nov 1 00:09:12.838225 env[1316]: time="2025-11-01T00:09:12.838177720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 1 00:09:12.838473 env[1316]: time="2025-11-01T00:09:12.838385080Z" 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}" Nov 1 00:09:12.838473 env[1316]: time="2025-11-01T00:09:12.838461640Z" level=info msg="Connect containerd service" Nov 1 00:09:12.839099 env[1316]: time="2025-11-01T00:09:12.838493600Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 1 00:09:12.839127 env[1316]: time="2025-11-01T00:09:12.839101560Z" 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" Nov 1 00:09:12.839337 env[1316]: time="2025-11-01T00:09:12.839306800Z" level=info msg="Start subscribing containerd event" Nov 1 00:09:12.839365 env[1316]: time="2025-11-01T00:09:12.839351160Z" level=info msg="Start recovering state" Nov 1 00:09:12.839422 env[1316]: time="2025-11-01T00:09:12.839408960Z" level=info msg="Start event monitor" Nov 1 00:09:12.839471 env[1316]: time="2025-11-01T00:09:12.839442880Z" level=info msg="Start snapshots syncer" Nov 1 00:09:12.839471 env[1316]: time="2025-11-01T00:09:12.839454760Z" level=info msg="Start cni network conf syncer for default" Nov 1 00:09:12.839471 env[1316]: time="2025-11-01T00:09:12.839464560Z" level=info msg="Start streaming server" Nov 1 00:09:12.839532 env[1316]: time="2025-11-01T00:09:12.839472160Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 1 00:09:12.839532 env[1316]: time="2025-11-01T00:09:12.839520640Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 1 00:09:12.839582 env[1316]: time="2025-11-01T00:09:12.839568920Z" level=info msg="containerd successfully booted in 0.034226s" Nov 1 00:09:12.839662 systemd[1]: Started containerd.service. Nov 1 00:09:12.847684 locksmithd[1348]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 1 00:09:13.784539 systemd-networkd[1098]: eth0: Gained IPv6LL Nov 1 00:09:13.786224 systemd[1]: Finished systemd-networkd-wait-online.service. Nov 1 00:09:13.787574 systemd[1]: Reached target network-online.target. Nov 1 00:09:13.790019 systemd[1]: Starting kubelet.service... Nov 1 00:09:14.120743 sshd_keygen[1308]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 1 00:09:14.138871 systemd[1]: Finished sshd-keygen.service. Nov 1 00:09:14.141240 systemd[1]: Starting issuegen.service... Nov 1 00:09:14.146065 systemd[1]: issuegen.service: Deactivated successfully. Nov 1 00:09:14.146278 systemd[1]: Finished issuegen.service. Nov 1 00:09:14.148861 systemd[1]: Starting systemd-user-sessions.service... Nov 1 00:09:14.154915 systemd[1]: Finished systemd-user-sessions.service. Nov 1 00:09:14.157437 systemd[1]: Started getty@tty1.service. Nov 1 00:09:14.159675 systemd[1]: Started serial-getty@ttyAMA0.service. Nov 1 00:09:14.160894 systemd[1]: Reached target getty.target. Nov 1 00:09:14.368263 systemd[1]: Started kubelet.service. Nov 1 00:09:14.369586 systemd[1]: Reached target multi-user.target. Nov 1 00:09:14.371633 systemd[1]: Starting systemd-update-utmp-runlevel.service... Nov 1 00:09:14.377359 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 1 00:09:14.377596 systemd[1]: Finished systemd-update-utmp-runlevel.service. Nov 1 00:09:14.378755 systemd[1]: Startup finished in 4.479s (kernel) + 4.913s (userspace) = 9.393s. Nov 1 00:09:14.738549 kubelet[1384]: E1101 00:09:14.738462 1384 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" Nov 1 00:09:14.740377 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Nov 1 00:09:14.740522 systemd[1]: kubelet.service: Failed with result 'exit-code'. Nov 1 00:09:17.709714 systemd[1]: Created slice system-sshd.slice. Nov 1 00:09:17.711101 systemd[1]: Started sshd@0-10.0.0.27:22-10.0.0.1:36444.service. Nov 1 00:09:17.762445 sshd[1394]: Accepted publickey for core from 10.0.0.1 port 36444 ssh2: RSA SHA256:kb3suJ2QTjzwtL4e8dR0lwVlSg216vRjckn55cG0Sc4 Nov 1 00:09:17.764710 sshd[1394]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:17.774386 systemd-logind[1299]: New session 1 of user core. Nov 1 00:09:17.775235 systemd[1]: Created slice user-500.slice. Nov 1 00:09:17.776250 systemd[1]: Starting user-runtime-dir@500.service... Nov 1 00:09:17.785516 systemd[1]: Finished user-runtime-dir@500.service. Nov 1 00:09:17.786954 systemd[1]: Starting user@500.service... Nov 1 00:09:17.790158 (systemd)[1399]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:17.856079 systemd[1399]: Queued start job for default target default.target. Nov 1 00:09:17.856334 systemd[1399]: Reached target paths.target. Nov 1 00:09:17.856349 systemd[1399]: Reached target sockets.target. Nov 1 00:09:17.856360 systemd[1399]: Reached target timers.target. Nov 1 00:09:17.856370 systemd[1399]: Reached target basic.target. Nov 1 00:09:17.856425 systemd[1399]: Reached target default.target. Nov 1 00:09:17.856468 systemd[1399]: Startup finished in 60ms. Nov 1 00:09:17.856634 systemd[1]: Started user@500.service. Nov 1 00:09:17.858076 systemd[1]: Started session-1.scope. Nov 1 00:09:17.911210 systemd[1]: Started sshd@1-10.0.0.27:22-10.0.0.1:36448.service. Nov 1 00:09:17.953389 sshd[1408]: Accepted publickey for core from 10.0.0.1 port 36448 ssh2: RSA SHA256:kb3suJ2QTjzwtL4e8dR0lwVlSg216vRjckn55cG0Sc4 Nov 1 00:09:17.956222 sshd[1408]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:17.960385 systemd-logind[1299]: New session 2 of user core. Nov 1 00:09:17.961620 systemd[1]: Started session-2.scope. Nov 1 00:09:18.015610 sshd[1408]: pam_unix(sshd:session): session closed for user core Nov 1 00:09:18.017470 systemd[1]: Started sshd@2-10.0.0.27:22-10.0.0.1:36454.service. Nov 1 00:09:18.018494 systemd[1]: sshd@1-10.0.0.27:22-10.0.0.1:36448.service: Deactivated successfully. Nov 1 00:09:18.019466 systemd-logind[1299]: Session 2 logged out. Waiting for processes to exit. Nov 1 00:09:18.019515 systemd[1]: session-2.scope: Deactivated successfully. Nov 1 00:09:18.020526 systemd-logind[1299]: Removed session 2. Nov 1 00:09:18.059556 sshd[1413]: Accepted publickey for core from 10.0.0.1 port 36454 ssh2: RSA SHA256:kb3suJ2QTjzwtL4e8dR0lwVlSg216vRjckn55cG0Sc4 Nov 1 00:09:18.060758 sshd[1413]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:18.064114 systemd-logind[1299]: New session 3 of user core. Nov 1 00:09:18.064895 systemd[1]: Started session-3.scope. Nov 1 00:09:18.114326 sshd[1413]: pam_unix(sshd:session): session closed for user core Nov 1 00:09:18.116826 systemd[1]: Started sshd@3-10.0.0.27:22-10.0.0.1:36464.service. Nov 1 00:09:18.117905 systemd[1]: sshd@2-10.0.0.27:22-10.0.0.1:36454.service: Deactivated successfully. Nov 1 00:09:18.118802 systemd-logind[1299]: Session 3 logged out. Waiting for processes to exit. Nov 1 00:09:18.118864 systemd[1]: session-3.scope: Deactivated successfully. Nov 1 00:09:18.119900 systemd-logind[1299]: Removed session 3. Nov 1 00:09:18.162700 sshd[1420]: Accepted publickey for core from 10.0.0.1 port 36464 ssh2: RSA SHA256:kb3suJ2QTjzwtL4e8dR0lwVlSg216vRjckn55cG0Sc4 Nov 1 00:09:18.163951 sshd[1420]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:18.167861 systemd-logind[1299]: New session 4 of user core. Nov 1 00:09:18.168653 systemd[1]: Started session-4.scope. Nov 1 00:09:18.223187 sshd[1420]: pam_unix(sshd:session): session closed for user core Nov 1 00:09:18.225610 systemd[1]: Started sshd@4-10.0.0.27:22-10.0.0.1:36480.service. Nov 1 00:09:18.226045 systemd[1]: sshd@3-10.0.0.27:22-10.0.0.1:36464.service: Deactivated successfully. Nov 1 00:09:18.227084 systemd[1]: session-4.scope: Deactivated successfully. Nov 1 00:09:18.227109 systemd-logind[1299]: Session 4 logged out. Waiting for processes to exit. Nov 1 00:09:18.228283 systemd-logind[1299]: Removed session 4. Nov 1 00:09:18.270239 sshd[1427]: Accepted publickey for core from 10.0.0.1 port 36480 ssh2: RSA SHA256:kb3suJ2QTjzwtL4e8dR0lwVlSg216vRjckn55cG0Sc4 Nov 1 00:09:18.271608 sshd[1427]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:09:18.275524 systemd-logind[1299]: New session 5 of user core. Nov 1 00:09:18.275991 systemd[1]: Started session-5.scope. Nov 1 00:09:18.335815 sudo[1433]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Nov 1 00:09:18.336035 sudo[1433]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:09:18.348427 systemd[1]: Starting coreos-metadata.service... Nov 1 00:09:18.355381 systemd[1]: coreos-metadata.service: Deactivated successfully. Nov 1 00:09:18.355652 systemd[1]: Finished coreos-metadata.service. Nov 1 00:09:18.793958 systemd[1]: Stopped kubelet.service. Nov 1 00:09:18.797315 systemd[1]: Starting kubelet.service... Nov 1 00:09:18.831837 systemd[1]: Reloading. Nov 1 00:09:18.896593 /usr/lib/systemd/system-generators/torcx-generator[1497]: time="2025-11-01T00:09:18Z" 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]" Nov 1 00:09:18.896621 /usr/lib/systemd/system-generators/torcx-generator[1497]: time="2025-11-01T00:09:18Z" level=info msg="torcx already run" Nov 1 00:09:18.984296 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Nov 1 00:09:18.984315 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Nov 1 00:09:18.999198 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. Nov 1 00:09:19.091961 systemd[1]: Started kubelet.service. Nov 1 00:09:19.095690 systemd[1]: Stopping kubelet.service... Nov 1 00:09:19.097605 systemd[1]: kubelet.service: Deactivated successfully. Nov 1 00:09:19.097838 systemd[1]: Stopped kubelet.service. Nov 1 00:09:19.103895 systemd[1]: Starting kubelet.service... Nov 1 00:09:19.189820 systemd[1]: Started kubelet.service. Nov 1 00:09:19.228549 kubelet[1561]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Nov 1 00:09:19.228549 kubelet[1561]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Nov 1 00:09:19.228549 kubelet[1561]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Nov 1 00:09:19.228906 kubelet[1561]: I1101 00:09:19.228598 1561 server.go:215] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Nov 1 00:09:19.526552 kubelet[1561]: I1101 00:09:19.526443 1561 server.go:520] "Kubelet version" kubeletVersion="v1.32.4" Nov 1 00:09:19.526552 kubelet[1561]: I1101 00:09:19.526479 1561 server.go:522] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Nov 1 00:09:19.527113 kubelet[1561]: I1101 00:09:19.526917 1561 server.go:954] "Client rotation is on, will bootstrap in background" Nov 1 00:09:19.549192 kubelet[1561]: I1101 00:09:19.549149 1561 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Nov 1 00:09:19.559769 kubelet[1561]: E1101 00:09:19.559689 1561 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Nov 1 00:09:19.559769 kubelet[1561]: I1101 00:09:19.559772 1561 server.go:1421] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Nov 1 00:09:19.563112 kubelet[1561]: I1101 00:09:19.562524 1561 server.go:772] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Nov 1 00:09:19.563112 kubelet[1561]: I1101 00:09:19.562884 1561 container_manager_linux.go:268] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Nov 1 00:09:19.563112 kubelet[1561]: I1101 00:09:19.562908 1561 container_manager_linux.go:273] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.27","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":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":1} Nov 1 00:09:19.563297 kubelet[1561]: I1101 00:09:19.563147 1561 topology_manager.go:138] "Creating topology manager with none policy" Nov 1 00:09:19.563297 kubelet[1561]: I1101 00:09:19.563156 1561 container_manager_linux.go:304] "Creating device plugin manager" Nov 1 00:09:19.563344 kubelet[1561]: I1101 00:09:19.563334 1561 state_mem.go:36] "Initialized new in-memory state store" Nov 1 00:09:19.566249 kubelet[1561]: I1101 00:09:19.566151 1561 kubelet.go:446] "Attempting to sync node with API server" Nov 1 00:09:19.566249 kubelet[1561]: I1101 00:09:19.566175 1561 kubelet.go:341] "Adding static pod path" path="/etc/kubernetes/manifests" Nov 1 00:09:19.566249 kubelet[1561]: I1101 00:09:19.566195 1561 kubelet.go:352] "Adding apiserver pod source" Nov 1 00:09:19.566249 kubelet[1561]: I1101 00:09:19.566204 1561 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Nov 1 00:09:19.566658 kubelet[1561]: E1101 00:09:19.566507 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:19.574666 kubelet[1561]: E1101 00:09:19.574625 1561 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:19.588865 kubelet[1561]: I1101 00:09:19.588415 1561 kuberuntime_manager.go:269] "Container runtime initialized" containerRuntime="containerd" version="1.6.16" apiVersion="v1" Nov 1 00:09:19.589216 kubelet[1561]: I1101 00:09:19.589125 1561 kubelet.go:890] "Not starting ClusterTrustBundle informer because we are in static kubelet mode" Nov 1 00:09:19.589405 kubelet[1561]: W1101 00:09:19.589260 1561 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Nov 1 00:09:19.590282 kubelet[1561]: I1101 00:09:19.590203 1561 watchdog_linux.go:99] "Systemd watchdog is not enabled" Nov 1 00:09:19.590282 kubelet[1561]: I1101 00:09:19.590248 1561 server.go:1287] "Started kubelet" Nov 1 00:09:19.590487 kubelet[1561]: I1101 00:09:19.590311 1561 server.go:169] "Starting to listen" address="0.0.0.0" port=10250 Nov 1 00:09:19.591250 kubelet[1561]: I1101 00:09:19.591226 1561 server.go:479] "Adding debug handlers to kubelet server" Nov 1 00:09:19.597628 kernel: SELinux: Context system_u:object_r:container_file_t:s0 is not valid (left unmapped). Nov 1 00:09:19.598175 kubelet[1561]: I1101 00:09:19.598139 1561 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Nov 1 00:09:19.600628 kubelet[1561]: I1101 00:09:19.600569 1561 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Nov 1 00:09:19.600820 kubelet[1561]: I1101 00:09:19.600802 1561 server.go:243] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Nov 1 00:09:19.601977 kubelet[1561]: E1101 00:09:19.601940 1561 kubelet.go:1555] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Nov 1 00:09:19.602516 kubelet[1561]: I1101 00:09:19.602492 1561 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Nov 1 00:09:19.603218 kubelet[1561]: W1101 00:09:19.603192 1561 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope Nov 1 00:09:19.603283 kubelet[1561]: E1101 00:09:19.603235 1561 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User \"system:anonymous\" cannot list resource \"services\" in API group \"\" at the cluster scope" logger="UnhandledError" Nov 1 00:09:19.606520 kubelet[1561]: E1101 00:09:19.606489 1561 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.27\" not found" Nov 1 00:09:19.606590 kubelet[1561]: I1101 00:09:19.606528 1561 volume_manager.go:297] "Starting Kubelet Volume Manager" Nov 1 00:09:19.606991 kubelet[1561]: I1101 00:09:19.606706 1561 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Nov 1 00:09:19.607054 kubelet[1561]: I1101 00:09:19.607018 1561 reconciler.go:26] "Reconciler: start to sync state" Nov 1 00:09:19.608333 kubelet[1561]: I1101 00:09:19.608294 1561 factory.go:221] Registration of the systemd container factory successfully Nov 1 00:09:19.608446 kubelet[1561]: I1101 00:09:19.608406 1561 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Nov 1 00:09:19.611464 kubelet[1561]: I1101 00:09:19.611441 1561 factory.go:221] Registration of the containerd container factory successfully Nov 1 00:09:19.624096 kubelet[1561]: E1101 00:09:19.622087 1561 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.27.1873b96d98541c12 default 0 0001-01-01 00:00:00 +0000 UTC map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.27,UID:10.0.0.27,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.27,},FirstTimestamp:2025-11-01 00:09:19.59021877 +0000 UTC m=+0.396697564,LastTimestamp:2025-11-01 00:09:19.59021877 +0000 UTC m=+0.396697564,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.27,}" Nov 1 00:09:19.629283 kubelet[1561]: W1101 00:09:19.628214 1561 reflector.go:569] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope Nov 1 00:09:19.629283 kubelet[1561]: E1101 00:09:19.628257 1561 reflector.go:166] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User \"system:anonymous\" cannot list resource \"csidrivers\" in API group \"storage.k8s.io\" at the cluster scope" logger="UnhandledError" Nov 1 00:09:19.639934 kubelet[1561]: I1101 00:09:19.639902 1561 cpu_manager.go:221] "Starting CPU manager" policy="none" Nov 1 00:09:19.639934 kubelet[1561]: I1101 00:09:19.639927 1561 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Nov 1 00:09:19.640061 kubelet[1561]: I1101 00:09:19.639947 1561 state_mem.go:36] "Initialized new in-memory state store" Nov 1 00:09:19.640736 kubelet[1561]: E1101 00:09:19.640638 1561 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.27\" not found" node="10.0.0.27" Nov 1 00:09:19.707498 kubelet[1561]: E1101 00:09:19.707462 1561 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.0.0.27\" not found" Nov 1 00:09:19.711557 kubelet[1561]: I1101 00:09:19.711532 1561 policy_none.go:49] "None policy: Start" Nov 1 00:09:19.711557 kubelet[1561]: I1101 00:09:19.711560 1561 memory_manager.go:186] "Starting memorymanager" policy="None" Nov 1 00:09:19.711648 kubelet[1561]: I1101 00:09:19.711573 1561 state_mem.go:35] "Initializing new in-memory state store" Nov 1 00:09:19.718304 kubelet[1561]: I1101 00:09:19.718245 1561 manager.go:519] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Nov 1 00:09:19.718409 kubelet[1561]: I1101 00:09:19.718387 1561 eviction_manager.go:189] "Eviction manager: starting control loop" Nov 1 00:09:19.718491 kubelet[1561]: I1101 00:09:19.718398 1561 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Nov 1 00:09:19.718830 kubelet[1561]: I1101 00:09:19.718800 1561 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Nov 1 00:09:19.719684 kubelet[1561]: E1101 00:09:19.719653 1561 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Nov 1 00:09:19.719684 kubelet[1561]: E1101 00:09:19.719697 1561 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.27\" not found" Nov 1 00:09:19.756688 kubelet[1561]: I1101 00:09:19.756633 1561 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Nov 1 00:09:19.758141 kubelet[1561]: I1101 00:09:19.758117 1561 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Nov 1 00:09:19.758250 kubelet[1561]: I1101 00:09:19.758241 1561 status_manager.go:227] "Starting to sync pod status with apiserver" Nov 1 00:09:19.758464 kubelet[1561]: I1101 00:09:19.758450 1561 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Nov 1 00:09:19.758556 kubelet[1561]: I1101 00:09:19.758545 1561 kubelet.go:2382] "Starting kubelet main sync loop" Nov 1 00:09:19.758677 kubelet[1561]: E1101 00:09:19.758663 1561 kubelet.go:2406] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Nov 1 00:09:19.820146 kubelet[1561]: I1101 00:09:19.820060 1561 kubelet_node_status.go:75] "Attempting to register node" node="10.0.0.27" Nov 1 00:09:19.827188 kubelet[1561]: I1101 00:09:19.827156 1561 kubelet_node_status.go:78] "Successfully registered node" node="10.0.0.27" Nov 1 00:09:19.838770 kubelet[1561]: I1101 00:09:19.838527 1561 kuberuntime_manager.go:1702] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Nov 1 00:09:19.839222 env[1316]: time="2025-11-01T00:09:19.839114272Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Nov 1 00:09:19.840518 kubelet[1561]: I1101 00:09:19.839797 1561 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Nov 1 00:09:20.225545 sudo[1433]: pam_unix(sudo:session): session closed for user root Nov 1 00:09:20.229055 sshd[1427]: pam_unix(sshd:session): session closed for user core Nov 1 00:09:20.231677 systemd[1]: sshd@4-10.0.0.27:22-10.0.0.1:36480.service: Deactivated successfully. Nov 1 00:09:20.233204 systemd[1]: session-5.scope: Deactivated successfully. Nov 1 00:09:20.233219 systemd-logind[1299]: Session 5 logged out. Waiting for processes to exit. Nov 1 00:09:20.234082 systemd-logind[1299]: Removed session 5. Nov 1 00:09:20.528796 kubelet[1561]: I1101 00:09:20.528488 1561 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Nov 1 00:09:20.528796 kubelet[1561]: W1101 00:09:20.528630 1561 reflector.go:492] 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 Nov 1 00:09:20.529120 kubelet[1561]: W1101 00:09:20.528852 1561 reflector.go:492] 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 Nov 1 00:09:20.567033 kubelet[1561]: I1101 00:09:20.567009 1561 apiserver.go:52] "Watching apiserver" Nov 1 00:09:20.567255 kubelet[1561]: E1101 00:09:20.567194 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:20.608136 kubelet[1561]: I1101 00:09:20.608103 1561 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Nov 1 00:09:20.613451 kubelet[1561]: I1101 00:09:20.613411 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/c665b576-e35f-4f36-afbf-c4254c85f217-cni\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.613525 kubelet[1561]: I1101 00:09:20.613455 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/61a8552d-a642-4029-b65b-7b75526d4a2d-xtables-lock\") pod \"kube-proxy-b62dt\" (UID: \"61a8552d-a642-4029-b65b-7b75526d4a2d\") " pod="kube-system/kube-proxy-b62dt" Nov 1 00:09:20.613525 kubelet[1561]: I1101 00:09:20.613473 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/61a8552d-a642-4029-b65b-7b75526d4a2d-kube-proxy\") pod \"kube-proxy-b62dt\" (UID: \"61a8552d-a642-4029-b65b-7b75526d4a2d\") " pod="kube-system/kube-proxy-b62dt" Nov 1 00:09:20.613525 kubelet[1561]: I1101 00:09:20.613490 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/61a8552d-a642-4029-b65b-7b75526d4a2d-lib-modules\") pod \"kube-proxy-b62dt\" (UID: \"61a8552d-a642-4029-b65b-7b75526d4a2d\") " pod="kube-system/kube-proxy-b62dt" Nov 1 00:09:20.613525 kubelet[1561]: I1101 00:09:20.613508 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-xqqsc\" (UniqueName: \"kubernetes.io/projected/61a8552d-a642-4029-b65b-7b75526d4a2d-kube-api-access-xqqsc\") pod \"kube-proxy-b62dt\" (UID: \"61a8552d-a642-4029-b65b-7b75526d4a2d\") " pod="kube-system/kube-proxy-b62dt" Nov 1 00:09:20.613525 kubelet[1561]: I1101 00:09:20.613522 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/c665b576-e35f-4f36-afbf-c4254c85f217-run\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.613661 kubelet[1561]: I1101 00:09:20.613537 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/c665b576-e35f-4f36-afbf-c4254c85f217-cni-plugin\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.613661 kubelet[1561]: I1101 00:09:20.613551 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/c665b576-e35f-4f36-afbf-c4254c85f217-flannel-cfg\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.613661 kubelet[1561]: I1101 00:09:20.613565 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/c665b576-e35f-4f36-afbf-c4254c85f217-xtables-lock\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.613661 kubelet[1561]: I1101 00:09:20.613589 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-twkj2\" (UniqueName: \"kubernetes.io/projected/c665b576-e35f-4f36-afbf-c4254c85f217-kube-api-access-twkj2\") pod \"kube-flannel-ds-4cpps\" (UID: \"c665b576-e35f-4f36-afbf-c4254c85f217\") " pod="kube-flannel/kube-flannel-ds-4cpps" Nov 1 00:09:20.736222 kubelet[1561]: I1101 00:09:20.736187 1561 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" Nov 1 00:09:20.877108 kubelet[1561]: E1101 00:09:20.876602 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:20.877554 env[1316]: time="2025-11-01T00:09:20.877475768Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-b62dt,Uid:61a8552d-a642-4029-b65b-7b75526d4a2d,Namespace:kube-system,Attempt:0,}" Nov 1 00:09:20.878393 kubelet[1561]: E1101 00:09:20.878349 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:20.879326 env[1316]: time="2025-11-01T00:09:20.879238126Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-4cpps,Uid:c665b576-e35f-4f36-afbf-c4254c85f217,Namespace:kube-flannel,Attempt:0,}" Nov 1 00:09:21.472194 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3288395014.mount: Deactivated successfully. Nov 1 00:09:21.481385 env[1316]: time="2025-11-01T00:09:21.481342371Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.482301 env[1316]: time="2025-11-01T00:09:21.482274454Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.484060 env[1316]: time="2025-11-01T00:09:21.484035741Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.486193 env[1316]: time="2025-11-01T00:09:21.486156532Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:7d46a07936af93fcce097459055f93ab07331509aa55f4a2a90d95a3ace1850e,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.488695 env[1316]: time="2025-11-01T00:09:21.488665898Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.490566 env[1316]: time="2025-11-01T00:09:21.490538252Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause:3.6,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.492981 env[1316]: time="2025-11-01T00:09:21.492934139Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.493622 env[1316]: time="2025-11-01T00:09:21.493599037Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/pause@sha256:3d380ca8864549e74af4b29c10f9cb0956236dfb01c40ca076fb6c37253234db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:21.521845 env[1316]: time="2025-11-01T00:09:21.521592225Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:09:21.521845 env[1316]: time="2025-11-01T00:09:21.521628495Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:09:21.521845 env[1316]: time="2025-11-01T00:09:21.521638582Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:09:21.522255 env[1316]: time="2025-11-01T00:09:21.521890776Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/3fcea4026fe4b65882b786fd62c7a985f48c33fcfe4f13dfe5ba46d0d21c2266 pid=1621 runtime=io.containerd.runc.v2 Nov 1 00:09:21.524981 env[1316]: time="2025-11-01T00:09:21.524813123Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:09:21.524981 env[1316]: time="2025-11-01T00:09:21.524848998Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:09:21.524981 env[1316]: time="2025-11-01T00:09:21.524859005Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:09:21.525253 env[1316]: time="2025-11-01T00:09:21.525214474Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0 pid=1633 runtime=io.containerd.runc.v2 Nov 1 00:09:21.568867 kubelet[1561]: E1101 00:09:21.567808 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:21.571822 env[1316]: time="2025-11-01T00:09:21.571785841Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-b62dt,Uid:61a8552d-a642-4029-b65b-7b75526d4a2d,Namespace:kube-system,Attempt:0,} returns sandbox id \"3fcea4026fe4b65882b786fd62c7a985f48c33fcfe4f13dfe5ba46d0d21c2266\"" Nov 1 00:09:21.573347 kubelet[1561]: E1101 00:09:21.573328 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:21.574744 env[1316]: time="2025-11-01T00:09:21.574702848Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\"" Nov 1 00:09:21.585073 env[1316]: time="2025-11-01T00:09:21.585024744Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-4cpps,Uid:c665b576-e35f-4f36-afbf-c4254c85f217,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\"" Nov 1 00:09:21.585710 kubelet[1561]: E1101 00:09:21.585691 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:22.568097 kubelet[1561]: E1101 00:09:22.568047 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:22.641529 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount122739320.mount: Deactivated successfully. Nov 1 00:09:23.101458 env[1316]: time="2025-11-01T00:09:23.101402755Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy:v1.32.9,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:23.103342 env[1316]: time="2025-11-01T00:09:23.103292196Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:72b57ec14d31e8422925ef4c3eff44822cdc04a11fd30d13824f1897d83a16d4,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:23.104764 env[1316]: time="2025-11-01T00:09:23.104740319Z" level=info msg="ImageUpdate event &ImageUpdate{Name:registry.k8s.io/kube-proxy:v1.32.9,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:23.106720 env[1316]: time="2025-11-01T00:09:23.106683298Z" level=info msg="ImageCreate event &ImageCreate{Name:registry.k8s.io/kube-proxy@sha256:886af02535dc34886e4618b902f8c140d89af57233a245621d29642224516064,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:23.107249 env[1316]: time="2025-11-01T00:09:23.107210912Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.32.9\" returns image reference \"sha256:72b57ec14d31e8422925ef4c3eff44822cdc04a11fd30d13824f1897d83a16d4\"" Nov 1 00:09:23.111514 env[1316]: time="2025-11-01T00:09:23.111484849Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Nov 1 00:09:23.114126 env[1316]: time="2025-11-01T00:09:23.114052050Z" level=info msg="CreateContainer within sandbox \"3fcea4026fe4b65882b786fd62c7a985f48c33fcfe4f13dfe5ba46d0d21c2266\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Nov 1 00:09:23.129265 env[1316]: time="2025-11-01T00:09:23.129222146Z" level=info msg="CreateContainer within sandbox \"3fcea4026fe4b65882b786fd62c7a985f48c33fcfe4f13dfe5ba46d0d21c2266\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"49c999490be74cd36610ef635500ff098cef8dfa2ad786e886280083f2b8d877\"" Nov 1 00:09:23.129860 env[1316]: time="2025-11-01T00:09:23.129820312Z" level=info msg="StartContainer for \"49c999490be74cd36610ef635500ff098cef8dfa2ad786e886280083f2b8d877\"" Nov 1 00:09:23.180025 env[1316]: time="2025-11-01T00:09:23.179360955Z" level=info msg="StartContainer for \"49c999490be74cd36610ef635500ff098cef8dfa2ad786e886280083f2b8d877\" returns successfully" Nov 1 00:09:23.569588 kubelet[1561]: E1101 00:09:23.569396 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:23.768571 kubelet[1561]: E1101 00:09:23.768543 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:23.777617 kubelet[1561]: I1101 00:09:23.777545 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-b62dt" podStartSLOduration=3.241097052 podStartE2EDuration="4.777527891s" podCreationTimestamp="2025-11-01 00:09:19 +0000 UTC" firstStartedPulling="2025-11-01 00:09:21.574302802 +0000 UTC m=+2.380781557" lastFinishedPulling="2025-11-01 00:09:23.110733601 +0000 UTC m=+3.917212396" observedRunningTime="2025-11-01 00:09:23.777407846 +0000 UTC m=+4.583886640" watchObservedRunningTime="2025-11-01 00:09:23.777527891 +0000 UTC m=+4.584006726" Nov 1 00:09:24.253746 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount191034364.mount: Deactivated successfully. Nov 1 00:09:24.292408 env[1316]: time="2025-11-01T00:09:24.292360513Z" 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:[],}" Nov 1 00:09:24.294346 env[1316]: time="2025-11-01T00:09:24.294306260Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:24.295636 env[1316]: time="2025-11-01T00:09:24.295610081Z" 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:[],}" Nov 1 00:09:24.297462 env[1316]: time="2025-11-01T00:09:24.297423068Z" 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:[],}" Nov 1 00:09:24.297932 env[1316]: time="2025-11-01T00:09:24.297908611Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"" Nov 1 00:09:24.300155 env[1316]: time="2025-11-01T00:09:24.300127779Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Nov 1 00:09:24.308475 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3334411342.mount: Deactivated successfully. Nov 1 00:09:24.315025 env[1316]: time="2025-11-01T00:09:24.314995335Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"dabf65bfaa43985bbf0907d4dd91d34446cfc046c79bca3c3ff85df730edc68e\"" Nov 1 00:09:24.315675 env[1316]: time="2025-11-01T00:09:24.315651712Z" level=info msg="StartContainer for \"dabf65bfaa43985bbf0907d4dd91d34446cfc046c79bca3c3ff85df730edc68e\"" Nov 1 00:09:24.358500 env[1316]: time="2025-11-01T00:09:24.358460249Z" level=info msg="StartContainer for \"dabf65bfaa43985bbf0907d4dd91d34446cfc046c79bca3c3ff85df730edc68e\" returns successfully" Nov 1 00:09:24.521634 env[1316]: time="2025-11-01T00:09:24.521511225Z" level=info msg="shim disconnected" id=dabf65bfaa43985bbf0907d4dd91d34446cfc046c79bca3c3ff85df730edc68e Nov 1 00:09:24.521634 env[1316]: time="2025-11-01T00:09:24.521561209Z" level=warning msg="cleaning up after shim disconnected" id=dabf65bfaa43985bbf0907d4dd91d34446cfc046c79bca3c3ff85df730edc68e namespace=k8s.io Nov 1 00:09:24.521634 env[1316]: time="2025-11-01T00:09:24.521572047Z" level=info msg="cleaning up dead shim" Nov 1 00:09:24.529131 env[1316]: time="2025-11-01T00:09:24.529095073Z" level=warning msg="cleanup warnings time=\"2025-11-01T00:09:24Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1908 runtime=io.containerd.runc.v2\n" Nov 1 00:09:24.570252 kubelet[1561]: E1101 00:09:24.570205 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:24.771195 kubelet[1561]: E1101 00:09:24.771165 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:24.771842 kubelet[1561]: E1101 00:09:24.771771 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:24.772858 env[1316]: time="2025-11-01T00:09:24.772817647Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Nov 1 00:09:25.175282 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount397984216.mount: Deactivated successfully. Nov 1 00:09:25.570593 kubelet[1561]: E1101 00:09:25.570464 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:25.943147 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1658068676.mount: Deactivated successfully. Nov 1 00:09:26.571375 kubelet[1561]: E1101 00:09:26.571328 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:26.631939 env[1316]: time="2025-11-01T00:09:26.631898153Z" 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:[],}" Nov 1 00:09:26.633748 env[1316]: time="2025-11-01T00:09:26.633724640Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:26.635334 env[1316]: time="2025-11-01T00:09:26.635299854Z" 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:[],}" Nov 1 00:09:26.637808 env[1316]: time="2025-11-01T00:09:26.637783280Z" level=info msg="ImageCreate event &ImageCreate{Name:docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:26.638706 env[1316]: time="2025-11-01T00:09:26.638677653Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"" Nov 1 00:09:26.641277 env[1316]: time="2025-11-01T00:09:26.641228611Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Nov 1 00:09:26.649945 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3645572232.mount: Deactivated successfully. Nov 1 00:09:26.655333 env[1316]: time="2025-11-01T00:09:26.655274011Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c\"" Nov 1 00:09:26.655802 env[1316]: time="2025-11-01T00:09:26.655778507Z" level=info msg="StartContainer for \"5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c\"" Nov 1 00:09:26.707847 env[1316]: time="2025-11-01T00:09:26.707801284Z" level=info msg="StartContainer for \"5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c\" returns successfully" Nov 1 00:09:26.763016 kubelet[1561]: I1101 00:09:26.762978 1561 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Nov 1 00:09:26.776971 kubelet[1561]: E1101 00:09:26.776930 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:26.831933 env[1316]: time="2025-11-01T00:09:26.831822745Z" level=info msg="shim disconnected" id=5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c Nov 1 00:09:26.832095 env[1316]: time="2025-11-01T00:09:26.832075053Z" level=warning msg="cleaning up after shim disconnected" id=5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c namespace=k8s.io Nov 1 00:09:26.832154 env[1316]: time="2025-11-01T00:09:26.832141511Z" level=info msg="cleaning up dead shim" Nov 1 00:09:26.839872 env[1316]: time="2025-11-01T00:09:26.839837814Z" level=warning msg="cleanup warnings time=\"2025-11-01T00:09:26Z\" level=info msg=\"starting signal loop\" namespace=k8s.io pid=1964 runtime=io.containerd.runc.v2\n" Nov 1 00:09:27.571785 kubelet[1561]: E1101 00:09:27.571740 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:27.647961 systemd[1]: run-containerd-runc-k8s.io-5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c-runc.IfeQUK.mount: Deactivated successfully. Nov 1 00:09:27.648098 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-5eae18ba6ee80a951ab5195d4bd668308f6f51143789521b753db9411272c67c-rootfs.mount: Deactivated successfully. Nov 1 00:09:27.779384 kubelet[1561]: E1101 00:09:27.779338 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:27.780765 env[1316]: time="2025-11-01T00:09:27.780728439Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Nov 1 00:09:27.793046 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1291845930.mount: Deactivated successfully. Nov 1 00:09:27.796960 env[1316]: time="2025-11-01T00:09:27.796924571Z" level=info msg="CreateContainer within sandbox \"1c4f9de593dd1f21fa5a4baf17d73c7a33db6e03d9e204b90304758e91b293b0\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"c1b36f27923c762c8071398789e2c89df82b5faa2cf2827cae2fe92f83f369c8\"" Nov 1 00:09:27.797549 env[1316]: time="2025-11-01T00:09:27.797516751Z" level=info msg="StartContainer for \"c1b36f27923c762c8071398789e2c89df82b5faa2cf2827cae2fe92f83f369c8\"" Nov 1 00:09:27.839606 env[1316]: time="2025-11-01T00:09:27.839516824Z" level=info msg="StartContainer for \"c1b36f27923c762c8071398789e2c89df82b5faa2cf2827cae2fe92f83f369c8\" returns successfully" Nov 1 00:09:28.572660 kubelet[1561]: E1101 00:09:28.572610 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:28.783324 kubelet[1561]: E1101 00:09:28.783258 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:28.797382 kubelet[1561]: I1101 00:09:28.797324 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-4cpps" podStartSLOduration=4.743668871 podStartE2EDuration="9.79729948s" podCreationTimestamp="2025-11-01 00:09:19 +0000 UTC" firstStartedPulling="2025-11-01 00:09:21.586293232 +0000 UTC m=+2.392772026" lastFinishedPulling="2025-11-01 00:09:26.63992388 +0000 UTC m=+7.446402635" observedRunningTime="2025-11-01 00:09:28.797249938 +0000 UTC m=+9.603728733" watchObservedRunningTime="2025-11-01 00:09:28.79729948 +0000 UTC m=+9.603778235" Nov 1 00:09:28.900260 systemd-networkd[1098]: flannel.1: Link UP Nov 1 00:09:28.900268 systemd-networkd[1098]: flannel.1: Gained carrier Nov 1 00:09:29.572877 kubelet[1561]: E1101 00:09:29.572836 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:29.785414 kubelet[1561]: E1101 00:09:29.785374 1561 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Nov 1 00:09:30.168549 systemd-networkd[1098]: flannel.1: Gained IPv6LL Nov 1 00:09:30.573871 kubelet[1561]: E1101 00:09:30.573752 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:30.868650 kubelet[1561]: I1101 00:09:30.868531 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-lnw44\" (UniqueName: \"kubernetes.io/projected/f12e6562-3f46-4bc6-be81-be008c23ad92-kube-api-access-lnw44\") pod \"nginx-deployment-7fcdb87857-c794t\" (UID: \"f12e6562-3f46-4bc6-be81-be008c23ad92\") " pod="default/nginx-deployment-7fcdb87857-c794t" Nov 1 00:09:31.170331 env[1316]: time="2025-11-01T00:09:31.170229526Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-c794t,Uid:f12e6562-3f46-4bc6-be81-be008c23ad92,Namespace:default,Attempt:0,}" Nov 1 00:09:31.193510 systemd-networkd[1098]: cni0: Link UP Nov 1 00:09:31.199413 systemd-networkd[1098]: veth9a73f9cb: Link UP Nov 1 00:09:31.201195 kernel: cni0: port 1(veth9a73f9cb) entered blocking state Nov 1 00:09:31.201266 kernel: cni0: port 1(veth9a73f9cb) entered disabled state Nov 1 00:09:31.202118 kernel: device veth9a73f9cb entered promiscuous mode Nov 1 00:09:31.203009 kernel: cni0: port 1(veth9a73f9cb) entered blocking state Nov 1 00:09:31.203050 kernel: cni0: port 1(veth9a73f9cb) entered forwarding state Nov 1 00:09:31.205360 kernel: cni0: port 1(veth9a73f9cb) entered disabled state Nov 1 00:09:31.210834 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth9a73f9cb: link becomes ready Nov 1 00:09:31.210906 kernel: cni0: port 1(veth9a73f9cb) entered blocking state Nov 1 00:09:31.210927 kernel: cni0: port 1(veth9a73f9cb) entered forwarding state Nov 1 00:09:31.211661 systemd-networkd[1098]: veth9a73f9cb: Gained carrier Nov 1 00:09:31.212525 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): cni0: link becomes ready Nov 1 00:09:31.212662 systemd-networkd[1098]: cni0: Gained carrier Nov 1 00:09:31.217158 env[1316]: 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"} Nov 1 00:09:31.217158 env[1316]: delegateAdd: netconf sent to delegate plugin: Nov 1 00:09:31.229412 env[1316]: {"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-11-01T00:09:31.229347970Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:09:31.229574 env[1316]: time="2025-11-01T00:09:31.229395630Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:09:31.229574 env[1316]: time="2025-11-01T00:09:31.229406358Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:09:31.229684 env[1316]: time="2025-11-01T00:09:31.229575859Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/0b2b255046ba566ee8a2bcf2511bb6dff884740419fad0eb8c3a1c0d51cea012 pid=2146 runtime=io.containerd.runc.v2 Nov 1 00:09:31.259723 systemd-resolved[1241]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 00:09:31.280850 env[1316]: time="2025-11-01T00:09:31.280807920Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-c794t,Uid:f12e6562-3f46-4bc6-be81-be008c23ad92,Namespace:default,Attempt:0,} returns sandbox id \"0b2b255046ba566ee8a2bcf2511bb6dff884740419fad0eb8c3a1c0d51cea012\"" Nov 1 00:09:31.282449 env[1316]: time="2025-11-01T00:09:31.282352812Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 1 00:09:31.574195 kubelet[1561]: E1101 00:09:31.574086 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:31.998355 systemd[1]: run-containerd-runc-k8s.io-0b2b255046ba566ee8a2bcf2511bb6dff884740419fad0eb8c3a1c0d51cea012-runc.ovrF2p.mount: Deactivated successfully. Nov 1 00:09:32.345550 systemd-networkd[1098]: cni0: Gained IPv6LL Nov 1 00:09:32.345806 systemd-networkd[1098]: veth9a73f9cb: Gained IPv6LL Nov 1 00:09:32.574387 kubelet[1561]: E1101 00:09:32.574337 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:33.473442 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount39645061.mount: Deactivated successfully. Nov 1 00:09:33.574624 kubelet[1561]: E1101 00:09:33.574576 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:34.575507 kubelet[1561]: E1101 00:09:34.575451 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:34.745010 env[1316]: time="2025-11-01T00:09:34.744964376Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:34.746457 env[1316]: time="2025-11-01T00:09:34.746414758Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:34.748025 env[1316]: time="2025-11-01T00:09:34.747978397Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:34.751282 env[1316]: time="2025-11-01T00:09:34.751243804Z" level=info msg="ImageCreate event &ImageCreate{Name:ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:34.751708 env[1316]: time="2025-11-01T00:09:34.751681262Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\"" Nov 1 00:09:34.754217 env[1316]: time="2025-11-01T00:09:34.754185408Z" level=info msg="CreateContainer within sandbox \"0b2b255046ba566ee8a2bcf2511bb6dff884740419fad0eb8c3a1c0d51cea012\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Nov 1 00:09:34.765217 env[1316]: time="2025-11-01T00:09:34.765165734Z" level=info msg="CreateContainer within sandbox \"0b2b255046ba566ee8a2bcf2511bb6dff884740419fad0eb8c3a1c0d51cea012\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"3d4cbd5aadd90bf814e469f59dd92244a10ab8f1771355f5bbf5b5830cba62bd\"" Nov 1 00:09:34.765708 env[1316]: time="2025-11-01T00:09:34.765637605Z" level=info msg="StartContainer for \"3d4cbd5aadd90bf814e469f59dd92244a10ab8f1771355f5bbf5b5830cba62bd\"" Nov 1 00:09:34.816484 env[1316]: time="2025-11-01T00:09:34.816412366Z" level=info msg="StartContainer for \"3d4cbd5aadd90bf814e469f59dd92244a10ab8f1771355f5bbf5b5830cba62bd\" returns successfully" Nov 1 00:09:35.575905 kubelet[1561]: E1101 00:09:35.575855 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:36.576232 kubelet[1561]: E1101 00:09:36.576175 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:37.173554 kubelet[1561]: I1101 00:09:37.173484 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-c794t" podStartSLOduration=3.702359107 podStartE2EDuration="7.173466498s" podCreationTimestamp="2025-11-01 00:09:30 +0000 UTC" firstStartedPulling="2025-11-01 00:09:31.281824327 +0000 UTC m=+12.088303122" lastFinishedPulling="2025-11-01 00:09:34.752931718 +0000 UTC m=+15.559410513" observedRunningTime="2025-11-01 00:09:35.808000314 +0000 UTC m=+16.614479149" watchObservedRunningTime="2025-11-01 00:09:37.173466498 +0000 UTC m=+17.979945293" Nov 1 00:09:37.202030 kubelet[1561]: I1101 00:09:37.201977 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-pqtq2\" (UniqueName: \"kubernetes.io/projected/5d06f209-cbbb-4ca8-b870-ba3212f37c2a-kube-api-access-pqtq2\") pod \"nfs-server-provisioner-0\" (UID: \"5d06f209-cbbb-4ca8-b870-ba3212f37c2a\") " pod="default/nfs-server-provisioner-0" Nov 1 00:09:37.202030 kubelet[1561]: I1101 00:09:37.202030 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/5d06f209-cbbb-4ca8-b870-ba3212f37c2a-data\") pod \"nfs-server-provisioner-0\" (UID: \"5d06f209-cbbb-4ca8-b870-ba3212f37c2a\") " pod="default/nfs-server-provisioner-0" Nov 1 00:09:37.476493 env[1316]: time="2025-11-01T00:09:37.476357011Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:5d06f209-cbbb-4ca8-b870-ba3212f37c2a,Namespace:default,Attempt:0,}" Nov 1 00:09:37.502355 systemd-networkd[1098]: veth26df962c: Link UP Nov 1 00:09:37.505233 kernel: cni0: port 2(veth26df962c) entered blocking state Nov 1 00:09:37.505420 kernel: cni0: port 2(veth26df962c) entered disabled state Nov 1 00:09:37.506517 kernel: device veth26df962c entered promiscuous mode Nov 1 00:09:37.516120 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 1 00:09:37.516235 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth26df962c: link becomes ready Nov 1 00:09:37.516280 kernel: cni0: port 2(veth26df962c) entered blocking state Nov 1 00:09:37.516303 kernel: cni0: port 2(veth26df962c) entered forwarding state Nov 1 00:09:37.517090 systemd-networkd[1098]: veth26df962c: Gained carrier Nov 1 00:09:37.519662 env[1316]: 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)(0x4000020928), "name":"cbr0", "type":"bridge"} Nov 1 00:09:37.519662 env[1316]: delegateAdd: netconf sent to delegate plugin: Nov 1 00:09:37.541143 env[1316]: {"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-11-01T00:09:37.540948013Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:09:37.541143 env[1316]: time="2025-11-01T00:09:37.540987960Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:09:37.541143 env[1316]: time="2025-11-01T00:09:37.540998067Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:09:37.541458 env[1316]: time="2025-11-01T00:09:37.541395822Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/159ae68670166e1d4d67d939d12cc391c9812bd2c7a40610f18f1375dfdc987f pid=2317 runtime=io.containerd.runc.v2 Nov 1 00:09:37.574287 systemd-resolved[1241]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 00:09:37.576544 kubelet[1561]: E1101 00:09:37.576475 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:37.590948 env[1316]: time="2025-11-01T00:09:37.590905197Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:5d06f209-cbbb-4ca8-b870-ba3212f37c2a,Namespace:default,Attempt:0,} returns sandbox id \"159ae68670166e1d4d67d939d12cc391c9812bd2c7a40610f18f1375dfdc987f\"" Nov 1 00:09:37.592054 env[1316]: time="2025-11-01T00:09:37.592021085Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Nov 1 00:09:38.576973 kubelet[1561]: E1101 00:09:38.576920 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:38.808612 systemd-networkd[1098]: veth26df962c: Gained IPv6LL Nov 1 00:09:39.567198 kubelet[1561]: E1101 00:09:39.567153 1561 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:39.577737 kubelet[1561]: E1101 00:09:39.577718 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:39.946480 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4044906183.mount: Deactivated successfully. Nov 1 00:09:40.578040 kubelet[1561]: E1101 00:09:40.577987 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:41.578448 kubelet[1561]: E1101 00:09:41.578367 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:41.676209 env[1316]: time="2025-11-01T00:09:41.676155271Z" 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:[],}" Nov 1 00:09:41.677496 env[1316]: time="2025-11-01T00:09:41.677470375Z" level=info msg="ImageCreate event &ImageCreate{Name:sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:41.678993 env[1316]: time="2025-11-01T00:09:41.678968098Z" 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:[],}" Nov 1 00:09:41.680792 env[1316]: time="2025-11-01T00:09:41.680764070Z" 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:[],}" Nov 1 00:09:41.682283 env[1316]: time="2025-11-01T00:09:41.682241528Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"" Nov 1 00:09:41.685278 env[1316]: time="2025-11-01T00:09:41.685243768Z" level=info msg="CreateContainer within sandbox \"159ae68670166e1d4d67d939d12cc391c9812bd2c7a40610f18f1375dfdc987f\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Nov 1 00:09:41.698859 env[1316]: time="2025-11-01T00:09:41.698809924Z" level=info msg="CreateContainer within sandbox \"159ae68670166e1d4d67d939d12cc391c9812bd2c7a40610f18f1375dfdc987f\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"b32b678e19f4cc59ee2ff5de1c34fa20fa4447491ba90410b7fd9c38b8037ac0\"" Nov 1 00:09:41.699385 env[1316]: time="2025-11-01T00:09:41.699359060Z" level=info msg="StartContainer for \"b32b678e19f4cc59ee2ff5de1c34fa20fa4447491ba90410b7fd9c38b8037ac0\"" Nov 1 00:09:41.747507 env[1316]: time="2025-11-01T00:09:41.747463846Z" level=info msg="StartContainer for \"b32b678e19f4cc59ee2ff5de1c34fa20fa4447491ba90410b7fd9c38b8037ac0\" returns successfully" Nov 1 00:09:42.579332 kubelet[1561]: E1101 00:09:42.579282 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:43.579444 kubelet[1561]: E1101 00:09:43.579380 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:44.580368 kubelet[1561]: E1101 00:09:44.580326 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:45.581540 kubelet[1561]: E1101 00:09:45.581486 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:46.582210 kubelet[1561]: E1101 00:09:46.582173 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:47.583458 kubelet[1561]: E1101 00:09:47.583393 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:48.584955 kubelet[1561]: E1101 00:09:48.584867 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:49.585982 kubelet[1561]: E1101 00:09:49.585943 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:50.587023 kubelet[1561]: E1101 00:09:50.586978 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:51.588013 kubelet[1561]: E1101 00:09:51.587962 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:51.656891 kubelet[1561]: I1101 00:09:51.656772 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=10.564673838000001 podStartE2EDuration="14.656754586s" podCreationTimestamp="2025-11-01 00:09:37 +0000 UTC" firstStartedPulling="2025-11-01 00:09:37.591841841 +0000 UTC m=+18.398320596" lastFinishedPulling="2025-11-01 00:09:41.683922549 +0000 UTC m=+22.490401344" observedRunningTime="2025-11-01 00:09:41.822066954 +0000 UTC m=+22.628545789" watchObservedRunningTime="2025-11-01 00:09:51.656754586 +0000 UTC m=+32.463233381" Nov 1 00:09:51.778060 kubelet[1561]: I1101 00:09:51.778029 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rhsvl\" (UniqueName: \"kubernetes.io/projected/353b9cba-be44-4b4c-9772-54d81bea8d1a-kube-api-access-rhsvl\") pod \"test-pod-1\" (UID: \"353b9cba-be44-4b4c-9772-54d81bea8d1a\") " pod="default/test-pod-1" Nov 1 00:09:51.778205 kubelet[1561]: I1101 00:09:51.778066 1561 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-2e9b46c7-5441-4a4c-8da1-f981d0cad32e\" (UniqueName: \"kubernetes.io/nfs/353b9cba-be44-4b4c-9772-54d81bea8d1a-pvc-2e9b46c7-5441-4a4c-8da1-f981d0cad32e\") pod \"test-pod-1\" (UID: \"353b9cba-be44-4b4c-9772-54d81bea8d1a\") " pod="default/test-pod-1" Nov 1 00:09:51.897503 kernel: FS-Cache: Loaded Nov 1 00:09:51.924903 kernel: RPC: Registered named UNIX socket transport module. Nov 1 00:09:51.925013 kernel: RPC: Registered udp transport module. Nov 1 00:09:51.925037 kernel: RPC: Registered tcp transport module. Nov 1 00:09:51.926447 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Nov 1 00:09:51.967460 kernel: FS-Cache: Netfs 'nfs' registered for caching Nov 1 00:09:52.095824 kernel: NFS: Registering the id_resolver key type Nov 1 00:09:52.095947 kernel: Key type id_resolver registered Nov 1 00:09:52.095971 kernel: Key type id_legacy registered Nov 1 00:09:52.117906 nfsidmap[2496]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 1 00:09:52.120637 nfsidmap[2499]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Nov 1 00:09:52.260937 env[1316]: time="2025-11-01T00:09:52.260816515Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:353b9cba-be44-4b4c-9772-54d81bea8d1a,Namespace:default,Attempt:0,}" Nov 1 00:09:52.286741 systemd-networkd[1098]: veth5cca2e78: Link UP Nov 1 00:09:52.290103 kernel: cni0: port 3(veth5cca2e78) entered blocking state Nov 1 00:09:52.290174 kernel: cni0: port 3(veth5cca2e78) entered disabled state Nov 1 00:09:52.291480 kernel: device veth5cca2e78 entered promiscuous mode Nov 1 00:09:52.296630 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 1 00:09:52.296712 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth5cca2e78: link becomes ready Nov 1 00:09:52.296743 kernel: cni0: port 3(veth5cca2e78) entered blocking state Nov 1 00:09:52.298056 kernel: cni0: port 3(veth5cca2e78) entered forwarding state Nov 1 00:09:52.298154 systemd-networkd[1098]: veth5cca2e78: Gained carrier Nov 1 00:09:52.299881 env[1316]: map[string]interface {}{"cniVersion":"0.3.1", "hairpinMode":true, "ipMasq":false, "ipam":map[string]interface {}{"ranges":[][]map[string]interface {}{[]map[string]interface {}{map[string]interface {}{"subnet":"192.168.1.0/24"}}}, "routes":[]types.Route{types.Route{Dst:net.IPNet{IP:net.IP{0xc0, 0xa8, 0x0, 0x0}, Mask:net.IPMask{0xff, 0xff, 0x80, 0x0}}, GW:net.IP(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0x400001c928), "name":"cbr0", "type":"bridge"} Nov 1 00:09:52.299881 env[1316]: delegateAdd: netconf sent to delegate plugin: Nov 1 00:09:52.312453 env[1316]: {"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-11-01T00:09:52.312263720Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:09:52.312453 env[1316]: time="2025-11-01T00:09:52.312304602Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:09:52.312453 env[1316]: time="2025-11-01T00:09:52.312315003Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:09:52.312614 env[1316]: time="2025-11-01T00:09:52.312483173Z" level=info msg="starting signal loop" namespace=k8s.io path=/run/containerd/io.containerd.runtime.v2.task/k8s.io/b4e06a9607a1f3fb87d43833994570ff5f0d4e160f02764cf44f1111acbc6a30 pid=2551 runtime=io.containerd.runc.v2 Nov 1 00:09:52.337450 systemd-resolved[1241]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Nov 1 00:09:52.354061 env[1316]: time="2025-11-01T00:09:52.354022055Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:353b9cba-be44-4b4c-9772-54d81bea8d1a,Namespace:default,Attempt:0,} returns sandbox id \"b4e06a9607a1f3fb87d43833994570ff5f0d4e160f02764cf44f1111acbc6a30\"" Nov 1 00:09:52.355303 env[1316]: time="2025-11-01T00:09:52.355182686Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Nov 1 00:09:52.589487 kubelet[1561]: E1101 00:09:52.588899 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:52.607715 env[1316]: time="2025-11-01T00:09:52.607649857Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:52.609172 env[1316]: time="2025-11-01T00:09:52.609147308Z" level=info msg="ImageUpdate event &ImageUpdate{Name:sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:52.610763 env[1316]: time="2025-11-01T00:09:52.610729644Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx:latest,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:52.612538 env[1316]: time="2025-11-01T00:09:52.612512633Z" level=info msg="ImageUpdate event &ImageUpdate{Name:ghcr.io/flatcar/nginx@sha256:0537df20ac7c5485a0f6b7bfb8e3fbbc8714fce070bab2a6344e5cadfba58d90,Labels:map[string]string{io.cri-containerd.image: managed,},XXX_unrecognized:[],}" Nov 1 00:09:52.613324 env[1316]: time="2025-11-01T00:09:52.613295840Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:93a0bb2334812af7cad47dff33d3bbc1ced8774dea82e727e7d8cb917ca9a024\"" Nov 1 00:09:52.615405 env[1316]: time="2025-11-01T00:09:52.615372926Z" level=info msg="CreateContainer within sandbox \"b4e06a9607a1f3fb87d43833994570ff5f0d4e160f02764cf44f1111acbc6a30\" for container &ContainerMetadata{Name:test,Attempt:0,}" Nov 1 00:09:52.649361 env[1316]: time="2025-11-01T00:09:52.649301627Z" level=info msg="CreateContainer within sandbox \"b4e06a9607a1f3fb87d43833994570ff5f0d4e160f02764cf44f1111acbc6a30\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"5554381bf52b9958b4d05849e5ac6683513f34d37254411117ed22d447b5847d\"" Nov 1 00:09:52.649868 env[1316]: time="2025-11-01T00:09:52.649810338Z" level=info msg="StartContainer for \"5554381bf52b9958b4d05849e5ac6683513f34d37254411117ed22d447b5847d\"" Nov 1 00:09:52.696378 env[1316]: time="2025-11-01T00:09:52.696332203Z" level=info msg="StartContainer for \"5554381bf52b9958b4d05849e5ac6683513f34d37254411117ed22d447b5847d\" returns successfully" Nov 1 00:09:52.842407 kubelet[1561]: I1101 00:09:52.842048 1561 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=15.582644299 podStartE2EDuration="15.842031011s" podCreationTimestamp="2025-11-01 00:09:37 +0000 UTC" firstStartedPulling="2025-11-01 00:09:52.354885228 +0000 UTC m=+33.161364023" lastFinishedPulling="2025-11-01 00:09:52.61427194 +0000 UTC m=+33.420750735" observedRunningTime="2025-11-01 00:09:52.840782375 +0000 UTC m=+33.647261130" watchObservedRunningTime="2025-11-01 00:09:52.842031011 +0000 UTC m=+33.648509806" Nov 1 00:09:53.589622 kubelet[1561]: E1101 00:09:53.589581 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Nov 1 00:09:54.104578 systemd-networkd[1098]: veth5cca2e78: Gained IPv6LL Nov 1 00:09:54.590468 kubelet[1561]: E1101 00:09:54.590347 1561 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"