May 12 23:42:42.921541 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
May 12 23:42:42.921562 kernel: Linux version 6.6.89-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Mon May 12 22:21:23 -00 2025
May 12 23:42:42.921572 kernel: KASLR enabled
May 12 23:42:42.921578 kernel: efi: EFI v2.7 by EDK II
May 12 23:42:42.921583 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbbf018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40d98 
May 12 23:42:42.921589 kernel: random: crng init done
May 12 23:42:42.921596 kernel: secureboot: Secure boot disabled
May 12 23:42:42.921601 kernel: ACPI: Early table checksum verification disabled
May 12 23:42:42.921607 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS )
May 12 23:42:42.921615 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS  BXPC     00000001      01000013)
May 12 23:42:42.921621 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921627 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921632 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921638 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921646 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921654 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921661 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921667 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921674 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS  BXPC     00000001 BXPC 00000001)
May 12 23:42:42.921680 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600
May 12 23:42:42.921686 kernel: NUMA: Failed to initialise from firmware
May 12 23:42:42.921693 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff]
May 12 23:42:42.921699 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff]
May 12 23:42:42.921724 kernel: Zone ranges:
May 12 23:42:42.921731 kernel:   DMA      [mem 0x0000000040000000-0x00000000dcffffff]
May 12 23:42:42.921738 kernel:   DMA32    empty
May 12 23:42:42.921744 kernel:   Normal   empty
May 12 23:42:42.921750 kernel: Movable zone start for each node
May 12 23:42:42.921757 kernel: Early memory node ranges
May 12 23:42:42.921763 kernel:   node   0: [mem 0x0000000040000000-0x00000000d976ffff]
May 12 23:42:42.921769 kernel:   node   0: [mem 0x00000000d9770000-0x00000000d9b3ffff]
May 12 23:42:42.921775 kernel:   node   0: [mem 0x00000000d9b40000-0x00000000dce1ffff]
May 12 23:42:42.921781 kernel:   node   0: [mem 0x00000000dce20000-0x00000000dceaffff]
May 12 23:42:42.921787 kernel:   node   0: [mem 0x00000000dceb0000-0x00000000dcebffff]
May 12 23:42:42.921793 kernel:   node   0: [mem 0x00000000dcec0000-0x00000000dcfdffff]
May 12 23:42:42.921799 kernel:   node   0: [mem 0x00000000dcfe0000-0x00000000dcffffff]
May 12 23:42:42.921806 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff]
May 12 23:42:42.921813 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges
May 12 23:42:42.921820 kernel: psci: probing for conduit method from ACPI.
May 12 23:42:42.921826 kernel: psci: PSCIv1.1 detected in firmware.
May 12 23:42:42.921835 kernel: psci: Using standard PSCI v0.2 function IDs
May 12 23:42:42.921841 kernel: psci: Trusted OS migration not required
May 12 23:42:42.921848 kernel: psci: SMC Calling Convention v1.1
May 12 23:42:42.921857 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
May 12 23:42:42.921864 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976
May 12 23:42:42.921870 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096
May 12 23:42:42.921877 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
May 12 23:42:42.921884 kernel: Detected PIPT I-cache on CPU0
May 12 23:42:42.921890 kernel: CPU features: detected: GIC system register CPU interface
May 12 23:42:42.921897 kernel: CPU features: detected: Hardware dirty bit management
May 12 23:42:42.921904 kernel: CPU features: detected: Spectre-v4
May 12 23:42:42.921911 kernel: CPU features: detected: Spectre-BHB
May 12 23:42:42.921917 kernel: CPU features: kernel page table isolation forced ON by KASLR
May 12 23:42:42.921925 kernel: CPU features: detected: Kernel page table isolation (KPTI)
May 12 23:42:42.921932 kernel: CPU features: detected: ARM erratum 1418040
May 12 23:42:42.921939 kernel: CPU features: detected: SSBS not fully self-synchronizing
May 12 23:42:42.921946 kernel: alternatives: applying boot alternatives
May 12 23:42:42.921954 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=e3fb02dca379a9c7f05d94ae800dbbcafb80c81ea68c8486d0613b136c5c38d4
May 12 23:42:42.921961 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
May 12 23:42:42.921967 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
May 12 23:42:42.921974 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
May 12 23:42:42.921981 kernel: Fallback order for Node 0: 0 
May 12 23:42:42.921988 kernel: Built 1 zonelists, mobility grouping on.  Total pages: 633024
May 12 23:42:42.921994 kernel: Policy zone: DMA
May 12 23:42:42.922002 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
May 12 23:42:42.922009 kernel: software IO TLB: area num 4.
May 12 23:42:42.922015 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB)
May 12 23:42:42.922022 kernel: Memory: 2386256K/2572288K available (10240K kernel code, 2186K rwdata, 8104K rodata, 39744K init, 897K bss, 186032K reserved, 0K cma-reserved)
May 12 23:42:42.922029 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
May 12 23:42:42.922036 kernel: rcu: Preemptible hierarchical RCU implementation.
May 12 23:42:42.922043 kernel: rcu:         RCU event tracing is enabled.
May 12 23:42:42.922050 kernel: rcu:         RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
May 12 23:42:42.922057 kernel:         Trampoline variant of Tasks RCU enabled.
May 12 23:42:42.922063 kernel:         Tracing variant of Tasks RCU enabled.
May 12 23:42:42.922070 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
May 12 23:42:42.922076 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
May 12 23:42:42.922084 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
May 12 23:42:42.922091 kernel: GICv3: 256 SPIs implemented
May 12 23:42:42.922097 kernel: GICv3: 0 Extended SPIs implemented
May 12 23:42:42.922104 kernel: Root IRQ handler: gic_handle_irq
May 12 23:42:42.922111 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI
May 12 23:42:42.922117 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
May 12 23:42:42.922124 kernel: ITS [mem 0x08080000-0x0809ffff]
May 12 23:42:42.922130 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1)
May 12 23:42:42.922137 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1)
May 12 23:42:42.922144 kernel: GICv3: using LPI property table @0x00000000400f0000
May 12 23:42:42.922150 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000
May 12 23:42:42.922158 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
May 12 23:42:42.922165 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
May 12 23:42:42.922172 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
May 12 23:42:42.922179 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
May 12 23:42:42.922185 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
May 12 23:42:42.922192 kernel: arm-pv: using stolen time PV
May 12 23:42:42.922199 kernel: Console: colour dummy device 80x25
May 12 23:42:42.922206 kernel: ACPI: Core revision 20230628
May 12 23:42:42.922213 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
May 12 23:42:42.922220 kernel: pid_max: default: 32768 minimum: 301
May 12 23:42:42.922228 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
May 12 23:42:42.922235 kernel: landlock: Up and running.
May 12 23:42:42.922241 kernel: SELinux:  Initializing.
May 12 23:42:42.922271 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 12 23:42:42.922278 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
May 12 23:42:42.922285 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3)
May 12 23:42:42.922292 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 12 23:42:42.922299 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
May 12 23:42:42.922306 kernel: rcu: Hierarchical SRCU implementation.
May 12 23:42:42.922315 kernel: rcu:         Max phase no-delay instances is 400.
May 12 23:42:42.922322 kernel: Platform MSI: ITS@0x8080000 domain created
May 12 23:42:42.922329 kernel: PCI/MSI: ITS@0x8080000 domain created
May 12 23:42:42.922335 kernel: Remapping and enabling EFI services.
May 12 23:42:42.922342 kernel: smp: Bringing up secondary CPUs ...
May 12 23:42:42.922349 kernel: Detected PIPT I-cache on CPU1
May 12 23:42:42.922356 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
May 12 23:42:42.922363 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000
May 12 23:42:42.922370 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
May 12 23:42:42.922376 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
May 12 23:42:42.922385 kernel: Detected PIPT I-cache on CPU2
May 12 23:42:42.922392 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000
May 12 23:42:42.922403 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000
May 12 23:42:42.922412 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
May 12 23:42:42.922419 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1]
May 12 23:42:42.922426 kernel: Detected PIPT I-cache on CPU3
May 12 23:42:42.922433 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000
May 12 23:42:42.922440 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000
May 12 23:42:42.922448 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
May 12 23:42:42.922455 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1]
May 12 23:42:42.922463 kernel: smp: Brought up 1 node, 4 CPUs
May 12 23:42:42.922470 kernel: SMP: Total of 4 processors activated.
May 12 23:42:42.922477 kernel: CPU features: detected: 32-bit EL0 Support
May 12 23:42:42.922484 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
May 12 23:42:42.922492 kernel: CPU features: detected: Common not Private translations
May 12 23:42:42.922500 kernel: CPU features: detected: CRC32 instructions
May 12 23:42:42.922507 kernel: CPU features: detected: Enhanced Virtualization Traps
May 12 23:42:42.922516 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
May 12 23:42:42.922523 kernel: CPU features: detected: LSE atomic instructions
May 12 23:42:42.922530 kernel: CPU features: detected: Privileged Access Never
May 12 23:42:42.922537 kernel: CPU features: detected: RAS Extension Support
May 12 23:42:42.922544 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS)
May 12 23:42:42.922552 kernel: CPU: All CPU(s) started at EL1
May 12 23:42:42.922559 kernel: alternatives: applying system-wide alternatives
May 12 23:42:42.922566 kernel: devtmpfs: initialized
May 12 23:42:42.922573 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
May 12 23:42:42.922582 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
May 12 23:42:42.922589 kernel: pinctrl core: initialized pinctrl subsystem
May 12 23:42:42.922596 kernel: SMBIOS 3.0.0 present.
May 12 23:42:42.922603 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022
May 12 23:42:42.922610 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
May 12 23:42:42.922618 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
May 12 23:42:42.922625 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
May 12 23:42:42.922632 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
May 12 23:42:42.922639 kernel: audit: initializing netlink subsys (disabled)
May 12 23:42:42.922649 kernel: audit: type=2000 audit(0.018:1): state=initialized audit_enabled=0 res=1
May 12 23:42:42.922656 kernel: thermal_sys: Registered thermal governor 'step_wise'
May 12 23:42:42.922663 kernel: cpuidle: using governor menu
May 12 23:42:42.922670 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
May 12 23:42:42.922677 kernel: ASID allocator initialised with 32768 entries
May 12 23:42:42.922685 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 12 23:42:42.922692 kernel: Serial: AMBA PL011 UART driver
May 12 23:42:42.922699 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
May 12 23:42:42.922706 kernel: Modules: 0 pages in range for non-PLT usage
May 12 23:42:42.922715 kernel: Modules: 508944 pages in range for PLT usage
May 12 23:42:42.922727 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
May 12 23:42:42.922734 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
May 12 23:42:42.922742 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
May 12 23:42:42.922749 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
May 12 23:42:42.922756 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
May 12 23:42:42.922764 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
May 12 23:42:42.922771 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
May 12 23:42:42.922778 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
May 12 23:42:42.922787 kernel: ACPI: Added _OSI(Module Device)
May 12 23:42:42.922794 kernel: ACPI: Added _OSI(Processor Device)
May 12 23:42:42.922802 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
May 12 23:42:42.922809 kernel: ACPI: Added _OSI(Processor Aggregator Device)
May 12 23:42:42.922816 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
May 12 23:42:42.922823 kernel: ACPI: Interpreter enabled
May 12 23:42:42.922831 kernel: ACPI: Using GIC for interrupt routing
May 12 23:42:42.922838 kernel: ACPI: MCFG table detected, 1 entries
May 12 23:42:42.922845 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA
May 12 23:42:42.922853 kernel: printk: console [ttyAMA0] enabled
May 12 23:42:42.922861 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 12 23:42:42.922991 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
May 12 23:42:42.923063 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR]
May 12 23:42:42.923127 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
May 12 23:42:42.923188 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00
May 12 23:42:42.923258 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
May 12 23:42:42.923272 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io  0x0000-0xffff window]
May 12 23:42:42.923279 kernel: PCI host bridge to bus 0000:00
May 12 23:42:42.923355 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]
May 12 23:42:42.923413 kernel: pci_bus 0000:00: root bus resource [io  0x0000-0xffff window]
May 12 23:42:42.923473 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]
May 12 23:42:42.923528 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
May 12 23:42:42.923605 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000
May 12 23:42:42.923680 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00
May 12 23:42:42.923761 kernel: pci 0000:00:01.0: reg 0x10: [io  0x0000-0x001f]
May 12 23:42:42.923827 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff]
May 12 23:42:42.923890 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref]
May 12 23:42:42.923955 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref]
May 12 23:42:42.924019 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff]
May 12 23:42:42.924082 kernel: pci 0000:00:01.0: BAR 0: assigned [io  0x1000-0x101f]
May 12 23:42:42.924144 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]
May 12 23:42:42.924202 kernel: pci_bus 0000:00: resource 5 [io  0x0000-0xffff window]
May 12 23:42:42.924286 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]
May 12 23:42:42.924297 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35
May 12 23:42:42.924304 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36
May 12 23:42:42.924312 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37
May 12 23:42:42.924319 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38
May 12 23:42:42.924326 kernel: iommu: Default domain type: Translated
May 12 23:42:42.924336 kernel: iommu: DMA domain TLB invalidation policy: strict mode
May 12 23:42:42.924343 kernel: efivars: Registered efivars operations
May 12 23:42:42.924350 kernel: vgaarb: loaded
May 12 23:42:42.924357 kernel: clocksource: Switched to clocksource arch_sys_counter
May 12 23:42:42.924365 kernel: VFS: Disk quotas dquot_6.6.0
May 12 23:42:42.924372 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 12 23:42:42.924379 kernel: pnp: PnP ACPI init
May 12 23:42:42.924458 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved
May 12 23:42:42.924470 kernel: pnp: PnP ACPI: found 1 devices
May 12 23:42:42.924477 kernel: NET: Registered PF_INET protocol family
May 12 23:42:42.924485 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
May 12 23:42:42.924492 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
May 12 23:42:42.924499 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
May 12 23:42:42.924507 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
May 12 23:42:42.924514 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
May 12 23:42:42.924522 kernel: TCP: Hash tables configured (established 32768 bind 32768)
May 12 23:42:42.924529 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 12 23:42:42.924538 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
May 12 23:42:42.924545 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
May 12 23:42:42.924552 kernel: PCI: CLS 0 bytes, default 64
May 12 23:42:42.924560 kernel: kvm [1]: HYP mode not available
May 12 23:42:42.924567 kernel: Initialise system trusted keyrings
May 12 23:42:42.924574 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
May 12 23:42:42.924582 kernel: Key type asymmetric registered
May 12 23:42:42.924589 kernel: Asymmetric key parser 'x509' registered
May 12 23:42:42.924597 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
May 12 23:42:42.924606 kernel: io scheduler mq-deadline registered
May 12 23:42:42.924613 kernel: io scheduler kyber registered
May 12 23:42:42.924621 kernel: io scheduler bfq registered
May 12 23:42:42.924628 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
May 12 23:42:42.924636 kernel: ACPI: button: Power Button [PWRB]
May 12 23:42:42.924643 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36
May 12 23:42:42.924715 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007)
May 12 23:42:42.924731 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
May 12 23:42:42.924739 kernel: thunder_xcv, ver 1.0
May 12 23:42:42.924748 kernel: thunder_bgx, ver 1.0
May 12 23:42:42.924755 kernel: nicpf, ver 1.0
May 12 23:42:42.924763 kernel: nicvf, ver 1.0
May 12 23:42:42.924842 kernel: rtc-efi rtc-efi.0: registered as rtc0
May 12 23:42:42.924913 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-12T23:42:42 UTC (1747093362)
May 12 23:42:42.924923 kernel: hid: raw HID events driver (C) Jiri Kosina
May 12 23:42:42.924930 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available
May 12 23:42:42.924940 kernel: watchdog: Delayed init of the lockup detector failed: -19
May 12 23:42:42.924950 kernel: watchdog: Hard watchdog permanently disabled
May 12 23:42:42.924958 kernel: NET: Registered PF_INET6 protocol family
May 12 23:42:42.924966 kernel: Segment Routing with IPv6
May 12 23:42:42.924976 kernel: In-situ OAM (IOAM) with IPv6
May 12 23:42:42.924986 kernel: NET: Registered PF_PACKET protocol family
May 12 23:42:42.924997 kernel: Key type dns_resolver registered
May 12 23:42:42.925006 kernel: registered taskstats version 1
May 12 23:42:42.925013 kernel: Loading compiled-in X.509 certificates
May 12 23:42:42.925021 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.89-flatcar: f172f0fb4eac06c214e4b9ce0f39d6c4075ccc9a'
May 12 23:42:42.925030 kernel: Key type .fscrypt registered
May 12 23:42:42.925037 kernel: Key type fscrypt-provisioning registered
May 12 23:42:42.925045 kernel: ima: No TPM chip found, activating TPM-bypass!
May 12 23:42:42.925053 kernel: ima: Allocated hash algorithm: sha1
May 12 23:42:42.925060 kernel: ima: No architecture policies found
May 12 23:42:42.925068 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
May 12 23:42:42.925076 kernel: clk: Disabling unused clocks
May 12 23:42:42.925083 kernel: Freeing unused kernel memory: 39744K
May 12 23:42:42.925090 kernel: Run /init as init process
May 12 23:42:42.925099 kernel:   with arguments:
May 12 23:42:42.925107 kernel:     /init
May 12 23:42:42.925114 kernel:   with environment:
May 12 23:42:42.925122 kernel:     HOME=/
May 12 23:42:42.925130 kernel:     TERM=linux
May 12 23:42:42.925137 kernel:     BOOT_IMAGE=/flatcar/vmlinuz-a
May 12 23:42:42.925146 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
May 12 23:42:42.925155 systemd[1]: Detected virtualization kvm.
May 12 23:42:42.925165 systemd[1]: Detected architecture arm64.
May 12 23:42:42.925172 systemd[1]: Running in initrd.
May 12 23:42:42.925180 systemd[1]: No hostname configured, using default hostname.
May 12 23:42:42.925187 systemd[1]: Hostname set to <localhost>.
May 12 23:42:42.925195 systemd[1]: Initializing machine ID from VM UUID.
May 12 23:42:42.925202 systemd[1]: Queued start job for default target initrd.target.
May 12 23:42:42.925210 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 12 23:42:42.925218 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 12 23:42:42.925227 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
May 12 23:42:42.925235 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 12 23:42:42.925243 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
May 12 23:42:42.925267 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
May 12 23:42:42.925277 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
May 12 23:42:42.925285 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
May 12 23:42:42.925295 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 12 23:42:42.925303 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 12 23:42:42.925310 systemd[1]: Reached target paths.target - Path Units.
May 12 23:42:42.925318 systemd[1]: Reached target slices.target - Slice Units.
May 12 23:42:42.925326 systemd[1]: Reached target swap.target - Swaps.
May 12 23:42:42.925333 systemd[1]: Reached target timers.target - Timer Units.
May 12 23:42:42.925341 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
May 12 23:42:42.925349 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 12 23:42:42.925356 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
May 12 23:42:42.925365 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
May 12 23:42:42.925373 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 12 23:42:42.925381 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 12 23:42:42.925389 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 12 23:42:42.925397 systemd[1]: Reached target sockets.target - Socket Units.
May 12 23:42:42.925405 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
May 12 23:42:42.925412 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 12 23:42:42.925420 systemd[1]: Finished network-cleanup.service - Network Cleanup.
May 12 23:42:42.925428 systemd[1]: Starting systemd-fsck-usr.service...
May 12 23:42:42.925438 systemd[1]: Starting systemd-journald.service - Journal Service...
May 12 23:42:42.925446 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 12 23:42:42.925454 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 12 23:42:42.925462 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
May 12 23:42:42.925469 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 12 23:42:42.925543 systemd[1]: Finished systemd-fsck-usr.service.
May 12 23:42:42.925559 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 12 23:42:42.925567 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 12 23:42:42.925575 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 12 23:42:42.925602 systemd-journald[240]: Collecting audit messages is disabled.
May 12 23:42:42.925623 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 12 23:42:42.925632 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
May 12 23:42:42.925640 systemd-journald[240]: Journal started
May 12 23:42:42.925659 systemd-journald[240]: Runtime Journal (/run/log/journal/2dafd75b45754541854f63215c575498) is 5.9M, max 47.3M, 41.4M free.
May 12 23:42:42.914028 systemd-modules-load[241]: Inserted module 'overlay'
May 12 23:42:42.928099 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 12 23:42:42.930294 kernel: Bridge firewalling registered
May 12 23:42:42.930325 systemd[1]: Started systemd-journald.service - Journal Service.
May 12 23:42:42.929562 systemd-modules-load[241]: Inserted module 'br_netfilter'
May 12 23:42:42.931493 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 12 23:42:42.934263 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 12 23:42:42.939206 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
May 12 23:42:42.940855 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 12 23:42:42.943409 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 12 23:42:42.944802 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 12 23:42:42.955524 dracut-cmdline[266]: dracut-dracut-053
May 12 23:42:42.955747 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 12 23:42:42.957812 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 12 23:42:42.961285 dracut-cmdline[266]: 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=e3fb02dca379a9c7f05d94ae800dbbcafb80c81ea68c8486d0613b136c5c38d4
May 12 23:42:42.967467 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 12 23:42:42.993489 systemd-resolved[289]: Positive Trust Anchors:
May 12 23:42:42.993575 systemd-resolved[289]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 12 23:42:42.993607 systemd-resolved[289]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 12 23:42:42.998435 systemd-resolved[289]: Defaulting to hostname 'linux'.
May 12 23:42:42.999379 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 12 23:42:43.003490 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 12 23:42:43.041308 kernel: SCSI subsystem initialized
May 12 23:42:43.044268 kernel: Loading iSCSI transport class v2.0-870.
May 12 23:42:43.051298 kernel: iscsi: registered transport (tcp)
May 12 23:42:43.064525 kernel: iscsi: registered transport (qla4xxx)
May 12 23:42:43.064571 kernel: QLogic iSCSI HBA Driver
May 12 23:42:43.109328 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
May 12 23:42:43.120469 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
May 12 23:42:43.137277 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
May 12 23:42:43.137351 kernel: device-mapper: uevent: version 1.0.3
May 12 23:42:43.137363 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
May 12 23:42:43.183287 kernel: raid6: neonx8   gen() 15572 MB/s
May 12 23:42:43.200265 kernel: raid6: neonx4   gen() 15291 MB/s
May 12 23:42:43.219745 kernel: raid6: neonx2   gen()  9590 MB/s
May 12 23:42:43.234287 kernel: raid6: neonx1   gen()  9243 MB/s
May 12 23:42:43.251275 kernel: raid6: int64x8  gen()  6455 MB/s
May 12 23:42:43.268262 kernel: raid6: int64x4  gen()  7334 MB/s
May 12 23:42:43.285265 kernel: raid6: int64x2  gen()  6125 MB/s
May 12 23:42:43.302332 kernel: raid6: int64x1  gen()  5034 MB/s
May 12 23:42:43.302366 kernel: raid6: using algorithm neonx8 gen() 15572 MB/s
May 12 23:42:43.320267 kernel: raid6: .... xor() 11926 MB/s, rmw enabled
May 12 23:42:43.320289 kernel: raid6: using neon recovery algorithm
May 12 23:42:43.326276 kernel: xor: measuring software checksum speed
May 12 23:42:43.326311 kernel:    8regs           : 19773 MB/sec
May 12 23:42:43.326320 kernel:    32regs          : 18251 MB/sec
May 12 23:42:43.327704 kernel:    arm64_neon      : 26255 MB/sec
May 12 23:42:43.327722 kernel: xor: using function: arm64_neon (26255 MB/sec)
May 12 23:42:43.382295 kernel: Btrfs loaded, zoned=no, fsverity=no
May 12 23:42:43.395742 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
May 12 23:42:43.410482 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 12 23:42:43.424291 systemd-udevd[460]: Using default interface naming scheme 'v255'.
May 12 23:42:43.427587 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 12 23:42:43.437446 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
May 12 23:42:43.448874 dracut-pre-trigger[468]: rd.md=0: removing MD RAID activation
May 12 23:42:43.476950 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
May 12 23:42:43.490464 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 12 23:42:43.533206 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 12 23:42:43.544441 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
May 12 23:42:43.557116 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
May 12 23:42:43.559169 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
May 12 23:42:43.561558 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 12 23:42:43.563754 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 12 23:42:43.573658 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
May 12 23:42:43.584430 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
May 12 23:42:43.586681 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues
May 12 23:42:43.587834 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB)
May 12 23:42:43.598680 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 12 23:42:43.601472 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
May 12 23:42:43.601496 kernel: GPT:9289727 != 19775487
May 12 23:42:43.601513 kernel: GPT:Alternate GPT header not at the end of the disk.
May 12 23:42:43.601524 kernel: GPT:9289727 != 19775487
May 12 23:42:43.601533 kernel: GPT: Use GNU Parted to correct GPT errors.
May 12 23:42:43.601541 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 12 23:42:43.598807 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 12 23:42:43.604927 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 12 23:42:43.606111 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 12 23:42:43.606376 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 12 23:42:43.608335 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
May 12 23:42:43.620109 kernel: BTRFS: device fsid 8bc7e2dd-1c9f-4f38-9a4f-4a4a9806cb3a devid 1 transid 42 /dev/vda3 scanned by (udev-worker) (512)
May 12 23:42:43.620157 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (520)
May 12 23:42:43.619580 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 12 23:42:43.630963 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 12 23:42:43.636301 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
May 12 23:42:43.643941 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
May 12 23:42:43.647855 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
May 12 23:42:43.649131 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
May 12 23:42:43.655888 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 12 23:42:43.666424 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
May 12 23:42:43.671448 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
May 12 23:42:43.674407 disk-uuid[548]: Primary Header is updated.
May 12 23:42:43.674407 disk-uuid[548]: Secondary Entries is updated.
May 12 23:42:43.674407 disk-uuid[548]: Secondary Header is updated.
May 12 23:42:43.684275 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 12 23:42:43.698419 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 12 23:42:44.701283 kernel:  vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
May 12 23:42:44.702953 disk-uuid[549]: The operation has completed successfully.
May 12 23:42:44.740444 systemd[1]: disk-uuid.service: Deactivated successfully.
May 12 23:42:44.740553 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
May 12 23:42:44.760486 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
May 12 23:42:44.769053 sh[569]: Success
May 12 23:42:44.792275 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
May 12 23:42:44.827867 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
May 12 23:42:44.840158 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
May 12 23:42:44.842867 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
May 12 23:42:44.853283 kernel: BTRFS info (device dm-0): first mount of filesystem 8bc7e2dd-1c9f-4f38-9a4f-4a4a9806cb3a
May 12 23:42:44.853329 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm
May 12 23:42:44.854943 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
May 12 23:42:44.854961 kernel: BTRFS info (device dm-0): disabling log replay at mount time
May 12 23:42:44.856230 kernel: BTRFS info (device dm-0): using free space tree
May 12 23:42:44.860195 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
May 12 23:42:44.861768 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
May 12 23:42:44.871437 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
May 12 23:42:44.873008 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
May 12 23:42:44.882077 kernel: BTRFS info (device vda6): first mount of filesystem f5ecb074-2ad7-499c-bb35-c3ab71cda02a
May 12 23:42:44.882139 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
May 12 23:42:44.882154 kernel: BTRFS info (device vda6): using free space tree
May 12 23:42:44.885277 kernel: BTRFS info (device vda6): auto enabling async discard
May 12 23:42:44.893011 systemd[1]: mnt-oem.mount: Deactivated successfully.
May 12 23:42:44.894183 kernel: BTRFS info (device vda6): last unmount of filesystem f5ecb074-2ad7-499c-bb35-c3ab71cda02a
May 12 23:42:44.900259 systemd[1]: Finished ignition-setup.service - Ignition (setup).
May 12 23:42:44.906547 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
May 12 23:42:44.983163 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 12 23:42:44.995485 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 12 23:42:45.023976 ignition[660]: Ignition 2.20.0
May 12 23:42:45.023988 ignition[660]: Stage: fetch-offline
May 12 23:42:45.024028 ignition[660]: no configs at "/usr/lib/ignition/base.d"
May 12 23:42:45.024036 ignition[660]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:45.024276 ignition[660]: parsed url from cmdline: ""
May 12 23:42:45.024280 ignition[660]: no config URL provided
May 12 23:42:45.024285 ignition[660]: reading system config file "/usr/lib/ignition/user.ign"
May 12 23:42:45.024292 ignition[660]: no config at "/usr/lib/ignition/user.ign"
May 12 23:42:45.024321 ignition[660]: op(1): [started]  loading QEMU firmware config module
May 12 23:42:45.024326 ignition[660]: op(1): executing: "modprobe" "qemu_fw_cfg"
May 12 23:42:45.031024 systemd-networkd[762]: lo: Link UP
May 12 23:42:45.031029 systemd-networkd[762]: lo: Gained carrier
May 12 23:42:45.031851 systemd-networkd[762]: Enumeration completed
May 12 23:42:45.032426 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 12 23:42:45.032749 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 12 23:42:45.032752 systemd-networkd[762]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 12 23:42:45.034147 systemd-networkd[762]: eth0: Link UP
May 12 23:42:45.034150 systemd-networkd[762]: eth0: Gained carrier
May 12 23:42:45.034158 systemd-networkd[762]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 12 23:42:45.034223 systemd[1]: Reached target network.target - Network.
May 12 23:42:45.050220 ignition[660]: op(1): [finished] loading QEMU firmware config module
May 12 23:42:45.056643 ignition[660]: parsing config with SHA512: e457be0beaa5511a3064d74f906af9c3b9a42c6b1534313444cbbb36fa30004dcee2841e963c0c8735f5d98db65e01ee5a49d5769deb8a8e5c33469d85d65ab7
May 12 23:42:45.059301 systemd-networkd[762]: eth0: DHCPv4 address 10.0.0.33/16, gateway 10.0.0.1 acquired from 10.0.0.1
May 12 23:42:45.060169 unknown[660]: fetched base config from "system"
May 12 23:42:45.060176 unknown[660]: fetched user config from "qemu"
May 12 23:42:45.060506 ignition[660]: fetch-offline: fetch-offline passed
May 12 23:42:45.060593 ignition[660]: Ignition finished successfully
May 12 23:42:45.062781 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
May 12 23:42:45.064485 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json).
May 12 23:42:45.080525 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
May 12 23:42:45.092273 ignition[771]: Ignition 2.20.0
May 12 23:42:45.092287 ignition[771]: Stage: kargs
May 12 23:42:45.092465 ignition[771]: no configs at "/usr/lib/ignition/base.d"
May 12 23:42:45.092474 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:45.096067 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
May 12 23:42:45.093218 ignition[771]: kargs: kargs passed
May 12 23:42:45.093292 ignition[771]: Ignition finished successfully
May 12 23:42:45.108493 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
May 12 23:42:45.120043 ignition[781]: Ignition 2.20.0
May 12 23:42:45.120054 ignition[781]: Stage: disks
May 12 23:42:45.120234 ignition[781]: no configs at "/usr/lib/ignition/base.d"
May 12 23:42:45.120244 ignition[781]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:45.123064 systemd[1]: Finished ignition-disks.service - Ignition (disks).
May 12 23:42:45.120999 ignition[781]: disks: disks passed
May 12 23:42:45.124295 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
May 12 23:42:45.121045 ignition[781]: Ignition finished successfully
May 12 23:42:45.125955 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
May 12 23:42:45.127809 systemd[1]: Reached target local-fs.target - Local File Systems.
May 12 23:42:45.129177 systemd[1]: Reached target sysinit.target - System Initialization.
May 12 23:42:45.131083 systemd[1]: Reached target basic.target - Basic System.
May 12 23:42:45.141414 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
May 12 23:42:45.152837 systemd-fsck[791]: ROOT: clean, 14/553520 files, 52654/553472 blocks
May 12 23:42:45.156571 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
May 12 23:42:45.158655 systemd[1]: Mounting sysroot.mount - /sysroot...
May 12 23:42:45.205039 systemd[1]: Mounted sysroot.mount - /sysroot.
May 12 23:42:45.206513 kernel: EXT4-fs (vda9): mounted filesystem 267e1a87-2243-4e28-a518-ba9876b017ec r/w with ordered data mode. Quota mode: none.
May 12 23:42:45.206183 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
May 12 23:42:45.224363 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 12 23:42:45.226055 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
May 12 23:42:45.227293 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
May 12 23:42:45.227336 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
May 12 23:42:45.234629 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (799)
May 12 23:42:45.227359 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
May 12 23:42:45.235216 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
May 12 23:42:45.239658 kernel: BTRFS info (device vda6): first mount of filesystem f5ecb074-2ad7-499c-bb35-c3ab71cda02a
May 12 23:42:45.239682 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
May 12 23:42:45.239692 kernel: BTRFS info (device vda6): using free space tree
May 12 23:42:45.239644 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
May 12 23:42:45.242850 kernel: BTRFS info (device vda6): auto enabling async discard
May 12 23:42:45.244651 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 12 23:42:45.295735 initrd-setup-root[825]: cut: /sysroot/etc/passwd: No such file or directory
May 12 23:42:45.302721 initrd-setup-root[832]: cut: /sysroot/etc/group: No such file or directory
May 12 23:42:45.309610 initrd-setup-root[839]: cut: /sysroot/etc/shadow: No such file or directory
May 12 23:42:45.316450 initrd-setup-root[846]: cut: /sysroot/etc/gshadow: No such file or directory
May 12 23:42:45.417422 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
May 12 23:42:45.426448 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
May 12 23:42:45.428127 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
May 12 23:42:45.434300 kernel: BTRFS info (device vda6): last unmount of filesystem f5ecb074-2ad7-499c-bb35-c3ab71cda02a
May 12 23:42:45.455847 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
May 12 23:42:45.458469 ignition[915]: INFO     : Ignition 2.20.0
May 12 23:42:45.458469 ignition[915]: INFO     : Stage: mount
May 12 23:42:45.459731 ignition[915]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 12 23:42:45.459731 ignition[915]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:45.459731 ignition[915]: INFO     : mount: mount passed
May 12 23:42:45.459731 ignition[915]: INFO     : Ignition finished successfully
May 12 23:42:45.462297 systemd[1]: Finished ignition-mount.service - Ignition (mount).
May 12 23:42:45.468407 systemd[1]: Starting ignition-files.service - Ignition (files)...
May 12 23:42:45.854523 systemd[1]: sysroot-oem.mount: Deactivated successfully.
May 12 23:42:45.872518 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
May 12 23:42:45.882042 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (928)
May 12 23:42:45.882080 kernel: BTRFS info (device vda6): first mount of filesystem f5ecb074-2ad7-499c-bb35-c3ab71cda02a
May 12 23:42:45.882828 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
May 12 23:42:45.882843 kernel: BTRFS info (device vda6): using free space tree
May 12 23:42:45.885264 kernel: BTRFS info (device vda6): auto enabling async discard
May 12 23:42:45.887872 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
May 12 23:42:45.905023 ignition[945]: INFO     : Ignition 2.20.0
May 12 23:42:45.905023 ignition[945]: INFO     : Stage: files
May 12 23:42:45.906390 ignition[945]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 12 23:42:45.906390 ignition[945]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:45.906390 ignition[945]: DEBUG    : files: compiled without relabeling support, skipping
May 12 23:42:45.909067 ignition[945]: INFO     : files: ensureUsers: op(1): [started]  creating or modifying user "core"
May 12 23:42:45.909067 ignition[945]: DEBUG    : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
May 12 23:42:45.909067 ignition[945]: INFO     : files: ensureUsers: op(1): [finished] creating or modifying user "core"
May 12 23:42:45.912236 ignition[945]: INFO     : files: ensureUsers: op(2): [started]  adding ssh keys to user "core"
May 12 23:42:45.912236 ignition[945]: INFO     : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [started]  writing file "/sysroot/home/core/install.sh"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(4): [started]  writing file "/sysroot/etc/flatcar/update.conf"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(5): [started]  writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.0-arm64.raw"
May 12 23:42:45.912236 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.31.0-arm64.raw"
May 12 23:42:45.910541 unknown[945]: wrote ssh authorized keys file for user: core
May 12 23:42:45.928352 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(6): [started]  writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.0-arm64.raw"
May 12 23:42:45.928352 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(6): GET https://github.com/flatcar/sysext-bakery/releases/download/latest/kubernetes-v1.31.0-arm64.raw: attempt #1
May 12 23:42:46.177167 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(6): GET result: OK
May 12 23:42:46.420293 systemd-networkd[762]: eth0: Gained IPv6LL
May 12 23:42:46.521736 ignition[945]: INFO     : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.31.0-arm64.raw"
May 12 23:42:46.521736 ignition[945]: INFO     : files: op(7): [started]  processing unit "coreos-metadata.service"
May 12 23:42:46.524547 ignition[945]: INFO     : files: op(7): op(8): [started]  writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
May 12 23:42:46.524547 ignition[945]: INFO     : files: op(7): op(8): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
May 12 23:42:46.524547 ignition[945]: INFO     : files: op(7): [finished] processing unit "coreos-metadata.service"
May 12 23:42:46.524547 ignition[945]: INFO     : files: op(9): [started]  setting preset to disabled for "coreos-metadata.service"
May 12 23:42:46.552484 ignition[945]: INFO     : files: op(9): op(a): [started]  removing enablement symlink(s) for "coreos-metadata.service"
May 12 23:42:46.557093 ignition[945]: INFO     : files: op(9): op(a): [finished] removing enablement symlink(s) for "coreos-metadata.service"
May 12 23:42:46.558257 ignition[945]: INFO     : files: op(9): [finished] setting preset to disabled for "coreos-metadata.service"
May 12 23:42:46.558257 ignition[945]: INFO     : files: createResultFile: createFiles: op(b): [started]  writing file "/sysroot/etc/.ignition-result.json"
May 12 23:42:46.558257 ignition[945]: INFO     : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json"
May 12 23:42:46.558257 ignition[945]: INFO     : files: files passed
May 12 23:42:46.558257 ignition[945]: INFO     : Ignition finished successfully
May 12 23:42:46.560540 systemd[1]: Finished ignition-files.service - Ignition (files).
May 12 23:42:46.568423 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
May 12 23:42:46.573885 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
May 12 23:42:46.575050 systemd[1]: ignition-quench.service: Deactivated successfully.
May 12 23:42:46.575127 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
May 12 23:42:46.581028 initrd-setup-root-after-ignition[974]: grep: /sysroot/oem/oem-release: No such file or directory
May 12 23:42:46.584196 initrd-setup-root-after-ignition[976]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 12 23:42:46.584196 initrd-setup-root-after-ignition[976]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
May 12 23:42:46.586941 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
May 12 23:42:46.589045 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
May 12 23:42:46.590731 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
May 12 23:42:46.601476 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
May 12 23:42:46.620545 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
May 12 23:42:46.620666 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
May 12 23:42:46.622017 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
May 12 23:42:46.623015 systemd[1]: Reached target initrd.target - Initrd Default Target.
May 12 23:42:46.628435 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
May 12 23:42:46.630008 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
May 12 23:42:46.644960 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 12 23:42:46.653552 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
May 12 23:42:46.661123 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
May 12 23:42:46.662136 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
May 12 23:42:46.663999 systemd[1]: Stopped target timers.target - Timer Units.
May 12 23:42:46.665599 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
May 12 23:42:46.665738 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
May 12 23:42:46.668080 systemd[1]: Stopped target initrd.target - Initrd Default Target.
May 12 23:42:46.669988 systemd[1]: Stopped target basic.target - Basic System.
May 12 23:42:46.671395 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
May 12 23:42:46.672808 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
May 12 23:42:46.674435 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
May 12 23:42:46.676098 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
May 12 23:42:46.677837 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
May 12 23:42:46.678910 systemd[1]: Stopped target sysinit.target - System Initialization.
May 12 23:42:46.679826 systemd[1]: Stopped target local-fs.target - Local File Systems.
May 12 23:42:46.681270 systemd[1]: Stopped target swap.target - Swaps.
May 12 23:42:46.682910 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
May 12 23:42:46.683036 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
May 12 23:42:46.684904 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
May 12 23:42:46.686605 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 12 23:42:46.688021 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
May 12 23:42:46.691317 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 12 23:42:46.695246 systemd[1]: dracut-initqueue.service: Deactivated successfully.
May 12 23:42:46.695369 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
May 12 23:42:46.697944 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
May 12 23:42:46.698068 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
May 12 23:42:46.699697 systemd[1]: Stopped target paths.target - Path Units.
May 12 23:42:46.701939 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
May 12 23:42:46.705406 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 12 23:42:46.706354 systemd[1]: Stopped target slices.target - Slice Units.
May 12 23:42:46.708014 systemd[1]: Stopped target sockets.target - Socket Units.
May 12 23:42:46.709190 systemd[1]: iscsid.socket: Deactivated successfully.
May 12 23:42:46.709294 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
May 12 23:42:46.710596 systemd[1]: iscsiuio.socket: Deactivated successfully.
May 12 23:42:46.710682 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
May 12 23:42:46.711848 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
May 12 23:42:46.711955 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
May 12 23:42:46.713427 systemd[1]: ignition-files.service: Deactivated successfully.
May 12 23:42:46.713527 systemd[1]: Stopped ignition-files.service - Ignition (files).
May 12 23:42:46.727446 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
May 12 23:42:46.729460 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
May 12 23:42:46.730886 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
May 12 23:42:46.731808 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
May 12 23:42:46.732790 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
May 12 23:42:46.732886 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
May 12 23:42:46.741203 systemd[1]: initrd-cleanup.service: Deactivated successfully.
May 12 23:42:46.741318 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
May 12 23:42:46.746772 systemd[1]: sysroot-boot.mount: Deactivated successfully.
May 12 23:42:46.749588 ignition[1000]: INFO     : Ignition 2.20.0
May 12 23:42:46.749588 ignition[1000]: INFO     : Stage: umount
May 12 23:42:46.750952 ignition[1000]: INFO     : no configs at "/usr/lib/ignition/base.d"
May 12 23:42:46.750952 ignition[1000]: INFO     : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
May 12 23:42:46.750952 ignition[1000]: INFO     : umount: umount passed
May 12 23:42:46.750952 ignition[1000]: INFO     : Ignition finished successfully
May 12 23:42:46.752082 systemd[1]: ignition-mount.service: Deactivated successfully.
May 12 23:42:46.752184 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
May 12 23:42:46.753453 systemd[1]: Stopped target network.target - Network.
May 12 23:42:46.754113 systemd[1]: ignition-disks.service: Deactivated successfully.
May 12 23:42:46.754169 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
May 12 23:42:46.755035 systemd[1]: ignition-kargs.service: Deactivated successfully.
May 12 23:42:46.755078 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
May 12 23:42:46.756012 systemd[1]: ignition-setup.service: Deactivated successfully.
May 12 23:42:46.756056 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
May 12 23:42:46.757340 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
May 12 23:42:46.757377 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
May 12 23:42:46.758832 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
May 12 23:42:46.760769 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
May 12 23:42:46.771853 systemd-networkd[762]: eth0: DHCPv6 lease lost
May 12 23:42:46.773335 systemd[1]: systemd-networkd.service: Deactivated successfully.
May 12 23:42:46.773459 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
May 12 23:42:46.775172 systemd[1]: systemd-networkd.socket: Deactivated successfully.
May 12 23:42:46.775205 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
May 12 23:42:46.784448 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
May 12 23:42:46.785126 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
May 12 23:42:46.785195 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
May 12 23:42:46.787189 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 12 23:42:46.789746 systemd[1]: systemd-resolved.service: Deactivated successfully.
May 12 23:42:46.789845 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
May 12 23:42:46.793930 systemd[1]: systemd-sysctl.service: Deactivated successfully.
May 12 23:42:46.793995 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
May 12 23:42:46.795587 systemd[1]: systemd-modules-load.service: Deactivated successfully.
May 12 23:42:46.795636 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
May 12 23:42:46.798185 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
May 12 23:42:46.798237 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
May 12 23:42:46.800779 systemd[1]: sysroot-boot.service: Deactivated successfully.
May 12 23:42:46.800893 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
May 12 23:42:46.802440 systemd[1]: network-cleanup.service: Deactivated successfully.
May 12 23:42:46.802559 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
May 12 23:42:46.803828 systemd[1]: initrd-setup-root.service: Deactivated successfully.
May 12 23:42:46.803919 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
May 12 23:42:46.813113 systemd[1]: systemd-udevd.service: Deactivated successfully.
May 12 23:42:46.813981 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 12 23:42:46.816156 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
May 12 23:42:46.816197 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
May 12 23:42:46.817862 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
May 12 23:42:46.817894 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
May 12 23:42:46.819266 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
May 12 23:42:46.819310 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
May 12 23:42:46.821342 systemd[1]: dracut-cmdline.service: Deactivated successfully.
May 12 23:42:46.821381 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
May 12 23:42:46.823304 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
May 12 23:42:46.823345 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
May 12 23:42:46.834432 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
May 12 23:42:46.835233 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
May 12 23:42:46.835309 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 12 23:42:46.837003 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
May 12 23:42:46.837044 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 12 23:42:46.838594 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
May 12 23:42:46.838636 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
May 12 23:42:46.840320 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
May 12 23:42:46.840365 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
May 12 23:42:46.842421 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
May 12 23:42:46.842503 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
May 12 23:42:46.845878 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
May 12 23:42:46.847677 systemd[1]: Starting initrd-switch-root.service - Switch Root...
May 12 23:42:46.857614 systemd[1]: Switching root.
May 12 23:42:46.892135 systemd-journald[240]: Journal stopped
May 12 23:42:47.613320 systemd-journald[240]: Received SIGTERM from PID 1 (systemd).
May 12 23:42:47.613373 kernel: SELinux:  policy capability network_peer_controls=1
May 12 23:42:47.613385 kernel: SELinux:  policy capability open_perms=1
May 12 23:42:47.613396 kernel: SELinux:  policy capability extended_socket_class=1
May 12 23:42:47.613406 kernel: SELinux:  policy capability always_check_network=0
May 12 23:42:47.613427 kernel: SELinux:  policy capability cgroup_seclabel=1
May 12 23:42:47.613441 kernel: SELinux:  policy capability nnp_nosuid_transition=1
May 12 23:42:47.613458 kernel: SELinux:  policy capability genfs_seclabel_symlinks=0
May 12 23:42:47.613479 kernel: SELinux:  policy capability ioctl_skip_cloexec=0
May 12 23:42:47.613497 kernel: audit: type=1403 audit(1747093367.012:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
May 12 23:42:47.613509 systemd[1]: Successfully loaded SELinux policy in 37.636ms.
May 12 23:42:47.613525 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 17.643ms.
May 12 23:42:47.613537 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified)
May 12 23:42:47.613549 systemd[1]: Detected virtualization kvm.
May 12 23:42:47.613560 systemd[1]: Detected architecture arm64.
May 12 23:42:47.613603 systemd[1]: Detected first boot.
May 12 23:42:47.613615 systemd[1]: Initializing machine ID from VM UUID.
May 12 23:42:47.613631 zram_generator::config[1045]: No configuration found.
May 12 23:42:47.613644 systemd[1]: Populated /etc with preset unit settings.
May 12 23:42:47.613655 systemd[1]: initrd-switch-root.service: Deactivated successfully.
May 12 23:42:47.613666 systemd[1]: Stopped initrd-switch-root.service - Switch Root.
May 12 23:42:47.613677 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
May 12 23:42:47.613691 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
May 12 23:42:47.613708 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
May 12 23:42:47.613723 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
May 12 23:42:47.613735 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
May 12 23:42:47.613746 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
May 12 23:42:47.613758 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
May 12 23:42:47.613770 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
May 12 23:42:47.613785 systemd[1]: Created slice user.slice - User and Session Slice.
May 12 23:42:47.613797 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
May 12 23:42:47.613810 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
May 12 23:42:47.613822 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
May 12 23:42:47.613833 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
May 12 23:42:47.613844 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
May 12 23:42:47.613856 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
May 12 23:42:47.613867 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0...
May 12 23:42:47.613878 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
May 12 23:42:47.613892 systemd[1]: Stopped target initrd-switch-root.target - Switch Root.
May 12 23:42:47.613903 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems.
May 12 23:42:47.613916 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System.
May 12 23:42:47.613927 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
May 12 23:42:47.613938 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
May 12 23:42:47.613950 systemd[1]: Reached target remote-fs.target - Remote File Systems.
May 12 23:42:47.613961 systemd[1]: Reached target slices.target - Slice Units.
May 12 23:42:47.613975 systemd[1]: Reached target swap.target - Swaps.
May 12 23:42:47.613986 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
May 12 23:42:47.613999 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
May 12 23:42:47.614010 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
May 12 23:42:47.614022 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
May 12 23:42:47.614033 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
May 12 23:42:47.614044 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
May 12 23:42:47.614055 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
May 12 23:42:47.614065 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
May 12 23:42:47.614076 systemd[1]: Mounting media.mount - External Media Directory...
May 12 23:42:47.614087 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
May 12 23:42:47.614099 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
May 12 23:42:47.614111 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
May 12 23:42:47.614122 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw).
May 12 23:42:47.614134 systemd[1]: Reached target machines.target - Containers.
May 12 23:42:47.614145 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
May 12 23:42:47.614156 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 12 23:42:47.614167 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
May 12 23:42:47.614178 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
May 12 23:42:47.614189 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 12 23:42:47.614201 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 12 23:42:47.614212 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 12 23:42:47.614223 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
May 12 23:42:47.614234 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 12 23:42:47.614245 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
May 12 23:42:47.614326 systemd[1]: systemd-fsck-root.service: Deactivated successfully.
May 12 23:42:47.614339 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device.
May 12 23:42:47.614350 kernel: fuse: init (API version 7.39)
May 12 23:42:47.614363 systemd[1]: systemd-fsck-usr.service: Deactivated successfully.
May 12 23:42:47.614374 systemd[1]: Stopped systemd-fsck-usr.service.
May 12 23:42:47.614384 systemd[1]: Starting systemd-journald.service - Journal Service...
May 12 23:42:47.614395 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
May 12 23:42:47.614407 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
May 12 23:42:47.614418 kernel: ACPI: bus type drm_connector registered
May 12 23:42:47.614428 kernel: loop: module loaded
May 12 23:42:47.614441 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
May 12 23:42:47.614451 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
May 12 23:42:47.614462 systemd[1]: verity-setup.service: Deactivated successfully.
May 12 23:42:47.614475 systemd[1]: Stopped verity-setup.service.
May 12 23:42:47.614486 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
May 12 23:42:47.614498 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
May 12 23:42:47.614529 systemd-journald[1112]: Collecting audit messages is disabled.
May 12 23:42:47.614553 systemd[1]: Mounted media.mount - External Media Directory.
May 12 23:42:47.614564 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
May 12 23:42:47.614575 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
May 12 23:42:47.614586 systemd-journald[1112]: Journal started
May 12 23:42:47.614609 systemd-journald[1112]: Runtime Journal (/run/log/journal/2dafd75b45754541854f63215c575498) is 5.9M, max 47.3M, 41.4M free.
May 12 23:42:47.415143 systemd[1]: Queued start job for default target multi-user.target.
May 12 23:42:47.436135 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
May 12 23:42:47.436504 systemd[1]: systemd-journald.service: Deactivated successfully.
May 12 23:42:47.618091 systemd[1]: Started systemd-journald.service - Journal Service.
May 12 23:42:47.618722 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
May 12 23:42:47.619845 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
May 12 23:42:47.621360 systemd[1]: modprobe@configfs.service: Deactivated successfully.
May 12 23:42:47.621507 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
May 12 23:42:47.624578 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 12 23:42:47.624736 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 12 23:42:47.625992 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 12 23:42:47.626133 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 12 23:42:47.627411 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 12 23:42:47.627543 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 12 23:42:47.628969 systemd[1]: modprobe@fuse.service: Deactivated successfully.
May 12 23:42:47.629111 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
May 12 23:42:47.631567 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 12 23:42:47.631720 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 12 23:42:47.632934 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
May 12 23:42:47.634489 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
May 12 23:42:47.637286 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
May 12 23:42:47.648841 systemd[1]: Reached target network-pre.target - Preparation for Network.
May 12 23:42:47.659392 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
May 12 23:42:47.661446 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
May 12 23:42:47.662581 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
May 12 23:42:47.662620 systemd[1]: Reached target local-fs.target - Local File Systems.
May 12 23:42:47.664510 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink).
May 12 23:42:47.666749 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
May 12 23:42:47.668905 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
May 12 23:42:47.670037 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 12 23:42:47.672076 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
May 12 23:42:47.674165 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
May 12 23:42:47.675392 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 12 23:42:47.679470 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
May 12 23:42:47.682209 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 12 23:42:47.684722 systemd-journald[1112]: Time spent on flushing to /var/log/journal/2dafd75b45754541854f63215c575498 is 26.244ms for 838 entries.
May 12 23:42:47.684722 systemd-journald[1112]: System Journal (/var/log/journal/2dafd75b45754541854f63215c575498) is 8.0M, max 195.6M, 187.6M free.
May 12 23:42:47.808450 systemd-journald[1112]: Received client request to flush runtime journal.
May 12 23:42:47.808502 kernel: loop0: detected capacity change from 0 to 116808
May 12 23:42:47.808522 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 12 23:42:47.808540 kernel: loop1: detected capacity change from 0 to 113536
May 12 23:42:47.683659 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
May 12 23:42:47.688458 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
May 12 23:42:47.691936 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
May 12 23:42:47.694558 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
May 12 23:42:47.697619 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
May 12 23:42:47.698974 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
May 12 23:42:47.700503 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
May 12 23:42:47.708483 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
May 12 23:42:47.721475 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
May 12 23:42:47.726375 udevadm[1160]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
May 12 23:42:47.728845 systemd-tmpfiles[1149]: ACLs are not supported, ignoring.
May 12 23:42:47.728855 systemd-tmpfiles[1149]: ACLs are not supported, ignoring.
May 12 23:42:47.732556 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
May 12 23:42:47.788332 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
May 12 23:42:47.789546 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
May 12 23:42:47.791332 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
May 12 23:42:47.804018 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk...
May 12 23:42:47.806801 systemd[1]: Starting systemd-sysusers.service - Create System Users...
May 12 23:42:47.813280 kernel: loop2: detected capacity change from 0 to 189592
May 12 23:42:47.814587 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
May 12 23:42:47.828926 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
May 12 23:42:47.829770 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk.
May 12 23:42:47.832895 systemd[1]: Finished systemd-sysusers.service - Create System Users.
May 12 23:42:47.840547 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
May 12 23:42:47.852917 systemd-tmpfiles[1182]: ACLs are not supported, ignoring.
May 12 23:42:47.852938 systemd-tmpfiles[1182]: ACLs are not supported, ignoring.
May 12 23:42:47.856282 kernel: loop3: detected capacity change from 0 to 116808
May 12 23:42:47.859282 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
May 12 23:42:47.867280 kernel: loop4: detected capacity change from 0 to 113536
May 12 23:42:47.874273 kernel: loop5: detected capacity change from 0 to 189592
May 12 23:42:47.886832 (sd-merge)[1186]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'.
May 12 23:42:47.887260 (sd-merge)[1186]: Merged extensions into '/usr'.
May 12 23:42:47.891036 systemd[1]: Reloading requested from client PID 1148 ('systemd-sysext') (unit systemd-sysext.service)...
May 12 23:42:47.891054 systemd[1]: Reloading...
May 12 23:42:47.942296 zram_generator::config[1213]: No configuration found.
May 12 23:42:48.019985 ldconfig[1143]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
May 12 23:42:48.053355 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
May 12 23:42:48.089693 systemd[1]: Reloading finished in 198 ms.
May 12 23:42:48.122378 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
May 12 23:42:48.125288 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
May 12 23:42:48.144462 systemd[1]: Starting ensure-sysext.service...
May 12 23:42:48.146388 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
May 12 23:42:48.157297 systemd[1]: Reloading requested from client PID 1247 ('systemctl') (unit ensure-sysext.service)...
May 12 23:42:48.157315 systemd[1]: Reloading...
May 12 23:42:48.169219 systemd-tmpfiles[1248]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
May 12 23:42:48.169548 systemd-tmpfiles[1248]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
May 12 23:42:48.170292 systemd-tmpfiles[1248]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
May 12 23:42:48.170548 systemd-tmpfiles[1248]: ACLs are not supported, ignoring.
May 12 23:42:48.170604 systemd-tmpfiles[1248]: ACLs are not supported, ignoring.
May 12 23:42:48.173092 systemd-tmpfiles[1248]: Detected autofs mount point /boot during canonicalization of boot.
May 12 23:42:48.173106 systemd-tmpfiles[1248]: Skipping /boot
May 12 23:42:48.180204 systemd-tmpfiles[1248]: Detected autofs mount point /boot during canonicalization of boot.
May 12 23:42:48.180220 systemd-tmpfiles[1248]: Skipping /boot
May 12 23:42:48.209279 zram_generator::config[1275]: No configuration found.
May 12 23:42:48.292796 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
May 12 23:42:48.328092 systemd[1]: Reloading finished in 170 ms.
May 12 23:42:48.343366 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
May 12 23:42:48.344610 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
May 12 23:42:48.356102 systemd[1]: Starting audit-rules.service - Load Audit Rules...
May 12 23:42:48.358505 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
May 12 23:42:48.360911 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
May 12 23:42:48.364467 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
May 12 23:42:48.374511 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
May 12 23:42:48.377596 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
May 12 23:42:48.383598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 12 23:42:48.384889 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 12 23:42:48.388631 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
May 12 23:42:48.391916 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 12 23:42:48.392903 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 12 23:42:48.397931 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 12 23:42:48.398079 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 12 23:42:48.399923 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
May 12 23:42:48.401598 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 12 23:42:48.401740 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 12 23:42:48.408778 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
May 12 23:42:48.410747 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
May 12 23:42:48.410876 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
May 12 23:42:48.412194 systemd[1]: Finished ensure-sysext.service.
May 12 23:42:48.416827 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
May 12 23:42:48.426793 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
May 12 23:42:48.428045 systemd-udevd[1316]: Using default interface naming scheme 'v255'.
May 12 23:42:48.428738 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
May 12 23:42:48.429628 augenrules[1347]: No rules
May 12 23:42:48.430490 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
May 12 23:42:48.431387 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
May 12 23:42:48.431436 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
May 12 23:42:48.433468 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
May 12 23:42:48.436460 systemd[1]: Starting systemd-update-done.service - Update is Completed...
May 12 23:42:48.439466 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
May 12 23:42:48.440755 systemd[1]: audit-rules.service: Deactivated successfully.
May 12 23:42:48.440964 systemd[1]: Finished audit-rules.service - Load Audit Rules.
May 12 23:42:48.443344 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
May 12 23:42:48.444663 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
May 12 23:42:48.444813 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
May 12 23:42:48.446217 systemd[1]: modprobe@drm.service: Deactivated successfully.
May 12 23:42:48.446359 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
May 12 23:42:48.447499 systemd[1]: modprobe@loop.service: Deactivated successfully.
May 12 23:42:48.447636 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
May 12 23:42:48.448952 systemd[1]: Finished systemd-update-done.service - Update is Completed.
May 12 23:42:48.451212 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
May 12 23:42:48.469457 systemd[1]: Starting systemd-networkd.service - Network Configuration...
May 12 23:42:48.470285 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
May 12 23:42:48.470331 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt).
May 12 23:42:48.478049 systemd[1]: Started systemd-userdbd.service - User Database Manager.
May 12 23:42:48.494124 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped.
May 12 23:42:48.512268 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1370)
May 12 23:42:48.545986 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
May 12 23:42:48.547216 systemd[1]: Reached target time-set.target - System Time Set.
May 12 23:42:48.560393 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
May 12 23:42:48.560798 systemd-networkd[1373]: lo: Link UP
May 12 23:42:48.560808 systemd-networkd[1373]: lo: Gained carrier
May 12 23:42:48.560886 systemd-resolved[1315]: Positive Trust Anchors:
May 12 23:42:48.560954 systemd-resolved[1315]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
May 12 23:42:48.560987 systemd-resolved[1315]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test
May 12 23:42:48.564882 systemd-networkd[1373]: Enumeration completed
May 12 23:42:48.571838 systemd-resolved[1315]: Defaulting to hostname 'linux'.
May 12 23:42:48.572187 systemd-networkd[1373]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 12 23:42:48.572199 systemd-networkd[1373]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
May 12 23:42:48.572889 systemd-networkd[1373]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 12 23:42:48.572922 systemd-networkd[1373]: eth0: Link UP
May 12 23:42:48.572926 systemd-networkd[1373]: eth0: Gained carrier
May 12 23:42:48.572934 systemd-networkd[1373]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
May 12 23:42:48.576441 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
May 12 23:42:48.577659 systemd[1]: Started systemd-networkd.service - Network Configuration.
May 12 23:42:48.578635 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
May 12 23:42:48.579872 systemd[1]: Reached target network.target - Network.
May 12 23:42:48.580541 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
May 12 23:42:48.582836 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
May 12 23:42:48.592479 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
May 12 23:42:48.594335 systemd-networkd[1373]: eth0: DHCPv4 address 10.0.0.33/16, gateway 10.0.0.1 acquired from 10.0.0.1
May 12 23:42:48.595280 systemd-timesyncd[1353]: Network configuration changed, trying to establish connection.
May 12 23:42:48.595814 systemd-timesyncd[1353]: Contacted time server 10.0.0.1:123 (10.0.0.1).
May 12 23:42:48.595867 systemd-timesyncd[1353]: Initial clock synchronization to Mon 2025-05-12 23:42:48.563505 UTC.
May 12 23:42:48.615532 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
May 12 23:42:48.626879 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
May 12 23:42:48.629383 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
May 12 23:42:48.647629 lvm[1406]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 12 23:42:48.664134 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
May 12 23:42:48.681764 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
May 12 23:42:48.682908 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
May 12 23:42:48.685371 systemd[1]: Reached target sysinit.target - System Initialization.
May 12 23:42:48.686274 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
May 12 23:42:48.687180 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
May 12 23:42:48.688357 systemd[1]: Started logrotate.timer - Daily rotation of log files.
May 12 23:42:48.689455 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
May 12 23:42:48.690444 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
May 12 23:42:48.691311 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
May 12 23:42:48.691340 systemd[1]: Reached target paths.target - Path Units.
May 12 23:42:48.691960 systemd[1]: Reached target timers.target - Timer Units.
May 12 23:42:48.693587 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
May 12 23:42:48.695741 systemd[1]: Starting docker.socket - Docker Socket for the API...
May 12 23:42:48.703180 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
May 12 23:42:48.705346 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
May 12 23:42:48.706885 systemd[1]: Listening on docker.socket - Docker Socket for the API.
May 12 23:42:48.708052 systemd[1]: Reached target sockets.target - Socket Units.
May 12 23:42:48.709027 systemd[1]: Reached target basic.target - Basic System.
May 12 23:42:48.709997 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
May 12 23:42:48.710029 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
May 12 23:42:48.710953 systemd[1]: Starting containerd.service - containerd container runtime...
May 12 23:42:48.712880 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
May 12 23:42:48.715418 lvm[1413]:   WARNING: Failed to connect to lvmetad. Falling back to device scanning.
May 12 23:42:48.717410 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
May 12 23:42:48.720502 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
May 12 23:42:48.721857 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment).
May 12 23:42:48.722940 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
May 12 23:42:48.728465 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
May 12 23:42:48.732499 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
May 12 23:42:48.737845 jq[1416]: false
May 12 23:42:48.738475 extend-filesystems[1417]: Found loop3
May 12 23:42:48.738467 systemd[1]: Starting systemd-logind.service - User Login Management...
May 12 23:42:48.741541 extend-filesystems[1417]: Found loop4
May 12 23:42:48.741541 extend-filesystems[1417]: Found loop5
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda1
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda2
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda3
May 12 23:42:48.741541 extend-filesystems[1417]: Found usr
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda4
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda6
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda7
May 12 23:42:48.741541 extend-filesystems[1417]: Found vda9
May 12 23:42:48.741541 extend-filesystems[1417]: Checking size of /dev/vda9
May 12 23:42:48.743209 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
May 12 23:42:48.743711 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
May 12 23:42:48.747451 systemd[1]: Starting update-engine.service - Update Engine...
May 12 23:42:48.751525 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
May 12 23:42:48.757054 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
May 12 23:42:48.760388 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
May 12 23:42:48.762406 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
May 12 23:42:48.762709 systemd[1]: motdgen.service: Deactivated successfully.
May 12 23:42:48.762855 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
May 12 23:42:48.763951 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
May 12 23:42:48.764086 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
May 12 23:42:48.769564 jq[1432]: true
May 12 23:42:48.777368 (ntainerd)[1436]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
May 12 23:42:48.778883 dbus-daemon[1415]: [system] SELinux support is enabled
May 12 23:42:48.779477 systemd[1]: Started dbus.service - D-Bus System Message Bus.
May 12 23:42:48.782083 systemd-logind[1424]: Watching system buttons on /dev/input/event0 (Power Button)
May 12 23:42:48.782562 systemd-logind[1424]: New seat seat0.
May 12 23:42:48.786288 systemd[1]: Started systemd-logind.service - User Login Management.
May 12 23:42:48.787429 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml).
May 12 23:42:48.787462 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
May 12 23:42:48.788831 jq[1438]: true
May 12 23:42:48.788942 dbus-daemon[1415]: [system] Successfully activated service 'org.freedesktop.systemd1'
May 12 23:42:48.789185 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url).
May 12 23:42:48.789212 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
May 12 23:42:48.809278 extend-filesystems[1417]: Resized partition /dev/vda9
May 12 23:42:48.810151 extend-filesystems[1449]: resize2fs 1.47.1 (20-May-2024)
May 12 23:42:48.818469 update_engine[1429]: I20250512 23:42:48.818307  1429 main.cc:92] Flatcar Update Engine starting
May 12 23:42:48.825210 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks
May 12 23:42:48.825314 update_engine[1429]: I20250512 23:42:48.822855  1429 update_check_scheduler.cc:74] Next update check in 6m16s
May 12 23:42:48.821909 systemd[1]: Started update-engine.service - Update Engine.
May 12 23:42:48.828298 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (1381)
May 12 23:42:48.832616 systemd[1]: Started locksmithd.service - Cluster reboot manager.
May 12 23:42:48.893334 kernel: EXT4-fs (vda9): resized filesystem to 1864699
May 12 23:42:48.900477 locksmithd[1454]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
May 12 23:42:48.910424 extend-filesystems[1449]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required
May 12 23:42:48.910424 extend-filesystems[1449]: old_desc_blocks = 1, new_desc_blocks = 1
May 12 23:42:48.910424 extend-filesystems[1449]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long.
May 12 23:42:48.913771 extend-filesystems[1417]: Resized filesystem in /dev/vda9
May 12 23:42:48.912408 systemd[1]: extend-filesystems.service: Deactivated successfully.
May 12 23:42:48.912593 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
May 12 23:42:48.920376 bash[1465]: Updated "/home/core/.ssh/authorized_keys"
May 12 23:42:48.922003 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
May 12 23:42:48.923652 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
May 12 23:42:48.991885 containerd[1436]: time="2025-05-12T23:42:48.991788200Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23
May 12 23:42:49.017294 containerd[1436]: time="2025-05-12T23:42:49.017033207Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018423047Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.89-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018456213Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018472517Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018633634Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018651816Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018721945Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018739048Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018895970Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018911474Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018924142Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
May 12 23:42:49.019593 containerd[1436]: time="2025-05-12T23:42:49.018932933Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019001224Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019193990Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019304478Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019318424Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019399423Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
May 12 23:42:49.019853 containerd[1436]: time="2025-05-12T23:42:49.019439303Z" level=info msg="metadata content store policy set" policy=shared
May 12 23:42:49.023447 containerd[1436]: time="2025-05-12T23:42:49.023419812Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
May 12 23:42:49.023571 containerd[1436]: time="2025-05-12T23:42:49.023554556Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
May 12 23:42:49.023687 containerd[1436]: time="2025-05-12T23:42:49.023662847Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
May 12 23:42:49.023762 containerd[1436]: time="2025-05-12T23:42:49.023748560Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
May 12 23:42:49.023855 containerd[1436]: time="2025-05-12T23:42:49.023841467Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
May 12 23:42:49.024082 containerd[1436]: time="2025-05-12T23:42:49.024063843Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
May 12 23:42:49.024476 containerd[1436]: time="2025-05-12T23:42:49.024449374Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
May 12 23:42:49.024692 containerd[1436]: time="2025-05-12T23:42:49.024659762Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
May 12 23:42:49.024769 containerd[1436]: time="2025-05-12T23:42:49.024755706Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
May 12 23:42:49.024861 containerd[1436]: time="2025-05-12T23:42:49.024844696Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
May 12 23:42:49.024931 containerd[1436]: time="2025-05-12T23:42:49.024918182Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
May 12 23:42:49.024993 containerd[1436]: time="2025-05-12T23:42:49.024972048Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025064 containerd[1436]: time="2025-05-12T23:42:49.025043056Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025125 containerd[1436]: time="2025-05-12T23:42:49.025112506Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025190 containerd[1436]: time="2025-05-12T23:42:49.025177321Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025261 containerd[1436]: time="2025-05-12T23:42:49.025229948Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025339 containerd[1436]: time="2025-05-12T23:42:49.025325811Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025400 containerd[1436]: time="2025-05-12T23:42:49.025379877Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
May 12 23:42:49.025463 containerd[1436]: time="2025-05-12T23:42:49.025450565Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025535 containerd[1436]: time="2025-05-12T23:42:49.025522293Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025597 containerd[1436]: time="2025-05-12T23:42:49.025585629Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025660 containerd[1436]: time="2025-05-12T23:42:49.025647407Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025737 containerd[1436]: time="2025-05-12T23:42:49.025724210Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025796 containerd[1436]: time="2025-05-12T23:42:49.025779714Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025848 containerd[1436]: time="2025-05-12T23:42:49.025837815Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025902 containerd[1436]: time="2025-05-12T23:42:49.025887365Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
May 12 23:42:49.025957 containerd[1436]: time="2025-05-12T23:42:49.025945906Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026012 containerd[1436]: time="2025-05-12T23:42:49.026002010Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026070 containerd[1436]: time="2025-05-12T23:42:49.026050721Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026131 containerd[1436]: time="2025-05-12T23:42:49.026119012Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026191 containerd[1436]: time="2025-05-12T23:42:49.026179990Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026269 containerd[1436]: time="2025-05-12T23:42:49.026233457Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
May 12 23:42:49.026341 containerd[1436]: time="2025-05-12T23:42:49.026329879Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026398 containerd[1436]: time="2025-05-12T23:42:49.026382626Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
May 12 23:42:49.026462 containerd[1436]: time="2025-05-12T23:42:49.026450478Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
May 12 23:42:49.026724 containerd[1436]: time="2025-05-12T23:42:49.026708698Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
May 12 23:42:49.026872 containerd[1436]: time="2025-05-12T23:42:49.026853192Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
May 12 23:42:49.026953 containerd[1436]: time="2025-05-12T23:42:49.026939066Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
May 12 23:42:49.027013 containerd[1436]: time="2025-05-12T23:42:49.026994929Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
May 12 23:42:49.027060 containerd[1436]: time="2025-05-12T23:42:49.027049634Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
May 12 23:42:49.027112 containerd[1436]: time="2025-05-12T23:42:49.027101822Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
May 12 23:42:49.027181 containerd[1436]: time="2025-05-12T23:42:49.027158085Z" level=info msg="NRI interface is disabled by configuration."
May 12 23:42:49.027232 containerd[1436]: time="2025-05-12T23:42:49.027221421Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
May 12 23:42:49.027711 containerd[1436]: time="2025-05-12T23:42:49.027649270Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}"
May 12 23:42:49.027892 containerd[1436]: time="2025-05-12T23:42:49.027875402Z" level=info msg="Connect containerd service"
May 12 23:42:49.027985 containerd[1436]: time="2025-05-12T23:42:49.027971545Z" level=info msg="using legacy CRI server"
May 12 23:42:49.028066 containerd[1436]: time="2025-05-12T23:42:49.028052504Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
May 12 23:42:49.028376 containerd[1436]: time="2025-05-12T23:42:49.028359075Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
May 12 23:42:49.029187 containerd[1436]: time="2025-05-12T23:42:49.029161666Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config"
May 12 23:42:49.029420 containerd[1436]: time="2025-05-12T23:42:49.029394671Z" level=info msg="Start subscribing containerd event"
May 12 23:42:49.030005 containerd[1436]: time="2025-05-12T23:42:49.029985636Z" level=info msg="Start recovering state"
May 12 23:42:49.030132 containerd[1436]: time="2025-05-12T23:42:49.030114226Z" level=info msg="Start event monitor"
May 12 23:42:49.030203 containerd[1436]: time="2025-05-12T23:42:49.030189510Z" level=info msg="Start snapshots syncer"
May 12 23:42:49.030287 containerd[1436]: time="2025-05-12T23:42:49.030272747Z" level=info msg="Start cni network conf syncer for default"
May 12 23:42:49.030336 containerd[1436]: time="2025-05-12T23:42:49.030324734Z" level=info msg="Start streaming server"
May 12 23:42:49.030738 containerd[1436]: time="2025-05-12T23:42:49.029947674Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
May 12 23:42:49.030738 containerd[1436]: time="2025-05-12T23:42:49.030584552Z" level=info msg=serving... address=/run/containerd/containerd.sock
May 12 23:42:49.030738 containerd[1436]: time="2025-05-12T23:42:49.030640496Z" level=info msg="containerd successfully booted in 0.040270s"
May 12 23:42:49.030870 systemd[1]: Started containerd.service - containerd container runtime.
May 12 23:42:49.864417 sshd_keygen[1435]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
May 12 23:42:49.884530 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
May 12 23:42:49.898521 systemd[1]: Starting issuegen.service - Generate /run/issue...
May 12 23:42:49.904364 systemd[1]: issuegen.service: Deactivated successfully.
May 12 23:42:49.905356 systemd[1]: Finished issuegen.service - Generate /run/issue.
May 12 23:42:49.908013 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
May 12 23:42:49.922095 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
May 12 23:42:49.924697 systemd[1]: Started getty@tty1.service - Getty on tty1.
May 12 23:42:49.926591 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0.
May 12 23:42:49.927613 systemd[1]: Reached target getty.target - Login Prompts.
May 12 23:42:49.999357 systemd-networkd[1373]: eth0: Gained IPv6LL
May 12 23:42:50.001917 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
May 12 23:42:50.003434 systemd[1]: Reached target network-online.target - Network is Online.
May 12 23:42:50.014544 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
May 12 23:42:50.016900 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
May 12 23:42:50.018894 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
May 12 23:42:50.034846 systemd[1]: coreos-metadata.service: Deactivated successfully.
May 12 23:42:50.035033 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
May 12 23:42:50.037370 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
May 12 23:42:50.038607 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
May 12 23:42:50.523105 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent.
May 12 23:42:50.524758 systemd[1]: Reached target multi-user.target - Multi-User System.
May 12 23:42:50.525851 systemd[1]: Startup finished in 571ms (kernel) + 4.310s (initrd) + 3.548s (userspace) = 8.430s.
May 12 23:42:50.527474 (kubelet)[1521]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS
May 12 23:42:50.984298 kubelet[1521]: E0512 23:42:50.984175    1521 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"
May 12 23:42:50.986855 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE
May 12 23:42:50.987011 systemd[1]: kubelet.service: Failed with result 'exit-code'.
May 12 23:42:55.541065 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
May 12 23:42:55.542168 systemd[1]: Started sshd@0-10.0.0.33:22-10.0.0.1:49904.service - OpenSSH per-connection server daemon (10.0.0.1:49904).
May 12 23:42:55.617309 sshd[1534]: Accepted publickey for core from 10.0.0.1 port 49904 ssh2: RSA SHA256:SZ6XZJGCUk0YkyeRdV4YqMMB8lYnDHpF+o6Fl5qyEaU
May 12 23:42:55.619183 sshd-session[1534]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 12 23:42:55.630868 systemd-logind[1424]: New session 1 of user core.
May 12 23:42:55.631858 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
May 12 23:42:55.641488 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
May 12 23:42:55.650053 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
May 12 23:42:55.653511 systemd[1]: Starting user@500.service - User Manager for UID 500...
May 12 23:42:55.660655 (systemd)[1538]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
May 12 23:42:55.734317 systemd[1538]: Queued start job for default target default.target.
May 12 23:42:55.747190 systemd[1538]: Created slice app.slice - User Application Slice.
May 12 23:42:55.747221 systemd[1538]: Reached target paths.target - Paths.
May 12 23:42:55.747233 systemd[1538]: Reached target timers.target - Timers.
May 12 23:42:55.748471 systemd[1538]: Starting dbus.socket - D-Bus User Message Bus Socket...
May 12 23:42:55.758298 systemd[1538]: Listening on dbus.socket - D-Bus User Message Bus Socket.
May 12 23:42:55.758354 systemd[1538]: Reached target sockets.target - Sockets.
May 12 23:42:55.758365 systemd[1538]: Reached target basic.target - Basic System.
May 12 23:42:55.758409 systemd[1538]: Reached target default.target - Main User Target.
May 12 23:42:55.758437 systemd[1538]: Startup finished in 91ms.
May 12 23:42:55.758534 systemd[1]: Started user@500.service - User Manager for UID 500.
May 12 23:42:55.759681 systemd[1]: Started session-1.scope - Session 1 of User core.
May 12 23:42:55.817841 systemd[1]: Started sshd@1-10.0.0.33:22-10.0.0.1:49910.service - OpenSSH per-connection server daemon (10.0.0.1:49910).
May 12 23:42:55.870170 sshd[1549]: Accepted publickey for core from 10.0.0.1 port 49910 ssh2: RSA SHA256:SZ6XZJGCUk0YkyeRdV4YqMMB8lYnDHpF+o6Fl5qyEaU
May 12 23:42:55.871277 sshd-session[1549]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 12 23:42:55.875320 systemd-logind[1424]: New session 2 of user core.
May 12 23:42:55.883416 systemd[1]: Started session-2.scope - Session 2 of User core.
May 12 23:42:55.933279 sshd[1551]: Connection closed by 10.0.0.1 port 49910
May 12 23:42:55.933698 sshd-session[1549]: pam_unix(sshd:session): session closed for user core
May 12 23:42:55.942660 systemd[1]: sshd@1-10.0.0.33:22-10.0.0.1:49910.service: Deactivated successfully.
May 12 23:42:55.945418 systemd[1]: session-2.scope: Deactivated successfully.
May 12 23:42:55.946699 systemd-logind[1424]: Session 2 logged out. Waiting for processes to exit.
May 12 23:42:55.947798 systemd[1]: Started sshd@2-10.0.0.33:22-10.0.0.1:49918.service - OpenSSH per-connection server daemon (10.0.0.1:49918).
May 12 23:42:55.948547 systemd-logind[1424]: Removed session 2.
May 12 23:42:55.986180 sshd[1556]: Accepted publickey for core from 10.0.0.1 port 49918 ssh2: RSA SHA256:SZ6XZJGCUk0YkyeRdV4YqMMB8lYnDHpF+o6Fl5qyEaU
May 12 23:42:55.987214 sshd-session[1556]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 12 23:42:55.991138 systemd-logind[1424]: New session 3 of user core.
May 12 23:42:56.006393 systemd[1]: Started session-3.scope - Session 3 of User core.
May 12 23:42:56.053932 sshd[1558]: Connection closed by 10.0.0.1 port 49918
May 12 23:42:56.054171 sshd-session[1556]: pam_unix(sshd:session): session closed for user core
May 12 23:42:56.066591 systemd[1]: sshd@2-10.0.0.33:22-10.0.0.1:49918.service: Deactivated successfully.
May 12 23:42:56.067857 systemd[1]: session-3.scope: Deactivated successfully.
May 12 23:42:56.070364 systemd-logind[1424]: Session 3 logged out. Waiting for processes to exit.
May 12 23:42:56.071523 systemd[1]: Started sshd@3-10.0.0.33:22-10.0.0.1:49930.service - OpenSSH per-connection server daemon (10.0.0.1:49930).
May 12 23:42:56.072324 systemd-logind[1424]: Removed session 3.
May 12 23:42:56.110711 sshd[1563]: Accepted publickey for core from 10.0.0.1 port 49930 ssh2: RSA SHA256:SZ6XZJGCUk0YkyeRdV4YqMMB8lYnDHpF+o6Fl5qyEaU
May 12 23:42:56.111979 sshd-session[1563]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 12 23:42:56.116077 systemd-logind[1424]: New session 4 of user core.
May 12 23:42:56.123457 systemd[1]: Started session-4.scope - Session 4 of User core.
May 12 23:42:56.176300 sshd[1565]: Connection closed by 10.0.0.1 port 49930
May 12 23:42:56.176633 sshd-session[1563]: pam_unix(sshd:session): session closed for user core
May 12 23:42:56.188661 systemd[1]: sshd@3-10.0.0.33:22-10.0.0.1:49930.service: Deactivated successfully.
May 12 23:42:56.190300 systemd[1]: session-4.scope: Deactivated successfully.
May 12 23:42:56.191700 systemd-logind[1424]: Session 4 logged out. Waiting for processes to exit.
May 12 23:42:56.204526 systemd[1]: Started sshd@4-10.0.0.33:22-10.0.0.1:49940.service - OpenSSH per-connection server daemon (10.0.0.1:49940).
May 12 23:42:56.205364 systemd-logind[1424]: Removed session 4.
May 12 23:42:56.242900 sshd[1570]: Accepted publickey for core from 10.0.0.1 port 49940 ssh2: RSA SHA256:SZ6XZJGCUk0YkyeRdV4YqMMB8lYnDHpF+o6Fl5qyEaU
May 12 23:42:56.244110 sshd-session[1570]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
May 12 23:42:56.248005 systemd-logind[1424]: New session 5 of user core.
May 12 23:42:56.253402 systemd[1]: Started session-5.scope - Session 5 of User core.
May 12 23:42:56.313527 sudo[1573]:     core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh
May 12 23:42:56.315567 sudo[1573]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
May 12 23:42:56.332783 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
May 12 23:42:56.347745 systemd[1]: coreos-metadata.service: Deactivated successfully.
May 12 23:42:56.347949 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
May 12 23:42:56.783939 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent.
May 12 23:42:56.795510 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
May 12 23:42:56.815481 systemd[1]: Reloading requested from client PID 1614 ('systemctl') (unit session-5.scope)...
May 12 23:42:56.815500 systemd[1]: Reloading...
May 12 23:42:56.879291 zram_generator::config[1649]: No configuration found.
May 12 23:42:57.052750 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly.
May 12 23:42:57.106015 systemd[1]: Reloading finished in 290 ms.
May 12 23:42:57.153121 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM
May 12 23:42:57.153189 systemd[1]: kubelet.service: Failed with result 'signal'.
May 12 23:42:57.153566 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent.
May 12 23:42:57.156059 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
May 12 23:42:57.262006 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent.
May 12 23:42:57.267341 (kubelet)[1698]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS
May 12 23:42:57.303714 kubelet[1698]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information.
May 12 23:42:57.303714 kubelet[1698]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI.
May 12 23:42:57.303714 kubelet[1698]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information.
May 12 23:42:57.304016 kubelet[1698]: I0512 23:42:57.303851    1698 server.go:206] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime"
May 12 23:42:58.028933 kubelet[1698]: I0512 23:42:58.028884    1698 server.go:486] "Kubelet version" kubeletVersion="v1.31.0"
May 12 23:42:58.028933 kubelet[1698]: I0512 23:42:58.028918    1698 server.go:488] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
May 12 23:42:58.029168 kubelet[1698]: I0512 23:42:58.029153    1698 server.go:929] "Client rotation is on, will bootstrap in background"
May 12 23:42:58.074711 kubelet[1698]: I0512 23:42:58.074676    1698 dynamic_cafile_content.go:160] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
May 12 23:42:58.090577 kubelet[1698]: E0512 23:42:58.090535    1698 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService"
May 12 23:42:58.090577 kubelet[1698]: I0512 23:42:58.090571    1698 server.go:1403] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config."
May 12 23:42:58.094457 kubelet[1698]: I0512 23:42:58.094417    1698 server.go:744] "--cgroups-per-qos enabled, but --cgroup-root was not specified.  defaulting to /"
May 12 23:42:58.095678 kubelet[1698]: I0512 23:42:58.095633    1698 swap_util.go:113] "Swap is on" /proc/swaps contents="Filename\t\t\t\tType\t\tSize\t\tUsed\t\tPriority"
May 12 23:42:58.096332 kubelet[1698]: I0512 23:42:58.095795    1698 container_manager_linux.go:264] "Container manager verified user specified cgroup-root exists" cgroupRoot=[]
May 12 23:42:58.096332 kubelet[1698]: I0512 23:42:58.095828    1698 container_manager_linux.go:269] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.33","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2}
May 12 23:42:58.096458 kubelet[1698]: I0512 23:42:58.096344    1698 topology_manager.go:138] "Creating topology manager with none policy"
May 12 23:42:58.096458 kubelet[1698]: I0512 23:42:58.096354    1698 container_manager_linux.go:300] "Creating device plugin manager"
May 12 23:42:58.096645 kubelet[1698]: I0512 23:42:58.096602    1698 state_mem.go:36] "Initialized new in-memory state store"
May 12 23:42:58.103060 kubelet[1698]: I0512 23:42:58.102482    1698 kubelet.go:408] "Attempting to sync node with API server"
May 12 23:42:58.103060 kubelet[1698]: I0512 23:42:58.102524    1698 kubelet.go:303] "Adding static pod path" path="/etc/kubernetes/manifests"
May 12 23:42:58.103060 kubelet[1698]: I0512 23:42:58.102691    1698 kubelet.go:314] "Adding apiserver pod source"
May 12 23:42:58.103060 kubelet[1698]: I0512 23:42:58.102703    1698 apiserver.go:42] "Waiting for node sync before watching apiserver pods"
May 12 23:42:58.103225 kubelet[1698]: E0512 23:42:58.103121    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:42:58.103621 kubelet[1698]: E0512 23:42:58.103413    1698 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:42:58.106273 kubelet[1698]: I0512 23:42:58.106239    1698 kuberuntime_manager.go:262] "Container runtime initialized" containerRuntime="containerd" version="v1.7.23" apiVersion="v1"
May 12 23:42:58.108474 kubelet[1698]: I0512 23:42:58.108444    1698 kubelet.go:837] "Not starting ClusterTrustBundle informer because we are in static kubelet mode"
May 12 23:42:58.108792 kubelet[1698]: W0512 23:42:58.108763    1698 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating.
May 12 23:42:58.109290 kubelet[1698]: W0512 23:42:58.109082    1698 reflector.go:561] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.33" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope
May 12 23:42:58.109290 kubelet[1698]: W0512 23:42:58.109119    1698 reflector.go:561] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope
May 12 23:42:58.109290 kubelet[1698]: E0512 23:42:58.109245    1698 reflector.go:158] "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"
May 12 23:42:58.109290 kubelet[1698]: E0512 23:42:58.109277    1698 reflector.go:158] "Unhandled Error" err="k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes \"10.0.0.33\" is forbidden: User \"system:anonymous\" cannot list resource \"nodes\" in API group \"\" at the cluster scope" logger="UnhandledError"
May 12 23:42:58.109774 kubelet[1698]: I0512 23:42:58.109738    1698 server.go:1269] "Started kubelet"
May 12 23:42:58.109972 kubelet[1698]: I0512 23:42:58.109939    1698 server.go:163] "Starting to listen" address="0.0.0.0" port=10250
May 12 23:42:58.110896 kubelet[1698]: I0512 23:42:58.110325    1698 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10
May 12 23:42:58.111236 kubelet[1698]: I0512 23:42:58.111175    1698 server.go:236] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock"
May 12 23:42:58.112136 kubelet[1698]: I0512 23:42:58.112111    1698 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer"
May 12 23:42:58.112477 kubelet[1698]: I0512 23:42:58.112438    1698 server.go:460] "Adding debug handlers to kubelet server"
May 12 23:42:58.114309 kubelet[1698]: I0512 23:42:58.114261    1698 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key"
May 12 23:42:58.116275 kubelet[1698]: E0512 23:42:58.115585    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.116275 kubelet[1698]: I0512 23:42:58.116168    1698 volume_manager.go:289] "Starting Kubelet Volume Manager"
May 12 23:42:58.116275 kubelet[1698]: I0512 23:42:58.116268    1698 desired_state_of_world_populator.go:146] "Desired state populator starts to run"
May 12 23:42:58.116416 kubelet[1698]: I0512 23:42:58.116341    1698 reconciler.go:26] "Reconciler: start to sync state"
May 12 23:42:58.116816 kubelet[1698]: I0512 23:42:58.116785    1698 factory.go:221] Registration of the systemd container factory successfully
May 12 23:42:58.116919 kubelet[1698]: I0512 23:42:58.116896    1698 factory.go:219] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory
May 12 23:42:58.117664 kubelet[1698]: E0512 23:42:58.117642    1698 kubelet.go:1478] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem"
May 12 23:42:58.119120 kubelet[1698]: I0512 23:42:58.119034    1698 factory.go:221] Registration of the containerd container factory successfully
May 12 23:42:58.128762 kubelet[1698]: E0512 23:42:58.128722    1698 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.33\" not found" node="10.0.0.33"
May 12 23:42:58.131857 kubelet[1698]: I0512 23:42:58.131781    1698 cpu_manager.go:214] "Starting CPU manager" policy="none"
May 12 23:42:58.131857 kubelet[1698]: I0512 23:42:58.131796    1698 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s"
May 12 23:42:58.131857 kubelet[1698]: I0512 23:42:58.131818    1698 state_mem.go:36] "Initialized new in-memory state store"
May 12 23:42:58.194842 kubelet[1698]: I0512 23:42:58.194583    1698 policy_none.go:49] "None policy: Start"
May 12 23:42:58.195842 kubelet[1698]: I0512 23:42:58.195437    1698 memory_manager.go:170] "Starting memorymanager" policy="None"
May 12 23:42:58.195842 kubelet[1698]: I0512 23:42:58.195471    1698 state_mem.go:35] "Initializing new in-memory state store"
May 12 23:42:58.201890 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice.
May 12 23:42:58.214417 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice.
May 12 23:42:58.215719 kubelet[1698]: E0512 23:42:58.215690    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.218271 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice.
May 12 23:42:58.224044 kubelet[1698]: I0512 23:42:58.223996    1698 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4"
May 12 23:42:58.225137 kubelet[1698]: I0512 23:42:58.225098    1698 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6"
May 12 23:42:58.225137 kubelet[1698]: I0512 23:42:58.225128    1698 status_manager.go:217] "Starting to sync pod status with apiserver"
May 12 23:42:58.225237 kubelet[1698]: I0512 23:42:58.225150    1698 kubelet.go:2321] "Starting kubelet main sync loop"
May 12 23:42:58.225237 kubelet[1698]: E0512 23:42:58.225200    1698 kubelet.go:2345] "Skipping pod synchronization" err="[container runtime status check may not have completed yet, PLEG is not healthy: pleg has yet to be successful]"
May 12 23:42:58.229474 kubelet[1698]: I0512 23:42:58.229221    1698 manager.go:510] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found"
May 12 23:42:58.229474 kubelet[1698]: I0512 23:42:58.229444    1698 eviction_manager.go:189] "Eviction manager: starting control loop"
May 12 23:42:58.229474 kubelet[1698]: I0512 23:42:58.229458    1698 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s"
May 12 23:42:58.230023 kubelet[1698]: I0512 23:42:58.229659    1698 plugin_manager.go:118] "Starting Kubelet Plugin Manager"
May 12 23:42:58.230786 kubelet[1698]: E0512 23:42:58.230763    1698 eviction_manager.go:285] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.33\" not found"
May 12 23:42:58.331205 kubelet[1698]: I0512 23:42:58.331068    1698 kubelet_node_status.go:72] "Attempting to register node" node="10.0.0.33"
May 12 23:42:58.335534 kubelet[1698]: I0512 23:42:58.335501    1698 kubelet_node_status.go:75] "Successfully registered node" node="10.0.0.33"
May 12 23:42:58.335534 kubelet[1698]: E0512 23:42:58.335537    1698 kubelet_node_status.go:535] "Error updating node status, will retry" err="error getting node \"10.0.0.33\": node \"10.0.0.33\" not found"
May 12 23:42:58.346620 kubelet[1698]: E0512 23:42:58.346586    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.447628 kubelet[1698]: E0512 23:42:58.447593    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.548584 kubelet[1698]: E0512 23:42:58.548537    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.649548 kubelet[1698]: E0512 23:42:58.649428    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.749945 kubelet[1698]: E0512 23:42:58.749905    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.793131 sudo[1573]: pam_unix(sudo:session): session closed for user root
May 12 23:42:58.794518 sshd[1572]: Connection closed by 10.0.0.1 port 49940
May 12 23:42:58.794912 sshd-session[1570]: pam_unix(sshd:session): session closed for user core
May 12 23:42:58.797649 systemd[1]: sshd@4-10.0.0.33:22-10.0.0.1:49940.service: Deactivated successfully.
May 12 23:42:58.799356 systemd[1]: session-5.scope: Deactivated successfully.
May 12 23:42:58.800626 systemd-logind[1424]: Session 5 logged out. Waiting for processes to exit.
May 12 23:42:58.802472 systemd-logind[1424]: Removed session 5.
May 12 23:42:58.850416 kubelet[1698]: E0512 23:42:58.850374    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:58.951464 kubelet[1698]: E0512 23:42:58.951362    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:59.031491 kubelet[1698]: I0512 23:42:59.031448    1698 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials"
May 12 23:42:59.031751 kubelet[1698]: W0512 23:42:59.031697    1698 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received
May 12 23:42:59.031751 kubelet[1698]: W0512 23:42:59.031705    1698 reflector.go:484] k8s.io/client-go/informers/factory.go:160: watch of *v1.CSIDriver ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received
May 12 23:42:59.051681 kubelet[1698]: E0512 23:42:59.051639    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:59.104117 kubelet[1698]: E0512 23:42:59.104073    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:42:59.152045 kubelet[1698]: E0512 23:42:59.152001    1698 kubelet_node_status.go:453] "Error getting the current node from lister" err="node \"10.0.0.33\" not found"
May 12 23:42:59.253624 kubelet[1698]: I0512 23:42:59.253502    1698 kuberuntime_manager.go:1633] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24"
May 12 23:42:59.253998 containerd[1436]: time="2025-05-12T23:42:59.253856060Z" level=info msg="No cni config template is specified, wait for other system components to drop the config."
May 12 23:42:59.254696 kubelet[1698]: I0512 23:42:59.254182    1698 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24"
May 12 23:43:00.104233 kubelet[1698]: E0512 23:43:00.104187    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:00.104615 kubelet[1698]: I0512 23:43:00.104324    1698 apiserver.go:52] "Watching apiserver"
May 12 23:43:00.116837 kubelet[1698]: I0512 23:43:00.116772    1698 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world"
May 12 23:43:00.120749 systemd[1]: Created slice kubepods-besteffort-pod4bffce16_bda4_41b0_9ed3_dde5db85832c.slice - libcontainer container kubepods-besteffort-pod4bffce16_bda4_41b0_9ed3_dde5db85832c.slice.
May 12 23:43:00.130839 kubelet[1698]: I0512 23:43:00.130538    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/41ae7b54-9d44-4604-817b-b47cc6ba545b-run\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.130839 kubelet[1698]: I0512 23:43:00.130584    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/41ae7b54-9d44-4604-817b-b47cc6ba545b-flannel-cfg\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.130839 kubelet[1698]: I0512 23:43:00.130608    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-f8p4h\" (UniqueName: \"kubernetes.io/projected/41ae7b54-9d44-4604-817b-b47cc6ba545b-kube-api-access-f8p4h\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.130839 kubelet[1698]: I0512 23:43:00.130652    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-djq4v\" (UniqueName: \"kubernetes.io/projected/4bffce16-bda4-41b0-9ed3-dde5db85832c-kube-api-access-djq4v\") pod \"kube-proxy-4st4t\" (UID: \"4bffce16-bda4-41b0-9ed3-dde5db85832c\") " pod="kube-system/kube-proxy-4st4t"
May 12 23:43:00.130839 kubelet[1698]: I0512 23:43:00.130684    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/4bffce16-bda4-41b0-9ed3-dde5db85832c-lib-modules\") pod \"kube-proxy-4st4t\" (UID: \"4bffce16-bda4-41b0-9ed3-dde5db85832c\") " pod="kube-system/kube-proxy-4st4t"
May 12 23:43:00.131207 kubelet[1698]: I0512 23:43:00.130702    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/41ae7b54-9d44-4604-817b-b47cc6ba545b-cni-plugin\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.131207 kubelet[1698]: I0512 23:43:00.130717    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/41ae7b54-9d44-4604-817b-b47cc6ba545b-cni\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.131207 kubelet[1698]: I0512 23:43:00.130733    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/41ae7b54-9d44-4604-817b-b47cc6ba545b-xtables-lock\") pod \"kube-flannel-ds-l5xw7\" (UID: \"41ae7b54-9d44-4604-817b-b47cc6ba545b\") " pod="kube-flannel/kube-flannel-ds-l5xw7"
May 12 23:43:00.131207 kubelet[1698]: I0512 23:43:00.130752    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/4bffce16-bda4-41b0-9ed3-dde5db85832c-kube-proxy\") pod \"kube-proxy-4st4t\" (UID: \"4bffce16-bda4-41b0-9ed3-dde5db85832c\") " pod="kube-system/kube-proxy-4st4t"
May 12 23:43:00.131207 kubelet[1698]: I0512 23:43:00.130767    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/4bffce16-bda4-41b0-9ed3-dde5db85832c-xtables-lock\") pod \"kube-proxy-4st4t\" (UID: \"4bffce16-bda4-41b0-9ed3-dde5db85832c\") " pod="kube-system/kube-proxy-4st4t"
May 12 23:43:00.134751 systemd[1]: Created slice kubepods-burstable-pod41ae7b54_9d44_4604_817b_b47cc6ba545b.slice - libcontainer container kubepods-burstable-pod41ae7b54_9d44_4604_817b_b47cc6ba545b.slice.
May 12 23:43:00.434678 kubelet[1698]: E0512 23:43:00.432868    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:00.434791 containerd[1436]: time="2025-05-12T23:43:00.433914536Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-4st4t,Uid:4bffce16-bda4-41b0-9ed3-dde5db85832c,Namespace:kube-system,Attempt:0,}"
May 12 23:43:00.450713 kubelet[1698]: E0512 23:43:00.450586    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:00.451175 containerd[1436]: time="2025-05-12T23:43:00.451143217Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-l5xw7,Uid:41ae7b54-9d44-4604-817b-b47cc6ba545b,Namespace:kube-flannel,Attempt:0,}"
May 12 23:43:01.030442 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1562750386.mount: Deactivated successfully.
May 12 23:43:01.035230 containerd[1436]: time="2025-05-12T23:43:01.035176751Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}  labels:{key:\"io.cri-containerd.pinned\"  value:\"pinned\"}"
May 12 23:43:01.037723 containerd[1436]: time="2025-05-12T23:43:01.037685625Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269175"
May 12 23:43:01.038578 containerd[1436]: time="2025-05-12T23:43:01.038531003Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}  labels:{key:\"io.cri-containerd.pinned\"  value:\"pinned\"}"
May 12 23:43:01.040019 containerd[1436]: time="2025-05-12T23:43:01.039986322Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}  labels:{key:\"io.cri-containerd.pinned\"  value:\"pinned\"}"
May 12 23:43:01.040838 containerd[1436]: time="2025-05-12T23:43:01.040466471Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0"
May 12 23:43:01.041778 containerd[1436]: time="2025-05-12T23:43:01.041747829Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}  labels:{key:\"io.cri-containerd.pinned\"  value:\"pinned\"}"
May 12 23:43:01.044159 containerd[1436]: time="2025-05-12T23:43:01.044129191Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 592.906391ms"
May 12 23:43:01.045058 containerd[1436]: time="2025-05-12T23:43:01.044883671Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"268403\" in 610.886115ms"
May 12 23:43:01.104794 kubelet[1698]: E0512 23:43:01.104747    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:01.174943 containerd[1436]: time="2025-05-12T23:43:01.174522378Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 12 23:43:01.174943 containerd[1436]: time="2025-05-12T23:43:01.174591490Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 12 23:43:01.174943 containerd[1436]: time="2025-05-12T23:43:01.174602642Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:01.174943 containerd[1436]: time="2025-05-12T23:43:01.174666518Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:01.183130 containerd[1436]: time="2025-05-12T23:43:01.182799082Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 12 23:43:01.183130 containerd[1436]: time="2025-05-12T23:43:01.182854564Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 12 23:43:01.183130 containerd[1436]: time="2025-05-12T23:43:01.182869513Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:01.183130 containerd[1436]: time="2025-05-12T23:43:01.182953136Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:01.286427 systemd[1]: Started cri-containerd-f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68.scope - libcontainer container f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68.
May 12 23:43:01.292557 systemd[1]: Started cri-containerd-abf8c98dc1826da0b8b0b379a857e0f60f124117473095374d253d56a2cf8310.scope - libcontainer container abf8c98dc1826da0b8b0b379a857e0f60f124117473095374d253d56a2cf8310.
May 12 23:43:01.325474 containerd[1436]: time="2025-05-12T23:43:01.325288065Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-4st4t,Uid:4bffce16-bda4-41b0-9ed3-dde5db85832c,Namespace:kube-system,Attempt:0,} returns sandbox id \"abf8c98dc1826da0b8b0b379a857e0f60f124117473095374d253d56a2cf8310\""
May 12 23:43:01.327162 kubelet[1698]: E0512 23:43:01.327128    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:01.328551 containerd[1436]: time="2025-05-12T23:43:01.328423867Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.8\""
May 12 23:43:01.332061 containerd[1436]: time="2025-05-12T23:43:01.331986135Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-l5xw7,Uid:41ae7b54-9d44-4604-817b-b47cc6ba545b,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\""
May 12 23:43:01.332644 kubelet[1698]: E0512 23:43:01.332550    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:02.105023 kubelet[1698]: E0512 23:43:02.104973    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:02.254395 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount463656815.mount: Deactivated successfully.
May 12 23:43:02.483009 containerd[1436]: time="2025-05-12T23:43:02.482881786Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.31.8\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:02.483705 containerd[1436]: time="2025-05-12T23:43:02.483665024Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.31.8: active requests=0, bytes read=26871919"
May 12 23:43:02.484339 containerd[1436]: time="2025-05-12T23:43:02.484302839Z" level=info msg="ImageCreate event name:\"sha256:c5361ece77e80334cd5fb082c0b678cb3244f5834ecacea1719ae6b38b465581\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:02.487054 containerd[1436]: time="2025-05-12T23:43:02.487023265Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:dd0c9a37670f209947b1ed880f06a2e93e1d41da78c037f52f94b13858769838\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:02.488459 containerd[1436]: time="2025-05-12T23:43:02.488418175Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.31.8\" with image id \"sha256:c5361ece77e80334cd5fb082c0b678cb3244f5834ecacea1719ae6b38b465581\", repo tag \"registry.k8s.io/kube-proxy:v1.31.8\", repo digest \"registry.k8s.io/kube-proxy@sha256:dd0c9a37670f209947b1ed880f06a2e93e1d41da78c037f52f94b13858769838\", size \"26870936\" in 1.159954056s"
May 12 23:43:02.488509 containerd[1436]: time="2025-05-12T23:43:02.488460347Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.31.8\" returns image reference \"sha256:c5361ece77e80334cd5fb082c0b678cb3244f5834ecacea1719ae6b38b465581\""
May 12 23:43:02.489831 containerd[1436]: time="2025-05-12T23:43:02.489770594Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\""
May 12 23:43:02.490687 containerd[1436]: time="2025-05-12T23:43:02.490651766Z" level=info msg="CreateContainer within sandbox \"abf8c98dc1826da0b8b0b379a857e0f60f124117473095374d253d56a2cf8310\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}"
May 12 23:43:02.507409 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1478353905.mount: Deactivated successfully.
May 12 23:43:02.511168 containerd[1436]: time="2025-05-12T23:43:02.511125597Z" level=info msg="CreateContainer within sandbox \"abf8c98dc1826da0b8b0b379a857e0f60f124117473095374d253d56a2cf8310\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"4d2c8d4492c973dd4b870c9432ee08835d6b4f57aaabbca9a9a6be37e965892e\""
May 12 23:43:02.511817 containerd[1436]: time="2025-05-12T23:43:02.511789794Z" level=info msg="StartContainer for \"4d2c8d4492c973dd4b870c9432ee08835d6b4f57aaabbca9a9a6be37e965892e\""
May 12 23:43:02.546444 systemd[1]: Started cri-containerd-4d2c8d4492c973dd4b870c9432ee08835d6b4f57aaabbca9a9a6be37e965892e.scope - libcontainer container 4d2c8d4492c973dd4b870c9432ee08835d6b4f57aaabbca9a9a6be37e965892e.
May 12 23:43:02.575442 containerd[1436]: time="2025-05-12T23:43:02.573405158Z" level=info msg="StartContainer for \"4d2c8d4492c973dd4b870c9432ee08835d6b4f57aaabbca9a9a6be37e965892e\" returns successfully"
May 12 23:43:03.106053 kubelet[1698]: E0512 23:43:03.105989    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:03.236990 kubelet[1698]: E0512 23:43:03.236958    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:03.244988 kubelet[1698]: I0512 23:43:03.244905    1698 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-4st4t" podStartSLOduration=4.083503503 podStartE2EDuration="5.24489023s" podCreationTimestamp="2025-05-12 23:42:58 +0000 UTC" firstStartedPulling="2025-05-12 23:43:01.327833553 +0000 UTC m=+4.057376776" lastFinishedPulling="2025-05-12 23:43:02.48922032 +0000 UTC m=+5.218763503" observedRunningTime="2025-05-12 23:43:03.244883234 +0000 UTC m=+5.974426457" watchObservedRunningTime="2025-05-12 23:43:03.24489023 +0000 UTC m=+5.974433453"
May 12 23:43:03.657453 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2659633620.mount: Deactivated successfully.
May 12 23:43:03.686544 containerd[1436]: time="2025-05-12T23:43:03.686499835Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:03.686995 containerd[1436]: time="2025-05-12T23:43:03.686946906Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673532"
May 12 23:43:03.687727 containerd[1436]: time="2025-05-12T23:43:03.687703777Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:03.689899 containerd[1436]: time="2025-05-12T23:43:03.689844115Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:03.690914 containerd[1436]: time="2025-05-12T23:43:03.690780031Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3662650\" in 1.200976619s"
May 12 23:43:03.690914 containerd[1436]: time="2025-05-12T23:43:03.690816048Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\""
May 12 23:43:03.692705 containerd[1436]: time="2025-05-12T23:43:03.692674727Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}"
May 12 23:43:03.705230 containerd[1436]: time="2025-05-12T23:43:03.705142156Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a\""
May 12 23:43:03.705630 containerd[1436]: time="2025-05-12T23:43:03.705598421Z" level=info msg="StartContainer for \"5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a\""
May 12 23:43:03.731447 systemd[1]: Started cri-containerd-5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a.scope - libcontainer container 5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a.
May 12 23:43:03.760769 containerd[1436]: time="2025-05-12T23:43:03.760674652Z" level=info msg="StartContainer for \"5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a\" returns successfully"
May 12 23:43:03.764816 systemd[1]: cri-containerd-5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a.scope: Deactivated successfully.
May 12 23:43:03.917007 containerd[1436]: time="2025-05-12T23:43:03.916815775Z" level=info msg="shim disconnected" id=5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a namespace=k8s.io
May 12 23:43:03.917007 containerd[1436]: time="2025-05-12T23:43:03.916872898Z" level=warning msg="cleaning up after shim disconnected" id=5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a namespace=k8s.io
May 12 23:43:03.917007 containerd[1436]: time="2025-05-12T23:43:03.916880693Z" level=info msg="cleaning up dead shim" namespace=k8s.io
May 12 23:43:04.107022 kubelet[1698]: E0512 23:43:04.106977    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:04.239962 kubelet[1698]: E0512 23:43:04.239723    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:04.239962 kubelet[1698]: E0512 23:43:04.239762    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:04.240575 containerd[1436]: time="2025-05-12T23:43:04.240521115Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\""
May 12 23:43:04.608986 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-5853489ddd79ced7956b8ab0c331620979c08fa671b98e09f026b866323e594a-rootfs.mount: Deactivated successfully.
May 12 23:43:05.108148 kubelet[1698]: E0512 23:43:05.108042    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:05.384367 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1737648015.mount: Deactivated successfully.
May 12 23:43:05.874488 containerd[1436]: time="2025-05-12T23:43:05.874370017Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:05.875388 containerd[1436]: time="2025-05-12T23:43:05.874956582Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874260"
May 12 23:43:05.876469 containerd[1436]: time="2025-05-12T23:43:05.876423093Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:05.880019 containerd[1436]: time="2025-05-12T23:43:05.879943400Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:05.881443 containerd[1436]: time="2025-05-12T23:43:05.881301377Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26863435\" in 1.640730413s"
May 12 23:43:05.881443 containerd[1436]: time="2025-05-12T23:43:05.881336875Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\""
May 12 23:43:05.884600 containerd[1436]: time="2025-05-12T23:43:05.884408414Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}"
May 12 23:43:05.898603 containerd[1436]: time="2025-05-12T23:43:05.898560997Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5\""
May 12 23:43:05.899172 containerd[1436]: time="2025-05-12T23:43:05.899143484Z" level=info msg="StartContainer for \"b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5\""
May 12 23:43:05.927442 systemd[1]: Started cri-containerd-b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5.scope - libcontainer container b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5.
May 12 23:43:05.955546 containerd[1436]: time="2025-05-12T23:43:05.955497930Z" level=info msg="StartContainer for \"b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5\" returns successfully"
May 12 23:43:05.961186 systemd[1]: cri-containerd-b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5.scope: Deactivated successfully.
May 12 23:43:05.984232 kubelet[1698]: I0512 23:43:05.984155    1698 kubelet_node_status.go:488] "Fast updating node status as it just became ready"
May 12 23:43:06.072263 containerd[1436]: time="2025-05-12T23:43:06.072187794Z" level=info msg="shim disconnected" id=b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5 namespace=k8s.io
May 12 23:43:06.072263 containerd[1436]: time="2025-05-12T23:43:06.072241443Z" level=warning msg="cleaning up after shim disconnected" id=b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5 namespace=k8s.io
May 12 23:43:06.072263 containerd[1436]: time="2025-05-12T23:43:06.072268587Z" level=info msg="cleaning up dead shim" namespace=k8s.io
May 12 23:43:06.108377 kubelet[1698]: E0512 23:43:06.108325    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:06.244422 kubelet[1698]: E0512 23:43:06.244297    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:06.246015 containerd[1436]: time="2025-05-12T23:43:06.245972685Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}"
May 12 23:43:06.401432 containerd[1436]: time="2025-05-12T23:43:06.401336351Z" level=info msg="CreateContainer within sandbox \"f5acfa3a025f2947e5e7d89c89d5813dc127e21d6c2673db8416d28c37784a68\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"608b5fe3977a7c2bf122e7844a5148addee11735292fb1fd4ff0ded2e1ccba54\""
May 12 23:43:06.401888 containerd[1436]: time="2025-05-12T23:43:06.401838576Z" level=info msg="StartContainer for \"608b5fe3977a7c2bf122e7844a5148addee11735292fb1fd4ff0ded2e1ccba54\""
May 12 23:43:06.443144 systemd[1]: Started cri-containerd-608b5fe3977a7c2bf122e7844a5148addee11735292fb1fd4ff0ded2e1ccba54.scope - libcontainer container 608b5fe3977a7c2bf122e7844a5148addee11735292fb1fd4ff0ded2e1ccba54.
May 12 23:43:06.484668 containerd[1436]: time="2025-05-12T23:43:06.484588953Z" level=info msg="StartContainer for \"608b5fe3977a7c2bf122e7844a5148addee11735292fb1fd4ff0ded2e1ccba54\" returns successfully"
May 12 23:43:06.891681 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b23721017141d80b7126876638df27b24ea5590259012ce0d813cfc769c828f5-rootfs.mount: Deactivated successfully.
May 12 23:43:07.109459 kubelet[1698]: E0512 23:43:07.109385    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:07.248183 kubelet[1698]: E0512 23:43:07.248067    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:07.577730 systemd-networkd[1373]: flannel.1: Link UP
May 12 23:43:07.577740 systemd-networkd[1373]: flannel.1: Gained carrier
May 12 23:43:08.109884 kubelet[1698]: E0512 23:43:08.109838    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:08.250188 kubelet[1698]: E0512 23:43:08.250112    1698 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8"
May 12 23:43:09.110811 kubelet[1698]: E0512 23:43:09.110745    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:09.199723 systemd-networkd[1373]: flannel.1: Gained IPv6LL
May 12 23:43:09.709869 kubelet[1698]: I0512 23:43:09.709802    1698 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-l5xw7" podStartSLOduration=7.159728274 podStartE2EDuration="11.709782596s" podCreationTimestamp="2025-05-12 23:42:58 +0000 UTC" firstStartedPulling="2025-05-12 23:43:01.333066112 +0000 UTC m=+4.062609335" lastFinishedPulling="2025-05-12 23:43:05.883120434 +0000 UTC m=+8.612663657" observedRunningTime="2025-05-12 23:43:07.26781791 +0000 UTC m=+9.997361133" watchObservedRunningTime="2025-05-12 23:43:09.709782596 +0000 UTC m=+12.439325819"
May 12 23:43:09.718848 systemd[1]: Created slice kubepods-besteffort-podcc60ae4e_58ee_4ef7_932e_efb127e42771.slice - libcontainer container kubepods-besteffort-podcc60ae4e_58ee_4ef7_932e_efb127e42771.slice.
May 12 23:43:09.787816 kubelet[1698]: I0512 23:43:09.787769    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-cdbs9\" (UniqueName: \"kubernetes.io/projected/cc60ae4e-58ee-4ef7-932e-efb127e42771-kube-api-access-cdbs9\") pod \"nginx-deployment-8587fbcb89-kfwzc\" (UID: \"cc60ae4e-58ee-4ef7-932e-efb127e42771\") " pod="default/nginx-deployment-8587fbcb89-kfwzc"
May 12 23:43:10.026350 containerd[1436]: time="2025-05-12T23:43:10.026213613Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-kfwzc,Uid:cc60ae4e-58ee-4ef7-932e-efb127e42771,Namespace:default,Attempt:0,}"
May 12 23:43:10.079716 systemd-networkd[1373]: cni0: Link UP
May 12 23:43:10.079722 systemd-networkd[1373]: cni0: Gained carrier
May 12 23:43:10.079958 systemd-networkd[1373]: cni0: Lost carrier
May 12 23:43:10.096828 systemd-networkd[1373]: veth30abd187: Link UP
May 12 23:43:10.098416 kernel: cni0: port 1(veth30abd187) entered blocking state
May 12 23:43:10.098499 kernel: cni0: port 1(veth30abd187) entered disabled state
May 12 23:43:10.098523 kernel: veth30abd187: entered allmulticast mode
May 12 23:43:10.099660 kernel: veth30abd187: entered promiscuous mode
May 12 23:43:10.100899 kernel: cni0: port 1(veth30abd187) entered blocking state
May 12 23:43:10.100956 kernel: cni0: port 1(veth30abd187) entered forwarding state
May 12 23:43:10.102116 kernel: cni0: port 1(veth30abd187) entered disabled state
May 12 23:43:10.112351 kubelet[1698]: E0512 23:43:10.112314    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:10.115858 kernel: cni0: port 1(veth30abd187) entered blocking state
May 12 23:43:10.115932 kernel: cni0: port 1(veth30abd187) entered forwarding state
May 12 23:43:10.115272 systemd-networkd[1373]: veth30abd187: Gained carrier
May 12 23:43:10.115498 systemd-networkd[1373]: cni0: Gained carrier
May 12 23:43:10.116762 containerd[1436]: 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)(0x4000012938), "name":"cbr0", "type":"bridge"}
May 12 23:43:10.116762 containerd[1436]: delegateAdd: netconf sent to delegate plugin:
May 12 23:43:10.142715 containerd[1436]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-05-12T23:43:10.142633858Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 12 23:43:10.142715 containerd[1436]: time="2025-05-12T23:43:10.142683793Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 12 23:43:10.142715 containerd[1436]: time="2025-05-12T23:43:10.142700424Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:10.142893 containerd[1436]: time="2025-05-12T23:43:10.142782741Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:10.167427 systemd[1]: Started cri-containerd-055b218200646f0ad7460ea8697c821fd65a50f5fb234f5616bbdd65cb900c29.scope - libcontainer container 055b218200646f0ad7460ea8697c821fd65a50f5fb234f5616bbdd65cb900c29.
May 12 23:43:10.176674 systemd-resolved[1315]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 12 23:43:10.192357 containerd[1436]: time="2025-05-12T23:43:10.192315611Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-8587fbcb89-kfwzc,Uid:cc60ae4e-58ee-4ef7-932e-efb127e42771,Namespace:default,Attempt:0,} returns sandbox id \"055b218200646f0ad7460ea8697c821fd65a50f5fb234f5616bbdd65cb900c29\""
May 12 23:43:10.193560 containerd[1436]: time="2025-05-12T23:43:10.193521907Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\""
May 12 23:43:11.112894 kubelet[1698]: E0512 23:43:11.112842    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:11.376380 systemd-networkd[1373]: cni0: Gained IPv6LL
May 12 23:43:11.567453 systemd-networkd[1373]: veth30abd187: Gained IPv6LL
May 12 23:43:11.961050 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1264513183.mount: Deactivated successfully.
May 12 23:43:12.113839 kubelet[1698]: E0512 23:43:12.113801    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:12.743915 containerd[1436]: time="2025-05-12T23:43:12.743869754Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:12.744439 containerd[1436]: time="2025-05-12T23:43:12.744391461Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=69948859"
May 12 23:43:12.745073 containerd[1436]: time="2025-05-12T23:43:12.745046543Z" level=info msg="ImageCreate event name:\"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:12.748159 containerd[1436]: time="2025-05-12T23:43:12.748118652Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:beabce8f1782671ba500ddff99dd260fbf9c5ec85fb9c3162e35a3c40bafd023\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:12.749356 containerd[1436]: time="2025-05-12T23:43:12.749332183Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:beabce8f1782671ba500ddff99dd260fbf9c5ec85fb9c3162e35a3c40bafd023\", size \"69948737\" in 2.555770656s"
May 12 23:43:12.749356 containerd[1436]: time="2025-05-12T23:43:12.749358691Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\""
May 12 23:43:12.751739 containerd[1436]: time="2025-05-12T23:43:12.751606920Z" level=info msg="CreateContainer within sandbox \"055b218200646f0ad7460ea8697c821fd65a50f5fb234f5616bbdd65cb900c29\" for container &ContainerMetadata{Name:nginx,Attempt:0,}"
May 12 23:43:12.763177 containerd[1436]: time="2025-05-12T23:43:12.763121413Z" level=info msg="CreateContainer within sandbox \"055b218200646f0ad7460ea8697c821fd65a50f5fb234f5616bbdd65cb900c29\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"cc2174383b4bc06fa6dcd7104101600fe2ecc12b01e9f46f762bbda21960ef9b\""
May 12 23:43:12.763701 containerd[1436]: time="2025-05-12T23:43:12.763670826Z" level=info msg="StartContainer for \"cc2174383b4bc06fa6dcd7104101600fe2ecc12b01e9f46f762bbda21960ef9b\""
May 12 23:43:12.786695 systemd[1]: Started cri-containerd-cc2174383b4bc06fa6dcd7104101600fe2ecc12b01e9f46f762bbda21960ef9b.scope - libcontainer container cc2174383b4bc06fa6dcd7104101600fe2ecc12b01e9f46f762bbda21960ef9b.
May 12 23:43:12.808543 containerd[1436]: time="2025-05-12T23:43:12.808499474Z" level=info msg="StartContainer for \"cc2174383b4bc06fa6dcd7104101600fe2ecc12b01e9f46f762bbda21960ef9b\" returns successfully"
May 12 23:43:13.114623 kubelet[1698]: E0512 23:43:13.114493    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:13.267067 kubelet[1698]: I0512 23:43:13.266900    1698 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-8587fbcb89-kfwzc" podStartSLOduration=1.7100136099999999 podStartE2EDuration="4.266886604s" podCreationTimestamp="2025-05-12 23:43:09 +0000 UTC" firstStartedPulling="2025-05-12 23:43:10.193317253 +0000 UTC m=+12.922860436" lastFinishedPulling="2025-05-12 23:43:12.750190207 +0000 UTC m=+15.479733430" observedRunningTime="2025-05-12 23:43:13.266814638 +0000 UTC m=+15.996357861" watchObservedRunningTime="2025-05-12 23:43:13.266886604 +0000 UTC m=+15.996429827"
May 12 23:43:14.115004 kubelet[1698]: E0512 23:43:14.114963    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:15.115728 kubelet[1698]: E0512 23:43:15.115682    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:16.117658 kubelet[1698]: E0512 23:43:16.116200    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:16.786338 systemd[1]: Created slice kubepods-besteffort-poda2243a4d_c5ce_4c1b_b4b9_e934dfb69a7f.slice - libcontainer container kubepods-besteffort-poda2243a4d_c5ce_4c1b_b4b9_e934dfb69a7f.slice.
May 12 23:43:16.826443 kubelet[1698]: I0512 23:43:16.826334    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f-data\") pod \"nfs-server-provisioner-0\" (UID: \"a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f\") " pod="default/nfs-server-provisioner-0"
May 12 23:43:16.826443 kubelet[1698]: I0512 23:43:16.826389    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-x9hjc\" (UniqueName: \"kubernetes.io/projected/a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f-kube-api-access-x9hjc\") pod \"nfs-server-provisioner-0\" (UID: \"a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f\") " pod="default/nfs-server-provisioner-0"
May 12 23:43:17.089523 containerd[1436]: time="2025-05-12T23:43:17.089357814Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f,Namespace:default,Attempt:0,}"
May 12 23:43:17.116689 systemd-networkd[1373]: veth3775cc8b: Link UP
May 12 23:43:17.116979 kubelet[1698]: E0512 23:43:17.116885    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:17.119037 kernel: cni0: port 2(veth3775cc8b) entered blocking state
May 12 23:43:17.119104 kernel: cni0: port 2(veth3775cc8b) entered disabled state
May 12 23:43:17.119123 kernel: veth3775cc8b: entered allmulticast mode
May 12 23:43:17.119135 kernel: veth3775cc8b: entered promiscuous mode
May 12 23:43:17.123785 kernel: cni0: port 2(veth3775cc8b) entered blocking state
May 12 23:43:17.123917 kernel: cni0: port 2(veth3775cc8b) entered forwarding state
May 12 23:43:17.123970 systemd-networkd[1373]: veth3775cc8b: Gained carrier
May 12 23:43:17.125763 containerd[1436]: 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)(0x4000016938), "name":"cbr0", "type":"bridge"}
May 12 23:43:17.125763 containerd[1436]: delegateAdd: netconf sent to delegate plugin:
May 12 23:43:17.143163 containerd[1436]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-05-12T23:43:17.143069619Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 12 23:43:17.143786 containerd[1436]: time="2025-05-12T23:43:17.143737742Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 12 23:43:17.143846 containerd[1436]: time="2025-05-12T23:43:17.143783443Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:17.143846 containerd[1436]: time="2025-05-12T23:43:17.143882642Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:17.163461 systemd[1]: Started cri-containerd-e950db579a2b6a0ed2842dc479a2b0d114c09adc90ec51af501323d7ed361fe3.scope - libcontainer container e950db579a2b6a0ed2842dc479a2b0d114c09adc90ec51af501323d7ed361fe3.
May 12 23:43:17.172937 systemd-resolved[1315]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 12 23:43:17.189843 containerd[1436]: time="2025-05-12T23:43:17.189795596Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a2243a4d-c5ce-4c1b-b4b9-e934dfb69a7f,Namespace:default,Attempt:0,} returns sandbox id \"e950db579a2b6a0ed2842dc479a2b0d114c09adc90ec51af501323d7ed361fe3\""
May 12 23:43:17.191643 containerd[1436]: time="2025-05-12T23:43:17.191608485Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\""
May 12 23:43:18.103123 kubelet[1698]: E0512 23:43:18.103065    1698 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:18.117987 kubelet[1698]: E0512 23:43:18.117925    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:18.543405 systemd-networkd[1373]: veth3775cc8b: Gained IPv6LL
May 12 23:43:19.118376 kubelet[1698]: E0512 23:43:19.118331    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:19.678086 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3280934760.mount: Deactivated successfully.
May 12 23:43:20.119097 kubelet[1698]: E0512 23:43:20.118872    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:21.091516 containerd[1436]: time="2025-05-12T23:43:21.091449709Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:21.092063 containerd[1436]: time="2025-05-12T23:43:21.092005387Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625"
May 12 23:43:21.093957 containerd[1436]: time="2025-05-12T23:43:21.093908493Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:21.096784 containerd[1436]: time="2025-05-12T23:43:21.096736942Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:21.098244 containerd[1436]: time="2025-05-12T23:43:21.098199928Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"87371201\" in 3.906425311s"
May 12 23:43:21.098303 containerd[1436]: time="2025-05-12T23:43:21.098242433Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\""
May 12 23:43:21.100816 containerd[1436]: time="2025-05-12T23:43:21.100774390Z" level=info msg="CreateContainer within sandbox \"e950db579a2b6a0ed2842dc479a2b0d114c09adc90ec51af501323d7ed361fe3\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}"
May 12 23:43:21.115409 containerd[1436]: time="2025-05-12T23:43:21.115363111Z" level=info msg="CreateContainer within sandbox \"e950db579a2b6a0ed2842dc479a2b0d114c09adc90ec51af501323d7ed361fe3\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"9275bcdf1ae0f49650dcfa77eda644b84f8d4596c0ba74faeb35143d525d570a\""
May 12 23:43:21.116105 containerd[1436]: time="2025-05-12T23:43:21.116032667Z" level=info msg="StartContainer for \"9275bcdf1ae0f49650dcfa77eda644b84f8d4596c0ba74faeb35143d525d570a\""
May 12 23:43:21.119011 kubelet[1698]: E0512 23:43:21.118970    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:21.143449 systemd[1]: Started cri-containerd-9275bcdf1ae0f49650dcfa77eda644b84f8d4596c0ba74faeb35143d525d570a.scope - libcontainer container 9275bcdf1ae0f49650dcfa77eda644b84f8d4596c0ba74faeb35143d525d570a.
May 12 23:43:21.169341 containerd[1436]: time="2025-05-12T23:43:21.169295408Z" level=info msg="StartContainer for \"9275bcdf1ae0f49650dcfa77eda644b84f8d4596c0ba74faeb35143d525d570a\" returns successfully"
May 12 23:43:22.119987 kubelet[1698]: E0512 23:43:22.119936    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:23.121020 kubelet[1698]: E0512 23:43:23.120942    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:24.121836 kubelet[1698]: E0512 23:43:24.121786    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:25.122458 kubelet[1698]: E0512 23:43:25.122404    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:26.122724 kubelet[1698]: E0512 23:43:26.122679    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:27.123614 kubelet[1698]: E0512 23:43:27.123561    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:28.124337 kubelet[1698]: E0512 23:43:28.124302    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:29.125433 kubelet[1698]: E0512 23:43:29.125353    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:30.126034 kubelet[1698]: E0512 23:43:30.125995    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:31.059615 kubelet[1698]: I0512 23:43:31.059541    1698 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=11.151323538 podStartE2EDuration="15.059516375s" podCreationTimestamp="2025-05-12 23:43:16 +0000 UTC" firstStartedPulling="2025-05-12 23:43:17.191155513 +0000 UTC m=+19.920698736" lastFinishedPulling="2025-05-12 23:43:21.09934835 +0000 UTC m=+23.828891573" observedRunningTime="2025-05-12 23:43:21.285072439 +0000 UTC m=+24.014615662" watchObservedRunningTime="2025-05-12 23:43:31.059516375 +0000 UTC m=+33.789059558"
May 12 23:43:31.065726 systemd[1]: Created slice kubepods-besteffort-pod108fd993_a94e_4c7c_bc97_4836d7064b18.slice - libcontainer container kubepods-besteffort-pod108fd993_a94e_4c7c_bc97_4836d7064b18.slice.
May 12 23:43:31.105585 kubelet[1698]: I0512 23:43:31.105541    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-14e8c3fb-9e44-41f6-9226-ad16c531f070\" (UniqueName: \"kubernetes.io/nfs/108fd993-a94e-4c7c-bc97-4836d7064b18-pvc-14e8c3fb-9e44-41f6-9226-ad16c531f070\") pod \"test-pod-1\" (UID: \"108fd993-a94e-4c7c-bc97-4836d7064b18\") " pod="default/test-pod-1"
May 12 23:43:31.105585 kubelet[1698]: I0512 23:43:31.105585    1698 reconciler_common.go:245] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-ldrk9\" (UniqueName: \"kubernetes.io/projected/108fd993-a94e-4c7c-bc97-4836d7064b18-kube-api-access-ldrk9\") pod \"test-pod-1\" (UID: \"108fd993-a94e-4c7c-bc97-4836d7064b18\") " pod="default/test-pod-1"
May 12 23:43:31.126777 kubelet[1698]: E0512 23:43:31.126589    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:31.239308 kernel: FS-Cache: Loaded
May 12 23:43:31.266734 kernel: RPC: Registered named UNIX socket transport module.
May 12 23:43:31.266876 kernel: RPC: Registered udp transport module.
May 12 23:43:31.266896 kernel: RPC: Registered tcp transport module.
May 12 23:43:31.267666 kernel: RPC: Registered tcp-with-tls transport module.
May 12 23:43:31.267704 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
May 12 23:43:31.447360 kernel: NFS: Registering the id_resolver key type
May 12 23:43:31.447474 kernel: Key type id_resolver registered
May 12 23:43:31.448338 kernel: Key type id_legacy registered
May 12 23:43:31.486351 nfsidmap[2731]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain'
May 12 23:43:31.491793 nfsidmap[2734]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain'
May 12 23:43:31.669789 containerd[1436]: time="2025-05-12T23:43:31.669710163Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:108fd993-a94e-4c7c-bc97-4836d7064b18,Namespace:default,Attempt:0,}"
May 12 23:43:31.688425 systemd-networkd[1373]: veth4f0dad03: Link UP
May 12 23:43:31.689510 kernel: cni0: port 3(veth4f0dad03) entered blocking state
May 12 23:43:31.689581 kernel: cni0: port 3(veth4f0dad03) entered disabled state
May 12 23:43:31.689596 kernel: veth4f0dad03: entered allmulticast mode
May 12 23:43:31.690505 kernel: veth4f0dad03: entered promiscuous mode
May 12 23:43:31.694745 kernel: cni0: port 3(veth4f0dad03) entered blocking state
May 12 23:43:31.694831 kernel: cni0: port 3(veth4f0dad03) entered forwarding state
May 12 23:43:31.694933 systemd-networkd[1373]: veth4f0dad03: Gained carrier
May 12 23:43:31.698910 containerd[1436]: 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)(0x4000014938), "name":"cbr0", "type":"bridge"}
May 12 23:43:31.698910 containerd[1436]: delegateAdd: netconf sent to delegate plugin:
May 12 23:43:31.714741 containerd[1436]: {"cniVersion":"0.3.1","hairpinMode":true,"ipMasq":false,"ipam":{"ranges":[[{"subnet":"192.168.1.0/24"}]],"routes":[{"dst":"192.168.0.0/17"}],"type":"host-local"},"isDefaultGateway":true,"isGateway":true,"mtu":1450,"name":"cbr0","type":"bridge"}time="2025-05-12T23:43:31.714535907Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
May 12 23:43:31.714958 containerd[1436]: time="2025-05-12T23:43:31.714904849Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
May 12 23:43:31.714958 containerd[1436]: time="2025-05-12T23:43:31.714934122Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:31.715200 containerd[1436]: time="2025-05-12T23:43:31.715143386Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
May 12 23:43:31.734470 systemd[1]: Started cri-containerd-617f13992c1789cb7a7adf2ec844a545f502e15463c55e8c0b06aaace165ece6.scope - libcontainer container 617f13992c1789cb7a7adf2ec844a545f502e15463c55e8c0b06aaace165ece6.
May 12 23:43:31.750944 systemd-resolved[1315]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
May 12 23:43:31.769431 containerd[1436]: time="2025-05-12T23:43:31.769389310Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:108fd993-a94e-4c7c-bc97-4836d7064b18,Namespace:default,Attempt:0,} returns sandbox id \"617f13992c1789cb7a7adf2ec844a545f502e15463c55e8c0b06aaace165ece6\""
May 12 23:43:31.771414 containerd[1436]: time="2025-05-12T23:43:31.771374823Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\""
May 12 23:43:32.010593 containerd[1436]: time="2025-05-12T23:43:32.010529314Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\"  labels:{key:\"io.cri-containerd.image\"  value:\"managed\"}"
May 12 23:43:32.011173 containerd[1436]: time="2025-05-12T23:43:32.011022067Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61"
May 12 23:43:32.014690 containerd[1436]: time="2025-05-12T23:43:32.014603706Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:beabce8f1782671ba500ddff99dd260fbf9c5ec85fb9c3162e35a3c40bafd023\", size \"69948737\" in 243.184975ms"
May 12 23:43:32.014690 containerd[1436]: time="2025-05-12T23:43:32.014653814Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:e8b1cb61bd96acc3ff3c695318c9cc691213d532eee3731d038af92816fcb5f4\""
May 12 23:43:32.021462 containerd[1436]: time="2025-05-12T23:43:32.021408837Z" level=info msg="CreateContainer within sandbox \"617f13992c1789cb7a7adf2ec844a545f502e15463c55e8c0b06aaace165ece6\" for container &ContainerMetadata{Name:test,Attempt:0,}"
May 12 23:43:32.037410 containerd[1436]: time="2025-05-12T23:43:32.037350739Z" level=info msg="CreateContainer within sandbox \"617f13992c1789cb7a7adf2ec844a545f502e15463c55e8c0b06aaace165ece6\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"6c58428208a3dc1d42d59ba0c03267afefa847ac744b56b0206889b7445556d5\""
May 12 23:43:32.038130 containerd[1436]: time="2025-05-12T23:43:32.038092228Z" level=info msg="StartContainer for \"6c58428208a3dc1d42d59ba0c03267afefa847ac744b56b0206889b7445556d5\""
May 12 23:43:32.070470 systemd[1]: Started cri-containerd-6c58428208a3dc1d42d59ba0c03267afefa847ac744b56b0206889b7445556d5.scope - libcontainer container 6c58428208a3dc1d42d59ba0c03267afefa847ac744b56b0206889b7445556d5.
May 12 23:43:32.099040 containerd[1436]: time="2025-05-12T23:43:32.098905914Z" level=info msg="StartContainer for \"6c58428208a3dc1d42d59ba0c03267afefa847ac744b56b0206889b7445556d5\" returns successfully"
May 12 23:43:32.126840 kubelet[1698]: E0512 23:43:32.126782    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:33.071566 systemd-networkd[1373]: veth4f0dad03: Gained IPv6LL
May 12 23:43:33.128025 kubelet[1698]: E0512 23:43:33.127968    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
May 12 23:43:34.098315 update_engine[1429]: I20250512 23:43:34.097932  1429 update_attempter.cc:509] Updating boot flags...
May 12 23:43:34.120872 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 42 scanned by (udev-worker) (2721)
May 12 23:43:34.132522 kubelet[1698]: E0512 23:43:34.131412    1698 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"