Aug 5 22:18:07.127518 kernel: Linux version 6.6.43-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT_DYNAMIC Mon Aug 5 20:36:27 -00 2024 Aug 5 22:18:07.127546 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 verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:18:07.127560 kernel: BIOS-provided physical RAM map: Aug 5 22:18:07.127568 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Aug 5 22:18:07.127576 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Aug 5 22:18:07.127585 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Aug 5 22:18:07.127594 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdcfff] usable Aug 5 22:18:07.127603 kernel: BIOS-e820: [mem 0x000000009cfdd000-0x000000009cffffff] reserved Aug 5 22:18:07.127612 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Aug 5 22:18:07.127623 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Aug 5 22:18:07.127631 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Aug 5 22:18:07.127640 kernel: NX (Execute Disable) protection: active Aug 5 22:18:07.127648 kernel: APIC: Static calls initialized Aug 5 22:18:07.127657 kernel: SMBIOS 2.8 present. Aug 5 22:18:07.127667 kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Aug 5 22:18:07.127679 kernel: Hypervisor detected: KVM Aug 5 22:18:07.127688 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Aug 5 22:18:07.127698 kernel: kvm-clock: using sched offset of 2501393315 cycles Aug 5 22:18:07.127708 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Aug 5 22:18:07.127717 kernel: tsc: Detected 2794.748 MHz processor Aug 5 22:18:07.127727 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Aug 5 22:18:07.127737 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Aug 5 22:18:07.127747 kernel: last_pfn = 0x9cfdd max_arch_pfn = 0x400000000 Aug 5 22:18:07.127756 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Aug 5 22:18:07.127769 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Aug 5 22:18:07.127779 kernel: Using GB pages for direct mapping Aug 5 22:18:07.127788 kernel: ACPI: Early table checksum verification disabled Aug 5 22:18:07.127798 kernel: ACPI: RSDP 0x00000000000F59C0 000014 (v00 BOCHS ) Aug 5 22:18:07.127808 kernel: ACPI: RSDT 0x000000009CFE1BDD 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127818 kernel: ACPI: FACP 0x000000009CFE1A79 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127828 kernel: ACPI: DSDT 0x000000009CFE0040 001A39 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127838 kernel: ACPI: FACS 0x000000009CFE0000 000040 Aug 5 22:18:07.127848 kernel: ACPI: APIC 0x000000009CFE1AED 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127861 kernel: ACPI: HPET 0x000000009CFE1B7D 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127871 kernel: ACPI: WAET 0x000000009CFE1BB5 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:18:07.127881 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe1a79-0x9cfe1aec] Aug 5 22:18:07.127891 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe1a78] Aug 5 22:18:07.127901 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Aug 5 22:18:07.127911 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe1aed-0x9cfe1b7c] Aug 5 22:18:07.127921 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe1b7d-0x9cfe1bb4] Aug 5 22:18:07.127938 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe1bb5-0x9cfe1bdc] Aug 5 22:18:07.127947 kernel: No NUMA configuration found Aug 5 22:18:07.127957 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdcfff] Aug 5 22:18:07.127967 kernel: NODE_DATA(0) allocated [mem 0x9cfd7000-0x9cfdcfff] Aug 5 22:18:07.127978 kernel: Zone ranges: Aug 5 22:18:07.127988 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Aug 5 22:18:07.127999 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdcfff] Aug 5 22:18:07.128012 kernel: Normal empty Aug 5 22:18:07.128022 kernel: Movable zone start for each node Aug 5 22:18:07.128042 kernel: Early memory node ranges Aug 5 22:18:07.128052 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Aug 5 22:18:07.128060 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdcfff] Aug 5 22:18:07.128067 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdcfff] Aug 5 22:18:07.128074 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Aug 5 22:18:07.128082 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Aug 5 22:18:07.128089 kernel: On node 0, zone DMA32: 12323 pages in unavailable ranges Aug 5 22:18:07.128100 kernel: ACPI: PM-Timer IO Port: 0x608 Aug 5 22:18:07.128107 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Aug 5 22:18:07.128128 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Aug 5 22:18:07.128135 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Aug 5 22:18:07.128143 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Aug 5 22:18:07.128150 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Aug 5 22:18:07.128157 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Aug 5 22:18:07.128165 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Aug 5 22:18:07.128173 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Aug 5 22:18:07.128185 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Aug 5 22:18:07.128194 kernel: TSC deadline timer available Aug 5 22:18:07.128203 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Aug 5 22:18:07.128212 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Aug 5 22:18:07.128221 kernel: kvm-guest: KVM setup pv remote TLB flush Aug 5 22:18:07.128230 kernel: kvm-guest: setup PV sched yield Aug 5 22:18:07.128239 kernel: [mem 0x9d000000-0xfeffbfff] available for PCI devices Aug 5 22:18:07.128247 kernel: Booting paravirtualized kernel on KVM Aug 5 22:18:07.128257 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Aug 5 22:18:07.128266 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Aug 5 22:18:07.128278 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288 Aug 5 22:18:07.128287 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152 Aug 5 22:18:07.128296 kernel: pcpu-alloc: [0] 0 1 2 3 Aug 5 22:18:07.128305 kernel: kvm-guest: PV spinlocks enabled Aug 5 22:18:07.128314 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Aug 5 22:18:07.128325 kernel: Kernel command line: rootflags=rw mount.usrflags=ro 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 verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:18:07.128335 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:18:07.128344 kernel: random: crng init done Aug 5 22:18:07.128356 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:18:07.128365 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:18:07.128374 kernel: Fallback order for Node 0: 0 Aug 5 22:18:07.128383 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632733 Aug 5 22:18:07.128392 kernel: Policy zone: DMA32 Aug 5 22:18:07.128399 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:18:07.128407 kernel: Memory: 2428452K/2571756K available (12288K kernel code, 2302K rwdata, 22640K rodata, 49328K init, 2016K bss, 143044K reserved, 0K cma-reserved) Aug 5 22:18:07.128414 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:18:07.128421 kernel: ftrace: allocating 37659 entries in 148 pages Aug 5 22:18:07.128431 kernel: ftrace: allocated 148 pages with 3 groups Aug 5 22:18:07.128438 kernel: Dynamic Preempt: voluntary Aug 5 22:18:07.128445 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:18:07.128453 kernel: rcu: RCU event tracing is enabled. Aug 5 22:18:07.128461 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:18:07.128468 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:18:07.128475 kernel: Rude variant of Tasks RCU enabled. Aug 5 22:18:07.128483 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:18:07.128490 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:18:07.128499 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:18:07.128507 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Aug 5 22:18:07.128514 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:18:07.128521 kernel: Console: colour VGA+ 80x25 Aug 5 22:18:07.128528 kernel: printk: console [ttyS0] enabled Aug 5 22:18:07.128535 kernel: ACPI: Core revision 20230628 Aug 5 22:18:07.128543 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Aug 5 22:18:07.128550 kernel: APIC: Switch to symmetric I/O mode setup Aug 5 22:18:07.128558 kernel: x2apic enabled Aug 5 22:18:07.128567 kernel: APIC: Switched APIC routing to: physical x2apic Aug 5 22:18:07.128575 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Aug 5 22:18:07.128582 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Aug 5 22:18:07.128589 kernel: kvm-guest: setup PV IPIs Aug 5 22:18:07.128596 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Aug 5 22:18:07.128604 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Aug 5 22:18:07.128611 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Aug 5 22:18:07.128619 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Aug 5 22:18:07.128639 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Aug 5 22:18:07.128649 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Aug 5 22:18:07.128660 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Aug 5 22:18:07.128671 kernel: Spectre V2 : Mitigation: Retpolines Aug 5 22:18:07.128686 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Aug 5 22:18:07.128698 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Aug 5 22:18:07.128710 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Aug 5 22:18:07.128721 kernel: RETBleed: Mitigation: untrained return thunk Aug 5 22:18:07.128733 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Aug 5 22:18:07.128748 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Aug 5 22:18:07.128759 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Aug 5 22:18:07.128772 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Aug 5 22:18:07.128784 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Aug 5 22:18:07.128795 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Aug 5 22:18:07.128806 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Aug 5 22:18:07.128816 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Aug 5 22:18:07.128827 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Aug 5 22:18:07.128841 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Aug 5 22:18:07.128851 kernel: Freeing SMP alternatives memory: 32K Aug 5 22:18:07.128861 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:18:07.128872 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:18:07.128882 kernel: SELinux: Initializing. Aug 5 22:18:07.128893 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:18:07.128903 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:18:07.128914 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Aug 5 22:18:07.128925 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:18:07.128939 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:18:07.128950 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:18:07.128961 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Aug 5 22:18:07.128973 kernel: ... version: 0 Aug 5 22:18:07.128984 kernel: ... bit width: 48 Aug 5 22:18:07.128995 kernel: ... generic registers: 6 Aug 5 22:18:07.129007 kernel: ... value mask: 0000ffffffffffff Aug 5 22:18:07.129017 kernel: ... max period: 00007fffffffffff Aug 5 22:18:07.129036 kernel: ... fixed-purpose events: 0 Aug 5 22:18:07.129051 kernel: ... event mask: 000000000000003f Aug 5 22:18:07.129062 kernel: signal: max sigframe size: 1776 Aug 5 22:18:07.129074 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:18:07.129086 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:18:07.129098 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:18:07.129109 kernel: smpboot: x86: Booting SMP configuration: Aug 5 22:18:07.129135 kernel: .... node #0, CPUs: #1 #2 #3 Aug 5 22:18:07.129146 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:18:07.129158 kernel: smpboot: Max logical packages: 1 Aug 5 22:18:07.129174 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Aug 5 22:18:07.129185 kernel: devtmpfs: initialized Aug 5 22:18:07.129196 kernel: x86/mm: Memory block size: 128MB Aug 5 22:18:07.129208 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:18:07.129220 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:18:07.129232 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:18:07.129242 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:18:07.129253 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:18:07.129263 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:18:07.129277 kernel: thermal_sys: Registered thermal governor 'user_space' Aug 5 22:18:07.129288 kernel: audit: type=2000 audit(1722896285.949:1): state=initialized audit_enabled=0 res=1 Aug 5 22:18:07.129299 kernel: cpuidle: using governor menu Aug 5 22:18:07.129310 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:18:07.129321 kernel: dca service started, version 1.12.1 Aug 5 22:18:07.129333 kernel: PCI: Using configuration type 1 for base access Aug 5 22:18:07.129345 kernel: PCI: Using configuration type 1 for extended access Aug 5 22:18:07.129357 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Aug 5 22:18:07.129368 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:18:07.129384 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:18:07.129396 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:18:07.129407 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:18:07.129419 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:18:07.129431 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:18:07.129443 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:18:07.129455 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:18:07.129467 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:18:07.129479 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Aug 5 22:18:07.129495 kernel: ACPI: Interpreter enabled Aug 5 22:18:07.129507 kernel: ACPI: PM: (supports S0 S3 S5) Aug 5 22:18:07.129518 kernel: ACPI: Using IOAPIC for interrupt routing Aug 5 22:18:07.129530 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Aug 5 22:18:07.129542 kernel: PCI: Using E820 reservations for host bridge windows Aug 5 22:18:07.129554 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Aug 5 22:18:07.129567 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:18:07.129827 kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:18:07.129852 kernel: acpiphp: Slot [3] registered Aug 5 22:18:07.129864 kernel: acpiphp: Slot [4] registered Aug 5 22:18:07.129876 kernel: acpiphp: Slot [5] registered Aug 5 22:18:07.129888 kernel: acpiphp: Slot [6] registered Aug 5 22:18:07.129900 kernel: acpiphp: Slot [7] registered Aug 5 22:18:07.129911 kernel: acpiphp: Slot [8] registered Aug 5 22:18:07.129923 kernel: acpiphp: Slot [9] registered Aug 5 22:18:07.129935 kernel: acpiphp: Slot [10] registered Aug 5 22:18:07.129947 kernel: acpiphp: Slot [11] registered Aug 5 22:18:07.129958 kernel: acpiphp: Slot [12] registered Aug 5 22:18:07.129974 kernel: acpiphp: Slot [13] registered Aug 5 22:18:07.129986 kernel: acpiphp: Slot [14] registered Aug 5 22:18:07.129997 kernel: acpiphp: Slot [15] registered Aug 5 22:18:07.130007 kernel: acpiphp: Slot [16] registered Aug 5 22:18:07.130017 kernel: acpiphp: Slot [17] registered Aug 5 22:18:07.130038 kernel: acpiphp: Slot [18] registered Aug 5 22:18:07.130049 kernel: acpiphp: Slot [19] registered Aug 5 22:18:07.130059 kernel: acpiphp: Slot [20] registered Aug 5 22:18:07.130069 kernel: acpiphp: Slot [21] registered Aug 5 22:18:07.130083 kernel: acpiphp: Slot [22] registered Aug 5 22:18:07.130094 kernel: acpiphp: Slot [23] registered Aug 5 22:18:07.130104 kernel: acpiphp: Slot [24] registered Aug 5 22:18:07.130128 kernel: acpiphp: Slot [25] registered Aug 5 22:18:07.130139 kernel: acpiphp: Slot [26] registered Aug 5 22:18:07.130149 kernel: acpiphp: Slot [27] registered Aug 5 22:18:07.130160 kernel: acpiphp: Slot [28] registered Aug 5 22:18:07.130171 kernel: acpiphp: Slot [29] registered Aug 5 22:18:07.130183 kernel: acpiphp: Slot [30] registered Aug 5 22:18:07.130195 kernel: acpiphp: Slot [31] registered Aug 5 22:18:07.130211 kernel: PCI host bridge to bus 0000:00 Aug 5 22:18:07.130404 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Aug 5 22:18:07.130569 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Aug 5 22:18:07.130733 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Aug 5 22:18:07.130878 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xfebfffff window] Aug 5 22:18:07.131024 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] Aug 5 22:18:07.131220 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:18:07.131452 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Aug 5 22:18:07.131641 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Aug 5 22:18:07.131830 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Aug 5 22:18:07.132007 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc0c0-0xc0cf] Aug 5 22:18:07.132190 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Aug 5 22:18:07.132407 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Aug 5 22:18:07.132591 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Aug 5 22:18:07.132760 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Aug 5 22:18:07.132949 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Aug 5 22:18:07.133153 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Aug 5 22:18:07.133337 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Aug 5 22:18:07.133529 kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 Aug 5 22:18:07.133708 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Aug 5 22:18:07.133895 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Aug 5 22:18:07.134104 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Aug 5 22:18:07.134329 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Aug 5 22:18:07.134521 kernel: pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:18:07.134697 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f] Aug 5 22:18:07.134871 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Aug 5 22:18:07.135069 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Aug 5 22:18:07.135291 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Aug 5 22:18:07.135494 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Aug 5 22:18:07.135679 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Aug 5 22:18:07.135860 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Aug 5 22:18:07.136060 kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 Aug 5 22:18:07.136408 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf] Aug 5 22:18:07.136596 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Aug 5 22:18:07.136762 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Aug 5 22:18:07.136923 kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Aug 5 22:18:07.136940 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Aug 5 22:18:07.136951 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Aug 5 22:18:07.136962 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Aug 5 22:18:07.136974 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Aug 5 22:18:07.136985 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Aug 5 22:18:07.136997 kernel: iommu: Default domain type: Translated Aug 5 22:18:07.137013 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Aug 5 22:18:07.137024 kernel: PCI: Using ACPI for IRQ routing Aug 5 22:18:07.137045 kernel: PCI: pci_cache_line_size set to 64 bytes Aug 5 22:18:07.137056 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Aug 5 22:18:07.137067 kernel: e820: reserve RAM buffer [mem 0x9cfdd000-0x9fffffff] Aug 5 22:18:07.137246 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Aug 5 22:18:07.137411 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Aug 5 22:18:07.137568 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Aug 5 22:18:07.137589 kernel: vgaarb: loaded Aug 5 22:18:07.137600 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Aug 5 22:18:07.137611 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Aug 5 22:18:07.137622 kernel: clocksource: Switched to clocksource kvm-clock Aug 5 22:18:07.137633 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:18:07.137644 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:18:07.137655 kernel: pnp: PnP ACPI init Aug 5 22:18:07.137833 kernel: pnp 00:02: [dma 2] Aug 5 22:18:07.137855 kernel: pnp: PnP ACPI: found 6 devices Aug 5 22:18:07.137867 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Aug 5 22:18:07.137879 kernel: NET: Registered PF_INET protocol family Aug 5 22:18:07.137890 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:18:07.137902 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:18:07.137914 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:18:07.137926 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:18:07.137937 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:18:07.137949 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:18:07.137964 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:18:07.137975 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:18:07.137986 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:18:07.137998 kernel: NET: Registered PF_XDP protocol family Aug 5 22:18:07.138171 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Aug 5 22:18:07.138325 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Aug 5 22:18:07.138468 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Aug 5 22:18:07.138623 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xfebfffff window] Aug 5 22:18:07.138774 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] Aug 5 22:18:07.138956 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Aug 5 22:18:07.139206 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Aug 5 22:18:07.139230 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:18:07.139245 kernel: Initialise system trusted keyrings Aug 5 22:18:07.139260 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:18:07.139274 kernel: Key type asymmetric registered Aug 5 22:18:07.139289 kernel: Asymmetric key parser 'x509' registered Aug 5 22:18:07.139303 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Aug 5 22:18:07.139324 kernel: io scheduler mq-deadline registered Aug 5 22:18:07.139339 kernel: io scheduler kyber registered Aug 5 22:18:07.139354 kernel: io scheduler bfq registered Aug 5 22:18:07.139368 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Aug 5 22:18:07.139383 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Aug 5 22:18:07.139397 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Aug 5 22:18:07.139410 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Aug 5 22:18:07.139420 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:18:07.139432 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Aug 5 22:18:07.139447 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Aug 5 22:18:07.139458 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Aug 5 22:18:07.139469 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Aug 5 22:18:07.139650 kernel: rtc_cmos 00:05: RTC can wake from S4 Aug 5 22:18:07.139838 kernel: rtc_cmos 00:05: registered as rtc0 Aug 5 22:18:07.140011 kernel: rtc_cmos 00:05: setting system clock to 2024-08-05T22:18:06 UTC (1722896286) Aug 5 22:18:07.140212 kernel: rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Aug 5 22:18:07.140231 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Aug 5 22:18:07.140250 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Aug 5 22:18:07.140263 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:18:07.140274 kernel: Segment Routing with IPv6 Aug 5 22:18:07.140284 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:18:07.140295 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:18:07.140306 kernel: Key type dns_resolver registered Aug 5 22:18:07.140316 kernel: IPI shorthand broadcast: enabled Aug 5 22:18:07.140327 kernel: sched_clock: Marking stable (1111002824, 122785469)->(1397008470, -163220177) Aug 5 22:18:07.140338 kernel: registered taskstats version 1 Aug 5 22:18:07.140354 kernel: Loading compiled-in X.509 certificates Aug 5 22:18:07.140367 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: e31e857530e65c19b206dbf3ab8297cc37ac5d55' Aug 5 22:18:07.140379 kernel: Key type .fscrypt registered Aug 5 22:18:07.140391 kernel: Key type fscrypt-provisioning registered Aug 5 22:18:07.140402 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:18:07.140413 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:18:07.140425 kernel: ima: No architecture policies found Aug 5 22:18:07.140436 kernel: clk: Disabling unused clocks Aug 5 22:18:07.140447 kernel: Freeing unused kernel image (initmem) memory: 49328K Aug 5 22:18:07.140462 kernel: Write protecting the kernel read-only data: 36864k Aug 5 22:18:07.140473 kernel: Freeing unused kernel image (rodata/data gap) memory: 1936K Aug 5 22:18:07.140484 kernel: Run /init as init process Aug 5 22:18:07.140495 kernel: with arguments: Aug 5 22:18:07.140505 kernel: /init Aug 5 22:18:07.140516 kernel: with environment: Aug 5 22:18:07.140527 kernel: HOME=/ Aug 5 22:18:07.140559 kernel: TERM=linux Aug 5 22:18:07.140573 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:18:07.140592 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) Aug 5 22:18:07.140607 systemd[1]: Detected virtualization kvm. Aug 5 22:18:07.140620 systemd[1]: Detected architecture x86-64. Aug 5 22:18:07.140632 systemd[1]: Running in initrd. Aug 5 22:18:07.140645 systemd[1]: No hostname configured, using default hostname. Aug 5 22:18:07.140657 systemd[1]: Hostname set to . Aug 5 22:18:07.140674 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:18:07.140686 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:18:07.140700 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:18:07.140712 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:18:07.140726 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:18:07.140739 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:18:07.140752 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:18:07.140765 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:18:07.140784 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 5 22:18:07.140798 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:18:07.140811 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:18:07.140823 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:18:07.140836 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:18:07.140849 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:18:07.140863 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:18:07.140876 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:18:07.140894 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:18:07.140908 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:18:07.140921 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:18:07.140934 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:18:07.140947 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:18:07.140960 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:18:07.140973 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:18:07.140987 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:18:07.141004 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:18:07.141018 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:18:07.141040 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:18:07.141052 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:18:07.141064 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:18:07.141080 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:18:07.141138 systemd-journald[192]: Collecting audit messages is disabled. Aug 5 22:18:07.141170 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:18:07.141183 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:18:07.141200 systemd-journald[192]: Journal started Aug 5 22:18:07.141224 systemd-journald[192]: Runtime Journal (/run/log/journal/689a85d40dd049938bb81cf353f7bd83) is 6.0M, max 48.4M, 42.3M free. Aug 5 22:18:07.146280 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:18:07.147529 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:18:07.169555 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:18:07.220308 systemd-modules-load[193]: Inserted module 'overlay' Aug 5 22:18:07.222423 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:18:07.271304 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:18:07.278565 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 5 22:18:07.273582 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:18:07.283470 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:18:07.287951 kernel: Bridge firewalling registered Aug 5 22:18:07.287832 systemd-modules-load[193]: Inserted module 'br_netfilter' Aug 5 22:18:07.297034 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:18:07.301453 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:18:07.301962 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:18:07.304613 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:18:07.317733 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:18:07.320824 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:18:07.324003 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:18:07.326002 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:18:07.336314 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:18:07.339750 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:18:07.357372 dracut-cmdline[226]: dracut-dracut-053 Aug 5 22:18:07.363333 dracut-cmdline[226]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro 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 verity.usrhash=4a86c72568bc3f74d57effa5e252d5620941ef6d74241fc198859d020a6392c5 Aug 5 22:18:07.380776 systemd-resolved[229]: Positive Trust Anchors: Aug 5 22:18:07.380810 systemd-resolved[229]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:18:07.380855 systemd-resolved[229]: 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 corp home internal intranet lan local private test Aug 5 22:18:07.384524 systemd-resolved[229]: Defaulting to hostname 'linux'. Aug 5 22:18:07.386003 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:18:07.394853 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:18:07.512176 kernel: SCSI subsystem initialized Aug 5 22:18:07.528160 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:18:07.550157 kernel: iscsi: registered transport (tcp) Aug 5 22:18:07.597605 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:18:07.597737 kernel: QLogic iSCSI HBA Driver Aug 5 22:18:07.682538 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:18:07.691748 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:18:07.724191 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:18:07.724272 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:18:07.724289 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:18:07.788178 kernel: raid6: avx2x4 gen() 24424 MB/s Aug 5 22:18:07.805165 kernel: raid6: avx2x2 gen() 24240 MB/s Aug 5 22:18:07.822375 kernel: raid6: avx2x1 gen() 20595 MB/s Aug 5 22:18:07.822450 kernel: raid6: using algorithm avx2x4 gen() 24424 MB/s Aug 5 22:18:07.840412 kernel: raid6: .... xor() 5650 MB/s, rmw enabled Aug 5 22:18:07.840518 kernel: raid6: using avx2x2 recovery algorithm Aug 5 22:18:07.871270 kernel: xor: automatically using best checksumming function avx Aug 5 22:18:08.130167 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:18:08.150595 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:18:08.163509 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:18:08.181902 systemd-udevd[413]: Using default interface naming scheme 'v255'. Aug 5 22:18:08.189472 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:18:08.196361 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:18:08.225893 dracut-pre-trigger[416]: rd.md=0: removing MD RAID activation Aug 5 22:18:08.270325 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:18:08.278848 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:18:08.351313 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:18:08.360463 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:18:08.374153 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:18:08.378581 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:18:08.380257 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:18:08.385041 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:18:08.392324 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:18:08.398131 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Aug 5 22:18:08.409048 kernel: virtio_blk virtio1: [vda] 19775488 512-byte logical blocks (10.1 GB/9.43 GiB) Aug 5 22:18:08.409352 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 5 22:18:08.409370 kernel: GPT:9289727 != 19775487 Aug 5 22:18:08.409385 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 5 22:18:08.409400 kernel: GPT:9289727 != 19775487 Aug 5 22:18:08.409414 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 5 22:18:08.409428 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:18:08.413828 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:18:08.428141 kernel: cryptd: max_cpu_qlen set to 1000 Aug 5 22:18:08.431332 kernel: libata version 3.00 loaded. Aug 5 22:18:08.435133 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:18:08.440241 kernel: ata_piix 0000:00:01.1: version 2.13 Aug 5 22:18:08.453683 kernel: scsi host0: ata_piix Aug 5 22:18:08.453903 kernel: scsi host1: ata_piix Aug 5 22:18:08.454107 kernel: AVX2 version of gcm_enc/dec engaged. Aug 5 22:18:08.454138 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14 Aug 5 22:18:08.454154 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15 Aug 5 22:18:08.454168 kernel: AES CTR mode by8 optimization enabled Aug 5 22:18:08.435312 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:18:08.441771 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:18:08.443279 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:18:08.443495 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:18:08.475443 kernel: BTRFS: device fsid d3844c60-0a2c-449a-9ee9-2a875f8d8e12 devid 1 transid 36 /dev/vda3 scanned by (udev-worker) (459) Aug 5 22:18:08.475474 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (460) Aug 5 22:18:08.444969 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:18:08.458481 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:18:08.499165 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:18:08.522895 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:18:08.527316 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:18:08.540094 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 5 22:18:08.540328 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:18:08.550763 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:18:08.566447 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:18:08.569504 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:18:08.582727 disk-uuid[543]: Primary Header is updated. Aug 5 22:18:08.582727 disk-uuid[543]: Secondary Entries is updated. Aug 5 22:18:08.582727 disk-uuid[543]: Secondary Header is updated. Aug 5 22:18:08.588146 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:18:08.593157 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:18:08.596577 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:18:08.610335 kernel: ata2: found unknown device (class 0) Aug 5 22:18:08.612250 kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Aug 5 22:18:08.614178 kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Aug 5 22:18:08.685127 kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Aug 5 22:18:08.708026 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Aug 5 22:18:08.708049 kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Aug 5 22:18:09.614884 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:18:09.621436 disk-uuid[547]: The operation has completed successfully. Aug 5 22:18:09.727242 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:18:09.730666 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:18:09.760295 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:18:09.772283 sh[581]: Success Aug 5 22:18:09.838028 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Aug 5 22:18:09.919055 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:18:09.925795 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:18:09.932566 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:18:09.951265 kernel: BTRFS info (device dm-0): first mount of filesystem d3844c60-0a2c-449a-9ee9-2a875f8d8e12 Aug 5 22:18:09.951351 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:18:09.951368 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:18:09.953765 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:18:09.953823 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:18:09.983683 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:18:09.988427 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:18:10.006588 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:18:10.010554 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:18:10.036263 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:18:10.036330 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:18:10.036348 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:18:10.070159 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:18:10.089001 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:18:10.090914 kernel: BTRFS info (device vda6): last unmount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:18:10.117771 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:18:10.128451 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:18:10.240413 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:18:10.257003 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:18:10.258985 ignition[701]: Ignition 2.18.0 Aug 5 22:18:10.259895 ignition[701]: Stage: fetch-offline Aug 5 22:18:10.260189 ignition[701]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:10.260353 ignition[701]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:10.261192 ignition[701]: parsed url from cmdline: "" Aug 5 22:18:10.261197 ignition[701]: no config URL provided Aug 5 22:18:10.261205 ignition[701]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:18:10.261216 ignition[701]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:18:10.261250 ignition[701]: op(1): [started] loading QEMU firmware config module Aug 5 22:18:10.261256 ignition[701]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:18:10.307634 ignition[701]: op(1): [finished] loading QEMU firmware config module Aug 5 22:18:10.308150 ignition[701]: parsing config with SHA512: 7e82b6819663e84e0d7d7c0dae2f03c772d2a8b00ad686482d1619123a7e21b961152edddc82e236cb79af6e8bf8027e020754348479ce01476051c716bb0d37 Aug 5 22:18:10.319547 systemd-networkd[767]: lo: Link UP Aug 5 22:18:10.320528 unknown[701]: fetched base config from "system" Aug 5 22:18:10.321005 ignition[701]: fetch-offline: fetch-offline passed Aug 5 22:18:10.320539 unknown[701]: fetched user config from "qemu" Aug 5 22:18:10.321090 ignition[701]: Ignition finished successfully Aug 5 22:18:10.322155 systemd-networkd[767]: lo: Gained carrier Aug 5 22:18:10.324046 systemd-networkd[767]: Enumeration completed Aug 5 22:18:10.324950 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:18:10.328629 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:18:10.328634 systemd-networkd[767]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:18:10.338543 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:18:10.344613 systemd[1]: Reached target network.target - Network. Aug 5 22:18:10.345187 systemd-networkd[767]: eth0: Link UP Aug 5 22:18:10.345192 systemd-networkd[767]: eth0: Gained carrier Aug 5 22:18:10.345206 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:18:10.346792 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:18:10.378073 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:18:10.388750 systemd-networkd[767]: eth0: DHCPv4 address 10.0.0.148/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:18:10.435781 ignition[772]: Ignition 2.18.0 Aug 5 22:18:10.435842 ignition[772]: Stage: kargs Aug 5 22:18:10.437508 ignition[772]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:10.446942 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:18:10.437531 ignition[772]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:10.438512 ignition[772]: kargs: kargs passed Aug 5 22:18:10.438571 ignition[772]: Ignition finished successfully Aug 5 22:18:10.467357 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:18:10.493474 ignition[782]: Ignition 2.18.0 Aug 5 22:18:10.493485 ignition[782]: Stage: disks Aug 5 22:18:10.493767 ignition[782]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:10.493781 ignition[782]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:10.499153 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:18:10.494896 ignition[782]: disks: disks passed Aug 5 22:18:10.499760 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:18:10.494970 ignition[782]: Ignition finished successfully Aug 5 22:18:10.536208 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:18:10.551222 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:18:10.556436 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:18:10.559861 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:18:10.576648 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:18:10.607153 systemd-fsck[792]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 22:18:10.622096 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:18:10.651980 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:18:10.942227 kernel: EXT4-fs (vda9): mounted filesystem e865ac73-053b-4efa-9a0f-50dec3f650d9 r/w with ordered data mode. Quota mode: none. Aug 5 22:18:10.942286 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:18:10.946597 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:18:10.980735 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:18:10.995052 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:18:10.997172 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:18:11.010494 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (801) Aug 5 22:18:11.010529 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:18:11.010547 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:18:11.010564 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:18:10.997240 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 22:18:10.997273 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:18:11.023395 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:18:11.023288 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:18:11.033573 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:18:11.058504 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:18:11.804644 initrd-setup-root[825]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:18:11.814985 initrd-setup-root[832]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:18:11.823224 initrd-setup-root[839]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:18:11.836592 initrd-setup-root[846]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:18:12.019020 systemd-networkd[767]: eth0: Gained IPv6LL Aug 5 22:18:12.096756 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:18:12.112409 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:18:12.116554 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:18:12.129095 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:18:12.133215 kernel: BTRFS info (device vda6): last unmount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:18:12.226793 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:18:12.235412 ignition[914]: INFO : Ignition 2.18.0 Aug 5 22:18:12.235412 ignition[914]: INFO : Stage: mount Aug 5 22:18:12.244369 ignition[914]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:12.244369 ignition[914]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:12.244369 ignition[914]: INFO : mount: mount passed Aug 5 22:18:12.244369 ignition[914]: INFO : Ignition finished successfully Aug 5 22:18:12.258500 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:18:12.280321 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:18:12.307824 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:18:12.335959 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (928) Aug 5 22:18:12.353352 kernel: BTRFS info (device vda6): first mount of filesystem b6695624-d538-4f05-9ddd-23ee987404c1 Aug 5 22:18:12.353446 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Aug 5 22:18:12.353465 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:18:12.366971 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:18:12.369766 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:18:12.439697 ignition[946]: INFO : Ignition 2.18.0 Aug 5 22:18:12.439697 ignition[946]: INFO : Stage: files Aug 5 22:18:12.444732 ignition[946]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:12.444732 ignition[946]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:12.444732 ignition[946]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:18:12.450346 ignition[946]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:18:12.450346 ignition[946]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:18:12.463143 ignition[946]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:18:12.468012 ignition[946]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:18:12.477744 unknown[946]: wrote ssh authorized keys file for user: core Aug 5 22:18:12.479752 ignition[946]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:18:12.485971 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar-cgroupv1" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/home/core/install.sh" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/home/core/install.sh" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.28.7-x86-64.raw" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.28.7-x86-64.raw" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.28.7-x86-64.raw" Aug 5 22:18:12.491343 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET https://github.com/flatcar/sysext-bakery/releases/download/latest/kubernetes-v1.28.7-x86-64.raw: attempt #1 Aug 5 22:18:12.904854 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(7): GET result: OK Aug 5 22:18:13.916388 ignition[946]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.28.7-x86-64.raw" Aug 5 22:18:13.916388 ignition[946]: INFO : files: op(8): [started] processing unit "containerd.service" Aug 5 22:18:13.957975 ignition[946]: INFO : files: op(8): op(9): [started] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 5 22:18:13.967434 ignition[946]: INFO : files: op(8): op(9): [finished] writing systemd drop-in "10-use-cgroupfs.conf" at "/sysroot/etc/systemd/system/containerd.service.d/10-use-cgroupfs.conf" Aug 5 22:18:13.977274 ignition[946]: INFO : files: op(8): [finished] processing unit "containerd.service" Aug 5 22:18:13.977274 ignition[946]: INFO : files: op(a): [started] processing unit "coreos-metadata.service" Aug 5 22:18:13.977274 ignition[946]: INFO : files: op(a): op(b): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:18:14.005431 ignition[946]: INFO : files: op(a): op(b): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:18:14.005431 ignition[946]: INFO : files: op(a): [finished] processing unit "coreos-metadata.service" Aug 5 22:18:14.005431 ignition[946]: INFO : files: op(c): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:18:14.199482 ignition[946]: INFO : files: op(c): op(d): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:18:14.215993 ignition[946]: INFO : files: op(c): op(d): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:18:14.215993 ignition[946]: INFO : files: op(c): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:18:14.215993 ignition[946]: INFO : files: createResultFile: createFiles: op(e): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:18:14.215993 ignition[946]: INFO : files: createResultFile: createFiles: op(e): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:18:14.215993 ignition[946]: INFO : files: files passed Aug 5 22:18:14.215993 ignition[946]: INFO : Ignition finished successfully Aug 5 22:18:14.241392 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:18:14.323311 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:18:14.368991 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:18:14.384541 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:18:14.384699 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:18:14.410196 initrd-setup-root-after-ignition[974]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:18:14.416998 initrd-setup-root-after-ignition[976]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:18:14.416998 initrd-setup-root-after-ignition[976]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:18:14.435039 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:18:14.421143 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:18:14.463397 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:18:14.489660 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:18:14.661374 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:18:14.661562 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:18:14.669556 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:18:14.676332 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:18:14.698512 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:18:14.733106 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:18:14.790546 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:18:14.814178 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:18:14.853997 systemd[1]: Stopped target network.target - Network. Aug 5 22:18:14.862048 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:18:14.880582 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:18:14.884977 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:18:14.893726 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:18:14.893940 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:18:14.907686 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:18:14.917308 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:18:14.924014 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:18:14.927859 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:18:14.933441 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:18:14.939520 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:18:14.943047 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:18:14.952370 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:18:14.956652 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:18:14.958219 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:18:14.962162 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:18:14.962347 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:18:14.967138 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:18:14.975184 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:18:14.979730 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:18:14.979933 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:18:14.988896 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:18:14.989132 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:18:15.033420 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:18:15.033611 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:18:15.053189 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:18:15.081371 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:18:15.089366 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:18:15.120727 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:18:15.124999 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:18:15.140562 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:18:15.143069 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:18:15.171779 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:18:15.171933 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:18:15.173920 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:18:15.174092 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:18:15.180040 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:18:15.180240 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:18:15.209177 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:18:15.234628 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:18:15.237221 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:18:15.249363 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:18:15.252831 systemd-networkd[767]: eth0: DHCPv6 lease lost Aug 5 22:18:15.252895 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:18:15.253149 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:18:15.260459 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:18:15.291231 ignition[1000]: INFO : Ignition 2.18.0 Aug 5 22:18:15.291231 ignition[1000]: INFO : Stage: umount Aug 5 22:18:15.291231 ignition[1000]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:18:15.291231 ignition[1000]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:18:15.291231 ignition[1000]: INFO : umount: umount passed Aug 5 22:18:15.291231 ignition[1000]: INFO : Ignition finished successfully Aug 5 22:18:15.260678 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:18:15.281328 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:18:15.282665 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:18:15.282825 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:18:15.289628 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:18:15.289826 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:18:15.315169 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:18:15.315356 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:18:15.335435 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:18:15.335582 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:18:15.343479 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:18:15.343642 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:18:15.380607 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:18:15.386710 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:18:15.418946 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:18:15.419441 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:18:15.431525 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:18:15.432365 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:18:15.439743 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:18:15.439855 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:18:15.464569 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:18:15.466710 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:18:15.486061 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:18:15.486188 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:18:15.526667 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:18:15.538939 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:18:15.539062 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:18:15.540853 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:18:15.540935 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:18:15.550515 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:18:15.550631 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:18:15.566180 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:18:15.566273 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:18:15.569645 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:18:15.593667 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:18:15.593880 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:18:15.611992 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:18:15.612843 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:18:15.626501 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:18:15.626627 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:18:15.628482 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:18:15.628531 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:18:15.632151 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:18:15.632229 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:18:15.647539 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:18:15.647632 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:18:15.656885 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:18:15.657154 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:18:15.680702 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:18:15.682405 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:18:15.682503 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:18:15.690045 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 5 22:18:15.690158 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:18:15.691774 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:18:15.691851 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:18:15.700841 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:18:15.700946 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:18:15.709019 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:18:15.709187 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:18:15.717220 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:18:15.726485 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:18:15.740828 systemd[1]: Switching root. Aug 5 22:18:15.783240 systemd-journald[192]: Journal stopped Aug 5 22:18:17.869391 systemd-journald[192]: Received SIGTERM from PID 1 (systemd). Aug 5 22:18:17.869472 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:18:17.869491 kernel: SELinux: policy capability open_perms=1 Aug 5 22:18:17.869515 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:18:17.869531 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:18:17.869546 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:18:17.869561 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:18:17.869590 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:18:17.869611 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:18:17.869626 kernel: audit: type=1403 audit(1722896296.523:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:18:17.869649 systemd[1]: Successfully loaded SELinux policy in 63.624ms. Aug 5 22:18:17.869671 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 19.370ms. Aug 5 22:18:17.869692 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) Aug 5 22:18:17.869709 systemd[1]: Detected virtualization kvm. Aug 5 22:18:17.869736 systemd[1]: Detected architecture x86-64. Aug 5 22:18:17.869764 systemd[1]: Detected first boot. Aug 5 22:18:17.869780 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:18:17.869796 zram_generator::config[1060]: No configuration found. Aug 5 22:18:17.869814 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:18:17.869830 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:18:17.869850 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 22:18:17.869868 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:18:17.869884 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:18:17.869900 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:18:17.869916 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:18:17.869938 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:18:17.869954 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:18:17.869970 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:18:17.869992 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:18:17.870011 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:18:17.870027 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:18:17.870043 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:18:17.870059 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:18:17.870078 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:18:17.870094 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:18:17.870110 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 5 22:18:17.870145 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:18:17.870161 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:18:17.870180 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:18:17.870201 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:18:17.870216 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:18:17.870232 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:18:17.870248 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:18:17.870263 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:18:17.870279 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:18:17.870294 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:18:17.870314 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:18:17.870329 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:18:17.870344 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:18:17.870359 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:18:17.870375 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:18:17.870391 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:18:17.870406 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:18:17.870422 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:17.870440 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:18:17.870458 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:18:17.870475 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:18:17.870491 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:18:17.870507 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:18:17.870523 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:18:17.870539 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:18:17.870555 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:18:17.870577 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:18:17.870595 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:18:17.870610 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:18:17.870626 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:18:17.870641 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:18:17.870657 systemd[1]: systemd-journald.service: unit configures an IP firewall, but the local system does not support BPF/cgroup firewalling. Aug 5 22:18:17.870672 systemd[1]: systemd-journald.service: (This warning is only shown for the first unit using IP firewalling.) Aug 5 22:18:17.870688 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:18:17.870703 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:18:17.870721 kernel: fuse: init (API version 7.39) Aug 5 22:18:17.870832 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:18:17.870848 kernel: loop: module loaded Aug 5 22:18:17.870864 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:18:17.870884 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:18:17.870901 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:17.870940 systemd-journald[1144]: Collecting audit messages is disabled. Aug 5 22:18:17.870969 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:18:17.870988 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:18:17.871003 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:18:17.871018 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:18:17.871032 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:18:17.871048 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:18:17.871063 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:18:17.871079 systemd-journald[1144]: Journal started Aug 5 22:18:17.871140 systemd-journald[1144]: Runtime Journal (/run/log/journal/689a85d40dd049938bb81cf353f7bd83) is 6.0M, max 48.4M, 42.3M free. Aug 5 22:18:17.876324 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:18:17.878869 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:18:17.879578 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:18:17.882588 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:18:17.883044 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:18:17.885347 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:18:17.885601 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:18:17.887748 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:18:17.888061 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:18:17.889643 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:18:17.889922 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:18:17.891763 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:18:17.894464 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:18:17.896470 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:18:17.909315 kernel: ACPI: bus type drm_connector registered Aug 5 22:18:17.912221 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:18:17.912558 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:18:17.919435 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:18:17.931576 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:18:17.936329 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:18:17.938145 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:18:17.986468 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:18:17.990224 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:18:17.991812 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:18:17.997629 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:18:17.999653 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:18:18.010367 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:18:18.015273 systemd-journald[1144]: Time spent on flushing to /var/log/journal/689a85d40dd049938bb81cf353f7bd83 is 27.992ms for 918 entries. Aug 5 22:18:18.015273 systemd-journald[1144]: System Journal (/var/log/journal/689a85d40dd049938bb81cf353f7bd83) is 8.0M, max 195.6M, 187.6M free. Aug 5 22:18:18.477100 systemd-journald[1144]: Received client request to flush runtime journal. Aug 5 22:18:18.018744 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:18:18.036015 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:18:18.038023 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:18:18.039551 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:18:18.062798 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:18:18.088244 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:18:18.113431 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:18:18.127664 udevadm[1205]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 5 22:18:18.172933 systemd-tmpfiles[1194]: ACLs are not supported, ignoring. Aug 5 22:18:18.172948 systemd-tmpfiles[1194]: ACLs are not supported, ignoring. Aug 5 22:18:18.180045 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:18:18.195511 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:18:18.268441 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:18:18.287290 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:18:18.311549 systemd-tmpfiles[1220]: ACLs are not supported, ignoring. Aug 5 22:18:18.311566 systemd-tmpfiles[1220]: ACLs are not supported, ignoring. Aug 5 22:18:18.318554 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:18:18.437043 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:18:18.443580 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:18:18.479614 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:18:19.143460 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:18:19.158436 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:18:19.201445 systemd-udevd[1233]: Using default interface naming scheme 'v255'. Aug 5 22:18:19.246595 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:18:19.260360 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:18:19.288286 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:18:19.306550 systemd[1]: Found device dev-ttyS0.device - /dev/ttyS0. Aug 5 22:18:19.331270 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1238) Aug 5 22:18:19.358177 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1252) Aug 5 22:18:19.412893 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:18:19.430389 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:18:19.435132 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2 Aug 5 22:18:19.443144 kernel: ACPI: button: Power Button [PWRF] Aug 5 22:18:19.449143 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Aug 5 22:18:19.474160 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input3 Aug 5 22:18:19.499148 kernel: mousedev: PS/2 mouse device common for all mice Aug 5 22:18:19.518930 systemd-networkd[1242]: lo: Link UP Aug 5 22:18:19.518944 systemd-networkd[1242]: lo: Gained carrier Aug 5 22:18:19.521610 systemd-networkd[1242]: Enumeration completed Aug 5 22:18:19.523125 systemd-networkd[1242]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:18:19.523144 systemd-networkd[1242]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:18:19.525366 systemd-networkd[1242]: eth0: Link UP Aug 5 22:18:19.525383 systemd-networkd[1242]: eth0: Gained carrier Aug 5 22:18:19.525412 systemd-networkd[1242]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:18:19.530529 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:18:19.533462 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:18:19.537654 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:18:19.565213 systemd-networkd[1242]: eth0: DHCPv4 address 10.0.0.148/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:18:19.728729 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:18:19.838737 kernel: kvm_amd: TSC scaling supported Aug 5 22:18:19.838854 kernel: kvm_amd: Nested Virtualization enabled Aug 5 22:18:19.838910 kernel: kvm_amd: Nested Paging enabled Aug 5 22:18:19.838933 kernel: kvm_amd: LBR virtualization supported Aug 5 22:18:19.838956 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Aug 5 22:18:19.838978 kernel: kvm_amd: Virtual GIF supported Aug 5 22:18:20.026902 kernel: EDAC MC: Ver: 3.0.0 Aug 5 22:18:20.061428 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:18:20.082478 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:18:20.100850 lvm[1282]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:18:20.138363 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:18:20.145240 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:18:20.164979 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:18:20.176294 lvm[1285]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:18:20.217563 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:18:20.220706 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:18:20.226732 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). Aug 5 22:18:20.226784 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:18:20.228510 systemd[1]: Reached target machines.target - Containers. Aug 5 22:18:20.238780 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:18:20.253375 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:18:20.259451 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:18:20.261034 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:18:20.264618 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:18:20.269440 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:18:20.273538 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:18:20.276152 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:18:20.299563 kernel: loop0: detected capacity change from 0 to 139904 Aug 5 22:18:20.301039 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:18:20.384150 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:18:20.415150 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:18:20.461231 kernel: loop1: detected capacity change from 0 to 80568 Aug 5 22:18:20.602551 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:18:20.603872 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:18:20.651140 kernel: loop2: detected capacity change from 0 to 209816 Aug 5 22:18:20.787215 kernel: loop3: detected capacity change from 0 to 139904 Aug 5 22:18:20.896197 kernel: loop4: detected capacity change from 0 to 80568 Aug 5 22:18:20.951199 kernel: loop5: detected capacity change from 0 to 209816 Aug 5 22:18:20.999960 (sd-merge)[1305]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes'. Aug 5 22:18:21.001838 (sd-merge)[1305]: Merged extensions into '/usr'. Aug 5 22:18:21.035335 systemd[1]: Reloading requested from client PID 1293 ('systemd-sysext') (unit systemd-sysext.service)... Aug 5 22:18:21.035354 systemd[1]: Reloading... Aug 5 22:18:21.287681 zram_generator::config[1340]: No configuration found. Aug 5 22:18:21.552530 systemd-networkd[1242]: eth0: Gained IPv6LL Aug 5 22:18:21.573280 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. Aug 5 22:18:21.666812 systemd[1]: Reloading finished in 630 ms. Aug 5 22:18:21.766586 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:18:21.769049 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:18:21.789656 systemd[1]: Starting ensure-sysext.service... Aug 5 22:18:21.796920 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:18:21.804953 systemd[1]: Reloading requested from client PID 1375 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:18:21.804974 systemd[1]: Reloading... Aug 5 22:18:22.175485 zram_generator::config[1410]: No configuration found. Aug 5 22:18:22.181322 systemd-tmpfiles[1381]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:18:22.182032 systemd-tmpfiles[1381]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:18:22.184848 systemd-tmpfiles[1381]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:18:22.185299 systemd-tmpfiles[1381]: ACLs are not supported, ignoring. Aug 5 22:18:22.185395 systemd-tmpfiles[1381]: ACLs are not supported, ignoring. Aug 5 22:18:22.194244 systemd-tmpfiles[1381]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:18:22.194260 systemd-tmpfiles[1381]: Skipping /boot Aug 5 22:18:22.213794 systemd-tmpfiles[1381]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:18:22.213811 systemd-tmpfiles[1381]: Skipping /boot Aug 5 22:18:22.228463 ldconfig[1289]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:18:22.391141 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. Aug 5 22:18:22.503038 systemd[1]: Reloading finished in 697 ms. Aug 5 22:18:22.530668 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:18:22.551110 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:18:22.566447 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:18:22.597228 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:18:22.606767 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:18:22.617537 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:18:22.628231 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:18:22.640123 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.640383 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:18:22.656995 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:18:22.692409 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:18:22.698697 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:18:22.701203 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:18:22.701422 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.703055 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:18:22.710058 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:18:22.710393 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:18:22.720873 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:18:22.721210 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:18:22.733223 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:18:22.736433 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:18:22.745965 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.746535 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:18:22.748435 augenrules[1486]: No rules Aug 5 22:18:22.759817 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:18:22.767554 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:18:22.774382 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:18:22.776517 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:18:22.783261 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:18:22.784667 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.786819 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:18:22.789473 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:18:22.790563 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:18:22.790962 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:18:22.799103 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:18:22.799417 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:18:22.811605 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:18:22.812109 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:18:22.816442 systemd-resolved[1464]: Positive Trust Anchors: Aug 5 22:18:22.816471 systemd-resolved[1464]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:18:22.816517 systemd-resolved[1464]: 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 corp home internal intranet lan local private test Aug 5 22:18:22.823580 systemd-resolved[1464]: Defaulting to hostname 'linux'. Aug 5 22:18:22.827532 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:18:22.832193 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:18:22.837492 systemd[1]: Reached target network.target - Network. Aug 5 22:18:22.839971 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:18:22.842167 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:18:22.843949 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.844299 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:18:22.850327 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:18:22.858709 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:18:22.865506 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:18:22.871690 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:18:22.873300 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:18:22.873556 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). Aug 5 22:18:22.873884 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Aug 5 22:18:22.880896 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:18:22.881410 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:18:22.884087 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:18:22.884444 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:18:22.890750 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:18:22.891078 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:18:22.893919 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:18:22.896558 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:18:22.897546 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:18:22.908910 systemd[1]: Finished ensure-sysext.service. Aug 5 22:18:22.914391 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:18:22.914495 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:18:22.929549 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:18:23.020730 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:18:23.022856 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:18:23.708457 systemd-timesyncd[1535]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:18:23.708528 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:18:23.709447 systemd-resolved[1464]: Clock change detected. Flushing caches. Aug 5 22:18:23.710377 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 5 22:18:23.711082 systemd-timesyncd[1535]: Initial clock synchronization to Mon 2024-08-05 22:18:23.708323 UTC. Aug 5 22:18:23.711884 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:18:23.713610 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:18:23.713662 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:18:23.714802 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:18:23.716423 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:18:23.718793 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:18:23.720717 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:18:23.723573 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:18:23.727861 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:18:23.731671 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:18:23.738186 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:18:23.739787 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:18:23.741221 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:18:23.743328 systemd[1]: System is tainted: cgroupsv1 Aug 5 22:18:23.743387 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:18:23.743416 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:18:23.748871 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:18:23.753000 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:18:23.756647 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:18:23.763154 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:18:23.766911 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:18:23.768711 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). Aug 5 22:18:23.774194 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 5 22:18:23.779179 jq[1543]: false Aug 5 22:18:23.780229 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:18:23.784428 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:18:23.789752 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:18:23.794898 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:18:23.816392 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:18:23.819610 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:18:23.823569 extend-filesystems[1545]: Found loop3 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found loop4 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found loop5 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found sr0 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda1 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda2 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda3 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found usr Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda4 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda6 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda7 Aug 5 22:18:23.824925 extend-filesystems[1545]: Found vda9 Aug 5 22:18:23.824925 extend-filesystems[1545]: Checking size of /dev/vda9 Aug 5 22:18:23.825320 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:18:23.830559 dbus-daemon[1542]: [system] SELinux support is enabled Aug 5 22:18:23.832779 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:18:23.862128 update_engine[1563]: I0805 22:18:23.854575 1563 main.cc:92] Flatcar Update Engine starting Aug 5 22:18:23.862128 update_engine[1563]: I0805 22:18:23.856729 1563 update_check_scheduler.cc:74] Next update check in 7m59s Aug 5 22:18:23.836550 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:18:23.862599 jq[1566]: true Aug 5 22:18:23.859564 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:18:23.860059 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:18:23.873356 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:18:23.873799 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:18:23.875689 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:18:23.876147 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:18:23.923212 extend-filesystems[1545]: Resized partition /dev/vda9 Aug 5 22:18:23.944666 extend-filesystems[1582]: resize2fs 1.47.0 (5-Feb-2023) Aug 5 22:18:23.938260 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:18:23.963067 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (1590) Aug 5 22:18:23.971989 (ntainerd)[1585]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:18:23.977508 jq[1584]: true Aug 5 22:18:23.997067 kernel: EXT4-fs (vda9): resizing filesystem from 553472 to 1864699 blocks Aug 5 22:18:24.005049 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:18:24.005449 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:18:24.015958 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:18:24.020044 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:18:24.020189 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). Aug 5 22:18:24.020227 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:18:24.024167 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). Aug 5 22:18:24.024201 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:18:24.032331 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:18:24.042437 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:18:24.044860 systemd-logind[1557]: Watching system buttons on /dev/input/event1 (Power Button) Aug 5 22:18:24.044886 systemd-logind[1557]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Aug 5 22:18:24.048733 systemd-logind[1557]: New seat seat0. Aug 5 22:18:24.051315 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:18:24.137938 locksmithd[1621]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:18:24.153799 sshd_keygen[1571]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:18:24.203333 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:18:24.210012 kernel: EXT4-fs (vda9): resized filesystem to 1864699 Aug 5 22:18:24.232787 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:18:24.248922 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:18:24.249357 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:18:24.281066 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:18:24.317648 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:18:24.330623 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:18:24.336541 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 5 22:18:24.341496 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:18:24.431182 extend-filesystems[1582]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Aug 5 22:18:24.431182 extend-filesystems[1582]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 5 22:18:24.431182 extend-filesystems[1582]: The filesystem on /dev/vda9 is now 1864699 (4k) blocks long. Aug 5 22:18:24.444211 extend-filesystems[1545]: Resized filesystem in /dev/vda9 Aug 5 22:18:24.436090 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:18:24.436688 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:18:24.471182 bash[1629]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:18:24.474169 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:18:24.477856 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:18:24.898882 containerd[1585]: time="2024-08-05T22:18:24.898680770Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:18:25.049477 containerd[1585]: time="2024-08-05T22:18:25.047386076Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:18:25.049477 containerd[1585]: time="2024-08-05T22:18:25.047557658Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.053784345Z" 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.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.053844478Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054294942Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054316713Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054440606Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054526597Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054542797Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.054663514Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.055006777Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.055042494Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:18:25.056976 containerd[1585]: time="2024-08-05T22:18:25.055057292Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:25.057430 containerd[1585]: time="2024-08-05T22:18:25.055266505Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 22:18:25.057430 containerd[1585]: time="2024-08-05T22:18:25.055284358Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:18:25.057430 containerd[1585]: time="2024-08-05T22:18:25.055359890Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:18:25.057430 containerd[1585]: time="2024-08-05T22:18:25.055373986Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083021134Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083107035Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083124438Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083167619Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083188148Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083203927Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083220598Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083444027Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083476839Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083492548Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083510712Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083547622Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083569723Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086522 containerd[1585]: time="2024-08-05T22:18:25.083589741Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083611762Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083630156Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083649393Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083666354Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083688676Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.083848486Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084299622Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084332524Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084350367Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084376757Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084471454Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084490640Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084506410Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.086956 containerd[1585]: time="2024-08-05T22:18:25.084520947Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084540133Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084555191Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084569909Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084584687Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084601358Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084790282Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084810540Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084825608Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084841338Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084856316Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084874089Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084890720Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087329 containerd[1585]: time="2024-08-05T22:18:25.084904837Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.085237651Z" 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}" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.085390117Z" level=info msg="Connect containerd service" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.085435192Z" level=info msg="using legacy CRI server" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.085444198Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.085579953Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.086351320Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.086413015Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.086433694Z" 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 Aug 5 22:18:25.087671 containerd[1585]: time="2024-08-05T22:18:25.086447450Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:18:25.099372 containerd[1585]: time="2024-08-05T22:18:25.099297899Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.088475503Z" level=info msg="Start subscribing containerd event" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.099714410Z" level=info msg="Start recovering state" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.100005857Z" level=info msg="Start event monitor" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.100117937Z" level=info msg="Start snapshots syncer" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.100186716Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.100208016Z" level=info msg="Start streaming server" Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.101093266Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.101155062Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:18:25.103982 containerd[1585]: time="2024-08-05T22:18:25.101227788Z" level=info msg="containerd successfully booted in 0.208301s" Aug 5 22:18:25.102243 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:18:28.187765 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 5 22:18:28.191802 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:18:28.194040 (kubelet)[1675]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Aug 5 22:18:28.197983 systemd[1]: Startup finished in 11.030s (kernel) + 11.051s (userspace) = 22.081s. Aug 5 22:18:29.547668 kubelet[1675]: E0805 22:18:29.547532 1675 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" Aug 5 22:18:29.552720 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Aug 5 22:18:29.553581 systemd[1]: kubelet.service: Failed with result 'exit-code'. Aug 5 22:18:33.244142 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:18:33.256497 systemd[1]: Started sshd@0-10.0.0.148:22-10.0.0.1:50928.service - OpenSSH per-connection server daemon (10.0.0.1:50928). Aug 5 22:18:33.413298 sshd[1690]: Accepted publickey for core from 10.0.0.1 port 50928 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:18:33.399105 sshd[1690]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:33.461487 systemd-logind[1557]: New session 1 of user core. Aug 5 22:18:33.464838 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:18:33.482509 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:18:33.553391 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:18:33.578146 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:18:33.584940 (systemd)[1696]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:33.865195 systemd[1696]: Queued start job for default target default.target. Aug 5 22:18:33.877772 systemd[1696]: Created slice app.slice - User Application Slice. Aug 5 22:18:33.877813 systemd[1696]: Reached target paths.target - Paths. Aug 5 22:18:33.877830 systemd[1696]: Reached target timers.target - Timers. Aug 5 22:18:33.895519 systemd[1696]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:18:33.916755 systemd[1696]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:18:33.916873 systemd[1696]: Reached target sockets.target - Sockets. Aug 5 22:18:33.916895 systemd[1696]: Reached target basic.target - Basic System. Aug 5 22:18:33.916977 systemd[1696]: Reached target default.target - Main User Target. Aug 5 22:18:33.917023 systemd[1696]: Startup finished in 306ms. Aug 5 22:18:33.917304 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:18:33.919953 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:18:34.011439 systemd[1]: Started sshd@1-10.0.0.148:22-10.0.0.1:50944.service - OpenSSH per-connection server daemon (10.0.0.1:50944). Aug 5 22:18:34.083508 sshd[1708]: Accepted publickey for core from 10.0.0.1 port 50944 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:18:34.085781 sshd[1708]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:34.102118 systemd-logind[1557]: New session 2 of user core. Aug 5 22:18:34.114613 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:18:34.212705 sshd[1708]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:34.241348 systemd[1]: Started sshd@2-10.0.0.148:22-10.0.0.1:50960.service - OpenSSH per-connection server daemon (10.0.0.1:50960). Aug 5 22:18:34.242107 systemd[1]: sshd@1-10.0.0.148:22-10.0.0.1:50944.service: Deactivated successfully. Aug 5 22:18:34.248062 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:18:34.254572 systemd-logind[1557]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:18:34.265170 systemd-logind[1557]: Removed session 2. Aug 5 22:18:34.324369 sshd[1713]: Accepted publickey for core from 10.0.0.1 port 50960 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:18:34.329272 sshd[1713]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:34.365306 systemd-logind[1557]: New session 3 of user core. Aug 5 22:18:34.375714 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:18:34.452569 sshd[1713]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:34.494581 systemd[1]: Started sshd@3-10.0.0.148:22-10.0.0.1:50966.service - OpenSSH per-connection server daemon (10.0.0.1:50966). Aug 5 22:18:34.495544 systemd[1]: sshd@2-10.0.0.148:22-10.0.0.1:50960.service: Deactivated successfully. Aug 5 22:18:34.511845 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:18:34.517767 systemd-logind[1557]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:18:34.528703 systemd-logind[1557]: Removed session 3. Aug 5 22:18:34.578301 sshd[1721]: Accepted publickey for core from 10.0.0.1 port 50966 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:18:34.579830 sshd[1721]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:34.604160 systemd-logind[1557]: New session 4 of user core. Aug 5 22:18:34.614700 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:18:34.702308 sshd[1721]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:34.731494 systemd[1]: Started sshd@4-10.0.0.148:22-10.0.0.1:50972.service - OpenSSH per-connection server daemon (10.0.0.1:50972). Aug 5 22:18:34.742207 systemd[1]: sshd@3-10.0.0.148:22-10.0.0.1:50966.service: Deactivated successfully. Aug 5 22:18:34.766588 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:18:34.778339 systemd-logind[1557]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:18:34.795974 systemd-logind[1557]: Removed session 4. Aug 5 22:18:34.828194 sshd[1730]: Accepted publickey for core from 10.0.0.1 port 50972 ssh2: RSA SHA256:/wAyea3vP9dXQlCAyE/d+D0JDO90hh/Jr57IUMqxZQo Aug 5 22:18:34.832385 sshd[1730]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:34.859219 systemd-logind[1557]: New session 5 of user core. Aug 5 22:18:34.875613 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:18:34.980122 sudo[1736]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Aug 5 22:18:34.981691 sudo[1736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:18:35.296702 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:18:35.362839 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:18:35.363315 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:18:37.519599 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 5 22:18:37.535658 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 5 22:18:37.583441 systemd[1]: Reloading requested from client PID 1788 ('systemctl') (unit session-5.scope)... Aug 5 22:18:37.583461 systemd[1]: Reloading... Aug 5 22:18:37.747069 zram_generator::config[1827]: No configuration found. Aug 5 22:18:38.190439 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. Aug 5 22:18:38.350712 systemd[1]: Reloading finished in 766 ms. Aug 5 22:18:38.518573 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 5 22:18:38.525839 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Aug 5 22:18:38.535141 systemd[1]: kubelet.service: Deactivated successfully. Aug 5 22:18:38.541433 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Aug 5 22:18:38.548593 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Aug 5 22:18:38.930427 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Aug 5 22:18:38.940120 (kubelet)[1886]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Aug 5 22:18:39.396181 kubelet[1886]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Aug 5 22:18:39.396181 kubelet[1886]: Flag --pod-infra-container-image has been deprecated, will be removed in a future release. Image garbage collector will get sandbox image information from CRI. Aug 5 22:18:39.396181 kubelet[1886]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Aug 5 22:18:39.396181 kubelet[1886]: I0805 22:18:39.395150 1886 server.go:203] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Aug 5 22:18:40.424089 kubelet[1886]: I0805 22:18:40.422438 1886 server.go:467] "Kubelet version" kubeletVersion="v1.28.7" Aug 5 22:18:40.424089 kubelet[1886]: I0805 22:18:40.423433 1886 server.go:469] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Aug 5 22:18:40.427191 kubelet[1886]: I0805 22:18:40.426476 1886 server.go:895] "Client rotation is on, will bootstrap in background" Aug 5 22:18:41.253633 kubelet[1886]: I0805 22:18:41.251476 1886 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Aug 5 22:18:41.601011 kubelet[1886]: I0805 22:18:41.599370 1886 server.go:725] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Aug 5 22:18:41.601011 kubelet[1886]: I0805 22:18:41.600077 1886 container_manager_linux.go:265] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Aug 5 22:18:41.601011 kubelet[1886]: I0805 22:18:41.600283 1886 container_manager_linux.go:270] "Creating Container Manager object based on Node Config" nodeConfig={"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}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"ExperimentalMemoryManagerPolicy":"None","ExperimentalMemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null} Aug 5 22:18:41.601011 kubelet[1886]: I0805 22:18:41.600305 1886 topology_manager.go:138] "Creating topology manager with none policy" Aug 5 22:18:41.601011 kubelet[1886]: I0805 22:18:41.600315 1886 container_manager_linux.go:301] "Creating device plugin manager" Aug 5 22:18:41.608018 kubelet[1886]: I0805 22:18:41.607696 1886 state_mem.go:36] "Initialized new in-memory state store" Aug 5 22:18:41.612006 kubelet[1886]: I0805 22:18:41.610304 1886 kubelet.go:393] "Attempting to sync node with API server" Aug 5 22:18:41.612006 kubelet[1886]: I0805 22:18:41.610356 1886 kubelet.go:298] "Adding static pod path" path="/etc/kubernetes/manifests" Aug 5 22:18:41.612006 kubelet[1886]: I0805 22:18:41.610398 1886 kubelet.go:309] "Adding apiserver pod source" Aug 5 22:18:41.612006 kubelet[1886]: I0805 22:18:41.610417 1886 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Aug 5 22:18:41.612006 kubelet[1886]: E0805 22:18:41.611198 1886 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:41.612006 kubelet[1886]: E0805 22:18:41.611265 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:41.618768 kubelet[1886]: I0805 22:18:41.618246 1886 kuberuntime_manager.go:257] "Container runtime initialized" containerRuntime="containerd" version="v1.7.17" apiVersion="v1" Aug 5 22:18:41.629627 kubelet[1886]: W0805 22:18:41.624365 1886 probe.go:268] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Aug 5 22:18:41.647070 kubelet[1886]: I0805 22:18:41.638594 1886 server.go:1232] "Started kubelet" Aug 5 22:18:41.652578 kubelet[1886]: I0805 22:18:41.648787 1886 ratelimit.go:65] "Setting rate limiting for podresources endpoint" qps=100 burstTokens=10 Aug 5 22:18:41.652578 kubelet[1886]: I0805 22:18:41.649063 1886 server.go:162] "Starting to listen" address="0.0.0.0" port=10250 Aug 5 22:18:41.652578 kubelet[1886]: I0805 22:18:41.650148 1886 server.go:462] "Adding debug handlers to kubelet server" Aug 5 22:18:41.652578 kubelet[1886]: E0805 22:18:41.651390 1886 cri_stats_provider.go:448] "Failed to get the info of the filesystem with mountpoint" err="unable to find data in memory cache" mountpoint="/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs" Aug 5 22:18:41.652578 kubelet[1886]: E0805 22:18:41.651423 1886 kubelet.go:1431] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Aug 5 22:18:41.654781 kubelet[1886]: I0805 22:18:41.653955 1886 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Aug 5 22:18:41.665679 kubelet[1886]: I0805 22:18:41.663340 1886 server.go:233] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Aug 5 22:18:41.670701 kubelet[1886]: E0805 22:18:41.668476 1886 kubelet_node_status.go:458] "Error getting the current node from lister" err="node \"10.0.0.148\" not found" Aug 5 22:18:41.670701 kubelet[1886]: I0805 22:18:41.668521 1886 volume_manager.go:291] "Starting Kubelet Volume Manager" Aug 5 22:18:41.670701 kubelet[1886]: I0805 22:18:41.668617 1886 desired_state_of_world_populator.go:151] "Desired state populator starts to run" Aug 5 22:18:41.670701 kubelet[1886]: I0805 22:18:41.668726 1886 reconciler_new.go:29] "Reconciler: start to sync state" Aug 5 22:18:42.064837 kubelet[1886]: E0805 22:18:42.063666 1886 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.0.0.148\" not found" node="10.0.0.148" Aug 5 22:18:42.066894 kubelet[1886]: E0805 22:18:42.066662 1886 container_manager_linux.go:881] "Unable to get rootfs data from cAdvisor interface" err="unable to find data in memory cache" Aug 5 22:18:42.071786 kubelet[1886]: I0805 22:18:42.071746 1886 kubelet_node_status.go:70] "Attempting to register node" node="10.0.0.148" Aug 5 22:18:42.111444 kubelet[1886]: I0805 22:18:42.111396 1886 kubelet_node_status.go:73] "Successfully registered node" node="10.0.0.148" Aug 5 22:18:42.146297 kubelet[1886]: I0805 22:18:42.145856 1886 cpu_manager.go:214] "Starting CPU manager" policy="none" Aug 5 22:18:42.146297 kubelet[1886]: I0805 22:18:42.145892 1886 cpu_manager.go:215] "Reconciling" reconcilePeriod="10s" Aug 5 22:18:42.146297 kubelet[1886]: I0805 22:18:42.145926 1886 state_mem.go:36] "Initialized new in-memory state store" Aug 5 22:18:42.160193 kubelet[1886]: I0805 22:18:42.155603 1886 policy_none.go:49] "None policy: Start" Aug 5 22:18:42.164554 kubelet[1886]: I0805 22:18:42.163936 1886 memory_manager.go:169] "Starting memorymanager" policy="None" Aug 5 22:18:42.164554 kubelet[1886]: I0805 22:18:42.164003 1886 state_mem.go:35] "Initializing new in-memory state store" Aug 5 22:18:42.282556 kubelet[1886]: I0805 22:18:42.282452 1886 manager.go:471] "Failed to read data from checkpoint" checkpoint="kubelet_internal_checkpoint" err="checkpoint is not found" Aug 5 22:18:42.293064 kubelet[1886]: I0805 22:18:42.285312 1886 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Aug 5 22:18:42.304581 kubelet[1886]: I0805 22:18:42.304544 1886 kuberuntime_manager.go:1528] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Aug 5 22:18:42.306582 containerd[1585]: time="2024-08-05T22:18:42.305744468Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Aug 5 22:18:42.307256 kubelet[1886]: I0805 22:18:42.306171 1886 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Aug 5 22:18:42.438155 kubelet[1886]: I0805 22:18:42.434149 1886 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Aug 5 22:18:42.438155 kubelet[1886]: W0805 22:18:42.434424 1886 reflector.go:458] vendor/k8s.io/client-go/informers/factory.go:150: watch of *v1.CSIDriver ended with: very short watch: vendor/k8s.io/client-go/informers/factory.go:150: Unexpected watch close - watch lasted less than a second and no items received Aug 5 22:18:42.438155 kubelet[1886]: W0805 22:18:42.434477 1886 reflector.go:458] vendor/k8s.io/client-go/informers/factory.go:150: watch of *v1.Service ended with: very short watch: vendor/k8s.io/client-go/informers/factory.go:150: Unexpected watch close - watch lasted less than a second and no items received Aug 5 22:18:42.438410 kubelet[1886]: E0805 22:18:42.434591 1886 event.go:289] Unable to write event: '&v1.Event{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"10.0.0.148.17e8f513aa9a15f5", GenerateName:"", Namespace:"default", SelfLink:"", UID:"", ResourceVersion:"", Generation:0, CreationTimestamp:time.Date(1, time.January, 1, 0, 0, 0, 0, time.UTC), DeletionTimestamp:, DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string(nil), Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Finalizers:[]string(nil), ManagedFields:[]v1.ManagedFieldsEntry(nil)}, InvolvedObject:v1.ObjectReference{Kind:"Node", Namespace:"", Name:"10.0.0.148", UID:"10.0.0.148", APIVersion:"", ResourceVersion:"", FieldPath:""}, Reason:"NodeAllocatableEnforced", Message:"Updated Node Allocatable limit across pods", Source:v1.EventSource{Component:"kubelet", Host:"10.0.0.148"}, FirstTimestamp:time.Date(2024, time.August, 5, 22, 18, 42, 284623349, time.Local), LastTimestamp:time.Date(2024, time.August, 5, 22, 18, 42, 284623349, time.Local), Count:1, Type:"Normal", EventTime:time.Date(1, time.January, 1, 0, 0, 0, 0, time.UTC), Series:(*v1.EventSeries)(nil), Action:"", Related:(*v1.ObjectReference)(nil), ReportingController:"kubelet", ReportingInstance:"10.0.0.148"}': 'Post "https://10.0.0.136:6443/api/v1/namespaces/default/events": read tcp 10.0.0.148:34302->10.0.0.136:6443: use of closed network connection'(may retry after sleeping) Aug 5 22:18:42.514590 kubelet[1886]: I0805 22:18:42.514232 1886 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv4" Aug 5 22:18:42.520857 kubelet[1886]: I0805 22:18:42.520328 1886 kubelet_network_linux.go:50] "Initialized iptables rules." protocol="IPv6" Aug 5 22:18:42.520857 kubelet[1886]: I0805 22:18:42.520370 1886 status_manager.go:217] "Starting to sync pod status with apiserver" Aug 5 22:18:42.520857 kubelet[1886]: I0805 22:18:42.520401 1886 kubelet.go:2303] "Starting kubelet main sync loop" Aug 5 22:18:42.520857 kubelet[1886]: E0805 22:18:42.520475 1886 kubelet.go:2327] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Aug 5 22:18:42.613048 kubelet[1886]: I0805 22:18:42.611532 1886 apiserver.go:52] "Watching apiserver" Aug 5 22:18:42.613048 kubelet[1886]: E0805 22:18:42.612671 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:42.632018 kubelet[1886]: I0805 22:18:42.630253 1886 topology_manager.go:215] "Topology Admit Handler" podUID="2d21afb6-9569-41bb-82be-27db15e5cbdb" podNamespace="kube-system" podName="kube-proxy-j9gnz" Aug 5 22:18:42.632018 kubelet[1886]: I0805 22:18:42.630411 1886 topology_manager.go:215] "Topology Admit Handler" podUID="57a824b6-d2bd-46b2-b3aa-4d213ad764d9" podNamespace="kube-flannel" podName="kube-flannel-ds-v87kd" Aug 5 22:18:42.665152 sudo[1736]: pam_unix(sudo:session): session closed for user root Aug 5 22:18:42.669488 sshd[1730]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676524 1886 desired_state_of_world_populator.go:159] "Finished populating initial desired state of world" Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676806 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/2d21afb6-9569-41bb-82be-27db15e5cbdb-kube-proxy\") pod \"kube-proxy-j9gnz\" (UID: \"2d21afb6-9569-41bb-82be-27db15e5cbdb\") " pod="kube-system/kube-proxy-j9gnz" Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676844 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/2d21afb6-9569-41bb-82be-27db15e5cbdb-xtables-lock\") pod \"kube-proxy-j9gnz\" (UID: \"2d21afb6-9569-41bb-82be-27db15e5cbdb\") " pod="kube-system/kube-proxy-j9gnz" Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676878 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-2zp4q\" (UniqueName: \"kubernetes.io/projected/2d21afb6-9569-41bb-82be-27db15e5cbdb-kube-api-access-2zp4q\") pod \"kube-proxy-j9gnz\" (UID: \"2d21afb6-9569-41bb-82be-27db15e5cbdb\") " pod="kube-system/kube-proxy-j9gnz" Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676904 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-cni-plugin\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.681366 kubelet[1886]: I0805 22:18:42.676936 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-xtables-lock\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.681790 kubelet[1886]: I0805 22:18:42.677113 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/2d21afb6-9569-41bb-82be-27db15e5cbdb-lib-modules\") pod \"kube-proxy-j9gnz\" (UID: \"2d21afb6-9569-41bb-82be-27db15e5cbdb\") " pod="kube-system/kube-proxy-j9gnz" Aug 5 22:18:42.681790 kubelet[1886]: I0805 22:18:42.677153 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-run\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.681790 kubelet[1886]: I0805 22:18:42.677184 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-cni\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.681790 kubelet[1886]: I0805 22:18:42.677214 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-flannel-cfg\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.681790 kubelet[1886]: I0805 22:18:42.677247 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-c8zkv\" (UniqueName: \"kubernetes.io/projected/57a824b6-d2bd-46b2-b3aa-4d213ad764d9-kube-api-access-c8zkv\") pod \"kube-flannel-ds-v87kd\" (UID: \"57a824b6-d2bd-46b2-b3aa-4d213ad764d9\") " pod="kube-flannel/kube-flannel-ds-v87kd" Aug 5 22:18:42.691579 systemd[1]: sshd@4-10.0.0.148:22-10.0.0.1:50972.service: Deactivated successfully. Aug 5 22:18:42.702560 systemd-logind[1557]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:18:42.705364 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:18:42.715586 systemd-logind[1557]: Removed session 5. Aug 5 22:18:42.941160 kubelet[1886]: E0805 22:18:42.940736 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:42.942644 containerd[1585]: time="2024-08-05T22:18:42.941909114Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-j9gnz,Uid:2d21afb6-9569-41bb-82be-27db15e5cbdb,Namespace:kube-system,Attempt:0,}" Aug 5 22:18:42.946427 kubelet[1886]: E0805 22:18:42.946365 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:42.948686 containerd[1585]: time="2024-08-05T22:18:42.948061472Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-v87kd,Uid:57a824b6-d2bd-46b2-b3aa-4d213ad764d9,Namespace:kube-flannel,Attempt:0,}" Aug 5 22:18:43.615177 kubelet[1886]: E0805 22:18:43.615102 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:44.047335 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3384022882.mount: Deactivated successfully. Aug 5 22:18:44.085321 containerd[1585]: time="2024-08-05T22:18:44.083417830Z" 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\"}" Aug 5 22:18:44.093595 containerd[1585]: time="2024-08-05T22:18:44.089911578Z" 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\"}" Aug 5 22:18:44.096669 containerd[1585]: time="2024-08-05T22:18:44.095321073Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312056" Aug 5 22:18:44.102207 containerd[1585]: time="2024-08-05T22:18:44.100508682Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Aug 5 22:18:44.103343 containerd[1585]: time="2024-08-05T22:18:44.103291511Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Aug 5 22:18:44.107139 containerd[1585]: time="2024-08-05T22:18:44.107018881Z" 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\"}" Aug 5 22:18:44.113310 containerd[1585]: time="2024-08-05T22:18:44.108692930Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.16647136s" Aug 5 22:18:44.124277 containerd[1585]: time="2024-08-05T22:18:44.120417488Z" level=info msg="Pulled image \"registry.k8s.io/pause:3.8\" with image id \"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\", repo tag \"registry.k8s.io/pause:3.8\", repo digest \"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\", size \"311286\" in 1.172129491s" Aug 5 22:18:44.615899 kubelet[1886]: E0805 22:18:44.615766 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:45.144827 containerd[1585]: time="2024-08-05T22:18:45.144641504Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:18:45.144827 containerd[1585]: time="2024-08-05T22:18:45.144750899Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:45.144827 containerd[1585]: time="2024-08-05T22:18:45.144777759Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:18:45.144827 containerd[1585]: time="2024-08-05T22:18:45.144790493Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:45.165977 containerd[1585]: time="2024-08-05T22:18:45.149323474Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:18:45.165977 containerd[1585]: time="2024-08-05T22:18:45.149401440Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:45.165977 containerd[1585]: time="2024-08-05T22:18:45.149437428Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:18:45.165977 containerd[1585]: time="2024-08-05T22:18:45.149456674Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:45.616624 kubelet[1886]: E0805 22:18:45.616379 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:46.177994 containerd[1585]: time="2024-08-05T22:18:46.171054374Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-j9gnz,Uid:2d21afb6-9569-41bb-82be-27db15e5cbdb,Namespace:kube-system,Attempt:0,} returns sandbox id \"825963877d53c17d572018624be6d0f64525c4d6b1602b8105705a4f2783eeb5\"" Aug 5 22:18:46.178703 kubelet[1886]: E0805 22:18:46.172545 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:46.188420 containerd[1585]: time="2024-08-05T22:18:46.183538116Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.28.12\"" Aug 5 22:18:46.276947 containerd[1585]: time="2024-08-05T22:18:46.276792341Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-v87kd,Uid:57a824b6-d2bd-46b2-b3aa-4d213ad764d9,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\"" Aug 5 22:18:46.279510 kubelet[1886]: E0805 22:18:46.278007 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:46.620990 kubelet[1886]: E0805 22:18:46.617276 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:47.618323 kubelet[1886]: E0805 22:18:47.618274 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:48.498955 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3993171739.mount: Deactivated successfully. Aug 5 22:18:48.619188 kubelet[1886]: E0805 22:18:48.618893 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:49.537682 containerd[1585]: time="2024-08-05T22:18:49.537530008Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.28.12\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:49.562276 containerd[1585]: time="2024-08-05T22:18:49.562171700Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.28.12: active requests=0, bytes read=28303769" Aug 5 22:18:49.581392 containerd[1585]: time="2024-08-05T22:18:49.581272200Z" level=info msg="ImageCreate event name:\"sha256:1610963ec6edeaf744dc6bc6475bb85db4736faef7394a1ad6f0ccb9d30d2ab3\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:49.594399 containerd[1585]: time="2024-08-05T22:18:49.594314258Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:7dd7829fa889ac805a0b1047eba04599fa5006bdbcb5cb9c8d14e1dc8910488b\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:49.595274 containerd[1585]: time="2024-08-05T22:18:49.595218584Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.28.12\" with image id \"sha256:1610963ec6edeaf744dc6bc6475bb85db4736faef7394a1ad6f0ccb9d30d2ab3\", repo tag \"registry.k8s.io/kube-proxy:v1.28.12\", repo digest \"registry.k8s.io/kube-proxy@sha256:7dd7829fa889ac805a0b1047eba04599fa5006bdbcb5cb9c8d14e1dc8910488b\", size \"28302788\" in 3.41162826s" Aug 5 22:18:49.595274 containerd[1585]: time="2024-08-05T22:18:49.595268598Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.28.12\" returns image reference \"sha256:1610963ec6edeaf744dc6bc6475bb85db4736faef7394a1ad6f0ccb9d30d2ab3\"" Aug 5 22:18:49.595971 containerd[1585]: time="2024-08-05T22:18:49.595936771Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\"" Aug 5 22:18:49.597784 containerd[1585]: time="2024-08-05T22:18:49.597576226Z" level=info msg="CreateContainer within sandbox \"825963877d53c17d572018624be6d0f64525c4d6b1602b8105705a4f2783eeb5\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Aug 5 22:18:49.619827 kubelet[1886]: E0805 22:18:49.619761 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:49.694394 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2697271218.mount: Deactivated successfully. Aug 5 22:18:49.711409 containerd[1585]: time="2024-08-05T22:18:49.711131813Z" level=info msg="CreateContainer within sandbox \"825963877d53c17d572018624be6d0f64525c4d6b1602b8105705a4f2783eeb5\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"0b9e1401e9585eb81d0c43166d58871a99f87e732136acc98dcd42d4210fc8ee\"" Aug 5 22:18:49.713221 containerd[1585]: time="2024-08-05T22:18:49.713174343Z" level=info msg="StartContainer for \"0b9e1401e9585eb81d0c43166d58871a99f87e732136acc98dcd42d4210fc8ee\"" Aug 5 22:18:49.856481 containerd[1585]: time="2024-08-05T22:18:49.856309092Z" level=info msg="StartContainer for \"0b9e1401e9585eb81d0c43166d58871a99f87e732136acc98dcd42d4210fc8ee\" returns successfully" Aug 5 22:18:50.586615 kubelet[1886]: E0805 22:18:50.586574 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:50.621134 kubelet[1886]: E0805 22:18:50.620986 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:50.632355 kubelet[1886]: I0805 22:18:50.632291 1886 pod_startup_latency_tracker.go:102] "Observed pod startup duration" pod="kube-system/kube-proxy-j9gnz" podStartSLOduration=5.210201877 podCreationTimestamp="2024-08-05 22:18:42 +0000 UTC" firstStartedPulling="2024-08-05 22:18:46.173660051 +0000 UTC m=+7.222645480" lastFinishedPulling="2024-08-05 22:18:49.595699596 +0000 UTC m=+10.644685035" observedRunningTime="2024-08-05 22:18:50.631017737 +0000 UTC m=+11.680003166" watchObservedRunningTime="2024-08-05 22:18:50.632241432 +0000 UTC m=+11.681226861" Aug 5 22:18:51.589070 kubelet[1886]: E0805 22:18:51.588991 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:51.621430 kubelet[1886]: E0805 22:18:51.621292 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:52.260043 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount4153431350.mount: Deactivated successfully. Aug 5 22:18:52.622596 kubelet[1886]: E0805 22:18:52.622438 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:53.320617 containerd[1585]: time="2024-08-05T22:18:53.319312419Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin:v1.1.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:53.323231 containerd[1585]: time="2024-08-05T22:18:53.323088090Z" level=info msg="stop pulling image docker.io/flannel/flannel-cni-plugin:v1.1.2: active requests=0, bytes read=3852936" Aug 5 22:18:53.334618 containerd[1585]: time="2024-08-05T22:18:53.331780552Z" level=info msg="ImageCreate event name:\"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:53.343690 containerd[1585]: time="2024-08-05T22:18:53.340196364Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:18:53.345815 containerd[1585]: time="2024-08-05T22:18:53.344284130Z" level=info msg="Pulled image \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" with image id \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\", repo tag \"docker.io/flannel/flannel-cni-plugin:v1.1.2\", repo digest \"docker.io/flannel/flannel-cni-plugin@sha256:bf4b62b131666d040f35a327d906ee5a3418280b68a88d9b9c7e828057210443\", size \"3842055\" in 3.748307034s" Aug 5 22:18:53.345815 containerd[1585]: time="2024-08-05T22:18:53.344334695Z" level=info msg="PullImage \"docker.io/flannel/flannel-cni-plugin:v1.1.2\" returns image reference \"sha256:7a2dcab94698c786e7e41360faf8cd0ea2b29952469be75becc34c61902240e0\"" Aug 5 22:18:53.353122 containerd[1585]: time="2024-08-05T22:18:53.353014232Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Aug 5 22:18:53.403775 containerd[1585]: time="2024-08-05T22:18:53.403546689Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54\"" Aug 5 22:18:53.406384 containerd[1585]: time="2024-08-05T22:18:53.405560596Z" level=info msg="StartContainer for \"e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54\"" Aug 5 22:18:53.625705 kubelet[1886]: E0805 22:18:53.624076 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:53.946941 systemd[1]: run-containerd-runc-k8s.io-e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54-runc.W9qNPf.mount: Deactivated successfully. Aug 5 22:18:54.033244 containerd[1585]: time="2024-08-05T22:18:54.033083495Z" level=info msg="StartContainer for \"e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54\" returns successfully" Aug 5 22:18:54.117135 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54-rootfs.mount: Deactivated successfully. Aug 5 22:18:54.624870 kubelet[1886]: E0805 22:18:54.624819 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:54.633457 kubelet[1886]: E0805 22:18:54.632849 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:54.896851 containerd[1585]: time="2024-08-05T22:18:54.896601479Z" level=info msg="shim disconnected" id=e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54 namespace=k8s.io Aug 5 22:18:54.896851 containerd[1585]: time="2024-08-05T22:18:54.896707057Z" level=warning msg="cleaning up after shim disconnected" id=e3359f6ca4b0fdacd4cfdba8654621ac0656ded500222fac3f2d09c1db634e54 namespace=k8s.io Aug 5 22:18:54.896851 containerd[1585]: time="2024-08-05T22:18:54.896719531Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 5 22:18:55.626001 kubelet[1886]: E0805 22:18:55.625853 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:55.657559 kubelet[1886]: E0805 22:18:55.656913 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:18:55.661010 containerd[1585]: time="2024-08-05T22:18:55.659350456Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\"" Aug 5 22:18:56.627269 kubelet[1886]: E0805 22:18:56.627134 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:57.628865 kubelet[1886]: E0805 22:18:57.628788 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:58.243343 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2926719505.mount: Deactivated successfully. Aug 5 22:18:58.629141 kubelet[1886]: E0805 22:18:58.628939 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:18:59.633369 kubelet[1886]: E0805 22:18:59.630312 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:00.634515 kubelet[1886]: E0805 22:19:00.634377 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:01.611612 kubelet[1886]: E0805 22:19:01.611531 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:01.635591 kubelet[1886]: E0805 22:19:01.635443 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:02.636509 kubelet[1886]: E0805 22:19:02.636355 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:03.636618 kubelet[1886]: E0805 22:19:03.636539 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:04.642207 kubelet[1886]: E0805 22:19:04.642123 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:05.643355 kubelet[1886]: E0805 22:19:05.643282 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:06.647084 kubelet[1886]: E0805 22:19:06.644996 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:07.649774 kubelet[1886]: E0805 22:19:07.649634 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:08.655673 kubelet[1886]: E0805 22:19:08.655235 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:09.208210 update_engine[1563]: I0805 22:19:09.208101 1563 update_attempter.cc:509] Updating boot flags... Aug 5 22:19:09.411061 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2277) Aug 5 22:19:11.156994 kubelet[1886]: E0805 22:19:11.156137 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:11.212203 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 36 scanned by (udev-worker) (2278) Aug 5 22:19:11.754432 containerd[1585]: time="2024-08-05T22:19:11.752909934Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel:v0.22.0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:11.757233 containerd[1585]: time="2024-08-05T22:19:11.757100887Z" level=info msg="stop pulling image docker.io/flannel/flannel:v0.22.0: active requests=0, bytes read=26866357" Aug 5 22:19:11.766984 containerd[1585]: time="2024-08-05T22:19:11.761509873Z" level=info msg="ImageCreate event name:\"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:11.771602 containerd[1585]: time="2024-08-05T22:19:11.771391324Z" level=info msg="ImageCreate event name:\"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:11.775211 containerd[1585]: time="2024-08-05T22:19:11.773632586Z" level=info msg="Pulled image \"docker.io/flannel/flannel:v0.22.0\" with image id \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\", repo tag \"docker.io/flannel/flannel:v0.22.0\", repo digest \"docker.io/flannel/flannel@sha256:5f83f1243057458e27249157394e3859cf31cc075354af150d497f2ebc8b54db\", size \"26855532\" in 16.114234892s" Aug 5 22:19:11.775211 containerd[1585]: time="2024-08-05T22:19:11.773699343Z" level=info msg="PullImage \"docker.io/flannel/flannel:v0.22.0\" returns image reference \"sha256:38c11b8f4aa1904512c0b3e93d34604de20ba24b38d4365d27fe05b7a4ce6f68\"" Aug 5 22:19:11.788824 containerd[1585]: time="2024-08-05T22:19:11.786413077Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Aug 5 22:19:11.853117 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2832614322.mount: Deactivated successfully. Aug 5 22:19:11.887944 containerd[1585]: time="2024-08-05T22:19:11.883700776Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954\"" Aug 5 22:19:11.887944 containerd[1585]: time="2024-08-05T22:19:11.884571699Z" level=info msg="StartContainer for \"343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954\"" Aug 5 22:19:12.156983 kubelet[1886]: E0805 22:19:12.156714 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:12.713632 kubelet[1886]: I0805 22:19:12.712547 1886 kubelet_node_status.go:493] "Fast updating node status as it just became ready" Aug 5 22:19:12.737288 containerd[1585]: time="2024-08-05T22:19:12.721262659Z" level=info msg="StartContainer for \"343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954\" returns successfully" Aug 5 22:19:12.823292 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954-rootfs.mount: Deactivated successfully. Aug 5 22:19:13.149150 containerd[1585]: time="2024-08-05T22:19:13.144155832Z" level=error msg="collecting metrics for 343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954" error="cgroups: cgroup deleted: unknown" Aug 5 22:19:13.157509 kubelet[1886]: E0805 22:19:13.157391 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:13.181714 kubelet[1886]: E0805 22:19:13.180989 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:19:13.362198 containerd[1585]: time="2024-08-05T22:19:13.362118374Z" level=info msg="shim disconnected" id=343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954 namespace=k8s.io Aug 5 22:19:13.362463 containerd[1585]: time="2024-08-05T22:19:13.362442267Z" level=warning msg="cleaning up after shim disconnected" id=343a10fbecae65267bd2f626e1a4510bea3549e743b7f6f321e9fe99f1c5f954 namespace=k8s.io Aug 5 22:19:13.362553 containerd[1585]: time="2024-08-05T22:19:13.362534412Z" level=info msg="cleaning up dead shim" namespace=k8s.io Aug 5 22:19:14.158605 kubelet[1886]: E0805 22:19:14.158409 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:14.201735 kubelet[1886]: E0805 22:19:14.201165 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:19:14.207706 containerd[1585]: time="2024-08-05T22:19:14.207304374Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Aug 5 22:19:14.295219 containerd[1585]: time="2024-08-05T22:19:14.295133331Z" level=info msg="CreateContainer within sandbox \"28cadacce6e27474e4ba0f1c7ef0da27757cede822174cb94afe047d363daf74\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"65bf76afdf392639c619754cf4d1f2dac945e18f0564b0cc1e29777123fd89f9\"" Aug 5 22:19:14.297323 containerd[1585]: time="2024-08-05T22:19:14.296266056Z" level=info msg="StartContainer for \"65bf76afdf392639c619754cf4d1f2dac945e18f0564b0cc1e29777123fd89f9\"" Aug 5 22:19:14.415264 systemd[1]: run-containerd-runc-k8s.io-65bf76afdf392639c619754cf4d1f2dac945e18f0564b0cc1e29777123fd89f9-runc.6GT2c3.mount: Deactivated successfully. Aug 5 22:19:14.635875 containerd[1585]: time="2024-08-05T22:19:14.634926858Z" level=info msg="StartContainer for \"65bf76afdf392639c619754cf4d1f2dac945e18f0564b0cc1e29777123fd89f9\" returns successfully" Aug 5 22:19:15.162357 kubelet[1886]: E0805 22:19:15.162245 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:15.230153 kubelet[1886]: E0805 22:19:15.230093 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:19:15.834860 systemd-networkd[1242]: flannel.1: Link UP Aug 5 22:19:15.834873 systemd-networkd[1242]: flannel.1: Gained carrier Aug 5 22:19:16.163647 kubelet[1886]: E0805 22:19:16.163310 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:16.236957 kubelet[1886]: E0805 22:19:16.234053 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:19:16.660782 kubelet[1886]: I0805 22:19:16.655005 1886 pod_startup_latency_tracker.go:102] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-v87kd" podStartSLOduration=9.160169436 podCreationTimestamp="2024-08-05 22:18:42 +0000 UTC" firstStartedPulling="2024-08-05 22:18:46.279202701 +0000 UTC m=+7.328188130" lastFinishedPulling="2024-08-05 22:19:11.773989183 +0000 UTC m=+32.822974612" observedRunningTime="2024-08-05 22:19:15.29084889 +0000 UTC m=+36.339834319" watchObservedRunningTime="2024-08-05 22:19:16.654955918 +0000 UTC m=+37.703941357" Aug 5 22:19:16.660782 kubelet[1886]: I0805 22:19:16.658475 1886 topology_manager.go:215] "Topology Admit Handler" podUID="050d235f-5ffd-429e-a886-d8b5038b21de" podNamespace="default" podName="nginx-deployment-6d5f899847-w28fn" Aug 5 22:19:16.691872 kubelet[1886]: I0805 22:19:16.691781 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-ngfcf\" (UniqueName: \"kubernetes.io/projected/050d235f-5ffd-429e-a886-d8b5038b21de-kube-api-access-ngfcf\") pod \"nginx-deployment-6d5f899847-w28fn\" (UID: \"050d235f-5ffd-429e-a886-d8b5038b21de\") " pod="default/nginx-deployment-6d5f899847-w28fn" Aug 5 22:19:16.976172 containerd[1585]: time="2024-08-05T22:19:16.974827883Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6d5f899847-w28fn,Uid:050d235f-5ffd-429e-a886-d8b5038b21de,Namespace:default,Attempt:0,}" Aug 5 22:19:17.377158 kubelet[1886]: E0805 22:19:17.376964 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:17.428173 systemd-networkd[1242]: cni0: Link UP Aug 5 22:19:17.428183 systemd-networkd[1242]: cni0: Gained carrier Aug 5 22:19:17.428982 systemd-networkd[1242]: cni0: Lost carrier Aug 5 22:19:17.526643 systemd-networkd[1242]: vethd28e3568: Link UP Aug 5 22:19:17.544182 kernel: cni0: port 1(vethd28e3568) entered blocking state Aug 5 22:19:17.544300 kernel: cni0: port 1(vethd28e3568) entered disabled state Aug 5 22:19:17.552213 kernel: vethd28e3568: entered allmulticast mode Aug 5 22:19:17.556075 kernel: vethd28e3568: entered promiscuous mode Aug 5 22:19:17.556189 kernel: cni0: port 1(vethd28e3568) entered blocking state Aug 5 22:19:17.556215 kernel: cni0: port 1(vethd28e3568) entered forwarding state Aug 5 22:19:17.560739 kernel: cni0: port 1(vethd28e3568) entered disabled state Aug 5 22:19:17.604670 kernel: cni0: port 1(vethd28e3568) entered blocking state Aug 5 22:19:17.614512 kernel: cni0: port 1(vethd28e3568) entered forwarding state Aug 5 22:19:17.605394 systemd-networkd[1242]: vethd28e3568: Gained carrier Aug 5 22:19:17.605815 systemd-networkd[1242]: cni0: Gained carrier Aug 5 22:19:17.648854 containerd[1585]: 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)(0xc00001c938), "name":"cbr0", "type":"bridge"} Aug 5 22:19:17.648854 containerd[1585]: delegateAdd: netconf sent to delegate plugin: Aug 5 22:19:17.662526 systemd-networkd[1242]: flannel.1: Gained IPv6LL Aug 5 22:19:18.156656 containerd[1585]: {"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="2024-08-05T22:19:18.156258452Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:19:18.156656 containerd[1585]: time="2024-08-05T22:19:18.156370935Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:19:18.156656 containerd[1585]: time="2024-08-05T22:19:18.156401152Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:19:18.156656 containerd[1585]: time="2024-08-05T22:19:18.156420498Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:19:18.377551 kubelet[1886]: E0805 22:19:18.377472 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:18.543926 systemd-resolved[1464]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:19:18.700654 systemd-networkd[1242]: cni0: Gained IPv6LL Aug 5 22:19:19.075922 containerd[1585]: time="2024-08-05T22:19:19.071442723Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6d5f899847-w28fn,Uid:050d235f-5ffd-429e-a886-d8b5038b21de,Namespace:default,Attempt:0,} returns sandbox id \"7701f5b11ce3f9e58c3d1acdb6efa74cee83efe3cca75c1292049c6f4180d548\"" Aug 5 22:19:19.075922 containerd[1585]: time="2024-08-05T22:19:19.073718772Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 5 22:19:19.378893 kubelet[1886]: E0805 22:19:19.378493 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:19.389515 systemd-networkd[1242]: vethd28e3568: Gained IPv6LL Aug 5 22:19:20.380240 kubelet[1886]: E0805 22:19:20.379111 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:21.396081 kubelet[1886]: E0805 22:19:21.396002 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:21.617443 kubelet[1886]: E0805 22:19:21.613004 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:22.396453 kubelet[1886]: E0805 22:19:22.396377 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:23.404760 kubelet[1886]: E0805 22:19:23.404662 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:24.411903 kubelet[1886]: E0805 22:19:24.411817 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:25.413163 kubelet[1886]: E0805 22:19:25.412989 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:26.413266 kubelet[1886]: E0805 22:19:26.413181 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:27.415389 kubelet[1886]: E0805 22:19:27.415300 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:28.416356 kubelet[1886]: E0805 22:19:28.416308 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:29.967688 kubelet[1886]: E0805 22:19:29.967631 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:30.908330 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1698264621.mount: Deactivated successfully. Aug 5 22:19:30.974667 kubelet[1886]: E0805 22:19:30.974599 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:31.976848 kubelet[1886]: E0805 22:19:31.976646 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:32.993781 kubelet[1886]: E0805 22:19:32.991992 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:33.993573 kubelet[1886]: E0805 22:19:33.992754 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:34.994807 kubelet[1886]: E0805 22:19:34.994609 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:35.995645 kubelet[1886]: E0805 22:19:35.995573 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:37.012553 kubelet[1886]: E0805 22:19:37.012491 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:38.017450 kubelet[1886]: E0805 22:19:38.013664 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:39.003160 containerd[1585]: time="2024-08-05T22:19:39.003070694Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:39.008092 containerd[1585]: time="2024-08-05T22:19:39.006470562Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=70974994" Aug 5 22:19:39.008761 containerd[1585]: time="2024-08-05T22:19:39.008579685Z" level=info msg="ImageCreate event name:\"sha256:fcb81a1d00e70f650105e1b8ddc093ad0164f1dd64114e5b38c184d6c75a8bc0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:39.014772 kubelet[1886]: E0805 22:19:39.014245 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:39.017018 containerd[1585]: time="2024-08-05T22:19:39.016852460Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:57fce0d39ce5904a8ade9fc245b9e6ebca359113d98cf0b850f93b66294bcc36\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:19:39.022300 containerd[1585]: time="2024-08-05T22:19:39.022020520Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fcb81a1d00e70f650105e1b8ddc093ad0164f1dd64114e5b38c184d6c75a8bc0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:57fce0d39ce5904a8ade9fc245b9e6ebca359113d98cf0b850f93b66294bcc36\", size \"70974872\" in 19.94821228s" Aug 5 22:19:39.022300 containerd[1585]: time="2024-08-05T22:19:39.022108937Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fcb81a1d00e70f650105e1b8ddc093ad0164f1dd64114e5b38c184d6c75a8bc0\"" Aug 5 22:19:39.036241 containerd[1585]: time="2024-08-05T22:19:39.036188843Z" level=info msg="CreateContainer within sandbox \"7701f5b11ce3f9e58c3d1acdb6efa74cee83efe3cca75c1292049c6f4180d548\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Aug 5 22:19:39.119637 containerd[1585]: time="2024-08-05T22:19:39.119395728Z" level=info msg="CreateContainer within sandbox \"7701f5b11ce3f9e58c3d1acdb6efa74cee83efe3cca75c1292049c6f4180d548\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"7d057dd913a5ceed9942c13f2620198ce3ba68f94226e88fd31e81d018906f38\"" Aug 5 22:19:39.123854 containerd[1585]: time="2024-08-05T22:19:39.122471659Z" level=info msg="StartContainer for \"7d057dd913a5ceed9942c13f2620198ce3ba68f94226e88fd31e81d018906f38\"" Aug 5 22:19:39.356117 containerd[1585]: time="2024-08-05T22:19:39.354173676Z" level=info msg="StartContainer for \"7d057dd913a5ceed9942c13f2620198ce3ba68f94226e88fd31e81d018906f38\" returns successfully" Aug 5 22:19:40.014898 kubelet[1886]: E0805 22:19:40.014659 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:41.015264 kubelet[1886]: E0805 22:19:41.015174 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:41.615374 kubelet[1886]: E0805 22:19:41.611109 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:42.017021 kubelet[1886]: E0805 22:19:42.016366 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:43.019006 kubelet[1886]: E0805 22:19:43.017742 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:44.019706 kubelet[1886]: E0805 22:19:44.019549 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:45.020152 kubelet[1886]: E0805 22:19:45.019948 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:46.020291 kubelet[1886]: E0805 22:19:46.020202 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:47.021285 kubelet[1886]: E0805 22:19:47.021133 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:47.249159 kubelet[1886]: I0805 22:19:47.246851 1886 pod_startup_latency_tracker.go:102] "Observed pod startup duration" pod="default/nginx-deployment-6d5f899847-w28fn" podStartSLOduration=11.295138296 podCreationTimestamp="2024-08-05 22:19:16 +0000 UTC" firstStartedPulling="2024-08-05 22:19:19.073273782 +0000 UTC m=+40.122259211" lastFinishedPulling="2024-08-05 22:19:39.024935057 +0000 UTC m=+60.073920486" observedRunningTime="2024-08-05 22:19:39.417190464 +0000 UTC m=+60.466175894" watchObservedRunningTime="2024-08-05 22:19:47.246799571 +0000 UTC m=+68.295785000" Aug 5 22:19:47.249159 kubelet[1886]: I0805 22:19:47.246998 1886 topology_manager.go:215] "Topology Admit Handler" podUID="0f47b0b5-680b-4563-9db3-a229eb7ebf0b" podNamespace="default" podName="nfs-server-provisioner-0" Aug 5 22:19:47.277455 kubelet[1886]: I0805 22:19:47.276311 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-fq24p\" (UniqueName: \"kubernetes.io/projected/0f47b0b5-680b-4563-9db3-a229eb7ebf0b-kube-api-access-fq24p\") pod \"nfs-server-provisioner-0\" (UID: \"0f47b0b5-680b-4563-9db3-a229eb7ebf0b\") " pod="default/nfs-server-provisioner-0" Aug 5 22:19:47.277455 kubelet[1886]: I0805 22:19:47.276401 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/0f47b0b5-680b-4563-9db3-a229eb7ebf0b-data\") pod \"nfs-server-provisioner-0\" (UID: \"0f47b0b5-680b-4563-9db3-a229eb7ebf0b\") " pod="default/nfs-server-provisioner-0" Aug 5 22:19:47.579792 containerd[1585]: time="2024-08-05T22:19:47.579481180Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:0f47b0b5-680b-4563-9db3-a229eb7ebf0b,Namespace:default,Attempt:0,}" Aug 5 22:19:47.691214 systemd-networkd[1242]: veth471abac1: Link UP Aug 5 22:19:47.697214 kernel: cni0: port 2(veth471abac1) entered blocking state Aug 5 22:19:47.697340 kernel: cni0: port 2(veth471abac1) entered disabled state Aug 5 22:19:47.697368 kernel: veth471abac1: entered allmulticast mode Aug 5 22:19:47.702324 kernel: veth471abac1: entered promiscuous mode Aug 5 22:19:47.724537 kernel: cni0: port 2(veth471abac1) entered blocking state Aug 5 22:19:47.724645 kernel: cni0: port 2(veth471abac1) entered forwarding state Aug 5 22:19:47.723629 systemd-networkd[1242]: veth471abac1: Gained carrier Aug 5 22:19:47.739171 containerd[1585]: 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)(0xc000018938), "name":"cbr0", "type":"bridge"} Aug 5 22:19:47.739171 containerd[1585]: delegateAdd: netconf sent to delegate plugin: Aug 5 22:19:47.828875 containerd[1585]: {"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="2024-08-05T22:19:47.828512004Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:19:47.828875 containerd[1585]: time="2024-08-05T22:19:47.828593978Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:19:47.828875 containerd[1585]: time="2024-08-05T22:19:47.828620148Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:19:47.828875 containerd[1585]: time="2024-08-05T22:19:47.828637020Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:19:48.021410 kubelet[1886]: E0805 22:19:48.021346 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:48.464960 systemd-resolved[1464]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:19:48.570908 containerd[1585]: time="2024-08-05T22:19:48.570791419Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:0f47b0b5-680b-4563-9db3-a229eb7ebf0b,Namespace:default,Attempt:0,} returns sandbox id \"bc7f7c7d6b199914623da735478808ac435753d882ee4ef71afb31020eece599\"" Aug 5 22:19:48.605338 containerd[1585]: time="2024-08-05T22:19:48.605263927Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Aug 5 22:19:49.022181 kubelet[1886]: E0805 22:19:49.021964 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:49.343579 systemd-networkd[1242]: veth471abac1: Gained IPv6LL Aug 5 22:19:50.119193 kubelet[1886]: E0805 22:19:50.117072 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:51.118081 kubelet[1886]: E0805 22:19:51.117926 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:52.118220 kubelet[1886]: E0805 22:19:52.118165 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:53.122414 kubelet[1886]: E0805 22:19:53.122367 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:54.134594 kubelet[1886]: E0805 22:19:54.134541 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:55.135775 kubelet[1886]: E0805 22:19:55.135705 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:56.136979 kubelet[1886]: E0805 22:19:56.136907 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:57.137850 kubelet[1886]: E0805 22:19:57.137736 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:58.139332 kubelet[1886]: E0805 22:19:58.138019 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:59.139250 kubelet[1886]: E0805 22:19:59.139158 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:19:59.211770 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1442038681.mount: Deactivated successfully. Aug 5 22:20:00.141315 kubelet[1886]: E0805 22:20:00.141247 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:01.142793 kubelet[1886]: E0805 22:20:01.142688 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:01.611161 kubelet[1886]: E0805 22:20:01.611090 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:02.144619 kubelet[1886]: E0805 22:20:02.144541 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:03.150994 kubelet[1886]: E0805 22:20:03.150927 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:04.152571 kubelet[1886]: E0805 22:20:04.152480 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:05.153185 kubelet[1886]: E0805 22:20:05.152878 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:05.526915 kubelet[1886]: E0805 22:20:05.526857 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:20:06.157082 kubelet[1886]: E0805 22:20:06.153326 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:07.154081 kubelet[1886]: E0805 22:20:07.153816 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:08.154427 kubelet[1886]: E0805 22:20:08.154333 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:09.156701 kubelet[1886]: E0805 22:20:09.156650 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:10.158739 kubelet[1886]: E0805 22:20:10.158620 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:11.131070 containerd[1585]: time="2024-08-05T22:20:11.129513133Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:20:11.131070 containerd[1585]: time="2024-08-05T22:20:11.129587535Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039406" Aug 5 22:20:11.141810 containerd[1585]: time="2024-08-05T22:20:11.141055707Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:20:11.160554 kubelet[1886]: E0805 22:20:11.160137 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:11.162298 containerd[1585]: time="2024-08-05T22:20:11.162210315Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:20:11.171194 containerd[1585]: time="2024-08-05T22:20:11.166114920Z" level=info msg="Pulled image \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" with image id \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\", repo tag \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\", repo digest \"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\", size \"91036984\" in 22.560697751s" Aug 5 22:20:11.171194 containerd[1585]: time="2024-08-05T22:20:11.168559608Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Aug 5 22:20:11.180524 containerd[1585]: time="2024-08-05T22:20:11.180209339Z" level=info msg="CreateContainer within sandbox \"bc7f7c7d6b199914623da735478808ac435753d882ee4ef71afb31020eece599\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Aug 5 22:20:11.231841 containerd[1585]: time="2024-08-05T22:20:11.230995417Z" level=info msg="CreateContainer within sandbox \"bc7f7c7d6b199914623da735478808ac435753d882ee4ef71afb31020eece599\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"973a9534c8c51b5e36b3f1c5d6715e6341572354fe858b80ef36d701a4e99ca1\"" Aug 5 22:20:11.234107 containerd[1585]: time="2024-08-05T22:20:11.232348217Z" level=info msg="StartContainer for \"973a9534c8c51b5e36b3f1c5d6715e6341572354fe858b80ef36d701a4e99ca1\"" Aug 5 22:20:11.566601 containerd[1585]: time="2024-08-05T22:20:11.566417332Z" level=info msg="StartContainer for \"973a9534c8c51b5e36b3f1c5d6715e6341572354fe858b80ef36d701a4e99ca1\" returns successfully" Aug 5 22:20:12.008526 kubelet[1886]: I0805 22:20:12.006218 1886 pod_startup_latency_tracker.go:102] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=2.435838874 podCreationTimestamp="2024-08-05 22:19:47 +0000 UTC" firstStartedPulling="2024-08-05 22:19:48.604009974 +0000 UTC m=+69.652995403" lastFinishedPulling="2024-08-05 22:20:11.174338545 +0000 UTC m=+92.223323974" observedRunningTime="2024-08-05 22:20:12.006063555 +0000 UTC m=+93.055048984" watchObservedRunningTime="2024-08-05 22:20:12.006167445 +0000 UTC m=+93.055152884" Aug 5 22:20:12.161427 kubelet[1886]: E0805 22:20:12.161365 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:13.162318 kubelet[1886]: E0805 22:20:13.162158 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:14.162982 kubelet[1886]: E0805 22:20:14.162884 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:15.165748 kubelet[1886]: E0805 22:20:15.165175 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:16.166340 kubelet[1886]: E0805 22:20:16.166180 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:17.167463 kubelet[1886]: E0805 22:20:17.167390 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:18.167751 kubelet[1886]: E0805 22:20:18.167659 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:19.168737 kubelet[1886]: E0805 22:20:19.168614 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:20.169201 kubelet[1886]: E0805 22:20:20.169051 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:21.169905 kubelet[1886]: E0805 22:20:21.169617 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:21.611597 kubelet[1886]: E0805 22:20:21.611013 1886 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:22.170949 kubelet[1886]: E0805 22:20:22.170820 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:22.449623 kubelet[1886]: I0805 22:20:22.446077 1886 topology_manager.go:215] "Topology Admit Handler" podUID="0ce86643-873c-4dd5-9151-c5408ebaf659" podNamespace="default" podName="test-pod-1" Aug 5 22:20:22.630230 kubelet[1886]: I0805 22:20:22.622559 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-s59n8\" (UniqueName: \"kubernetes.io/projected/0ce86643-873c-4dd5-9151-c5408ebaf659-kube-api-access-s59n8\") pod \"test-pod-1\" (UID: \"0ce86643-873c-4dd5-9151-c5408ebaf659\") " pod="default/test-pod-1" Aug 5 22:20:22.630230 kubelet[1886]: I0805 22:20:22.626808 1886 reconciler_common.go:258] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-ebe97348-0df6-4310-836f-093280889b64\" (UniqueName: \"kubernetes.io/nfs/0ce86643-873c-4dd5-9151-c5408ebaf659-pvc-ebe97348-0df6-4310-836f-093280889b64\") pod \"test-pod-1\" (UID: \"0ce86643-873c-4dd5-9151-c5408ebaf659\") " pod="default/test-pod-1" Aug 5 22:20:22.912970 kernel: FS-Cache: Loaded Aug 5 22:20:23.137300 kernel: RPC: Registered named UNIX socket transport module. Aug 5 22:20:23.137454 kernel: RPC: Registered udp transport module. Aug 5 22:20:23.137483 kernel: RPC: Registered tcp transport module. Aug 5 22:20:23.137509 kernel: RPC: Registered tcp-with-tls transport module. Aug 5 22:20:23.137527 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Aug 5 22:20:23.175667 kubelet[1886]: E0805 22:20:23.174412 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:23.739587 kernel: NFS: Registering the id_resolver key type Aug 5 22:20:23.739741 kernel: Key type id_resolver registered Aug 5 22:20:23.739794 kernel: Key type id_legacy registered Aug 5 22:20:23.840164 nfsidmap[3106]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 5 22:20:23.853365 nfsidmap[3109]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'localdomain' Aug 5 22:20:23.977427 containerd[1585]: time="2024-08-05T22:20:23.963920738Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0ce86643-873c-4dd5-9151-c5408ebaf659,Namespace:default,Attempt:0,}" Aug 5 22:20:24.070596 systemd-networkd[1242]: vetha1122440: Link UP Aug 5 22:20:24.074173 kernel: cni0: port 3(vetha1122440) entered blocking state Aug 5 22:20:24.074277 kernel: cni0: port 3(vetha1122440) entered disabled state Aug 5 22:20:24.074306 kernel: vetha1122440: entered allmulticast mode Aug 5 22:20:24.076646 kernel: vetha1122440: entered promiscuous mode Aug 5 22:20:24.101406 kernel: cni0: port 3(vetha1122440) entered blocking state Aug 5 22:20:24.101514 kernel: cni0: port 3(vetha1122440) entered forwarding state Aug 5 22:20:24.101934 systemd-networkd[1242]: vetha1122440: Gained carrier Aug 5 22:20:24.116706 containerd[1585]: 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)(0xc00001c938), "name":"cbr0", "type":"bridge"} Aug 5 22:20:24.116706 containerd[1585]: delegateAdd: netconf sent to delegate plugin: Aug 5 22:20:24.175608 kubelet[1886]: E0805 22:20:24.175491 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:24.194526 containerd[1585]: {"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="2024-08-05T22:20:24.191568858Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:20:24.194526 containerd[1585]: time="2024-08-05T22:20:24.193938489Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:20:24.194526 containerd[1585]: time="2024-08-05T22:20:24.194213495Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:20:24.194526 containerd[1585]: time="2024-08-05T22:20:24.194231749Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:20:24.269372 systemd-resolved[1464]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:20:24.394612 containerd[1585]: time="2024-08-05T22:20:24.391815098Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:0ce86643-873c-4dd5-9151-c5408ebaf659,Namespace:default,Attempt:0,} returns sandbox id \"a088c0153d4355426a2ebc58d29bf3838efa04969c386f947b9c474dc3256f54\"" Aug 5 22:20:24.407143 containerd[1585]: time="2024-08-05T22:20:24.405901793Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Aug 5 22:20:24.901332 containerd[1585]: time="2024-08-05T22:20:24.898773359Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Aug 5 22:20:24.914787 containerd[1585]: time="2024-08-05T22:20:24.910936564Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Aug 5 22:20:24.929967 containerd[1585]: time="2024-08-05T22:20:24.917122189Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:fcb81a1d00e70f650105e1b8ddc093ad0164f1dd64114e5b38c184d6c75a8bc0\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:57fce0d39ce5904a8ade9fc245b9e6ebca359113d98cf0b850f93b66294bcc36\", size \"70974872\" in 511.064089ms" Aug 5 22:20:24.929967 containerd[1585]: time="2024-08-05T22:20:24.922257941Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:fcb81a1d00e70f650105e1b8ddc093ad0164f1dd64114e5b38c184d6c75a8bc0\"" Aug 5 22:20:24.935667 containerd[1585]: time="2024-08-05T22:20:24.933942691Z" level=info msg="CreateContainer within sandbox \"a088c0153d4355426a2ebc58d29bf3838efa04969c386f947b9c474dc3256f54\" for container &ContainerMetadata{Name:test,Attempt:0,}" Aug 5 22:20:25.054790 containerd[1585]: time="2024-08-05T22:20:25.054427332Z" level=info msg="CreateContainer within sandbox \"a088c0153d4355426a2ebc58d29bf3838efa04969c386f947b9c474dc3256f54\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"6f2c80f3a67603830c83c7612a6d0ab9f35f317db28fa203c8d3f2a275701ff5\"" Aug 5 22:20:25.067495 containerd[1585]: time="2024-08-05T22:20:25.065584857Z" level=info msg="StartContainer for \"6f2c80f3a67603830c83c7612a6d0ab9f35f317db28fa203c8d3f2a275701ff5\"" Aug 5 22:20:25.177951 kubelet[1886]: E0805 22:20:25.177087 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:25.327170 containerd[1585]: time="2024-08-05T22:20:25.314225806Z" level=info msg="StartContainer for \"6f2c80f3a67603830c83c7612a6d0ab9f35f317db28fa203c8d3f2a275701ff5\" returns successfully" Aug 5 22:20:25.879728 systemd[1]: run-containerd-runc-k8s.io-6f2c80f3a67603830c83c7612a6d0ab9f35f317db28fa203c8d3f2a275701ff5-runc.1CG30h.mount: Deactivated successfully. Aug 5 22:20:26.077181 systemd-networkd[1242]: vetha1122440: Gained IPv6LL Aug 5 22:20:26.178399 kubelet[1886]: E0805 22:20:26.178203 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:27.180913 kubelet[1886]: E0805 22:20:27.180773 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:28.181758 kubelet[1886]: E0805 22:20:28.181635 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:29.182829 kubelet[1886]: E0805 22:20:29.182729 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:29.522458 kubelet[1886]: E0805 22:20:29.521748 1886 dns.go:153] "Nameserver limits exceeded" err="Nameserver limits were exceeded, some nameservers have been omitted, the applied nameserver line is: 1.1.1.1 1.0.0.1 8.8.8.8" Aug 5 22:20:30.183622 kubelet[1886]: E0805 22:20:30.183441 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:31.186088 kubelet[1886]: E0805 22:20:31.185272 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:32.187012 kubelet[1886]: E0805 22:20:32.186846 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Aug 5 22:20:33.188248 kubelet[1886]: E0805 22:20:33.188120 1886 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"