Jan 20 01:23:18.028892 kernel: Linux version 6.6.119-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT_DYNAMIC Mon Jan 19 22:42:14 -00 2026 Jan 20 01:23:18.028927 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=8c5dc1cd4dcc734d9dabe08efcaa33dd0d0e79b2d8f11a958a4b004e775e3441 Jan 20 01:23:18.028942 kernel: BIOS-provided physical RAM map: Jan 20 01:23:18.028957 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jan 20 01:23:18.028967 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jan 20 01:23:18.028978 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jan 20 01:23:18.028990 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdbfff] usable Jan 20 01:23:18.029000 kernel: BIOS-e820: [mem 0x000000007ffdc000-0x000000007fffffff] reserved Jan 20 01:23:18.029010 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Jan 20 01:23:18.029021 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Jan 20 01:23:18.029031 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jan 20 01:23:18.029041 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jan 20 01:23:18.029057 kernel: NX (Execute Disable) protection: active Jan 20 01:23:18.029067 kernel: APIC: Static calls initialized Jan 20 01:23:18.029080 kernel: SMBIOS 2.8 present. Jan 20 01:23:18.029092 kernel: DMI: Red Hat KVM/RHEL-AV, BIOS 1.13.0-2.module_el8.5.0+2608+72063365 04/01/2014 Jan 20 01:23:18.029123 kernel: Hypervisor detected: KVM Jan 20 01:23:18.029142 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jan 20 01:23:18.029154 kernel: kvm-clock: using sched offset of 4468337953 cycles Jan 20 01:23:18.029166 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jan 20 01:23:18.029178 kernel: tsc: Detected 2500.032 MHz processor Jan 20 01:23:18.029190 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jan 20 01:23:18.029201 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jan 20 01:23:18.029213 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Jan 20 01:23:18.029224 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Jan 20 01:23:18.029236 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Jan 20 01:23:18.029252 kernel: Using GB pages for direct mapping Jan 20 01:23:18.029264 kernel: ACPI: Early table checksum verification disabled Jan 20 01:23:18.029275 kernel: ACPI: RSDP 0x00000000000F5AA0 000014 (v00 BOCHS ) Jan 20 01:23:18.029287 kernel: ACPI: RSDT 0x000000007FFE47A5 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029299 kernel: ACPI: FACP 0x000000007FFE438D 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029311 kernel: ACPI: DSDT 0x000000007FFDFD80 00460D (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029322 kernel: ACPI: FACS 0x000000007FFDFD40 000040 Jan 20 01:23:18.029334 kernel: ACPI: APIC 0x000000007FFE4481 0000F0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029345 kernel: ACPI: SRAT 0x000000007FFE4571 0001D0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029361 kernel: ACPI: MCFG 0x000000007FFE4741 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029373 kernel: ACPI: WAET 0x000000007FFE477D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Jan 20 01:23:18.029385 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe438d-0x7ffe4480] Jan 20 01:23:18.029396 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffdfd80-0x7ffe438c] Jan 20 01:23:18.029408 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffdfd40-0x7ffdfd7f] Jan 20 01:23:18.029426 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe4481-0x7ffe4570] Jan 20 01:23:18.029438 kernel: ACPI: Reserving SRAT table memory at [mem 0x7ffe4571-0x7ffe4740] Jan 20 01:23:18.029454 kernel: ACPI: Reserving MCFG table memory at [mem 0x7ffe4741-0x7ffe477c] Jan 20 01:23:18.029467 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe477d-0x7ffe47a4] Jan 20 01:23:18.029478 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Jan 20 01:23:18.029491 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Jan 20 01:23:18.029502 kernel: SRAT: PXM 0 -> APIC 0x02 -> Node 0 Jan 20 01:23:18.029514 kernel: SRAT: PXM 0 -> APIC 0x03 -> Node 0 Jan 20 01:23:18.029526 kernel: SRAT: PXM 0 -> APIC 0x04 -> Node 0 Jan 20 01:23:18.029543 kernel: SRAT: PXM 0 -> APIC 0x05 -> Node 0 Jan 20 01:23:18.029555 kernel: SRAT: PXM 0 -> APIC 0x06 -> Node 0 Jan 20 01:23:18.029567 kernel: SRAT: PXM 0 -> APIC 0x07 -> Node 0 Jan 20 01:23:18.029579 kernel: SRAT: PXM 0 -> APIC 0x08 -> Node 0 Jan 20 01:23:18.029590 kernel: SRAT: PXM 0 -> APIC 0x09 -> Node 0 Jan 20 01:23:18.029602 kernel: SRAT: PXM 0 -> APIC 0x0a -> Node 0 Jan 20 01:23:18.029614 kernel: SRAT: PXM 0 -> APIC 0x0b -> Node 0 Jan 20 01:23:18.029637 kernel: SRAT: PXM 0 -> APIC 0x0c -> Node 0 Jan 20 01:23:18.029650 kernel: SRAT: PXM 0 -> APIC 0x0d -> Node 0 Jan 20 01:23:18.029662 kernel: SRAT: PXM 0 -> APIC 0x0e -> Node 0 Jan 20 01:23:18.029679 kernel: SRAT: PXM 0 -> APIC 0x0f -> Node 0 Jan 20 01:23:18.029691 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Jan 20 01:23:18.029703 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0x7fffffff] Jan 20 01:23:18.029715 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x20800fffff] hotplug Jan 20 01:23:18.029728 kernel: NUMA: Node 0 [mem 0x00000000-0x0009ffff] + [mem 0x00100000-0x7ffdbfff] -> [mem 0x00000000-0x7ffdbfff] Jan 20 01:23:18.029740 kernel: NODE_DATA(0) allocated [mem 0x7ffd6000-0x7ffdbfff] Jan 20 01:23:18.029752 kernel: Zone ranges: Jan 20 01:23:18.029764 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jan 20 01:23:18.029776 kernel: DMA32 [mem 0x0000000001000000-0x000000007ffdbfff] Jan 20 01:23:18.029792 kernel: Normal empty Jan 20 01:23:18.029805 kernel: Movable zone start for each node Jan 20 01:23:18.029817 kernel: Early memory node ranges Jan 20 01:23:18.029829 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jan 20 01:23:18.029841 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdbfff] Jan 20 01:23:18.029853 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdbfff] Jan 20 01:23:18.029865 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Jan 20 01:23:18.029877 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Jan 20 01:23:18.029889 kernel: On node 0, zone DMA32: 36 pages in unavailable ranges Jan 20 01:23:18.029901 kernel: ACPI: PM-Timer IO Port: 0x608 Jan 20 01:23:18.029918 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jan 20 01:23:18.029930 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jan 20 01:23:18.029942 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jan 20 01:23:18.029954 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jan 20 01:23:18.029966 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jan 20 01:23:18.029978 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jan 20 01:23:18.029990 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jan 20 01:23:18.030002 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Jan 20 01:23:18.030014 kernel: TSC deadline timer available Jan 20 01:23:18.030031 kernel: smpboot: Allowing 16 CPUs, 14 hotplug CPUs Jan 20 01:23:18.030043 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Jan 20 01:23:18.030056 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Jan 20 01:23:18.030068 kernel: Booting paravirtualized kernel on KVM Jan 20 01:23:18.030080 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Jan 20 01:23:18.030092 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:16 nr_cpu_ids:16 nr_node_ids:1 Jan 20 01:23:18.030123 kernel: percpu: Embedded 57 pages/cpu s196328 r8192 d28952 u262144 Jan 20 01:23:18.030148 kernel: pcpu-alloc: s196328 r8192 d28952 u262144 alloc=1*2097152 Jan 20 01:23:18.030160 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Jan 20 01:23:18.030182 kernel: kvm-guest: PV spinlocks enabled Jan 20 01:23:18.030194 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Jan 20 01:23:18.030207 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=8c5dc1cd4dcc734d9dabe08efcaa33dd0d0e79b2d8f11a958a4b004e775e3441 Jan 20 01:23:18.030220 kernel: random: crng init done Jan 20 01:23:18.030231 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jan 20 01:23:18.030244 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Jan 20 01:23:18.030256 kernel: Fallback order for Node 0: 0 Jan 20 01:23:18.030268 kernel: Built 1 zonelists, mobility grouping on. Total pages: 515804 Jan 20 01:23:18.030296 kernel: Policy zone: DMA32 Jan 20 01:23:18.030309 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jan 20 01:23:18.030321 kernel: software IO TLB: area num 16. Jan 20 01:23:18.030333 kernel: Memory: 1901588K/2096616K available (12288K kernel code, 2288K rwdata, 22752K rodata, 42880K init, 2316K bss, 194768K reserved, 0K cma-reserved) Jan 20 01:23:18.030345 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1 Jan 20 01:23:18.030357 kernel: Kernel/User page tables isolation: enabled Jan 20 01:23:18.030369 kernel: ftrace: allocating 37989 entries in 149 pages Jan 20 01:23:18.030381 kernel: ftrace: allocated 149 pages with 4 groups Jan 20 01:23:18.030393 kernel: Dynamic Preempt: voluntary Jan 20 01:23:18.030410 kernel: rcu: Preemptible hierarchical RCU implementation. Jan 20 01:23:18.030431 kernel: rcu: RCU event tracing is enabled. Jan 20 01:23:18.030444 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=16. Jan 20 01:23:18.030456 kernel: Trampoline variant of Tasks RCU enabled. Jan 20 01:23:18.030468 kernel: Rude variant of Tasks RCU enabled. Jan 20 01:23:18.030501 kernel: Tracing variant of Tasks RCU enabled. Jan 20 01:23:18.030519 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jan 20 01:23:18.030532 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16 Jan 20 01:23:18.030544 kernel: NR_IRQS: 33024, nr_irqs: 552, preallocated irqs: 16 Jan 20 01:23:18.030557 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jan 20 01:23:18.030569 kernel: Console: colour VGA+ 80x25 Jan 20 01:23:18.030582 kernel: printk: console [tty0] enabled Jan 20 01:23:18.030599 kernel: printk: console [ttyS0] enabled Jan 20 01:23:18.030615 kernel: ACPI: Core revision 20230628 Jan 20 01:23:18.030637 kernel: APIC: Switch to symmetric I/O mode setup Jan 20 01:23:18.030651 kernel: x2apic enabled Jan 20 01:23:18.030663 kernel: APIC: Switched APIC routing to: physical x2apic Jan 20 01:23:18.030682 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x240957bf147, max_idle_ns: 440795216753 ns Jan 20 01:23:18.030695 kernel: Calibrating delay loop (skipped) preset value.. 5000.06 BogoMIPS (lpj=2500032) Jan 20 01:23:18.030708 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Jan 20 01:23:18.030720 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jan 20 01:23:18.030733 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jan 20 01:23:18.030745 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Jan 20 01:23:18.030758 kernel: Spectre V2 : Mitigation: Retpolines Jan 20 01:23:18.030770 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Jan 20 01:23:18.030783 kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Jan 20 01:23:18.030795 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Jan 20 01:23:18.030813 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Jan 20 01:23:18.030825 kernel: MDS: Mitigation: Clear CPU buffers Jan 20 01:23:18.030838 kernel: MMIO Stale Data: Unknown: No mitigations Jan 20 01:23:18.030850 kernel: SRBDS: Unknown: Dependent on hypervisor status Jan 20 01:23:18.030863 kernel: active return thunk: its_return_thunk Jan 20 01:23:18.030875 kernel: ITS: Mitigation: Aligned branch/return thunks Jan 20 01:23:18.030888 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jan 20 01:23:18.030901 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jan 20 01:23:18.030925 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jan 20 01:23:18.030937 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jan 20 01:23:18.030949 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Jan 20 01:23:18.030966 kernel: Freeing SMP alternatives memory: 32K Jan 20 01:23:18.030978 kernel: pid_max: default: 32768 minimum: 301 Jan 20 01:23:18.030999 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Jan 20 01:23:18.031012 kernel: landlock: Up and running. Jan 20 01:23:18.031023 kernel: SELinux: Initializing. Jan 20 01:23:18.031036 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jan 20 01:23:18.031048 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Jan 20 01:23:18.031060 kernel: smpboot: CPU0: Intel Xeon E3-12xx v2 (Ivy Bridge, IBRS) (family: 0x6, model: 0x3a, stepping: 0x9) Jan 20 01:23:18.031072 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Jan 20 01:23:18.031096 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Jan 20 01:23:18.031113 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Jan 20 01:23:18.031137 kernel: Performance Events: unsupported p6 CPU model 58 no PMU driver, software events only. Jan 20 01:23:18.031150 kernel: signal: max sigframe size: 1776 Jan 20 01:23:18.031162 kernel: rcu: Hierarchical SRCU implementation. Jan 20 01:23:18.031174 kernel: rcu: Max phase no-delay instances is 400. Jan 20 01:23:18.031186 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Jan 20 01:23:18.031198 kernel: smp: Bringing up secondary CPUs ... Jan 20 01:23:18.031210 kernel: smpboot: x86: Booting SMP configuration: Jan 20 01:23:18.031222 kernel: .... node #0, CPUs: #1 Jan 20 01:23:18.031241 kernel: smpboot: CPU 1 Converting physical 0 to logical die 1 Jan 20 01:23:18.031253 kernel: smp: Brought up 1 node, 2 CPUs Jan 20 01:23:18.031265 kernel: smpboot: Max logical packages: 16 Jan 20 01:23:18.031277 kernel: smpboot: Total of 2 processors activated (10000.12 BogoMIPS) Jan 20 01:23:18.031289 kernel: devtmpfs: initialized Jan 20 01:23:18.031301 kernel: x86/mm: Memory block size: 128MB Jan 20 01:23:18.031313 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jan 20 01:23:18.031338 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Jan 20 01:23:18.031350 kernel: pinctrl core: initialized pinctrl subsystem Jan 20 01:23:18.031367 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jan 20 01:23:18.031379 kernel: audit: initializing netlink subsys (disabled) Jan 20 01:23:18.031392 kernel: audit: type=2000 audit(1768872196.785:1): state=initialized audit_enabled=0 res=1 Jan 20 01:23:18.031404 kernel: thermal_sys: Registered thermal governor 'step_wise' Jan 20 01:23:18.031416 kernel: thermal_sys: Registered thermal governor 'user_space' Jan 20 01:23:18.031441 kernel: cpuidle: using governor menu Jan 20 01:23:18.031453 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 20 01:23:18.031466 kernel: dca service started, version 1.12.1 Jan 20 01:23:18.031479 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Jan 20 01:23:18.031496 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Jan 20 01:23:18.031509 kernel: PCI: Using configuration type 1 for base access Jan 20 01:23:18.031522 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Jan 20 01:23:18.031534 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jan 20 01:23:18.031548 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Jan 20 01:23:18.031560 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jan 20 01:23:18.031573 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Jan 20 01:23:18.031586 kernel: ACPI: Added _OSI(Module Device) Jan 20 01:23:18.031598 kernel: ACPI: Added _OSI(Processor Device) Jan 20 01:23:18.031615 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 20 01:23:18.031639 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jan 20 01:23:18.031652 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Jan 20 01:23:18.031664 kernel: ACPI: Interpreter enabled Jan 20 01:23:18.031677 kernel: ACPI: PM: (supports S0 S5) Jan 20 01:23:18.031689 kernel: ACPI: Using IOAPIC for interrupt routing Jan 20 01:23:18.031702 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jan 20 01:23:18.031714 kernel: PCI: Using E820 reservations for host bridge windows Jan 20 01:23:18.031727 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Jan 20 01:23:18.031745 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 20 01:23:18.032033 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jan 20 01:23:18.032297 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jan 20 01:23:18.032468 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jan 20 01:23:18.032487 kernel: PCI host bridge to bus 0000:00 Jan 20 01:23:18.032703 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jan 20 01:23:18.032864 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jan 20 01:23:18.033036 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jan 20 01:23:18.033221 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] Jan 20 01:23:18.033381 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jan 20 01:23:18.033552 kernel: pci_bus 0000:00: root bus resource [mem 0x20c0000000-0x28bfffffff window] Jan 20 01:23:18.033721 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 20 01:23:18.033967 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Jan 20 01:23:18.034676 kernel: pci 0000:00:01.0: [1013:00b8] type 00 class 0x030000 Jan 20 01:23:18.034860 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfa000000-0xfbffffff pref] Jan 20 01:23:18.035047 kernel: pci 0000:00:01.0: reg 0x14: [mem 0xfea50000-0xfea50fff] Jan 20 01:23:18.035237 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfea40000-0xfea4ffff pref] Jan 20 01:23:18.035416 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jan 20 01:23:18.035650 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.035828 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfea51000-0xfea51fff] Jan 20 01:23:18.036049 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.036550 kernel: pci 0000:00:02.1: reg 0x10: [mem 0xfea52000-0xfea52fff] Jan 20 01:23:18.038343 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.038512 kernel: pci 0000:00:02.2: reg 0x10: [mem 0xfea53000-0xfea53fff] Jan 20 01:23:18.038780 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.038956 kernel: pci 0000:00:02.3: reg 0x10: [mem 0xfea54000-0xfea54fff] Jan 20 01:23:18.040287 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.040470 kernel: pci 0000:00:02.4: reg 0x10: [mem 0xfea55000-0xfea55fff] Jan 20 01:23:18.040714 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.040888 kernel: pci 0000:00:02.5: reg 0x10: [mem 0xfea56000-0xfea56fff] Jan 20 01:23:18.041107 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.042553 kernel: pci 0000:00:02.6: reg 0x10: [mem 0xfea57000-0xfea57fff] Jan 20 01:23:18.042802 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 Jan 20 01:23:18.042977 kernel: pci 0000:00:02.7: reg 0x10: [mem 0xfea58000-0xfea58fff] Jan 20 01:23:18.045283 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 Jan 20 01:23:18.045459 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc0c0-0xc0df] Jan 20 01:23:18.045651 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfea59000-0xfea59fff] Jan 20 01:23:18.045827 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfd000000-0xfd003fff 64bit pref] Jan 20 01:23:18.046027 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfea00000-0xfea3ffff pref] Jan 20 01:23:18.046313 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Jan 20 01:23:18.046475 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Jan 20 01:23:18.046668 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfea5a000-0xfea5afff] Jan 20 01:23:18.046839 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfd004000-0xfd007fff 64bit pref] Jan 20 01:23:18.047044 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Jan 20 01:23:18.047253 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Jan 20 01:23:18.047451 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Jan 20 01:23:18.049202 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc0e0-0xc0ff] Jan 20 01:23:18.049435 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfea5b000-0xfea5bfff] Jan 20 01:23:18.049662 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Jan 20 01:23:18.049835 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Jan 20 01:23:18.050044 kernel: pci 0000:01:00.0: [1b36:000e] type 01 class 0x060400 Jan 20 01:23:18.051291 kernel: pci 0000:01:00.0: reg 0x10: [mem 0xfda00000-0xfda000ff 64bit] Jan 20 01:23:18.051494 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Jan 20 01:23:18.051682 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Jan 20 01:23:18.051855 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Jan 20 01:23:18.052061 kernel: pci_bus 0000:02: extended config space not accessible Jan 20 01:23:18.053358 kernel: pci 0000:02:01.0: [8086:25ab] type 00 class 0x088000 Jan 20 01:23:18.053551 kernel: pci 0000:02:01.0: reg 0x10: [mem 0xfd800000-0xfd80000f] Jan 20 01:23:18.053756 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Jan 20 01:23:18.053933 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Jan 20 01:23:18.056219 kernel: pci 0000:03:00.0: [1b36:000d] type 00 class 0x0c0330 Jan 20 01:23:18.056413 kernel: pci 0000:03:00.0: reg 0x10: [mem 0xfe800000-0xfe803fff 64bit] Jan 20 01:23:18.056593 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Jan 20 01:23:18.056780 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Jan 20 01:23:18.056950 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Jan 20 01:23:18.057200 kernel: pci 0000:04:00.0: [1af4:1044] type 00 class 0x00ff00 Jan 20 01:23:18.057407 kernel: pci 0000:04:00.0: reg 0x20: [mem 0xfca00000-0xfca03fff 64bit pref] Jan 20 01:23:18.057590 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Jan 20 01:23:18.057776 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Jan 20 01:23:18.057949 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Jan 20 01:23:18.058148 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Jan 20 01:23:18.058317 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Jan 20 01:23:18.058483 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Jan 20 01:23:18.058691 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Jan 20 01:23:18.058858 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Jan 20 01:23:18.059025 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Jan 20 01:23:18.061307 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Jan 20 01:23:18.061481 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Jan 20 01:23:18.061664 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Jan 20 01:23:18.061835 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Jan 20 01:23:18.062024 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Jan 20 01:23:18.063221 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Jan 20 01:23:18.063397 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Jan 20 01:23:18.063566 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Jan 20 01:23:18.063753 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Jan 20 01:23:18.063773 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Jan 20 01:23:18.063787 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Jan 20 01:23:18.063800 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Jan 20 01:23:18.063813 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Jan 20 01:23:18.063826 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Jan 20 01:23:18.063847 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Jan 20 01:23:18.063860 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Jan 20 01:23:18.063873 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Jan 20 01:23:18.063886 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Jan 20 01:23:18.063899 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Jan 20 01:23:18.063923 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Jan 20 01:23:18.063936 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Jan 20 01:23:18.063948 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Jan 20 01:23:18.063960 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Jan 20 01:23:18.063990 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Jan 20 01:23:18.064003 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Jan 20 01:23:18.064016 kernel: iommu: Default domain type: Translated Jan 20 01:23:18.064029 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Jan 20 01:23:18.064042 kernel: PCI: Using ACPI for IRQ routing Jan 20 01:23:18.064055 kernel: PCI: pci_cache_line_size set to 64 bytes Jan 20 01:23:18.064067 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jan 20 01:23:18.064080 kernel: e820: reserve RAM buffer [mem 0x7ffdc000-0x7fffffff] Jan 20 01:23:18.065290 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Jan 20 01:23:18.065472 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Jan 20 01:23:18.065653 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jan 20 01:23:18.065673 kernel: vgaarb: loaded Jan 20 01:23:18.065686 kernel: clocksource: Switched to clocksource kvm-clock Jan 20 01:23:18.065699 kernel: VFS: Disk quotas dquot_6.6.0 Jan 20 01:23:18.065712 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 20 01:23:18.065725 kernel: pnp: PnP ACPI init Jan 20 01:23:18.065924 kernel: system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved Jan 20 01:23:18.065953 kernel: pnp: PnP ACPI: found 5 devices Jan 20 01:23:18.065967 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jan 20 01:23:18.065980 kernel: NET: Registered PF_INET protocol family Jan 20 01:23:18.065993 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Jan 20 01:23:18.066006 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Jan 20 01:23:18.066019 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jan 20 01:23:18.066031 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Jan 20 01:23:18.066045 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Jan 20 01:23:18.066063 kernel: TCP: Hash tables configured (established 16384 bind 16384) Jan 20 01:23:18.066076 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Jan 20 01:23:18.066089 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Jan 20 01:23:18.066127 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jan 20 01:23:18.066141 kernel: NET: Registered PF_XDP protocol family Jan 20 01:23:18.066310 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01-02] add_size 1000 Jan 20 01:23:18.066479 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Jan 20 01:23:18.066661 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Jan 20 01:23:18.066840 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Jan 20 01:23:18.067009 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Jan 20 01:23:18.070213 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Jan 20 01:23:18.070386 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Jan 20 01:23:18.070554 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Jan 20 01:23:18.070741 kernel: pci 0000:00:02.0: BAR 13: assigned [io 0x1000-0x1fff] Jan 20 01:23:18.070921 kernel: pci 0000:00:02.1: BAR 13: assigned [io 0x2000-0x2fff] Jan 20 01:23:18.071089 kernel: pci 0000:00:02.2: BAR 13: assigned [io 0x3000-0x3fff] Jan 20 01:23:18.071278 kernel: pci 0000:00:02.3: BAR 13: assigned [io 0x4000-0x4fff] Jan 20 01:23:18.071449 kernel: pci 0000:00:02.4: BAR 13: assigned [io 0x5000-0x5fff] Jan 20 01:23:18.071634 kernel: pci 0000:00:02.5: BAR 13: assigned [io 0x6000-0x6fff] Jan 20 01:23:18.071810 kernel: pci 0000:00:02.6: BAR 13: assigned [io 0x7000-0x7fff] Jan 20 01:23:18.071989 kernel: pci 0000:00:02.7: BAR 13: assigned [io 0x8000-0x8fff] Jan 20 01:23:18.073235 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Jan 20 01:23:18.073443 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Jan 20 01:23:18.073616 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Jan 20 01:23:18.073799 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Jan 20 01:23:18.073968 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Jan 20 01:23:18.075190 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Jan 20 01:23:18.075365 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Jan 20 01:23:18.075532 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Jan 20 01:23:18.075739 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Jan 20 01:23:18.075908 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Jan 20 01:23:18.076084 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Jan 20 01:23:18.078289 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Jan 20 01:23:18.078459 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Jan 20 01:23:18.078651 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Jan 20 01:23:18.078821 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Jan 20 01:23:18.079007 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Jan 20 01:23:18.079188 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Jan 20 01:23:18.079369 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Jan 20 01:23:18.079539 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Jan 20 01:23:18.079724 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Jan 20 01:23:18.079894 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Jan 20 01:23:18.080075 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Jan 20 01:23:18.082388 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Jan 20 01:23:18.082597 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Jan 20 01:23:18.082938 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Jan 20 01:23:18.083153 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Jan 20 01:23:18.083329 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Jan 20 01:23:18.083518 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Jan 20 01:23:18.083716 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Jan 20 01:23:18.083902 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Jan 20 01:23:18.084076 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Jan 20 01:23:18.084273 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Jan 20 01:23:18.084456 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Jan 20 01:23:18.084647 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Jan 20 01:23:18.084818 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jan 20 01:23:18.084971 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jan 20 01:23:18.086223 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jan 20 01:23:18.086409 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] Jan 20 01:23:18.086577 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Jan 20 01:23:18.086766 kernel: pci_bus 0000:00: resource 9 [mem 0x20c0000000-0x28bfffffff window] Jan 20 01:23:18.086950 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Jan 20 01:23:18.087133 kernel: pci_bus 0000:01: resource 1 [mem 0xfd800000-0xfdbfffff] Jan 20 01:23:18.087315 kernel: pci_bus 0000:01: resource 2 [mem 0xfce00000-0xfcffffff 64bit pref] Jan 20 01:23:18.087502 kernel: pci_bus 0000:02: resource 1 [mem 0xfd800000-0xfd9fffff] Jan 20 01:23:18.087718 kernel: pci_bus 0000:03: resource 0 [io 0x2000-0x2fff] Jan 20 01:23:18.087900 kernel: pci_bus 0000:03: resource 1 [mem 0xfe800000-0xfe9fffff] Jan 20 01:23:18.088071 kernel: pci_bus 0000:03: resource 2 [mem 0xfcc00000-0xfcdfffff 64bit pref] Jan 20 01:23:18.088270 kernel: pci_bus 0000:04: resource 0 [io 0x3000-0x3fff] Jan 20 01:23:18.088434 kernel: pci_bus 0000:04: resource 1 [mem 0xfe600000-0xfe7fffff] Jan 20 01:23:18.088599 kernel: pci_bus 0000:04: resource 2 [mem 0xfca00000-0xfcbfffff 64bit pref] Jan 20 01:23:18.088804 kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Jan 20 01:23:18.088989 kernel: pci_bus 0000:05: resource 1 [mem 0xfe400000-0xfe5fffff] Jan 20 01:23:18.089192 kernel: pci_bus 0000:05: resource 2 [mem 0xfc800000-0xfc9fffff 64bit pref] Jan 20 01:23:18.089396 kernel: pci_bus 0000:06: resource 0 [io 0x5000-0x5fff] Jan 20 01:23:18.089565 kernel: pci_bus 0000:06: resource 1 [mem 0xfe200000-0xfe3fffff] Jan 20 01:23:18.089758 kernel: pci_bus 0000:06: resource 2 [mem 0xfc600000-0xfc7fffff 64bit pref] Jan 20 01:23:18.089953 kernel: pci_bus 0000:07: resource 0 [io 0x6000-0x6fff] Jan 20 01:23:18.090205 kernel: pci_bus 0000:07: resource 1 [mem 0xfe000000-0xfe1fffff] Jan 20 01:23:18.090385 kernel: pci_bus 0000:07: resource 2 [mem 0xfc400000-0xfc5fffff 64bit pref] Jan 20 01:23:18.090563 kernel: pci_bus 0000:08: resource 0 [io 0x7000-0x7fff] Jan 20 01:23:18.090736 kernel: pci_bus 0000:08: resource 1 [mem 0xfde00000-0xfdffffff] Jan 20 01:23:18.090893 kernel: pci_bus 0000:08: resource 2 [mem 0xfc200000-0xfc3fffff 64bit pref] Jan 20 01:23:18.091079 kernel: pci_bus 0000:09: resource 0 [io 0x8000-0x8fff] Jan 20 01:23:18.091308 kernel: pci_bus 0000:09: resource 1 [mem 0xfdc00000-0xfddfffff] Jan 20 01:23:18.091464 kernel: pci_bus 0000:09: resource 2 [mem 0xfc000000-0xfc1fffff 64bit pref] Jan 20 01:23:18.091491 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Jan 20 01:23:18.091506 kernel: PCI: CLS 0 bytes, default 64 Jan 20 01:23:18.091519 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jan 20 01:23:18.091533 kernel: software IO TLB: mapped [mem 0x0000000079800000-0x000000007d800000] (64MB) Jan 20 01:23:18.091546 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Jan 20 01:23:18.091560 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x240957bf147, max_idle_ns: 440795216753 ns Jan 20 01:23:18.091573 kernel: Initialise system trusted keyrings Jan 20 01:23:18.091586 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Jan 20 01:23:18.091599 kernel: Key type asymmetric registered Jan 20 01:23:18.091642 kernel: Asymmetric key parser 'x509' registered Jan 20 01:23:18.091656 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Jan 20 01:23:18.091669 kernel: io scheduler mq-deadline registered Jan 20 01:23:18.091683 kernel: io scheduler kyber registered Jan 20 01:23:18.091696 kernel: io scheduler bfq registered Jan 20 01:23:18.091867 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 24 Jan 20 01:23:18.092041 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 24 Jan 20 01:23:18.092227 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.092407 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 25 Jan 20 01:23:18.092578 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 25 Jan 20 01:23:18.092765 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.092938 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 26 Jan 20 01:23:18.093135 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 26 Jan 20 01:23:18.093307 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.093485 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 27 Jan 20 01:23:18.093669 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 27 Jan 20 01:23:18.093838 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.094010 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 28 Jan 20 01:23:18.094201 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 28 Jan 20 01:23:18.094370 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.094548 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 29 Jan 20 01:23:18.094733 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 29 Jan 20 01:23:18.094904 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.095076 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 30 Jan 20 01:23:18.095311 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 30 Jan 20 01:23:18.095513 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.095705 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 31 Jan 20 01:23:18.095873 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 31 Jan 20 01:23:18.096040 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Jan 20 01:23:18.096061 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Jan 20 01:23:18.096076 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Jan 20 01:23:18.096090 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Jan 20 01:23:18.096127 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jan 20 01:23:18.096149 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jan 20 01:23:18.096163 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jan 20 01:23:18.096181 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jan 20 01:23:18.096195 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jan 20 01:23:18.096377 kernel: rtc_cmos 00:03: RTC can wake from S4 Jan 20 01:23:18.096398 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Jan 20 01:23:18.096577 kernel: rtc_cmos 00:03: registered as rtc0 Jan 20 01:23:18.096759 kernel: rtc_cmos 00:03: setting system clock to 2026-01-20T01:23:17 UTC (1768872197) Jan 20 01:23:18.096925 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Jan 20 01:23:18.096946 kernel: intel_pstate: CPU model not supported Jan 20 01:23:18.096960 kernel: NET: Registered PF_INET6 protocol family Jan 20 01:23:18.096973 kernel: Segment Routing with IPv6 Jan 20 01:23:18.096987 kernel: In-situ OAM (IOAM) with IPv6 Jan 20 01:23:18.097000 kernel: NET: Registered PF_PACKET protocol family Jan 20 01:23:18.097014 kernel: Key type dns_resolver registered Jan 20 01:23:18.097027 kernel: IPI shorthand broadcast: enabled Jan 20 01:23:18.097049 kernel: sched_clock: Marking stable (1334013570, 235665552)->(1697187877, -127508755) Jan 20 01:23:18.097070 kernel: registered taskstats version 1 Jan 20 01:23:18.097084 kernel: Loading compiled-in X.509 certificates Jan 20 01:23:18.097097 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.119-flatcar: ea2d429b6f340e470c7de035feb011ab349763d1' Jan 20 01:23:18.097130 kernel: Key type .fscrypt registered Jan 20 01:23:18.097144 kernel: Key type fscrypt-provisioning registered Jan 20 01:23:18.097158 kernel: ima: No TPM chip found, activating TPM-bypass! Jan 20 01:23:18.097171 kernel: ima: Allocated hash algorithm: sha1 Jan 20 01:23:18.097185 kernel: ima: No architecture policies found Jan 20 01:23:18.097198 kernel: clk: Disabling unused clocks Jan 20 01:23:18.097218 kernel: Freeing unused kernel image (initmem) memory: 42880K Jan 20 01:23:18.097232 kernel: Write protecting the kernel read-only data: 36864k Jan 20 01:23:18.097246 kernel: Freeing unused kernel image (rodata/data gap) memory: 1824K Jan 20 01:23:18.097259 kernel: Run /init as init process Jan 20 01:23:18.097273 kernel: with arguments: Jan 20 01:23:18.097286 kernel: /init Jan 20 01:23:18.097299 kernel: with environment: Jan 20 01:23:18.097312 kernel: HOME=/ Jan 20 01:23:18.097326 kernel: TERM=linux Jan 20 01:23:18.097347 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 20 01:23:18.097364 systemd[1]: Detected virtualization kvm. Jan 20 01:23:18.097378 systemd[1]: Detected architecture x86-64. Jan 20 01:23:18.097392 systemd[1]: Running in initrd. Jan 20 01:23:18.097418 systemd[1]: No hostname configured, using default hostname. Jan 20 01:23:18.097431 systemd[1]: Hostname set to . Jan 20 01:23:18.097445 systemd[1]: Initializing machine ID from VM UUID. Jan 20 01:23:18.097477 systemd[1]: Queued start job for default target initrd.target. Jan 20 01:23:18.097490 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 20 01:23:18.097503 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 20 01:23:18.097517 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jan 20 01:23:18.097531 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 20 01:23:18.097544 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jan 20 01:23:18.097558 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jan 20 01:23:18.097578 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jan 20 01:23:18.097592 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jan 20 01:23:18.097606 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 20 01:23:18.097646 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 20 01:23:18.097660 systemd[1]: Reached target paths.target - Path Units. Jan 20 01:23:18.097675 systemd[1]: Reached target slices.target - Slice Units. Jan 20 01:23:18.097689 systemd[1]: Reached target swap.target - Swaps. Jan 20 01:23:18.097703 systemd[1]: Reached target timers.target - Timer Units. Jan 20 01:23:18.097723 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jan 20 01:23:18.097738 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 20 01:23:18.097753 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jan 20 01:23:18.097767 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Jan 20 01:23:18.097786 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 20 01:23:18.097801 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 20 01:23:18.097815 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 20 01:23:18.097830 systemd[1]: Reached target sockets.target - Socket Units. Jan 20 01:23:18.097844 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jan 20 01:23:18.097863 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 20 01:23:18.097878 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jan 20 01:23:18.097892 systemd[1]: Starting systemd-fsck-usr.service... Jan 20 01:23:18.097906 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 20 01:23:18.097921 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 20 01:23:18.097935 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 20 01:23:18.097991 systemd-journald[202]: Collecting audit messages is disabled. Jan 20 01:23:18.098029 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jan 20 01:23:18.098044 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 20 01:23:18.098058 systemd[1]: Finished systemd-fsck-usr.service. Jan 20 01:23:18.098078 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 20 01:23:18.098092 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jan 20 01:23:18.098144 kernel: Bridge firewalling registered Jan 20 01:23:18.098161 systemd-journald[202]: Journal started Jan 20 01:23:18.098194 systemd-journald[202]: Runtime Journal (/run/log/journal/4c0740050c3143619a7273e0b5ed7c6d) is 4.7M, max 38.0M, 33.2M free. Jan 20 01:23:18.043495 systemd-modules-load[203]: Inserted module 'overlay' Jan 20 01:23:18.085437 systemd-modules-load[203]: Inserted module 'br_netfilter' Jan 20 01:23:18.149134 systemd[1]: Started systemd-journald.service - Journal Service. Jan 20 01:23:18.150497 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 20 01:23:18.151560 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 20 01:23:18.163343 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 20 01:23:18.167269 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 20 01:23:18.180323 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 20 01:23:18.182061 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 20 01:23:18.200790 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 20 01:23:18.202383 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 20 01:23:18.203406 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 20 01:23:18.212288 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jan 20 01:23:18.221546 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 20 01:23:18.222653 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 20 01:23:18.238603 dracut-cmdline[236]: dracut-dracut-053 Jan 20 01:23:18.240241 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 20 01:23:18.244153 dracut-cmdline[236]: 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,115200n8 console=tty0 flatcar.first_boot=detected flatcar.oem.id=openstack flatcar.autologin verity.usrhash=8c5dc1cd4dcc734d9dabe08efcaa33dd0d0e79b2d8f11a958a4b004e775e3441 Jan 20 01:23:18.277265 systemd-resolved[243]: Positive Trust Anchors: Jan 20 01:23:18.277281 systemd-resolved[243]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 20 01:23:18.277326 systemd-resolved[243]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 20 01:23:18.286795 systemd-resolved[243]: Defaulting to hostname 'linux'. Jan 20 01:23:18.289573 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 20 01:23:18.290738 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 20 01:23:18.350194 kernel: SCSI subsystem initialized Jan 20 01:23:18.362204 kernel: Loading iSCSI transport class v2.0-870. Jan 20 01:23:18.375152 kernel: iscsi: registered transport (tcp) Jan 20 01:23:18.402652 kernel: iscsi: registered transport (qla4xxx) Jan 20 01:23:18.402735 kernel: QLogic iSCSI HBA Driver Jan 20 01:23:18.458583 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jan 20 01:23:18.467368 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jan 20 01:23:18.498719 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jan 20 01:23:18.498806 kernel: device-mapper: uevent: version 1.0.3 Jan 20 01:23:18.501073 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Jan 20 01:23:18.550202 kernel: raid6: sse2x4 gen() 13485 MB/s Jan 20 01:23:18.568144 kernel: raid6: sse2x2 gen() 9413 MB/s Jan 20 01:23:18.586749 kernel: raid6: sse2x1 gen() 10268 MB/s Jan 20 01:23:18.586820 kernel: raid6: using algorithm sse2x4 gen() 13485 MB/s Jan 20 01:23:18.607185 kernel: raid6: .... xor() 7602 MB/s, rmw enabled Jan 20 01:23:18.607322 kernel: raid6: using ssse3x2 recovery algorithm Jan 20 01:23:18.633143 kernel: xor: automatically using best checksumming function avx Jan 20 01:23:18.828174 kernel: Btrfs loaded, zoned=no, fsverity=no Jan 20 01:23:18.844151 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jan 20 01:23:18.851331 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 20 01:23:18.877839 systemd-udevd[422]: Using default interface naming scheme 'v255'. Jan 20 01:23:18.884946 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 20 01:23:18.892160 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jan 20 01:23:18.913931 dracut-pre-trigger[430]: rd.md=0: removing MD RAID activation Jan 20 01:23:18.953158 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jan 20 01:23:18.961303 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 20 01:23:19.070878 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 20 01:23:19.081272 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jan 20 01:23:19.114048 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jan 20 01:23:19.115875 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jan 20 01:23:19.117298 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 20 01:23:19.119328 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 20 01:23:19.126314 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jan 20 01:23:19.152632 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jan 20 01:23:19.200125 kernel: virtio_blk virtio1: 2/0/0 default/read/poll queues Jan 20 01:23:19.206281 kernel: cryptd: max_cpu_qlen set to 1000 Jan 20 01:23:19.214152 kernel: virtio_blk virtio1: [vda] 125829120 512-byte logical blocks (64.4 GB/60.0 GiB) Jan 20 01:23:19.241812 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jan 20 01:23:19.241882 kernel: GPT:17805311 != 125829119 Jan 20 01:23:19.241903 kernel: GPT:Alternate GPT header not at the end of the disk. Jan 20 01:23:19.241920 kernel: GPT:17805311 != 125829119 Jan 20 01:23:19.241948 kernel: GPT: Use GNU Parted to correct GPT errors. Jan 20 01:23:19.241966 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 20 01:23:19.248785 kernel: AVX version of gcm_enc/dec engaged. Jan 20 01:23:19.248824 kernel: AES CTR mode by8 optimization enabled Jan 20 01:23:19.255238 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 20 01:23:19.255434 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 20 01:23:19.258121 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 20 01:23:19.258862 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 20 01:23:19.259042 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 20 01:23:19.259914 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jan 20 01:23:19.265539 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 20 01:23:19.282145 kernel: ACPI: bus type USB registered Jan 20 01:23:19.285319 kernel: usbcore: registered new interface driver usbfs Jan 20 01:23:19.285354 kernel: usbcore: registered new interface driver hub Jan 20 01:23:19.287757 kernel: usbcore: registered new device driver usb Jan 20 01:23:19.326166 kernel: BTRFS: device fsid ea39c6ab-04c2-4917-8268-943d4ecb2b5c devid 1 transid 33 /dev/vda3 scanned by (udev-worker) (465) Jan 20 01:23:19.329130 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (476) Jan 20 01:23:19.358234 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Jan 20 01:23:19.399904 kernel: libata version 3.00 loaded. Jan 20 01:23:19.402016 kernel: ahci 0000:00:1f.2: version 3.0 Jan 20 01:23:19.402366 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Jan 20 01:23:19.401003 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 20 01:23:19.409165 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Jan 20 01:23:19.409406 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Jan 20 01:23:19.413365 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Jan 20 01:23:19.464237 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Jan 20 01:23:19.464522 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 1 Jan 20 01:23:19.464786 kernel: scsi host0: ahci Jan 20 01:23:19.465010 kernel: xhci_hcd 0000:03:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Jan 20 01:23:19.465268 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Jan 20 01:23:19.465478 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 2 Jan 20 01:23:19.465700 kernel: xhci_hcd 0000:03:00.0: Host supports USB 3.0 SuperSpeed Jan 20 01:23:19.465903 kernel: hub 1-0:1.0: USB hub found Jan 20 01:23:19.466177 kernel: hub 1-0:1.0: 4 ports detected Jan 20 01:23:19.466402 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Jan 20 01:23:19.466722 kernel: hub 2-0:1.0: USB hub found Jan 20 01:23:19.466998 kernel: hub 2-0:1.0: 4 ports detected Jan 20 01:23:19.467267 kernel: scsi host1: ahci Jan 20 01:23:19.467487 kernel: scsi host2: ahci Jan 20 01:23:19.467734 kernel: scsi host3: ahci Jan 20 01:23:19.467951 kernel: scsi host4: ahci Jan 20 01:23:19.468207 kernel: scsi host5: ahci Jan 20 01:23:19.468406 kernel: ata1: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b100 irq 38 Jan 20 01:23:19.468427 kernel: ata2: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b180 irq 38 Jan 20 01:23:19.468444 kernel: ata3: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b200 irq 38 Jan 20 01:23:19.468469 kernel: ata4: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b280 irq 38 Jan 20 01:23:19.468487 kernel: ata5: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b300 irq 38 Jan 20 01:23:19.468504 kernel: ata6: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b380 irq 38 Jan 20 01:23:19.481966 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 20 01:23:19.488209 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Jan 20 01:23:19.489064 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Jan 20 01:23:19.498328 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jan 20 01:23:19.500673 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jan 20 01:23:19.515179 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 20 01:23:19.515394 disk-uuid[564]: Primary Header is updated. Jan 20 01:23:19.515394 disk-uuid[564]: Secondary Entries is updated. Jan 20 01:23:19.515394 disk-uuid[564]: Secondary Header is updated. Jan 20 01:23:19.540466 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 20 01:23:19.660152 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Jan 20 01:23:19.749864 kernel: ata3: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.750327 kernel: ata2: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.753432 kernel: ata4: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.755232 kernel: ata1: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.756869 kernel: ata5: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.757609 kernel: ata6: SATA link down (SStatus 0 SControl 300) Jan 20 01:23:19.802159 kernel: hid: raw HID events driver (C) Jiri Kosina Jan 20 01:23:19.809261 kernel: usbcore: registered new interface driver usbhid Jan 20 01:23:19.809329 kernel: usbhid: USB HID core driver Jan 20 01:23:19.817230 kernel: input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:02.1/0000:03:00.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2 Jan 20 01:23:19.817277 kernel: hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:03:00.0-1/input0 Jan 20 01:23:20.532794 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Jan 20 01:23:20.533610 disk-uuid[565]: The operation has completed successfully. Jan 20 01:23:20.583767 systemd[1]: disk-uuid.service: Deactivated successfully. Jan 20 01:23:20.585158 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jan 20 01:23:20.609330 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jan 20 01:23:20.627144 sh[588]: Success Jan 20 01:23:20.645325 kernel: device-mapper: verity: sha256 using implementation "sha256-avx" Jan 20 01:23:20.716607 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jan 20 01:23:20.720238 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jan 20 01:23:20.721230 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jan 20 01:23:20.749772 kernel: BTRFS info (device dm-0): first mount of filesystem ea39c6ab-04c2-4917-8268-943d4ecb2b5c Jan 20 01:23:20.749844 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Jan 20 01:23:20.753502 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Jan 20 01:23:20.753554 kernel: BTRFS info (device dm-0): disabling log replay at mount time Jan 20 01:23:20.756591 kernel: BTRFS info (device dm-0): using free space tree Jan 20 01:23:20.769073 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jan 20 01:23:20.770622 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jan 20 01:23:20.776309 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jan 20 01:23:20.780285 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jan 20 01:23:20.794144 kernel: BTRFS info (device vda6): first mount of filesystem 4d38e730-f67b-44a8-80fa-82ea4ebb2132 Jan 20 01:23:20.797858 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 20 01:23:20.797908 kernel: BTRFS info (device vda6): using free space tree Jan 20 01:23:20.803128 kernel: BTRFS info (device vda6): auto enabling async discard Jan 20 01:23:20.817577 systemd[1]: mnt-oem.mount: Deactivated successfully. Jan 20 01:23:20.820136 kernel: BTRFS info (device vda6): last unmount of filesystem 4d38e730-f67b-44a8-80fa-82ea4ebb2132 Jan 20 01:23:20.828576 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jan 20 01:23:20.835315 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jan 20 01:23:20.923031 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 20 01:23:20.933409 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 20 01:23:20.971709 systemd-networkd[771]: lo: Link UP Jan 20 01:23:20.971722 systemd-networkd[771]: lo: Gained carrier Jan 20 01:23:20.974314 systemd-networkd[771]: Enumeration completed Jan 20 01:23:20.974446 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 20 01:23:20.975187 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 20 01:23:20.975193 systemd-networkd[771]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 20 01:23:20.977130 systemd-networkd[771]: eth0: Link UP Jan 20 01:23:20.977136 systemd-networkd[771]: eth0: Gained carrier Jan 20 01:23:20.977155 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 20 01:23:20.978694 systemd[1]: Reached target network.target - Network. Jan 20 01:23:20.998064 ignition[679]: Ignition 2.19.0 Jan 20 01:23:20.998090 ignition[679]: Stage: fetch-offline Jan 20 01:23:21.000271 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jan 20 01:23:20.998203 ignition[679]: no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:20.998230 ignition[679]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:20.998404 ignition[679]: parsed url from cmdline: "" Jan 20 01:23:20.998411 ignition[679]: no config URL provided Jan 20 01:23:20.998421 ignition[679]: reading system config file "/usr/lib/ignition/user.ign" Jan 20 01:23:20.998436 ignition[679]: no config at "/usr/lib/ignition/user.ign" Jan 20 01:23:20.998445 ignition[679]: failed to fetch config: resource requires networking Jan 20 01:23:20.998942 ignition[679]: Ignition finished successfully Jan 20 01:23:21.009221 systemd-networkd[771]: eth0: DHCPv4 address 10.230.30.174/30, gateway 10.230.30.173 acquired from 10.230.30.173 Jan 20 01:23:21.010318 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jan 20 01:23:21.033661 ignition[778]: Ignition 2.19.0 Jan 20 01:23:21.033684 ignition[778]: Stage: fetch Jan 20 01:23:21.033970 ignition[778]: no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:21.033991 ignition[778]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:21.034151 ignition[778]: parsed url from cmdline: "" Jan 20 01:23:21.034158 ignition[778]: no config URL provided Jan 20 01:23:21.034168 ignition[778]: reading system config file "/usr/lib/ignition/user.ign" Jan 20 01:23:21.034185 ignition[778]: no config at "/usr/lib/ignition/user.ign" Jan 20 01:23:21.034406 ignition[778]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 Jan 20 01:23:21.035867 ignition[778]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... Jan 20 01:23:21.035908 ignition[778]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... Jan 20 01:23:21.052448 ignition[778]: GET result: OK Jan 20 01:23:21.052799 ignition[778]: parsing config with SHA512: e289376ac47d75d2db9c9b59e71643fe755653a81312730fb789b15c8f380540d9a84d4d955433e090048154aedea12fdf2c1dc24cbb44c7e114162c844e4400 Jan 20 01:23:21.058088 unknown[778]: fetched base config from "system" Jan 20 01:23:21.058148 unknown[778]: fetched base config from "system" Jan 20 01:23:21.058496 ignition[778]: fetch: fetch complete Jan 20 01:23:21.058159 unknown[778]: fetched user config from "openstack" Jan 20 01:23:21.058505 ignition[778]: fetch: fetch passed Jan 20 01:23:21.060834 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jan 20 01:23:21.058594 ignition[778]: Ignition finished successfully Jan 20 01:23:21.075388 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jan 20 01:23:21.098322 ignition[785]: Ignition 2.19.0 Jan 20 01:23:21.098344 ignition[785]: Stage: kargs Jan 20 01:23:21.098642 ignition[785]: no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:21.102210 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jan 20 01:23:21.098665 ignition[785]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:21.099898 ignition[785]: kargs: kargs passed Jan 20 01:23:21.099995 ignition[785]: Ignition finished successfully Jan 20 01:23:21.111368 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jan 20 01:23:21.133669 ignition[791]: Ignition 2.19.0 Jan 20 01:23:21.133691 ignition[791]: Stage: disks Jan 20 01:23:21.133954 ignition[791]: no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:21.136568 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jan 20 01:23:21.133974 ignition[791]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:21.138949 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jan 20 01:23:21.134962 ignition[791]: disks: disks passed Jan 20 01:23:21.140727 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jan 20 01:23:21.135035 ignition[791]: Ignition finished successfully Jan 20 01:23:21.142458 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 20 01:23:21.143895 systemd[1]: Reached target sysinit.target - System Initialization. Jan 20 01:23:21.145657 systemd[1]: Reached target basic.target - Basic System. Jan 20 01:23:21.154394 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jan 20 01:23:21.173241 systemd-fsck[799]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks Jan 20 01:23:21.177874 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jan 20 01:23:21.185305 systemd[1]: Mounting sysroot.mount - /sysroot... Jan 20 01:23:21.307150 kernel: EXT4-fs (vda9): mounted filesystem 3f4cac35-b37d-4410-a45a-1329edafa0f9 r/w with ordered data mode. Quota mode: none. Jan 20 01:23:21.308620 systemd[1]: Mounted sysroot.mount - /sysroot. Jan 20 01:23:21.310024 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jan 20 01:23:21.318283 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 20 01:23:21.322241 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jan 20 01:23:21.323380 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jan 20 01:23:21.324310 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... Jan 20 01:23:21.327509 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jan 20 01:23:21.327563 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jan 20 01:23:21.340091 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (807) Jan 20 01:23:21.340161 kernel: BTRFS info (device vda6): first mount of filesystem 4d38e730-f67b-44a8-80fa-82ea4ebb2132 Jan 20 01:23:21.342237 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 20 01:23:21.344308 kernel: BTRFS info (device vda6): using free space tree Jan 20 01:23:21.343550 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jan 20 01:23:21.354140 kernel: BTRFS info (device vda6): auto enabling async discard Jan 20 01:23:21.358578 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jan 20 01:23:21.364236 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 20 01:23:21.434785 initrd-setup-root[835]: cut: /sysroot/etc/passwd: No such file or directory Jan 20 01:23:21.444938 initrd-setup-root[842]: cut: /sysroot/etc/group: No such file or directory Jan 20 01:23:21.451498 initrd-setup-root[849]: cut: /sysroot/etc/shadow: No such file or directory Jan 20 01:23:21.458474 initrd-setup-root[856]: cut: /sysroot/etc/gshadow: No such file or directory Jan 20 01:23:21.568812 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jan 20 01:23:21.575263 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jan 20 01:23:21.578304 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jan 20 01:23:21.591162 kernel: BTRFS info (device vda6): last unmount of filesystem 4d38e730-f67b-44a8-80fa-82ea4ebb2132 Jan 20 01:23:21.622294 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jan 20 01:23:21.626213 ignition[924]: INFO : Ignition 2.19.0 Jan 20 01:23:21.628198 ignition[924]: INFO : Stage: mount Jan 20 01:23:21.628198 ignition[924]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:21.628198 ignition[924]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:21.631364 ignition[924]: INFO : mount: mount passed Jan 20 01:23:21.631364 ignition[924]: INFO : Ignition finished successfully Jan 20 01:23:21.632412 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jan 20 01:23:21.748380 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jan 20 01:23:23.008377 systemd-networkd[771]: eth0: Gained IPv6LL Jan 20 01:23:25.575714 systemd-networkd[771]: eth0: Ignoring DHCPv6 address 2a02:1348:179:87ab:24:19ff:fee6:1eae/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:87ab:24:19ff:fee6:1eae/64 assigned by NDisc. Jan 20 01:23:25.575745 systemd-networkd[771]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Jan 20 01:23:28.504726 coreos-metadata[809]: Jan 20 01:23:28.504 WARN failed to locate config-drive, using the metadata service API instead Jan 20 01:23:28.530062 coreos-metadata[809]: Jan 20 01:23:28.529 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Jan 20 01:23:28.544303 coreos-metadata[809]: Jan 20 01:23:28.544 INFO Fetch successful Jan 20 01:23:28.545235 coreos-metadata[809]: Jan 20 01:23:28.544 INFO wrote hostname srv-4lxr2.gb1.brightbox.com to /sysroot/etc/hostname Jan 20 01:23:28.546940 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. Jan 20 01:23:28.547126 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. Jan 20 01:23:28.555330 systemd[1]: Starting ignition-files.service - Ignition (files)... Jan 20 01:23:28.574363 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jan 20 01:23:28.586133 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (940) Jan 20 01:23:28.591149 kernel: BTRFS info (device vda6): first mount of filesystem 4d38e730-f67b-44a8-80fa-82ea4ebb2132 Jan 20 01:23:28.591191 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Jan 20 01:23:28.591211 kernel: BTRFS info (device vda6): using free space tree Jan 20 01:23:28.597172 kernel: BTRFS info (device vda6): auto enabling async discard Jan 20 01:23:28.599977 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jan 20 01:23:28.634705 ignition[958]: INFO : Ignition 2.19.0 Jan 20 01:23:28.634705 ignition[958]: INFO : Stage: files Jan 20 01:23:28.636541 ignition[958]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:28.636541 ignition[958]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:28.636541 ignition[958]: DEBUG : files: compiled without relabeling support, skipping Jan 20 01:23:28.639350 ignition[958]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jan 20 01:23:28.639350 ignition[958]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jan 20 01:23:28.641403 ignition[958]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jan 20 01:23:28.641403 ignition[958]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jan 20 01:23:28.643373 ignition[958]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jan 20 01:23:28.641735 unknown[958]: wrote ssh authorized keys file for user: core Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.0-x86-64.raw" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.33.0-x86-64.raw" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.0-x86-64.raw" Jan 20 01:23:28.645612 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.33.0-x86-64.raw: attempt #1 Jan 20 01:23:29.029690 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Jan 20 01:23:30.403209 ignition[958]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.33.0-x86-64.raw" Jan 20 01:23:30.403209 ignition[958]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Jan 20 01:23:30.403209 ignition[958]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Jan 20 01:23:30.403209 ignition[958]: INFO : files: files passed Jan 20 01:23:30.403209 ignition[958]: INFO : Ignition finished successfully Jan 20 01:23:30.408653 systemd[1]: Finished ignition-files.service - Ignition (files). Jan 20 01:23:30.420413 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jan 20 01:23:30.423823 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jan 20 01:23:30.427536 systemd[1]: ignition-quench.service: Deactivated successfully. Jan 20 01:23:30.427692 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jan 20 01:23:30.451310 initrd-setup-root-after-ignition[986]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 20 01:23:30.451310 initrd-setup-root-after-ignition[986]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jan 20 01:23:30.454558 initrd-setup-root-after-ignition[990]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jan 20 01:23:30.457111 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 20 01:23:30.458663 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jan 20 01:23:30.468393 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jan 20 01:23:30.509879 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jan 20 01:23:30.511109 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jan 20 01:23:30.512569 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jan 20 01:23:30.513932 systemd[1]: Reached target initrd.target - Initrd Default Target. Jan 20 01:23:30.515714 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jan 20 01:23:30.520350 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jan 20 01:23:30.545170 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 20 01:23:30.556329 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jan 20 01:23:30.569186 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jan 20 01:23:30.571055 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 20 01:23:30.572178 systemd[1]: Stopped target timers.target - Timer Units. Jan 20 01:23:30.574629 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jan 20 01:23:30.574829 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jan 20 01:23:30.576402 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jan 20 01:23:30.577368 systemd[1]: Stopped target basic.target - Basic System. Jan 20 01:23:30.579050 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jan 20 01:23:30.580587 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jan 20 01:23:30.581986 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jan 20 01:23:30.583717 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jan 20 01:23:30.585281 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jan 20 01:23:30.586875 systemd[1]: Stopped target sysinit.target - System Initialization. Jan 20 01:23:30.588430 systemd[1]: Stopped target local-fs.target - Local File Systems. Jan 20 01:23:30.590023 systemd[1]: Stopped target swap.target - Swaps. Jan 20 01:23:30.591554 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jan 20 01:23:30.591793 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jan 20 01:23:30.593598 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jan 20 01:23:30.594681 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 20 01:23:30.596154 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jan 20 01:23:30.596386 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 20 01:23:30.597619 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jan 20 01:23:30.597821 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jan 20 01:23:30.599893 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jan 20 01:23:30.600068 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jan 20 01:23:30.601796 systemd[1]: ignition-files.service: Deactivated successfully. Jan 20 01:23:30.601962 systemd[1]: Stopped ignition-files.service - Ignition (files). Jan 20 01:23:30.610588 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jan 20 01:23:30.613421 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jan 20 01:23:30.614843 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jan 20 01:23:30.615141 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jan 20 01:23:30.621744 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jan 20 01:23:30.621962 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jan 20 01:23:30.631171 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jan 20 01:23:30.631355 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jan 20 01:23:30.648812 ignition[1010]: INFO : Ignition 2.19.0 Jan 20 01:23:30.648812 ignition[1010]: INFO : Stage: umount Jan 20 01:23:30.654079 ignition[1010]: INFO : no configs at "/usr/lib/ignition/base.d" Jan 20 01:23:30.654079 ignition[1010]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Jan 20 01:23:30.654079 ignition[1010]: INFO : umount: umount passed Jan 20 01:23:30.654079 ignition[1010]: INFO : Ignition finished successfully Jan 20 01:23:30.653809 systemd[1]: ignition-mount.service: Deactivated successfully. Jan 20 01:23:30.654990 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jan 20 01:23:30.659308 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jan 20 01:23:30.660515 systemd[1]: ignition-disks.service: Deactivated successfully. Jan 20 01:23:30.660634 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jan 20 01:23:30.661745 systemd[1]: ignition-kargs.service: Deactivated successfully. Jan 20 01:23:30.661814 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jan 20 01:23:30.664027 systemd[1]: ignition-fetch.service: Deactivated successfully. Jan 20 01:23:30.664121 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jan 20 01:23:30.666596 systemd[1]: Stopped target network.target - Network. Jan 20 01:23:30.667918 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jan 20 01:23:30.668038 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jan 20 01:23:30.670510 systemd[1]: Stopped target paths.target - Path Units. Jan 20 01:23:30.671792 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jan 20 01:23:30.676241 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 20 01:23:30.677805 systemd[1]: Stopped target slices.target - Slice Units. Jan 20 01:23:30.679330 systemd[1]: Stopped target sockets.target - Socket Units. Jan 20 01:23:30.681090 systemd[1]: iscsid.socket: Deactivated successfully. Jan 20 01:23:30.681258 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jan 20 01:23:30.682519 systemd[1]: iscsiuio.socket: Deactivated successfully. Jan 20 01:23:30.682581 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jan 20 01:23:30.689785 systemd[1]: ignition-setup.service: Deactivated successfully. Jan 20 01:23:30.689920 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jan 20 01:23:30.691042 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jan 20 01:23:30.691131 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jan 20 01:23:30.692889 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jan 20 01:23:30.695166 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jan 20 01:23:30.696987 systemd[1]: sysroot-boot.service: Deactivated successfully. Jan 20 01:23:30.697187 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jan 20 01:23:30.698323 systemd-networkd[771]: eth0: DHCPv6 lease lost Jan 20 01:23:30.702026 systemd[1]: systemd-networkd.service: Deactivated successfully. Jan 20 01:23:30.704283 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jan 20 01:23:30.708622 systemd[1]: systemd-resolved.service: Deactivated successfully. Jan 20 01:23:30.708853 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jan 20 01:23:30.713782 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jan 20 01:23:30.714091 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jan 20 01:23:30.714910 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jan 20 01:23:30.714993 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jan 20 01:23:30.723317 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jan 20 01:23:30.724056 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jan 20 01:23:30.724150 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jan 20 01:23:30.725656 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jan 20 01:23:30.725734 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jan 20 01:23:30.729624 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jan 20 01:23:30.729694 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jan 20 01:23:30.731311 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jan 20 01:23:30.731379 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 20 01:23:30.733037 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 20 01:23:30.744612 systemd[1]: systemd-udevd.service: Deactivated successfully. Jan 20 01:23:30.745360 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 20 01:23:30.749262 systemd[1]: network-cleanup.service: Deactivated successfully. Jan 20 01:23:30.749426 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jan 20 01:23:30.752943 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jan 20 01:23:30.753057 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jan 20 01:23:30.754905 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jan 20 01:23:30.754968 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jan 20 01:23:30.756579 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jan 20 01:23:30.756672 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jan 20 01:23:30.759017 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jan 20 01:23:30.759094 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jan 20 01:23:30.760495 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jan 20 01:23:30.760560 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jan 20 01:23:30.772398 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jan 20 01:23:30.774598 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jan 20 01:23:30.774679 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 20 01:23:30.776324 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Jan 20 01:23:30.776391 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 20 01:23:30.779551 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jan 20 01:23:30.779620 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jan 20 01:23:30.781555 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jan 20 01:23:30.781623 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jan 20 01:23:30.784882 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jan 20 01:23:30.785066 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jan 20 01:23:30.786703 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jan 20 01:23:30.794423 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jan 20 01:23:30.808034 systemd[1]: Switching root. Jan 20 01:23:30.848081 systemd-journald[202]: Journal stopped Jan 20 01:23:32.539157 systemd-journald[202]: Received SIGTERM from PID 1 (systemd). Jan 20 01:23:32.539410 kernel: SELinux: policy capability network_peer_controls=1 Jan 20 01:23:32.539460 kernel: SELinux: policy capability open_perms=1 Jan 20 01:23:32.539485 kernel: SELinux: policy capability extended_socket_class=1 Jan 20 01:23:32.539510 kernel: SELinux: policy capability always_check_network=0 Jan 20 01:23:32.539548 kernel: SELinux: policy capability cgroup_seclabel=1 Jan 20 01:23:32.539568 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jan 20 01:23:32.539604 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jan 20 01:23:32.539628 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jan 20 01:23:32.539672 kernel: audit: type=1403 audit(1768872211.223:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jan 20 01:23:32.539704 systemd[1]: Successfully loaded SELinux policy in 51.822ms. Jan 20 01:23:32.539752 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 22.911ms. Jan 20 01:23:32.539789 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Jan 20 01:23:32.539818 systemd[1]: Detected virtualization kvm. Jan 20 01:23:32.539871 systemd[1]: Detected architecture x86-64. Jan 20 01:23:32.539892 systemd[1]: Detected first boot. Jan 20 01:23:32.539919 systemd[1]: Hostname set to . Jan 20 01:23:32.539948 systemd[1]: Initializing machine ID from VM UUID. Jan 20 01:23:32.539969 zram_generator::config[1053]: No configuration found. Jan 20 01:23:32.540004 systemd[1]: Populated /etc with preset unit settings. Jan 20 01:23:32.540025 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jan 20 01:23:32.540064 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jan 20 01:23:32.540085 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jan 20 01:23:32.540127 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jan 20 01:23:32.540165 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jan 20 01:23:32.540188 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jan 20 01:23:32.541512 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jan 20 01:23:32.541564 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jan 20 01:23:32.541593 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jan 20 01:23:32.541622 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jan 20 01:23:32.541643 systemd[1]: Created slice user.slice - User and Session Slice. Jan 20 01:23:32.541664 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jan 20 01:23:32.541729 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jan 20 01:23:32.541764 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jan 20 01:23:32.541786 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jan 20 01:23:32.541823 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jan 20 01:23:32.541859 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jan 20 01:23:32.541881 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jan 20 01:23:32.541914 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jan 20 01:23:32.541935 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jan 20 01:23:32.541955 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jan 20 01:23:32.541995 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jan 20 01:23:32.542023 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jan 20 01:23:32.542043 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jan 20 01:23:32.542069 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jan 20 01:23:32.542095 systemd[1]: Reached target slices.target - Slice Units. Jan 20 01:23:32.542158 systemd[1]: Reached target swap.target - Swaps. Jan 20 01:23:32.544022 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jan 20 01:23:32.544052 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jan 20 01:23:32.544073 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jan 20 01:23:32.544122 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jan 20 01:23:32.544197 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jan 20 01:23:32.544220 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jan 20 01:23:32.544240 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jan 20 01:23:32.544268 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jan 20 01:23:32.544288 systemd[1]: Mounting media.mount - External Media Directory... Jan 20 01:23:32.544318 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:32.544346 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jan 20 01:23:32.544373 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jan 20 01:23:32.544393 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jan 20 01:23:32.544427 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Jan 20 01:23:32.544449 systemd[1]: Reached target machines.target - Containers. Jan 20 01:23:32.544469 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jan 20 01:23:32.544490 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 20 01:23:32.544510 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jan 20 01:23:32.544536 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jan 20 01:23:32.544555 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 20 01:23:32.544575 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 20 01:23:32.544616 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 20 01:23:32.544648 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jan 20 01:23:32.544694 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 20 01:23:32.544736 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jan 20 01:23:32.544764 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jan 20 01:23:32.544800 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jan 20 01:23:32.544822 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jan 20 01:23:32.544842 systemd[1]: Stopped systemd-fsck-usr.service. Jan 20 01:23:32.544863 systemd[1]: Starting systemd-journald.service - Journal Service... Jan 20 01:23:32.544890 kernel: fuse: init (API version 7.39) Jan 20 01:23:32.544913 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jan 20 01:23:32.544939 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jan 20 01:23:32.544960 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jan 20 01:23:32.544981 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jan 20 01:23:32.545017 systemd[1]: verity-setup.service: Deactivated successfully. Jan 20 01:23:32.545039 systemd[1]: Stopped verity-setup.service. Jan 20 01:23:32.545060 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:32.545094 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jan 20 01:23:32.548685 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jan 20 01:23:32.548712 kernel: loop: module loaded Jan 20 01:23:32.548743 systemd[1]: Mounted media.mount - External Media Directory. Jan 20 01:23:32.548772 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jan 20 01:23:32.548822 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jan 20 01:23:32.548844 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jan 20 01:23:32.548871 kernel: ACPI: bus type drm_connector registered Jan 20 01:23:32.548892 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jan 20 01:23:32.548913 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jan 20 01:23:32.548934 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jan 20 01:23:32.548967 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jan 20 01:23:32.548998 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 20 01:23:32.549040 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 20 01:23:32.549085 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 20 01:23:32.549230 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 20 01:23:32.549274 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 20 01:23:32.549297 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 20 01:23:32.549317 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jan 20 01:23:32.549396 systemd-journald[1149]: Collecting audit messages is disabled. Jan 20 01:23:32.549452 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jan 20 01:23:32.549477 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 20 01:23:32.549498 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 20 01:23:32.549528 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jan 20 01:23:32.549567 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jan 20 01:23:32.549597 systemd-journald[1149]: Journal started Jan 20 01:23:32.549636 systemd-journald[1149]: Runtime Journal (/run/log/journal/4c0740050c3143619a7273e0b5ed7c6d) is 4.7M, max 38.0M, 33.2M free. Jan 20 01:23:32.053617 systemd[1]: Queued start job for default target multi-user.target. Jan 20 01:23:32.553166 systemd[1]: Started systemd-journald.service - Journal Service. Jan 20 01:23:32.077676 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Jan 20 01:23:32.078427 systemd[1]: systemd-journald.service: Deactivated successfully. Jan 20 01:23:32.556267 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jan 20 01:23:32.577745 systemd[1]: Reached target network-pre.target - Preparation for Network. Jan 20 01:23:32.587293 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jan 20 01:23:32.599238 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jan 20 01:23:32.601439 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jan 20 01:23:32.601663 systemd[1]: Reached target local-fs.target - Local File Systems. Jan 20 01:23:32.607077 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Jan 20 01:23:32.620405 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jan 20 01:23:32.628391 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jan 20 01:23:32.630630 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 20 01:23:32.633040 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jan 20 01:23:32.642903 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jan 20 01:23:32.643838 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 20 01:23:32.653462 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jan 20 01:23:32.654693 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 20 01:23:32.667409 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jan 20 01:23:32.672050 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jan 20 01:23:32.682715 systemd-journald[1149]: Time spent on flushing to /var/log/journal/4c0740050c3143619a7273e0b5ed7c6d is 99.007ms for 1117 entries. Jan 20 01:23:32.682715 systemd-journald[1149]: System Journal (/var/log/journal/4c0740050c3143619a7273e0b5ed7c6d) is 8.0M, max 584.8M, 576.8M free. Jan 20 01:23:32.828649 systemd-journald[1149]: Received client request to flush runtime journal. Jan 20 01:23:32.828726 kernel: loop0: detected capacity change from 0 to 8 Jan 20 01:23:32.685056 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jan 20 01:23:32.694750 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jan 20 01:23:32.696546 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jan 20 01:23:32.699490 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jan 20 01:23:32.700699 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jan 20 01:23:32.715488 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Jan 20 01:23:32.747840 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jan 20 01:23:32.749003 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jan 20 01:23:32.757441 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Jan 20 01:23:32.796218 udevadm[1192]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. Jan 20 01:23:32.843659 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 20 01:23:32.804477 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jan 20 01:23:32.807256 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Jan 20 01:23:32.814614 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jan 20 01:23:32.833246 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jan 20 01:23:32.857600 systemd-tmpfiles[1187]: ACLs are not supported, ignoring. Jan 20 01:23:32.857628 systemd-tmpfiles[1187]: ACLs are not supported, ignoring. Jan 20 01:23:32.874155 kernel: loop1: detected capacity change from 0 to 140768 Jan 20 01:23:32.875918 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jan 20 01:23:32.884750 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jan 20 01:23:32.924156 kernel: loop2: detected capacity change from 0 to 142488 Jan 20 01:23:33.000552 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jan 20 01:23:33.006149 kernel: loop3: detected capacity change from 0 to 229808 Jan 20 01:23:33.014560 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jan 20 01:23:33.060184 kernel: loop4: detected capacity change from 0 to 8 Jan 20 01:23:33.069165 kernel: loop5: detected capacity change from 0 to 140768 Jan 20 01:23:33.098179 kernel: loop6: detected capacity change from 0 to 142488 Jan 20 01:23:33.112574 systemd-tmpfiles[1210]: ACLs are not supported, ignoring. Jan 20 01:23:33.112602 systemd-tmpfiles[1210]: ACLs are not supported, ignoring. Jan 20 01:23:33.125165 kernel: loop7: detected capacity change from 0 to 229808 Jan 20 01:23:33.126438 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jan 20 01:23:33.152399 (sd-merge)[1212]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-openstack'. Jan 20 01:23:33.153383 (sd-merge)[1212]: Merged extensions into '/usr'. Jan 20 01:23:33.161311 systemd[1]: Reloading requested from client PID 1186 ('systemd-sysext') (unit systemd-sysext.service)... Jan 20 01:23:33.161495 systemd[1]: Reloading... Jan 20 01:23:33.343168 zram_generator::config[1238]: No configuration found. Jan 20 01:23:33.479533 ldconfig[1181]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jan 20 01:23:33.568089 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 20 01:23:33.636975 systemd[1]: Reloading finished in 474 ms. Jan 20 01:23:33.669027 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jan 20 01:23:33.670640 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jan 20 01:23:33.684444 systemd[1]: Starting ensure-sysext.service... Jan 20 01:23:33.688937 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jan 20 01:23:33.722844 systemd[1]: Reloading requested from client PID 1296 ('systemctl') (unit ensure-sysext.service)... Jan 20 01:23:33.722874 systemd[1]: Reloading... Jan 20 01:23:33.745890 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jan 20 01:23:33.746964 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jan 20 01:23:33.748527 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jan 20 01:23:33.748960 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Jan 20 01:23:33.749136 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Jan 20 01:23:33.757273 systemd-tmpfiles[1297]: Detected autofs mount point /boot during canonicalization of boot. Jan 20 01:23:33.757294 systemd-tmpfiles[1297]: Skipping /boot Jan 20 01:23:33.782100 systemd-tmpfiles[1297]: Detected autofs mount point /boot during canonicalization of boot. Jan 20 01:23:33.782168 systemd-tmpfiles[1297]: Skipping /boot Jan 20 01:23:33.848221 zram_generator::config[1325]: No configuration found. Jan 20 01:23:34.023389 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 20 01:23:34.094284 systemd[1]: Reloading finished in 370 ms. Jan 20 01:23:34.119703 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jan 20 01:23:34.124771 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jan 20 01:23:34.137316 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Jan 20 01:23:34.143309 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jan 20 01:23:34.153344 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jan 20 01:23:34.162199 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jan 20 01:23:34.170361 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jan 20 01:23:34.174318 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jan 20 01:23:34.186366 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.186652 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 20 01:23:34.196530 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jan 20 01:23:34.199856 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jan 20 01:23:34.206719 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jan 20 01:23:34.208438 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 20 01:23:34.212599 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jan 20 01:23:34.214140 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.218230 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.218501 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 20 01:23:34.218731 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 20 01:23:34.218882 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.223054 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.223408 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jan 20 01:23:34.230431 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jan 20 01:23:34.231400 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jan 20 01:23:34.231610 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Jan 20 01:23:34.236185 systemd[1]: Finished ensure-sysext.service. Jan 20 01:23:34.246388 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Jan 20 01:23:34.252746 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jan 20 01:23:34.263268 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jan 20 01:23:34.267883 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jan 20 01:23:34.275558 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jan 20 01:23:34.275813 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jan 20 01:23:34.288174 augenrules[1415]: No rules Jan 20 01:23:34.288639 systemd[1]: modprobe@drm.service: Deactivated successfully. Jan 20 01:23:34.288900 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jan 20 01:23:34.295312 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Jan 20 01:23:34.299195 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jan 20 01:23:34.315626 systemd[1]: modprobe@loop.service: Deactivated successfully. Jan 20 01:23:34.316077 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jan 20 01:23:34.317785 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jan 20 01:23:34.322370 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jan 20 01:23:34.322869 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jan 20 01:23:34.333235 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jan 20 01:23:34.353797 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jan 20 01:23:34.362062 systemd-udevd[1393]: Using default interface naming scheme 'v255'. Jan 20 01:23:34.378997 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jan 20 01:23:34.381342 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Jan 20 01:23:34.406181 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jan 20 01:23:34.418323 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jan 20 01:23:34.550883 systemd-networkd[1435]: lo: Link UP Jan 20 01:23:34.550896 systemd-networkd[1435]: lo: Gained carrier Jan 20 01:23:34.551980 systemd-networkd[1435]: Enumeration completed Jan 20 01:23:34.552207 systemd[1]: Started systemd-networkd.service - Network Configuration. Jan 20 01:23:34.561484 systemd-resolved[1392]: Positive Trust Anchors: Jan 20 01:23:34.561524 systemd-resolved[1392]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jan 20 01:23:34.561568 systemd-resolved[1392]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test Jan 20 01:23:34.563320 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jan 20 01:23:34.565034 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Jan 20 01:23:34.566157 systemd[1]: Reached target time-set.target - System Time Set. Jan 20 01:23:34.573322 systemd-resolved[1392]: Using system hostname 'srv-4lxr2.gb1.brightbox.com'. Jan 20 01:23:34.578207 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jan 20 01:23:34.580251 systemd[1]: Reached target network.target - Network. Jan 20 01:23:34.580928 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jan 20 01:23:34.626405 systemd-networkd[1435]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 20 01:23:34.626647 systemd-networkd[1435]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jan 20 01:23:34.631828 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jan 20 01:23:34.631964 systemd-networkd[1435]: eth0: Link UP Jan 20 01:23:34.631971 systemd-networkd[1435]: eth0: Gained carrier Jan 20 01:23:34.631991 systemd-networkd[1435]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jan 20 01:23:34.647200 systemd-networkd[1435]: eth0: DHCPv4 address 10.230.30.174/30, gateway 10.230.30.173 acquired from 10.230.30.173 Jan 20 01:23:34.648337 systemd-timesyncd[1408]: Network configuration changed, trying to establish connection. Jan 20 01:23:34.678132 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1437) Jan 20 01:23:34.743146 kernel: mousedev: PS/2 mouse device common for all mice Jan 20 01:23:34.743272 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Jan 20 01:23:34.765127 kernel: ACPI: button: Power Button [PWRF] Jan 20 01:23:34.766810 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Jan 20 01:23:34.774267 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jan 20 01:23:34.797997 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jan 20 01:23:34.833365 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Jan 20 01:23:34.833528 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Jan 20 01:23:34.842981 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Jan 20 01:23:34.844080 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Jan 20 01:23:34.922559 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jan 20 01:23:35.101095 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jan 20 01:23:35.124230 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Jan 20 01:23:35.131369 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Jan 20 01:23:35.165125 lvm[1470]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 20 01:23:35.198811 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Jan 20 01:23:35.200326 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jan 20 01:23:35.201253 systemd[1]: Reached target sysinit.target - System Initialization. Jan 20 01:23:35.202386 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jan 20 01:23:35.203376 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jan 20 01:23:35.204674 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jan 20 01:23:35.205800 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jan 20 01:23:35.206744 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jan 20 01:23:35.207682 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jan 20 01:23:35.207849 systemd[1]: Reached target paths.target - Path Units. Jan 20 01:23:35.208553 systemd[1]: Reached target timers.target - Timer Units. Jan 20 01:23:35.210568 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jan 20 01:23:35.213613 systemd[1]: Starting docker.socket - Docker Socket for the API... Jan 20 01:23:35.220388 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jan 20 01:23:35.223194 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Jan 20 01:23:35.224608 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jan 20 01:23:35.225476 systemd[1]: Reached target sockets.target - Socket Units. Jan 20 01:23:35.226220 systemd[1]: Reached target basic.target - Basic System. Jan 20 01:23:35.226918 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jan 20 01:23:35.226963 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jan 20 01:23:35.233223 systemd[1]: Starting containerd.service - containerd container runtime... Jan 20 01:23:35.238956 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jan 20 01:23:35.242408 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jan 20 01:23:35.249122 lvm[1474]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Jan 20 01:23:35.256182 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jan 20 01:23:35.258701 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jan 20 01:23:35.259888 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Jan 20 01:23:35.262323 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jan 20 01:23:35.266041 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jan 20 01:23:35.269076 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jan 20 01:23:35.278289 systemd[1]: Starting systemd-logind.service - User Login Management... Jan 20 01:23:35.279938 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jan 20 01:23:35.280671 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jan 20 01:23:35.288356 systemd[1]: Starting update-engine.service - Update Engine... Jan 20 01:23:35.304300 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jan 20 01:23:35.313485 jq[1478]: false Jan 20 01:23:35.313729 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jan 20 01:23:35.314544 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jan 20 01:23:35.341826 jq[1487]: true Jan 20 01:23:35.345334 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Jan 20 01:23:35.347919 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jan 20 01:23:35.349196 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jan 20 01:23:35.375115 dbus-daemon[1477]: [system] SELinux support is enabled Jan 20 01:23:35.385616 (ntainerd)[1495]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jan 20 01:23:35.385873 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jan 20 01:23:35.389684 dbus-daemon[1477]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.1' (uid=244 pid=1435 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jan 20 01:23:35.393235 dbus-daemon[1477]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 20 01:23:35.394292 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jan 20 01:23:35.395164 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Jan 20 01:23:35.395202 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jan 20 01:23:35.396036 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Jan 20 01:23:35.396079 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jan 20 01:23:35.415014 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jan 20 01:23:35.428793 update_engine[1486]: I20260120 01:23:35.428642 1486 main.cc:92] Flatcar Update Engine starting Jan 20 01:23:35.434344 systemd[1]: Started update-engine.service - Update Engine. Jan 20 01:23:35.434732 update_engine[1486]: I20260120 01:23:35.434679 1486 update_check_scheduler.cc:74] Next update check in 6m23s Jan 20 01:23:35.437152 extend-filesystems[1479]: Found loop4 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found loop5 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found loop6 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found loop7 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda1 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda2 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda3 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found usr Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda4 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda6 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda7 Jan 20 01:23:35.439987 extend-filesystems[1479]: Found vda9 Jan 20 01:23:35.439987 extend-filesystems[1479]: Checking size of /dev/vda9 Jan 20 01:23:35.444286 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jan 20 01:23:35.503085 jq[1494]: true Jan 20 01:23:35.488671 systemd[1]: motdgen.service: Deactivated successfully. Jan 20 01:23:35.488999 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jan 20 01:23:35.544999 extend-filesystems[1479]: Resized partition /dev/vda9 Jan 20 01:23:35.555161 extend-filesystems[1524]: resize2fs 1.47.1 (20-May-2024) Jan 20 01:23:35.576766 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 15121403 blocks Jan 20 01:23:35.555688 systemd-logind[1484]: Watching system buttons on /dev/input/event2 (Power Button) Jan 20 01:23:35.555726 systemd-logind[1484]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Jan 20 01:23:35.562427 systemd-logind[1484]: New seat seat0. Jan 20 01:23:35.577780 systemd[1]: Started systemd-logind.service - User Login Management. Jan 20 01:23:35.671304 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1447) Jan 20 01:23:35.659280 locksmithd[1509]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jan 20 01:23:36.548142 systemd-resolved[1392]: Clock change detected. Flushing caches. Jan 20 01:23:36.549068 systemd-timesyncd[1408]: Contacted time server 213.5.132.231:123 (0.flatcar.pool.ntp.org). Jan 20 01:23:36.549148 systemd-timesyncd[1408]: Initial clock synchronization to Tue 2026-01-20 01:23:36.547559 UTC. Jan 20 01:23:36.573869 bash[1531]: Updated "/home/core/.ssh/authorized_keys" Jan 20 01:23:36.571735 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jan 20 01:23:36.589891 systemd[1]: Starting sshkeys.service... Jan 20 01:23:36.604213 dbus-daemon[1477]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 20 01:23:36.604859 dbus-daemon[1477]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.8' (uid=0 pid=1503 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jan 20 01:23:36.605573 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jan 20 01:23:36.617097 systemd[1]: Starting polkit.service - Authorization Manager... Jan 20 01:23:36.667621 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jan 20 01:23:36.679675 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jan 20 01:23:36.708555 polkitd[1543]: Started polkitd version 121 Jan 20 01:23:36.738095 polkitd[1543]: Loading rules from directory /etc/polkit-1/rules.d Jan 20 01:23:36.744875 polkitd[1543]: Loading rules from directory /usr/share/polkit-1/rules.d Jan 20 01:23:36.750948 polkitd[1543]: Finished loading, compiling and executing 2 rules Jan 20 01:23:36.752734 dbus-daemon[1477]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 20 01:23:36.753191 systemd[1]: Started polkit.service - Authorization Manager. Jan 20 01:23:36.756112 polkitd[1543]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jan 20 01:23:36.766618 containerd[1495]: time="2026-01-20T01:23:36.763970553Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Jan 20 01:23:36.774586 kernel: EXT4-fs (vda9): resized filesystem to 15121403 Jan 20 01:23:36.793554 extend-filesystems[1524]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Jan 20 01:23:36.793554 extend-filesystems[1524]: old_desc_blocks = 1, new_desc_blocks = 8 Jan 20 01:23:36.793554 extend-filesystems[1524]: The filesystem on /dev/vda9 is now 15121403 (4k) blocks long. Jan 20 01:23:36.807046 extend-filesystems[1479]: Resized filesystem in /dev/vda9 Jan 20 01:23:36.795041 systemd[1]: extend-filesystems.service: Deactivated successfully. Jan 20 01:23:36.795587 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jan 20 01:23:36.802188 systemd-networkd[1435]: eth0: Gained IPv6LL Jan 20 01:23:36.806787 systemd-hostnamed[1503]: Hostname set to (static) Jan 20 01:23:36.807657 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jan 20 01:23:36.814620 systemd[1]: Reached target network-online.target - Network is Online. Jan 20 01:23:36.827830 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jan 20 01:23:36.832686 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jan 20 01:23:36.860871 containerd[1495]: time="2026-01-20T01:23:36.860621875Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.866126 containerd[1495]: time="2026-01-20T01:23:36.865992008Z" 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.119-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Jan 20 01:23:36.866126 containerd[1495]: time="2026-01-20T01:23:36.866067334Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Jan 20 01:23:36.866352 containerd[1495]: time="2026-01-20T01:23:36.866284665Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Jan 20 01:23:36.866975 containerd[1495]: time="2026-01-20T01:23:36.866827042Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Jan 20 01:23:36.866975 containerd[1495]: time="2026-01-20T01:23:36.866899980Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.867196 containerd[1495]: time="2026-01-20T01:23:36.867167444Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Jan 20 01:23:36.867665 containerd[1495]: time="2026-01-20T01:23:36.867292275Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.867794 containerd[1495]: time="2026-01-20T01:23:36.867756088Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 20 01:23:36.867936 containerd[1495]: time="2026-01-20T01:23:36.867910378Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.868057 containerd[1495]: time="2026-01-20T01:23:36.868031350Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Jan 20 01:23:36.868246 containerd[1495]: time="2026-01-20T01:23:36.868116569Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.868633 containerd[1495]: time="2026-01-20T01:23:36.868447816Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.869176 containerd[1495]: time="2026-01-20T01:23:36.869069550Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Jan 20 01:23:36.870296 containerd[1495]: time="2026-01-20T01:23:36.870147189Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Jan 20 01:23:36.870296 containerd[1495]: time="2026-01-20T01:23:36.870215659Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Jan 20 01:23:36.870602 containerd[1495]: time="2026-01-20T01:23:36.870576956Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Jan 20 01:23:36.870880 containerd[1495]: time="2026-01-20T01:23:36.870845489Z" level=info msg="metadata content store policy set" policy=shared Jan 20 01:23:36.878767 containerd[1495]: time="2026-01-20T01:23:36.878736149Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.878914481Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.878948855Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.878991444Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879022996Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879206089Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879586360Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879756702Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879805583Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879827455Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879846458Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879864647Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879881557Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879903011Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.880534 containerd[1495]: time="2026-01-20T01:23:36.879923071Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.879941617Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.879961496Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.879977776Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880012674Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880033391Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880053411Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880103578Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880124779Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880143295Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880161060Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880197231Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880217050Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880250602Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881041 containerd[1495]: time="2026-01-20T01:23:36.880268299Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880285901Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880306297Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880329829Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880369757Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880392082Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.881611 containerd[1495]: time="2026-01-20T01:23:36.880411417Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Jan 20 01:23:36.881923 containerd[1495]: time="2026-01-20T01:23:36.881896640Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Jan 20 01:23:36.882036 containerd[1495]: time="2026-01-20T01:23:36.882009074Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Jan 20 01:23:36.882127 containerd[1495]: time="2026-01-20T01:23:36.882105989Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Jan 20 01:23:36.882241 containerd[1495]: time="2026-01-20T01:23:36.882206283Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Jan 20 01:23:36.882326 containerd[1495]: time="2026-01-20T01:23:36.882304935Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.882460 containerd[1495]: time="2026-01-20T01:23:36.882418232Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Jan 20 01:23:36.882574 containerd[1495]: time="2026-01-20T01:23:36.882552322Z" level=info msg="NRI interface is disabled by configuration." Jan 20 01:23:36.882675 containerd[1495]: time="2026-01-20T01:23:36.882651280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Jan 20 01:23:36.883216 containerd[1495]: time="2026-01-20T01:23:36.883124614Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Jan 20 01:23:36.883583 containerd[1495]: time="2026-01-20T01:23:36.883558710Z" level=info msg="Connect containerd service" Jan 20 01:23:36.883761 containerd[1495]: time="2026-01-20T01:23:36.883736197Z" level=info msg="using legacy CRI server" Jan 20 01:23:36.883878 containerd[1495]: time="2026-01-20T01:23:36.883856682Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jan 20 01:23:36.884125 containerd[1495]: time="2026-01-20T01:23:36.884099337Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Jan 20 01:23:36.885351 containerd[1495]: time="2026-01-20T01:23:36.885320249Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886042801Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886129515Z" level=info msg=serving... address=/run/containerd/containerd.sock Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886238828Z" level=info msg="Start subscribing containerd event" Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886303785Z" level=info msg="Start recovering state" Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886420444Z" level=info msg="Start event monitor" Jan 20 01:23:36.886529 containerd[1495]: time="2026-01-20T01:23:36.886469673Z" level=info msg="Start snapshots syncer" Jan 20 01:23:36.888368 containerd[1495]: time="2026-01-20T01:23:36.886492391Z" level=info msg="Start cni network conf syncer for default" Jan 20 01:23:36.888788 containerd[1495]: time="2026-01-20T01:23:36.888761460Z" level=info msg="Start streaming server" Jan 20 01:23:36.890736 systemd[1]: Started containerd.service - containerd container runtime. Jan 20 01:23:36.893699 containerd[1495]: time="2026-01-20T01:23:36.892110849Z" level=info msg="containerd successfully booted in 0.133886s" Jan 20 01:23:36.897965 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jan 20 01:23:37.082290 sshd_keygen[1505]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jan 20 01:23:37.120119 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jan 20 01:23:37.131652 systemd[1]: Starting issuegen.service - Generate /run/issue... Jan 20 01:23:37.136951 systemd[1]: Started sshd@0-10.230.30.174:22-20.161.92.111:60288.service - OpenSSH per-connection server daemon (20.161.92.111:60288). Jan 20 01:23:37.141241 systemd[1]: issuegen.service: Deactivated successfully. Jan 20 01:23:37.141670 systemd[1]: Finished issuegen.service - Generate /run/issue. Jan 20 01:23:37.152558 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jan 20 01:23:37.168644 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jan 20 01:23:37.179106 systemd[1]: Started getty@tty1.service - Getty on tty1. Jan 20 01:23:37.189958 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jan 20 01:23:37.191094 systemd[1]: Reached target getty.target - Login Prompts. Jan 20 01:23:37.737330 sshd[1581]: Accepted publickey for core from 20.161.92.111 port 60288 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:37.739636 sshd[1581]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:37.761387 systemd-logind[1484]: New session 1 of user core. Jan 20 01:23:37.762831 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jan 20 01:23:37.771891 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jan 20 01:23:37.807593 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jan 20 01:23:37.819036 systemd[1]: Starting user@500.service - User Manager for UID 500... Jan 20 01:23:37.843339 (systemd)[1594]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jan 20 01:23:37.956716 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jan 20 01:23:37.960720 (kubelet)[1605]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jan 20 01:23:37.988590 systemd[1594]: Queued start job for default target default.target. Jan 20 01:23:37.994815 systemd[1594]: Created slice app.slice - User Application Slice. Jan 20 01:23:37.994985 systemd[1594]: Reached target paths.target - Paths. Jan 20 01:23:37.995107 systemd[1594]: Reached target timers.target - Timers. Jan 20 01:23:37.997559 systemd[1594]: Starting dbus.socket - D-Bus User Message Bus Socket... Jan 20 01:23:38.021963 systemd[1594]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jan 20 01:23:38.023054 systemd[1]: Started sshd@1-10.230.30.174:22-188.166.25.188:52728.service - OpenSSH per-connection server daemon (188.166.25.188:52728). Jan 20 01:23:38.025021 systemd[1594]: Reached target sockets.target - Sockets. Jan 20 01:23:38.025049 systemd[1594]: Reached target basic.target - Basic System. Jan 20 01:23:38.025114 systemd[1594]: Reached target default.target - Main User Target. Jan 20 01:23:38.025190 systemd[1594]: Startup finished in 169ms. Jan 20 01:23:38.027290 systemd[1]: Started user@500.service - User Manager for UID 500. Jan 20 01:23:38.039003 systemd[1]: Started session-1.scope - Session 1 of User core. Jan 20 01:23:38.128334 sshd[1608]: Connection closed by authenticating user root 188.166.25.188 port 52728 [preauth] Jan 20 01:23:38.130046 systemd[1]: sshd@1-10.230.30.174:22-188.166.25.188:52728.service: Deactivated successfully. Jan 20 01:23:38.313694 systemd-networkd[1435]: eth0: Ignoring DHCPv6 address 2a02:1348:179:87ab:24:19ff:fee6:1eae/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:87ab:24:19ff:fee6:1eae/64 assigned by NDisc. Jan 20 01:23:38.313707 systemd-networkd[1435]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Jan 20 01:23:38.467120 systemd[1]: Started sshd@2-10.230.30.174:22-20.161.92.111:60302.service - OpenSSH per-connection server daemon (20.161.92.111:60302). Jan 20 01:23:38.630692 kubelet[1605]: E0120 01:23:38.629555 1605 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Jan 20 01:23:38.634958 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jan 20 01:23:38.635223 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jan 20 01:23:38.635952 systemd[1]: kubelet.service: Consumed 1.109s CPU time. Jan 20 01:23:39.033000 sshd[1621]: Accepted publickey for core from 20.161.92.111 port 60302 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:39.035342 sshd[1621]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:39.043840 systemd-logind[1484]: New session 2 of user core. Jan 20 01:23:39.053829 systemd[1]: Started session-2.scope - Session 2 of User core. Jan 20 01:23:39.437769 sshd[1621]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:39.443113 systemd[1]: sshd@2-10.230.30.174:22-20.161.92.111:60302.service: Deactivated successfully. Jan 20 01:23:39.445801 systemd[1]: session-2.scope: Deactivated successfully. Jan 20 01:23:39.447131 systemd-logind[1484]: Session 2 logged out. Waiting for processes to exit. Jan 20 01:23:39.448629 systemd-logind[1484]: Removed session 2. Jan 20 01:23:39.552983 systemd[1]: Started sshd@3-10.230.30.174:22-20.161.92.111:60310.service - OpenSSH per-connection server daemon (20.161.92.111:60310). Jan 20 01:23:40.114195 sshd[1631]: Accepted publickey for core from 20.161.92.111 port 60310 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:40.116320 sshd[1631]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:40.123160 systemd-logind[1484]: New session 3 of user core. Jan 20 01:23:40.136045 systemd[1]: Started session-3.scope - Session 3 of User core. Jan 20 01:23:40.519021 sshd[1631]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:40.525260 systemd[1]: sshd@3-10.230.30.174:22-20.161.92.111:60310.service: Deactivated successfully. Jan 20 01:23:40.528212 systemd[1]: session-3.scope: Deactivated successfully. Jan 20 01:23:40.529483 systemd-logind[1484]: Session 3 logged out. Waiting for processes to exit. Jan 20 01:23:40.531455 systemd-logind[1484]: Removed session 3. Jan 20 01:23:40.585931 systemd[1]: Started sshd@4-10.230.30.174:22-164.92.217.44:43758.service - OpenSSH per-connection server daemon (164.92.217.44:43758). Jan 20 01:23:40.967326 sshd[1639]: Connection closed by authenticating user root 164.92.217.44 port 43758 [preauth] Jan 20 01:23:40.969706 systemd[1]: sshd@4-10.230.30.174:22-164.92.217.44:43758.service: Deactivated successfully. Jan 20 01:23:42.397129 login[1587]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jan 20 01:23:42.400690 login[1588]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Jan 20 01:23:42.407194 systemd-logind[1484]: New session 5 of user core. Jan 20 01:23:42.418832 systemd[1]: Started session-5.scope - Session 5 of User core. Jan 20 01:23:42.423404 systemd-logind[1484]: New session 4 of user core. Jan 20 01:23:42.429833 systemd[1]: Started session-4.scope - Session 4 of User core. Jan 20 01:23:43.336921 coreos-metadata[1476]: Jan 20 01:23:43.336 WARN failed to locate config-drive, using the metadata service API instead Jan 20 01:23:43.369259 coreos-metadata[1476]: Jan 20 01:23:43.369 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 Jan 20 01:23:43.377473 coreos-metadata[1476]: Jan 20 01:23:43.377 INFO Fetch failed with 404: resource not found Jan 20 01:23:43.377582 coreos-metadata[1476]: Jan 20 01:23:43.377 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Jan 20 01:23:43.378545 coreos-metadata[1476]: Jan 20 01:23:43.378 INFO Fetch successful Jan 20 01:23:43.378745 coreos-metadata[1476]: Jan 20 01:23:43.378 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 Jan 20 01:23:43.394376 coreos-metadata[1476]: Jan 20 01:23:43.394 INFO Fetch successful Jan 20 01:23:43.394460 coreos-metadata[1476]: Jan 20 01:23:43.394 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 Jan 20 01:23:43.407322 coreos-metadata[1476]: Jan 20 01:23:43.407 INFO Fetch successful Jan 20 01:23:43.407425 coreos-metadata[1476]: Jan 20 01:23:43.407 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 Jan 20 01:23:43.421033 coreos-metadata[1476]: Jan 20 01:23:43.420 INFO Fetch successful Jan 20 01:23:43.421033 coreos-metadata[1476]: Jan 20 01:23:43.420 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 Jan 20 01:23:43.440930 coreos-metadata[1476]: Jan 20 01:23:43.440 INFO Fetch successful Jan 20 01:23:43.480442 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jan 20 01:23:43.481803 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jan 20 01:23:43.864219 coreos-metadata[1546]: Jan 20 01:23:43.864 WARN failed to locate config-drive, using the metadata service API instead Jan 20 01:23:43.888219 coreos-metadata[1546]: Jan 20 01:23:43.888 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 Jan 20 01:23:43.914835 coreos-metadata[1546]: Jan 20 01:23:43.914 INFO Fetch successful Jan 20 01:23:43.915092 coreos-metadata[1546]: Jan 20 01:23:43.914 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 Jan 20 01:23:43.940642 coreos-metadata[1546]: Jan 20 01:23:43.940 INFO Fetch successful Jan 20 01:23:43.942889 unknown[1546]: wrote ssh authorized keys file for user: core Jan 20 01:23:43.968255 update-ssh-keys[1679]: Updated "/home/core/.ssh/authorized_keys" Jan 20 01:23:43.969029 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jan 20 01:23:43.972372 systemd[1]: Finished sshkeys.service. Jan 20 01:23:43.975290 systemd[1]: Reached target multi-user.target - Multi-User System. Jan 20 01:23:43.976668 systemd[1]: Startup finished in 1.518s (kernel) + 13.462s (initrd) + 11.938s (userspace) = 26.919s. Jan 20 01:23:48.886190 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 1. Jan 20 01:23:48.901923 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jan 20 01:23:49.128773 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jan 20 01:23:49.129004 (kubelet)[1690]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Jan 20 01:23:49.212259 kubelet[1690]: E0120 01:23:49.211989 1690 run.go:72] "command failed" err="failed to load kubelet config file, path: /var/lib/kubelet/config.yaml, error: failed to load Kubelet config file /var/lib/kubelet/config.yaml, error failed to read kubelet config file \"/var/lib/kubelet/config.yaml\", error: open /var/lib/kubelet/config.yaml: no such file or directory" Jan 20 01:23:49.217796 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Jan 20 01:23:49.218244 systemd[1]: kubelet.service: Failed with result 'exit-code'. Jan 20 01:23:50.629242 systemd[1]: Started sshd@5-10.230.30.174:22-20.161.92.111:57674.service - OpenSSH per-connection server daemon (20.161.92.111:57674). Jan 20 01:23:51.197917 sshd[1698]: Accepted publickey for core from 20.161.92.111 port 57674 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:51.200390 sshd[1698]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:51.209572 systemd-logind[1484]: New session 6 of user core. Jan 20 01:23:51.211736 systemd[1]: Started session-6.scope - Session 6 of User core. Jan 20 01:23:51.605056 sshd[1698]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:51.610821 systemd[1]: sshd@5-10.230.30.174:22-20.161.92.111:57674.service: Deactivated successfully. Jan 20 01:23:51.613447 systemd[1]: session-6.scope: Deactivated successfully. Jan 20 01:23:51.615560 systemd-logind[1484]: Session 6 logged out. Waiting for processes to exit. Jan 20 01:23:51.617032 systemd-logind[1484]: Removed session 6. Jan 20 01:23:51.711875 systemd[1]: Started sshd@6-10.230.30.174:22-20.161.92.111:57676.service - OpenSSH per-connection server daemon (20.161.92.111:57676). Jan 20 01:23:52.276078 sshd[1705]: Accepted publickey for core from 20.161.92.111 port 57676 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:52.279612 sshd[1705]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:52.287203 systemd-logind[1484]: New session 7 of user core. Jan 20 01:23:52.298992 systemd[1]: Started session-7.scope - Session 7 of User core. Jan 20 01:23:52.675695 sshd[1705]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:52.682252 systemd[1]: sshd@6-10.230.30.174:22-20.161.92.111:57676.service: Deactivated successfully. Jan 20 01:23:52.684806 systemd[1]: session-7.scope: Deactivated successfully. Jan 20 01:23:52.686383 systemd-logind[1484]: Session 7 logged out. Waiting for processes to exit. Jan 20 01:23:52.687847 systemd-logind[1484]: Removed session 7. Jan 20 01:23:52.778860 systemd[1]: Started sshd@7-10.230.30.174:22-20.161.92.111:44868.service - OpenSSH per-connection server daemon (20.161.92.111:44868). Jan 20 01:23:53.349422 sshd[1712]: Accepted publickey for core from 20.161.92.111 port 44868 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:53.351703 sshd[1712]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:53.360077 systemd-logind[1484]: New session 8 of user core. Jan 20 01:23:53.366768 systemd[1]: Started session-8.scope - Session 8 of User core. Jan 20 01:23:53.753027 sshd[1712]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:53.758315 systemd[1]: sshd@7-10.230.30.174:22-20.161.92.111:44868.service: Deactivated successfully. Jan 20 01:23:53.760484 systemd[1]: session-8.scope: Deactivated successfully. Jan 20 01:23:53.761810 systemd-logind[1484]: Session 8 logged out. Waiting for processes to exit. Jan 20 01:23:53.763073 systemd-logind[1484]: Removed session 8. Jan 20 01:23:53.859914 systemd[1]: Started sshd@8-10.230.30.174:22-20.161.92.111:44884.service - OpenSSH per-connection server daemon (20.161.92.111:44884). Jan 20 01:23:54.422575 sshd[1719]: Accepted publickey for core from 20.161.92.111 port 44884 ssh2: RSA SHA256:vwYWaPWY4E+jnxDgal8jMKtiDg2o3eyknQaSavuqdLU Jan 20 01:23:54.424522 sshd[1719]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jan 20 01:23:54.431575 systemd-logind[1484]: New session 9 of user core. Jan 20 01:23:54.437764 systemd[1]: Started session-9.scope - Session 9 of User core. Jan 20 01:23:54.750315 sudo[1722]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Jan 20 01:23:54.750848 sudo[1722]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jan 20 01:23:55.527676 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jan 20 01:23:55.539949 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jan 20 01:23:55.573033 systemd[1]: Reloading requested from client PID 1757 ('systemctl') (unit session-9.scope)... Jan 20 01:23:55.573077 systemd[1]: Reloading... Jan 20 01:23:55.729554 zram_generator::config[1796]: No configuration found. Jan 20 01:23:55.922228 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Jan 20 01:23:56.038841 systemd[1]: Reloading finished in 465 ms. Jan 20 01:23:56.116764 systemd[1]: kubelet.service: Control process exited, code=killed, status=15/TERM Jan 20 01:23:56.117117 systemd[1]: kubelet.service: Failed with result 'signal'. Jan 20 01:23:56.117732 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Jan 20 01:23:56.124988 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Jan 20 01:23:56.293850 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Jan 20 01:23:56.308091 (kubelet)[1864]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Jan 20 01:23:56.387895 kubelet[1864]: Flag --container-runtime-endpoint has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jan 20 01:23:56.387895 kubelet[1864]: Flag --pod-infra-container-image has been deprecated, will be removed in 1.35. Image garbage collector will get sandbox image information from CRI. Jan 20 01:23:56.387895 kubelet[1864]: Flag --volume-plugin-dir has been deprecated, This parameter should be set via the config file specified by the Kubelet's --config flag. See https://kubernetes.io/docs/tasks/administer-cluster/kubelet-config-file/ for more information. Jan 20 01:23:56.388518 kubelet[1864]: I0120 01:23:56.387979 1864 server.go:212] "--pod-infra-container-image will not be pruned by the image garbage collector in kubelet and should also be set in the remote runtime" Jan 20 01:23:56.764586 kubelet[1864]: I0120 01:23:56.764146 1864 server.go:530] "Kubelet version" kubeletVersion="v1.33.0" Jan 20 01:23:56.764586 kubelet[1864]: I0120 01:23:56.764214 1864 server.go:532] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Jan 20 01:23:56.765100 kubelet[1864]: I0120 01:23:56.764671 1864 server.go:956] "Client rotation is on, will bootstrap in background" Jan 20 01:23:56.805232 kubelet[1864]: I0120 01:23:56.804921 1864 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Jan 20 01:23:56.819102 kubelet[1864]: E0120 01:23:56.818734 1864 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Jan 20 01:23:56.819102 kubelet[1864]: I0120 01:23:56.818818 1864 server.go:1423] "CRI implementation should be updated to support RuntimeConfig when KubeletCgroupDriverFromCRI feature gate has been enabled. Falling back to using cgroupDriver from kubelet config." Jan 20 01:23:56.826361 kubelet[1864]: I0120 01:23:56.826328 1864 server.go:782] "--cgroups-per-qos enabled, but --cgroup-root was not specified. defaulting to /" Jan 20 01:23:56.826926 kubelet[1864]: I0120 01:23:56.826871 1864 container_manager_linux.go:267] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Jan 20 01:23:56.827266 kubelet[1864]: I0120 01:23:56.826923 1864 container_manager_linux.go:272] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.230.30.174","RuntimeCgroupsName":"","SystemCgroupsName":"","KubeletCgroupsName":"","KubeletOOMScoreAdj":-999,"ContainerRuntime":"","CgroupsPerQOS":true,"CgroupRoot":"/","CgroupDriver":"systemd","KubeletRootDir":"/var/lib/kubelet","ProtectKernelDefaults":false,"KubeReservedCgroupName":"","SystemReservedCgroupName":"","ReservedSystemCPUs":{},"EnforceNodeAllocatable":{"pods":{}},"KubeReserved":null,"SystemReserved":null,"HardEvictionThresholds":[{"Signal":"nodefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.15},"GracePeriod":0,"MinReclaim":null},{"Signal":"imagefs.inodesFree","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.05},"GracePeriod":0,"MinReclaim":null},{"Signal":"memory.available","Operator":"LessThan","Value":{"Quantity":"100Mi","Percentage":0},"GracePeriod":0,"MinReclaim":null},{"Signal":"nodefs.available","Operator":"LessThan","Value":{"Quantity":null,"Percentage":0.1},"GracePeriod":0,"MinReclaim":null}],"QOSReserved":{},"CPUManagerPolicy":"none","CPUManagerPolicyOptions":null,"TopologyManagerScope":"container","CPUManagerReconcilePeriod":10000000000,"MemoryManagerPolicy":"None","MemoryManagerReservedMemory":null,"PodPidsLimit":-1,"EnforceCPULimits":true,"CPUCFSQuotaPeriod":100000000,"TopologyManagerPolicy":"none","TopologyManagerPolicyOptions":null,"CgroupVersion":2} Jan 20 01:23:56.827266 kubelet[1864]: I0120 01:23:56.827238 1864 topology_manager.go:138] "Creating topology manager with none policy" Jan 20 01:23:56.827266 kubelet[1864]: I0120 01:23:56.827259 1864 container_manager_linux.go:303] "Creating device plugin manager" Jan 20 01:23:56.829433 kubelet[1864]: I0120 01:23:56.829353 1864 state_mem.go:36] "Initialized new in-memory state store" Jan 20 01:23:56.833056 kubelet[1864]: I0120 01:23:56.833019 1864 kubelet.go:480] "Attempting to sync node with API server" Jan 20 01:23:56.833153 kubelet[1864]: I0120 01:23:56.833060 1864 kubelet.go:375] "Adding static pod path" path="/etc/kubernetes/manifests" Jan 20 01:23:56.834131 kubelet[1864]: I0120 01:23:56.834110 1864 kubelet.go:386] "Adding apiserver pod source" Jan 20 01:23:56.834228 kubelet[1864]: I0120 01:23:56.834159 1864 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Jan 20 01:23:56.835576 kubelet[1864]: E0120 01:23:56.834366 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:23:56.835576 kubelet[1864]: E0120 01:23:56.834427 1864 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:23:56.838940 kubelet[1864]: I0120 01:23:56.838900 1864 kuberuntime_manager.go:279] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Jan 20 01:23:56.839964 kubelet[1864]: I0120 01:23:56.839939 1864 kubelet.go:935] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Jan 20 01:23:56.841102 kubelet[1864]: W0120 01:23:56.841079 1864 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Jan 20 01:23:56.847355 kubelet[1864]: I0120 01:23:56.847259 1864 watchdog_linux.go:99] "Systemd watchdog is not enabled" Jan 20 01:23:56.847682 kubelet[1864]: I0120 01:23:56.847663 1864 server.go:1289] "Started kubelet" Jan 20 01:23:56.851675 kubelet[1864]: I0120 01:23:56.851652 1864 fs_resource_analyzer.go:67] "Starting FS ResourceAnalyzer" Jan 20 01:23:56.854009 kubelet[1864]: I0120 01:23:56.853967 1864 volume_manager.go:297] "Starting Kubelet Volume Manager" Jan 20 01:23:56.854363 kubelet[1864]: E0120 01:23:56.854330 1864 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.230.30.174\" not found" Jan 20 01:23:56.856531 kubelet[1864]: I0120 01:23:56.855085 1864 desired_state_of_world_populator.go:150] "Desired state populator starts to run" Jan 20 01:23:56.856531 kubelet[1864]: I0120 01:23:56.855372 1864 reconciler.go:26] "Reconciler: start to sync state" Jan 20 01:23:56.860550 kubelet[1864]: I0120 01:23:56.860483 1864 server.go:180] "Starting to listen" address="0.0.0.0" port=10250 Jan 20 01:23:56.863582 kubelet[1864]: I0120 01:23:56.863560 1864 server.go:317] "Adding debug handlers to kubelet server" Jan 20 01:23:56.871685 kubelet[1864]: I0120 01:23:56.871357 1864 ratelimit.go:55] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Jan 20 01:23:56.874760 kubelet[1864]: I0120 01:23:56.874734 1864 factory.go:223] Registration of the systemd container factory successfully Jan 20 01:23:56.877001 kubelet[1864]: I0120 01:23:56.876956 1864 factory.go:221] Registration of the crio container factory failed: Get "http://%2Fvar%2Frun%2Fcrio%2Fcrio.sock/info": dial unix /var/run/crio/crio.sock: connect: no such file or directory Jan 20 01:23:56.877302 kubelet[1864]: I0120 01:23:56.872437 1864 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Jan 20 01:23:56.877538 kubelet[1864]: I0120 01:23:56.876777 1864 server.go:255] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Jan 20 01:23:56.879414 kubelet[1864]: E0120 01:23:56.879263 1864 nodelease.go:49] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.230.30.174\" not found" node="10.230.30.174" Jan 20 01:23:56.879973 kubelet[1864]: E0120 01:23:56.879939 1864 kubelet.go:1600] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Jan 20 01:23:56.882741 kubelet[1864]: I0120 01:23:56.882716 1864 factory.go:223] Registration of the containerd container factory successfully Jan 20 01:23:56.906083 kubelet[1864]: I0120 01:23:56.906044 1864 cpu_manager.go:221] "Starting CPU manager" policy="none" Jan 20 01:23:56.906284 kubelet[1864]: I0120 01:23:56.906261 1864 cpu_manager.go:222] "Reconciling" reconcilePeriod="10s" Jan 20 01:23:56.906853 kubelet[1864]: I0120 01:23:56.906835 1864 state_mem.go:36] "Initialized new in-memory state store" Jan 20 01:23:56.909921 kubelet[1864]: I0120 01:23:56.909899 1864 policy_none.go:49] "None policy: Start" Jan 20 01:23:56.910075 kubelet[1864]: I0120 01:23:56.910047 1864 memory_manager.go:186] "Starting memorymanager" policy="None" Jan 20 01:23:56.910225 kubelet[1864]: I0120 01:23:56.910206 1864 state_mem.go:35] "Initializing new in-memory state store" Jan 20 01:23:56.922213 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Jan 20 01:23:56.940270 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Jan 20 01:23:56.948611 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Jan 20 01:23:56.955619 kubelet[1864]: E0120 01:23:56.954609 1864 kubelet_node_status.go:466] "Error getting the current node from lister" err="node \"10.230.30.174\" not found" Jan 20 01:23:56.956284 kubelet[1864]: E0120 01:23:56.955855 1864 manager.go:517] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Jan 20 01:23:56.957154 kubelet[1864]: I0120 01:23:56.957027 1864 eviction_manager.go:189] "Eviction manager: starting control loop" Jan 20 01:23:56.960546 kubelet[1864]: I0120 01:23:56.957190 1864 container_log_manager.go:189] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Jan 20 01:23:56.960546 kubelet[1864]: I0120 01:23:56.957827 1864 plugin_manager.go:118] "Starting Kubelet Plugin Manager" Jan 20 01:23:56.964085 kubelet[1864]: E0120 01:23:56.964053 1864 eviction_manager.go:267] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Jan 20 01:23:56.964166 kubelet[1864]: E0120 01:23:56.964149 1864 eviction_manager.go:292] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.230.30.174\" not found" Jan 20 01:23:56.982748 kubelet[1864]: I0120 01:23:56.982706 1864 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv4" Jan 20 01:23:56.984936 kubelet[1864]: I0120 01:23:56.984913 1864 kubelet_network_linux.go:49] "Initialized iptables rules." protocol="IPv6" Jan 20 01:23:56.985215 kubelet[1864]: I0120 01:23:56.985194 1864 status_manager.go:230] "Starting to sync pod status with apiserver" Jan 20 01:23:56.985363 kubelet[1864]: I0120 01:23:56.985342 1864 watchdog_linux.go:127] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Jan 20 01:23:56.985531 kubelet[1864]: I0120 01:23:56.985480 1864 kubelet.go:2436] "Starting kubelet main sync loop" Jan 20 01:23:56.986722 kubelet[1864]: E0120 01:23:56.986611 1864 kubelet.go:2460] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Jan 20 01:23:57.062452 kubelet[1864]: I0120 01:23:57.062245 1864 kubelet_node_status.go:75] "Attempting to register node" node="10.230.30.174" Jan 20 01:23:57.070989 kubelet[1864]: I0120 01:23:57.070939 1864 kubelet_node_status.go:78] "Successfully registered node" node="10.230.30.174" Jan 20 01:23:57.186530 kubelet[1864]: I0120 01:23:57.186366 1864 kuberuntime_manager.go:1746] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Jan 20 01:23:57.187232 containerd[1495]: time="2026-01-20T01:23:57.187095349Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Jan 20 01:23:57.187944 kubelet[1864]: I0120 01:23:57.187401 1864 kubelet_network.go:61] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Jan 20 01:23:57.352686 sudo[1722]: pam_unix(sudo:session): session closed for user root Jan 20 01:23:57.444465 sshd[1719]: pam_unix(sshd:session): session closed for user core Jan 20 01:23:57.450351 systemd-logind[1484]: Session 9 logged out. Waiting for processes to exit. Jan 20 01:23:57.450983 systemd[1]: sshd@8-10.230.30.174:22-20.161.92.111:44884.service: Deactivated successfully. Jan 20 01:23:57.454019 systemd[1]: session-9.scope: Deactivated successfully. Jan 20 01:23:57.456642 systemd-logind[1484]: Removed session 9. Jan 20 01:23:57.767921 kubelet[1864]: I0120 01:23:57.767734 1864 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Jan 20 01:23:57.768580 kubelet[1864]: I0120 01:23:57.768047 1864 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jan 20 01:23:57.768580 kubelet[1864]: I0120 01:23:57.768097 1864 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jan 20 01:23:57.768580 kubelet[1864]: I0120 01:23:57.768133 1864 reflector.go:556] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:160" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:160: Unexpected watch close - watch lasted less than a second and no items received" Jan 20 01:23:57.834838 kubelet[1864]: E0120 01:23:57.834743 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:23:57.834838 kubelet[1864]: I0120 01:23:57.834833 1864 apiserver.go:52] "Watching apiserver" Jan 20 01:23:57.856428 kubelet[1864]: I0120 01:23:57.855845 1864 desired_state_of_world_populator.go:158] "Finished populating initial desired state of world" Jan 20 01:23:57.856898 systemd[1]: Created slice kubepods-besteffort-pod381567c0_e1f0_409f_be06_afdf08bfc71c.slice - libcontainer container kubepods-besteffort-pod381567c0_e1f0_409f_be06_afdf08bfc71c.slice. Jan 20 01:23:57.860941 kubelet[1864]: I0120 01:23:57.860725 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-run\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.860941 kubelet[1864]: I0120 01:23:57.860816 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-cni-plugin\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.860941 kubelet[1864]: I0120 01:23:57.860854 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-flannel-cfg\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.861178 kubelet[1864]: I0120 01:23:57.860966 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-xtables-lock\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.861178 kubelet[1864]: I0120 01:23:57.861041 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/381567c0-e1f0-409f-be06-afdf08bfc71c-xtables-lock\") pod \"kube-proxy-jkpdw\" (UID: \"381567c0-e1f0-409f-be06-afdf08bfc71c\") " pod="kube-system/kube-proxy-jkpdw" Jan 20 01:23:57.861178 kubelet[1864]: I0120 01:23:57.861098 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-4m2fg\" (UniqueName: \"kubernetes.io/projected/381567c0-e1f0-409f-be06-afdf08bfc71c-kube-api-access-4m2fg\") pod \"kube-proxy-jkpdw\" (UID: \"381567c0-e1f0-409f-be06-afdf08bfc71c\") " pod="kube-system/kube-proxy-jkpdw" Jan 20 01:23:57.861312 kubelet[1864]: I0120 01:23:57.861184 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-cni\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.861312 kubelet[1864]: I0120 01:23:57.861225 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-6lrj7\" (UniqueName: \"kubernetes.io/projected/8e1b4afa-3945-4d01-be2a-193b0cfdc8dc-kube-api-access-6lrj7\") pod \"kube-flannel-ds-tr6hz\" (UID: \"8e1b4afa-3945-4d01-be2a-193b0cfdc8dc\") " pod="kube-flannel/kube-flannel-ds-tr6hz" Jan 20 01:23:57.861312 kubelet[1864]: I0120 01:23:57.861280 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/381567c0-e1f0-409f-be06-afdf08bfc71c-kube-proxy\") pod \"kube-proxy-jkpdw\" (UID: \"381567c0-e1f0-409f-be06-afdf08bfc71c\") " pod="kube-system/kube-proxy-jkpdw" Jan 20 01:23:57.861462 kubelet[1864]: I0120 01:23:57.861316 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/381567c0-e1f0-409f-be06-afdf08bfc71c-lib-modules\") pod \"kube-proxy-jkpdw\" (UID: \"381567c0-e1f0-409f-be06-afdf08bfc71c\") " pod="kube-system/kube-proxy-jkpdw" Jan 20 01:23:57.874609 systemd[1]: Created slice kubepods-burstable-pod8e1b4afa_3945_4d01_be2a_193b0cfdc8dc.slice - libcontainer container kubepods-burstable-pod8e1b4afa_3945_4d01_be2a_193b0cfdc8dc.slice. Jan 20 01:23:58.174087 containerd[1495]: time="2026-01-20T01:23:58.173931015Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-jkpdw,Uid:381567c0-e1f0-409f-be06-afdf08bfc71c,Namespace:kube-system,Attempt:0,}" Jan 20 01:23:58.185840 containerd[1495]: time="2026-01-20T01:23:58.185709420Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-tr6hz,Uid:8e1b4afa-3945-4d01-be2a-193b0cfdc8dc,Namespace:kube-flannel,Attempt:0,}" Jan 20 01:23:58.836176 kubelet[1864]: E0120 01:23:58.836065 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:23:58.972650 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2653231186.mount: Deactivated successfully. Jan 20 01:23:58.978938 containerd[1495]: time="2026-01-20T01:23:58.978882762Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jan 20 01:23:58.980200 containerd[1495]: time="2026-01-20T01:23:58.980163222Z" level=info msg="ImageUpdate event name:\"registry.k8s.io/pause:3.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jan 20 01:23:58.982002 containerd[1495]: time="2026-01-20T01:23:58.981949841Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Jan 20 01:23:58.982096 containerd[1495]: time="2026-01-20T01:23:58.981997711Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312064" Jan 20 01:23:58.986532 containerd[1495]: time="2026-01-20T01:23:58.984466069Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jan 20 01:23:58.989879 containerd[1495]: time="2026-01-20T01:23:58.989844209Z" level=info msg="ImageCreate event name:\"registry.k8s.io/pause@sha256:9001185023633d17a2f98ff69b6ff2615b8ea02a825adffa40422f51dfdcde9d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Jan 20 01:23:58.993016 containerd[1495]: time="2026-01-20T01:23:58.992982029Z" 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 818.816343ms" Jan 20 01:23:58.994938 containerd[1495]: time="2026-01-20T01:23:58.994888108Z" 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 809.063633ms" Jan 20 01:23:59.147580 containerd[1495]: time="2026-01-20T01:23:59.146482766Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148053709Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148122905Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148146881Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148292437Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.147289205Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148392214Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:23:59.151380 containerd[1495]: time="2026-01-20T01:23:59.148566532Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:23:59.248751 systemd[1]: Started cri-containerd-1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918.scope - libcontainer container 1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918. Jan 20 01:23:59.252259 systemd[1]: Started cri-containerd-dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4.scope - libcontainer container dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4. Jan 20 01:23:59.314019 containerd[1495]: time="2026-01-20T01:23:59.313965988Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-jkpdw,Uid:381567c0-e1f0-409f-be06-afdf08bfc71c,Namespace:kube-system,Attempt:0,} returns sandbox id \"1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918\"" Jan 20 01:23:59.321909 containerd[1495]: time="2026-01-20T01:23:59.321439319Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.7\"" Jan 20 01:23:59.328893 containerd[1495]: time="2026-01-20T01:23:59.328843324Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-tr6hz,Uid:8e1b4afa-3945-4d01-be2a-193b0cfdc8dc,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\"" Jan 20 01:23:59.836931 kubelet[1864]: E0120 01:23:59.836640 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:00.013249 systemd[1]: run-containerd-runc-k8s.io-1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918-runc.PzsWCo.mount: Deactivated successfully. Jan 20 01:24:00.837840 kubelet[1864]: E0120 01:24:00.837728 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:01.487115 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3807806792.mount: Deactivated successfully. Jan 20 01:24:01.838718 kubelet[1864]: E0120 01:24:01.838562 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:02.255603 containerd[1495]: time="2026-01-20T01:24:02.255423170Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.33.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:02.256957 containerd[1495]: time="2026-01-20T01:24:02.256900869Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.33.7: active requests=0, bytes read=31930104" Jan 20 01:24:02.258094 containerd[1495]: time="2026-01-20T01:24:02.257683429Z" level=info msg="ImageCreate event name:\"sha256:0929027b17fc30cb9de279f3bdba4e130b991a1dab7978a7db2e5feb2091853c\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:02.260417 containerd[1495]: time="2026-01-20T01:24:02.260381446Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:ec25702b19026e9c0d339bc1c3bd231435a59f28b5fccb21e1b1078a357380f5\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:02.261556 containerd[1495]: time="2026-01-20T01:24:02.261492486Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.33.7\" with image id \"sha256:0929027b17fc30cb9de279f3bdba4e130b991a1dab7978a7db2e5feb2091853c\", repo tag \"registry.k8s.io/kube-proxy:v1.33.7\", repo digest \"registry.k8s.io/kube-proxy@sha256:ec25702b19026e9c0d339bc1c3bd231435a59f28b5fccb21e1b1078a357380f5\", size \"31929115\" in 2.939990051s" Jan 20 01:24:02.261645 containerd[1495]: time="2026-01-20T01:24:02.261560546Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.33.7\" returns image reference \"sha256:0929027b17fc30cb9de279f3bdba4e130b991a1dab7978a7db2e5feb2091853c\"" Jan 20 01:24:02.264836 containerd[1495]: time="2026-01-20T01:24:02.264805650Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Jan 20 01:24:02.268194 containerd[1495]: time="2026-01-20T01:24:02.268145853Z" level=info msg="CreateContainer within sandbox \"1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Jan 20 01:24:02.285349 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2499985853.mount: Deactivated successfully. Jan 20 01:24:02.289449 containerd[1495]: time="2026-01-20T01:24:02.288720323Z" level=info msg="CreateContainer within sandbox \"1ad711b824c80b74118f401616b2d057b0173f1b13ffa3b68da450db759fd918\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"71800e88a3c86fa2773b1939ab5a47e1b59855f63f1f70dbc90d5978e63a74d8\"" Jan 20 01:24:02.291580 containerd[1495]: time="2026-01-20T01:24:02.289746627Z" level=info msg="StartContainer for \"71800e88a3c86fa2773b1939ab5a47e1b59855f63f1f70dbc90d5978e63a74d8\"" Jan 20 01:24:02.334738 systemd[1]: Started cri-containerd-71800e88a3c86fa2773b1939ab5a47e1b59855f63f1f70dbc90d5978e63a74d8.scope - libcontainer container 71800e88a3c86fa2773b1939ab5a47e1b59855f63f1f70dbc90d5978e63a74d8. Jan 20 01:24:02.384535 containerd[1495]: time="2026-01-20T01:24:02.382884255Z" level=info msg="StartContainer for \"71800e88a3c86fa2773b1939ab5a47e1b59855f63f1f70dbc90d5978e63a74d8\" returns successfully" Jan 20 01:24:02.838822 kubelet[1864]: E0120 01:24:02.838755 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:03.030844 kubelet[1864]: I0120 01:24:03.030715 1864 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-system/kube-proxy-jkpdw" podStartSLOduration=3.088214105 podStartE2EDuration="6.030674806s" podCreationTimestamp="2026-01-20 01:23:57 +0000 UTC" firstStartedPulling="2026-01-20 01:23:59.320890579 +0000 UTC m=+3.006875664" lastFinishedPulling="2026-01-20 01:24:02.263351266 +0000 UTC m=+5.949336365" observedRunningTime="2026-01-20 01:24:03.029836059 +0000 UTC m=+6.715821196" watchObservedRunningTime="2026-01-20 01:24:03.030674806 +0000 UTC m=+6.716659896" Jan 20 01:24:03.637205 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount462849355.mount: Deactivated successfully. Jan 20 01:24:03.746100 containerd[1495]: time="2026-01-20T01:24:03.745708270Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:03.749068 containerd[1495]: time="2026-01-20T01:24:03.746241398Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Jan 20 01:24:03.749068 containerd[1495]: time="2026-01-20T01:24:03.748387543Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:03.753339 containerd[1495]: time="2026-01-20T01:24:03.753300568Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:03.758807 containerd[1495]: time="2026-01-20T01:24:03.758656875Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" with image id \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\", repo tag \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\", repo digest \"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\", size \"4856838\" in 1.493810099s" Jan 20 01:24:03.758807 containerd[1495]: time="2026-01-20T01:24:03.758757156Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Jan 20 01:24:03.769209 containerd[1495]: time="2026-01-20T01:24:03.769160973Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Jan 20 01:24:03.835275 containerd[1495]: time="2026-01-20T01:24:03.835224993Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d\"" Jan 20 01:24:03.836583 containerd[1495]: time="2026-01-20T01:24:03.836400622Z" level=info msg="StartContainer for \"56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d\"" Jan 20 01:24:03.839698 kubelet[1864]: E0120 01:24:03.839652 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:03.886810 systemd[1]: Started cri-containerd-56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d.scope - libcontainer container 56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d. Jan 20 01:24:03.925206 containerd[1495]: time="2026-01-20T01:24:03.925151996Z" level=info msg="StartContainer for \"56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d\" returns successfully" Jan 20 01:24:03.927660 systemd[1]: cri-containerd-56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d.scope: Deactivated successfully. Jan 20 01:24:04.101027 containerd[1495]: time="2026-01-20T01:24:04.100705953Z" level=info msg="shim disconnected" id=56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d namespace=k8s.io Jan 20 01:24:04.101027 containerd[1495]: time="2026-01-20T01:24:04.100816834Z" level=warning msg="cleaning up after shim disconnected" id=56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d namespace=k8s.io Jan 20 01:24:04.101027 containerd[1495]: time="2026-01-20T01:24:04.100841881Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jan 20 01:24:04.469602 systemd[1]: run-containerd-runc-k8s.io-56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d-runc.sHI1Dx.mount: Deactivated successfully. Jan 20 01:24:04.469775 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-56a36387dc2fea59bd2004a2ae03e9e2b1d7db5f23a5244f6b865a558377453d-rootfs.mount: Deactivated successfully. Jan 20 01:24:04.841387 kubelet[1864]: E0120 01:24:04.841183 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:05.021663 containerd[1495]: time="2026-01-20T01:24:05.021595656Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Jan 20 01:24:05.841710 kubelet[1864]: E0120 01:24:05.841658 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:06.842322 kubelet[1864]: E0120 01:24:06.842206 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:07.487579 containerd[1495]: time="2026-01-20T01:24:07.487462418Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:07.489475 containerd[1495]: time="2026-01-20T01:24:07.489412629Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Jan 20 01:24:07.490648 containerd[1495]: time="2026-01-20T01:24:07.489830130Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:07.494973 containerd[1495]: time="2026-01-20T01:24:07.494936174Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:07.497143 containerd[1495]: time="2026-01-20T01:24:07.497092903Z" level=info msg="Pulled image \"ghcr.io/flannel-io/flannel:v0.26.7\" with image id \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\", repo tag \"ghcr.io/flannel-io/flannel:v0.26.7\", repo digest \"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\", size \"32996046\" in 2.475429177s" Jan 20 01:24:07.497208 containerd[1495]: time="2026-01-20T01:24:07.497159838Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Jan 20 01:24:07.502964 containerd[1495]: time="2026-01-20T01:24:07.502914287Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Jan 20 01:24:07.516062 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1499914814.mount: Deactivated successfully. Jan 20 01:24:07.528267 containerd[1495]: time="2026-01-20T01:24:07.528220792Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32\"" Jan 20 01:24:07.529167 containerd[1495]: time="2026-01-20T01:24:07.529133860Z" level=info msg="StartContainer for \"d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32\"" Jan 20 01:24:07.579736 systemd[1]: Started cri-containerd-d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32.scope - libcontainer container d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32. Jan 20 01:24:07.617646 systemd[1]: cri-containerd-d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32.scope: Deactivated successfully. Jan 20 01:24:07.621281 containerd[1495]: time="2026-01-20T01:24:07.621237086Z" level=info msg="StartContainer for \"d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32\" returns successfully" Jan 20 01:24:07.645134 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32-rootfs.mount: Deactivated successfully. Jan 20 01:24:07.708136 kubelet[1864]: I0120 01:24:07.707185 1864 kubelet_node_status.go:501] "Fast updating node status as it just became ready" Jan 20 01:24:07.828150 containerd[1495]: time="2026-01-20T01:24:07.827904157Z" level=info msg="shim disconnected" id=d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32 namespace=k8s.io Jan 20 01:24:07.828150 containerd[1495]: time="2026-01-20T01:24:07.828031717Z" level=warning msg="cleaning up after shim disconnected" id=d40fa81c1ae0e6da757df9cd43bcaae3f074c9bc9ed2df530303493a87a5ce32 namespace=k8s.io Jan 20 01:24:07.828150 containerd[1495]: time="2026-01-20T01:24:07.828053292Z" level=info msg="cleaning up dead shim" namespace=k8s.io Jan 20 01:24:07.843281 kubelet[1864]: E0120 01:24:07.843203 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:08.033678 containerd[1495]: time="2026-01-20T01:24:08.033618637Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Jan 20 01:24:08.047279 containerd[1495]: time="2026-01-20T01:24:08.046962860Z" level=info msg="CreateContainer within sandbox \"dce8ab2c8426baa1611f62a30ae30ef7e865aea507159bf62aeca28184d8e2c4\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"69636aabc76fc7ab21efafff4f8d1576a1087b1662954fc0eda9f1a51e9376f2\"" Jan 20 01:24:08.048139 containerd[1495]: time="2026-01-20T01:24:08.047998945Z" level=info msg="StartContainer for \"69636aabc76fc7ab21efafff4f8d1576a1087b1662954fc0eda9f1a51e9376f2\"" Jan 20 01:24:08.082774 systemd[1]: Started cri-containerd-69636aabc76fc7ab21efafff4f8d1576a1087b1662954fc0eda9f1a51e9376f2.scope - libcontainer container 69636aabc76fc7ab21efafff4f8d1576a1087b1662954fc0eda9f1a51e9376f2. Jan 20 01:24:08.122798 containerd[1495]: time="2026-01-20T01:24:08.122160077Z" level=info msg="StartContainer for \"69636aabc76fc7ab21efafff4f8d1576a1087b1662954fc0eda9f1a51e9376f2\" returns successfully" Jan 20 01:24:08.345419 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jan 20 01:24:08.844170 kubelet[1864]: E0120 01:24:08.843977 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:09.050539 kubelet[1864]: I0120 01:24:09.050139 1864 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-tr6hz" podStartSLOduration=3.881358691 podStartE2EDuration="12.050096458s" podCreationTimestamp="2026-01-20 01:23:57 +0000 UTC" firstStartedPulling="2026-01-20 01:23:59.330882457 +0000 UTC m=+3.016867550" lastFinishedPulling="2026-01-20 01:24:07.499620231 +0000 UTC m=+11.185605317" observedRunningTime="2026-01-20 01:24:09.049582431 +0000 UTC m=+12.735567561" watchObservedRunningTime="2026-01-20 01:24:09.050096458 +0000 UTC m=+12.736081551" Jan 20 01:24:09.203790 systemd-networkd[1435]: flannel.1: Link UP Jan 20 01:24:09.203809 systemd-networkd[1435]: flannel.1: Gained carrier Jan 20 01:24:09.844781 kubelet[1864]: E0120 01:24:09.844704 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:10.593934 systemd-networkd[1435]: flannel.1: Gained IPv6LL Jan 20 01:24:10.845591 kubelet[1864]: E0120 01:24:10.845331 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:11.845874 kubelet[1864]: E0120 01:24:11.845794 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:12.204897 systemd[1]: Created slice kubepods-besteffort-podc5d39308_2b85_47ca_8d3a_c897955b8167.slice - libcontainer container kubepods-besteffort-podc5d39308_2b85_47ca_8d3a_c897955b8167.slice. Jan 20 01:24:12.253767 kubelet[1864]: I0120 01:24:12.253679 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-rmqp6\" (UniqueName: \"kubernetes.io/projected/c5d39308-2b85-47ca-8d3a-c897955b8167-kube-api-access-rmqp6\") pod \"nginx-deployment-7fcdb87857-vs9zw\" (UID: \"c5d39308-2b85-47ca-8d3a-c897955b8167\") " pod="default/nginx-deployment-7fcdb87857-vs9zw" Jan 20 01:24:12.510635 containerd[1495]: time="2026-01-20T01:24:12.509986101Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-vs9zw,Uid:c5d39308-2b85-47ca-8d3a-c897955b8167,Namespace:default,Attempt:0,}" Jan 20 01:24:12.546156 systemd-networkd[1435]: cni0: Link UP Jan 20 01:24:12.546167 systemd-networkd[1435]: cni0: Gained carrier Jan 20 01:24:12.552393 systemd-networkd[1435]: cni0: Lost carrier Jan 20 01:24:12.561496 systemd-networkd[1435]: veth94df69e8: Link UP Jan 20 01:24:12.566212 kernel: cni0: port 1(veth94df69e8) entered blocking state Jan 20 01:24:12.566456 kernel: cni0: port 1(veth94df69e8) entered disabled state Jan 20 01:24:12.568827 kernel: veth94df69e8: entered allmulticast mode Jan 20 01:24:12.568918 kernel: veth94df69e8: entered promiscuous mode Jan 20 01:24:12.572866 kernel: cni0: port 1(veth94df69e8) entered blocking state Jan 20 01:24:12.572944 kernel: cni0: port 1(veth94df69e8) entered forwarding state Jan 20 01:24:12.572996 kernel: cni0: port 1(veth94df69e8) entered disabled state Jan 20 01:24:12.587469 kernel: cni0: port 1(veth94df69e8) entered blocking state Jan 20 01:24:12.587714 kernel: cni0: port 1(veth94df69e8) entered forwarding state Jan 20 01:24:12.591687 systemd-networkd[1435]: veth94df69e8: Gained carrier Jan 20 01:24:12.592323 systemd-networkd[1435]: cni0: Gained carrier Jan 20 01:24:12.595321 containerd[1495]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc000084950), "name":"cbr0", "type":"bridge"} Jan 20 01:24:12.595321 containerd[1495]: delegateAdd: netconf sent to delegate plugin: Jan 20 01:24:12.633381 containerd[1495]: {"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="2026-01-20T01:24:12.633027713Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 20 01:24:12.633381 containerd[1495]: time="2026-01-20T01:24:12.633124838Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 20 01:24:12.633381 containerd[1495]: time="2026-01-20T01:24:12.633148764Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:12.633381 containerd[1495]: time="2026-01-20T01:24:12.633275860Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:12.670786 systemd[1]: Started cri-containerd-503012f82ba09d8fdb34d9686ed3649fb410f751fad23c051f2227b267e9618a.scope - libcontainer container 503012f82ba09d8fdb34d9686ed3649fb410f751fad23c051f2227b267e9618a. Jan 20 01:24:12.726797 containerd[1495]: time="2026-01-20T01:24:12.726727049Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-7fcdb87857-vs9zw,Uid:c5d39308-2b85-47ca-8d3a-c897955b8167,Namespace:default,Attempt:0,} returns sandbox id \"503012f82ba09d8fdb34d9686ed3649fb410f751fad23c051f2227b267e9618a\"" Jan 20 01:24:12.728862 containerd[1495]: time="2026-01-20T01:24:12.728811775Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jan 20 01:24:12.847737 kubelet[1864]: E0120 01:24:12.846480 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:13.665782 systemd-networkd[1435]: veth94df69e8: Gained IPv6LL Jan 20 01:24:13.847792 kubelet[1864]: E0120 01:24:13.847715 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:13.921894 systemd-networkd[1435]: cni0: Gained IPv6LL Jan 20 01:24:14.849190 kubelet[1864]: E0120 01:24:14.848978 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:15.206109 systemd[1]: Started sshd@9-10.230.30.174:22-164.92.217.44:48586.service - OpenSSH per-connection server daemon (164.92.217.44:48586). Jan 20 01:24:15.393552 sshd[2539]: Connection closed by authenticating user root 164.92.217.44 port 48586 [preauth] Jan 20 01:24:15.394086 systemd[1]: sshd@9-10.230.30.174:22-164.92.217.44:48586.service: Deactivated successfully. Jan 20 01:24:15.851297 kubelet[1864]: E0120 01:24:15.850229 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:16.536148 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1400601990.mount: Deactivated successfully. Jan 20 01:24:16.835537 kubelet[1864]: E0120 01:24:16.835107 1864 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:16.851941 kubelet[1864]: E0120 01:24:16.851748 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:17.852355 kubelet[1864]: E0120 01:24:17.852213 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:17.968886 containerd[1495]: time="2026-01-20T01:24:17.968765048Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:17.970455 containerd[1495]: time="2026-01-20T01:24:17.969977514Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=63836480" Jan 20 01:24:17.971547 containerd[1495]: time="2026-01-20T01:24:17.971202904Z" level=info msg="ImageCreate event name:\"sha256:94a30ed18e45363486a55379bd1fbb8c479f36524ae816779f3553afe6b787ed\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:17.976544 containerd[1495]: time="2026-01-20T01:24:17.975683690Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:32c5137cb8c7cf61e75836f150e983b9be21fecc642ada89fd936c8cd6c0faa0\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:17.978138 containerd[1495]: time="2026-01-20T01:24:17.977329498Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:94a30ed18e45363486a55379bd1fbb8c479f36524ae816779f3553afe6b787ed\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:32c5137cb8c7cf61e75836f150e983b9be21fecc642ada89fd936c8cd6c0faa0\", size \"63836358\" in 5.248440861s" Jan 20 01:24:17.978138 containerd[1495]: time="2026-01-20T01:24:17.977397361Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:94a30ed18e45363486a55379bd1fbb8c479f36524ae816779f3553afe6b787ed\"" Jan 20 01:24:17.984321 containerd[1495]: time="2026-01-20T01:24:17.984275335Z" level=info msg="CreateContainer within sandbox \"503012f82ba09d8fdb34d9686ed3649fb410f751fad23c051f2227b267e9618a\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Jan 20 01:24:18.002198 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2400720205.mount: Deactivated successfully. Jan 20 01:24:18.003451 containerd[1495]: time="2026-01-20T01:24:18.003408966Z" level=info msg="CreateContainer within sandbox \"503012f82ba09d8fdb34d9686ed3649fb410f751fad23c051f2227b267e9618a\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"9505ae6a8954a66aad466393aa894784dfe3e897199a8658e4b5bab25c4f46b5\"" Jan 20 01:24:18.006277 containerd[1495]: time="2026-01-20T01:24:18.004837292Z" level=info msg="StartContainer for \"9505ae6a8954a66aad466393aa894784dfe3e897199a8658e4b5bab25c4f46b5\"" Jan 20 01:24:18.058849 systemd[1]: Started cri-containerd-9505ae6a8954a66aad466393aa894784dfe3e897199a8658e4b5bab25c4f46b5.scope - libcontainer container 9505ae6a8954a66aad466393aa894784dfe3e897199a8658e4b5bab25c4f46b5. Jan 20 01:24:18.100450 containerd[1495]: time="2026-01-20T01:24:18.100352257Z" level=info msg="StartContainer for \"9505ae6a8954a66aad466393aa894784dfe3e897199a8658e4b5bab25c4f46b5\" returns successfully" Jan 20 01:24:18.296962 systemd[1]: Started sshd@10-10.230.30.174:22-188.166.25.188:50384.service - OpenSSH per-connection server daemon (188.166.25.188:50384). Jan 20 01:24:18.497193 sshd[2622]: Connection closed by authenticating user root 188.166.25.188 port 50384 [preauth] Jan 20 01:24:18.500288 systemd[1]: sshd@10-10.230.30.174:22-188.166.25.188:50384.service: Deactivated successfully. Jan 20 01:24:18.854043 kubelet[1864]: E0120 01:24:18.853966 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:19.296557 kubelet[1864]: I0120 01:24:19.296080 1864 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nginx-deployment-7fcdb87857-vs9zw" podStartSLOduration=2.044441222 podStartE2EDuration="7.296022312s" podCreationTimestamp="2026-01-20 01:24:12 +0000 UTC" firstStartedPulling="2026-01-20 01:24:12.728162213 +0000 UTC m=+16.414147295" lastFinishedPulling="2026-01-20 01:24:17.979743297 +0000 UTC m=+21.665728385" observedRunningTime="2026-01-20 01:24:19.293150062 +0000 UTC m=+22.979135155" watchObservedRunningTime="2026-01-20 01:24:19.296022312 +0000 UTC m=+22.982007429" Jan 20 01:24:19.855278 kubelet[1864]: E0120 01:24:19.855197 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:20.856531 kubelet[1864]: E0120 01:24:20.856422 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:21.061593 update_engine[1486]: I20260120 01:24:21.061055 1486 update_attempter.cc:509] Updating boot flags... Jan 20 01:24:21.111814 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2653) Jan 20 01:24:21.197722 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2652) Jan 20 01:24:21.271638 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2652) Jan 20 01:24:21.857417 kubelet[1864]: E0120 01:24:21.857338 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:22.857995 kubelet[1864]: E0120 01:24:22.857879 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:22.911851 systemd[1]: Created slice kubepods-besteffort-podcf17fe92_1c76_406b_b97f_9f294fbc1db4.slice - libcontainer container kubepods-besteffort-podcf17fe92_1c76_406b_b97f_9f294fbc1db4.slice. Jan 20 01:24:22.933428 kubelet[1864]: I0120 01:24:22.933278 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/cf17fe92-1c76-406b-b97f-9f294fbc1db4-data\") pod \"nfs-server-provisioner-0\" (UID: \"cf17fe92-1c76-406b-b97f-9f294fbc1db4\") " pod="default/nfs-server-provisioner-0" Jan 20 01:24:22.933428 kubelet[1864]: I0120 01:24:22.933358 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-wfh62\" (UniqueName: \"kubernetes.io/projected/cf17fe92-1c76-406b-b97f-9f294fbc1db4-kube-api-access-wfh62\") pod \"nfs-server-provisioner-0\" (UID: \"cf17fe92-1c76-406b-b97f-9f294fbc1db4\") " pod="default/nfs-server-provisioner-0" Jan 20 01:24:23.220387 containerd[1495]: time="2026-01-20T01:24:23.219214729Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:cf17fe92-1c76-406b-b97f-9f294fbc1db4,Namespace:default,Attempt:0,}" Jan 20 01:24:23.274993 systemd-networkd[1435]: vethb4a5a358: Link UP Jan 20 01:24:23.277759 kernel: cni0: port 2(vethb4a5a358) entered blocking state Jan 20 01:24:23.277905 kernel: cni0: port 2(vethb4a5a358) entered disabled state Jan 20 01:24:23.284309 kernel: vethb4a5a358: entered allmulticast mode Jan 20 01:24:23.285077 kernel: vethb4a5a358: entered promiscuous mode Jan 20 01:24:23.314722 kernel: cni0: port 2(vethb4a5a358) entered blocking state Jan 20 01:24:23.314833 kernel: cni0: port 2(vethb4a5a358) entered forwarding state Jan 20 01:24:23.314864 systemd-networkd[1435]: vethb4a5a358: Gained carrier Jan 20 01:24:23.322676 containerd[1495]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Jan 20 01:24:23.322676 containerd[1495]: delegateAdd: netconf sent to delegate plugin: Jan 20 01:24:23.359746 containerd[1495]: {"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="2026-01-20T01:24:23.359570125Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 20 01:24:23.359746 containerd[1495]: time="2026-01-20T01:24:23.359686084Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 20 01:24:23.359746 containerd[1495]: time="2026-01-20T01:24:23.359710687Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:23.360157 containerd[1495]: time="2026-01-20T01:24:23.359902259Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:23.393108 systemd[1]: Started cri-containerd-cc9f73958232de549c88010c74c8e65fb38d267b189fd823d22d2aa98473c0b6.scope - libcontainer container cc9f73958232de549c88010c74c8e65fb38d267b189fd823d22d2aa98473c0b6. Jan 20 01:24:23.453970 containerd[1495]: time="2026-01-20T01:24:23.453871730Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:cf17fe92-1c76-406b-b97f-9f294fbc1db4,Namespace:default,Attempt:0,} returns sandbox id \"cc9f73958232de549c88010c74c8e65fb38d267b189fd823d22d2aa98473c0b6\"" Jan 20 01:24:23.458152 containerd[1495]: time="2026-01-20T01:24:23.457688260Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Jan 20 01:24:23.859005 kubelet[1864]: E0120 01:24:23.858857 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:24.860034 kubelet[1864]: E0120 01:24:24.859926 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:25.249925 systemd-networkd[1435]: vethb4a5a358: Gained IPv6LL Jan 20 01:24:25.862772 kubelet[1864]: E0120 01:24:25.862684 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:26.863852 kubelet[1864]: E0120 01:24:26.863729 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:27.864146 kubelet[1864]: E0120 01:24:27.864024 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:28.865156 kubelet[1864]: E0120 01:24:28.864981 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:29.867651 kubelet[1864]: E0120 01:24:29.866441 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:30.005832 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3994779915.mount: Deactivated successfully. Jan 20 01:24:30.868530 kubelet[1864]: E0120 01:24:30.868404 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:31.869544 kubelet[1864]: E0120 01:24:31.868799 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:32.869855 kubelet[1864]: E0120 01:24:32.869673 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:33.148654 containerd[1495]: time="2026-01-20T01:24:33.146836518Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:33.148654 containerd[1495]: time="2026-01-20T01:24:33.148265410Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039414" Jan 20 01:24:33.149763 containerd[1495]: time="2026-01-20T01:24:33.149713570Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:33.154395 containerd[1495]: time="2026-01-20T01:24:33.154350181Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:33.156230 containerd[1495]: time="2026-01-20T01:24:33.156175484Z" 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 9.698426907s" Jan 20 01:24:33.156417 containerd[1495]: time="2026-01-20T01:24:33.156374178Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Jan 20 01:24:33.163128 containerd[1495]: time="2026-01-20T01:24:33.162612150Z" level=info msg="CreateContainer within sandbox \"cc9f73958232de549c88010c74c8e65fb38d267b189fd823d22d2aa98473c0b6\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Jan 20 01:24:33.186238 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount1673240852.mount: Deactivated successfully. Jan 20 01:24:33.189051 containerd[1495]: time="2026-01-20T01:24:33.188988851Z" level=info msg="CreateContainer within sandbox \"cc9f73958232de549c88010c74c8e65fb38d267b189fd823d22d2aa98473c0b6\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"cce3e4a92dd4c8a7938d1084bdf59ae63c22418208dbbac6954d31c58d7d3b36\"" Jan 20 01:24:33.190577 containerd[1495]: time="2026-01-20T01:24:33.190542675Z" level=info msg="StartContainer for \"cce3e4a92dd4c8a7938d1084bdf59ae63c22418208dbbac6954d31c58d7d3b36\"" Jan 20 01:24:33.303831 systemd[1]: Started cri-containerd-cce3e4a92dd4c8a7938d1084bdf59ae63c22418208dbbac6954d31c58d7d3b36.scope - libcontainer container cce3e4a92dd4c8a7938d1084bdf59ae63c22418208dbbac6954d31c58d7d3b36. Jan 20 01:24:33.346680 containerd[1495]: time="2026-01-20T01:24:33.346497951Z" level=info msg="StartContainer for \"cce3e4a92dd4c8a7938d1084bdf59ae63c22418208dbbac6954d31c58d7d3b36\" returns successfully" Jan 20 01:24:33.872139 kubelet[1864]: E0120 01:24:33.871956 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:34.872703 kubelet[1864]: E0120 01:24:34.872618 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:35.873860 kubelet[1864]: E0120 01:24:35.873763 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:36.834751 kubelet[1864]: E0120 01:24:36.834647 1864 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:36.874333 kubelet[1864]: E0120 01:24:36.874250 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:37.875423 kubelet[1864]: E0120 01:24:37.875309 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:38.649609 kubelet[1864]: I0120 01:24:38.648986 1864 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.947757096 podStartE2EDuration="16.648921472s" podCreationTimestamp="2026-01-20 01:24:22 +0000 UTC" firstStartedPulling="2026-01-20 01:24:23.457116354 +0000 UTC m=+27.143101439" lastFinishedPulling="2026-01-20 01:24:33.158280729 +0000 UTC m=+36.844265815" observedRunningTime="2026-01-20 01:24:34.138198574 +0000 UTC m=+37.824183669" watchObservedRunningTime="2026-01-20 01:24:38.648921472 +0000 UTC m=+42.334906567" Jan 20 01:24:38.662303 systemd[1]: Created slice kubepods-besteffort-podd5737b4d_19f8_46aa_91b8_ada420e1ac0b.slice - libcontainer container kubepods-besteffort-podd5737b4d_19f8_46aa_91b8_ada420e1ac0b.slice. Jan 20 01:24:38.747286 kubelet[1864]: I0120 01:24:38.747191 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-bg5mf\" (UniqueName: \"kubernetes.io/projected/d5737b4d-19f8-46aa-91b8-ada420e1ac0b-kube-api-access-bg5mf\") pod \"test-pod-1\" (UID: \"d5737b4d-19f8-46aa-91b8-ada420e1ac0b\") " pod="default/test-pod-1" Jan 20 01:24:38.747286 kubelet[1864]: I0120 01:24:38.747255 1864 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-da9788d0-cc75-4ddb-8937-3e3ea6929836\" (UniqueName: \"kubernetes.io/nfs/d5737b4d-19f8-46aa-91b8-ada420e1ac0b-pvc-da9788d0-cc75-4ddb-8937-3e3ea6929836\") pod \"test-pod-1\" (UID: \"d5737b4d-19f8-46aa-91b8-ada420e1ac0b\") " pod="default/test-pod-1" Jan 20 01:24:38.876550 kubelet[1864]: E0120 01:24:38.876445 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:38.907541 kernel: FS-Cache: Loaded Jan 20 01:24:39.004982 kernel: RPC: Registered named UNIX socket transport module. Jan 20 01:24:39.005187 kernel: RPC: Registered udp transport module. Jan 20 01:24:39.005911 kernel: RPC: Registered tcp transport module. Jan 20 01:24:39.006985 kernel: RPC: Registered tcp-with-tls transport module. Jan 20 01:24:39.009268 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Jan 20 01:24:39.354082 kernel: NFS: Registering the id_resolver key type Jan 20 01:24:39.354342 kernel: Key type id_resolver registered Jan 20 01:24:39.354402 kernel: Key type id_legacy registered Jan 20 01:24:39.410551 nfsidmap[2933]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'gb1.brightbox.com' Jan 20 01:24:39.419562 nfsidmap[2936]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'gb1.brightbox.com' Jan 20 01:24:39.567578 containerd[1495]: time="2026-01-20T01:24:39.567366817Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:d5737b4d-19f8-46aa-91b8-ada420e1ac0b,Namespace:default,Attempt:0,}" Jan 20 01:24:39.617341 kernel: cni0: port 3(vethdc155a0a) entered blocking state Jan 20 01:24:39.617551 kernel: cni0: port 3(vethdc155a0a) entered disabled state Jan 20 01:24:39.613762 systemd-networkd[1435]: vethdc155a0a: Link UP Jan 20 01:24:39.619541 kernel: vethdc155a0a: entered allmulticast mode Jan 20 01:24:39.621536 kernel: vethdc155a0a: entered promiscuous mode Jan 20 01:24:39.631340 kernel: cni0: port 3(vethdc155a0a) entered blocking state Jan 20 01:24:39.631444 kernel: cni0: port 3(vethdc155a0a) entered forwarding state Jan 20 01:24:39.631921 systemd-networkd[1435]: vethdc155a0a: Gained carrier Jan 20 01:24:39.638219 containerd[1495]: 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), MTU:0, AdvMSS:0, Priority:0, Table:(*int)(nil), Scope:(*int)(nil)}}, "type":"host-local"}, "isDefaultGateway":true, "isGateway":true, "mtu":(*uint)(0xc0000129a0), "name":"cbr0", "type":"bridge"} Jan 20 01:24:39.638219 containerd[1495]: delegateAdd: netconf sent to delegate plugin: Jan 20 01:24:39.688538 containerd[1495]: {"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="2026-01-20T01:24:39.688077359Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Jan 20 01:24:39.688538 containerd[1495]: time="2026-01-20T01:24:39.688201830Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Jan 20 01:24:39.688538 containerd[1495]: time="2026-01-20T01:24:39.688251511Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:39.688991 containerd[1495]: time="2026-01-20T01:24:39.688736360Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Jan 20 01:24:39.721807 systemd[1]: Started cri-containerd-e57823e6444fcfe448105b6ecd65e86cf64ebde12ffff193e1d996e8f5cb108e.scope - libcontainer container e57823e6444fcfe448105b6ecd65e86cf64ebde12ffff193e1d996e8f5cb108e. Jan 20 01:24:39.789554 containerd[1495]: time="2026-01-20T01:24:39.787189574Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:d5737b4d-19f8-46aa-91b8-ada420e1ac0b,Namespace:default,Attempt:0,} returns sandbox id \"e57823e6444fcfe448105b6ecd65e86cf64ebde12ffff193e1d996e8f5cb108e\"" Jan 20 01:24:39.792431 containerd[1495]: time="2026-01-20T01:24:39.792302724Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Jan 20 01:24:39.877663 kubelet[1864]: E0120 01:24:39.877327 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:40.127539 containerd[1495]: time="2026-01-20T01:24:40.125667687Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Jan 20 01:24:40.127539 containerd[1495]: time="2026-01-20T01:24:40.126332292Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Jan 20 01:24:40.132020 containerd[1495]: time="2026-01-20T01:24:40.131880615Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:94a30ed18e45363486a55379bd1fbb8c479f36524ae816779f3553afe6b787ed\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:32c5137cb8c7cf61e75836f150e983b9be21fecc642ada89fd936c8cd6c0faa0\", size \"63836358\" in 339.534219ms" Jan 20 01:24:40.132020 containerd[1495]: time="2026-01-20T01:24:40.131948503Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:94a30ed18e45363486a55379bd1fbb8c479f36524ae816779f3553afe6b787ed\"" Jan 20 01:24:40.136979 containerd[1495]: time="2026-01-20T01:24:40.136945062Z" level=info msg="CreateContainer within sandbox \"e57823e6444fcfe448105b6ecd65e86cf64ebde12ffff193e1d996e8f5cb108e\" for container &ContainerMetadata{Name:test,Attempt:0,}" Jan 20 01:24:40.156992 containerd[1495]: time="2026-01-20T01:24:40.156946565Z" level=info msg="CreateContainer within sandbox \"e57823e6444fcfe448105b6ecd65e86cf64ebde12ffff193e1d996e8f5cb108e\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"3617082b86df1aa0675dded235c02159c7d4efe0e57fbf612cd44c6525ba4f95\"" Jan 20 01:24:40.157935 containerd[1495]: time="2026-01-20T01:24:40.157898515Z" level=info msg="StartContainer for \"3617082b86df1aa0675dded235c02159c7d4efe0e57fbf612cd44c6525ba4f95\"" Jan 20 01:24:40.205890 systemd[1]: Started cri-containerd-3617082b86df1aa0675dded235c02159c7d4efe0e57fbf612cd44c6525ba4f95.scope - libcontainer container 3617082b86df1aa0675dded235c02159c7d4efe0e57fbf612cd44c6525ba4f95. Jan 20 01:24:40.260559 containerd[1495]: time="2026-01-20T01:24:40.260358559Z" level=info msg="StartContainer for \"3617082b86df1aa0675dded235c02159c7d4efe0e57fbf612cd44c6525ba4f95\" returns successfully" Jan 20 01:24:40.879398 kubelet[1864]: E0120 01:24:40.879309 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:41.153750 kubelet[1864]: I0120 01:24:41.153323 1864 pod_startup_latency_tracker.go:104] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=16.812390358000002 podStartE2EDuration="17.153303095s" podCreationTimestamp="2026-01-20 01:24:24 +0000 UTC" firstStartedPulling="2026-01-20 01:24:39.791928926 +0000 UTC m=+43.477914012" lastFinishedPulling="2026-01-20 01:24:40.132841655 +0000 UTC m=+43.818826749" observedRunningTime="2026-01-20 01:24:41.152805156 +0000 UTC m=+44.838790255" watchObservedRunningTime="2026-01-20 01:24:41.153303095 +0000 UTC m=+44.839288176" Jan 20 01:24:41.250120 systemd-networkd[1435]: vethdc155a0a: Gained IPv6LL Jan 20 01:24:41.879874 kubelet[1864]: E0120 01:24:41.879783 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:42.881124 kubelet[1864]: E0120 01:24:42.881030 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:43.882093 kubelet[1864]: E0120 01:24:43.882007 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:44.883246 kubelet[1864]: E0120 01:24:44.883167 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:45.883942 kubelet[1864]: E0120 01:24:45.883847 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Jan 20 01:24:46.884706 kubelet[1864]: E0120 01:24:46.884630 1864 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"