Jan 30 13:15:42.961524 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1]
Jan 30 13:15:42.961548 kernel: Linux version 6.6.74-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Wed Jan 29 10:12:48 -00 2025
Jan 30 13:15:42.961558 kernel: KASLR enabled
Jan 30 13:15:42.961564 kernel: efi: EFI v2.7 by EDK II
Jan 30 13:15:42.961570 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdba86018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18
Jan 30 13:15:42.961576 kernel: random: crng init done
Jan 30 13:15:42.961583 kernel: ACPI: Early table checksum verification disabled
Jan 30 13:15:42.961589 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS )
Jan 30 13:15:42.961596 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013)
Jan 30 13:15:42.961604 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961610 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961616 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961623 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961629 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961636 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961645 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961651 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961658 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001)
Jan 30 13:15:42.961664 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600
Jan 30 13:15:42.961671 kernel: NUMA: Failed to initialise from firmware
Jan 30 13:15:42.961677 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff]
Jan 30 13:15:42.961684 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff]
Jan 30 13:15:42.961690 kernel: Zone ranges:
Jan 30 13:15:42.961697 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff]
Jan 30 13:15:42.961703 kernel: DMA32 empty
Jan 30 13:15:42.961711 kernel: Normal empty
Jan 30 13:15:42.961717 kernel: Movable zone start for each node
Jan 30 13:15:42.961724 kernel: Early memory node ranges
Jan 30 13:15:42.961730 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff]
Jan 30 13:15:42.961736 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff]
Jan 30 13:15:42.961743 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff]
Jan 30 13:15:42.961749 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff]
Jan 30 13:15:42.961756 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff]
Jan 30 13:15:42.961762 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff]
Jan 30 13:15:42.961769 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff]
Jan 30 13:15:42.961775 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff]
Jan 30 13:15:42.961781 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges
Jan 30 13:15:42.961789 kernel: psci: probing for conduit method from ACPI.
Jan 30 13:15:42.961796 kernel: psci: PSCIv1.1 detected in firmware.
Jan 30 13:15:42.961803 kernel: psci: Using standard PSCI v0.2 function IDs
Jan 30 13:15:42.961812 kernel: psci: Trusted OS migration not required
Jan 30 13:15:42.961819 kernel: psci: SMC Calling Convention v1.1
Jan 30 13:15:42.961826 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)
Jan 30 13:15:42.961835 kernel: percpu: Embedded 31 pages/cpu s86696 r8192 d32088 u126976
Jan 30 13:15:42.961842 kernel: pcpu-alloc: s86696 r8192 d32088 u126976 alloc=31*4096
Jan 30 13:15:42.961849 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
Jan 30 13:15:42.961856 kernel: Detected PIPT I-cache on CPU0
Jan 30 13:15:42.961863 kernel: CPU features: detected: GIC system register CPU interface
Jan 30 13:15:42.961870 kernel: CPU features: detected: Hardware dirty bit management
Jan 30 13:15:42.961876 kernel: CPU features: detected: Spectre-v4
Jan 30 13:15:42.961883 kernel: CPU features: detected: Spectre-BHB
Jan 30 13:15:42.961890 kernel: CPU features: kernel page table isolation forced ON by KASLR
Jan 30 13:15:42.961897 kernel: CPU features: detected: Kernel page table isolation (KPTI)
Jan 30 13:15:42.961905 kernel: CPU features: detected: ARM erratum 1418040
Jan 30 13:15:42.961912 kernel: CPU features: detected: SSBS not fully self-synchronizing
Jan 30 13:15:42.961919 kernel: alternatives: applying boot alternatives
Jan 30 13:15:42.961927 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=05d22c8845dec898f2b35f78b7d946edccf803dd23b974a9db2c3070ca1d8f8c
Jan 30 13:15:42.961934 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space.
Jan 30 13:15:42.961941 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear)
Jan 30 13:15:42.961948 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear)
Jan 30 13:15:42.961955 kernel: Fallback order for Node 0: 0
Jan 30 13:15:42.961962 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024
Jan 30 13:15:42.961969 kernel: Policy zone: DMA
Jan 30 13:15:42.961975 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off
Jan 30 13:15:42.961984 kernel: software IO TLB: area num 4.
Jan 30 13:15:42.961991 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB)
Jan 30 13:15:42.961998 kernel: Memory: 2386528K/2572288K available (10240K kernel code, 2186K rwdata, 8096K rodata, 39360K init, 897K bss, 185760K reserved, 0K cma-reserved)
Jan 30 13:15:42.962005 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan 30 13:15:42.962012 kernel: rcu: Preemptible hierarchical RCU implementation.
Jan 30 13:15:42.962020 kernel: rcu: RCU event tracing is enabled.
Jan 30 13:15:42.962027 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
Jan 30 13:15:42.962034 kernel: Trampoline variant of Tasks RCU enabled.
Jan 30 13:15:42.962041 kernel: Tracing variant of Tasks RCU enabled.
Jan 30 13:15:42.962048 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
Jan 30 13:15:42.962055 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
Jan 30 13:15:42.962061 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
Jan 30 13:15:42.962071 kernel: GICv3: 256 SPIs implemented
Jan 30 13:15:42.962077 kernel: GICv3: 0 Extended SPIs implemented
Jan 30 13:15:42.962084 kernel: Root IRQ handler: gic_handle_irq
Jan 30 13:15:42.962091 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI
Jan 30 13:15:42.962098 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000
Jan 30 13:15:42.962105 kernel: ITS [mem 0x08080000-0x0809ffff]
Jan 30 13:15:42.962112 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1)
Jan 30 13:15:42.962119 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1)
Jan 30 13:15:42.962126 kernel: GICv3: using LPI property table @0x00000000400f0000
Jan 30 13:15:42.962133 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000
Jan 30 13:15:42.962139 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention.
Jan 30 13:15:42.962148 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jan 30 13:15:42.962162 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt).
Jan 30 13:15:42.962171 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns
Jan 30 13:15:42.962178 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns
Jan 30 13:15:42.962185 kernel: arm-pv: using stolen time PV
Jan 30 13:15:42.962193 kernel: Console: colour dummy device 80x25
Jan 30 13:15:42.962200 kernel: ACPI: Core revision 20230628
Jan 30 13:15:42.962207 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000)
Jan 30 13:15:42.962214 kernel: pid_max: default: 32768 minimum: 301
Jan 30 13:15:42.962221 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity
Jan 30 13:15:42.962231 kernel: landlock: Up and running.
Jan 30 13:15:42.962238 kernel: SELinux: Initializing.
Jan 30 13:15:42.962245 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan 30 13:15:42.962252 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear)
Jan 30 13:15:42.962259 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
Jan 30 13:15:42.962267 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4.
Jan 30 13:15:42.962274 kernel: rcu: Hierarchical SRCU implementation.
Jan 30 13:15:42.962281 kernel: rcu: Max phase no-delay instances is 400.
Jan 30 13:15:42.962288 kernel: Platform MSI: ITS@0x8080000 domain created
Jan 30 13:15:42.962340 kernel: PCI/MSI: ITS@0x8080000 domain created
Jan 30 13:15:42.962349 kernel: Remapping and enabling EFI services.
Jan 30 13:15:42.962356 kernel: smp: Bringing up secondary CPUs ...
Jan 30 13:15:42.962363 kernel: Detected PIPT I-cache on CPU1
Jan 30 13:15:42.962370 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000
Jan 30 13:15:42.962377 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000
Jan 30 13:15:42.962385 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jan 30 13:15:42.962392 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1]
Jan 30 13:15:42.962399 kernel: Detected PIPT I-cache on CPU2
Jan 30 13:15:42.962406 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000
Jan 30 13:15:42.962416 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000
Jan 30 13:15:42.962423 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jan 30 13:15:42.962439 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1]
Jan 30 13:15:42.962450 kernel: Detected PIPT I-cache on CPU3
Jan 30 13:15:42.962458 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000
Jan 30 13:15:42.962465 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000
Jan 30 13:15:42.962473 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040
Jan 30 13:15:42.962480 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1]
Jan 30 13:15:42.962488 kernel: smp: Brought up 1 node, 4 CPUs
Jan 30 13:15:42.962497 kernel: SMP: Total of 4 processors activated.
Jan 30 13:15:42.962504 kernel: CPU features: detected: 32-bit EL0 Support
Jan 30 13:15:42.962512 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence
Jan 30 13:15:42.962519 kernel: CPU features: detected: Common not Private translations
Jan 30 13:15:42.962527 kernel: CPU features: detected: CRC32 instructions
Jan 30 13:15:42.962534 kernel: CPU features: detected: Enhanced Virtualization Traps
Jan 30 13:15:42.962542 kernel: CPU features: detected: RCpc load-acquire (LDAPR)
Jan 30 13:15:42.962549 kernel: CPU features: detected: LSE atomic instructions
Jan 30 13:15:42.962558 kernel: CPU features: detected: Privileged Access Never
Jan 30 13:15:42.962565 kernel: CPU features: detected: RAS Extension Support
Jan 30 13:15:42.962573 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS)
Jan 30 13:15:42.962580 kernel: CPU: All CPU(s) started at EL1
Jan 30 13:15:42.962588 kernel: alternatives: applying system-wide alternatives
Jan 30 13:15:42.962595 kernel: devtmpfs: initialized
Jan 30 13:15:42.962603 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
Jan 30 13:15:42.962611 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear)
Jan 30 13:15:42.962618 kernel: pinctrl core: initialized pinctrl subsystem
Jan 30 13:15:42.962627 kernel: SMBIOS 3.0.0 present.
Jan 30 13:15:42.962635 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023
Jan 30 13:15:42.962643 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family
Jan 30 13:15:42.962650 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations
Jan 30 13:15:42.962658 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
Jan 30 13:15:42.962665 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
Jan 30 13:15:42.962673 kernel: audit: initializing netlink subsys (disabled)
Jan 30 13:15:42.962680 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1
Jan 30 13:15:42.962688 kernel: thermal_sys: Registered thermal governor 'step_wise'
Jan 30 13:15:42.962697 kernel: cpuidle: using governor menu
Jan 30 13:15:42.962704 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
Jan 30 13:15:42.962711 kernel: ASID allocator initialised with 32768 entries
Jan 30 13:15:42.962719 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Jan 30 13:15:42.962726 kernel: Serial: AMBA PL011 UART driver
Jan 30 13:15:42.962733 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL
Jan 30 13:15:42.962741 kernel: Modules: 0 pages in range for non-PLT usage
Jan 30 13:15:42.962748 kernel: Modules: 509040 pages in range for PLT usage
Jan 30 13:15:42.962756 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
Jan 30 13:15:42.962765 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page
Jan 30 13:15:42.962772 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages
Jan 30 13:15:42.962779 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page
Jan 30 13:15:42.962787 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
Jan 30 13:15:42.962795 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page
Jan 30 13:15:42.962802 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages
Jan 30 13:15:42.962810 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page
Jan 30 13:15:42.962817 kernel: ACPI: Added _OSI(Module Device)
Jan 30 13:15:42.962824 kernel: ACPI: Added _OSI(Processor Device)
Jan 30 13:15:42.962833 kernel: ACPI: Added _OSI(3.0 _SCP Extensions)
Jan 30 13:15:42.962841 kernel: ACPI: Added _OSI(Processor Aggregator Device)
Jan 30 13:15:42.962848 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded
Jan 30 13:15:42.962856 kernel: ACPI: Interpreter enabled
Jan 30 13:15:42.962863 kernel: ACPI: Using GIC for interrupt routing
Jan 30 13:15:42.962870 kernel: ACPI: MCFG table detected, 1 entries
Jan 30 13:15:42.962878 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA
Jan 30 13:15:42.962885 kernel: printk: console [ttyAMA0] enabled
Jan 30 13:15:42.962893 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Jan 30 13:15:42.963053 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
Jan 30 13:15:42.963132 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR]
Jan 30 13:15:42.963215 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability]
Jan 30 13:15:42.963292 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00
Jan 30 13:15:42.963383 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]
Jan 30 13:15:42.963394 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window]
Jan 30 13:15:42.963402 kernel: PCI host bridge to bus 0000:00
Jan 30 13:15:42.963486 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window]
Jan 30 13:15:42.963551 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window]
Jan 30 13:15:42.963614 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window]
Jan 30 13:15:42.963674 kernel: pci_bus 0000:00: root bus resource [bus 00-ff]
Jan 30 13:15:42.963756 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000
Jan 30 13:15:42.963836 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00
Jan 30 13:15:42.963909 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f]
Jan 30 13:15:42.963979 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff]
Jan 30 13:15:42.964048 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref]
Jan 30 13:15:42.964117 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref]
Jan 30 13:15:42.964199 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff]
Jan 30 13:15:42.964271 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f]
Jan 30 13:15:42.964389 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window]
Jan 30 13:15:42.964506 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window]
Jan 30 13:15:42.964655 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window]
Jan 30 13:15:42.964667 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35
Jan 30 13:15:42.964675 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36
Jan 30 13:15:42.964683 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37
Jan 30 13:15:42.964691 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38
Jan 30 13:15:42.964699 kernel: iommu: Default domain type: Translated
Jan 30 13:15:42.964706 kernel: iommu: DMA domain TLB invalidation policy: strict mode
Jan 30 13:15:42.964718 kernel: efivars: Registered efivars operations
Jan 30 13:15:42.964726 kernel: vgaarb: loaded
Jan 30 13:15:42.964733 kernel: clocksource: Switched to clocksource arch_sys_counter
Jan 30 13:15:42.964741 kernel: VFS: Disk quotas dquot_6.6.0
Jan 30 13:15:42.964748 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jan 30 13:15:42.964756 kernel: pnp: PnP ACPI init
Jan 30 13:15:42.964909 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved
Jan 30 13:15:42.964926 kernel: pnp: PnP ACPI: found 1 devices
Jan 30 13:15:42.964934 kernel: NET: Registered PF_INET protocol family
Jan 30 13:15:42.964949 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear)
Jan 30 13:15:42.964957 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear)
Jan 30 13:15:42.964964 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
Jan 30 13:15:42.964972 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear)
Jan 30 13:15:42.964980 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear)
Jan 30 13:15:42.964987 kernel: TCP: Hash tables configured (established 32768 bind 32768)
Jan 30 13:15:42.964995 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jan 30 13:15:42.965003 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear)
Jan 30 13:15:42.965012 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family
Jan 30 13:15:42.965019 kernel: PCI: CLS 0 bytes, default 64
Jan 30 13:15:42.965027 kernel: kvm [1]: HYP mode not available
Jan 30 13:15:42.965035 kernel: Initialise system trusted keyrings
Jan 30 13:15:42.965042 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0
Jan 30 13:15:42.965049 kernel: Key type asymmetric registered
Jan 30 13:15:42.965057 kernel: Asymmetric key parser 'x509' registered
Jan 30 13:15:42.965065 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
Jan 30 13:15:42.965174 kernel: io scheduler mq-deadline registered
Jan 30 13:15:42.965182 kernel: io scheduler kyber registered
Jan 30 13:15:42.965192 kernel: io scheduler bfq registered
Jan 30 13:15:42.965201 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0
Jan 30 13:15:42.965208 kernel: ACPI: button: Power Button [PWRB]
Jan 30 13:15:42.965216 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36
Jan 30 13:15:42.965326 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007)
Jan 30 13:15:42.965370 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
Jan 30 13:15:42.965378 kernel: thunder_xcv, ver 1.0
Jan 30 13:15:42.965385 kernel: thunder_bgx, ver 1.0
Jan 30 13:15:42.965393 kernel: nicpf, ver 1.0
Jan 30 13:15:42.965404 kernel: nicvf, ver 1.0
Jan 30 13:15:42.965509 kernel: rtc-efi rtc-efi.0: registered as rtc0
Jan 30 13:15:42.965578 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-01-30T13:15:42 UTC (1738242942)
Jan 30 13:15:42.965588 kernel: hid: raw HID events driver (C) Jiri Kosina
Jan 30 13:15:42.965596 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available
Jan 30 13:15:42.965604 kernel: watchdog: Delayed init of the lockup detector failed: -19
Jan 30 13:15:42.965612 kernel: watchdog: Hard watchdog permanently disabled
Jan 30 13:15:42.965619 kernel: NET: Registered PF_INET6 protocol family
Jan 30 13:15:42.965629 kernel: Segment Routing with IPv6
Jan 30 13:15:42.965637 kernel: In-situ OAM (IOAM) with IPv6
Jan 30 13:15:42.965644 kernel: NET: Registered PF_PACKET protocol family
Jan 30 13:15:42.965652 kernel: Key type dns_resolver registered
Jan 30 13:15:42.965659 kernel: registered taskstats version 1
Jan 30 13:15:42.965667 kernel: Loading compiled-in X.509 certificates
Jan 30 13:15:42.965674 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.74-flatcar: f200c60883a4a38d496d9250faf693faee9d7415'
Jan 30 13:15:42.965682 kernel: Key type .fscrypt registered
Jan 30 13:15:42.965689 kernel: Key type fscrypt-provisioning registered
Jan 30 13:15:42.965699 kernel: ima: No TPM chip found, activating TPM-bypass!
Jan 30 13:15:42.965706 kernel: ima: Allocated hash algorithm: sha1
Jan 30 13:15:42.965714 kernel: ima: No architecture policies found
Jan 30 13:15:42.965721 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng)
Jan 30 13:15:42.965728 kernel: clk: Disabling unused clocks
Jan 30 13:15:42.965736 kernel: Freeing unused kernel memory: 39360K
Jan 30 13:15:42.965743 kernel: Run /init as init process
Jan 30 13:15:42.965751 kernel: with arguments:
Jan 30 13:15:42.965758 kernel: /init
Jan 30 13:15:42.965767 kernel: with environment:
Jan 30 13:15:42.965775 kernel: HOME=/
Jan 30 13:15:42.965782 kernel: TERM=linux
Jan 30 13:15:42.965790 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a
Jan 30 13:15:42.965799 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)
Jan 30 13:15:42.965809 systemd[1]: Detected virtualization kvm.
Jan 30 13:15:42.965817 systemd[1]: Detected architecture arm64.
Jan 30 13:15:42.965827 systemd[1]: Running in initrd.
Jan 30 13:15:42.965835 systemd[1]: No hostname configured, using default hostname.
Jan 30 13:15:42.965843 systemd[1]: Hostname set to <localhost>.
Jan 30 13:15:42.965851 systemd[1]: Initializing machine ID from VM UUID.
Jan 30 13:15:42.965859 systemd[1]: Queued start job for default target initrd.target.
Jan 30 13:15:42.965867 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jan 30 13:15:42.965875 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jan 30 13:15:42.965884 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM...
Jan 30 13:15:42.965894 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Jan 30 13:15:42.965902 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT...
Jan 30 13:15:42.965911 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A...
Jan 30 13:15:42.965921 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132...
Jan 30 13:15:42.965929 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr...
Jan 30 13:15:42.965937 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jan 30 13:15:42.965945 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Jan 30 13:15:42.965955 systemd[1]: Reached target paths.target - Path Units.
Jan 30 13:15:42.965964 systemd[1]: Reached target slices.target - Slice Units.
Jan 30 13:15:42.965972 systemd[1]: Reached target swap.target - Swaps.
Jan 30 13:15:42.965980 systemd[1]: Reached target timers.target - Timer Units.
Jan 30 13:15:42.965989 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket.
Jan 30 13:15:42.965997 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Jan 30 13:15:42.966005 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
Jan 30 13:15:42.966013 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
Jan 30 13:15:42.966021 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Jan 30 13:15:42.966031 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Jan 30 13:15:42.966039 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Jan 30 13:15:42.966048 systemd[1]: Reached target sockets.target - Socket Units.
Jan 30 13:15:42.966056 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup...
Jan 30 13:15:42.966064 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Jan 30 13:15:42.966072 systemd[1]: Finished network-cleanup.service - Network Cleanup.
Jan 30 13:15:42.966080 systemd[1]: Starting systemd-fsck-usr.service...
Jan 30 13:15:42.966088 systemd[1]: Starting systemd-journald.service - Journal Service...
Jan 30 13:15:42.966099 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Jan 30 13:15:42.966107 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jan 30 13:15:42.966115 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup.
Jan 30 13:15:42.966123 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Jan 30 13:15:42.966132 systemd[1]: Finished systemd-fsck-usr.service.
Jan 30 13:15:42.966141 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Jan 30 13:15:42.966179 systemd-journald[237]: Collecting audit messages is disabled.
Jan 30 13:15:42.966201 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jan 30 13:15:42.966210 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jan 30 13:15:42.966221 systemd-journald[237]: Journal started
Jan 30 13:15:42.966240 systemd-journald[237]: Runtime Journal (/run/log/journal/165c0a212e424ebfb532136ca440dc1b) is 5.9M, max 47.3M, 41.4M free.
Jan 30 13:15:42.960546 systemd-modules-load[238]: Inserted module 'overlay'
Jan 30 13:15:42.968089 systemd[1]: Started systemd-journald.service - Journal Service.
Jan 30 13:15:42.978496 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jan 30 13:15:42.981968 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this.
Jan 30 13:15:42.982240 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Jan 30 13:15:42.987684 kernel: Bridge firewalling registered
Jan 30 13:15:42.985365 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
Jan 30 13:15:42.985722 systemd-modules-load[238]: Inserted module 'br_netfilter'
Jan 30 13:15:42.986720 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Jan 30 13:15:42.989828 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Jan 30 13:15:42.995847 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jan 30 13:15:43.000011 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
Jan 30 13:15:43.003854 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Jan 30 13:15:43.007369 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jan 30 13:15:43.014475 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook...
Jan 30 13:15:43.016925 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Jan 30 13:15:43.025924 dracut-cmdline[276]: dracut-dracut-053
Jan 30 13:15:43.028605 dracut-cmdline[276]: 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=05d22c8845dec898f2b35f78b7d946edccf803dd23b974a9db2c3070ca1d8f8c
Jan 30 13:15:43.053091 systemd-resolved[278]: Positive Trust Anchors:
Jan 30 13:15:43.053112 systemd-resolved[278]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jan 30 13:15:43.053145 systemd-resolved[278]: 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
Jan 30 13:15:43.057995 systemd-resolved[278]: Defaulting to hostname 'linux'.
Jan 30 13:15:43.059256 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Jan 30 13:15:43.062835 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Jan 30 13:15:43.101338 kernel: SCSI subsystem initialized
Jan 30 13:15:43.106326 kernel: Loading iSCSI transport class v2.0-870.
Jan 30 13:15:43.114328 kernel: iscsi: registered transport (tcp)
Jan 30 13:15:43.128525 kernel: iscsi: registered transport (qla4xxx)
Jan 30 13:15:43.128586 kernel: QLogic iSCSI HBA Driver
Jan 30 13:15:43.174376 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook.
Jan 30 13:15:43.183502 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook...
Jan 30 13:15:43.202379 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
Jan 30 13:15:43.202439 kernel: device-mapper: uevent: version 1.0.3
Jan 30 13:15:43.203522 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com
Jan 30 13:15:43.252339 kernel: raid6: neonx8 gen() 15276 MB/s
Jan 30 13:15:43.269323 kernel: raid6: neonx4 gen() 15317 MB/s
Jan 30 13:15:43.286314 kernel: raid6: neonx2 gen() 13274 MB/s
Jan 30 13:15:43.303329 kernel: raid6: neonx1 gen() 10182 MB/s
Jan 30 13:15:43.320319 kernel: raid6: int64x8 gen() 6432 MB/s
Jan 30 13:15:43.337325 kernel: raid6: int64x4 gen() 7347 MB/s
Jan 30 13:15:43.354324 kernel: raid6: int64x2 gen() 6117 MB/s
Jan 30 13:15:43.371445 kernel: raid6: int64x1 gen() 5053 MB/s
Jan 30 13:15:43.371504 kernel: raid6: using algorithm neonx4 gen() 15317 MB/s
Jan 30 13:15:43.389388 kernel: raid6: .... xor() 12274 MB/s, rmw enabled
Jan 30 13:15:43.389436 kernel: raid6: using neon recovery algorithm
Jan 30 13:15:43.394321 kernel: xor: measuring software checksum speed
Jan 30 13:15:43.395562 kernel: 8regs : 17726 MB/sec
Jan 30 13:15:43.395576 kernel: 32regs : 19646 MB/sec
Jan 30 13:15:43.396788 kernel: arm64_neon : 26874 MB/sec
Jan 30 13:15:43.396812 kernel: xor: using function: arm64_neon (26874 MB/sec)
Jan 30 13:15:43.446338 kernel: Btrfs loaded, zoned=no, fsverity=no
Jan 30 13:15:43.458225 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook.
Jan 30 13:15:43.469508 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jan 30 13:15:43.481971 systemd-udevd[461]: Using default interface naming scheme 'v255'.
Jan 30 13:15:43.485139 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jan 30 13:15:43.492468 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook...
Jan 30 13:15:43.512317 dracut-pre-trigger[471]: rd.md=0: removing MD RAID activation
Jan 30 13:15:43.544436 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook.
Jan 30 13:15:43.555500 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Jan 30 13:15:43.599465 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Jan 30 13:15:43.609478 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook...
Jan 30 13:15:43.623380 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook.
Jan 30 13:15:43.625354 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems.
Jan 30 13:15:43.628489 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Jan 30 13:15:43.631568 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Jan 30 13:15:43.643955 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook...
Jan 30 13:15:43.651753 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues
Jan 30 13:15:43.663534 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB)
Jan 30 13:15:43.663653 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk.
Jan 30 13:15:43.663665 kernel: GPT:9289727 != 19775487
Jan 30 13:15:43.663675 kernel: GPT:Alternate GPT header not at the end of the disk.
Jan 30 13:15:43.663685 kernel: GPT:9289727 != 19775487
Jan 30 13:15:43.663694 kernel: GPT: Use GNU Parted to correct GPT errors.
Jan 30 13:15:43.663704 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jan 30 13:15:43.661131 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook.
Jan 30 13:15:43.672556 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Jan 30 13:15:43.672760 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jan 30 13:15:43.681244 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (508)
Jan 30 13:15:43.681271 kernel: BTRFS: device fsid f02ec3fd-6702-4c1a-b68e-9001713a3a08 devid 1 transid 38 /dev/vda3 scanned by (udev-worker) (514)
Jan 30 13:15:43.676123 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jan 30 13:15:43.678507 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Jan 30 13:15:43.678753 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Jan 30 13:15:43.683906 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup...
Jan 30 13:15:43.693634 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jan 30 13:15:43.699046 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT.
Jan 30 13:15:43.709349 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jan 30 13:15:43.716382 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM.
Jan 30 13:15:43.725761 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
Jan 30 13:15:43.730120 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132.
Jan 30 13:15:43.731481 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A.
Jan 30 13:15:43.748515 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary...
Jan 30 13:15:43.750509 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters...
Jan 30 13:15:43.757793 disk-uuid[551]: Primary Header is updated.
Jan 30 13:15:43.757793 disk-uuid[551]: Secondary Entries is updated.
Jan 30 13:15:43.757793 disk-uuid[551]: Secondary Header is updated.
Jan 30 13:15:43.764664 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jan 30 13:15:43.776985 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jan 30 13:15:44.775323 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9
Jan 30 13:15:44.775755 disk-uuid[552]: The operation has completed successfully.
Jan 30 13:15:44.805863 systemd[1]: disk-uuid.service: Deactivated successfully.
Jan 30 13:15:44.805979 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary.
Jan 30 13:15:44.828537 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr...
Jan 30 13:15:44.831761 sh[574]: Success
Jan 30 13:15:44.848699 kernel: device-mapper: verity: sha256 using implementation "sha256-ce"
Jan 30 13:15:44.884235 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr.
Jan 30 13:15:44.896761 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr...
Jan 30 13:15:44.899532 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr.
Jan 30 13:15:44.917415 kernel: BTRFS info (device dm-0): first mount of filesystem f02ec3fd-6702-4c1a-b68e-9001713a3a08
Jan 30 13:15:44.917469 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm
Jan 30 13:15:44.917481 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead
Jan 30 13:15:44.918489 kernel: BTRFS info (device dm-0): disabling log replay at mount time
Jan 30 13:15:44.919920 kernel: BTRFS info (device dm-0): using free space tree
Jan 30 13:15:44.924516 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr.
Jan 30 13:15:44.925951 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met.
Jan 30 13:15:44.939548 systemd[1]: Starting ignition-setup.service - Ignition (setup)...
Jan 30 13:15:44.941505 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline...
Jan 30 13:15:44.954368 kernel: BTRFS info (device vda6): first mount of filesystem db40e17a-cddf-4890-8d80-4d8cda0a956a
Jan 30 13:15:44.954426 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
Jan 30 13:15:44.954438 kernel: BTRFS info (device vda6): using free space tree
Jan 30 13:15:44.958323 kernel: BTRFS info (device vda6): auto enabling async discard
Jan 30 13:15:44.973897 systemd[1]: mnt-oem.mount: Deactivated successfully.
Jan 30 13:15:44.975966 kernel: BTRFS info (device vda6): last unmount of filesystem db40e17a-cddf-4890-8d80-4d8cda0a956a
Jan 30 13:15:44.986769 systemd[1]: Finished ignition-setup.service - Ignition (setup).
Jan 30 13:15:44.993541 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)...
Jan 30 13:15:45.051805 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Jan 30 13:15:45.063625 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Jan 30 13:15:45.089271 systemd-networkd[759]: lo: Link UP
Jan 30 13:15:45.089283 systemd-networkd[759]: lo: Gained carrier
Jan 30 13:15:45.090019 systemd-networkd[759]: Enumeration completed
Jan 30 13:15:45.090409 systemd[1]: Started systemd-networkd.service - Network Configuration.
Jan 30 13:15:45.090619 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jan 30 13:15:45.090623 systemd-networkd[759]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jan 30 13:15:45.091830 systemd[1]: Reached target network.target - Network.
Jan 30 13:15:45.091878 systemd-networkd[759]: eth0: Link UP
Jan 30 13:15:45.091882 systemd-networkd[759]: eth0: Gained carrier
Jan 30 13:15:45.091889 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jan 30 13:15:45.103340 ignition[681]: Ignition 2.19.0
Jan 30 13:15:45.103349 ignition[681]: Stage: fetch-offline
Jan 30 13:15:45.103392 ignition[681]: no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:45.106381 systemd-networkd[759]: eth0: DHCPv4 address 10.0.0.150/16, gateway 10.0.0.1 acquired from 10.0.0.1
Jan 30 13:15:45.103402 ignition[681]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:45.103612 ignition[681]: parsed url from cmdline: ""
Jan 30 13:15:45.103615 ignition[681]: no config URL provided
Jan 30 13:15:45.103620 ignition[681]: reading system config file "/usr/lib/ignition/user.ign"
Jan 30 13:15:45.103629 ignition[681]: no config at "/usr/lib/ignition/user.ign"
Jan 30 13:15:45.103656 ignition[681]: op(1): [started] loading QEMU firmware config module
Jan 30 13:15:45.103665 ignition[681]: op(1): executing: "modprobe" "qemu_fw_cfg"
Jan 30 13:15:45.114424 ignition[681]: op(1): [finished] loading QEMU firmware config module
Jan 30 13:15:45.120946 ignition[681]: parsing config with SHA512: d7553a42532590b338e043e23927501519ddad8c537cc09982bf432ad15b71d112a36607d616582d81c00a3fa838c4121a9a021b0a2b478930d61984478a00ff
Jan 30 13:15:45.124213 unknown[681]: fetched base config from "system"
Jan 30 13:15:45.124226 unknown[681]: fetched user config from "qemu"
Jan 30 13:15:45.124606 ignition[681]: fetch-offline: fetch-offline passed
Jan 30 13:15:45.124676 ignition[681]: Ignition finished successfully
Jan 30 13:15:45.126750 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline).
Jan 30 13:15:45.128215 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json).
Jan 30 13:15:45.140503 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)...
Jan 30 13:15:45.152682 ignition[770]: Ignition 2.19.0
Jan 30 13:15:45.152693 ignition[770]: Stage: kargs
Jan 30 13:15:45.152894 ignition[770]: no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:45.152904 ignition[770]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:45.157058 systemd[1]: Finished ignition-kargs.service - Ignition (kargs).
Jan 30 13:15:45.153681 ignition[770]: kargs: kargs passed
Jan 30 13:15:45.153733 ignition[770]: Ignition finished successfully
Jan 30 13:15:45.166532 systemd[1]: Starting ignition-disks.service - Ignition (disks)...
Jan 30 13:15:45.176711 ignition[779]: Ignition 2.19.0
Jan 30 13:15:45.176722 ignition[779]: Stage: disks
Jan 30 13:15:45.176907 ignition[779]: no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:45.176916 ignition[779]: no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:45.179642 systemd[1]: Finished ignition-disks.service - Ignition (disks).
Jan 30 13:15:45.177737 ignition[779]: disks: disks passed
Jan 30 13:15:45.181388 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device.
Jan 30 13:15:45.177786 ignition[779]: Ignition finished successfully
Jan 30 13:15:45.183122 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
Jan 30 13:15:45.184825 systemd[1]: Reached target local-fs.target - Local File Systems.
Jan 30 13:15:45.186753 systemd[1]: Reached target sysinit.target - System Initialization.
Jan 30 13:15:45.188321 systemd[1]: Reached target basic.target - Basic System.
Jan 30 13:15:45.199501 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT...
Jan 30 13:15:45.209855 systemd-resolved[278]: Detected conflict on linux IN A 10.0.0.150
Jan 30 13:15:45.209871 systemd-resolved[278]: Hostname conflict, changing published hostname from 'linux' to 'linux3'.
Jan 30 13:15:45.212500 systemd-fsck[789]: ROOT: clean, 14/553520 files, 52654/553472 blocks
Jan 30 13:15:45.217471 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT.
Jan 30 13:15:45.229456 systemd[1]: Mounting sysroot.mount - /sysroot...
Jan 30 13:15:45.279307 kernel: EXT4-fs (vda9): mounted filesystem 8499bb43-f860-448d-b3b8-5a1fc2b80abf r/w with ordered data mode. Quota mode: none.
Jan 30 13:15:45.279758 systemd[1]: Mounted sysroot.mount - /sysroot.
Jan 30 13:15:45.281085 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System.
Jan 30 13:15:45.290401 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Jan 30 13:15:45.292777 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr...
Jan 30 13:15:45.294112 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met.
Jan 30 13:15:45.294173 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot).
Jan 30 13:15:45.294200 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup.
Jan 30 13:15:45.302358 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (798)
Jan 30 13:15:45.301633 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr.
Jan 30 13:15:45.306944 kernel: BTRFS info (device vda6): first mount of filesystem db40e17a-cddf-4890-8d80-4d8cda0a956a
Jan 30 13:15:45.306967 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
Jan 30 13:15:45.306977 kernel: BTRFS info (device vda6): using free space tree
Jan 30 13:15:45.306339 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup...
Jan 30 13:15:45.310026 kernel: BTRFS info (device vda6): auto enabling async discard
Jan 30 13:15:45.311983 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Jan 30 13:15:45.348117 initrd-setup-root[822]: cut: /sysroot/etc/passwd: No such file or directory
Jan 30 13:15:45.352567 initrd-setup-root[829]: cut: /sysroot/etc/group: No such file or directory
Jan 30 13:15:45.355929 initrd-setup-root[836]: cut: /sysroot/etc/shadow: No such file or directory
Jan 30 13:15:45.359193 initrd-setup-root[843]: cut: /sysroot/etc/gshadow: No such file or directory
Jan 30 13:15:45.437809 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup.
Jan 30 13:15:45.447419 systemd[1]: Starting ignition-mount.service - Ignition (mount)...
Jan 30 13:15:45.449119 systemd[1]: Starting sysroot-boot.service - /sysroot/boot...
Jan 30 13:15:45.455317 kernel: BTRFS info (device vda6): last unmount of filesystem db40e17a-cddf-4890-8d80-4d8cda0a956a
Jan 30 13:15:45.472610 ignition[913]: INFO : Ignition 2.19.0
Jan 30 13:15:45.472610 ignition[913]: INFO : Stage: mount
Jan 30 13:15:45.474256 ignition[913]: INFO : no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:45.474256 ignition[913]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:45.474256 ignition[913]: INFO : mount: mount passed
Jan 30 13:15:45.474256 ignition[913]: INFO : Ignition finished successfully
Jan 30 13:15:45.474385 systemd[1]: Finished sysroot-boot.service - /sysroot/boot.
Jan 30 13:15:45.476479 systemd[1]: Finished ignition-mount.service - Ignition (mount).
Jan 30 13:15:45.485472 systemd[1]: Starting ignition-files.service - Ignition (files)...
Jan 30 13:15:45.913462 systemd[1]: sysroot-oem.mount: Deactivated successfully.
Jan 30 13:15:45.925538 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem...
Jan 30 13:15:45.933021 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (927)
Jan 30 13:15:45.933054 kernel: BTRFS info (device vda6): first mount of filesystem db40e17a-cddf-4890-8d80-4d8cda0a956a
Jan 30 13:15:45.933065 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm
Jan 30 13:15:45.934653 kernel: BTRFS info (device vda6): using free space tree
Jan 30 13:15:45.937318 kernel: BTRFS info (device vda6): auto enabling async discard
Jan 30 13:15:45.938224 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem.
Jan 30 13:15:45.967610 ignition[944]: INFO : Ignition 2.19.0
Jan 30 13:15:45.967610 ignition[944]: INFO : Stage: files
Jan 30 13:15:45.969395 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:45.969395 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:45.969395 ignition[944]: DEBUG : files: compiled without relabeling support, skipping
Jan 30 13:15:45.973061 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core"
Jan 30 13:15:45.973061 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core"
Jan 30 13:15:45.973061 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core"
Jan 30 13:15:45.973061 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core"
Jan 30 13:15:45.973061 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core"
Jan 30 13:15:45.972571 unknown[944]: wrote ssh authorized keys file for user: core
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw"
Jan 30 13:15:45.981249 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://github.com/flatcar/sysext-bakery/releases/download/latest/kubernetes-v1.30.1-arm64.raw: attempt #1
Jan 30 13:15:46.285825 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK
Jan 30 13:15:46.482631 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.30.1-arm64.raw"
Jan 30 13:15:46.482631 ignition[944]: INFO : files: op(8): [started] processing unit "containerd.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(8): [finished] processing unit "containerd.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(a): [started] processing unit "coreos-metadata.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service"
Jan 30 13:15:46.486421 ignition[944]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service"
Jan 30 13:15:46.521959 ignition[944]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service"
Jan 30 13:15:46.527659 ignition[944]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service"
Jan 30 13:15:46.530592 ignition[944]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service"
Jan 30 13:15:46.530592 ignition[944]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json"
Jan 30 13:15:46.530592 ignition[944]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json"
Jan 30 13:15:46.530592 ignition[944]: INFO : files: files passed
Jan 30 13:15:46.530592 ignition[944]: INFO : Ignition finished successfully
Jan 30 13:15:46.532343 systemd[1]: Finished ignition-files.service - Ignition (files).
Jan 30 13:15:46.545540 systemd[1]: Starting ignition-quench.service - Ignition (record completion)...
Jan 30 13:15:46.548322 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion...
Jan 30 13:15:46.551069 systemd[1]: ignition-quench.service: Deactivated successfully.
Jan 30 13:15:46.551280 systemd[1]: Finished ignition-quench.service - Ignition (record completion).
Jan 30 13:15:46.558699 initrd-setup-root-after-ignition[972]: grep: /sysroot/oem/oem-release: No such file or directory
Jan 30 13:15:46.562016 initrd-setup-root-after-ignition[974]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Jan 30 13:15:46.562016 initrd-setup-root-after-ignition[974]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory
Jan 30 13:15:46.565478 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory
Jan 30 13:15:46.565130 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion.
Jan 30 13:15:46.566880 systemd[1]: Reached target ignition-complete.target - Ignition Complete.
Jan 30 13:15:46.578511 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root...
Jan 30 13:15:46.603280 systemd[1]: initrd-parse-etc.service: Deactivated successfully.
Jan 30 13:15:46.603428 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root.
Jan 30 13:15:46.605907 systemd[1]: Reached target initrd-fs.target - Initrd File Systems.
Jan 30 13:15:46.607772 systemd[1]: Reached target initrd.target - Initrd Default Target.
Jan 30 13:15:46.609647 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met.
Jan 30 13:15:46.610551 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook...
Jan 30 13:15:46.629462 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Jan 30 13:15:46.639552 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons...
Jan 30 13:15:46.649111 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups.
Jan 30 13:15:46.650564 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes.
Jan 30 13:15:46.652673 systemd[1]: Stopped target timers.target - Timer Units.
Jan 30 13:15:46.654441 systemd[1]: dracut-pre-pivot.service: Deactivated successfully.
Jan 30 13:15:46.654588 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook.
Jan 30 13:15:46.657079 systemd[1]: Stopped target initrd.target - Initrd Default Target.
Jan 30 13:15:46.659247 systemd[1]: Stopped target basic.target - Basic System.
Jan 30 13:15:46.660970 systemd[1]: Stopped target ignition-complete.target - Ignition Complete.
Jan 30 13:15:46.662761 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup.
Jan 30 13:15:46.664811 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device.
Jan 30 13:15:46.666793 systemd[1]: Stopped target remote-fs.target - Remote File Systems.
Jan 30 13:15:46.668614 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems.
Jan 30 13:15:46.670614 systemd[1]: Stopped target sysinit.target - System Initialization.
Jan 30 13:15:46.672639 systemd[1]: Stopped target local-fs.target - Local File Systems.
Jan 30 13:15:46.674438 systemd[1]: Stopped target swap.target - Swaps.
Jan 30 13:15:46.676085 systemd[1]: dracut-pre-mount.service: Deactivated successfully.
Jan 30 13:15:46.676239 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook.
Jan 30 13:15:46.678653 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes.
Jan 30 13:15:46.680718 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jan 30 13:15:46.682768 systemd[1]: clevis-luks-askpass.path: Deactivated successfully.
Jan 30 13:15:46.682921 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jan 30 13:15:46.684995 systemd[1]: dracut-initqueue.service: Deactivated successfully.
Jan 30 13:15:46.685137 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook.
Jan 30 13:15:46.688210 systemd[1]: ignition-fetch-offline.service: Deactivated successfully.
Jan 30 13:15:46.688359 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline).
Jan 30 13:15:46.690432 systemd[1]: Stopped target paths.target - Path Units.
Jan 30 13:15:46.692118 systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
Jan 30 13:15:46.692241 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jan 30 13:15:46.694281 systemd[1]: Stopped target slices.target - Slice Units.
Jan 30 13:15:46.696262 systemd[1]: Stopped target sockets.target - Socket Units.
Jan 30 13:15:46.697877 systemd[1]: iscsid.socket: Deactivated successfully.
Jan 30 13:15:46.697992 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket.
Jan 30 13:15:46.699762 systemd[1]: iscsiuio.socket: Deactivated successfully.
Jan 30 13:15:46.699862 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket.
Jan 30 13:15:46.702081 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully.
Jan 30 13:15:46.702218 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion.
Jan 30 13:15:46.703915 systemd[1]: ignition-files.service: Deactivated successfully.
Jan 30 13:15:46.704032 systemd[1]: Stopped ignition-files.service - Ignition (files).
Jan 30 13:15:46.712541 systemd[1]: Stopping ignition-mount.service - Ignition (mount)...
Jan 30 13:15:46.715175 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot...
Jan 30 13:15:46.716240 systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
Jan 30 13:15:46.716399 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices.
Jan 30 13:15:46.718374 systemd[1]: dracut-pre-trigger.service: Deactivated successfully.
Jan 30 13:15:46.718480 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook.
Jan 30 13:15:46.724908 systemd[1]: initrd-cleanup.service: Deactivated successfully.
Jan 30 13:15:46.725016 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons.
Jan 30 13:15:46.728303 ignition[998]: INFO : Ignition 2.19.0
Jan 30 13:15:46.728303 ignition[998]: INFO : Stage: umount
Jan 30 13:15:46.728303 ignition[998]: INFO : no configs at "/usr/lib/ignition/base.d"
Jan 30 13:15:46.728303 ignition[998]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu"
Jan 30 13:15:46.732340 ignition[998]: INFO : umount: umount passed
Jan 30 13:15:46.732340 ignition[998]: INFO : Ignition finished successfully
Jan 30 13:15:46.731247 systemd[1]: ignition-mount.service: Deactivated successfully.
Jan 30 13:15:46.731432 systemd[1]: Stopped ignition-mount.service - Ignition (mount).
Jan 30 13:15:46.734131 systemd[1]: Stopped target network.target - Network.
Jan 30 13:15:46.735223 systemd[1]: ignition-disks.service: Deactivated successfully.
Jan 30 13:15:46.735342 systemd[1]: Stopped ignition-disks.service - Ignition (disks).
Jan 30 13:15:46.736547 systemd[1]: ignition-kargs.service: Deactivated successfully.
Jan 30 13:15:46.736603 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs).
Jan 30 13:15:46.738740 systemd[1]: ignition-setup.service: Deactivated successfully.
Jan 30 13:15:46.738793 systemd[1]: Stopped ignition-setup.service - Ignition (setup).
Jan 30 13:15:46.740494 systemd[1]: ignition-setup-pre.service: Deactivated successfully.
Jan 30 13:15:46.740549 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup.
Jan 30 13:15:46.742640 systemd[1]: Stopping systemd-networkd.service - Network Configuration...
Jan 30 13:15:46.744212 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution...
Jan 30 13:15:46.749004 systemd[1]: sysroot-boot.mount: Deactivated successfully.
Jan 30 13:15:46.755410 systemd-networkd[759]: eth0: DHCPv6 lease lost
Jan 30 13:15:46.757210 systemd[1]: systemd-resolved.service: Deactivated successfully.
Jan 30 13:15:46.757356 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution.
Jan 30 13:15:46.759518 systemd[1]: systemd-networkd.service: Deactivated successfully.
Jan 30 13:15:46.759650 systemd[1]: Stopped systemd-networkd.service - Network Configuration.
Jan 30 13:15:46.763034 systemd[1]: systemd-networkd.socket: Deactivated successfully.
Jan 30 13:15:46.763107 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket.
Jan 30 13:15:46.772456 systemd[1]: Stopping network-cleanup.service - Network Cleanup...
Jan 30 13:15:46.773407 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully.
Jan 30 13:15:46.773485 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline.
Jan 30 13:15:46.775481 systemd[1]: systemd-sysctl.service: Deactivated successfully.
Jan 30 13:15:46.775534 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables.
Jan 30 13:15:46.777799 systemd[1]: systemd-modules-load.service: Deactivated successfully.
Jan 30 13:15:46.777922 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules.
Jan 30 13:15:46.780068 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
Jan 30 13:15:46.780124 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories.
Jan 30 13:15:46.782137 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jan 30 13:15:46.794231 systemd[1]: sysroot-boot.service: Deactivated successfully.
Jan 30 13:15:46.794381 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot.
Jan 30 13:15:46.796649 systemd[1]: network-cleanup.service: Deactivated successfully.
Jan 30 13:15:46.797375 systemd[1]: Stopped network-cleanup.service - Network Cleanup.
Jan 30 13:15:46.799212 systemd[1]: systemd-udevd.service: Deactivated successfully.
Jan 30 13:15:46.799361 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jan 30 13:15:46.801818 systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
Jan 30 13:15:46.801887 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket.
Jan 30 13:15:46.803962 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully.
Jan 30 13:15:46.804000 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket.
Jan 30 13:15:46.805658 systemd[1]: dracut-pre-udev.service: Deactivated successfully.
Jan 30 13:15:46.805713 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook.
Jan 30 13:15:46.808346 systemd[1]: dracut-cmdline.service: Deactivated successfully.
Jan 30 13:15:46.808402 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook.
Jan 30 13:15:46.811002 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully.
Jan 30 13:15:46.811056 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters.
Jan 30 13:15:46.813842 systemd[1]: initrd-setup-root.service: Deactivated successfully.
Jan 30 13:15:46.813899 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup.
Jan 30 13:15:46.824514 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database...
Jan 30 13:15:46.825619 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
Jan 30 13:15:46.825694 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jan 30 13:15:46.827828 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
Jan 30 13:15:46.827884 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jan 30 13:15:46.829859 systemd[1]: kmod-static-nodes.service: Deactivated successfully.
Jan 30 13:15:46.829912 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes.
Jan 30 13:15:46.832060 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
Jan 30 13:15:46.832108 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup.
Jan 30 13:15:46.834513 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
Jan 30 13:15:46.834632 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database.
Jan 30 13:15:46.837916 systemd[1]: Reached target initrd-switch-root.target - Switch Root.
Jan 30 13:15:46.839951 systemd[1]: Starting initrd-switch-root.service - Switch Root...
Jan 30 13:15:46.852523 systemd[1]: Switching root.
Jan 30 13:15:46.883433 systemd-journald[237]: Journal stopped
Jan 30 13:15:47.627736 systemd-journald[237]: Received SIGTERM from PID 1 (systemd).
Jan 30 13:15:47.627797 kernel: SELinux: policy capability network_peer_controls=1
Jan 30 13:15:47.627811 kernel: SELinux: policy capability open_perms=1
Jan 30 13:15:47.627823 kernel: SELinux: policy capability extended_socket_class=1
Jan 30 13:15:47.627833 kernel: SELinux: policy capability always_check_network=0
Jan 30 13:15:47.627843 kernel: SELinux: policy capability cgroup_seclabel=1
Jan 30 13:15:47.627853 kernel: SELinux: policy capability nnp_nosuid_transition=1
Jan 30 13:15:47.627863 kernel: SELinux: policy capability genfs_seclabel_symlinks=0
Jan 30 13:15:47.627873 kernel: SELinux: policy capability ioctl_skip_cloexec=0
Jan 30 13:15:47.627883 kernel: audit: type=1403 audit(1738242947.050:2): auid=4294967295 ses=4294967295 lsm=selinux res=1
Jan 30 13:15:47.627895 systemd[1]: Successfully loaded SELinux policy in 33.807ms.
Jan 30 13:15:47.627913 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.576ms.
Jan 30 13:15:47.627927 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)
Jan 30 13:15:47.627938 systemd[1]: Detected virtualization kvm.
Jan 30 13:15:47.627949 systemd[1]: Detected architecture arm64.
Jan 30 13:15:47.627959 systemd[1]: Detected first boot.
Jan 30 13:15:47.627970 systemd[1]: Initializing machine ID from VM UUID.
Jan 30 13:15:47.627981 zram_generator::config[1060]: No configuration found.
Jan 30 13:15:47.627992 systemd[1]: Populated /etc with preset unit settings.
Jan 30 13:15:47.628003 systemd[1]: Queued start job for default target multi-user.target.
Jan 30 13:15:47.628015 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6.
Jan 30 13:15:47.628042 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config.
Jan 30 13:15:47.628053 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run.
Jan 30 13:15:47.628064 systemd[1]: Created slice system-getty.slice - Slice /system/getty.
Jan 30 13:15:47.628075 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe.
Jan 30 13:15:47.628086 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty.
Jan 30 13:15:47.628097 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit.
Jan 30 13:15:47.628109 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck.
Jan 30 13:15:47.628119 systemd[1]: Created slice user.slice - User and Session Slice.
Jan 30 13:15:47.628132 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch.
Jan 30 13:15:47.628154 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch.
Jan 30 13:15:47.628167 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch.
Jan 30 13:15:47.628180 systemd[1]: Set up automount boot.automount - Boot partition Automount Point.
Jan 30 13:15:47.628191 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point.
Jan 30 13:15:47.628202 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM...
Jan 30 13:15:47.628213 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0...
Jan 30 13:15:47.628224 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre).
Jan 30 13:15:47.628235 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes.
Jan 30 13:15:47.628248 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes.
Jan 30 13:15:47.628259 systemd[1]: Reached target remote-fs.target - Remote File Systems.
Jan 30 13:15:47.628270 systemd[1]: Reached target slices.target - Slice Units.
Jan 30 13:15:47.628281 systemd[1]: Reached target swap.target - Swaps.
Jan 30 13:15:47.628292 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes.
Jan 30 13:15:47.629121 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket.
Jan 30 13:15:47.629151 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log).
Jan 30 13:15:47.629166 systemd[1]: Listening on systemd-journald.socket - Journal Socket.
Jan 30 13:15:47.629183 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket.
Jan 30 13:15:47.629194 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket.
Jan 30 13:15:47.629210 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket.
Jan 30 13:15:47.629221 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket.
Jan 30 13:15:47.629231 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System...
Jan 30 13:15:47.629243 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System...
Jan 30 13:15:47.629254 systemd[1]: Mounting media.mount - External Media Directory...
Jan 30 13:15:47.629264 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System...
Jan 30 13:15:47.629275 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System...
Jan 30 13:15:47.629287 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp...
Jan 30 13:15:47.629320 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files...
Jan 30 13:15:47.629334 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jan 30 13:15:47.629345 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes...
Jan 30 13:15:47.629356 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs...
Jan 30 13:15:47.629367 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jan 30 13:15:47.629378 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Jan 30 13:15:47.629389 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jan 30 13:15:47.629402 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse...
Jan 30 13:15:47.629412 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jan 30 13:15:47.629424 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf).
Jan 30 13:15:47.629435 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling.
Jan 30 13:15:47.629447 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.)
Jan 30 13:15:47.629467 systemd[1]: Starting systemd-journald.service - Journal Service...
Jan 30 13:15:47.629479 kernel: loop: module loaded
Jan 30 13:15:47.629489 kernel: fuse: init (API version 7.39)
Jan 30 13:15:47.629499 kernel: ACPI: bus type drm_connector registered
Jan 30 13:15:47.629512 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules...
Jan 30 13:15:47.629523 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line...
Jan 30 13:15:47.629534 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems...
Jan 30 13:15:47.629545 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices...
Jan 30 13:15:47.629579 systemd-journald[1142]: Collecting audit messages is disabled.
Jan 30 13:15:47.629603 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System.
Jan 30 13:15:47.629614 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System.
Jan 30 13:15:47.629628 systemd-journald[1142]: Journal started
Jan 30 13:15:47.629650 systemd-journald[1142]: Runtime Journal (/run/log/journal/165c0a212e424ebfb532136ca440dc1b) is 5.9M, max 47.3M, 41.4M free.
Jan 30 13:15:47.633665 systemd[1]: Started systemd-journald.service - Journal Service.
Jan 30 13:15:47.634242 systemd[1]: Mounted media.mount - External Media Directory.
Jan 30 13:15:47.635382 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System.
Jan 30 13:15:47.636526 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System.
Jan 30 13:15:47.637662 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp.
Jan 30 13:15:47.638936 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files.
Jan 30 13:15:47.640437 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes.
Jan 30 13:15:47.641849 systemd[1]: modprobe@configfs.service: Deactivated successfully.
Jan 30 13:15:47.642024 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs.
Jan 30 13:15:47.643425 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jan 30 13:15:47.643581 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jan 30 13:15:47.644916 systemd[1]: modprobe@drm.service: Deactivated successfully.
Jan 30 13:15:47.645081 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Jan 30 13:15:47.646606 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jan 30 13:15:47.646758 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jan 30 13:15:47.648170 systemd[1]: modprobe@fuse.service: Deactivated successfully.
Jan 30 13:15:47.648348 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse.
Jan 30 13:15:47.649839 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jan 30 13:15:47.650044 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jan 30 13:15:47.651599 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules.
Jan 30 13:15:47.653204 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line.
Jan 30 13:15:47.654732 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems.
Jan 30 13:15:47.666293 systemd[1]: Reached target network-pre.target - Preparation for Network.
Jan 30 13:15:47.680395 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System...
Jan 30 13:15:47.682696 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System...
Jan 30 13:15:47.683951 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
Jan 30 13:15:47.685597 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database...
Jan 30 13:15:47.687822 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage...
Jan 30 13:15:47.689026 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Jan 30 13:15:47.690368 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed...
Jan 30 13:15:47.691655 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Jan 30 13:15:47.693423 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables...
Jan 30 13:15:47.696479 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully...
Jan 30 13:15:47.697851 systemd-journald[1142]: Time spent on flushing to /var/log/journal/165c0a212e424ebfb532136ca440dc1b is 12.886ms for 830 entries.
Jan 30 13:15:47.697851 systemd-journald[1142]: System Journal (/var/log/journal/165c0a212e424ebfb532136ca440dc1b) is 8.0M, max 195.6M, 187.6M free.
Jan 30 13:15:47.721376 systemd-journald[1142]: Received client request to flush runtime journal.
Jan 30 13:15:47.700622 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices.
Jan 30 13:15:47.702192 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System.
Jan 30 13:15:47.703417 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System.
Jan 30 13:15:47.708595 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization...
Jan 30 13:15:47.719281 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed.
Jan 30 13:15:47.720812 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables.
Jan 30 13:15:47.725970 systemd[1]: Reached target first-boot-complete.target - First Boot Complete.
Jan 30 13:15:47.727564 systemd-tmpfiles[1195]: ACLs are not supported, ignoring.
Jan 30 13:15:47.727581 systemd-tmpfiles[1195]: ACLs are not supported, ignoring.
Jan 30 13:15:47.727747 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage.
Jan 30 13:15:47.729374 udevadm[1201]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in.
Jan 30 13:15:47.731845 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully.
Jan 30 13:15:47.743453 systemd[1]: Starting systemd-sysusers.service - Create System Users...
Jan 30 13:15:47.764038 systemd[1]: Finished systemd-sysusers.service - Create System Users.
Jan 30 13:15:47.779491 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev...
Jan 30 13:15:47.791172 systemd-tmpfiles[1216]: ACLs are not supported, ignoring.
Jan 30 13:15:47.791191 systemd-tmpfiles[1216]: ACLs are not supported, ignoring.
Jan 30 13:15:47.794963 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev.
Jan 30 13:15:48.168415 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database.
Jan 30 13:15:48.178575 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files...
Jan 30 13:15:48.198678 systemd-udevd[1222]: Using default interface naming scheme 'v255'.
Jan 30 13:15:48.218422 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files.
Jan 30 13:15:48.229639 systemd[1]: Starting systemd-networkd.service - Network Configuration...
Jan 30 13:15:48.245513 systemd[1]: Starting systemd-userdbd.service - User Database Manager...
Jan 30 13:15:48.250213 systemd[1]: Found device dev-ttyAMA0.device - /dev/ttyAMA0.
Jan 30 13:15:48.254321 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1237)
Jan 30 13:15:48.311622 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM.
Jan 30 13:15:48.313111 systemd[1]: Started systemd-userdbd.service - User Database Manager.
Jan 30 13:15:48.356857 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup...
Jan 30 13:15:48.367233 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization.
Jan 30 13:15:48.370692 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes...
Jan 30 13:15:48.391327 lvm[1258]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jan 30 13:15:48.393146 systemd-networkd[1229]: lo: Link UP
Jan 30 13:15:48.393154 systemd-networkd[1229]: lo: Gained carrier
Jan 30 13:15:48.393954 systemd-networkd[1229]: Enumeration completed
Jan 30 13:15:48.394102 systemd[1]: Started systemd-networkd.service - Network Configuration.
Jan 30 13:15:48.394489 systemd-networkd[1229]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jan 30 13:15:48.394493 systemd-networkd[1229]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network.
Jan 30 13:15:48.395166 systemd-networkd[1229]: eth0: Link UP
Jan 30 13:15:48.395170 systemd-networkd[1229]: eth0: Gained carrier
Jan 30 13:15:48.395183 systemd-networkd[1229]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name.
Jan 30 13:15:48.410390 systemd-networkd[1229]: eth0: DHCPv4 address 10.0.0.150/16, gateway 10.0.0.1 acquired from 10.0.0.1
Jan 30 13:15:48.410523 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured...
Jan 30 13:15:48.412232 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup.
Jan 30 13:15:48.416976 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes.
Jan 30 13:15:48.418604 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes.
Jan 30 13:15:48.421452 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes...
Jan 30 13:15:48.429698 lvm[1269]: WARNING: Failed to connect to lvmetad. Falling back to device scanning.
Jan 30 13:15:48.468896 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes.
Jan 30 13:15:48.470561 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems.
Jan 30 13:15:48.471947 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).
Jan 30 13:15:48.471984 systemd[1]: Reached target local-fs.target - Local File Systems.
Jan 30 13:15:48.473100 systemd[1]: Reached target machines.target - Containers.
Jan 30 13:15:48.476581 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink).
Jan 30 13:15:48.485498 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown...
Jan 30 13:15:48.488203 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache...
Jan 30 13:15:48.489466 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jan 30 13:15:48.490683 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM...
Jan 30 13:15:48.493275 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk...
Jan 30 13:15:48.495962 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/...
Jan 30 13:15:48.498121 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown.
Jan 30 13:15:48.515555 kernel: loop0: detected capacity change from 0 to 114432
Jan 30 13:15:48.517337 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM.
Jan 30 13:15:48.525802 systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
Jan 30 13:15:48.526561 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk.
Jan 30 13:15:48.531351 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 30 13:15:48.555412 kernel: loop1: detected capacity change from 0 to 114328
Jan 30 13:15:48.591363 kernel: loop2: detected capacity change from 0 to 194096
Jan 30 13:15:48.634336 kernel: loop3: detected capacity change from 0 to 114432
Jan 30 13:15:48.641345 kernel: loop4: detected capacity change from 0 to 114328
Jan 30 13:15:48.647320 kernel: loop5: detected capacity change from 0 to 194096
Jan 30 13:15:48.656151 (sd-merge)[1291]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'.
Jan 30 13:15:48.657255 (sd-merge)[1291]: Merged extensions into '/usr'.
Jan 30 13:15:48.662366 systemd[1]: Reloading requested from client PID 1277 ('systemd-sysext') (unit systemd-sysext.service)...
Jan 30 13:15:48.662391 systemd[1]: Reloading...
Jan 30 13:15:48.713383 zram_generator::config[1319]: No configuration found.
Jan 30 13:15:48.761155 ldconfig[1274]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start.
Jan 30 13:15:48.833669 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.
Jan 30 13:15:48.878385 systemd[1]: Reloading finished in 215 ms.
Jan 30 13:15:48.892737 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache.
Jan 30 13:15:48.894398 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/.
Jan 30 13:15:48.912549 systemd[1]: Starting ensure-sysext.service...
Jan 30 13:15:48.914847 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories...
Jan 30 13:15:48.923012 systemd[1]: Reloading requested from client PID 1360 ('systemctl') (unit ensure-sysext.service)...
Jan 30 13:15:48.923035 systemd[1]: Reloading...
Jan 30 13:15:48.934251 systemd-tmpfiles[1361]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring.
Jan 30 13:15:48.934658 systemd-tmpfiles[1361]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring.
Jan 30 13:15:48.935336 systemd-tmpfiles[1361]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring.
Jan 30 13:15:48.935589 systemd-tmpfiles[1361]: ACLs are not supported, ignoring.
Jan 30 13:15:48.935642 systemd-tmpfiles[1361]: ACLs are not supported, ignoring.
Jan 30 13:15:48.938247 systemd-tmpfiles[1361]: Detected autofs mount point /boot during canonicalization of boot.
Jan 30 13:15:48.938260 systemd-tmpfiles[1361]: Skipping /boot
Jan 30 13:15:48.945765 systemd-tmpfiles[1361]: Detected autofs mount point /boot during canonicalization of boot.
Jan 30 13:15:48.945784 systemd-tmpfiles[1361]: Skipping /boot
Jan 30 13:15:48.978346 zram_generator::config[1394]: No configuration found.
Jan 30 13:15:49.068860 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.
Jan 30 13:15:49.114366 systemd[1]: Reloading finished in 190 ms.
Jan 30 13:15:49.131671 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories.
Jan 30 13:15:49.152865 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules...
Jan 30 13:15:49.155773 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs...
Jan 30 13:15:49.158521 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog...
Jan 30 13:15:49.164533 systemd[1]: Starting systemd-resolved.service - Network Name Resolution...
Jan 30 13:15:49.167081 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP...
Jan 30 13:15:49.181625 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jan 30 13:15:49.186628 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jan 30 13:15:49.193778 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jan 30 13:15:49.199331 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jan 30 13:15:49.201143 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jan 30 13:15:49.201924 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jan 30 13:15:49.202104 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jan 30 13:15:49.209819 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jan 30 13:15:49.210012 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jan 30 13:15:49.211914 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jan 30 13:15:49.212097 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jan 30 13:15:49.223502 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog.
Jan 30 13:15:49.231571 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jan 30 13:15:49.247751 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jan 30 13:15:49.252643 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jan 30 13:15:49.258642 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jan 30 13:15:49.259900 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jan 30 13:15:49.264617 systemd[1]: Starting systemd-update-done.service - Update is Completed...
Jan 30 13:15:49.266726 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs.
Jan 30 13:15:49.270248 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP.
Jan 30 13:15:49.271525 augenrules[1472]: No rules
Jan 30 13:15:49.271975 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jan 30 13:15:49.272142 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jan 30 13:15:49.273904 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules.
Jan 30 13:15:49.275547 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jan 30 13:15:49.275713 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jan 30 13:15:49.277750 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jan 30 13:15:49.277968 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jan 30 13:15:49.279525 systemd-resolved[1436]: Positive Trust Anchors:
Jan 30 13:15:49.279541 systemd-resolved[1436]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d
Jan 30 13:15:49.279577 systemd-resolved[1436]: 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
Jan 30 13:15:49.283877 systemd[1]: Finished systemd-update-done.service - Update is Completed.
Jan 30 13:15:49.289459 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met.
Jan 30 13:15:49.289934 systemd-resolved[1436]: Defaulting to hostname 'linux'.
Jan 30 13:15:49.302601 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod...
Jan 30 13:15:49.304859 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm...
Jan 30 13:15:49.307100 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore...
Jan 30 13:15:49.309639 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop...
Jan 30 13:15:49.310833 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met.
Jan 30 13:15:49.310898 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).
Jan 30 13:15:49.311182 systemd[1]: Started systemd-resolved.service - Network Name Resolution.
Jan 30 13:15:49.313022 systemd[1]: Finished ensure-sysext.service.
Jan 30 13:15:49.314401 systemd[1]: modprobe@dm_mod.service: Deactivated successfully.
Jan 30 13:15:49.314598 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod.
Jan 30 13:15:49.316165 systemd[1]: modprobe@drm.service: Deactivated successfully.
Jan 30 13:15:49.316482 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm.
Jan 30 13:15:49.317986 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
Jan 30 13:15:49.318162 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore.
Jan 30 13:15:49.319931 systemd[1]: modprobe@loop.service: Deactivated successfully.
Jan 30 13:15:49.320169 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop.
Jan 30 13:15:49.328103 systemd[1]: Reached target network.target - Network.
Jan 30 13:15:49.329177 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups.
Jan 30 13:15:49.330559 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
Jan 30 13:15:49.330655 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met.
Jan 30 13:15:49.339478 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization...
Jan 30 13:15:49.383548 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization.
Jan 30 13:15:49.384396 systemd-timesyncd[1504]: Contacted time server 10.0.0.1:123 (10.0.0.1).
Jan 30 13:15:49.384449 systemd-timesyncd[1504]: Initial clock synchronization to Thu 2025-01-30 13:15:49.150659 UTC.
Jan 30 13:15:49.385249 systemd[1]: Reached target sysinit.target - System Initialization.
Jan 30 13:15:49.386549 systemd[1]: Started motdgen.path - Watch for update engine configuration changes.
Jan 30 13:15:49.387884 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data.
Jan 30 13:15:49.389205 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories.
Jan 30 13:15:49.390527 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate).
Jan 30 13:15:49.390564 systemd[1]: Reached target paths.target - Path Units.
Jan 30 13:15:49.391499 systemd[1]: Reached target time-set.target - System Time Set.
Jan 30 13:15:49.392669 systemd[1]: Started logrotate.timer - Daily rotation of log files.
Jan 30 13:15:49.393864 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information..
Jan 30 13:15:49.395118 systemd[1]: Reached target timers.target - Timer Units.
Jan 30 13:15:49.396871 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket.
Jan 30 13:15:49.399533 systemd[1]: Starting docker.socket - Docker Socket for the API...
Jan 30 13:15:49.401697 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket.
Jan 30 13:15:49.404437 systemd[1]: Listening on docker.socket - Docker Socket for the API.
Jan 30 13:15:49.405567 systemd[1]: Reached target sockets.target - Socket Units.
Jan 30 13:15:49.406534 systemd[1]: Reached target basic.target - Basic System.
Jan 30 13:15:49.407629 systemd[1]: System is tainted: cgroupsv1
Jan 30 13:15:49.407679 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met.
Jan 30 13:15:49.407702 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met.
Jan 30 13:15:49.408991 systemd[1]: Starting containerd.service - containerd container runtime...
Jan 30 13:15:49.411267 systemd[1]: Starting dbus.service - D-Bus System Message Bus...
Jan 30 13:15:49.413459 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit...
Jan 30 13:15:49.416488 systemd[1]: Starting extend-filesystems.service - Extend Filesystems...
Jan 30 13:15:49.417645 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).
Jan 30 13:15:49.421035 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd...
Jan 30 13:15:49.425720 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline...
Jan 30 13:15:49.431151 jq[1510]: false
Jan 30 13:15:49.431632 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys...
Jan 30 13:15:49.439522 systemd[1]: Starting systemd-logind.service - User Login Management...
Jan 30 13:15:49.447052 extend-filesystems[1512]: Found loop3
Jan 30 13:15:49.447052 extend-filesystems[1512]: Found loop4
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found loop5
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda1
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda2
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda3
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found usr
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda4
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda6
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda7
Jan 30 13:15:49.449312 extend-filesystems[1512]: Found vda9
Jan 30 13:15:49.449312 extend-filesystems[1512]: Checking size of /dev/vda9
Jan 30 13:15:49.447540 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0).
Jan 30 13:15:49.449580 systemd[1]: Starting update-engine.service - Update Engine...
Jan 30 13:15:49.454619 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition...
Jan 30 13:15:49.465876 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'.
Jan 30 13:15:49.466138 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped.
Jan 30 13:15:49.466442 systemd[1]: motdgen.service: Deactivated successfully.
Jan 30 13:15:49.466644 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd.
Jan 30 13:15:49.468387 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully.
Jan 30 13:15:49.468617 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline.
Jan 30 13:15:49.471763 dbus-daemon[1509]: [system] SELinux support is enabled
Jan 30 13:15:49.473217 systemd[1]: Started dbus.service - D-Bus System Message Bus.
Jan 30 13:15:49.476616 jq[1529]: true
Jan 30 13:15:49.482516 extend-filesystems[1512]: Resized partition /dev/vda9
Jan 30 13:15:49.489628 extend-filesystems[1542]: resize2fs 1.47.1 (20-May-2024)
Jan 30 13:15:49.494580 jq[1539]: true
Jan 30 13:15:49.496270 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1238)
Jan 30 13:15:49.499557 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks
Jan 30 13:15:49.511911 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).
Jan 30 13:15:49.511950 systemd[1]: Reached target system-config.target - Load system-provided cloud configs.
Jan 30 13:15:49.514124 (ntainerd)[1541]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR
Jan 30 13:15:49.516583 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).
Jan 30 13:15:49.518496 update_engine[1527]: I20250130 13:15:49.517230 1527 main.cc:92] Flatcar Update Engine starting
Jan 30 13:15:49.516616 systemd[1]: Reached target user-config.target - Load user-provided cloud configs.
Jan 30 13:15:49.521017 systemd[1]: Started update-engine.service - Update Engine.
Jan 30 13:15:49.521655 update_engine[1527]: I20250130 13:15:49.521569 1527 update_check_scheduler.cc:74] Next update check in 10m29s
Jan 30 13:15:49.523244 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details.
Jan 30 13:15:49.526511 systemd[1]: Started locksmithd.service - Cluster reboot manager.
Jan 30 13:15:49.535321 kernel: EXT4-fs (vda9): resized filesystem to 1864699
Jan 30 13:15:49.554464 systemd-logind[1520]: Watching system buttons on /dev/input/event0 (Power Button)
Jan 30 13:15:49.567877 extend-filesystems[1542]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required
Jan 30 13:15:49.567877 extend-filesystems[1542]: old_desc_blocks = 1, new_desc_blocks = 1
Jan 30 13:15:49.567877 extend-filesystems[1542]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long.
Jan 30 13:15:49.567747 systemd-logind[1520]: New seat seat0.
Jan 30 13:15:49.583663 extend-filesystems[1512]: Resized filesystem in /dev/vda9
Jan 30 13:15:49.568831 systemd[1]: extend-filesystems.service: Deactivated successfully.
Jan 30 13:15:49.569071 systemd[1]: Finished extend-filesystems.service - Extend Filesystems.
Jan 30 13:15:49.577184 systemd[1]: Started systemd-logind.service - User Login Management.
Jan 30 13:15:49.588732 bash[1565]: Updated "/home/core/.ssh/authorized_keys"
Jan 30 13:15:49.589953 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition.
Jan 30 13:15:49.592526 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met.
Jan 30 13:15:49.600025 locksmithd[1551]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot"
Jan 30 13:15:49.707159 containerd[1541]: time="2025-01-30T13:15:49.707052680Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21
Jan 30 13:15:49.732846 containerd[1541]: time="2025-01-30T13:15:49.732790880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734363 containerd[1541]: time="2025-01-30T13:15:49.734317560Z" 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.74-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734363 containerd[1541]: time="2025-01-30T13:15:49.734354440Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
Jan 30 13:15:49.734363 containerd[1541]: time="2025-01-30T13:15:49.734370680Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
Jan 30 13:15:49.734562 containerd[1541]: time="2025-01-30T13:15:49.734532400Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
Jan 30 13:15:49.734562 containerd[1541]: time="2025-01-30T13:15:49.734556400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734626 containerd[1541]: time="2025-01-30T13:15:49.734610480Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734652 containerd[1541]: time="2025-01-30T13:15:49.734627800Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734871 containerd[1541]: time="2025-01-30T13:15:49.734840760Z" 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
Jan 30 13:15:49.734871 containerd[1541]: time="2025-01-30T13:15:49.734863520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734922 containerd[1541]: time="2025-01-30T13:15:49.734877200Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734922 containerd[1541]: time="2025-01-30T13:15:49.734886720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.734973 containerd[1541]: time="2025-01-30T13:15:49.734958560Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.735185 containerd[1541]: time="2025-01-30T13:15:49.735157720Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1
Jan 30 13:15:49.735328 containerd[1541]: time="2025-01-30T13:15:49.735290640Z" 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
Jan 30 13:15:49.735355 containerd[1541]: time="2025-01-30T13:15:49.735329160Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
Jan 30 13:15:49.735425 containerd[1541]: time="2025-01-30T13:15:49.735409840Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
Jan 30 13:15:49.735469 containerd[1541]: time="2025-01-30T13:15:49.735456840Z" level=info msg="metadata content store policy set" policy=shared
Jan 30 13:15:49.739754 containerd[1541]: time="2025-01-30T13:15:49.739721240Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
Jan 30 13:15:49.739794 containerd[1541]: time="2025-01-30T13:15:49.739775280Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
Jan 30 13:15:49.739814 containerd[1541]: time="2025-01-30T13:15:49.739791880Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
Jan 30 13:15:49.739833 containerd[1541]: time="2025-01-30T13:15:49.739814960Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
Jan 30 13:15:49.739833 containerd[1541]: time="2025-01-30T13:15:49.739828960Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1
Jan 30 13:15:49.740004 containerd[1541]: time="2025-01-30T13:15:49.739974840Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1
Jan 30 13:15:49.740955 containerd[1541]: time="2025-01-30T13:15:49.740922200Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
Jan 30 13:15:49.741086 containerd[1541]: time="2025-01-30T13:15:49.741068400Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
Jan 30 13:15:49.741119 containerd[1541]: time="2025-01-30T13:15:49.741092440Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
Jan 30 13:15:49.741119 containerd[1541]: time="2025-01-30T13:15:49.741106160Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
Jan 30 13:15:49.741164 containerd[1541]: time="2025-01-30T13:15:49.741119760Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741164 containerd[1541]: time="2025-01-30T13:15:49.741144640Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741164 containerd[1541]: time="2025-01-30T13:15:49.741159920Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741214 containerd[1541]: time="2025-01-30T13:15:49.741174560Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741214 containerd[1541]: time="2025-01-30T13:15:49.741192480Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741214 containerd[1541]: time="2025-01-30T13:15:49.741205400Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741268 containerd[1541]: time="2025-01-30T13:15:49.741217320Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741268 containerd[1541]: time="2025-01-30T13:15:49.741229600Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
Jan 30 13:15:49.741268 containerd[1541]: time="2025-01-30T13:15:49.741248920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741334 containerd[1541]: time="2025-01-30T13:15:49.741270920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741334 containerd[1541]: time="2025-01-30T13:15:49.741288040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741334 containerd[1541]: time="2025-01-30T13:15:49.741324720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741396 containerd[1541]: time="2025-01-30T13:15:49.741338880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741396 containerd[1541]: time="2025-01-30T13:15:49.741352560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741396 containerd[1541]: time="2025-01-30T13:15:49.741365560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741396 containerd[1541]: time="2025-01-30T13:15:49.741378200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741396 containerd[1541]: time="2025-01-30T13:15:49.741390640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741405800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741417920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741429960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741442520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741458920Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
Jan 30 13:15:49.741483 containerd[1541]: time="2025-01-30T13:15:49.741480560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741585 containerd[1541]: time="2025-01-30T13:15:49.741493800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741585 containerd[1541]: time="2025-01-30T13:15:49.741505800Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
Jan 30 13:15:49.741636 containerd[1541]: time="2025-01-30T13:15:49.741621160Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
Jan 30 13:15:49.741658 containerd[1541]: time="2025-01-30T13:15:49.741641960Z" 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
Jan 30 13:15:49.741658 containerd[1541]: time="2025-01-30T13:15:49.741653080Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
Jan 30 13:15:49.741700 containerd[1541]: time="2025-01-30T13:15:49.741665040Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
Jan 30 13:15:49.741700 containerd[1541]: time="2025-01-30T13:15:49.741676240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.741700 containerd[1541]: time="2025-01-30T13:15:49.741687720Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
Jan 30 13:15:49.741700 containerd[1541]: time="2025-01-30T13:15:49.741697760Z" level=info msg="NRI interface is disabled by configuration."
Jan 30 13:15:49.741766 containerd[1541]: time="2025-01-30T13:15:49.741709280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1
Jan 30 13:15:49.742101 containerd[1541]: time="2025-01-30T13:15:49.742044800Z" 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:false] 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:false 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}"
Jan 30 13:15:49.742215 containerd[1541]: time="2025-01-30T13:15:49.742106920Z" level=info msg="Connect containerd service"
Jan 30 13:15:49.742215 containerd[1541]: time="2025-01-30T13:15:49.742147480Z" level=info msg="using legacy CRI server"
Jan 30 13:15:49.742215 containerd[1541]: time="2025-01-30T13:15:49.742156120Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this"
Jan 30 13:15:49.742279 containerd[1541]: time="2025-01-30T13:15:49.742237600Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\""
Jan 30 13:15:49.742878 containerd[1541]: time="2025-01-30T13:15:49.742850120Z" 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"
Jan 30 13:15:49.743291 containerd[1541]: time="2025-01-30T13:15:49.743150120Z" level=info msg="Start subscribing containerd event"
Jan 30 13:15:49.743291 containerd[1541]: time="2025-01-30T13:15:49.743221000Z" level=info msg="Start recovering state"
Jan 30 13:15:49.743383 containerd[1541]: time="2025-01-30T13:15:49.743369360Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc
Jan 30 13:15:49.743443 containerd[1541]: time="2025-01-30T13:15:49.743428360Z" level=info msg="Start event monitor"
Jan 30 13:15:49.743502 containerd[1541]: time="2025-01-30T13:15:49.743490360Z" level=info msg="Start snapshots syncer"
Jan 30 13:15:49.743551 containerd[1541]: time="2025-01-30T13:15:49.743538040Z" level=info msg="Start cni network conf syncer for default"
Jan 30 13:15:49.743617 containerd[1541]: time="2025-01-30T13:15:49.743450840Z" level=info msg=serving... address=/run/containerd/containerd.sock
Jan 30 13:15:49.743663 containerd[1541]: time="2025-01-30T13:15:49.743590200Z" level=info msg="Start streaming server"
Jan 30 13:15:49.743793 containerd[1541]: time="2025-01-30T13:15:49.743728320Z" level=info msg="containerd successfully booted in 0.039021s"
Jan 30 13:15:49.743841 systemd[1]: Started containerd.service - containerd container runtime.
Jan 30 13:15:50.051493 systemd-networkd[1229]: eth0: Gained IPv6LL
Jan 30 13:15:50.053833 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured.
Jan 30 13:15:50.055667 systemd[1]: Reached target network-online.target - Network is Online.
Jan 30 13:15:50.070563 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
Jan 30 13:15:50.075502 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
Jan 30 13:15:50.077802 systemd[1]: Starting nvidia.service - NVIDIA Configure Service...
Jan 30 13:15:50.098684 systemd[1]: Finished nvidia.service - NVIDIA Configure Service.
Jan 30 13:15:50.104337 systemd[1]: coreos-metadata.service: Deactivated successfully.
Jan 30 13:15:50.104628 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
Jan 30 13:15:50.106163 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met.
Jan 30 13:15:50.295674 sshd_keygen[1533]: ssh-keygen: generating new host keys: RSA ECDSA ED25519
Jan 30 13:15:50.313682 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys.
Jan 30 13:15:50.327575 systemd[1]: Starting issuegen.service - Generate /run/issue...
Jan 30 13:15:50.333289 systemd[1]: issuegen.service: Deactivated successfully.
Jan 30 13:15:50.333549 systemd[1]: Finished issuegen.service - Generate /run/issue.
Jan 30 13:15:50.336347 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions...
Jan 30 13:15:50.351730 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions.
Jan 30 13:15:50.354619 systemd[1]: Started getty@tty1.service - Getty on tty1.
Jan 30 13:15:50.356675 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0.
Jan 30 13:15:50.358131 systemd[1]: Reached target getty.target - Login Prompts.
Jan 30 13:15:50.566514 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent.
Jan 30 13:15:50.567926 systemd[1]: Reached target multi-user.target - Multi-User System.
Jan 30 13:15:50.570117 (kubelet)[1635]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS
Jan 30 13:15:50.572385 systemd[1]: Startup finished in 4.994s (kernel) + 3.557s (userspace) = 8.552s.
Jan 30 13:15:51.050919 kubelet[1635]: E0130 13:15:51.050804 1635 run.go:74] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory"
Jan 30 13:15:51.053108 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE
Jan 30 13:15:51.053314 systemd[1]: kubelet.service: Failed with result 'exit-code'.
Jan 30 13:15:55.773780 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd.
Jan 30 13:15:55.783580 systemd[1]: Started sshd@0-10.0.0.150:22-10.0.0.1:34530.service - OpenSSH per-connection server daemon (10.0.0.1:34530).
Jan 30 13:15:55.844448 sshd[1650]: Accepted publickey for core from 10.0.0.1 port 34530 ssh2: RSA SHA256:L/o4MUo/PVZc4DGxUVgHzL5cb5Nt9LAG1MaqWWrUsp0
Jan 30 13:15:55.846391 sshd[1650]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Jan 30 13:15:55.859760 systemd-logind[1520]: New session 1 of user core.
Jan 30 13:15:55.860666 systemd[1]: Created slice user-500.slice - User Slice of UID 500.
Jan 30 13:15:55.869589 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500...
Jan 30 13:15:55.879844 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500.
Jan 30 13:15:55.882561 systemd[1]: Starting user@500.service - User Manager for UID 500...
Jan 30 13:15:55.889609 (systemd)[1656]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0)
Jan 30 13:15:55.969344 systemd[1656]: Queued start job for default target default.target.
Jan 30 13:15:55.970109 systemd[1656]: Created slice app.slice - User Application Slice.
Jan 30 13:15:55.970141 systemd[1656]: Reached target paths.target - Paths.
Jan 30 13:15:55.970151 systemd[1656]: Reached target timers.target - Timers.
Jan 30 13:15:55.980408 systemd[1656]: Starting dbus.socket - D-Bus User Message Bus Socket...
Jan 30 13:15:55.987427 systemd[1656]: Listening on dbus.socket - D-Bus User Message Bus Socket.
Jan 30 13:15:55.987589 systemd[1656]: Reached target sockets.target - Sockets.
Jan 30 13:15:55.987604 systemd[1656]: Reached target basic.target - Basic System.
Jan 30 13:15:55.987644 systemd[1656]: Reached target default.target - Main User Target.
Jan 30 13:15:55.987674 systemd[1656]: Startup finished in 92ms.
Jan 30 13:15:55.987878 systemd[1]: Started user@500.service - User Manager for UID 500.
Jan 30 13:15:55.989222 systemd[1]: Started session-1.scope - Session 1 of User core.
Jan 30 13:15:56.053580 systemd[1]: Started sshd@1-10.0.0.150:22-10.0.0.1:34538.service - OpenSSH per-connection server daemon (10.0.0.1:34538).
Jan 30 13:15:56.088859 sshd[1668]: Accepted publickey for core from 10.0.0.1 port 34538 ssh2: RSA SHA256:L/o4MUo/PVZc4DGxUVgHzL5cb5Nt9LAG1MaqWWrUsp0
Jan 30 13:15:56.090156 sshd[1668]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Jan 30 13:15:56.094697 systemd-logind[1520]: New session 2 of user core.
Jan 30 13:15:56.100658 systemd[1]: Started session-2.scope - Session 2 of User core.
Jan 30 13:15:56.153692 sshd[1668]: pam_unix(sshd:session): session closed for user core
Jan 30 13:15:56.162642 systemd[1]: Started sshd@2-10.0.0.150:22-10.0.0.1:34554.service - OpenSSH per-connection server daemon (10.0.0.1:34554).
Jan 30 13:15:56.163017 systemd[1]: sshd@1-10.0.0.150:22-10.0.0.1:34538.service: Deactivated successfully.
Jan 30 13:15:56.165395 systemd[1]: session-2.scope: Deactivated successfully.
Jan 30 13:15:56.166077 systemd-logind[1520]: Session 2 logged out. Waiting for processes to exit.
Jan 30 13:15:56.167039 systemd-logind[1520]: Removed session 2.
Jan 30 13:15:56.194453 sshd[1673]: Accepted publickey for core from 10.0.0.1 port 34554 ssh2: RSA SHA256:L/o4MUo/PVZc4DGxUVgHzL5cb5Nt9LAG1MaqWWrUsp0
Jan 30 13:15:56.195716 sshd[1673]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Jan 30 13:15:56.199424 systemd-logind[1520]: New session 3 of user core.
Jan 30 13:15:56.209628 systemd[1]: Started session-3.scope - Session 3 of User core.
Jan 30 13:15:56.257767 sshd[1673]: pam_unix(sshd:session): session closed for user core
Jan 30 13:15:56.268578 systemd[1]: Started sshd@3-10.0.0.150:22-10.0.0.1:34566.service - OpenSSH per-connection server daemon (10.0.0.1:34566).
Jan 30 13:15:56.269098 systemd[1]: sshd@2-10.0.0.150:22-10.0.0.1:34554.service: Deactivated successfully.
Jan 30 13:15:56.270389 systemd[1]: session-3.scope: Deactivated successfully.
Jan 30 13:15:56.271059 systemd-logind[1520]: Session 3 logged out. Waiting for processes to exit.
Jan 30 13:15:56.272256 systemd-logind[1520]: Removed session 3.
Jan 30 13:15:56.299797 sshd[1681]: Accepted publickey for core from 10.0.0.1 port 34566 ssh2: RSA SHA256:L/o4MUo/PVZc4DGxUVgHzL5cb5Nt9LAG1MaqWWrUsp0
Jan 30 13:15:56.301070 sshd[1681]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Jan 30 13:15:56.305454 systemd-logind[1520]: New session 4 of user core.
Jan 30 13:15:56.311619 systemd[1]: Started session-4.scope - Session 4 of User core.
Jan 30 13:15:56.363170 sshd[1681]: pam_unix(sshd:session): session closed for user core
Jan 30 13:15:56.370614 systemd[1]: Started sshd@4-10.0.0.150:22-10.0.0.1:34582.service - OpenSSH per-connection server daemon (10.0.0.1:34582).
Jan 30 13:15:56.371027 systemd[1]: sshd@3-10.0.0.150:22-10.0.0.1:34566.service: Deactivated successfully.
Jan 30 13:15:56.372418 systemd[1]: session-4.scope: Deactivated successfully.
Jan 30 13:15:56.372963 systemd-logind[1520]: Session 4 logged out. Waiting for processes to exit.
Jan 30 13:15:56.374198 systemd-logind[1520]: Removed session 4.
Jan 30 13:15:56.402471 sshd[1689]: Accepted publickey for core from 10.0.0.1 port 34582 ssh2: RSA SHA256:L/o4MUo/PVZc4DGxUVgHzL5cb5Nt9LAG1MaqWWrUsp0
Jan 30 13:15:56.403760 sshd[1689]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0)
Jan 30 13:15:56.408532 systemd-logind[1520]: New session 5 of user core.
Jan 30 13:15:56.417633 systemd[1]: Started session-5.scope - Session 5 of User core.
Jan 30 13:15:56.483428 sudo[1696]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh
Jan 30 13:15:56.483706 sudo[1696]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500)
Jan 30 13:15:56.505698 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent...
Jan 30 13:15:56.523118 systemd[1]: coreos-metadata.service: Deactivated successfully.
Jan 30 13:15:56.523381 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent.
Jan 30 13:15:57.150719 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent.
Jan 30 13:15:57.164606 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
Jan 30 13:15:57.182112 systemd[1]: Reloading requested from client PID 1749 ('systemctl') (unit session-5.scope)...
Jan 30 13:15:57.182130 systemd[1]: Reloading...
Jan 30 13:15:57.242137 zram_generator::config[1785]: No configuration found.
Jan 30 13:15:57.359135 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.
Jan 30 13:15:57.413941 systemd[1]: Reloading finished in 231 ms.
Jan 30 13:15:57.462436 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM
Jan 30 13:15:57.462518 systemd[1]: kubelet.service: Failed with result 'signal'.
Jan 30 13:15:57.462800 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent.
Jan 30 13:15:57.465387 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent...
Jan 30 13:15:57.563940 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent.
Jan 30 13:15:57.569647 (kubelet)[1845]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS
Jan 30 13:15:57.613722 kubelet[1845]: 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.
Jan 30 13:15:57.613722 kubelet[1845]: 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.
Jan 30 13:15:57.613722 kubelet[1845]: 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.
Jan 30 13:15:57.614764 kubelet[1845]: I0130 13:15:57.614710 1845 server.go:205] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime"
Jan 30 13:15:58.506148 kubelet[1845]: I0130 13:15:58.506101 1845 server.go:484] "Kubelet version" kubeletVersion="v1.30.1"
Jan 30 13:15:58.506148 kubelet[1845]: I0130 13:15:58.506137 1845 server.go:486] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
Jan 30 13:15:58.506412 kubelet[1845]: I0130 13:15:58.506386 1845 server.go:927] "Client rotation is on, will bootstrap in background"
Jan 30 13:15:58.528039 kubelet[1845]: I0130 13:15:58.527919 1845 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt"
Jan 30 13:15:58.543531 kubelet[1845]: I0130 13:15:58.543486 1845 server.go:742] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /"
Jan 30 13:15:58.544133 kubelet[1845]: I0130 13:15:58.544087 1845 container_manager_linux.go:265] "Container manager verified user specified cgroup-root exists" cgroupRoot=[]
Jan 30 13:15:58.544288 kubelet[1845]: I0130 13:15:58.544121 1845 container_manager_linux.go:270] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.0.0.150","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"cgroupfs","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null}
Jan 30 13:15:58.544383 kubelet[1845]: I0130 13:15:58.544372 1845 topology_manager.go:138] "Creating topology manager with none policy"
Jan 30 13:15:58.544383 kubelet[1845]: I0130 13:15:58.544384 1845 container_manager_linux.go:301] "Creating device plugin manager"
Jan 30 13:15:58.544609 kubelet[1845]: I0130 13:15:58.544569 1845 state_mem.go:36] "Initialized new in-memory state store"
Jan 30 13:15:58.545423 kubelet[1845]: I0130 13:15:58.545388 1845 kubelet.go:400] "Attempting to sync node with API server"
Jan 30 13:15:58.545423 kubelet[1845]: I0130 13:15:58.545416 1845 kubelet.go:301] "Adding static pod path" path="/etc/kubernetes/manifests"
Jan 30 13:15:58.545636 kubelet[1845]: I0130 13:15:58.545619 1845 kubelet.go:312] "Adding apiserver pod source"
Jan 30 13:15:58.545757 kubelet[1845]: I0130 13:15:58.545740 1845 apiserver.go:42] "Waiting for node sync before watching apiserver pods"
Jan 30 13:15:58.545801 kubelet[1845]: E0130 13:15:58.545780 1845 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:15:58.545989 kubelet[1845]: E0130 13:15:58.545899 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:15:58.546885 kubelet[1845]: I0130 13:15:58.546808 1845 kuberuntime_manager.go:261] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1"
Jan 30 13:15:58.547227 kubelet[1845]: I0130 13:15:58.547162 1845 kubelet.go:815] "Not starting ClusterTrustBundle informer because we are in static kubelet mode"
Jan 30 13:15:58.547278 kubelet[1845]: W0130 13:15:58.547259 1845 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating.
Jan 30 13:15:58.548272 kubelet[1845]: I0130 13:15:58.548017 1845 server.go:1264] "Started kubelet"
Jan 30 13:15:58.548479 kubelet[1845]: I0130 13:15:58.548431 1845 server.go:163] "Starting to listen" address="0.0.0.0" port=10250
Jan 30 13:15:58.548700 kubelet[1845]: I0130 13:15:58.548588 1845 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10
Jan 30 13:15:58.548970 kubelet[1845]: I0130 13:15:58.548941 1845 server.go:227] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock"
Jan 30 13:15:58.550320 kubelet[1845]: I0130 13:15:58.549757 1845 server.go:455] "Adding debug handlers to kubelet server"
Jan 30 13:15:58.552014 kubelet[1845]: I0130 13:15:58.551807 1845 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer"
Jan 30 13:15:58.552880 kubelet[1845]: E0130 13:15:58.552850 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:58.552985 kubelet[1845]: I0130 13:15:58.552951 1845 volume_manager.go:291] "Starting Kubelet Volume Manager"
Jan 30 13:15:58.553051 kubelet[1845]: I0130 13:15:58.553039 1845 desired_state_of_world_populator.go:149] "Desired state populator starts to run"
Jan 30 13:15:58.553990 kubelet[1845]: I0130 13:15:58.553164 1845 reconciler.go:26] "Reconciler: start to sync state"
Jan 30 13:15:58.553990 kubelet[1845]: E0130 13:15:58.553328 1845 kubelet.go:1467] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem"
Jan 30 13:15:58.554652 kubelet[1845]: I0130 13:15:58.554607 1845 factory.go:221] Registration of the systemd container factory successfully
Jan 30 13:15:58.554734 kubelet[1845]: I0130 13:15:58.554712 1845 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
Jan 30 13:15:58.558203 kubelet[1845]: I0130 13:15:58.558162 1845 factory.go:221] Registration of the containerd container factory successfully
Jan 30 13:15:58.572113 kubelet[1845]: E0130 13:15:58.572056 1845 controller.go:145] "Failed to ensure lease exists, will retry" err="leases.coordination.k8s.io \"10.0.0.150\" is forbidden: User \"system:anonymous\" cannot get resource \"leases\" in API group \"coordination.k8s.io\" in the namespace \"kube-node-lease\"" interval="200ms"
Jan 30 13:15:58.572261 kubelet[1845]: W0130 13:15:58.572191 1845 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Node: nodes "10.0.0.150" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope
Jan 30 13:15:58.572261 kubelet[1845]: E0130 13:15:58.572221 1845 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Node: failed to list *v1.Node: nodes "10.0.0.150" is forbidden: User "system:anonymous" cannot list resource "nodes" in API group "" at the cluster scope
Jan 30 13:15:58.572425 kubelet[1845]: W0130 13:15:58.572271 1845 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope
Jan 30 13:15:58.572425 kubelet[1845]: E0130 13:15:58.572282 1845 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:anonymous" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope
Jan 30 13:15:58.572918 kubelet[1845]: E0130 13:15:58.572483 1845 event.go:359] "Server rejected event (will not retry!)" err="events is forbidden: User \"system:anonymous\" cannot create resource \"events\" in API group \"\" in the namespace \"default\"" event="&Event{ObjectMeta:{10.0.0.150.181f7ac2dd93bcf1 default 0 0001-01-01 00:00:00 +0000 UTC <nil> <nil> map[] map[] [] [] []},InvolvedObject:ObjectReference{Kind:Node,Namespace:,Name:10.0.0.150,UID:10.0.0.150,APIVersion:,ResourceVersion:,FieldPath:,},Reason:Starting,Message:Starting kubelet.,Source:EventSource{Component:kubelet,Host:10.0.0.150,},FirstTimestamp:2025-01-30 13:15:58.547991793 +0000 UTC m=+0.974622729,LastTimestamp:2025-01-30 13:15:58.547991793 +0000 UTC m=+0.974622729,Count:1,Type:Normal,EventTime:0001-01-01 00:00:00 +0000 UTC,Series:nil,Action:,Related:nil,ReportingController:kubelet,ReportingInstance:10.0.0.150,}"
Jan 30 13:15:58.574513 kubelet[1845]: W0130 13:15:58.574357 1845 reflector.go:547] k8s.io/client-go/informers/factory.go:160: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope
Jan 30 13:15:58.574513 kubelet[1845]: E0130 13:15:58.574421 1845 reflector.go:150] k8s.io/client-go/informers/factory.go:160: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User "system:anonymous" cannot list resource "services" in API group "" at the cluster scope
Jan 30 13:15:58.579005 kubelet[1845]: I0130 13:15:58.578783 1845 cpu_manager.go:214] "Starting CPU manager" policy="none"
Jan 30 13:15:58.579005 kubelet[1845]: I0130 13:15:58.578826 1845 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s"
Jan 30 13:15:58.579005 kubelet[1845]: I0130 13:15:58.578845 1845 state_mem.go:36] "Initialized new in-memory state store"
Jan 30 13:15:58.645236 kubelet[1845]: I0130 13:15:58.645163 1845 policy_none.go:49] "None policy: Start"
Jan 30 13:15:58.646131 kubelet[1845]: I0130 13:15:58.646111 1845 memory_manager.go:170] "Starting memorymanager" policy="None"
Jan 30 13:15:58.646170 kubelet[1845]: I0130 13:15:58.646147 1845 state_mem.go:35] "Initializing new in-memory state store"
Jan 30 13:15:58.650966 kubelet[1845]: I0130 13:15:58.650935 1845 manager.go:479] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found"
Jan 30 13:15:58.651167 kubelet[1845]: I0130 13:15:58.651116 1845 container_log_manager.go:186] "Initializing container log rotate workers" workers=1 monitorPeriod="10s"
Jan 30 13:15:58.651235 kubelet[1845]: I0130 13:15:58.651222 1845 plugin_manager.go:118] "Starting Kubelet Plugin Manager"
Jan 30 13:15:58.653050 kubelet[1845]: E0130 13:15:58.653023 1845 eviction_manager.go:282] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.0.0.150\" not found"
Jan 30 13:15:58.653594 kubelet[1845]: I0130 13:15:58.653571 1845 kubelet_node_status.go:73] "Attempting to register node" node="10.0.0.150"
Jan 30 13:15:58.657592 kubelet[1845]: I0130 13:15:58.657566 1845 kubelet_node_status.go:76] "Successfully registered node" node="10.0.0.150"
Jan 30 13:15:58.669022 kubelet[1845]: I0130 13:15:58.668958 1845 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4"
Jan 30 13:15:58.670063 kubelet[1845]: I0130 13:15:58.670022 1845 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6"
Jan 30 13:15:58.670222 kubelet[1845]: I0130 13:15:58.670215 1845 status_manager.go:217] "Starting to sync pod status with apiserver"
Jan 30 13:15:58.670272 kubelet[1845]: I0130 13:15:58.670237 1845 kubelet.go:2337] "Starting kubelet main sync loop"
Jan 30 13:15:58.670355 kubelet[1845]: E0130 13:15:58.670281 1845 kubelet.go:2361] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful"
Jan 30 13:15:58.687963 kubelet[1845]: E0130 13:15:58.687923 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:58.788372 kubelet[1845]: E0130 13:15:58.788241 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:58.888653 kubelet[1845]: E0130 13:15:58.888598 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:58.989053 kubelet[1845]: E0130 13:15:58.988989 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.083880 sudo[1696]: pam_unix(sudo:session): session closed for user root
Jan 30 13:15:59.085720 sshd[1689]: pam_unix(sshd:session): session closed for user core
Jan 30 13:15:59.089804 kubelet[1845]: E0130 13:15:59.089745 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.090480 systemd[1]: sshd@4-10.0.0.150:22-10.0.0.1:34582.service: Deactivated successfully.
Jan 30 13:15:59.090889 systemd-logind[1520]: Session 5 logged out. Waiting for processes to exit.
Jan 30 13:15:59.092165 systemd[1]: session-5.scope: Deactivated successfully.
Jan 30 13:15:59.093136 systemd-logind[1520]: Removed session 5.
Jan 30 13:15:59.190315 kubelet[1845]: E0130 13:15:59.190252 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.290811 kubelet[1845]: E0130 13:15:59.290748 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.390951 kubelet[1845]: E0130 13:15:59.390815 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.491450 kubelet[1845]: E0130 13:15:59.491378 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.509615 kubelet[1845]: I0130 13:15:59.509547 1845 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials"
Jan 30 13:15:59.509769 kubelet[1845]: W0130 13:15:59.509730 1845 reflector.go:470] k8s.io/client-go/informers/factory.go:160: watch of *v1.Service ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received
Jan 30 13:15:59.509841 kubelet[1845]: W0130 13:15:59.509799 1845 reflector.go:470] k8s.io/client-go/informers/factory.go:160: watch of *v1.RuntimeClass ended with: very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received
Jan 30 13:15:59.546917 kubelet[1845]: E0130 13:15:59.546865 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:15:59.597008 kubelet[1845]: E0130 13:15:59.596967 1845 kubelet_node_status.go:462] "Error getting the current node from lister" err="node \"10.0.0.150\" not found"
Jan 30 13:15:59.698005 kubelet[1845]: I0130 13:15:59.697874 1845 kuberuntime_manager.go:1523] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24"
Jan 30 13:15:59.698360 containerd[1541]: time="2025-01-30T13:15:59.698183493Z" level=info msg="No cni config template is specified, wait for other system components to drop the config."
Jan 30 13:15:59.698552 kubelet[1845]: I0130 13:15:59.698360 1845 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24"
Jan 30 13:16:00.547710 kubelet[1845]: E0130 13:16:00.547450 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:00.547710 kubelet[1845]: I0130 13:16:00.547514 1845 apiserver.go:52] "Watching apiserver"
Jan 30 13:16:00.551901 kubelet[1845]: I0130 13:16:00.551849 1845 topology_manager.go:215] "Topology Admit Handler" podUID="d9307301-ed33-48a5-a4a1-90890c8e63be" podNamespace="kube-system" podName="kube-proxy-4vzmp"
Jan 30 13:16:00.552025 kubelet[1845]: I0130 13:16:00.551951 1845 topology_manager.go:215] "Topology Admit Handler" podUID="63c200b8-3380-4aef-8484-94af98f09fc8" podNamespace="kube-flannel" podName="kube-flannel-ds-fm5td"
Jan 30 13:16:00.553503 kubelet[1845]: I0130 13:16:00.553455 1845 desired_state_of_world_populator.go:157] "Finished populating initial desired state of world"
Jan 30 13:16:00.563680 kubelet[1845]: I0130 13:16:00.563641 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/63c200b8-3380-4aef-8484-94af98f09fc8-flannel-cfg\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563680 kubelet[1845]: I0130 13:16:00.563680 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/63c200b8-3380-4aef-8484-94af98f09fc8-xtables-lock\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563810 kubelet[1845]: I0130 13:16:00.563704 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-7tjbw\" (UniqueName: \"kubernetes.io/projected/63c200b8-3380-4aef-8484-94af98f09fc8-kube-api-access-7tjbw\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563810 kubelet[1845]: I0130 13:16:00.563722 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-5gwdj\" (UniqueName: \"kubernetes.io/projected/d9307301-ed33-48a5-a4a1-90890c8e63be-kube-api-access-5gwdj\") pod \"kube-proxy-4vzmp\" (UID: \"d9307301-ed33-48a5-a4a1-90890c8e63be\") " pod="kube-system/kube-proxy-4vzmp"
Jan 30 13:16:00.563810 kubelet[1845]: I0130 13:16:00.563737 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/63c200b8-3380-4aef-8484-94af98f09fc8-cni\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563810 kubelet[1845]: I0130 13:16:00.563753 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/d9307301-ed33-48a5-a4a1-90890c8e63be-lib-modules\") pod \"kube-proxy-4vzmp\" (UID: \"d9307301-ed33-48a5-a4a1-90890c8e63be\") " pod="kube-system/kube-proxy-4vzmp"
Jan 30 13:16:00.563810 kubelet[1845]: I0130 13:16:00.563768 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/63c200b8-3380-4aef-8484-94af98f09fc8-run\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563914 kubelet[1845]: I0130 13:16:00.563782 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/63c200b8-3380-4aef-8484-94af98f09fc8-cni-plugin\") pod \"kube-flannel-ds-fm5td\" (UID: \"63c200b8-3380-4aef-8484-94af98f09fc8\") " pod="kube-flannel/kube-flannel-ds-fm5td"
Jan 30 13:16:00.563914 kubelet[1845]: I0130 13:16:00.563799 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/d9307301-ed33-48a5-a4a1-90890c8e63be-kube-proxy\") pod \"kube-proxy-4vzmp\" (UID: \"d9307301-ed33-48a5-a4a1-90890c8e63be\") " pod="kube-system/kube-proxy-4vzmp"
Jan 30 13:16:00.563914 kubelet[1845]: I0130 13:16:00.563814 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/d9307301-ed33-48a5-a4a1-90890c8e63be-xtables-lock\") pod \"kube-proxy-4vzmp\" (UID: \"d9307301-ed33-48a5-a4a1-90890c8e63be\") " pod="kube-system/kube-proxy-4vzmp"
Jan 30 13:16:00.859572 kubelet[1845]: E0130 13:16:00.855704 1845 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"
Jan 30 13:16:00.859572 kubelet[1845]: E0130 13:16:00.855700 1845 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"
Jan 30 13:16:00.860158 containerd[1541]: time="2025-01-30T13:16:00.860104022Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-fm5td,Uid:63c200b8-3380-4aef-8484-94af98f09fc8,Namespace:kube-flannel,Attempt:0,}"
Jan 30 13:16:00.860419 containerd[1541]: time="2025-01-30T13:16:00.860315743Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-4vzmp,Uid:d9307301-ed33-48a5-a4a1-90890c8e63be,Namespace:kube-system,Attempt:0,}"
Jan 30 13:16:01.327683 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount856599142.mount: Deactivated successfully.
Jan 30 13:16:01.336961 containerd[1541]: time="2025-01-30T13:16:01.336884554Z" 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\"}"
Jan 30 13:16:01.338332 containerd[1541]: time="2025-01-30T13:16:01.338102432Z" 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\"}"
Jan 30 13:16:01.339356 containerd[1541]: time="2025-01-30T13:16:01.339319157Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=269175"
Jan 30 13:16:01.340187 containerd[1541]: time="2025-01-30T13:16:01.340114653Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0"
Jan 30 13:16:01.341218 containerd[1541]: time="2025-01-30T13:16:01.341150959Z" level=info msg="ImageCreate event name:\"sha256:4e42fb3c9d90ed7895bc04a9d96fe3102a65b521f485cc5a4f3dd818afef9cef\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}"
Jan 30 13:16:01.344689 containerd[1541]: time="2025-01-30T13:16:01.344625365Z" 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\"}"
Jan 30 13:16:01.345733 containerd[1541]: time="2025-01-30T13:16:01.345697827Z" 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 485.315309ms"
Jan 30 13:16:01.348160 containerd[1541]: time="2025-01-30T13:16:01.348124006Z" 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 487.924236ms"
Jan 30 13:16:01.471524 containerd[1541]: time="2025-01-30T13:16:01.471253753Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 30 13:16:01.471524 containerd[1541]: time="2025-01-30T13:16:01.471336434Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 30 13:16:01.471524 containerd[1541]: time="2025-01-30T13:16:01.471372986Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:01.471660 containerd[1541]: time="2025-01-30T13:16:01.471579946Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 30 13:16:01.471660 containerd[1541]: time="2025-01-30T13:16:01.471630364Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 30 13:16:01.471660 containerd[1541]: time="2025-01-30T13:16:01.471646257Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:01.471789 containerd[1541]: time="2025-01-30T13:16:01.471730685Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:01.472231 containerd[1541]: time="2025-01-30T13:16:01.471962516Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:01.547703 kubelet[1845]: E0130 13:16:01.547670 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:01.572800 containerd[1541]: time="2025-01-30T13:16:01.572748683Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-4vzmp,Uid:d9307301-ed33-48a5-a4a1-90890c8e63be,Namespace:kube-system,Attempt:0,} returns sandbox id \"54a126ebcbd381ce8037d20adf0f653a85c38da164abfd091f0ed963cc271e4d\""
Jan 30 13:16:01.574466 kubelet[1845]: E0130 13:16:01.574426 1845 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"
Jan 30 13:16:01.576698 containerd[1541]: time="2025-01-30T13:16:01.576662078Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.9\""
Jan 30 13:16:01.582732 containerd[1541]: time="2025-01-30T13:16:01.582598778Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-fm5td,Uid:63c200b8-3380-4aef-8484-94af98f09fc8,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\""
Jan 30 13:16:01.583400 kubelet[1845]: E0130 13:16:01.583209 1845 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"
Jan 30 13:16:02.548947 kubelet[1845]: E0130 13:16:02.548885 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:02.607925 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2801240782.mount: Deactivated successfully.
Jan 30 13:16:02.855446 containerd[1541]: time="2025-01-30T13:16:02.855313740Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.30.9\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:02.856001 containerd[1541]: time="2025-01-30T13:16:02.855956378Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.30.9: active requests=0, bytes read=25662714"
Jan 30 13:16:02.856863 containerd[1541]: time="2025-01-30T13:16:02.856798555Z" level=info msg="ImageCreate event name:\"sha256:d97113839930faa5ab88f70aff4bfb62f7381074a290dd5aadbec9b16b2567a2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:02.858689 containerd[1541]: time="2025-01-30T13:16:02.858649443Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:d78dc40d97ff862fd8ddb47f80a5ba3feec17bc73e58a60e963885e33faa0083\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:02.859860 containerd[1541]: time="2025-01-30T13:16:02.859824610Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.30.9\" with image id \"sha256:d97113839930faa5ab88f70aff4bfb62f7381074a290dd5aadbec9b16b2567a2\", repo tag \"registry.k8s.io/kube-proxy:v1.30.9\", repo digest \"registry.k8s.io/kube-proxy@sha256:d78dc40d97ff862fd8ddb47f80a5ba3feec17bc73e58a60e963885e33faa0083\", size \"25661731\" in 1.283039398s"
Jan 30 13:16:02.859860 containerd[1541]: time="2025-01-30T13:16:02.859859483Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.30.9\" returns image reference \"sha256:d97113839930faa5ab88f70aff4bfb62f7381074a290dd5aadbec9b16b2567a2\""
Jan 30 13:16:02.860836 containerd[1541]: time="2025-01-30T13:16:02.860808508Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\""
Jan 30 13:16:02.862410 containerd[1541]: time="2025-01-30T13:16:02.862340484Z" level=info msg="CreateContainer within sandbox \"54a126ebcbd381ce8037d20adf0f653a85c38da164abfd091f0ed963cc271e4d\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}"
Jan 30 13:16:02.876065 containerd[1541]: time="2025-01-30T13:16:02.876014893Z" level=info msg="CreateContainer within sandbox \"54a126ebcbd381ce8037d20adf0f653a85c38da164abfd091f0ed963cc271e4d\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"a84ccffe1c21d840bcbde8d22c976630138747bcbcbce6d68f0869da01e9c0fd\""
Jan 30 13:16:02.876786 containerd[1541]: time="2025-01-30T13:16:02.876752091Z" level=info msg="StartContainer for \"a84ccffe1c21d840bcbde8d22c976630138747bcbcbce6d68f0869da01e9c0fd\""
Jan 30 13:16:02.954249 containerd[1541]: time="2025-01-30T13:16:02.954197731Z" level=info msg="StartContainer for \"a84ccffe1c21d840bcbde8d22c976630138747bcbcbce6d68f0869da01e9c0fd\" returns successfully"
Jan 30 13:16:03.550036 kubelet[1845]: E0130 13:16:03.549975 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:03.681496 kubelet[1845]: E0130 13:16:03.681446 1845 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"
Jan 30 13:16:03.693433 kubelet[1845]: I0130 13:16:03.693322 1845 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-4vzmp" podStartSLOduration=4.408745922 podStartE2EDuration="5.693284779s" podCreationTimestamp="2025-01-30 13:15:58 +0000 UTC" firstStartedPulling="2025-01-30 13:16:01.576085063 +0000 UTC m=+4.002715999" lastFinishedPulling="2025-01-30 13:16:02.86062392 +0000 UTC m=+5.287254856" observedRunningTime="2025-01-30 13:16:03.692665701 +0000 UTC m=+6.119296637" watchObservedRunningTime="2025-01-30 13:16:03.693284779 +0000 UTC m=+6.119915913"
Jan 30 13:16:03.949951 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount231938824.mount: Deactivated successfully.
Jan 30 13:16:03.974870 containerd[1541]: time="2025-01-30T13:16:03.974820338Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:03.976023 containerd[1541]: time="2025-01-30T13:16:03.975902460Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3673531"
Jan 30 13:16:03.977093 containerd[1541]: time="2025-01-30T13:16:03.977052669Z" level=info msg="ImageCreate event name:\"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:03.979845 containerd[1541]: time="2025-01-30T13:16:03.979802881Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:03.980534 containerd[1541]: time="2025-01-30T13:16:03.980499716Z" 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.119659784s"
Jan 30 13:16:03.980534 containerd[1541]: time="2025-01-30T13:16:03.980534337Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:b45062ceea496fc421523388cb91166abc7715a15c2e2cbab4e6f8c9d5dc0ab8\""
Jan 30 13:16:03.982454 containerd[1541]: time="2025-01-30T13:16:03.982355873Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}"
Jan 30 13:16:03.992915 containerd[1541]: time="2025-01-30T13:16:03.992869879Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146\""
Jan 30 13:16:03.993364 containerd[1541]: time="2025-01-30T13:16:03.993337341Z" level=info msg="StartContainer for \"d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146\""
Jan 30 13:16:04.038619 containerd[1541]: time="2025-01-30T13:16:04.038581882Z" level=info msg="StartContainer for \"d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146\" returns successfully"
Jan 30 13:16:04.186294 containerd[1541]: time="2025-01-30T13:16:04.186236471Z" level=info msg="shim disconnected" id=d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146 namespace=k8s.io
Jan 30 13:16:04.186294 containerd[1541]: time="2025-01-30T13:16:04.186286166Z" level=warning msg="cleaning up after shim disconnected" id=d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146 namespace=k8s.io
Jan 30 13:16:04.186294 containerd[1541]: time="2025-01-30T13:16:04.186293971Z" level=info msg="cleaning up dead shim" namespace=k8s.io
Jan 30 13:16:04.550914 kubelet[1845]: E0130 13:16:04.550864 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:04.684561 kubelet[1845]: E0130 13:16:04.684511 1845 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"
Jan 30 13:16:04.685074 kubelet[1845]: E0130 13:16:04.684944 1845 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"
Jan 30 13:16:04.685681 containerd[1541]: time="2025-01-30T13:16:04.685642779Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\""
Jan 30 13:16:04.891288 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-d774f474809e83312cc8f775fa0bf521ac2de3a255690595d01e1b1e04acf146-rootfs.mount: Deactivated successfully.
Jan 30 13:16:05.551789 kubelet[1845]: E0130 13:16:05.551739 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:05.710922 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3650433713.mount: Deactivated successfully.
Jan 30 13:16:06.191893 containerd[1541]: time="2025-01-30T13:16:06.191835378Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:06.192459 containerd[1541]: time="2025-01-30T13:16:06.192424221Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26874261"
Jan 30 13:16:06.193354 containerd[1541]: time="2025-01-30T13:16:06.193320560Z" level=info msg="ImageCreate event name:\"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:06.196984 containerd[1541]: time="2025-01-30T13:16:06.196943784Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:06.197792 containerd[1541]: time="2025-01-30T13:16:06.197727114Z" 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.512037616s"
Jan 30 13:16:06.197792 containerd[1541]: time="2025-01-30T13:16:06.197769846Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:b3d1319ea6da12d4a1dd21a923f6a71f942a7b6e2c4763b8a3cca0725fb8aadf\""
Jan 30 13:16:06.200380 containerd[1541]: time="2025-01-30T13:16:06.200347487Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}"
Jan 30 13:16:06.210742 containerd[1541]: time="2025-01-30T13:16:06.210691418Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e\""
Jan 30 13:16:06.211392 containerd[1541]: time="2025-01-30T13:16:06.211345355Z" level=info msg="StartContainer for \"dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e\""
Jan 30 13:16:06.258597 containerd[1541]: time="2025-01-30T13:16:06.258553100Z" level=info msg="StartContainer for \"dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e\" returns successfully"
Jan 30 13:16:06.314277 kubelet[1845]: I0130 13:16:06.314044 1845 kubelet_node_status.go:497] "Fast updating node status as it just became ready"
Jan 30 13:16:06.389905 containerd[1541]: time="2025-01-30T13:16:06.389842967Z" level=info msg="shim disconnected" id=dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e namespace=k8s.io
Jan 30 13:16:06.389905 containerd[1541]: time="2025-01-30T13:16:06.389900289Z" level=warning msg="cleaning up after shim disconnected" id=dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e namespace=k8s.io
Jan 30 13:16:06.389905 containerd[1541]: time="2025-01-30T13:16:06.389909099Z" level=info msg="cleaning up dead shim" namespace=k8s.io
Jan 30 13:16:06.552052 kubelet[1845]: E0130 13:16:06.551887 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:06.689623 kubelet[1845]: E0130 13:16:06.689514 1845 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"
Jan 30 13:16:06.691633 containerd[1541]: time="2025-01-30T13:16:06.691501930Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}"
Jan 30 13:16:06.715653 containerd[1541]: time="2025-01-30T13:16:06.715569857Z" level=info msg="CreateContainer within sandbox \"ce121b08c23eb57bb91cb3a43f7ff1c22201f1d11d13d09ca6a8c0b9181337b2\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"e197b47ad5d3ae53ec0cb9048a5be48478fb9a1aabc9a7f2d148f0d3ad6f0cbd\""
Jan 30 13:16:06.716916 containerd[1541]: time="2025-01-30T13:16:06.716046488Z" level=info msg="StartContainer for \"e197b47ad5d3ae53ec0cb9048a5be48478fb9a1aabc9a7f2d148f0d3ad6f0cbd\""
Jan 30 13:16:06.756793 containerd[1541]: time="2025-01-30T13:16:06.756685161Z" level=info msg="StartContainer for \"e197b47ad5d3ae53ec0cb9048a5be48478fb9a1aabc9a7f2d148f0d3ad6f0cbd\" returns successfully"
Jan 30 13:16:07.207770 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-dc7ce2095cfcfa9ac2daed2322ae9796c857e9e484a5ec93ed644a4bc66f181e-rootfs.mount: Deactivated successfully.
Jan 30 13:16:07.552294 kubelet[1845]: E0130 13:16:07.552166 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:07.693692 kubelet[1845]: E0130 13:16:07.693200 1845 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"
Jan 30 13:16:07.708410 kubelet[1845]: I0130 13:16:07.708351 1845 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-fm5td" podStartSLOduration=5.093289543 podStartE2EDuration="9.708334875s" podCreationTimestamp="2025-01-30 13:15:58 +0000 UTC" firstStartedPulling="2025-01-30 13:16:01.583937796 +0000 UTC m=+4.010568732" lastFinishedPulling="2025-01-30 13:16:06.198983168 +0000 UTC m=+8.625614064" observedRunningTime="2025-01-30 13:16:07.708010896 +0000 UTC m=+10.134641831" watchObservedRunningTime="2025-01-30 13:16:07.708334875 +0000 UTC m=+10.134965811"
Jan 30 13:16:07.837864 systemd-networkd[1229]: flannel.1: Link UP
Jan 30 13:16:07.837872 systemd-networkd[1229]: flannel.1: Gained carrier
Jan 30 13:16:08.553159 kubelet[1845]: E0130 13:16:08.553069 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:08.695039 kubelet[1845]: E0130 13:16:08.694982 1845 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"
Jan 30 13:16:09.554191 kubelet[1845]: E0130 13:16:09.554118 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:09.699467 systemd-networkd[1229]: flannel.1: Gained IPv6LL
Jan 30 13:16:09.848234 kubelet[1845]: I0130 13:16:09.846065 1845 topology_manager.go:215] "Topology Admit Handler" podUID="ef1ac0d7-2cf3-4b26-a664-e96a2008d4ff" podNamespace="default" podName="nginx-deployment-85f456d6dd-m4429"
Jan 30 13:16:09.917851 kubelet[1845]: I0130 13:16:09.917810 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-95ql4\" (UniqueName: \"kubernetes.io/projected/ef1ac0d7-2cf3-4b26-a664-e96a2008d4ff-kube-api-access-95ql4\") pod \"nginx-deployment-85f456d6dd-m4429\" (UID: \"ef1ac0d7-2cf3-4b26-a664-e96a2008d4ff\") " pod="default/nginx-deployment-85f456d6dd-m4429"
Jan 30 13:16:10.150169 containerd[1541]: time="2025-01-30T13:16:10.150001514Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-m4429,Uid:ef1ac0d7-2cf3-4b26-a664-e96a2008d4ff,Namespace:default,Attempt:0,}"
Jan 30 13:16:10.187734 systemd-networkd[1229]: cni0: Link UP
Jan 30 13:16:10.187740 systemd-networkd[1229]: cni0: Gained carrier
Jan 30 13:16:10.188044 systemd-networkd[1229]: cni0: Lost carrier
Jan 30 13:16:10.193069 systemd-networkd[1229]: veth92b2f665: Link UP
Jan 30 13:16:10.195901 kernel: cni0: port 1(veth92b2f665) entered blocking state
Jan 30 13:16:10.196006 kernel: cni0: port 1(veth92b2f665) entered disabled state
Jan 30 13:16:10.196026 kernel: veth92b2f665: entered allmulticast mode
Jan 30 13:16:10.196875 kernel: veth92b2f665: entered promiscuous mode
Jan 30 13:16:10.198609 kernel: cni0: port 1(veth92b2f665) entered blocking state
Jan 30 13:16:10.198707 kernel: cni0: port 1(veth92b2f665) entered forwarding state
Jan 30 13:16:10.199689 kernel: cni0: port 1(veth92b2f665) entered disabled state
Jan 30 13:16:10.211708 kernel: cni0: port 1(veth92b2f665) entered blocking state
Jan 30 13:16:10.211787 kernel: cni0: port 1(veth92b2f665) entered forwarding state
Jan 30 13:16:10.212030 systemd-networkd[1229]: veth92b2f665: Gained carrier
Jan 30 13:16:10.212596 systemd-networkd[1229]: cni0: Gained carrier
Jan 30 13:16:10.214498 containerd[1541]: 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"}
Jan 30 13:16:10.214498 containerd[1541]: delegateAdd: netconf sent to delegate plugin:
Jan 30 13:16:10.237500 containerd[1541]: {"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-01-30T13:16:10.237114688Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 30 13:16:10.237500 containerd[1541]: time="2025-01-30T13:16:10.237234685Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 30 13:16:10.237500 containerd[1541]: time="2025-01-30T13:16:10.237252449Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:10.237500 containerd[1541]: time="2025-01-30T13:16:10.237474480Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:10.259957 systemd-resolved[1436]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
Jan 30 13:16:10.278450 containerd[1541]: time="2025-01-30T13:16:10.278406183Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-85f456d6dd-m4429,Uid:ef1ac0d7-2cf3-4b26-a664-e96a2008d4ff,Namespace:default,Attempt:0,} returns sandbox id \"361d371d834ddcc9e4457c4389ec5948b0ff240f8cbe4175a470eccdfc14cff2\""
Jan 30 13:16:10.280209 containerd[1541]: time="2025-01-30T13:16:10.280175041Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\""
Jan 30 13:16:10.555022 kubelet[1845]: E0130 13:16:10.554899 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:11.299529 systemd-networkd[1229]: cni0: Gained IPv6LL
Jan 30 13:16:11.555637 kubelet[1845]: E0130 13:16:11.555288 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:12.067528 systemd-networkd[1229]: veth92b2f665: Gained IPv6LL
Jan 30 13:16:12.247667 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1348027374.mount: Deactivated successfully.
Jan 30 13:16:12.556096 kubelet[1845]: E0130 13:16:12.555937 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:12.954509 containerd[1541]: time="2025-01-30T13:16:12.954357656Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:12.955496 containerd[1541]: time="2025-01-30T13:16:12.954726804Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=67680490"
Jan 30 13:16:12.956974 containerd[1541]: time="2025-01-30T13:16:12.956449734Z" level=info msg="ImageCreate event name:\"sha256:24e054abc3d1f73f3d72f6d30f9f1f63a4b4a2d920cd71b830c844925b3770a2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:12.962706 containerd[1541]: time="2025-01-30T13:16:12.962664582Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:2ffeb5a7ca68f2017f0bc48251750a6e40fcd3c341b94a22fc7812dcabbb84db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:12.965846 containerd[1541]: time="2025-01-30T13:16:12.965767772Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:24e054abc3d1f73f3d72f6d30f9f1f63a4b4a2d920cd71b830c844925b3770a2\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:2ffeb5a7ca68f2017f0bc48251750a6e40fcd3c341b94a22fc7812dcabbb84db\", size \"67680368\" in 2.68554183s"
Jan 30 13:16:12.965846 containerd[1541]: time="2025-01-30T13:16:12.965813981Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:24e054abc3d1f73f3d72f6d30f9f1f63a4b4a2d920cd71b830c844925b3770a2\""
Jan 30 13:16:12.968024 containerd[1541]: time="2025-01-30T13:16:12.967991566Z" level=info msg="CreateContainer within sandbox \"361d371d834ddcc9e4457c4389ec5948b0ff240f8cbe4175a470eccdfc14cff2\" for container &ContainerMetadata{Name:nginx,Attempt:0,}"
Jan 30 13:16:12.979223 containerd[1541]: time="2025-01-30T13:16:12.979178188Z" level=info msg="CreateContainer within sandbox \"361d371d834ddcc9e4457c4389ec5948b0ff240f8cbe4175a470eccdfc14cff2\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"700d457c3ffe08e86c4904c00b3f50a9f163269206d3e7230724e9b4c80bc17e\""
Jan 30 13:16:12.979644 containerd[1541]: time="2025-01-30T13:16:12.979617028Z" level=info msg="StartContainer for \"700d457c3ffe08e86c4904c00b3f50a9f163269206d3e7230724e9b4c80bc17e\""
Jan 30 13:16:13.021670 containerd[1541]: time="2025-01-30T13:16:13.021624021Z" level=info msg="StartContainer for \"700d457c3ffe08e86c4904c00b3f50a9f163269206d3e7230724e9b4c80bc17e\" returns successfully"
Jan 30 13:16:13.556421 kubelet[1845]: E0130 13:16:13.556355 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:13.717938 kubelet[1845]: I0130 13:16:13.717875 1845 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-85f456d6dd-m4429" podStartSLOduration=2.030814643 podStartE2EDuration="4.717861268s" podCreationTimestamp="2025-01-30 13:16:09 +0000 UTC" firstStartedPulling="2025-01-30 13:16:10.279557651 +0000 UTC m=+12.706188587" lastFinishedPulling="2025-01-30 13:16:12.966604276 +0000 UTC m=+15.393235212" observedRunningTime="2025-01-30 13:16:13.717748621 +0000 UTC m=+16.144379557" watchObservedRunningTime="2025-01-30 13:16:13.717861268 +0000 UTC m=+16.144492164"
Jan 30 13:16:14.556493 kubelet[1845]: E0130 13:16:14.556452 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:15.557459 kubelet[1845]: E0130 13:16:15.557409 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:16.558001 kubelet[1845]: E0130 13:16:16.557939 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:16.782626 kubelet[1845]: I0130 13:16:16.782391 1845 topology_manager.go:215] "Topology Admit Handler" podUID="a12353da-835f-4383-9078-8ecf207d6807" podNamespace="default" podName="nfs-server-provisioner-0"
Jan 30 13:16:16.850039 kubelet[1845]: I0130 13:16:16.849916 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/a12353da-835f-4383-9078-8ecf207d6807-data\") pod \"nfs-server-provisioner-0\" (UID: \"a12353da-835f-4383-9078-8ecf207d6807\") " pod="default/nfs-server-provisioner-0"
Jan 30 13:16:16.850039 kubelet[1845]: I0130 13:16:16.849966 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-j6s4v\" (UniqueName: \"kubernetes.io/projected/a12353da-835f-4383-9078-8ecf207d6807-kube-api-access-j6s4v\") pod \"nfs-server-provisioner-0\" (UID: \"a12353da-835f-4383-9078-8ecf207d6807\") " pod="default/nfs-server-provisioner-0"
Jan 30 13:16:17.085312 containerd[1541]: time="2025-01-30T13:16:17.085261304Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a12353da-835f-4383-9078-8ecf207d6807,Namespace:default,Attempt:0,}"
Jan 30 13:16:17.102771 kernel: cni0: port 2(veth25291369) entered blocking state
Jan 30 13:16:17.102877 kernel: cni0: port 2(veth25291369) entered disabled state
Jan 30 13:16:17.102907 kernel: veth25291369: entered allmulticast mode
Jan 30 13:16:17.103408 systemd-networkd[1229]: veth25291369: Link UP
Jan 30 13:16:17.104726 kernel: veth25291369: entered promiscuous mode
Jan 30 13:16:17.108514 kernel: cni0: port 2(veth25291369) entered blocking state
Jan 30 13:16:17.108578 kernel: cni0: port 2(veth25291369) entered forwarding state
Jan 30 13:16:17.108734 systemd-networkd[1229]: veth25291369: Gained carrier
Jan 30 13:16:17.110254 containerd[1541]: 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)(0x400001c938), "name":"cbr0", "type":"bridge"}
Jan 30 13:16:17.110254 containerd[1541]: delegateAdd: netconf sent to delegate plugin:
Jan 30 13:16:17.126448 containerd[1541]: {"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-01-30T13:16:17.126365573Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 30 13:16:17.126448 containerd[1541]: time="2025-01-30T13:16:17.126425086Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 30 13:16:17.126647 containerd[1541]: time="2025-01-30T13:16:17.126604504Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:17.126856 containerd[1541]: time="2025-01-30T13:16:17.126825528Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:17.160308 systemd-resolved[1436]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
Jan 30 13:16:17.182486 containerd[1541]: time="2025-01-30T13:16:17.182425364Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:a12353da-835f-4383-9078-8ecf207d6807,Namespace:default,Attempt:0,} returns sandbox id \"a358340619c6d4de2da6424daca8d7f07f848ad0725b42cb05f9de5799bd7e0d\""
Jan 30 13:16:17.184056 containerd[1541]: time="2025-01-30T13:16:17.183956228Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\""
Jan 30 13:16:17.558666 kubelet[1845]: E0130 13:16:17.558488 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:18.545910 kubelet[1845]: E0130 13:16:18.545861 1845 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:18.558681 kubelet[1845]: E0130 13:16:18.558647 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:18.595863 systemd-networkd[1229]: veth25291369: Gained IPv6LL
Jan 30 13:16:19.138808 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1988196467.mount: Deactivated successfully.
Jan 30 13:16:19.559567 kubelet[1845]: E0130 13:16:19.559434 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:20.452592 containerd[1541]: time="2025-01-30T13:16:20.452505874Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:20.453471 containerd[1541]: time="2025-01-30T13:16:20.453424665Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=87373625"
Jan 30 13:16:20.454211 containerd[1541]: time="2025-01-30T13:16:20.454173827Z" level=info msg="ImageCreate event name:\"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:20.457307 containerd[1541]: time="2025-01-30T13:16:20.457270939Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:20.458490 containerd[1541]: time="2025-01-30T13:16:20.458442436Z" 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.274447434s"
Jan 30 13:16:20.458490 containerd[1541]: time="2025-01-30T13:16:20.458487092Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:5a42a519e0a8cf95c3c5f18f767c58c8c8b072aaea0a26e5e47a6f206c7df685\""
Jan 30 13:16:20.461128 containerd[1541]: time="2025-01-30T13:16:20.461086150Z" level=info msg="CreateContainer within sandbox \"a358340619c6d4de2da6424daca8d7f07f848ad0725b42cb05f9de5799bd7e0d\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}"
Jan 30 13:16:20.471650 containerd[1541]: time="2025-01-30T13:16:20.471598157Z" level=info msg="CreateContainer within sandbox \"a358340619c6d4de2da6424daca8d7f07f848ad0725b42cb05f9de5799bd7e0d\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"786859d2c15df21d18247fbcdeee27c1740d8d6c26cda3611fd0f98160f96e52\""
Jan 30 13:16:20.472130 containerd[1541]: time="2025-01-30T13:16:20.472072385Z" level=info msg="StartContainer for \"786859d2c15df21d18247fbcdeee27c1740d8d6c26cda3611fd0f98160f96e52\""
Jan 30 13:16:20.514857 containerd[1541]: time="2025-01-30T13:16:20.514815765Z" level=info msg="StartContainer for \"786859d2c15df21d18247fbcdeee27c1740d8d6c26cda3611fd0f98160f96e52\" returns successfully"
Jan 30 13:16:20.560374 kubelet[1845]: E0130 13:16:20.560319 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:20.735815 kubelet[1845]: I0130 13:16:20.735682 1845 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=1.459968333 podStartE2EDuration="4.735667193s" podCreationTimestamp="2025-01-30 13:16:16 +0000 UTC" firstStartedPulling="2025-01-30 13:16:17.183559982 +0000 UTC m=+19.610190878" lastFinishedPulling="2025-01-30 13:16:20.459258802 +0000 UTC m=+22.885889738" observedRunningTime="2025-01-30 13:16:20.735572283 +0000 UTC m=+23.162203219" watchObservedRunningTime="2025-01-30 13:16:20.735667193 +0000 UTC m=+23.162298169"
Jan 30 13:16:21.561512 kubelet[1845]: E0130 13:16:21.561446 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:22.561637 kubelet[1845]: E0130 13:16:22.561588 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:23.561985 kubelet[1845]: E0130 13:16:23.561935 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:24.562232 kubelet[1845]: E0130 13:16:24.562175 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:25.563140 kubelet[1845]: E0130 13:16:25.563075 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:26.563491 kubelet[1845]: E0130 13:16:26.563437 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:27.563908 kubelet[1845]: E0130 13:16:27.563840 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:28.564247 kubelet[1845]: E0130 13:16:28.564174 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:29.564567 kubelet[1845]: E0130 13:16:29.564520 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:30.294695 kubelet[1845]: I0130 13:16:30.294647 1845 topology_manager.go:215] "Topology Admit Handler" podUID="239bb418-a400-4a2e-b392-c6af6c0cd313" podNamespace="default" podName="test-pod-1"
Jan 30 13:16:30.421965 kubelet[1845]: I0130 13:16:30.421893 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-cpl26\" (UniqueName: \"kubernetes.io/projected/239bb418-a400-4a2e-b392-c6af6c0cd313-kube-api-access-cpl26\") pod \"test-pod-1\" (UID: \"239bb418-a400-4a2e-b392-c6af6c0cd313\") " pod="default/test-pod-1"
Jan 30 13:16:30.421965 kubelet[1845]: I0130 13:16:30.421945 1845 reconciler_common.go:247] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-937b8e2a-0037-457e-883e-9342f6d63bc3\" (UniqueName: \"kubernetes.io/nfs/239bb418-a400-4a2e-b392-c6af6c0cd313-pvc-937b8e2a-0037-457e-883e-9342f6d63bc3\") pod \"test-pod-1\" (UID: \"239bb418-a400-4a2e-b392-c6af6c0cd313\") " pod="default/test-pod-1"
Jan 30 13:16:30.541349 kernel: FS-Cache: Loaded
Jan 30 13:16:30.564915 kubelet[1845]: E0130 13:16:30.564775 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:30.567437 kernel: RPC: Registered named UNIX socket transport module.
Jan 30 13:16:30.567504 kernel: RPC: Registered udp transport module.
Jan 30 13:16:30.567525 kernel: RPC: Registered tcp transport module.
Jan 30 13:16:30.567539 kernel: RPC: Registered tcp-with-tls transport module.
Jan 30 13:16:30.568744 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module.
Jan 30 13:16:30.746648 kernel: NFS: Registering the id_resolver key type
Jan 30 13:16:30.746902 kernel: Key type id_resolver registered
Jan 30 13:16:30.747424 kernel: Key type id_legacy registered
Jan 30 13:16:30.770146 nfsidmap[2868]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain'
Jan 30 13:16:30.773426 nfsidmap[2871]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain'
Jan 30 13:16:30.900522 containerd[1541]: time="2025-01-30T13:16:30.900471083Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:239bb418-a400-4a2e-b392-c6af6c0cd313,Namespace:default,Attempt:0,}"
Jan 30 13:16:30.917448 systemd-networkd[1229]: veth9f978828: Link UP
Jan 30 13:16:30.918589 kernel: cni0: port 3(veth9f978828) entered blocking state
Jan 30 13:16:30.918677 kernel: cni0: port 3(veth9f978828) entered disabled state
Jan 30 13:16:30.918729 kernel: veth9f978828: entered allmulticast mode
Jan 30 13:16:30.919851 kernel: veth9f978828: entered promiscuous mode
Jan 30 13:16:30.923915 kernel: cni0: port 3(veth9f978828) entered blocking state
Jan 30 13:16:30.924012 kernel: cni0: port 3(veth9f978828) entered forwarding state
Jan 30 13:16:30.924279 systemd-networkd[1229]: veth9f978828: Gained carrier
Jan 30 13:16:30.925819 containerd[1541]: 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"}
Jan 30 13:16:30.925819 containerd[1541]: delegateAdd: netconf sent to delegate plugin:
Jan 30 13:16:30.941886 containerd[1541]: {"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-01-30T13:16:30.941484068Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1
Jan 30 13:16:30.942025 containerd[1541]: time="2025-01-30T13:16:30.941899480Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1
Jan 30 13:16:30.942025 containerd[1541]: time="2025-01-30T13:16:30.941928000Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:30.942074 containerd[1541]: time="2025-01-30T13:16:30.942046724Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1
Jan 30 13:16:30.969799 systemd-resolved[1436]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address
Jan 30 13:16:30.987814 containerd[1541]: time="2025-01-30T13:16:30.987773484Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:239bb418-a400-4a2e-b392-c6af6c0cd313,Namespace:default,Attempt:0,} returns sandbox id \"f9d0bc92fcac67c05b09e08e6d22a4b084a23cd26e7dff4a210e2b0de8cbb056\""
Jan 30 13:16:30.989200 containerd[1541]: time="2025-01-30T13:16:30.989169645Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\""
Jan 30 13:16:31.229534 containerd[1541]: time="2025-01-30T13:16:31.229410440Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}"
Jan 30 13:16:31.230421 containerd[1541]: time="2025-01-30T13:16:31.230388986Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61"
Jan 30 13:16:31.233433 containerd[1541]: time="2025-01-30T13:16:31.233389109Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:24e054abc3d1f73f3d72f6d30f9f1f63a4b4a2d920cd71b830c844925b3770a2\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:2ffeb5a7ca68f2017f0bc48251750a6e40fcd3c341b94a22fc7812dcabbb84db\", size \"67680368\" in 244.184863ms"
Jan 30 13:16:31.233484 containerd[1541]: time="2025-01-30T13:16:31.233432190Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:24e054abc3d1f73f3d72f6d30f9f1f63a4b4a2d920cd71b830c844925b3770a2\""
Jan 30 13:16:31.242476 containerd[1541]: time="2025-01-30T13:16:31.242439236Z" level=info msg="CreateContainer within sandbox \"f9d0bc92fcac67c05b09e08e6d22a4b084a23cd26e7dff4a210e2b0de8cbb056\" for container &ContainerMetadata{Name:test,Attempt:0,}"
Jan 30 13:16:31.254677 containerd[1541]: time="2025-01-30T13:16:31.254554648Z" level=info msg="CreateContainer within sandbox \"f9d0bc92fcac67c05b09e08e6d22a4b084a23cd26e7dff4a210e2b0de8cbb056\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"b2153f1836451b439fef07b1caa78d336ff8f1ba15cde26be15c37a6420f1a18\""
Jan 30 13:16:31.255245 containerd[1541]: time="2025-01-30T13:16:31.255216466Z" level=info msg="StartContainer for \"b2153f1836451b439fef07b1caa78d336ff8f1ba15cde26be15c37a6420f1a18\""
Jan 30 13:16:31.307762 containerd[1541]: time="2025-01-30T13:16:31.307702983Z" level=info msg="StartContainer for \"b2153f1836451b439fef07b1caa78d336ff8f1ba15cde26be15c37a6420f1a18\" returns successfully"
Jan 30 13:16:31.565899 kubelet[1845]: E0130 13:16:31.565716 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:32.419626 systemd-networkd[1229]: veth9f978828: Gained IPv6LL
Jan 30 13:16:32.566067 kubelet[1845]: E0130 13:16:32.566018 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:33.566409 kubelet[1845]: E0130 13:16:33.566364 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"
Jan 30 13:16:34.566940 kubelet[1845]: E0130 13:16:34.566892 1845 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"