Mar 12 04:33:45.069299 kernel: Linux version 6.6.127-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 Wed Mar 11 23:23:33 -00 2026 Mar 12 04:33:45.069333 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=0e4243d51ac00bffbb09a606c7378a821ca08f30dbebc6b82c4452fcc120d7bc Mar 12 04:33:45.069347 kernel: BIOS-provided physical RAM map: Mar 12 04:33:45.069363 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Mar 12 04:33:45.069373 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Mar 12 04:33:45.069383 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Mar 12 04:33:45.069395 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000007ffdbfff] usable Mar 12 04:33:45.069405 kernel: BIOS-e820: [mem 0x000000007ffdc000-0x000000007fffffff] reserved Mar 12 04:33:45.069415 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Mar 12 04:33:45.069426 kernel: BIOS-e820: [mem 0x00000000fed1c000-0x00000000fed1ffff] reserved Mar 12 04:33:45.069436 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Mar 12 04:33:45.069447 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Mar 12 04:33:45.069462 kernel: NX (Execute Disable) protection: active Mar 12 04:33:45.069473 kernel: APIC: Static calls initialized Mar 12 04:33:45.069485 kernel: SMBIOS 2.8 present. Mar 12 04:33:45.069497 kernel: DMI: Red Hat KVM/RHEL-AV, BIOS 1.13.0-2.module_el8.5.0+2608+72063365 04/01/2014 Mar 12 04:33:45.069508 kernel: Hypervisor detected: KVM Mar 12 04:33:45.069524 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Mar 12 04:33:45.069536 kernel: kvm-clock: using sched offset of 4465143418 cycles Mar 12 04:33:45.069548 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Mar 12 04:33:45.069560 kernel: tsc: Detected 2499.998 MHz processor Mar 12 04:33:45.069583 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Mar 12 04:33:45.069595 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Mar 12 04:33:45.069606 kernel: last_pfn = 0x7ffdc max_arch_pfn = 0x400000000 Mar 12 04:33:45.069617 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Mar 12 04:33:45.069641 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Mar 12 04:33:45.069657 kernel: Using GB pages for direct mapping Mar 12 04:33:45.069669 kernel: ACPI: Early table checksum verification disabled Mar 12 04:33:45.069680 kernel: ACPI: RSDP 0x00000000000F5AA0 000014 (v00 BOCHS ) Mar 12 04:33:45.069692 kernel: ACPI: RSDT 0x000000007FFE47A5 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069703 kernel: ACPI: FACP 0x000000007FFE438D 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069715 kernel: ACPI: DSDT 0x000000007FFDFD80 00460D (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069738 kernel: ACPI: FACS 0x000000007FFDFD40 000040 Mar 12 04:33:45.069749 kernel: ACPI: APIC 0x000000007FFE4481 0000F0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069760 kernel: ACPI: SRAT 0x000000007FFE4571 0001D0 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069776 kernel: ACPI: MCFG 0x000000007FFE4741 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069800 kernel: ACPI: WAET 0x000000007FFE477D 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Mar 12 04:33:45.069812 kernel: ACPI: Reserving FACP table memory at [mem 0x7ffe438d-0x7ffe4480] Mar 12 04:33:45.069823 kernel: ACPI: Reserving DSDT table memory at [mem 0x7ffdfd80-0x7ffe438c] Mar 12 04:33:45.069835 kernel: ACPI: Reserving FACS table memory at [mem 0x7ffdfd40-0x7ffdfd7f] Mar 12 04:33:45.069852 kernel: ACPI: Reserving APIC table memory at [mem 0x7ffe4481-0x7ffe4570] Mar 12 04:33:45.069864 kernel: ACPI: Reserving SRAT table memory at [mem 0x7ffe4571-0x7ffe4740] Mar 12 04:33:45.069881 kernel: ACPI: Reserving MCFG table memory at [mem 0x7ffe4741-0x7ffe477c] Mar 12 04:33:45.069893 kernel: ACPI: Reserving WAET table memory at [mem 0x7ffe477d-0x7ffe47a4] Mar 12 04:33:45.069905 kernel: SRAT: PXM 0 -> APIC 0x00 -> Node 0 Mar 12 04:33:45.069917 kernel: SRAT: PXM 0 -> APIC 0x01 -> Node 0 Mar 12 04:33:45.069929 kernel: SRAT: PXM 0 -> APIC 0x02 -> Node 0 Mar 12 04:33:45.069941 kernel: SRAT: PXM 0 -> APIC 0x03 -> Node 0 Mar 12 04:33:45.069953 kernel: SRAT: PXM 0 -> APIC 0x04 -> Node 0 Mar 12 04:33:45.069964 kernel: SRAT: PXM 0 -> APIC 0x05 -> Node 0 Mar 12 04:33:45.069981 kernel: SRAT: PXM 0 -> APIC 0x06 -> Node 0 Mar 12 04:33:45.069993 kernel: SRAT: PXM 0 -> APIC 0x07 -> Node 0 Mar 12 04:33:45.070005 kernel: SRAT: PXM 0 -> APIC 0x08 -> Node 0 Mar 12 04:33:45.070016 kernel: SRAT: PXM 0 -> APIC 0x09 -> Node 0 Mar 12 04:33:45.070028 kernel: SRAT: PXM 0 -> APIC 0x0a -> Node 0 Mar 12 04:33:45.070040 kernel: SRAT: PXM 0 -> APIC 0x0b -> Node 0 Mar 12 04:33:45.070052 kernel: SRAT: PXM 0 -> APIC 0x0c -> Node 0 Mar 12 04:33:45.070064 kernel: SRAT: PXM 0 -> APIC 0x0d -> Node 0 Mar 12 04:33:45.070076 kernel: SRAT: PXM 0 -> APIC 0x0e -> Node 0 Mar 12 04:33:45.070092 kernel: SRAT: PXM 0 -> APIC 0x0f -> Node 0 Mar 12 04:33:45.071159 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00000000-0x0009ffff] Mar 12 04:33:45.071176 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x00100000-0x7fffffff] Mar 12 04:33:45.071189 kernel: ACPI: SRAT: Node 0 PXM 0 [mem 0x100000000-0x20800fffff] hotplug Mar 12 04:33:45.071201 kernel: NUMA: Node 0 [mem 0x00000000-0x0009ffff] + [mem 0x00100000-0x7ffdbfff] -> [mem 0x00000000-0x7ffdbfff] Mar 12 04:33:45.071213 kernel: NODE_DATA(0) allocated [mem 0x7ffd6000-0x7ffdbfff] Mar 12 04:33:45.071226 kernel: Zone ranges: Mar 12 04:33:45.071238 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Mar 12 04:33:45.071250 kernel: DMA32 [mem 0x0000000001000000-0x000000007ffdbfff] Mar 12 04:33:45.071269 kernel: Normal empty Mar 12 04:33:45.071282 kernel: Movable zone start for each node Mar 12 04:33:45.071294 kernel: Early memory node ranges Mar 12 04:33:45.071306 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Mar 12 04:33:45.071318 kernel: node 0: [mem 0x0000000000100000-0x000000007ffdbfff] Mar 12 04:33:45.071329 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000007ffdbfff] Mar 12 04:33:45.071341 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Mar 12 04:33:45.071353 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Mar 12 04:33:45.071365 kernel: On node 0, zone DMA32: 36 pages in unavailable ranges Mar 12 04:33:45.071377 kernel: ACPI: PM-Timer IO Port: 0x608 Mar 12 04:33:45.071394 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Mar 12 04:33:45.071407 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Mar 12 04:33:45.071419 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Mar 12 04:33:45.071431 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Mar 12 04:33:45.071443 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Mar 12 04:33:45.071455 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Mar 12 04:33:45.071467 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Mar 12 04:33:45.071479 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Mar 12 04:33:45.071491 kernel: TSC deadline timer available Mar 12 04:33:45.071507 kernel: smpboot: Allowing 16 CPUs, 14 hotplug CPUs Mar 12 04:33:45.071520 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Mar 12 04:33:45.071532 kernel: [mem 0xc0000000-0xfed1bfff] available for PCI devices Mar 12 04:33:45.071544 kernel: Booting paravirtualized kernel on KVM Mar 12 04:33:45.071556 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Mar 12 04:33:45.071568 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:16 nr_cpu_ids:16 nr_node_ids:1 Mar 12 04:33:45.071580 kernel: percpu: Embedded 57 pages/cpu s196328 r8192 d28952 u262144 Mar 12 04:33:45.071592 kernel: pcpu-alloc: s196328 r8192 d28952 u262144 alloc=1*2097152 Mar 12 04:33:45.071604 kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Mar 12 04:33:45.071621 kernel: kvm-guest: PV spinlocks enabled Mar 12 04:33:45.071645 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Mar 12 04:33:45.071659 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=0e4243d51ac00bffbb09a606c7378a821ca08f30dbebc6b82c4452fcc120d7bc Mar 12 04:33:45.071671 kernel: random: crng init done Mar 12 04:33:45.071683 kernel: Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Mar 12 04:33:45.071700 kernel: Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) Mar 12 04:33:45.071712 kernel: Fallback order for Node 0: 0 Mar 12 04:33:45.071736 kernel: Built 1 zonelists, mobility grouping on. Total pages: 515804 Mar 12 04:33:45.071752 kernel: Policy zone: DMA32 Mar 12 04:33:45.071763 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Mar 12 04:33:45.071774 kernel: software IO TLB: area num 16. Mar 12 04:33:45.071799 kernel: Memory: 1901600K/2096616K available (12288K kernel code, 2288K rwdata, 22752K rodata, 42892K init, 2304K bss, 194756K reserved, 0K cma-reserved) Mar 12 04:33:45.071811 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=16, Nodes=1 Mar 12 04:33:45.071823 kernel: Kernel/User page tables isolation: enabled Mar 12 04:33:45.071834 kernel: ftrace: allocating 37996 entries in 149 pages Mar 12 04:33:45.071858 kernel: ftrace: allocated 149 pages with 4 groups Mar 12 04:33:45.071870 kernel: Dynamic Preempt: voluntary Mar 12 04:33:45.071887 kernel: rcu: Preemptible hierarchical RCU implementation. Mar 12 04:33:45.071900 kernel: rcu: RCU event tracing is enabled. Mar 12 04:33:45.071913 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=16. Mar 12 04:33:45.071926 kernel: Trampoline variant of Tasks RCU enabled. Mar 12 04:33:45.071938 kernel: Rude variant of Tasks RCU enabled. Mar 12 04:33:45.071966 kernel: Tracing variant of Tasks RCU enabled. Mar 12 04:33:45.071980 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Mar 12 04:33:45.071993 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=16 Mar 12 04:33:45.072012 kernel: NR_IRQS: 33024, nr_irqs: 552, preallocated irqs: 16 Mar 12 04:33:45.072025 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Mar 12 04:33:45.072037 kernel: Console: colour VGA+ 80x25 Mar 12 04:33:45.072050 kernel: printk: console [tty0] enabled Mar 12 04:33:45.072068 kernel: printk: console [ttyS0] enabled Mar 12 04:33:45.072081 kernel: ACPI: Core revision 20230628 Mar 12 04:33:45.072112 kernel: APIC: Switch to symmetric I/O mode setup Mar 12 04:33:45.072129 kernel: x2apic enabled Mar 12 04:33:45.072142 kernel: APIC: Switched APIC routing to: physical x2apic Mar 12 04:33:45.072162 kernel: clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Mar 12 04:33:45.072175 kernel: Calibrating delay loop (skipped) preset value.. 4999.99 BogoMIPS (lpj=2499998) Mar 12 04:33:45.072187 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Mar 12 04:33:45.072200 kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Mar 12 04:33:45.072213 kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Mar 12 04:33:45.072226 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Mar 12 04:33:45.072238 kernel: Spectre V2 : Mitigation: Retpolines Mar 12 04:33:45.072250 kernel: Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT Mar 12 04:33:45.072263 kernel: Spectre V2 : Enabling Restricted Speculation for firmware calls Mar 12 04:33:45.072276 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Mar 12 04:33:45.072293 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Mar 12 04:33:45.072306 kernel: MDS: Mitigation: Clear CPU buffers Mar 12 04:33:45.072318 kernel: MMIO Stale Data: Unknown: No mitigations Mar 12 04:33:45.072331 kernel: SRBDS: Unknown: Dependent on hypervisor status Mar 12 04:33:45.072343 kernel: active return thunk: its_return_thunk Mar 12 04:33:45.072355 kernel: ITS: Mitigation: Aligned branch/return thunks Mar 12 04:33:45.072368 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Mar 12 04:33:45.072381 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Mar 12 04:33:45.072393 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Mar 12 04:33:45.072406 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Mar 12 04:33:45.072418 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Mar 12 04:33:45.072436 kernel: Freeing SMP alternatives memory: 32K Mar 12 04:33:45.072449 kernel: pid_max: default: 32768 minimum: 301 Mar 12 04:33:45.072461 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Mar 12 04:33:45.072474 kernel: landlock: Up and running. Mar 12 04:33:45.072486 kernel: SELinux: Initializing. Mar 12 04:33:45.072499 kernel: Mount-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Mar 12 04:33:45.072512 kernel: Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes, linear) Mar 12 04:33:45.072524 kernel: smpboot: CPU0: Intel Xeon E3-12xx v2 (Ivy Bridge, IBRS) (family: 0x6, model: 0x3a, stepping: 0x9) Mar 12 04:33:45.072537 kernel: RCU Tasks: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Mar 12 04:33:45.072550 kernel: RCU Tasks Rude: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Mar 12 04:33:45.072568 kernel: RCU Tasks Trace: Setting shift to 4 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=16. Mar 12 04:33:45.072581 kernel: Performance Events: unsupported p6 CPU model 58 no PMU driver, software events only. Mar 12 04:33:45.072594 kernel: signal: max sigframe size: 1776 Mar 12 04:33:45.072606 kernel: rcu: Hierarchical SRCU implementation. Mar 12 04:33:45.072619 kernel: rcu: Max phase no-delay instances is 400. Mar 12 04:33:45.072633 kernel: NMI watchdog: Perf NMI watchdog permanently disabled Mar 12 04:33:45.072645 kernel: smp: Bringing up secondary CPUs ... Mar 12 04:33:45.072658 kernel: smpboot: x86: Booting SMP configuration: Mar 12 04:33:45.072670 kernel: .... node #0, CPUs: #1 Mar 12 04:33:45.072688 kernel: smpboot: CPU 1 Converting physical 0 to logical die 1 Mar 12 04:33:45.072701 kernel: smp: Brought up 1 node, 2 CPUs Mar 12 04:33:45.072713 kernel: smpboot: Max logical packages: 16 Mar 12 04:33:45.072726 kernel: smpboot: Total of 2 processors activated (9999.99 BogoMIPS) Mar 12 04:33:45.072739 kernel: devtmpfs: initialized Mar 12 04:33:45.072752 kernel: x86/mm: Memory block size: 128MB Mar 12 04:33:45.072765 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Mar 12 04:33:45.072777 kernel: futex hash table entries: 4096 (order: 6, 262144 bytes, linear) Mar 12 04:33:45.072790 kernel: pinctrl core: initialized pinctrl subsystem Mar 12 04:33:45.072803 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Mar 12 04:33:45.072820 kernel: audit: initializing netlink subsys (disabled) Mar 12 04:33:45.072833 kernel: audit: type=2000 audit(1773290023.978:1): state=initialized audit_enabled=0 res=1 Mar 12 04:33:45.072846 kernel: thermal_sys: Registered thermal governor 'step_wise' Mar 12 04:33:45.072858 kernel: thermal_sys: Registered thermal governor 'user_space' Mar 12 04:33:45.072871 kernel: cpuidle: using governor menu Mar 12 04:33:45.072883 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Mar 12 04:33:45.072896 kernel: dca service started, version 1.12.1 Mar 12 04:33:45.072909 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Mar 12 04:33:45.072926 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Mar 12 04:33:45.072939 kernel: PCI: Using configuration type 1 for base access Mar 12 04:33:45.072952 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Mar 12 04:33:45.072964 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Mar 12 04:33:45.072977 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Mar 12 04:33:45.072990 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Mar 12 04:33:45.073003 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Mar 12 04:33:45.073016 kernel: ACPI: Added _OSI(Module Device) Mar 12 04:33:45.073028 kernel: ACPI: Added _OSI(Processor Device) Mar 12 04:33:45.073045 kernel: ACPI: Added _OSI(Processor Aggregator Device) Mar 12 04:33:45.073058 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Mar 12 04:33:45.073071 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Mar 12 04:33:45.073084 kernel: ACPI: Interpreter enabled Mar 12 04:33:45.075442 kernel: ACPI: PM: (supports S0 S5) Mar 12 04:33:45.075459 kernel: ACPI: Using IOAPIC for interrupt routing Mar 12 04:33:45.075472 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Mar 12 04:33:45.075485 kernel: PCI: Using E820 reservations for host bridge windows Mar 12 04:33:45.075498 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Mar 12 04:33:45.075517 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Mar 12 04:33:45.075784 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Mar 12 04:33:45.075977 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Mar 12 04:33:45.076195 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Mar 12 04:33:45.076215 kernel: PCI host bridge to bus 0000:00 Mar 12 04:33:45.076401 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Mar 12 04:33:45.076568 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Mar 12 04:33:45.076747 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Mar 12 04:33:45.076914 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xafffffff window] Mar 12 04:33:45.078173 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Mar 12 04:33:45.078354 kernel: pci_bus 0000:00: root bus resource [mem 0x20c0000000-0x28bfffffff window] Mar 12 04:33:45.078520 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Mar 12 04:33:45.078739 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Mar 12 04:33:45.078965 kernel: pci 0000:00:01.0: [1013:00b8] type 00 class 0x030000 Mar 12 04:33:45.080725 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xfa000000-0xfbffffff pref] Mar 12 04:33:45.080910 kernel: pci 0000:00:01.0: reg 0x14: [mem 0xfea50000-0xfea50fff] Mar 12 04:33:45.081195 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xfea40000-0xfea4ffff pref] Mar 12 04:33:45.081379 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Mar 12 04:33:45.081578 kernel: pci 0000:00:02.0: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.081758 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfea51000-0xfea51fff] Mar 12 04:33:45.081992 kernel: pci 0000:00:02.1: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.082205 kernel: pci 0000:00:02.1: reg 0x10: [mem 0xfea52000-0xfea52fff] Mar 12 04:33:45.082405 kernel: pci 0000:00:02.2: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.082589 kernel: pci 0000:00:02.2: reg 0x10: [mem 0xfea53000-0xfea53fff] Mar 12 04:33:45.082789 kernel: pci 0000:00:02.3: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.082969 kernel: pci 0000:00:02.3: reg 0x10: [mem 0xfea54000-0xfea54fff] Mar 12 04:33:45.084659 kernel: pci 0000:00:02.4: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.084846 kernel: pci 0000:00:02.4: reg 0x10: [mem 0xfea55000-0xfea55fff] Mar 12 04:33:45.085036 kernel: pci 0000:00:02.5: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.085261 kernel: pci 0000:00:02.5: reg 0x10: [mem 0xfea56000-0xfea56fff] Mar 12 04:33:45.085461 kernel: pci 0000:00:02.6: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.085642 kernel: pci 0000:00:02.6: reg 0x10: [mem 0xfea57000-0xfea57fff] Mar 12 04:33:45.085860 kernel: pci 0000:00:02.7: [1b36:000c] type 01 class 0x060400 Mar 12 04:33:45.086042 kernel: pci 0000:00:02.7: reg 0x10: [mem 0xfea58000-0xfea58fff] Mar 12 04:33:45.086326 kernel: pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 Mar 12 04:33:45.086508 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc0c0-0xc0df] Mar 12 04:33:45.086704 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfea59000-0xfea59fff] Mar 12 04:33:45.086879 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfd000000-0xfd003fff 64bit pref] Mar 12 04:33:45.087053 kernel: pci 0000:00:03.0: reg 0x30: [mem 0xfea00000-0xfea3ffff pref] Mar 12 04:33:45.088276 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Mar 12 04:33:45.088475 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Mar 12 04:33:45.088678 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfea5a000-0xfea5afff] Mar 12 04:33:45.088868 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfd004000-0xfd007fff 64bit pref] Mar 12 04:33:45.089072 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Mar 12 04:33:45.089331 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Mar 12 04:33:45.089544 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Mar 12 04:33:45.089735 kernel: pci 0000:00:1f.2: reg 0x20: [io 0xc0e0-0xc0ff] Mar 12 04:33:45.089912 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xfea5b000-0xfea5bfff] Mar 12 04:33:45.090172 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Mar 12 04:33:45.090355 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x0700-0x073f] Mar 12 04:33:45.090565 kernel: pci 0000:01:00.0: [1b36:000e] type 01 class 0x060400 Mar 12 04:33:45.090776 kernel: pci 0000:01:00.0: reg 0x10: [mem 0xfda00000-0xfda000ff 64bit] Mar 12 04:33:45.090961 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Mar 12 04:33:45.091162 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Mar 12 04:33:45.091343 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Mar 12 04:33:45.091554 kernel: pci_bus 0000:02: extended config space not accessible Mar 12 04:33:45.091801 kernel: pci 0000:02:01.0: [8086:25ab] type 00 class 0x088000 Mar 12 04:33:45.092009 kernel: pci 0000:02:01.0: reg 0x10: [mem 0xfd800000-0xfd80000f] Mar 12 04:33:45.092234 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Mar 12 04:33:45.092433 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Mar 12 04:33:45.092629 kernel: pci 0000:03:00.0: [1b36:000d] type 00 class 0x0c0330 Mar 12 04:33:45.092844 kernel: pci 0000:03:00.0: reg 0x10: [mem 0xfe800000-0xfe803fff 64bit] Mar 12 04:33:45.093025 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Mar 12 04:33:45.093261 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Mar 12 04:33:45.093438 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Mar 12 04:33:45.093665 kernel: pci 0000:04:00.0: [1af4:1044] type 00 class 0x00ff00 Mar 12 04:33:45.093868 kernel: pci 0000:04:00.0: reg 0x20: [mem 0xfca00000-0xfca03fff 64bit pref] Mar 12 04:33:45.094044 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Mar 12 04:33:45.094278 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Mar 12 04:33:45.094475 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Mar 12 04:33:45.094669 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Mar 12 04:33:45.094844 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Mar 12 04:33:45.095033 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Mar 12 04:33:45.095328 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Mar 12 04:33:45.095504 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Mar 12 04:33:45.095700 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Mar 12 04:33:45.095876 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Mar 12 04:33:45.096076 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Mar 12 04:33:45.096284 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Mar 12 04:33:45.096481 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Mar 12 04:33:45.096665 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Mar 12 04:33:45.096849 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Mar 12 04:33:45.097059 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Mar 12 04:33:45.097350 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Mar 12 04:33:45.097537 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Mar 12 04:33:45.097558 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Mar 12 04:33:45.097571 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Mar 12 04:33:45.097585 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Mar 12 04:33:45.097598 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Mar 12 04:33:45.097611 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Mar 12 04:33:45.097640 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Mar 12 04:33:45.097653 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Mar 12 04:33:45.097666 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Mar 12 04:33:45.097679 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Mar 12 04:33:45.097692 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Mar 12 04:33:45.097704 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Mar 12 04:33:45.097717 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Mar 12 04:33:45.097730 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Mar 12 04:33:45.097743 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Mar 12 04:33:45.097761 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Mar 12 04:33:45.097774 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Mar 12 04:33:45.097787 kernel: iommu: Default domain type: Translated Mar 12 04:33:45.097801 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Mar 12 04:33:45.097814 kernel: PCI: Using ACPI for IRQ routing Mar 12 04:33:45.097827 kernel: PCI: pci_cache_line_size set to 64 bytes Mar 12 04:33:45.097839 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Mar 12 04:33:45.097852 kernel: e820: reserve RAM buffer [mem 0x7ffdc000-0x7fffffff] Mar 12 04:33:45.098032 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Mar 12 04:33:45.098316 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Mar 12 04:33:45.098493 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Mar 12 04:33:45.098513 kernel: vgaarb: loaded Mar 12 04:33:45.098527 kernel: clocksource: Switched to clocksource kvm-clock Mar 12 04:33:45.098540 kernel: VFS: Disk quotas dquot_6.6.0 Mar 12 04:33:45.098553 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Mar 12 04:33:45.098566 kernel: pnp: PnP ACPI init Mar 12 04:33:45.098745 kernel: system 00:04: [mem 0xb0000000-0xbfffffff window] has been reserved Mar 12 04:33:45.098773 kernel: pnp: PnP ACPI: found 5 devices Mar 12 04:33:45.098787 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Mar 12 04:33:45.098800 kernel: NET: Registered PF_INET protocol family Mar 12 04:33:45.098812 kernel: IP idents hash table entries: 32768 (order: 6, 262144 bytes, linear) Mar 12 04:33:45.098826 kernel: tcp_listen_portaddr_hash hash table entries: 1024 (order: 2, 16384 bytes, linear) Mar 12 04:33:45.098839 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Mar 12 04:33:45.098852 kernel: TCP established hash table entries: 16384 (order: 5, 131072 bytes, linear) Mar 12 04:33:45.098865 kernel: TCP bind hash table entries: 16384 (order: 7, 524288 bytes, linear) Mar 12 04:33:45.098883 kernel: TCP: Hash tables configured (established 16384 bind 16384) Mar 12 04:33:45.098897 kernel: UDP hash table entries: 1024 (order: 3, 32768 bytes, linear) Mar 12 04:33:45.098910 kernel: UDP-Lite hash table entries: 1024 (order: 3, 32768 bytes, linear) Mar 12 04:33:45.098923 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Mar 12 04:33:45.098936 kernel: NET: Registered PF_XDP protocol family Mar 12 04:33:45.099134 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x0fff] to [bus 01-02] add_size 1000 Mar 12 04:33:45.099312 kernel: pci 0000:00:02.1: bridge window [io 0x1000-0x0fff] to [bus 03] add_size 1000 Mar 12 04:33:45.099489 kernel: pci 0000:00:02.2: bridge window [io 0x1000-0x0fff] to [bus 04] add_size 1000 Mar 12 04:33:45.099672 kernel: pci 0000:00:02.3: bridge window [io 0x1000-0x0fff] to [bus 05] add_size 1000 Mar 12 04:33:45.099849 kernel: pci 0000:00:02.4: bridge window [io 0x1000-0x0fff] to [bus 06] add_size 1000 Mar 12 04:33:45.100024 kernel: pci 0000:00:02.5: bridge window [io 0x1000-0x0fff] to [bus 07] add_size 1000 Mar 12 04:33:45.100236 kernel: pci 0000:00:02.6: bridge window [io 0x1000-0x0fff] to [bus 08] add_size 1000 Mar 12 04:33:45.100412 kernel: pci 0000:00:02.7: bridge window [io 0x1000-0x0fff] to [bus 09] add_size 1000 Mar 12 04:33:45.100585 kernel: pci 0000:00:02.0: BAR 13: assigned [io 0x1000-0x1fff] Mar 12 04:33:45.100767 kernel: pci 0000:00:02.1: BAR 13: assigned [io 0x2000-0x2fff] Mar 12 04:33:45.100943 kernel: pci 0000:00:02.2: BAR 13: assigned [io 0x3000-0x3fff] Mar 12 04:33:45.101179 kernel: pci 0000:00:02.3: BAR 13: assigned [io 0x4000-0x4fff] Mar 12 04:33:45.101385 kernel: pci 0000:00:02.4: BAR 13: assigned [io 0x5000-0x5fff] Mar 12 04:33:45.101600 kernel: pci 0000:00:02.5: BAR 13: assigned [io 0x6000-0x6fff] Mar 12 04:33:45.101777 kernel: pci 0000:00:02.6: BAR 13: assigned [io 0x7000-0x7fff] Mar 12 04:33:45.101952 kernel: pci 0000:00:02.7: BAR 13: assigned [io 0x8000-0x8fff] Mar 12 04:33:45.102173 kernel: pci 0000:01:00.0: PCI bridge to [bus 02] Mar 12 04:33:45.102395 kernel: pci 0000:01:00.0: bridge window [mem 0xfd800000-0xfd9fffff] Mar 12 04:33:45.102590 kernel: pci 0000:00:02.0: PCI bridge to [bus 01-02] Mar 12 04:33:45.102778 kernel: pci 0000:00:02.0: bridge window [io 0x1000-0x1fff] Mar 12 04:33:45.102982 kernel: pci 0000:00:02.0: bridge window [mem 0xfd800000-0xfdbfffff] Mar 12 04:33:45.103221 kernel: pci 0000:00:02.0: bridge window [mem 0xfce00000-0xfcffffff 64bit pref] Mar 12 04:33:45.103413 kernel: pci 0000:00:02.1: PCI bridge to [bus 03] Mar 12 04:33:45.103612 kernel: pci 0000:00:02.1: bridge window [io 0x2000-0x2fff] Mar 12 04:33:45.103843 kernel: pci 0000:00:02.1: bridge window [mem 0xfe800000-0xfe9fffff] Mar 12 04:33:45.104043 kernel: pci 0000:00:02.1: bridge window [mem 0xfcc00000-0xfcdfffff 64bit pref] Mar 12 04:33:45.104327 kernel: pci 0000:00:02.2: PCI bridge to [bus 04] Mar 12 04:33:45.104504 kernel: pci 0000:00:02.2: bridge window [io 0x3000-0x3fff] Mar 12 04:33:45.104679 kernel: pci 0000:00:02.2: bridge window [mem 0xfe600000-0xfe7fffff] Mar 12 04:33:45.104873 kernel: pci 0000:00:02.2: bridge window [mem 0xfca00000-0xfcbfffff 64bit pref] Mar 12 04:33:45.105059 kernel: pci 0000:00:02.3: PCI bridge to [bus 05] Mar 12 04:33:45.105281 kernel: pci 0000:00:02.3: bridge window [io 0x4000-0x4fff] Mar 12 04:33:45.105458 kernel: pci 0000:00:02.3: bridge window [mem 0xfe400000-0xfe5fffff] Mar 12 04:33:45.105632 kernel: pci 0000:00:02.3: bridge window [mem 0xfc800000-0xfc9fffff 64bit pref] Mar 12 04:33:45.105807 kernel: pci 0000:00:02.4: PCI bridge to [bus 06] Mar 12 04:33:45.105980 kernel: pci 0000:00:02.4: bridge window [io 0x5000-0x5fff] Mar 12 04:33:45.106223 kernel: pci 0000:00:02.4: bridge window [mem 0xfe200000-0xfe3fffff] Mar 12 04:33:45.106414 kernel: pci 0000:00:02.4: bridge window [mem 0xfc600000-0xfc7fffff 64bit pref] Mar 12 04:33:45.106589 kernel: pci 0000:00:02.5: PCI bridge to [bus 07] Mar 12 04:33:45.106764 kernel: pci 0000:00:02.5: bridge window [io 0x6000-0x6fff] Mar 12 04:33:45.106957 kernel: pci 0000:00:02.5: bridge window [mem 0xfe000000-0xfe1fffff] Mar 12 04:33:45.107189 kernel: pci 0000:00:02.5: bridge window [mem 0xfc400000-0xfc5fffff 64bit pref] Mar 12 04:33:45.107364 kernel: pci 0000:00:02.6: PCI bridge to [bus 08] Mar 12 04:33:45.107541 kernel: pci 0000:00:02.6: bridge window [io 0x7000-0x7fff] Mar 12 04:33:45.107720 kernel: pci 0000:00:02.6: bridge window [mem 0xfde00000-0xfdffffff] Mar 12 04:33:45.107904 kernel: pci 0000:00:02.6: bridge window [mem 0xfc200000-0xfc3fffff 64bit pref] Mar 12 04:33:45.108080 kernel: pci 0000:00:02.7: PCI bridge to [bus 09] Mar 12 04:33:45.108286 kernel: pci 0000:00:02.7: bridge window [io 0x8000-0x8fff] Mar 12 04:33:45.108466 kernel: pci 0000:00:02.7: bridge window [mem 0xfdc00000-0xfddfffff] Mar 12 04:33:45.108643 kernel: pci 0000:00:02.7: bridge window [mem 0xfc000000-0xfc1fffff 64bit pref] Mar 12 04:33:45.108827 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Mar 12 04:33:45.108989 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Mar 12 04:33:45.109185 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Mar 12 04:33:45.109348 kernel: pci_bus 0000:00: resource 7 [mem 0x80000000-0xafffffff window] Mar 12 04:33:45.109530 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Mar 12 04:33:45.109704 kernel: pci_bus 0000:00: resource 9 [mem 0x20c0000000-0x28bfffffff window] Mar 12 04:33:45.109886 kernel: pci_bus 0000:01: resource 0 [io 0x1000-0x1fff] Mar 12 04:33:45.110089 kernel: pci_bus 0000:01: resource 1 [mem 0xfd800000-0xfdbfffff] Mar 12 04:33:45.110311 kernel: pci_bus 0000:01: resource 2 [mem 0xfce00000-0xfcffffff 64bit pref] Mar 12 04:33:45.110501 kernel: pci_bus 0000:02: resource 1 [mem 0xfd800000-0xfd9fffff] Mar 12 04:33:45.110703 kernel: pci_bus 0000:03: resource 0 [io 0x2000-0x2fff] Mar 12 04:33:45.110900 kernel: pci_bus 0000:03: resource 1 [mem 0xfe800000-0xfe9fffff] Mar 12 04:33:45.111182 kernel: pci_bus 0000:03: resource 2 [mem 0xfcc00000-0xfcdfffff 64bit pref] Mar 12 04:33:45.111373 kernel: pci_bus 0000:04: resource 0 [io 0x3000-0x3fff] Mar 12 04:33:45.111540 kernel: pci_bus 0000:04: resource 1 [mem 0xfe600000-0xfe7fffff] Mar 12 04:33:45.111713 kernel: pci_bus 0000:04: resource 2 [mem 0xfca00000-0xfcbfffff 64bit pref] Mar 12 04:33:45.111908 kernel: pci_bus 0000:05: resource 0 [io 0x4000-0x4fff] Mar 12 04:33:45.112089 kernel: pci_bus 0000:05: resource 1 [mem 0xfe400000-0xfe5fffff] Mar 12 04:33:45.112284 kernel: pci_bus 0000:05: resource 2 [mem 0xfc800000-0xfc9fffff 64bit pref] Mar 12 04:33:45.112477 kernel: pci_bus 0000:06: resource 0 [io 0x5000-0x5fff] Mar 12 04:33:45.112651 kernel: pci_bus 0000:06: resource 1 [mem 0xfe200000-0xfe3fffff] Mar 12 04:33:45.112806 kernel: pci_bus 0000:06: resource 2 [mem 0xfc600000-0xfc7fffff 64bit pref] Mar 12 04:33:45.112964 kernel: pci_bus 0000:07: resource 0 [io 0x6000-0x6fff] Mar 12 04:33:45.113214 kernel: pci_bus 0000:07: resource 1 [mem 0xfe000000-0xfe1fffff] Mar 12 04:33:45.113391 kernel: pci_bus 0000:07: resource 2 [mem 0xfc400000-0xfc5fffff 64bit pref] Mar 12 04:33:45.113567 kernel: pci_bus 0000:08: resource 0 [io 0x7000-0x7fff] Mar 12 04:33:45.113751 kernel: pci_bus 0000:08: resource 1 [mem 0xfde00000-0xfdffffff] Mar 12 04:33:45.113926 kernel: pci_bus 0000:08: resource 2 [mem 0xfc200000-0xfc3fffff 64bit pref] Mar 12 04:33:45.114127 kernel: pci_bus 0000:09: resource 0 [io 0x8000-0x8fff] Mar 12 04:33:45.114299 kernel: pci_bus 0000:09: resource 1 [mem 0xfdc00000-0xfddfffff] Mar 12 04:33:45.114465 kernel: pci_bus 0000:09: resource 2 [mem 0xfc000000-0xfc1fffff 64bit pref] Mar 12 04:33:45.114494 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Mar 12 04:33:45.114509 kernel: PCI: CLS 0 bytes, default 64 Mar 12 04:33:45.114523 kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Mar 12 04:33:45.114537 kernel: software IO TLB: mapped [mem 0x0000000079800000-0x000000007d800000] (64MB) Mar 12 04:33:45.114550 kernel: RAPL PMU: API unit is 2^-32 Joules, 0 fixed counters, 10737418240 ms ovfl timer Mar 12 04:33:45.114564 kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x240937b9988, max_idle_ns: 440795218083 ns Mar 12 04:33:45.114578 kernel: Initialise system trusted keyrings Mar 12 04:33:45.114592 kernel: workingset: timestamp_bits=39 max_order=19 bucket_order=0 Mar 12 04:33:45.114610 kernel: Key type asymmetric registered Mar 12 04:33:45.114625 kernel: Asymmetric key parser 'x509' registered Mar 12 04:33:45.114638 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Mar 12 04:33:45.114652 kernel: io scheduler mq-deadline registered Mar 12 04:33:45.114666 kernel: io scheduler kyber registered Mar 12 04:33:45.114679 kernel: io scheduler bfq registered Mar 12 04:33:45.114855 kernel: pcieport 0000:00:02.0: PME: Signaling with IRQ 24 Mar 12 04:33:45.115057 kernel: pcieport 0000:00:02.0: AER: enabled with IRQ 24 Mar 12 04:33:45.115292 kernel: pcieport 0000:00:02.0: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.115479 kernel: pcieport 0000:00:02.1: PME: Signaling with IRQ 25 Mar 12 04:33:45.115664 kernel: pcieport 0000:00:02.1: AER: enabled with IRQ 25 Mar 12 04:33:45.115850 kernel: pcieport 0000:00:02.1: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.116039 kernel: pcieport 0000:00:02.2: PME: Signaling with IRQ 26 Mar 12 04:33:45.116263 kernel: pcieport 0000:00:02.2: AER: enabled with IRQ 26 Mar 12 04:33:45.116439 kernel: pcieport 0000:00:02.2: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.116626 kernel: pcieport 0000:00:02.3: PME: Signaling with IRQ 27 Mar 12 04:33:45.116802 kernel: pcieport 0000:00:02.3: AER: enabled with IRQ 27 Mar 12 04:33:45.116977 kernel: pcieport 0000:00:02.3: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.117235 kernel: pcieport 0000:00:02.4: PME: Signaling with IRQ 28 Mar 12 04:33:45.117413 kernel: pcieport 0000:00:02.4: AER: enabled with IRQ 28 Mar 12 04:33:45.117589 kernel: pcieport 0000:00:02.4: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.117801 kernel: pcieport 0000:00:02.5: PME: Signaling with IRQ 29 Mar 12 04:33:45.117974 kernel: pcieport 0000:00:02.5: AER: enabled with IRQ 29 Mar 12 04:33:45.118191 kernel: pcieport 0000:00:02.5: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.118368 kernel: pcieport 0000:00:02.6: PME: Signaling with IRQ 30 Mar 12 04:33:45.118544 kernel: pcieport 0000:00:02.6: AER: enabled with IRQ 30 Mar 12 04:33:45.118721 kernel: pcieport 0000:00:02.6: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.118905 kernel: pcieport 0000:00:02.7: PME: Signaling with IRQ 31 Mar 12 04:33:45.119090 kernel: pcieport 0000:00:02.7: AER: enabled with IRQ 31 Mar 12 04:33:45.119324 kernel: pcieport 0000:00:02.7: pciehp: Slot #0 AttnBtn+ PwrCtrl+ MRL- AttnInd+ PwrInd+ HotPlug+ Surprise+ Interlock+ NoCompl- IbPresDis- LLActRep+ Mar 12 04:33:45.119346 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Mar 12 04:33:45.119361 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Mar 12 04:33:45.119375 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Mar 12 04:33:45.119389 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Mar 12 04:33:45.119411 kernel: 00:00: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Mar 12 04:33:45.119425 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Mar 12 04:33:45.119439 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Mar 12 04:33:45.119452 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Mar 12 04:33:45.119626 kernel: rtc_cmos 00:03: RTC can wake from S4 Mar 12 04:33:45.119657 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Mar 12 04:33:45.119829 kernel: rtc_cmos 00:03: registered as rtc0 Mar 12 04:33:45.120006 kernel: rtc_cmos 00:03: setting system clock to 2026-03-12T04:33:44 UTC (1773290024) Mar 12 04:33:45.120208 kernel: rtc_cmos 00:03: alarms up to one day, y3k, 242 bytes nvram Mar 12 04:33:45.120229 kernel: intel_pstate: CPU model not supported Mar 12 04:33:45.120243 kernel: NET: Registered PF_INET6 protocol family Mar 12 04:33:45.120257 kernel: Segment Routing with IPv6 Mar 12 04:33:45.120271 kernel: In-situ OAM (IOAM) with IPv6 Mar 12 04:33:45.120284 kernel: NET: Registered PF_PACKET protocol family Mar 12 04:33:45.120297 kernel: Key type dns_resolver registered Mar 12 04:33:45.120311 kernel: IPI shorthand broadcast: enabled Mar 12 04:33:45.120325 kernel: sched_clock: Marking stable (1284030326, 236837545)->(1652790403, -131922532) Mar 12 04:33:45.120346 kernel: registered taskstats version 1 Mar 12 04:33:45.120360 kernel: Loading compiled-in X.509 certificates Mar 12 04:33:45.120373 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.127-flatcar: 67287262975845098ef9f337a0e8baa9afd38510' Mar 12 04:33:45.120387 kernel: Key type .fscrypt registered Mar 12 04:33:45.120400 kernel: Key type fscrypt-provisioning registered Mar 12 04:33:45.120413 kernel: ima: No TPM chip found, activating TPM-bypass! Mar 12 04:33:45.120427 kernel: ima: Allocated hash algorithm: sha1 Mar 12 04:33:45.120441 kernel: ima: No architecture policies found Mar 12 04:33:45.120454 kernel: clk: Disabling unused clocks Mar 12 04:33:45.120474 kernel: Freeing unused kernel image (initmem) memory: 42892K Mar 12 04:33:45.120488 kernel: Write protecting the kernel read-only data: 36864k Mar 12 04:33:45.120501 kernel: Freeing unused kernel image (rodata/data gap) memory: 1824K Mar 12 04:33:45.120515 kernel: Run /init as init process Mar 12 04:33:45.120528 kernel: with arguments: Mar 12 04:33:45.120542 kernel: /init Mar 12 04:33:45.120555 kernel: with environment: Mar 12 04:33:45.120568 kernel: HOME=/ Mar 12 04:33:45.120581 kernel: TERM=linux Mar 12 04:33:45.120612 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) Mar 12 04:33:45.120629 systemd[1]: Detected virtualization kvm. Mar 12 04:33:45.120644 systemd[1]: Detected architecture x86-64. Mar 12 04:33:45.120659 systemd[1]: Running in initrd. Mar 12 04:33:45.120676 systemd[1]: No hostname configured, using default hostname. Mar 12 04:33:45.120690 systemd[1]: Hostname set to . Mar 12 04:33:45.120705 systemd[1]: Initializing machine ID from VM UUID. Mar 12 04:33:45.120725 systemd[1]: Queued start job for default target initrd.target. Mar 12 04:33:45.120748 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 12 04:33:45.120763 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 12 04:33:45.120778 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Mar 12 04:33:45.120793 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 12 04:33:45.120808 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Mar 12 04:33:45.120823 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Mar 12 04:33:45.120844 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Mar 12 04:33:45.120860 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Mar 12 04:33:45.120875 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 12 04:33:45.120889 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 12 04:33:45.120909 systemd[1]: Reached target paths.target - Path Units. Mar 12 04:33:45.120924 systemd[1]: Reached target slices.target - Slice Units. Mar 12 04:33:45.120939 systemd[1]: Reached target swap.target - Swaps. Mar 12 04:33:45.120953 systemd[1]: Reached target timers.target - Timer Units. Mar 12 04:33:45.120978 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Mar 12 04:33:45.120993 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 12 04:33:45.121008 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Mar 12 04:33:45.121025 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Mar 12 04:33:45.121040 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 12 04:33:45.121054 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 12 04:33:45.121070 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 12 04:33:45.121084 systemd[1]: Reached target sockets.target - Socket Units. Mar 12 04:33:45.121154 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Mar 12 04:33:45.121178 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 12 04:33:45.121193 systemd[1]: Finished network-cleanup.service - Network Cleanup. Mar 12 04:33:45.121208 systemd[1]: Starting systemd-fsck-usr.service... Mar 12 04:33:45.121222 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 12 04:33:45.121237 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 12 04:33:45.121252 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 12 04:33:45.121305 systemd-journald[203]: Collecting audit messages is disabled. Mar 12 04:33:45.121343 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Mar 12 04:33:45.121358 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 12 04:33:45.121373 systemd[1]: Finished systemd-fsck-usr.service. Mar 12 04:33:45.121394 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Mar 12 04:33:45.121410 systemd-journald[203]: Journal started Mar 12 04:33:45.121436 systemd-journald[203]: Runtime Journal (/run/log/journal/8704a79728894fb3a206527b6b53329a) is 4.7M, max 38.0M, 33.2M free. Mar 12 04:33:45.101316 systemd-modules-load[204]: Inserted module 'overlay' Mar 12 04:33:45.184923 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Mar 12 04:33:45.184954 kernel: Bridge firewalling registered Mar 12 04:33:45.184974 systemd[1]: Started systemd-journald.service - Journal Service. Mar 12 04:33:45.147190 systemd-modules-load[204]: Inserted module 'br_netfilter' Mar 12 04:33:45.190695 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 12 04:33:45.191708 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 12 04:33:45.204525 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 12 04:33:45.206746 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 12 04:33:45.220783 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 12 04:33:45.222722 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Mar 12 04:33:45.235262 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 12 04:33:45.236368 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 12 04:33:45.241279 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 12 04:33:45.254307 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 12 04:33:45.255563 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 12 04:33:45.256678 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 12 04:33:45.260751 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Mar 12 04:33:45.286746 dracut-cmdline[239]: dracut-dracut-053 Mar 12 04:33:45.290200 dracut-cmdline[239]: 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=0e4243d51ac00bffbb09a606c7378a821ca08f30dbebc6b82c4452fcc120d7bc Mar 12 04:33:45.298150 systemd-resolved[236]: Positive Trust Anchors: Mar 12 04:33:45.299053 systemd-resolved[236]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 12 04:33:45.299154 systemd-resolved[236]: 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 Mar 12 04:33:45.307345 systemd-resolved[236]: Defaulting to hostname 'linux'. Mar 12 04:33:45.309978 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 12 04:33:45.311078 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 12 04:33:45.395120 kernel: SCSI subsystem initialized Mar 12 04:33:45.406129 kernel: Loading iSCSI transport class v2.0-870. Mar 12 04:33:45.420135 kernel: iscsi: registered transport (tcp) Mar 12 04:33:45.446852 kernel: iscsi: registered transport (qla4xxx) Mar 12 04:33:45.446905 kernel: QLogic iSCSI HBA Driver Mar 12 04:33:45.502905 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Mar 12 04:33:45.513420 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Mar 12 04:33:45.561895 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Mar 12 04:33:45.562005 kernel: device-mapper: uevent: version 1.0.3 Mar 12 04:33:45.564323 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Mar 12 04:33:45.613176 kernel: raid6: sse2x4 gen() 13362 MB/s Mar 12 04:33:45.631139 kernel: raid6: sse2x2 gen() 9512 MB/s Mar 12 04:33:45.649822 kernel: raid6: sse2x1 gen() 9938 MB/s Mar 12 04:33:45.649875 kernel: raid6: using algorithm sse2x4 gen() 13362 MB/s Mar 12 04:33:45.668908 kernel: raid6: .... xor() 7494 MB/s, rmw enabled Mar 12 04:33:45.668991 kernel: raid6: using ssse3x2 recovery algorithm Mar 12 04:33:45.696147 kernel: xor: automatically using best checksumming function avx Mar 12 04:33:45.893144 kernel: Btrfs loaded, zoned=no, fsverity=no Mar 12 04:33:45.908865 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Mar 12 04:33:45.918338 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 12 04:33:45.936738 systemd-udevd[422]: Using default interface naming scheme 'v255'. Mar 12 04:33:45.944688 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 12 04:33:45.953265 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Mar 12 04:33:45.975678 dracut-pre-trigger[427]: rd.md=0: removing MD RAID activation Mar 12 04:33:46.018475 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Mar 12 04:33:46.027318 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 12 04:33:46.143614 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 12 04:33:46.153473 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Mar 12 04:33:46.178152 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Mar 12 04:33:46.181932 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 12 04:33:46.186155 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 12 04:33:46.187548 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 12 04:33:46.195298 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Mar 12 04:33:46.222495 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Mar 12 04:33:46.279915 kernel: virtio_blk virtio1: 2/0/0 default/read/poll queues Mar 12 04:33:46.296410 kernel: cryptd: max_cpu_qlen set to 1000 Mar 12 04:33:46.296472 kernel: virtio_blk virtio1: [vda] 125829120 512-byte logical blocks (64.4 GB/60.0 GiB) Mar 12 04:33:46.320334 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Mar 12 04:33:46.320426 kernel: GPT:17805311 != 125829119 Mar 12 04:33:46.320459 kernel: GPT:Alternate GPT header not at the end of the disk. Mar 12 04:33:46.320488 kernel: GPT:17805311 != 125829119 Mar 12 04:33:46.320506 kernel: GPT: Use GNU Parted to correct GPT errors. Mar 12 04:33:46.320525 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 12 04:33:46.314685 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 12 04:33:46.314869 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 12 04:33:46.321751 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 12 04:33:46.322502 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 12 04:33:46.322705 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 12 04:33:46.324220 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Mar 12 04:33:46.333408 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 12 04:33:46.351297 kernel: ACPI: bus type USB registered Mar 12 04:33:46.351347 kernel: AVX version of gcm_enc/dec engaged. Mar 12 04:33:46.356296 kernel: usbcore: registered new interface driver usbfs Mar 12 04:33:46.356333 kernel: AES CTR mode by8 optimization enabled Mar 12 04:33:46.357885 kernel: usbcore: registered new interface driver hub Mar 12 04:33:46.359117 kernel: usbcore: registered new device driver usb Mar 12 04:33:46.402132 kernel: libata version 3.00 loaded. Mar 12 04:33:46.423134 kernel: ahci 0000:00:1f.2: version 3.0 Mar 12 04:33:46.423457 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Mar 12 04:33:46.425117 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Mar 12 04:33:46.425351 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Mar 12 04:33:46.427130 kernel: scsi host0: ahci Mar 12 04:33:46.433119 kernel: scsi host1: ahci Mar 12 04:33:46.442118 kernel: scsi host2: ahci Mar 12 04:33:46.446274 kernel: scsi host3: ahci Mar 12 04:33:46.460725 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Mar 12 04:33:46.460984 kernel: BTRFS: device fsid 94537345-7f6b-4b2a-965f-248bd6f0b7eb devid 1 transid 33 /dev/vda3 scanned by (udev-worker) (471) Mar 12 04:33:46.461006 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 1 Mar 12 04:33:46.461280 kernel: xhci_hcd 0000:03:00.0: hcc params 0x00087001 hci version 0x100 quirks 0x0000000000000010 Mar 12 04:33:46.461539 kernel: xhci_hcd 0000:03:00.0: xHCI Host Controller Mar 12 04:33:46.461787 kernel: xhci_hcd 0000:03:00.0: new USB bus registered, assigned bus number 2 Mar 12 04:33:46.461998 kernel: xhci_hcd 0000:03:00.0: Host supports USB 3.0 SuperSpeed Mar 12 04:33:46.463277 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/vda6 scanned by (udev-worker) (470) Mar 12 04:33:46.470127 kernel: hub 1-0:1.0: USB hub found Mar 12 04:33:46.472318 kernel: hub 1-0:1.0: 4 ports detected Mar 12 04:33:46.472785 kernel: scsi host4: ahci Mar 12 04:33:46.473020 kernel: scsi host5: ahci Mar 12 04:33:46.475305 kernel: ata1: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b100 irq 38 Mar 12 04:33:46.475329 kernel: ata2: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b180 irq 38 Mar 12 04:33:46.475348 kernel: ata3: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b200 irq 38 Mar 12 04:33:46.475366 kernel: ata4: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b280 irq 38 Mar 12 04:33:46.475384 kernel: ata5: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b300 irq 38 Mar 12 04:33:46.475402 kernel: ata6: SATA max UDMA/133 abar m4096@0xfea5b000 port 0xfea5b380 irq 38 Mar 12 04:33:46.478300 kernel: usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. Mar 12 04:33:46.478574 kernel: hub 2-0:1.0: USB hub found Mar 12 04:33:46.478822 kernel: hub 2-0:1.0: 4 ports detected Mar 12 04:33:46.481315 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Mar 12 04:33:46.549003 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 12 04:33:46.557443 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Mar 12 04:33:46.575298 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Mar 12 04:33:46.581389 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Mar 12 04:33:46.582214 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Mar 12 04:33:46.591323 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Mar 12 04:33:46.594952 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Mar 12 04:33:46.606130 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 12 04:33:46.609260 disk-uuid[564]: Primary Header is updated. Mar 12 04:33:46.609260 disk-uuid[564]: Secondary Entries is updated. Mar 12 04:33:46.609260 disk-uuid[564]: Secondary Header is updated. Mar 12 04:33:46.621024 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 12 04:33:46.631128 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 12 04:33:46.632812 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 12 04:33:46.723161 kernel: usb 1-1: new high-speed USB device number 2 using xhci_hcd Mar 12 04:33:46.786132 kernel: ata3: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.786202 kernel: ata2: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.786223 kernel: ata1: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.786242 kernel: ata4: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.788112 kernel: ata5: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.790114 kernel: ata6: SATA link down (SStatus 0 SControl 300) Mar 12 04:33:46.871129 kernel: hid: raw HID events driver (C) Jiri Kosina Mar 12 04:33:46.877439 kernel: usbcore: registered new interface driver usbhid Mar 12 04:33:46.877484 kernel: usbhid: USB HID core driver Mar 12 04:33:46.885987 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/input3 Mar 12 04:33:46.886029 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 Mar 12 04:33:47.631391 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Mar 12 04:33:47.632371 disk-uuid[566]: The operation has completed successfully. Mar 12 04:33:47.678702 systemd[1]: disk-uuid.service: Deactivated successfully. Mar 12 04:33:47.679919 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Mar 12 04:33:47.716349 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Mar 12 04:33:47.720503 sh[588]: Success Mar 12 04:33:47.739124 kernel: device-mapper: verity: sha256 using implementation "sha256-avx" Mar 12 04:33:47.792580 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Mar 12 04:33:47.798228 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Mar 12 04:33:47.799968 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Mar 12 04:33:47.820134 kernel: BTRFS info (device dm-0): first mount of filesystem 94537345-7f6b-4b2a-965f-248bd6f0b7eb Mar 12 04:33:47.820195 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Mar 12 04:33:47.821703 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Mar 12 04:33:47.825207 kernel: BTRFS info (device dm-0): disabling log replay at mount time Mar 12 04:33:47.825246 kernel: BTRFS info (device dm-0): using free space tree Mar 12 04:33:47.837803 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Mar 12 04:33:47.839262 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Mar 12 04:33:47.845292 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Mar 12 04:33:47.847112 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Mar 12 04:33:47.864134 kernel: BTRFS info (device vda6): first mount of filesystem 0ebf6eb2-dc55-4706-86d1-78d37843d203 Mar 12 04:33:47.867913 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 12 04:33:47.867952 kernel: BTRFS info (device vda6): using free space tree Mar 12 04:33:47.876137 kernel: BTRFS info (device vda6): auto enabling async discard Mar 12 04:33:47.889793 systemd[1]: mnt-oem.mount: Deactivated successfully. Mar 12 04:33:47.892998 kernel: BTRFS info (device vda6): last unmount of filesystem 0ebf6eb2-dc55-4706-86d1-78d37843d203 Mar 12 04:33:47.898041 systemd[1]: Finished ignition-setup.service - Ignition (setup). Mar 12 04:33:47.906294 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Mar 12 04:33:47.997401 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 12 04:33:48.009324 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 12 04:33:48.058925 systemd-networkd[771]: lo: Link UP Mar 12 04:33:48.060411 systemd-networkd[771]: lo: Gained carrier Mar 12 04:33:48.064059 systemd-networkd[771]: Enumeration completed Mar 12 04:33:48.065490 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 12 04:33:48.065496 systemd-networkd[771]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 12 04:33:48.067294 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 12 04:33:48.070393 ignition[682]: Ignition 2.19.0 Mar 12 04:33:48.069447 systemd[1]: Reached target network.target - Network. Mar 12 04:33:48.070412 ignition[682]: Stage: fetch-offline Mar 12 04:33:48.071973 systemd-networkd[771]: eth0: Link UP Mar 12 04:33:48.070504 ignition[682]: no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:48.071978 systemd-networkd[771]: eth0: Gained carrier Mar 12 04:33:48.070529 ignition[682]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:48.071990 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 12 04:33:48.070751 ignition[682]: parsed url from cmdline: "" Mar 12 04:33:48.073468 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Mar 12 04:33:48.070758 ignition[682]: no config URL provided Mar 12 04:33:48.070768 ignition[682]: reading system config file "/usr/lib/ignition/user.ign" Mar 12 04:33:48.083361 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Mar 12 04:33:48.070798 ignition[682]: no config at "/usr/lib/ignition/user.ign" Mar 12 04:33:48.070807 ignition[682]: failed to fetch config: resource requires networking Mar 12 04:33:48.071936 ignition[682]: Ignition finished successfully Mar 12 04:33:48.099675 systemd-networkd[771]: eth0: DHCPv4 address 10.230.9.230/30, gateway 10.230.9.229 acquired from 10.230.9.229 Mar 12 04:33:48.105121 ignition[779]: Ignition 2.19.0 Mar 12 04:33:48.105139 ignition[779]: Stage: fetch Mar 12 04:33:48.105364 ignition[779]: no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:48.105384 ignition[779]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:48.105516 ignition[779]: parsed url from cmdline: "" Mar 12 04:33:48.105523 ignition[779]: no config URL provided Mar 12 04:33:48.105532 ignition[779]: reading system config file "/usr/lib/ignition/user.ign" Mar 12 04:33:48.105547 ignition[779]: no config at "/usr/lib/ignition/user.ign" Mar 12 04:33:48.105742 ignition[779]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1 Mar 12 04:33:48.105768 ignition[779]: config drive ("/dev/disk/by-label/config-2") not found. Waiting... Mar 12 04:33:48.105821 ignition[779]: config drive ("/dev/disk/by-label/CONFIG-2") not found. Waiting... Mar 12 04:33:48.119922 ignition[779]: GET result: OK Mar 12 04:33:48.120854 ignition[779]: parsing config with SHA512: 99a94eb6d25fcc72029e062fb17cd3029f19a94956fb5b3cbace9858b5a358cc19e72428175d5608542ab883e13df0c982063fbb14903011e585b791284d8b2e Mar 12 04:33:48.126891 unknown[779]: fetched base config from "system" Mar 12 04:33:48.127586 unknown[779]: fetched base config from "system" Mar 12 04:33:48.127861 ignition[779]: fetch: fetch complete Mar 12 04:33:48.127597 unknown[779]: fetched user config from "openstack" Mar 12 04:33:48.127869 ignition[779]: fetch: fetch passed Mar 12 04:33:48.130110 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Mar 12 04:33:48.127942 ignition[779]: Ignition finished successfully Mar 12 04:33:48.142370 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Mar 12 04:33:48.163643 ignition[786]: Ignition 2.19.0 Mar 12 04:33:48.164756 ignition[786]: Stage: kargs Mar 12 04:33:48.165001 ignition[786]: no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:48.165041 ignition[786]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:48.168625 ignition[786]: kargs: kargs passed Mar 12 04:33:48.168722 ignition[786]: Ignition finished successfully Mar 12 04:33:48.170004 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Mar 12 04:33:48.175327 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Mar 12 04:33:48.197761 ignition[792]: Ignition 2.19.0 Mar 12 04:33:48.198151 ignition[792]: Stage: disks Mar 12 04:33:48.198387 ignition[792]: no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:48.198407 ignition[792]: no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:48.202680 ignition[792]: disks: disks passed Mar 12 04:33:48.202881 ignition[792]: Ignition finished successfully Mar 12 04:33:48.204003 systemd[1]: Finished ignition-disks.service - Ignition (disks). Mar 12 04:33:48.205466 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Mar 12 04:33:48.206335 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Mar 12 04:33:48.207956 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 12 04:33:48.209537 systemd[1]: Reached target sysinit.target - System Initialization. Mar 12 04:33:48.210945 systemd[1]: Reached target basic.target - Basic System. Mar 12 04:33:48.217287 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Mar 12 04:33:48.245476 systemd-fsck[800]: ROOT: clean, 14/1628000 files, 120691/1617920 blocks Mar 12 04:33:48.250990 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Mar 12 04:33:48.256193 systemd[1]: Mounting sysroot.mount - /sysroot... Mar 12 04:33:48.376126 kernel: EXT4-fs (vda9): mounted filesystem f90926b1-4cc2-4a2d-8c45-4ec584c98779 r/w with ordered data mode. Quota mode: none. Mar 12 04:33:48.377568 systemd[1]: Mounted sysroot.mount - /sysroot. Mar 12 04:33:48.379627 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Mar 12 04:33:48.387209 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 12 04:33:48.390216 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Mar 12 04:33:48.392413 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Mar 12 04:33:48.395486 systemd[1]: Starting flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent... Mar 12 04:33:48.396489 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Mar 12 04:33:48.396588 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Mar 12 04:33:48.405268 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/vda6 scanned by mount (808) Mar 12 04:33:48.411048 kernel: BTRFS info (device vda6): first mount of filesystem 0ebf6eb2-dc55-4706-86d1-78d37843d203 Mar 12 04:33:48.411108 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 12 04:33:48.411132 kernel: BTRFS info (device vda6): using free space tree Mar 12 04:33:48.413401 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Mar 12 04:33:48.416849 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Mar 12 04:33:48.432733 kernel: BTRFS info (device vda6): auto enabling async discard Mar 12 04:33:48.441544 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 12 04:33:48.505135 initrd-setup-root[836]: cut: /sysroot/etc/passwd: No such file or directory Mar 12 04:33:48.513544 initrd-setup-root[843]: cut: /sysroot/etc/group: No such file or directory Mar 12 04:33:48.523783 initrd-setup-root[850]: cut: /sysroot/etc/shadow: No such file or directory Mar 12 04:33:48.530658 initrd-setup-root[857]: cut: /sysroot/etc/gshadow: No such file or directory Mar 12 04:33:48.649600 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Mar 12 04:33:48.658242 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Mar 12 04:33:48.662438 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Mar 12 04:33:48.676123 kernel: BTRFS info (device vda6): last unmount of filesystem 0ebf6eb2-dc55-4706-86d1-78d37843d203 Mar 12 04:33:48.699153 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Mar 12 04:33:48.712775 ignition[925]: INFO : Ignition 2.19.0 Mar 12 04:33:48.712775 ignition[925]: INFO : Stage: mount Mar 12 04:33:48.715246 ignition[925]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:48.715246 ignition[925]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:48.715246 ignition[925]: INFO : mount: mount passed Mar 12 04:33:48.715246 ignition[925]: INFO : Ignition finished successfully Mar 12 04:33:48.715815 systemd[1]: Finished ignition-mount.service - Ignition (mount). Mar 12 04:33:48.817692 systemd[1]: sysroot-oem.mount: Deactivated successfully. Mar 12 04:33:49.227479 systemd-networkd[771]: eth0: Gained IPv6LL Mar 12 04:33:50.734029 systemd-networkd[771]: eth0: Ignoring DHCPv6 address 2a02:1348:179:8279:24:19ff:fee6:9e6/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:8279:24:19ff:fee6:9e6/64 assigned by NDisc. Mar 12 04:33:50.734047 systemd-networkd[771]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Mar 12 04:33:55.569599 coreos-metadata[810]: Mar 12 04:33:55.569 WARN failed to locate config-drive, using the metadata service API instead Mar 12 04:33:55.595696 coreos-metadata[810]: Mar 12 04:33:55.595 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Mar 12 04:33:55.610550 coreos-metadata[810]: Mar 12 04:33:55.610 INFO Fetch successful Mar 12 04:33:55.611575 coreos-metadata[810]: Mar 12 04:33:55.611 INFO wrote hostname srv-1aqj0.gb1.brightbox.com to /sysroot/etc/hostname Mar 12 04:33:55.614565 systemd[1]: flatcar-openstack-hostname.service: Deactivated successfully. Mar 12 04:33:55.614780 systemd[1]: Finished flatcar-openstack-hostname.service - Flatcar OpenStack Metadata Hostname Agent. Mar 12 04:33:55.624291 systemd[1]: Starting ignition-files.service - Ignition (files)... Mar 12 04:33:55.643360 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Mar 12 04:33:55.655134 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/vda6 scanned by mount (941) Mar 12 04:33:55.662572 kernel: BTRFS info (device vda6): first mount of filesystem 0ebf6eb2-dc55-4706-86d1-78d37843d203 Mar 12 04:33:55.662611 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Mar 12 04:33:55.662631 kernel: BTRFS info (device vda6): using free space tree Mar 12 04:33:55.667117 kernel: BTRFS info (device vda6): auto enabling async discard Mar 12 04:33:55.671062 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Mar 12 04:33:55.713906 ignition[959]: INFO : Ignition 2.19.0 Mar 12 04:33:55.713906 ignition[959]: INFO : Stage: files Mar 12 04:33:55.715899 ignition[959]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:55.715899 ignition[959]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:55.715899 ignition[959]: DEBUG : files: compiled without relabeling support, skipping Mar 12 04:33:55.719024 ignition[959]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Mar 12 04:33:55.719024 ignition[959]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Mar 12 04:33:55.721404 ignition[959]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Mar 12 04:33:55.722759 ignition[959]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Mar 12 04:33:55.723783 ignition[959]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Mar 12 04:33:55.723018 unknown[959]: wrote ssh authorized keys file for user: core Mar 12 04:33:55.725980 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/home/core/install.sh" Mar 12 04:33:55.725980 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/home/core/install.sh" Mar 12 04:33:55.725980 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Mar 12 04:33:55.725980 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Mar 12 04:33:55.725980 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Mar 12 04:33:55.732528 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing link "/sysroot/etc/extensions/kubernetes.raw" -> "/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Mar 12 04:33:55.732528 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Mar 12 04:33:55.732528 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET https://extensions.flatcar.org/extensions/kubernetes-v1.35.1-x86-64.raw: attempt #1 Mar 12 04:33:56.115648 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): GET result: OK Mar 12 04:33:57.205024 ignition[959]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/opt/extensions/kubernetes/kubernetes-v1.35.1-x86-64.raw" Mar 12 04:33:57.208895 ignition[959]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Mar 12 04:33:57.208895 ignition[959]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Mar 12 04:33:57.208895 ignition[959]: INFO : files: files passed Mar 12 04:33:57.208895 ignition[959]: INFO : Ignition finished successfully Mar 12 04:33:57.208666 systemd[1]: Finished ignition-files.service - Ignition (files). Mar 12 04:33:57.217383 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Mar 12 04:33:57.222681 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Mar 12 04:33:57.227108 systemd[1]: ignition-quench.service: Deactivated successfully. Mar 12 04:33:57.227254 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Mar 12 04:33:57.238074 initrd-setup-root-after-ignition[987]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 12 04:33:57.238074 initrd-setup-root-after-ignition[987]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Mar 12 04:33:57.241617 initrd-setup-root-after-ignition[991]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Mar 12 04:33:57.243882 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 12 04:33:57.245915 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Mar 12 04:33:57.252312 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Mar 12 04:33:57.282557 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Mar 12 04:33:57.283635 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Mar 12 04:33:57.285691 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Mar 12 04:33:57.286455 systemd[1]: Reached target initrd.target - Initrd Default Target. Mar 12 04:33:57.288012 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Mar 12 04:33:57.294303 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Mar 12 04:33:57.311832 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 12 04:33:57.317334 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Mar 12 04:33:57.334276 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Mar 12 04:33:57.335265 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 12 04:33:57.336980 systemd[1]: Stopped target timers.target - Timer Units. Mar 12 04:33:57.338511 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Mar 12 04:33:57.338679 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Mar 12 04:33:57.340581 systemd[1]: Stopped target initrd.target - Initrd Default Target. Mar 12 04:33:57.341582 systemd[1]: Stopped target basic.target - Basic System. Mar 12 04:33:57.343083 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Mar 12 04:33:57.344430 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Mar 12 04:33:57.345855 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Mar 12 04:33:57.347403 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Mar 12 04:33:57.348933 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Mar 12 04:33:57.350540 systemd[1]: Stopped target sysinit.target - System Initialization. Mar 12 04:33:57.352030 systemd[1]: Stopped target local-fs.target - Local File Systems. Mar 12 04:33:57.353659 systemd[1]: Stopped target swap.target - Swaps. Mar 12 04:33:57.355054 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Mar 12 04:33:57.355269 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Mar 12 04:33:57.357138 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Mar 12 04:33:57.358162 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 12 04:33:57.359481 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Mar 12 04:33:57.359902 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 12 04:33:57.361167 systemd[1]: dracut-initqueue.service: Deactivated successfully. Mar 12 04:33:57.361374 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Mar 12 04:33:57.363324 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Mar 12 04:33:57.363529 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Mar 12 04:33:57.365232 systemd[1]: ignition-files.service: Deactivated successfully. Mar 12 04:33:57.365434 systemd[1]: Stopped ignition-files.service - Ignition (files). Mar 12 04:33:57.381870 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Mar 12 04:33:57.382598 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Mar 12 04:33:57.382797 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Mar 12 04:33:57.386405 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Mar 12 04:33:57.387907 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Mar 12 04:33:57.388205 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Mar 12 04:33:57.390310 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Mar 12 04:33:57.390539 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Mar 12 04:33:57.402253 systemd[1]: initrd-cleanup.service: Deactivated successfully. Mar 12 04:33:57.402393 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Mar 12 04:33:57.411122 ignition[1011]: INFO : Ignition 2.19.0 Mar 12 04:33:57.411122 ignition[1011]: INFO : Stage: umount Mar 12 04:33:57.411122 ignition[1011]: INFO : no configs at "/usr/lib/ignition/base.d" Mar 12 04:33:57.411122 ignition[1011]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/openstack" Mar 12 04:33:57.415363 ignition[1011]: INFO : umount: umount passed Mar 12 04:33:57.415363 ignition[1011]: INFO : Ignition finished successfully Mar 12 04:33:57.414779 systemd[1]: ignition-mount.service: Deactivated successfully. Mar 12 04:33:57.415189 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Mar 12 04:33:57.418132 systemd[1]: ignition-disks.service: Deactivated successfully. Mar 12 04:33:57.418222 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Mar 12 04:33:57.418973 systemd[1]: ignition-kargs.service: Deactivated successfully. Mar 12 04:33:57.419044 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Mar 12 04:33:57.421318 systemd[1]: ignition-fetch.service: Deactivated successfully. Mar 12 04:33:57.421386 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Mar 12 04:33:57.423433 systemd[1]: Stopped target network.target - Network. Mar 12 04:33:57.425334 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Mar 12 04:33:57.425410 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Mar 12 04:33:57.426214 systemd[1]: Stopped target paths.target - Path Units. Mar 12 04:33:57.427588 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Mar 12 04:33:57.431477 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 12 04:33:57.432524 systemd[1]: Stopped target slices.target - Slice Units. Mar 12 04:33:57.433830 systemd[1]: Stopped target sockets.target - Socket Units. Mar 12 04:33:57.441376 systemd[1]: iscsid.socket: Deactivated successfully. Mar 12 04:33:57.441458 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Mar 12 04:33:57.443014 systemd[1]: iscsiuio.socket: Deactivated successfully. Mar 12 04:33:57.443079 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Mar 12 04:33:57.444372 systemd[1]: ignition-setup.service: Deactivated successfully. Mar 12 04:33:57.444447 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Mar 12 04:33:57.445712 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Mar 12 04:33:57.445796 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Mar 12 04:33:57.447316 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Mar 12 04:33:57.448829 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Mar 12 04:33:57.451563 systemd[1]: sysroot-boot.mount: Deactivated successfully. Mar 12 04:33:57.452259 systemd-networkd[771]: eth0: DHCPv6 lease lost Mar 12 04:33:57.455059 systemd[1]: systemd-networkd.service: Deactivated successfully. Mar 12 04:33:57.456226 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Mar 12 04:33:57.458564 systemd[1]: systemd-resolved.service: Deactivated successfully. Mar 12 04:33:57.458726 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Mar 12 04:33:57.462653 systemd[1]: systemd-networkd.socket: Deactivated successfully. Mar 12 04:33:57.462940 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Mar 12 04:33:57.470241 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Mar 12 04:33:57.471742 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Mar 12 04:33:57.471829 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Mar 12 04:33:57.475899 systemd[1]: systemd-sysctl.service: Deactivated successfully. Mar 12 04:33:57.475970 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Mar 12 04:33:57.477678 systemd[1]: systemd-modules-load.service: Deactivated successfully. Mar 12 04:33:57.477765 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Mar 12 04:33:57.479156 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Mar 12 04:33:57.479222 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 12 04:33:57.480837 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 12 04:33:57.489674 systemd[1]: systemd-udevd.service: Deactivated successfully. Mar 12 04:33:57.489922 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 12 04:33:57.493448 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Mar 12 04:33:57.493537 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Mar 12 04:33:57.497054 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Mar 12 04:33:57.497154 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Mar 12 04:33:57.498695 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Mar 12 04:33:57.498776 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Mar 12 04:33:57.500937 systemd[1]: dracut-cmdline.service: Deactivated successfully. Mar 12 04:33:57.501005 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Mar 12 04:33:57.502517 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Mar 12 04:33:57.502600 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Mar 12 04:33:57.509255 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Mar 12 04:33:57.510067 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Mar 12 04:33:57.510162 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 12 04:33:57.513890 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Mar 12 04:33:57.513962 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Mar 12 04:33:57.517046 systemd[1]: network-cleanup.service: Deactivated successfully. Mar 12 04:33:57.519230 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Mar 12 04:33:57.524346 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Mar 12 04:33:57.524514 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Mar 12 04:33:57.541335 systemd[1]: sysroot-boot.service: Deactivated successfully. Mar 12 04:33:57.541516 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Mar 12 04:33:57.543478 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Mar 12 04:33:57.544455 systemd[1]: initrd-setup-root.service: Deactivated successfully. Mar 12 04:33:57.544542 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Mar 12 04:33:57.551301 systemd[1]: Starting initrd-switch-root.service - Switch Root... Mar 12 04:33:57.561552 systemd[1]: Switching root. Mar 12 04:33:57.595040 systemd-journald[203]: Journal stopped Mar 12 04:33:59.133546 systemd-journald[203]: Received SIGTERM from PID 1 (systemd). Mar 12 04:33:59.133670 kernel: SELinux: policy capability network_peer_controls=1 Mar 12 04:33:59.133696 kernel: SELinux: policy capability open_perms=1 Mar 12 04:33:59.133729 kernel: SELinux: policy capability extended_socket_class=1 Mar 12 04:33:59.133750 kernel: SELinux: policy capability always_check_network=0 Mar 12 04:33:59.133781 kernel: SELinux: policy capability cgroup_seclabel=1 Mar 12 04:33:59.133801 kernel: SELinux: policy capability nnp_nosuid_transition=1 Mar 12 04:33:59.133819 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Mar 12 04:33:59.133837 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Mar 12 04:33:59.133870 systemd[1]: Successfully loaded SELinux policy in 48.166ms. Mar 12 04:33:59.133901 kernel: audit: type=1403 audit(1773290037.849:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Mar 12 04:33:59.133935 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 21.952ms. Mar 12 04:33:59.133958 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) Mar 12 04:33:59.133978 systemd[1]: Detected virtualization kvm. Mar 12 04:33:59.133998 systemd[1]: Detected architecture x86-64. Mar 12 04:33:59.134018 systemd[1]: Detected first boot. Mar 12 04:33:59.134038 systemd[1]: Hostname set to . Mar 12 04:33:59.134073 systemd[1]: Initializing machine ID from VM UUID. Mar 12 04:33:59.143737 zram_generator::config[1053]: No configuration found. Mar 12 04:33:59.143777 systemd[1]: Populated /etc with preset unit settings. Mar 12 04:33:59.143802 systemd[1]: initrd-switch-root.service: Deactivated successfully. Mar 12 04:33:59.143822 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Mar 12 04:33:59.143863 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Mar 12 04:33:59.143887 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Mar 12 04:33:59.143908 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Mar 12 04:33:59.143929 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Mar 12 04:33:59.143948 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Mar 12 04:33:59.143969 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Mar 12 04:33:59.143989 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Mar 12 04:33:59.144009 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Mar 12 04:33:59.144029 systemd[1]: Created slice user.slice - User and Session Slice. Mar 12 04:33:59.144063 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Mar 12 04:33:59.144085 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Mar 12 04:33:59.144132 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Mar 12 04:33:59.144161 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Mar 12 04:33:59.144182 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Mar 12 04:33:59.144204 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Mar 12 04:33:59.144234 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Mar 12 04:33:59.144258 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Mar 12 04:33:59.144280 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Mar 12 04:33:59.144319 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Mar 12 04:33:59.144348 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Mar 12 04:33:59.144370 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Mar 12 04:33:59.144390 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Mar 12 04:33:59.144411 systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 12 04:33:59.144431 systemd[1]: Reached target slices.target - Slice Units. Mar 12 04:33:59.144464 systemd[1]: Reached target swap.target - Swaps. Mar 12 04:33:59.144486 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Mar 12 04:33:59.144507 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Mar 12 04:33:59.144527 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Mar 12 04:33:59.144547 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Mar 12 04:33:59.144579 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Mar 12 04:33:59.144598 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Mar 12 04:33:59.144624 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Mar 12 04:33:59.144650 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Mar 12 04:33:59.144682 systemd[1]: Mounting media.mount - External Media Directory... Mar 12 04:33:59.144738 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:33:59.144760 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Mar 12 04:33:59.144789 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Mar 12 04:33:59.144822 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Mar 12 04:33:59.144846 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). Mar 12 04:33:59.144868 systemd[1]: Reached target machines.target - Containers. Mar 12 04:33:59.144888 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Mar 12 04:33:59.144908 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 12 04:33:59.144942 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Mar 12 04:33:59.144963 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Mar 12 04:33:59.144984 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 12 04:33:59.145004 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 12 04:33:59.145024 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 12 04:33:59.145044 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Mar 12 04:33:59.145084 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 12 04:33:59.145385 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Mar 12 04:33:59.145412 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Mar 12 04:33:59.145433 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Mar 12 04:33:59.145454 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Mar 12 04:33:59.145474 systemd[1]: Stopped systemd-fsck-usr.service. Mar 12 04:33:59.145493 kernel: fuse: init (API version 7.39) Mar 12 04:33:59.145514 systemd[1]: Starting systemd-journald.service - Journal Service... Mar 12 04:33:59.145552 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Mar 12 04:33:59.145574 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Mar 12 04:33:59.145595 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Mar 12 04:33:59.145615 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Mar 12 04:33:59.145635 systemd[1]: verity-setup.service: Deactivated successfully. Mar 12 04:33:59.145655 systemd[1]: Stopped verity-setup.service. Mar 12 04:33:59.145675 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:33:59.145695 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Mar 12 04:33:59.145738 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Mar 12 04:33:59.145761 systemd[1]: Mounted media.mount - External Media Directory. Mar 12 04:33:59.145782 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Mar 12 04:33:59.145809 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Mar 12 04:33:59.145831 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Mar 12 04:33:59.145863 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Mar 12 04:33:59.145886 systemd[1]: modprobe@configfs.service: Deactivated successfully. Mar 12 04:33:59.145948 systemd-journald[1142]: Collecting audit messages is disabled. Mar 12 04:33:59.145991 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Mar 12 04:33:59.146014 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 12 04:33:59.146035 kernel: ACPI: bus type drm_connector registered Mar 12 04:33:59.146055 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 12 04:33:59.146075 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 12 04:33:59.146136 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 12 04:33:59.146179 kernel: loop: module loaded Mar 12 04:33:59.146202 systemd[1]: modprobe@fuse.service: Deactivated successfully. Mar 12 04:33:59.146223 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Mar 12 04:33:59.146253 systemd-journald[1142]: Journal started Mar 12 04:33:59.146304 systemd-journald[1142]: Runtime Journal (/run/log/journal/8704a79728894fb3a206527b6b53329a) is 4.7M, max 38.0M, 33.2M free. Mar 12 04:33:58.701793 systemd[1]: Queued start job for default target multi-user.target. Mar 12 04:33:58.721478 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Mar 12 04:33:58.722219 systemd[1]: systemd-journald.service: Deactivated successfully. Mar 12 04:33:59.152120 systemd[1]: Started systemd-journald.service - Journal Service. Mar 12 04:33:59.151810 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 12 04:33:59.153177 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 12 04:33:59.154754 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 12 04:33:59.154969 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 12 04:33:59.156872 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Mar 12 04:33:59.159036 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Mar 12 04:33:59.161216 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Mar 12 04:33:59.168491 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Mar 12 04:33:59.179305 systemd[1]: Reached target network-pre.target - Preparation for Network. Mar 12 04:33:59.189368 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Mar 12 04:33:59.196245 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Mar 12 04:33:59.199224 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Mar 12 04:33:59.199289 systemd[1]: Reached target local-fs.target - Local File Systems. Mar 12 04:33:59.203088 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Mar 12 04:33:59.210242 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Mar 12 04:33:59.220332 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Mar 12 04:33:59.221782 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 12 04:33:59.226253 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Mar 12 04:33:59.232913 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Mar 12 04:33:59.234781 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 12 04:33:59.243393 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Mar 12 04:33:59.244263 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 12 04:33:59.248232 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Mar 12 04:33:59.255433 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Mar 12 04:33:59.266368 systemd[1]: Starting systemd-sysusers.service - Create System Users... Mar 12 04:33:59.270090 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Mar 12 04:33:59.273397 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Mar 12 04:33:59.274599 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Mar 12 04:33:59.275761 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Mar 12 04:33:59.283591 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Mar 12 04:33:59.294320 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Mar 12 04:33:59.296753 systemd-journald[1142]: Time spent on flushing to /var/log/journal/8704a79728894fb3a206527b6b53329a is 156.191ms for 1124 entries. Mar 12 04:33:59.296753 systemd-journald[1142]: System Journal (/var/log/journal/8704a79728894fb3a206527b6b53329a) is 8.0M, max 584.8M, 576.8M free. Mar 12 04:33:59.503199 systemd-journald[1142]: Received client request to flush runtime journal. Mar 12 04:33:59.503259 kernel: loop0: detected capacity change from 0 to 140768 Mar 12 04:33:59.503287 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Mar 12 04:33:59.503312 kernel: loop1: detected capacity change from 0 to 142488 Mar 12 04:33:59.392777 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Mar 12 04:33:59.398273 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Mar 12 04:33:59.402541 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Mar 12 04:33:59.405613 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Mar 12 04:33:59.422376 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Mar 12 04:33:59.475420 udevadm[1200]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Mar 12 04:33:59.500717 systemd[1]: Finished systemd-sysusers.service - Create System Users. Mar 12 04:33:59.508750 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Mar 12 04:33:59.510346 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Mar 12 04:33:59.582464 kernel: loop2: detected capacity change from 0 to 8 Mar 12 04:33:59.614259 kernel: loop3: detected capacity change from 0 to 217752 Mar 12 04:33:59.634628 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Mar 12 04:33:59.635203 systemd-tmpfiles[1204]: ACLs are not supported, ignoring. Mar 12 04:33:59.653454 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Mar 12 04:33:59.687133 kernel: loop4: detected capacity change from 0 to 140768 Mar 12 04:33:59.718135 kernel: loop5: detected capacity change from 0 to 142488 Mar 12 04:33:59.753129 kernel: loop6: detected capacity change from 0 to 8 Mar 12 04:33:59.760123 kernel: loop7: detected capacity change from 0 to 217752 Mar 12 04:33:59.799573 (sd-merge)[1213]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'kubernetes', 'oem-openstack'. Mar 12 04:33:59.802364 (sd-merge)[1213]: Merged extensions into '/usr'. Mar 12 04:33:59.814283 systemd[1]: Reloading requested from client PID 1186 ('systemd-sysext') (unit systemd-sysext.service)... Mar 12 04:33:59.814490 systemd[1]: Reloading... Mar 12 04:33:59.979145 zram_generator::config[1239]: No configuration found. Mar 12 04:34:00.103126 ldconfig[1181]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Mar 12 04:34:00.249853 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. Mar 12 04:34:00.319230 systemd[1]: Reloading finished in 501 ms. Mar 12 04:34:00.354733 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Mar 12 04:34:00.356022 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Mar 12 04:34:00.357280 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Mar 12 04:34:00.371360 systemd[1]: Starting ensure-sysext.service... Mar 12 04:34:00.373783 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Mar 12 04:34:00.377320 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Mar 12 04:34:00.392243 systemd[1]: Reloading requested from client PID 1296 ('systemctl') (unit ensure-sysext.service)... Mar 12 04:34:00.392272 systemd[1]: Reloading... Mar 12 04:34:00.414562 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Mar 12 04:34:00.415804 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Mar 12 04:34:00.417857 systemd-tmpfiles[1297]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Mar 12 04:34:00.418290 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Mar 12 04:34:00.418415 systemd-tmpfiles[1297]: ACLs are not supported, ignoring. Mar 12 04:34:00.425416 systemd-tmpfiles[1297]: Detected autofs mount point /boot during canonicalization of boot. Mar 12 04:34:00.425865 systemd-tmpfiles[1297]: Skipping /boot Mar 12 04:34:00.450627 systemd-tmpfiles[1297]: Detected autofs mount point /boot during canonicalization of boot. Mar 12 04:34:00.450804 systemd-tmpfiles[1297]: Skipping /boot Mar 12 04:34:00.467236 systemd-udevd[1298]: Using default interface naming scheme 'v255'. Mar 12 04:34:00.512121 zram_generator::config[1328]: No configuration found. Mar 12 04:34:00.663124 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1333) Mar 12 04:34:00.788705 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. Mar 12 04:34:00.802119 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 Mar 12 04:34:00.833275 kernel: mousedev: PS/2 mouse device common for all mice Mar 12 04:34:00.869174 kernel: ACPI: button: Power Button [PWRF] Mar 12 04:34:00.894320 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Mar 12 04:34:00.892562 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Mar 12 04:34:00.892979 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Mar 12 04:34:00.894008 systemd[1]: Reloading finished in 501 ms. Mar 12 04:34:00.899379 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Mar 12 04:34:00.903901 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Mar 12 04:34:00.922262 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input5 Mar 12 04:34:00.914996 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Mar 12 04:34:00.917813 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 12 04:34:00.980485 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Mar 12 04:34:00.985299 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Mar 12 04:34:00.992447 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Mar 12 04:34:00.997571 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Mar 12 04:34:01.004219 systemd[1]: Starting systemd-networkd.service - Network Configuration... Mar 12 04:34:01.014242 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Mar 12 04:34:01.027527 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 12 04:34:01.039641 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.039949 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 12 04:34:01.057697 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Mar 12 04:34:01.062225 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Mar 12 04:34:01.082232 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Mar 12 04:34:01.083705 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 12 04:34:01.084254 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.088699 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.088980 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 12 04:34:01.089618 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 12 04:34:01.103594 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Mar 12 04:34:01.104635 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.120130 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.120496 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Mar 12 04:34:01.129453 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Mar 12 04:34:01.130465 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Mar 12 04:34:01.130547 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Mar 12 04:34:01.131208 systemd[1]: Finished ensure-sysext.service. Mar 12 04:34:01.132286 systemd[1]: modprobe@loop.service: Deactivated successfully. Mar 12 04:34:01.132485 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Mar 12 04:34:01.137668 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 12 04:34:01.162361 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Mar 12 04:34:01.164743 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Mar 12 04:34:01.171202 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Mar 12 04:34:01.174606 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Mar 12 04:34:01.176167 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Mar 12 04:34:01.181599 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Mar 12 04:34:01.181723 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). Mar 12 04:34:01.202756 systemd[1]: modprobe@drm.service: Deactivated successfully. Mar 12 04:34:01.203013 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Mar 12 04:34:01.204630 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Mar 12 04:34:01.218948 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Mar 12 04:34:01.221384 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Mar 12 04:34:01.229392 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Mar 12 04:34:01.241342 systemd[1]: Starting systemd-update-done.service - Update is Completed... Mar 12 04:34:01.268909 augenrules[1445]: No rules Mar 12 04:34:01.270913 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Mar 12 04:34:01.290528 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Mar 12 04:34:01.294163 systemd[1]: Finished systemd-update-done.service - Update is Completed. Mar 12 04:34:01.318876 systemd[1]: Started systemd-userdbd.service - User Database Manager. Mar 12 04:34:01.502277 systemd-resolved[1412]: Positive Trust Anchors: Mar 12 04:34:01.502316 systemd-resolved[1412]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Mar 12 04:34:01.502361 systemd-resolved[1412]: 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 Mar 12 04:34:01.517955 systemd-resolved[1412]: Using system hostname 'srv-1aqj0.gb1.brightbox.com'. Mar 12 04:34:01.518137 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Mar 12 04:34:01.530740 systemd-networkd[1411]: lo: Link UP Mar 12 04:34:01.531367 systemd-networkd[1411]: lo: Gained carrier Mar 12 04:34:01.536887 systemd-timesyncd[1431]: No network connectivity, watching for changes. Mar 12 04:34:01.537691 systemd-networkd[1411]: Enumeration completed Mar 12 04:34:01.538604 systemd-networkd[1411]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 12 04:34:01.538617 systemd-networkd[1411]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Mar 12 04:34:01.542788 systemd-networkd[1411]: eth0: Link UP Mar 12 04:34:01.543035 systemd-networkd[1411]: eth0: Gained carrier Mar 12 04:34:01.543160 systemd-networkd[1411]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Mar 12 04:34:01.558181 systemd-networkd[1411]: eth0: DHCPv4 address 10.230.9.230/30, gateway 10.230.9.229 acquired from 10.230.9.229 Mar 12 04:34:01.558580 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Mar 12 04:34:01.560868 systemd[1]: Started systemd-networkd.service - Network Configuration. Mar 12 04:34:01.561201 systemd-timesyncd[1431]: Network configuration changed, trying to establish connection. Mar 12 04:34:01.562608 systemd[1]: Reached target network.target - Network. Mar 12 04:34:01.564218 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 12 04:34:01.564965 systemd[1]: Reached target time-set.target - System Time Set. Mar 12 04:34:01.573309 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Mar 12 04:34:01.574580 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Mar 12 04:34:01.576935 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Mar 12 04:34:01.582310 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Mar 12 04:34:01.610121 lvm[1469]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Mar 12 04:34:01.644674 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Mar 12 04:34:01.645927 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 12 04:34:01.646743 systemd[1]: Reached target sysinit.target - System Initialization. Mar 12 04:34:01.647697 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Mar 12 04:34:01.648691 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Mar 12 04:34:01.649791 systemd[1]: Started logrotate.timer - Daily rotation of log files. Mar 12 04:34:01.650714 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Mar 12 04:34:01.651527 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 12 04:34:01.652343 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Mar 12 04:34:01.652401 systemd[1]: Reached target paths.target - Path Units. Mar 12 04:34:01.653048 systemd[1]: Reached target timers.target - Timer Units. Mar 12 04:34:01.654804 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 12 04:34:01.657964 systemd[1]: Starting docker.socket - Docker Socket for the API... Mar 12 04:34:01.663273 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Mar 12 04:34:01.665874 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Mar 12 04:34:01.667295 systemd[1]: Listening on docker.socket - Docker Socket for the API. Mar 12 04:34:01.668160 systemd[1]: Reached target sockets.target - Socket Units. Mar 12 04:34:01.668832 systemd[1]: Reached target basic.target - Basic System. Mar 12 04:34:01.669552 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Mar 12 04:34:01.669603 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Mar 12 04:34:01.684032 systemd[1]: Starting containerd.service - containerd container runtime... Mar 12 04:34:01.688317 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Mar 12 04:34:01.689627 lvm[1473]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Mar 12 04:34:01.692291 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 12 04:34:01.701209 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Mar 12 04:34:01.713325 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Mar 12 04:34:01.714119 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). Mar 12 04:34:01.718348 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Mar 12 04:34:01.723306 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Mar 12 04:34:01.728078 jq[1477]: false Mar 12 04:34:01.732291 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Mar 12 04:34:01.747996 systemd[1]: Starting systemd-logind.service - User Login Management... Mar 12 04:34:01.749950 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Mar 12 04:34:01.750703 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Mar 12 04:34:01.762067 dbus-daemon[1476]: [system] SELinux support is enabled Mar 12 04:34:01.763328 systemd[1]: Starting update-engine.service - Update Engine... Mar 12 04:34:01.771991 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Mar 12 04:34:01.773241 dbus-daemon[1476]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1411 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Mar 12 04:34:01.774885 systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 12 04:34:01.777362 jq[1486]: true Mar 12 04:34:01.786184 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Mar 12 04:34:01.789656 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Mar 12 04:34:01.789901 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Mar 12 04:34:01.791420 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Mar 12 04:34:01.791687 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Mar 12 04:34:02.813437 systemd-resolved[1412]: Clock change detected. Flushing caches. Mar 12 04:34:02.813603 systemd-timesyncd[1431]: Contacted time server 139.162.242.115:123 (1.flatcar.pool.ntp.org). Mar 12 04:34:02.813680 systemd-timesyncd[1431]: Initial clock synchronization to Thu 2026-03-12 04:34:02.813364 UTC. Mar 12 04:34:02.830656 systemd[1]: motdgen.service: Deactivated successfully. Mar 12 04:34:02.832025 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Mar 12 04:34:02.833331 (ntainerd)[1499]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Mar 12 04:34:02.838452 dbus-daemon[1476]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 12 04:34:02.847174 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Mar 12 04:34:02.849106 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). Mar 12 04:34:02.849152 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Mar 12 04:34:02.852368 update_engine[1485]: I20260312 04:34:02.852231 1485 main.cc:92] Flatcar Update Engine starting Mar 12 04:34:02.855068 update_engine[1485]: I20260312 04:34:02.854801 1485 update_check_scheduler.cc:74] Next update check in 3m8s Mar 12 04:34:02.860177 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Mar 12 04:34:02.862099 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). Mar 12 04:34:02.862140 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Mar 12 04:34:02.863116 systemd[1]: Started update-engine.service - Update Engine. Mar 12 04:34:02.874000 systemd[1]: Started locksmithd.service - Cluster reboot manager. Mar 12 04:34:02.879956 jq[1489]: true Mar 12 04:34:02.894974 extend-filesystems[1478]: Found loop4 Mar 12 04:34:02.894974 extend-filesystems[1478]: Found loop5 Mar 12 04:34:02.894974 extend-filesystems[1478]: Found loop6 Mar 12 04:34:02.894974 extend-filesystems[1478]: Found loop7 Mar 12 04:34:02.894974 extend-filesystems[1478]: Found vda Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda1 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda2 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda3 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found usr Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda4 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda6 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda7 Mar 12 04:34:02.901357 extend-filesystems[1478]: Found vda9 Mar 12 04:34:02.901357 extend-filesystems[1478]: Checking size of /dev/vda9 Mar 12 04:34:02.965152 extend-filesystems[1478]: Resized partition /dev/vda9 Mar 12 04:34:02.976960 extend-filesystems[1523]: resize2fs 1.47.1 (20-May-2024) Mar 12 04:34:02.985966 kernel: EXT4-fs (vda9): resizing filesystem from 1617920 to 15121403 blocks Mar 12 04:34:03.024704 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1336) Mar 12 04:34:03.071265 systemd-logind[1484]: Watching system buttons on /dev/input/event2 (Power Button) Mar 12 04:34:03.071309 systemd-logind[1484]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Mar 12 04:34:03.073177 systemd-logind[1484]: New seat seat0. Mar 12 04:34:03.078188 systemd[1]: Started systemd-logind.service - User Login Management. Mar 12 04:34:03.116024 bash[1530]: Updated "/home/core/.ssh/authorized_keys" Mar 12 04:34:03.122038 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Mar 12 04:34:03.137799 systemd[1]: Starting sshkeys.service... Mar 12 04:34:03.216336 dbus-daemon[1476]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 12 04:34:03.217049 dbus-daemon[1476]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1508 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Mar 12 04:34:03.222673 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Mar 12 04:34:03.225424 locksmithd[1509]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Mar 12 04:34:03.232504 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Mar 12 04:34:03.244062 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Mar 12 04:34:03.252548 systemd[1]: Starting polkit.service - Authorization Manager... Mar 12 04:34:03.297754 polkitd[1544]: Started polkitd version 121 Mar 12 04:34:03.315802 kernel: EXT4-fs (vda9): resized filesystem to 15121403 Mar 12 04:34:03.315533 polkitd[1544]: Loading rules from directory /etc/polkit-1/rules.d Mar 12 04:34:03.315641 polkitd[1544]: Loading rules from directory /usr/share/polkit-1/rules.d Mar 12 04:34:03.318702 polkitd[1544]: Finished loading, compiling and executing 2 rules Mar 12 04:34:03.322049 dbus-daemon[1476]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Mar 12 04:34:03.322345 systemd[1]: Started polkit.service - Authorization Manager. Mar 12 04:34:03.323588 polkitd[1544]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Mar 12 04:34:03.342708 extend-filesystems[1523]: Filesystem at /dev/vda9 is mounted on /; on-line resizing required Mar 12 04:34:03.342708 extend-filesystems[1523]: old_desc_blocks = 1, new_desc_blocks = 8 Mar 12 04:34:03.342708 extend-filesystems[1523]: The filesystem on /dev/vda9 is now 15121403 (4k) blocks long. Mar 12 04:34:03.341824 systemd[1]: extend-filesystems.service: Deactivated successfully. Mar 12 04:34:03.360706 extend-filesystems[1478]: Resized filesystem in /dev/vda9 Mar 12 04:34:03.342151 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Mar 12 04:34:03.363922 systemd-hostnamed[1508]: Hostname set to (static) Mar 12 04:34:03.372248 containerd[1499]: time="2026-03-12T04:34:03.372124321Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Mar 12 04:34:03.404199 containerd[1499]: time="2026-03-12T04:34:03.404140973Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.406964 containerd[1499]: time="2026-03-12T04:34:03.406775804Z" 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.127-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Mar 12 04:34:03.406964 containerd[1499]: time="2026-03-12T04:34:03.406818062Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Mar 12 04:34:03.406964 containerd[1499]: time="2026-03-12T04:34:03.406841430Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Mar 12 04:34:03.407591 containerd[1499]: time="2026-03-12T04:34:03.407297279Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Mar 12 04:34:03.407591 containerd[1499]: time="2026-03-12T04:34:03.407340595Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.407591 containerd[1499]: time="2026-03-12T04:34:03.407450872Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Mar 12 04:34:03.407591 containerd[1499]: time="2026-03-12T04:34:03.407487398Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.407956 containerd[1499]: time="2026-03-12T04:34:03.407908097Z" 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 Mar 12 04:34:03.408051 containerd[1499]: time="2026-03-12T04:34:03.408027753Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.408800 containerd[1499]: time="2026-03-12T04:34:03.408131191Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Mar 12 04:34:03.408800 containerd[1499]: time="2026-03-12T04:34:03.408157158Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.408800 containerd[1499]: time="2026-03-12T04:34:03.408327784Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.408800 containerd[1499]: time="2026-03-12T04:34:03.408749002Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Mar 12 04:34:03.409148 containerd[1499]: time="2026-03-12T04:34:03.409117876Z" 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 Mar 12 04:34:03.409271 containerd[1499]: time="2026-03-12T04:34:03.409245692Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Mar 12 04:34:03.409513 containerd[1499]: time="2026-03-12T04:34:03.409486263Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Mar 12 04:34:03.409695 containerd[1499]: time="2026-03-12T04:34:03.409669736Z" level=info msg="metadata content store policy set" policy=shared Mar 12 04:34:03.413764 containerd[1499]: time="2026-03-12T04:34:03.413729904Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Mar 12 04:34:03.413966 containerd[1499]: time="2026-03-12T04:34:03.413917730Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Mar 12 04:34:03.414105 containerd[1499]: time="2026-03-12T04:34:03.414079796Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Mar 12 04:34:03.414274 containerd[1499]: time="2026-03-12T04:34:03.414236414Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Mar 12 04:34:03.414786 containerd[1499]: time="2026-03-12T04:34:03.414432774Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Mar 12 04:34:03.414786 containerd[1499]: time="2026-03-12T04:34:03.414696246Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Mar 12 04:34:03.415258 containerd[1499]: time="2026-03-12T04:34:03.415230756Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Mar 12 04:34:03.415555 containerd[1499]: time="2026-03-12T04:34:03.415527456Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Mar 12 04:34:03.415659 containerd[1499]: time="2026-03-12T04:34:03.415634596Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Mar 12 04:34:03.415763 containerd[1499]: time="2026-03-12T04:34:03.415738839Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Mar 12 04:34:03.415896 containerd[1499]: time="2026-03-12T04:34:03.415867137Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416001683Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416029981Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416051519Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416072449Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416093505Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416115782Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416135493Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416178364Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416205178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416234427Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416256577Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416276107Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416295644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.416685 containerd[1499]: time="2026-03-12T04:34:03.416319197Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416338639Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416357741Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416379928Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416402740Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416421281Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416441213Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416510434Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416546062Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416580267Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.417189 containerd[1499]: time="2026-03-12T04:34:03.416601198Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Mar 12 04:34:03.417597 containerd[1499]: time="2026-03-12T04:34:03.417543785Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417766161Z" 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 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417795208Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417815896Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417832200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417887661Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417922624Z" level=info msg="NRI interface is disabled by configuration." Mar 12 04:34:03.418970 containerd[1499]: time="2026-03-12T04:34:03.417959764Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Mar 12 04:34:03.419239 containerd[1499]: time="2026-03-12T04:34:03.418368941Z" 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}" Mar 12 04:34:03.419239 containerd[1499]: time="2026-03-12T04:34:03.418452522Z" level=info msg="Connect containerd service" Mar 12 04:34:03.419239 containerd[1499]: time="2026-03-12T04:34:03.418511922Z" level=info msg="using legacy CRI server" Mar 12 04:34:03.419239 containerd[1499]: time="2026-03-12T04:34:03.418528079Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Mar 12 04:34:03.419239 containerd[1499]: time="2026-03-12T04:34:03.418686546Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Mar 12 04:34:03.420291 containerd[1499]: time="2026-03-12T04:34:03.420257247Z" 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" Mar 12 04:34:03.420581 containerd[1499]: time="2026-03-12T04:34:03.420533803Z" level=info msg="Start subscribing containerd event" Mar 12 04:34:03.420695 containerd[1499]: time="2026-03-12T04:34:03.420670640Z" level=info msg="Start recovering state" Mar 12 04:34:03.420864 containerd[1499]: time="2026-03-12T04:34:03.420839650Z" level=info msg="Start event monitor" Mar 12 04:34:03.421000 containerd[1499]: time="2026-03-12T04:34:03.420974958Z" level=info msg="Start snapshots syncer" Mar 12 04:34:03.421107 containerd[1499]: time="2026-03-12T04:34:03.421083423Z" level=info msg="Start cni network conf syncer for default" Mar 12 04:34:03.421234 containerd[1499]: time="2026-03-12T04:34:03.421207780Z" level=info msg="Start streaming server" Mar 12 04:34:03.422189 containerd[1499]: time="2026-03-12T04:34:03.421834360Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Mar 12 04:34:03.422365 containerd[1499]: time="2026-03-12T04:34:03.422339708Z" level=info msg=serving... address=/run/containerd/containerd.sock Mar 12 04:34:03.422591 containerd[1499]: time="2026-03-12T04:34:03.422567478Z" level=info msg="containerd successfully booted in 0.052286s" Mar 12 04:34:03.422678 systemd[1]: Started containerd.service - containerd container runtime. Mar 12 04:34:03.864435 systemd-networkd[1411]: eth0: Gained IPv6LL Mar 12 04:34:03.870696 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Mar 12 04:34:03.873725 systemd[1]: Reached target network-online.target - Network is Online. Mar 12 04:34:03.885870 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Mar 12 04:34:03.895130 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Mar 12 04:34:03.948617 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Mar 12 04:34:04.466003 sshd_keygen[1507]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Mar 12 04:34:04.504551 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Mar 12 04:34:04.513802 systemd[1]: Starting issuegen.service - Generate /run/issue... Mar 12 04:34:04.518182 systemd[1]: Started sshd@0-10.230.9.230:22-20.161.92.111:48226.service - OpenSSH per-connection server daemon (20.161.92.111:48226). Mar 12 04:34:04.527685 systemd[1]: issuegen.service: Deactivated successfully. Mar 12 04:34:04.527972 systemd[1]: Finished issuegen.service - Generate /run/issue. Mar 12 04:34:04.535051 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 12 04:34:04.560773 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 12 04:34:04.569967 systemd-networkd[1411]: eth0: Ignoring DHCPv6 address 2a02:1348:179:8279:24:19ff:fee6:9e6/128 (valid for 59min 59s, preferred for 59min 59s) which conflicts with 2a02:1348:179:8279:24:19ff:fee6:9e6/64 assigned by NDisc. Mar 12 04:34:04.569992 systemd-networkd[1411]: eth0: Hint: use IPv6Token= setting to change the address generated by NDisc or set UseAutonomousPrefix=no. Mar 12 04:34:04.571650 systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 12 04:34:04.589267 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Mar 12 04:34:04.590471 systemd[1]: Reached target getty.target - Login Prompts. Mar 12 04:34:05.000122 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:05.006733 (kubelet)[1597]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Mar 12 04:34:05.124109 sshd[1582]: Accepted publickey for core from 20.161.92.111 port 48226 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:05.128307 sshd[1582]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:05.150234 systemd-logind[1484]: New session 1 of user core. Mar 12 04:34:05.154559 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Mar 12 04:34:05.168289 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Mar 12 04:34:05.204196 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Mar 12 04:34:05.215477 systemd[1]: Starting user@500.service - User Manager for UID 500... Mar 12 04:34:05.231198 (systemd)[1604]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Mar 12 04:34:05.379728 systemd[1604]: Queued start job for default target default.target. Mar 12 04:34:05.389484 systemd[1604]: Created slice app.slice - User Application Slice. Mar 12 04:34:05.389528 systemd[1604]: Reached target paths.target - Paths. Mar 12 04:34:05.389551 systemd[1604]: Reached target timers.target - Timers. Mar 12 04:34:05.393140 systemd[1604]: Starting dbus.socket - D-Bus User Message Bus Socket... Mar 12 04:34:05.421314 systemd[1604]: Listening on dbus.socket - D-Bus User Message Bus Socket. Mar 12 04:34:05.421671 systemd[1604]: Reached target sockets.target - Sockets. Mar 12 04:34:05.421856 systemd[1604]: Reached target basic.target - Basic System. Mar 12 04:34:05.421928 systemd[1604]: Reached target default.target - Main User Target. Mar 12 04:34:05.422015 systemd[1604]: Startup finished in 181ms. Mar 12 04:34:05.422644 systemd[1]: Started user@500.service - User Manager for UID 500. Mar 12 04:34:05.431223 systemd[1]: Started session-1.scope - Session 1 of User core. Mar 12 04:34:05.626058 kubelet[1597]: E0312 04:34:05.625665 1597 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" Mar 12 04:34:05.628156 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Mar 12 04:34:05.628418 systemd[1]: kubelet.service: Failed with result 'exit-code'. Mar 12 04:34:05.629688 systemd[1]: kubelet.service: Consumed 1.008s CPU time. Mar 12 04:34:05.853384 systemd[1]: Started sshd@1-10.230.9.230:22-20.161.92.111:48242.service - OpenSSH per-connection server daemon (20.161.92.111:48242). Mar 12 04:34:06.405031 sshd[1618]: Accepted publickey for core from 20.161.92.111 port 48242 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:06.407691 sshd[1618]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:06.415733 systemd-logind[1484]: New session 2 of user core. Mar 12 04:34:06.422246 systemd[1]: Started session-2.scope - Session 2 of User core. Mar 12 04:34:06.803450 sshd[1618]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:06.809768 systemd-logind[1484]: Session 2 logged out. Waiting for processes to exit. Mar 12 04:34:06.810244 systemd[1]: sshd@1-10.230.9.230:22-20.161.92.111:48242.service: Deactivated successfully. Mar 12 04:34:06.813142 systemd[1]: session-2.scope: Deactivated successfully. Mar 12 04:34:06.814475 systemd-logind[1484]: Removed session 2. Mar 12 04:34:06.912612 systemd[1]: Started sshd@2-10.230.9.230:22-20.161.92.111:48254.service - OpenSSH per-connection server daemon (20.161.92.111:48254). Mar 12 04:34:07.463902 sshd[1626]: Accepted publickey for core from 20.161.92.111 port 48254 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:07.467000 sshd[1626]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:07.474283 systemd-logind[1484]: New session 3 of user core. Mar 12 04:34:07.483398 systemd[1]: Started session-3.scope - Session 3 of User core. Mar 12 04:34:07.862391 sshd[1626]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:07.869015 systemd-logind[1484]: Session 3 logged out. Waiting for processes to exit. Mar 12 04:34:07.870160 systemd[1]: sshd@2-10.230.9.230:22-20.161.92.111:48254.service: Deactivated successfully. Mar 12 04:34:07.873234 systemd[1]: session-3.scope: Deactivated successfully. Mar 12 04:34:07.874788 systemd-logind[1484]: Removed session 3. Mar 12 04:34:09.629526 login[1590]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 12 04:34:09.639326 systemd-logind[1484]: New session 4 of user core. Mar 12 04:34:09.655123 login[1588]: pam_unix(login:session): session opened for user core(uid=500) by LOGIN(uid=0) Mar 12 04:34:09.655408 systemd[1]: Started session-4.scope - Session 4 of User core. Mar 12 04:34:09.671912 systemd-logind[1484]: New session 5 of user core. Mar 12 04:34:09.678288 systemd[1]: Started session-5.scope - Session 5 of User core. Mar 12 04:34:09.816783 coreos-metadata[1475]: Mar 12 04:34:09.816 WARN failed to locate config-drive, using the metadata service API instead Mar 12 04:34:09.844500 coreos-metadata[1475]: Mar 12 04:34:09.844 INFO Fetching http://169.254.169.254/openstack/2012-08-10/meta_data.json: Attempt #1 Mar 12 04:34:09.851343 coreos-metadata[1475]: Mar 12 04:34:09.851 INFO Fetch failed with 404: resource not found Mar 12 04:34:09.851343 coreos-metadata[1475]: Mar 12 04:34:09.851 INFO Fetching http://169.254.169.254/latest/meta-data/hostname: Attempt #1 Mar 12 04:34:09.852322 coreos-metadata[1475]: Mar 12 04:34:09.852 INFO Fetch successful Mar 12 04:34:09.852401 coreos-metadata[1475]: Mar 12 04:34:09.852 INFO Fetching http://169.254.169.254/latest/meta-data/instance-id: Attempt #1 Mar 12 04:34:09.868364 coreos-metadata[1475]: Mar 12 04:34:09.868 INFO Fetch successful Mar 12 04:34:09.868497 coreos-metadata[1475]: Mar 12 04:34:09.868 INFO Fetching http://169.254.169.254/latest/meta-data/instance-type: Attempt #1 Mar 12 04:34:09.885768 coreos-metadata[1475]: Mar 12 04:34:09.885 INFO Fetch successful Mar 12 04:34:09.885768 coreos-metadata[1475]: Mar 12 04:34:09.885 INFO Fetching http://169.254.169.254/latest/meta-data/local-ipv4: Attempt #1 Mar 12 04:34:09.902634 coreos-metadata[1475]: Mar 12 04:34:09.902 INFO Fetch successful Mar 12 04:34:09.902839 coreos-metadata[1475]: Mar 12 04:34:09.902 INFO Fetching http://169.254.169.254/latest/meta-data/public-ipv4: Attempt #1 Mar 12 04:34:09.920350 coreos-metadata[1475]: Mar 12 04:34:09.920 INFO Fetch successful Mar 12 04:34:09.959314 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Mar 12 04:34:09.960907 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Mar 12 04:34:10.363558 coreos-metadata[1543]: Mar 12 04:34:10.363 WARN failed to locate config-drive, using the metadata service API instead Mar 12 04:34:10.387812 coreos-metadata[1543]: Mar 12 04:34:10.387 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys: Attempt #1 Mar 12 04:34:10.413091 coreos-metadata[1543]: Mar 12 04:34:10.413 INFO Fetch successful Mar 12 04:34:10.413252 coreos-metadata[1543]: Mar 12 04:34:10.413 INFO Fetching http://169.254.169.254/latest/meta-data/public-keys/0/openssh-key: Attempt #1 Mar 12 04:34:10.444117 coreos-metadata[1543]: Mar 12 04:34:10.444 INFO Fetch successful Mar 12 04:34:10.446557 unknown[1543]: wrote ssh authorized keys file for user: core Mar 12 04:34:10.468680 update-ssh-keys[1665]: Updated "/home/core/.ssh/authorized_keys" Mar 12 04:34:10.470494 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Mar 12 04:34:10.472847 systemd[1]: Finished sshkeys.service. Mar 12 04:34:10.476378 systemd[1]: Reached target multi-user.target - Multi-User System. Mar 12 04:34:10.477092 systemd[1]: Startup finished in 1.471s (kernel) + 13.086s (initrd) + 11.670s (userspace) = 26.229s. Mar 12 04:34:15.816381 systemd[1]: kubelet.service: Scheduled restart job, restart counter is at 1. Mar 12 04:34:15.823208 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Mar 12 04:34:16.004573 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:16.019500 (kubelet)[1677]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS, KUBELET_KUBEADM_ARGS Mar 12 04:34:16.139463 kubelet[1677]: E0312 04:34:16.139248 1677 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" Mar 12 04:34:16.143410 systemd[1]: kubelet.service: Main process exited, code=exited, status=1/FAILURE Mar 12 04:34:16.143648 systemd[1]: kubelet.service: Failed with result 'exit-code'. Mar 12 04:34:17.965036 systemd[1]: Started sshd@3-10.230.9.230:22-20.161.92.111:36814.service - OpenSSH per-connection server daemon (20.161.92.111:36814). Mar 12 04:34:18.522108 sshd[1685]: Accepted publickey for core from 20.161.92.111 port 36814 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:18.524159 sshd[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:18.530825 systemd-logind[1484]: New session 6 of user core. Mar 12 04:34:18.544222 systemd[1]: Started session-6.scope - Session 6 of User core. Mar 12 04:34:18.916826 sshd[1685]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:18.921760 systemd[1]: sshd@3-10.230.9.230:22-20.161.92.111:36814.service: Deactivated successfully. Mar 12 04:34:18.924086 systemd[1]: session-6.scope: Deactivated successfully. Mar 12 04:34:18.925092 systemd-logind[1484]: Session 6 logged out. Waiting for processes to exit. Mar 12 04:34:18.926386 systemd-logind[1484]: Removed session 6. Mar 12 04:34:19.018256 systemd[1]: Started sshd@4-10.230.9.230:22-20.161.92.111:36830.service - OpenSSH per-connection server daemon (20.161.92.111:36830). Mar 12 04:34:19.568782 sshd[1692]: Accepted publickey for core from 20.161.92.111 port 36830 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:19.571571 sshd[1692]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:19.577494 systemd-logind[1484]: New session 7 of user core. Mar 12 04:34:19.584139 systemd[1]: Started session-7.scope - Session 7 of User core. Mar 12 04:34:19.957764 sshd[1692]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:19.963501 systemd-logind[1484]: Session 7 logged out. Waiting for processes to exit. Mar 12 04:34:19.964324 systemd[1]: sshd@4-10.230.9.230:22-20.161.92.111:36830.service: Deactivated successfully. Mar 12 04:34:19.966474 systemd[1]: session-7.scope: Deactivated successfully. Mar 12 04:34:19.967874 systemd-logind[1484]: Removed session 7. Mar 12 04:34:20.059845 systemd[1]: Started sshd@5-10.230.9.230:22-20.161.92.111:36844.service - OpenSSH per-connection server daemon (20.161.92.111:36844). Mar 12 04:34:20.633537 sshd[1699]: Accepted publickey for core from 20.161.92.111 port 36844 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:20.634503 sshd[1699]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:20.642197 systemd-logind[1484]: New session 8 of user core. Mar 12 04:34:20.652316 systemd[1]: Started session-8.scope - Session 8 of User core. Mar 12 04:34:21.029739 sshd[1699]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:21.034586 systemd[1]: sshd@5-10.230.9.230:22-20.161.92.111:36844.service: Deactivated successfully. Mar 12 04:34:21.037236 systemd[1]: session-8.scope: Deactivated successfully. Mar 12 04:34:21.039282 systemd-logind[1484]: Session 8 logged out. Waiting for processes to exit. Mar 12 04:34:21.040861 systemd-logind[1484]: Removed session 8. Mar 12 04:34:21.126711 systemd[1]: Started sshd@6-10.230.9.230:22-20.161.92.111:50342.service - OpenSSH per-connection server daemon (20.161.92.111:50342). Mar 12 04:34:21.690365 sshd[1706]: Accepted publickey for core from 20.161.92.111 port 50342 ssh2: RSA SHA256:Og1sBJQhpCaSrAUaqgWUKLRz71/5xOULak8g1URRdac Mar 12 04:34:21.691281 sshd[1706]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Mar 12 04:34:21.697935 systemd-logind[1484]: New session 9 of user core. Mar 12 04:34:21.706193 systemd[1]: Started session-9.scope - Session 9 of User core. Mar 12 04:34:22.008396 sudo[1709]: core : PWD=/home/core ; USER=root ; COMMAND=/home/core/install.sh Mar 12 04:34:22.008883 sudo[1709]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Mar 12 04:34:22.848356 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:22.856501 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Mar 12 04:34:22.909114 systemd[1]: Reloading requested from client PID 1750 ('systemctl') (unit session-9.scope)... Mar 12 04:34:22.909148 systemd[1]: Reloading... Mar 12 04:34:23.065120 zram_generator::config[1795]: No configuration found. Mar 12 04:34:23.236478 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. Mar 12 04:34:23.349135 systemd[1]: Reloading finished in 439 ms. Mar 12 04:34:23.435847 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:23.441595 systemd[1]: Stopping kubelet.service - kubelet: The Kubernetes Node Agent... Mar 12 04:34:23.444263 systemd[1]: kubelet.service: Deactivated successfully. Mar 12 04:34:23.444678 systemd[1]: Stopped kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:23.451255 systemd[1]: Starting kubelet.service - kubelet: The Kubernetes Node Agent... Mar 12 04:34:23.615526 systemd[1]: Started kubelet.service - kubelet: The Kubernetes Node Agent. Mar 12 04:34:23.630830 (kubelet)[1859]: kubelet.service: Referenced but unset environment variable evaluates to an empty string: KUBELET_EXTRA_ARGS Mar 12 04:34:23.681274 kubelet[1859]: 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. Mar 12 04:34:23.856443 kubelet[1859]: I0312 04:34:23.856356 1859 server.go:525] "Kubelet version" kubeletVersion="v1.35.1" Mar 12 04:34:23.856443 kubelet[1859]: I0312 04:34:23.856427 1859 server.go:527] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK="" Mar 12 04:34:23.856641 kubelet[1859]: I0312 04:34:23.856478 1859 watchdog_linux.go:95] "Systemd watchdog is not enabled" Mar 12 04:34:23.856641 kubelet[1859]: I0312 04:34:23.856490 1859 watchdog_linux.go:138] "Systemd watchdog is not enabled or the interval is invalid, so health checking will not be started." Mar 12 04:34:23.856839 kubelet[1859]: I0312 04:34:23.856803 1859 server.go:951] "Client rotation is on, will bootstrap in background" Mar 12 04:34:23.862538 kubelet[1859]: I0312 04:34:23.862074 1859 dynamic_cafile_content.go:161] "Starting controller" name="client-ca-bundle::/etc/kubernetes/pki/ca.crt" Mar 12 04:34:23.877249 kubelet[1859]: E0312 04:34:23.876490 1859 log.go:32] "RuntimeConfig from runtime service failed" err="rpc error: code = Unimplemented desc = unknown method RuntimeConfig for service runtime.v1.RuntimeService" Mar 12 04:34:23.877249 kubelet[1859]: I0312 04:34:23.876568 1859 server.go:1395] "CRI implementation should be updated to support RuntimeConfig. Falling back to using cgroupDriver from kubelet config." Mar 12 04:34:23.882600 kubelet[1859]: I0312 04:34:23.882573 1859 server.go:775] "--cgroups-per-qos enabled, but --cgroup-root was not specified. Defaulting to /" Mar 12 04:34:23.883618 kubelet[1859]: I0312 04:34:23.883559 1859 container_manager_linux.go:272] "Container manager verified user specified cgroup-root exists" cgroupRoot=[] Mar 12 04:34:23.883859 kubelet[1859]: I0312 04:34:23.883610 1859 container_manager_linux.go:277] "Creating Container Manager object based on Node Config" nodeConfig={"NodeName":"10.230.9.230","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} Mar 12 04:34:23.884446 kubelet[1859]: I0312 04:34:23.883872 1859 topology_manager.go:143] "Creating topology manager with none policy" Mar 12 04:34:23.884446 kubelet[1859]: I0312 04:34:23.883889 1859 container_manager_linux.go:308] "Creating device plugin manager" Mar 12 04:34:23.884446 kubelet[1859]: I0312 04:34:23.884063 1859 container_manager_linux.go:317] "Creating Dynamic Resource Allocation (DRA) manager" Mar 12 04:34:23.886323 kubelet[1859]: I0312 04:34:23.886296 1859 state_mem.go:41] "Initialized" logger="CPUManager state memory" Mar 12 04:34:23.886667 kubelet[1859]: I0312 04:34:23.886646 1859 kubelet.go:482] "Attempting to sync node with API server" Mar 12 04:34:23.886744 kubelet[1859]: I0312 04:34:23.886670 1859 kubelet.go:383] "Adding static pod path" path="/etc/kubernetes/manifests" Mar 12 04:34:23.886744 kubelet[1859]: I0312 04:34:23.886723 1859 kubelet.go:394] "Adding apiserver pod source" Mar 12 04:34:23.888439 kubelet[1859]: I0312 04:34:23.886761 1859 apiserver.go:42] "Waiting for node sync before watching apiserver pods" Mar 12 04:34:23.888439 kubelet[1859]: E0312 04:34:23.887260 1859 file.go:98] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:23.888439 kubelet[1859]: E0312 04:34:23.887590 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:23.891108 kubelet[1859]: I0312 04:34:23.891081 1859 kuberuntime_manager.go:294] "Container runtime initialized" containerRuntime="containerd" version="v1.7.21" apiVersion="v1" Mar 12 04:34:23.896245 kubelet[1859]: I0312 04:34:23.896206 1859 kubelet.go:943] "Not starting ClusterTrustBundle informer because we are in static kubelet mode or the ClusterTrustBundleProjection featuregate is disabled" Mar 12 04:34:23.896418 kubelet[1859]: I0312 04:34:23.896397 1859 kubelet.go:970] "Not starting PodCertificateRequest manager because we are in static kubelet mode or the PodCertificateProjection feature gate is disabled" Mar 12 04:34:23.896618 kubelet[1859]: W0312 04:34:23.896597 1859 probe.go:272] Flexvolume plugin directory at /opt/libexec/kubernetes/kubelet-plugins/volume/exec/ does not exist. Recreating. Mar 12 04:34:23.902455 kubelet[1859]: I0312 04:34:23.902434 1859 server.go:1257] "Started kubelet" Mar 12 04:34:23.903658 kubelet[1859]: I0312 04:34:23.903615 1859 server.go:182] "Starting to listen" address="0.0.0.0" port=10250 Mar 12 04:34:23.903838 kubelet[1859]: I0312 04:34:23.903775 1859 ratelimit.go:56] "Setting rate limiting for endpoint" service="podresources" qps=100 burstTokens=10 Mar 12 04:34:23.904058 kubelet[1859]: I0312 04:34:23.904031 1859 server_v1.go:49] "podresources" method="list" useActivePods=true Mar 12 04:34:23.904870 kubelet[1859]: I0312 04:34:23.904828 1859 server.go:254] "Starting to serve the podresources API" endpoint="unix:/var/lib/kubelet/pod-resources/kubelet.sock" Mar 12 04:34:23.906351 kubelet[1859]: I0312 04:34:23.906321 1859 server.go:317] "Adding debug handlers to kubelet server" Mar 12 04:34:23.916716 kubelet[1859]: I0312 04:34:23.916520 1859 fs_resource_analyzer.go:69] "Starting FS ResourceAnalyzer" Mar 12 04:34:23.921343 kubelet[1859]: I0312 04:34:23.921315 1859 dynamic_serving_content.go:135] "Starting controller" name="kubelet-server-cert-files::/var/lib/kubelet/pki/kubelet.crt::/var/lib/kubelet/pki/kubelet.key" Mar 12 04:34:23.927049 kubelet[1859]: E0312 04:34:23.927023 1859 kubelet_node_status.go:392] "Error getting the current node from lister" err="node \"10.230.9.230\" not found" Mar 12 04:34:23.927402 kubelet[1859]: I0312 04:34:23.927379 1859 volume_manager.go:311] "Starting Kubelet Volume Manager" Mar 12 04:34:23.927979 kubelet[1859]: I0312 04:34:23.927822 1859 desired_state_of_world_populator.go:146] "Desired state populator starts to run" Mar 12 04:34:23.927979 kubelet[1859]: I0312 04:34:23.927917 1859 reconciler.go:29] "Reconciler: start to sync state" Mar 12 04:34:23.929291 kubelet[1859]: E0312 04:34:23.929263 1859 kubelet.go:1656] "Image garbage collection failed once. Stats initialization may not have completed yet" err="invalid capacity 0 on image filesystem" Mar 12 04:34:23.932452 kubelet[1859]: I0312 04:34:23.932427 1859 factory.go:223] Registration of the containerd container factory successfully Mar 12 04:34:23.932564 kubelet[1859]: I0312 04:34:23.932546 1859 factory.go:223] Registration of the systemd container factory successfully Mar 12 04:34:23.932955 kubelet[1859]: I0312 04:34:23.932864 1859 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 Mar 12 04:34:23.942915 kubelet[1859]: E0312 04:34:23.942854 1859 nodelease.go:50] "Failed to get node when trying to set owner ref to the node lease" err="nodes \"10.230.9.230\" not found" node="10.230.9.230" Mar 12 04:34:23.957559 kubelet[1859]: I0312 04:34:23.957531 1859 cpu_manager.go:225] "Starting" policy="none" Mar 12 04:34:23.958420 kubelet[1859]: I0312 04:34:23.957705 1859 cpu_manager.go:226] "Reconciling" reconcilePeriod="10s" Mar 12 04:34:23.958420 kubelet[1859]: I0312 04:34:23.957748 1859 state_mem.go:41] "Initialized" logger="CPUManager state checkpoint.CPUManager state memory" Mar 12 04:34:23.963057 kubelet[1859]: I0312 04:34:23.963035 1859 policy_none.go:50] "Start" Mar 12 04:34:23.963498 kubelet[1859]: I0312 04:34:23.963463 1859 memory_manager.go:187] "Starting memorymanager" policy="None" Mar 12 04:34:23.963632 kubelet[1859]: I0312 04:34:23.963608 1859 state_mem.go:36] "Initializing new in-memory state store" logger="Memory Manager state checkpoint" Mar 12 04:34:23.967976 kubelet[1859]: I0312 04:34:23.966835 1859 policy_none.go:44] "Start" Mar 12 04:34:23.975897 systemd[1]: Created slice kubepods.slice - libcontainer container kubepods.slice. Mar 12 04:34:24.002017 systemd[1]: Created slice kubepods-burstable.slice - libcontainer container kubepods-burstable.slice. Mar 12 04:34:24.007983 systemd[1]: Created slice kubepods-besteffort.slice - libcontainer container kubepods-besteffort.slice. Mar 12 04:34:24.017757 kubelet[1859]: E0312 04:34:24.017614 1859 manager.go:525] "Failed to read data from checkpoint" err="checkpoint is not found" checkpoint="kubelet_internal_checkpoint" Mar 12 04:34:24.018246 kubelet[1859]: I0312 04:34:24.018223 1859 eviction_manager.go:194] "Eviction manager: starting control loop" Mar 12 04:34:24.018403 kubelet[1859]: I0312 04:34:24.018357 1859 container_log_manager.go:146] "Initializing container log rotate workers" workers=1 monitorPeriod="10s" Mar 12 04:34:24.019519 kubelet[1859]: I0312 04:34:24.019497 1859 plugin_manager.go:121] "Starting Kubelet Plugin Manager" Mar 12 04:34:24.024108 kubelet[1859]: E0312 04:34:24.024026 1859 eviction_manager.go:272] "eviction manager: failed to check if we have separate container filesystem. Ignoring." err="no imagefs label for configured runtime" Mar 12 04:34:24.025663 kubelet[1859]: E0312 04:34:24.025639 1859 eviction_manager.go:297] "Eviction manager: failed to get summary stats" err="failed to get node info: node \"10.230.9.230\" not found" Mar 12 04:34:24.047618 kubelet[1859]: I0312 04:34:24.047563 1859 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv4" Mar 12 04:34:24.050261 kubelet[1859]: I0312 04:34:24.050237 1859 kubelet_network_linux.go:54] "Initialized iptables rules." protocol="IPv6" Mar 12 04:34:24.050495 kubelet[1859]: I0312 04:34:24.050476 1859 status_manager.go:249] "Starting to sync pod status with apiserver" Mar 12 04:34:24.050761 kubelet[1859]: I0312 04:34:24.050732 1859 kubelet.go:2501] "Starting kubelet main sync loop" Mar 12 04:34:24.051556 kubelet[1859]: E0312 04:34:24.051530 1859 kubelet.go:2525] "Skipping pod synchronization" err="PLEG is not healthy: pleg has yet to be successful" Mar 12 04:34:24.120051 kubelet[1859]: I0312 04:34:24.119997 1859 kubelet_node_status.go:74] "Attempting to register node" node="10.230.9.230" Mar 12 04:34:24.129176 kubelet[1859]: I0312 04:34:24.128616 1859 kubelet_node_status.go:77] "Successfully registered node" node="10.230.9.230" Mar 12 04:34:24.142870 kubelet[1859]: I0312 04:34:24.142833 1859 kuberuntime_manager.go:2062] "Updating runtime config through cri with podcidr" CIDR="192.168.1.0/24" Mar 12 04:34:24.143528 containerd[1499]: time="2026-03-12T04:34:24.143335462Z" level=info msg="No cni config template is specified, wait for other system components to drop the config." Mar 12 04:34:24.144103 kubelet[1859]: I0312 04:34:24.143647 1859 kubelet_network.go:47] "Updating Pod CIDR" originalPodCIDR="" newPodCIDR="192.168.1.0/24" Mar 12 04:34:24.232192 sudo[1709]: pam_unix(sudo:session): session closed for user root Mar 12 04:34:24.321103 sshd[1706]: pam_unix(sshd:session): session closed for user core Mar 12 04:34:24.325392 systemd[1]: sshd@6-10.230.9.230:22-20.161.92.111:50342.service: Deactivated successfully. Mar 12 04:34:24.328688 systemd[1]: session-9.scope: Deactivated successfully. Mar 12 04:34:24.330876 systemd-logind[1484]: Session 9 logged out. Waiting for processes to exit. Mar 12 04:34:24.332642 systemd-logind[1484]: Removed session 9. Mar 12 04:34:24.859265 kubelet[1859]: I0312 04:34:24.859111 1859 transport.go:147] "Certificate rotation detected, shutting down client connections to start using new credentials" Mar 12 04:34:24.860240 kubelet[1859]: I0312 04:34:24.860005 1859 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.CSIDriver" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Mar 12 04:34:24.860240 kubelet[1859]: I0312 04:34:24.860005 1859 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.RuntimeClass" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Mar 12 04:34:24.860240 kubelet[1859]: I0312 04:34:24.860118 1859 reflector.go:578] "Warning: watch ended with error" reflector="k8s.io/client-go/informers/factory.go:161" type="*v1.Service" err="very short watch: k8s.io/client-go/informers/factory.go:161: Unexpected watch close - watch lasted less than a second and no items received" Mar 12 04:34:24.888114 kubelet[1859]: I0312 04:34:24.887836 1859 apiserver.go:52] "Watching apiserver" Mar 12 04:34:24.888114 kubelet[1859]: E0312 04:34:24.887901 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:24.910266 systemd[1]: Created slice kubepods-besteffort-podda4aca1c_c86d_4a2d_b823_3b09da625d95.slice - libcontainer container kubepods-besteffort-podda4aca1c_c86d_4a2d_b823_3b09da625d95.slice. Mar 12 04:34:24.924657 systemd[1]: Created slice kubepods-burstable-pode8064b06_ea78_471f_85bb_252f82321f22.slice - libcontainer container kubepods-burstable-pode8064b06_ea78_471f_85bb_252f82321f22.slice. Mar 12 04:34:24.928465 kubelet[1859]: I0312 04:34:24.928424 1859 desired_state_of_world_populator.go:154] "Finished populating initial desired state of world" Mar 12 04:34:24.931048 kubelet[1859]: I0312 04:34:24.930988 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-proxy\" (UniqueName: \"kubernetes.io/configmap/da4aca1c-c86d-4a2d-b823-3b09da625d95-kube-proxy\") pod \"kube-proxy-pfrcv\" (UID: \"da4aca1c-c86d-4a2d-b823-3b09da625d95\") " pod="kube-system/kube-proxy-pfrcv" Mar 12 04:34:24.931048 kubelet[1859]: I0312 04:34:24.931040 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"lib-modules\" (UniqueName: \"kubernetes.io/host-path/da4aca1c-c86d-4a2d-b823-3b09da625d95-lib-modules\") pod \"kube-proxy-pfrcv\" (UID: \"da4aca1c-c86d-4a2d-b823-3b09da625d95\") " pod="kube-system/kube-proxy-pfrcv" Mar 12 04:34:24.931198 kubelet[1859]: I0312 04:34:24.931071 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-hn9p5\" (UniqueName: \"kubernetes.io/projected/da4aca1c-c86d-4a2d-b823-3b09da625d95-kube-api-access-hn9p5\") pod \"kube-proxy-pfrcv\" (UID: \"da4aca1c-c86d-4a2d-b823-3b09da625d95\") " pod="kube-system/kube-proxy-pfrcv" Mar 12 04:34:24.931198 kubelet[1859]: I0312 04:34:24.931101 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"run\" (UniqueName: \"kubernetes.io/host-path/e8064b06-ea78-471f-85bb-252f82321f22-run\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:24.931198 kubelet[1859]: I0312 04:34:24.931125 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-g9f6j\" (UniqueName: \"kubernetes.io/projected/e8064b06-ea78-471f-85bb-252f82321f22-kube-api-access-g9f6j\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:24.931198 kubelet[1859]: I0312 04:34:24.931149 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/da4aca1c-c86d-4a2d-b823-3b09da625d95-xtables-lock\") pod \"kube-proxy-pfrcv\" (UID: \"da4aca1c-c86d-4a2d-b823-3b09da625d95\") " pod="kube-system/kube-proxy-pfrcv" Mar 12 04:34:24.931198 kubelet[1859]: I0312 04:34:24.931172 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni-plugin\" (UniqueName: \"kubernetes.io/host-path/e8064b06-ea78-471f-85bb-252f82321f22-cni-plugin\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:24.931412 kubelet[1859]: I0312 04:34:24.931197 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"cni\" (UniqueName: \"kubernetes.io/host-path/e8064b06-ea78-471f-85bb-252f82321f22-cni\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:24.931412 kubelet[1859]: I0312 04:34:24.931235 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"flannel-cfg\" (UniqueName: \"kubernetes.io/configmap/e8064b06-ea78-471f-85bb-252f82321f22-flannel-cfg\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:24.931412 kubelet[1859]: I0312 04:34:24.931260 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"xtables-lock\" (UniqueName: \"kubernetes.io/host-path/e8064b06-ea78-471f-85bb-252f82321f22-xtables-lock\") pod \"kube-flannel-ds-b2r29\" (UID: \"e8064b06-ea78-471f-85bb-252f82321f22\") " pod="kube-flannel/kube-flannel-ds-b2r29" Mar 12 04:34:25.224696 containerd[1499]: time="2026-03-12T04:34:25.224535046Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-pfrcv,Uid:da4aca1c-c86d-4a2d-b823-3b09da625d95,Namespace:kube-system,Attempt:0,}" Mar 12 04:34:25.249380 containerd[1499]: time="2026-03-12T04:34:25.248929237Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-b2r29,Uid:e8064b06-ea78-471f-85bb-252f82321f22,Namespace:kube-flannel,Attempt:0,}" Mar 12 04:34:25.888894 kubelet[1859]: E0312 04:34:25.888825 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:26.176461 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2713119697.mount: Deactivated successfully. Mar 12 04:34:26.184085 containerd[1499]: time="2026-03-12T04:34:26.183991564Z" 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\"}" Mar 12 04:34:26.185355 containerd[1499]: time="2026-03-12T04:34:26.185313025Z" 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\"}" Mar 12 04:34:26.186721 containerd[1499]: time="2026-03-12T04:34:26.186638309Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=0" Mar 12 04:34:26.186721 containerd[1499]: time="2026-03-12T04:34:26.186699800Z" level=info msg="stop pulling image registry.k8s.io/pause:3.8: active requests=0, bytes read=312064" Mar 12 04:34:26.188971 containerd[1499]: time="2026-03-12T04:34:26.188017243Z" level=info msg="ImageCreate event name:\"sha256:4873874c08efc72e9729683a83ffbb7502ee729e9a5ac097723806ea7fa13517\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"} labels:{key:\"io.cri-containerd.pinned\" value:\"pinned\"}" Mar 12 04:34:26.192630 containerd[1499]: time="2026-03-12T04:34:26.192494214Z" 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\"}" Mar 12 04:34:26.194166 containerd[1499]: time="2026-03-12T04:34:26.194070154Z" 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 945.000767ms" Mar 12 04:34:26.199885 containerd[1499]: time="2026-03-12T04:34:26.199781241Z" 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 975.044591ms" Mar 12 04:34:26.381410 containerd[1499]: time="2026-03-12T04:34:26.380789614Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 12 04:34:26.381410 containerd[1499]: time="2026-03-12T04:34:26.380911368Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 12 04:34:26.381410 containerd[1499]: time="2026-03-12T04:34:26.381010162Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:26.381410 containerd[1499]: time="2026-03-12T04:34:26.381328871Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:26.382476 containerd[1499]: time="2026-03-12T04:34:26.381979348Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 12 04:34:26.382476 containerd[1499]: time="2026-03-12T04:34:26.382164503Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 12 04:34:26.382476 containerd[1499]: time="2026-03-12T04:34:26.382211472Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:26.382476 containerd[1499]: time="2026-03-12T04:34:26.382387004Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:26.480165 systemd[1]: Started cri-containerd-b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603.scope - libcontainer container b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603. Mar 12 04:34:26.492355 systemd[1]: Started cri-containerd-3294a623ee1de2acd98c26896800d4a386391ad0eadc2842d9989d05e304b82b.scope - libcontainer container 3294a623ee1de2acd98c26896800d4a386391ad0eadc2842d9989d05e304b82b. Mar 12 04:34:26.529257 containerd[1499]: time="2026-03-12T04:34:26.529206433Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-proxy-pfrcv,Uid:da4aca1c-c86d-4a2d-b823-3b09da625d95,Namespace:kube-system,Attempt:0,} returns sandbox id \"3294a623ee1de2acd98c26896800d4a386391ad0eadc2842d9989d05e304b82b\"" Mar 12 04:34:26.535252 containerd[1499]: time="2026-03-12T04:34:26.535198966Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.2\"" Mar 12 04:34:26.556193 containerd[1499]: time="2026-03-12T04:34:26.556149619Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:kube-flannel-ds-b2r29,Uid:e8064b06-ea78-471f-85bb-252f82321f22,Namespace:kube-flannel,Attempt:0,} returns sandbox id \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\"" Mar 12 04:34:26.889567 kubelet[1859]: E0312 04:34:26.889515 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:27.890967 kubelet[1859]: E0312 04:34:27.890052 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:28.130912 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2039960404.mount: Deactivated successfully. Mar 12 04:34:28.628973 containerd[1499]: time="2026-03-12T04:34:28.628847030Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy:v1.35.2\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:28.638150 containerd[1499]: time="2026-03-12T04:34:28.638083679Z" level=info msg="stop pulling image registry.k8s.io/kube-proxy:v1.35.2: active requests=0, bytes read=25685320" Mar 12 04:34:28.639204 containerd[1499]: time="2026-03-12T04:34:28.639144572Z" level=info msg="ImageCreate event name:\"sha256:3c471cf273e44f68c91b48985c27627d581915b9ee5e72f7227bbf2146008b5e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:28.641861 containerd[1499]: time="2026-03-12T04:34:28.641817006Z" level=info msg="ImageCreate event name:\"registry.k8s.io/kube-proxy@sha256:015265214cc874b593a7adccdcfe4ac15d2b8e9ae89881bdcd5bcb99d42e1862\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:28.643223 containerd[1499]: time="2026-03-12T04:34:28.643016724Z" level=info msg="Pulled image \"registry.k8s.io/kube-proxy:v1.35.2\" with image id \"sha256:3c471cf273e44f68c91b48985c27627d581915b9ee5e72f7227bbf2146008b5e\", repo tag \"registry.k8s.io/kube-proxy:v1.35.2\", repo digest \"registry.k8s.io/kube-proxy@sha256:015265214cc874b593a7adccdcfe4ac15d2b8e9ae89881bdcd5bcb99d42e1862\", size \"25684331\" in 2.107773796s" Mar 12 04:34:28.643223 containerd[1499]: time="2026-03-12T04:34:28.643060051Z" level=info msg="PullImage \"registry.k8s.io/kube-proxy:v1.35.2\" returns image reference \"sha256:3c471cf273e44f68c91b48985c27627d581915b9ee5e72f7227bbf2146008b5e\"" Mar 12 04:34:28.645481 containerd[1499]: time="2026-03-12T04:34:28.644677168Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\"" Mar 12 04:34:28.648970 containerd[1499]: time="2026-03-12T04:34:28.648917610Z" level=info msg="CreateContainer within sandbox \"3294a623ee1de2acd98c26896800d4a386391ad0eadc2842d9989d05e304b82b\" for container &ContainerMetadata{Name:kube-proxy,Attempt:0,}" Mar 12 04:34:28.666402 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2438141079.mount: Deactivated successfully. Mar 12 04:34:28.669548 containerd[1499]: time="2026-03-12T04:34:28.669349773Z" level=info msg="CreateContainer within sandbox \"3294a623ee1de2acd98c26896800d4a386391ad0eadc2842d9989d05e304b82b\" for &ContainerMetadata{Name:kube-proxy,Attempt:0,} returns container id \"12b5ff4c32100f7e68e0d09ebffd962a1af7a0935150452328ea7ae61e5d1680\"" Mar 12 04:34:28.670981 containerd[1499]: time="2026-03-12T04:34:28.670131315Z" level=info msg="StartContainer for \"12b5ff4c32100f7e68e0d09ebffd962a1af7a0935150452328ea7ae61e5d1680\"" Mar 12 04:34:28.715172 systemd[1]: Started cri-containerd-12b5ff4c32100f7e68e0d09ebffd962a1af7a0935150452328ea7ae61e5d1680.scope - libcontainer container 12b5ff4c32100f7e68e0d09ebffd962a1af7a0935150452328ea7ae61e5d1680. Mar 12 04:34:28.755027 containerd[1499]: time="2026-03-12T04:34:28.754914584Z" level=info msg="StartContainer for \"12b5ff4c32100f7e68e0d09ebffd962a1af7a0935150452328ea7ae61e5d1680\" returns successfully" Mar 12 04:34:28.891301 kubelet[1859]: E0312 04:34:28.891093 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:29.892071 kubelet[1859]: E0312 04:34:29.891840 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:30.003311 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount281076640.mount: Deactivated successfully. Mar 12 04:34:30.065501 containerd[1499]: time="2026-03-12T04:34:30.065383744Z" 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\"}" Mar 12 04:34:30.067846 containerd[1499]: time="2026-03-12T04:34:30.067791727Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1: active requests=0, bytes read=4857008" Mar 12 04:34:30.070987 containerd[1499]: time="2026-03-12T04:34:30.070401922Z" level=info msg="ImageCreate event name:\"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:30.074281 containerd[1499]: time="2026-03-12T04:34:30.074218818Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel-cni-plugin@sha256:f1812994f0edbcb5bb5ccb63be2147ba6ad10e1faaa7ca9fcdad4f441739d84f\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:30.076016 containerd[1499]: time="2026-03-12T04:34:30.075975008Z" 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.431255438s" Mar 12 04:34:30.076125 containerd[1499]: time="2026-03-12T04:34:30.076016923Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel-cni-plugin:v1.6.2-flannel1\" returns image reference \"sha256:55ce2385d9d8c6f720091c177fbe885a21c9dc07c9e480bfb4d94b3001f58182\"" Mar 12 04:34:30.081990 containerd[1499]: time="2026-03-12T04:34:30.081928561Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for container &ContainerMetadata{Name:install-cni-plugin,Attempt:0,}" Mar 12 04:34:30.100853 containerd[1499]: time="2026-03-12T04:34:30.100805155Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for &ContainerMetadata{Name:install-cni-plugin,Attempt:0,} returns container id \"b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba\"" Mar 12 04:34:30.101319 containerd[1499]: time="2026-03-12T04:34:30.101282428Z" level=info msg="StartContainer for \"b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba\"" Mar 12 04:34:30.143180 systemd[1]: Started cri-containerd-b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba.scope - libcontainer container b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba. Mar 12 04:34:30.177826 systemd[1]: cri-containerd-b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba.scope: Deactivated successfully. Mar 12 04:34:30.178915 containerd[1499]: time="2026-03-12T04:34:30.178845473Z" level=info msg="StartContainer for \"b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba\" returns successfully" Mar 12 04:34:30.446356 containerd[1499]: time="2026-03-12T04:34:30.446017283Z" level=info msg="shim disconnected" id=b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba namespace=k8s.io Mar 12 04:34:30.446356 containerd[1499]: time="2026-03-12T04:34:30.446138895Z" level=warning msg="cleaning up after shim disconnected" id=b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba namespace=k8s.io Mar 12 04:34:30.446356 containerd[1499]: time="2026-03-12T04:34:30.446167579Z" level=info msg="cleaning up dead shim" namespace=k8s.io Mar 12 04:34:30.845679 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-b54d127afdc2789dc399fe963eddc3f68305e2e78552e83fcba62e0cac767aba-rootfs.mount: Deactivated successfully. Mar 12 04:34:30.892798 kubelet[1859]: E0312 04:34:30.892707 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:31.074777 containerd[1499]: time="2026-03-12T04:34:31.074231241Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\"" Mar 12 04:34:31.086087 kubelet[1859]: I0312 04:34:31.085996 1859 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-system/kube-proxy-pfrcv" podStartSLOduration=4.976040419 podStartE2EDuration="7.08596109s" podCreationTimestamp="2026-03-12 04:34:24 +0000 UTC" firstStartedPulling="2026-03-12 04:34:26.534503863 +0000 UTC m=+2.898760397" lastFinishedPulling="2026-03-12 04:34:28.644424517 +0000 UTC m=+5.008681068" observedRunningTime="2026-03-12 04:34:29.079722327 +0000 UTC m=+5.443978864" watchObservedRunningTime="2026-03-12 04:34:31.08596109 +0000 UTC m=+7.450217636" Mar 12 04:34:31.893460 kubelet[1859]: E0312 04:34:31.893371 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:32.894013 kubelet[1859]: E0312 04:34:32.893900 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:33.577606 containerd[1499]: time="2026-03-12T04:34:33.577508266Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel:v0.26.7\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:33.581026 containerd[1499]: time="2026-03-12T04:34:33.580907785Z" level=info msg="stop pulling image ghcr.io/flannel-io/flannel:v0.26.7: active requests=0, bytes read=29354574" Mar 12 04:34:33.582170 containerd[1499]: time="2026-03-12T04:34:33.582118653Z" level=info msg="ImageCreate event name:\"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:33.588704 containerd[1499]: time="2026-03-12T04:34:33.588614197Z" level=info msg="ImageCreate event name:\"ghcr.io/flannel-io/flannel@sha256:7f471907fa940f944867270de4ed78121b8b4c5d564e17f940dc787cb16dea82\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:33.591405 containerd[1499]: time="2026-03-12T04:34:33.590783224Z" 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.516494265s" Mar 12 04:34:33.591405 containerd[1499]: time="2026-03-12T04:34:33.590842073Z" level=info msg="PullImage \"ghcr.io/flannel-io/flannel:v0.26.7\" returns image reference \"sha256:965b9dd4aa4c1b6b68a4c54a166692b4645b6e6f8a5937d8dc17736cb63f515e\"" Mar 12 04:34:33.597109 containerd[1499]: time="2026-03-12T04:34:33.597059559Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for container &ContainerMetadata{Name:install-cni,Attempt:0,}" Mar 12 04:34:33.609466 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2392518975.mount: Deactivated successfully. Mar 12 04:34:33.622839 containerd[1499]: time="2026-03-12T04:34:33.622712404Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for &ContainerMetadata{Name:install-cni,Attempt:0,} returns container id \"6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89\"" Mar 12 04:34:33.623827 containerd[1499]: time="2026-03-12T04:34:33.623790984Z" level=info msg="StartContainer for \"6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89\"" Mar 12 04:34:33.666250 systemd[1]: Started cri-containerd-6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89.scope - libcontainer container 6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89. Mar 12 04:34:33.703448 systemd[1]: cri-containerd-6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89.scope: Deactivated successfully. Mar 12 04:34:33.715162 containerd[1499]: time="2026-03-12T04:34:33.715113697Z" level=info msg="StartContainer for \"6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89\" returns successfully" Mar 12 04:34:33.724970 kubelet[1859]: I0312 04:34:33.724625 1859 kubelet_node_status.go:427] "Fast updating node status as it just became ready" Mar 12 04:34:33.747178 systemd[1]: run-containerd-io.containerd.runtime.v2.task-k8s.io-6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89-rootfs.mount: Deactivated successfully. Mar 12 04:34:33.895076 kubelet[1859]: E0312 04:34:33.894811 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:33.952071 containerd[1499]: time="2026-03-12T04:34:33.951924504Z" level=info msg="shim disconnected" id=6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89 namespace=k8s.io Mar 12 04:34:33.952071 containerd[1499]: time="2026-03-12T04:34:33.952058335Z" level=warning msg="cleaning up after shim disconnected" id=6349334cda2c8bb6540bbddb101dafe3044dc61bfbdabe9208566c784000bb89 namespace=k8s.io Mar 12 04:34:33.952071 containerd[1499]: time="2026-03-12T04:34:33.952080737Z" level=info msg="cleaning up dead shim" namespace=k8s.io Mar 12 04:34:33.968542 containerd[1499]: time="2026-03-12T04:34:33.968439075Z" level=warning msg="cleanup warnings time=\"2026-03-12T04:34:33Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=k8s.io Mar 12 04:34:34.087064 containerd[1499]: time="2026-03-12T04:34:34.087015469Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for container &ContainerMetadata{Name:kube-flannel,Attempt:0,}" Mar 12 04:34:34.099094 containerd[1499]: time="2026-03-12T04:34:34.098974266Z" level=info msg="CreateContainer within sandbox \"b44b1d22ab7027b3c7f380da6854c592bdfb169a1472d74575e593e9c1975603\" for &ContainerMetadata{Name:kube-flannel,Attempt:0,} returns container id \"7999d30b64e6a1ef3145108b46c97741f456ebde5cdfc5d16b76429e21a7d6d6\"" Mar 12 04:34:34.100026 containerd[1499]: time="2026-03-12T04:34:34.099465272Z" level=info msg="StartContainer for \"7999d30b64e6a1ef3145108b46c97741f456ebde5cdfc5d16b76429e21a7d6d6\"" Mar 12 04:34:34.133210 systemd[1]: Started cri-containerd-7999d30b64e6a1ef3145108b46c97741f456ebde5cdfc5d16b76429e21a7d6d6.scope - libcontainer container 7999d30b64e6a1ef3145108b46c97741f456ebde5cdfc5d16b76429e21a7d6d6. Mar 12 04:34:34.170341 containerd[1499]: time="2026-03-12T04:34:34.170144901Z" level=info msg="StartContainer for \"7999d30b64e6a1ef3145108b46c97741f456ebde5cdfc5d16b76429e21a7d6d6\" returns successfully" Mar 12 04:34:34.610203 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Mar 12 04:34:34.895482 kubelet[1859]: E0312 04:34:34.895312 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:35.102991 kubelet[1859]: I0312 04:34:35.102729 1859 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="kube-flannel/kube-flannel-ds-b2r29" podStartSLOduration=3.576613807 podStartE2EDuration="11.10271293s" podCreationTimestamp="2026-03-12 04:34:24 +0000 UTC" firstStartedPulling="2026-03-12 04:34:26.55782729 +0000 UTC m=+2.922083832" lastFinishedPulling="2026-03-12 04:34:34.083926404 +0000 UTC m=+10.448182955" observedRunningTime="2026-03-12 04:34:35.102395234 +0000 UTC m=+11.466651802" watchObservedRunningTime="2026-03-12 04:34:35.10271293 +0000 UTC m=+11.466969464" Mar 12 04:34:35.262706 systemd-networkd[1411]: flannel.1: Link UP Mar 12 04:34:35.262907 systemd-networkd[1411]: flannel.1: Gained carrier Mar 12 04:34:35.896270 kubelet[1859]: E0312 04:34:35.896194 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:36.504173 systemd-networkd[1411]: flannel.1: Gained IPv6LL Mar 12 04:34:36.897215 kubelet[1859]: E0312 04:34:36.897133 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:37.898014 kubelet[1859]: E0312 04:34:37.897930 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:38.898843 kubelet[1859]: E0312 04:34:38.898746 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:39.061990 systemd[1]: Created slice kubepods-besteffort-pod64625bf1_dee8_494f_92df_d72c3b436e0c.slice - libcontainer container kubepods-besteffort-pod64625bf1_dee8_494f_92df_d72c3b436e0c.slice. Mar 12 04:34:39.115903 kubelet[1859]: I0312 04:34:39.115829 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-8h5kq\" (UniqueName: \"kubernetes.io/projected/64625bf1-dee8-494f-92df-d72c3b436e0c-kube-api-access-8h5kq\") pod \"nginx-deployment-6cc69d4fc7-7mw5f\" (UID: \"64625bf1-dee8-494f-92df-d72c3b436e0c\") " pod="default/nginx-deployment-6cc69d4fc7-7mw5f" Mar 12 04:34:39.367899 containerd[1499]: time="2026-03-12T04:34:39.367826103Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-7mw5f,Uid:64625bf1-dee8-494f-92df-d72c3b436e0c,Namespace:default,Attempt:0,}" Mar 12 04:34:39.422166 systemd-networkd[1411]: cni0: Link UP Mar 12 04:34:39.422178 systemd-networkd[1411]: cni0: Gained carrier Mar 12 04:34:39.426933 systemd-networkd[1411]: cni0: Lost carrier Mar 12 04:34:39.437398 systemd-networkd[1411]: vethb85ffa8f: Link UP Mar 12 04:34:39.445294 kernel: cni0: port 1(vethb85ffa8f) entered blocking state Mar 12 04:34:39.445450 kernel: cni0: port 1(vethb85ffa8f) entered disabled state Mar 12 04:34:39.446334 kernel: vethb85ffa8f: entered allmulticast mode Mar 12 04:34:39.447029 kernel: vethb85ffa8f: entered promiscuous mode Mar 12 04:34:39.451447 kernel: cni0: port 1(vethb85ffa8f) entered blocking state Mar 12 04:34:39.451515 kernel: cni0: port 1(vethb85ffa8f) entered forwarding state Mar 12 04:34:39.451569 kernel: cni0: port 1(vethb85ffa8f) entered disabled state Mar 12 04:34:39.476698 kernel: cni0: port 1(vethb85ffa8f) entered blocking state Mar 12 04:34:39.476805 kernel: cni0: port 1(vethb85ffa8f) entered forwarding state Mar 12 04:34:39.477113 systemd-networkd[1411]: vethb85ffa8f: Gained carrier Mar 12 04:34:39.480523 systemd-networkd[1411]: cni0: Gained carrier Mar 12 04:34:39.483357 containerd[1499]: 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)(0xc000082950), "name":"cbr0", "type":"bridge"} Mar 12 04:34:39.483357 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Mar 12 04:34:39.515130 containerd[1499]: {"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-03-12T04:34:39.514983835Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 12 04:34:39.515434 containerd[1499]: time="2026-03-12T04:34:39.515082794Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 12 04:34:39.515434 containerd[1499]: time="2026-03-12T04:34:39.515106489Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:39.515434 containerd[1499]: time="2026-03-12T04:34:39.515292201Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:39.543181 systemd[1]: run-containerd-runc-k8s.io-1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc-runc.g7V51G.mount: Deactivated successfully. Mar 12 04:34:39.555220 systemd[1]: Started cri-containerd-1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc.scope - libcontainer container 1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc. Mar 12 04:34:39.609548 containerd[1499]: time="2026-03-12T04:34:39.609407879Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nginx-deployment-6cc69d4fc7-7mw5f,Uid:64625bf1-dee8-494f-92df-d72c3b436e0c,Namespace:default,Attempt:0,} returns sandbox id \"1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc\"" Mar 12 04:34:39.612595 containerd[1499]: time="2026-03-12T04:34:39.612289411Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Mar 12 04:34:39.899867 kubelet[1859]: E0312 04:34:39.899803 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:40.792362 systemd-networkd[1411]: cni0: Gained IPv6LL Mar 12 04:34:40.900398 kubelet[1859]: E0312 04:34:40.900329 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:40.920578 systemd-networkd[1411]: vethb85ffa8f: Gained IPv6LL Mar 12 04:34:41.900845 kubelet[1859]: E0312 04:34:41.900777 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:42.901977 kubelet[1859]: E0312 04:34:42.901823 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:43.146223 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount2766200173.mount: Deactivated successfully. Mar 12 04:34:43.887309 kubelet[1859]: E0312 04:34:43.887249 1859 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:43.903018 kubelet[1859]: E0312 04:34:43.902964 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:44.491783 containerd[1499]: time="2026-03-12T04:34:44.491710809Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:44.493194 containerd[1499]: time="2026-03-12T04:34:44.493138441Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=63907328" Mar 12 04:34:44.494423 containerd[1499]: time="2026-03-12T04:34:44.493989324Z" level=info msg="ImageCreate event name:\"sha256:1f1a56031783bd6c9b1c02e432c6eabf091ec9558780f69aadad131b0d641a21\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:44.497720 containerd[1499]: time="2026-03-12T04:34:44.497661900Z" level=info msg="ImageCreate event name:\"ghcr.io/flatcar/nginx@sha256:94d84a302e569aca6fb7eed139af2d59a3cba208311ad18b69a7d799472c2b22\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:44.499440 containerd[1499]: time="2026-03-12T04:34:44.499276211Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:1f1a56031783bd6c9b1c02e432c6eabf091ec9558780f69aadad131b0d641a21\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:94d84a302e569aca6fb7eed139af2d59a3cba208311ad18b69a7d799472c2b22\", size \"63907206\" in 4.886946263s" Mar 12 04:34:44.499440 containerd[1499]: time="2026-03-12T04:34:44.499321359Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:1f1a56031783bd6c9b1c02e432c6eabf091ec9558780f69aadad131b0d641a21\"" Mar 12 04:34:44.505213 containerd[1499]: time="2026-03-12T04:34:44.505176285Z" level=info msg="CreateContainer within sandbox \"1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc\" for container &ContainerMetadata{Name:nginx,Attempt:0,}" Mar 12 04:34:44.517876 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount382471919.mount: Deactivated successfully. Mar 12 04:34:44.523548 containerd[1499]: time="2026-03-12T04:34:44.523495799Z" level=info msg="CreateContainer within sandbox \"1389bd0f927e4002eb21cc0807b4c8232627d382753c9e60331d3c535284efcc\" for &ContainerMetadata{Name:nginx,Attempt:0,} returns container id \"a3f140852749de35ec65d701ec4175346ae3009a57063c3168980b095c89cc7f\"" Mar 12 04:34:44.524456 containerd[1499]: time="2026-03-12T04:34:44.524410133Z" level=info msg="StartContainer for \"a3f140852749de35ec65d701ec4175346ae3009a57063c3168980b095c89cc7f\"" Mar 12 04:34:44.570208 systemd[1]: Started cri-containerd-a3f140852749de35ec65d701ec4175346ae3009a57063c3168980b095c89cc7f.scope - libcontainer container a3f140852749de35ec65d701ec4175346ae3009a57063c3168980b095c89cc7f. Mar 12 04:34:44.603998 containerd[1499]: time="2026-03-12T04:34:44.603782459Z" level=info msg="StartContainer for \"a3f140852749de35ec65d701ec4175346ae3009a57063c3168980b095c89cc7f\" returns successfully" Mar 12 04:34:44.903397 kubelet[1859]: E0312 04:34:44.903326 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:45.127090 kubelet[1859]: I0312 04:34:45.126906 1859 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nginx-deployment-6cc69d4fc7-7mw5f" podStartSLOduration=1.237827094 podStartE2EDuration="6.126879944s" podCreationTimestamp="2026-03-12 04:34:39 +0000 UTC" firstStartedPulling="2026-03-12 04:34:39.611785529 +0000 UTC m=+15.976042070" lastFinishedPulling="2026-03-12 04:34:44.500838385 +0000 UTC m=+20.865094920" observedRunningTime="2026-03-12 04:34:45.126753713 +0000 UTC m=+21.491010273" watchObservedRunningTime="2026-03-12 04:34:45.126879944 +0000 UTC m=+21.491136499" Mar 12 04:34:45.904330 kubelet[1859]: E0312 04:34:45.904250 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:46.905149 kubelet[1859]: E0312 04:34:46.905088 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:47.905994 kubelet[1859]: E0312 04:34:47.905913 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:48.252816 update_engine[1485]: I20260312 04:34:48.252434 1485 update_attempter.cc:509] Updating boot flags... Mar 12 04:34:48.299093 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2645) Mar 12 04:34:48.376067 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2644) Mar 12 04:34:48.454985 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2644) Mar 12 04:34:48.906376 kubelet[1859]: E0312 04:34:48.906292 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:49.865274 systemd[1]: Created slice kubepods-besteffort-pod39f282f1_2912_409d_bb86_7329c9a83c17.slice - libcontainer container kubepods-besteffort-pod39f282f1_2912_409d_bb86_7329c9a83c17.slice. Mar 12 04:34:49.892206 kubelet[1859]: I0312 04:34:49.892166 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-456r9\" (UniqueName: \"kubernetes.io/projected/39f282f1-2912-409d-bb86-7329c9a83c17-kube-api-access-456r9\") pod \"nfs-server-provisioner-0\" (UID: \"39f282f1-2912-409d-bb86-7329c9a83c17\") " pod="default/nfs-server-provisioner-0" Mar 12 04:34:49.892473 kubelet[1859]: I0312 04:34:49.892223 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"data\" (UniqueName: \"kubernetes.io/empty-dir/39f282f1-2912-409d-bb86-7329c9a83c17-data\") pod \"nfs-server-provisioner-0\" (UID: \"39f282f1-2912-409d-bb86-7329c9a83c17\") " pod="default/nfs-server-provisioner-0" Mar 12 04:34:49.906466 kubelet[1859]: E0312 04:34:49.906422 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:50.186816 containerd[1499]: time="2026-03-12T04:34:50.186650924Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:39f282f1-2912-409d-bb86-7329c9a83c17,Namespace:default,Attempt:0,}" Mar 12 04:34:50.218596 kernel: cni0: port 2(vethf3fc01dd) entered blocking state Mar 12 04:34:50.218777 kernel: cni0: port 2(vethf3fc01dd) entered disabled state Mar 12 04:34:50.218706 systemd-networkd[1411]: vethf3fc01dd: Link UP Mar 12 04:34:50.225141 kernel: vethf3fc01dd: entered allmulticast mode Mar 12 04:34:50.225232 kernel: vethf3fc01dd: entered promiscuous mode Mar 12 04:34:50.234991 kernel: cni0: port 2(vethf3fc01dd) entered blocking state Mar 12 04:34:50.235073 kernel: cni0: port 2(vethf3fc01dd) entered forwarding state Mar 12 04:34:50.238454 systemd-networkd[1411]: vethf3fc01dd: Gained carrier Mar 12 04:34:50.243866 containerd[1499]: 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"} Mar 12 04:34:50.243866 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Mar 12 04:34:50.279160 containerd[1499]: {"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-03-12T04:34:50.279049939Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 12 04:34:50.280169 containerd[1499]: time="2026-03-12T04:34:50.279851842Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 12 04:34:50.280169 containerd[1499]: time="2026-03-12T04:34:50.279966534Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:50.280343 containerd[1499]: time="2026-03-12T04:34:50.280145632Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:34:50.315218 systemd[1]: Started cri-containerd-24411c8652d2e8701cd2f34a291284c427494e4bd9df8be01db8bb7831b30603.scope - libcontainer container 24411c8652d2e8701cd2f34a291284c427494e4bd9df8be01db8bb7831b30603. Mar 12 04:34:50.376234 containerd[1499]: time="2026-03-12T04:34:50.376089614Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:nfs-server-provisioner-0,Uid:39f282f1-2912-409d-bb86-7329c9a83c17,Namespace:default,Attempt:0,} returns sandbox id \"24411c8652d2e8701cd2f34a291284c427494e4bd9df8be01db8bb7831b30603\"" Mar 12 04:34:50.378860 containerd[1499]: time="2026-03-12T04:34:50.378628081Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\"" Mar 12 04:34:50.907053 kubelet[1859]: E0312 04:34:50.906969 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:51.907379 kubelet[1859]: E0312 04:34:51.907329 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:52.056321 systemd-networkd[1411]: vethf3fc01dd: Gained IPv6LL Mar 12 04:34:52.907662 kubelet[1859]: E0312 04:34:52.907613 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:53.555512 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount427633091.mount: Deactivated successfully. Mar 12 04:34:53.909534 kubelet[1859]: E0312 04:34:53.909458 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:54.910159 kubelet[1859]: E0312 04:34:54.910094 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:55.910636 kubelet[1859]: E0312 04:34:55.910528 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:55.979305 systemd[1]: Started sshd@7-10.230.9.230:22-185.156.73.233:57016.service - OpenSSH per-connection server daemon (185.156.73.233:57016). Mar 12 04:34:56.470441 containerd[1499]: time="2026-03-12T04:34:56.470357759Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:56.472242 containerd[1499]: time="2026-03-12T04:34:56.470923900Z" level=info msg="stop pulling image registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8: active requests=0, bytes read=91039414" Mar 12 04:34:56.472531 containerd[1499]: time="2026-03-12T04:34:56.472391373Z" level=info msg="ImageCreate event name:\"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:56.478811 containerd[1499]: time="2026-03-12T04:34:56.478056525Z" level=info msg="ImageCreate event name:\"registry.k8s.io/sig-storage/nfs-provisioner@sha256:c825f3d5e28bde099bd7a3daace28772d412c9157ad47fa752a9ad0baafc118d\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:34:56.478811 containerd[1499]: time="2026-03-12T04:34:56.478609474Z" 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 6.099936827s" Mar 12 04:34:56.478811 containerd[1499]: time="2026-03-12T04:34:56.478653956Z" level=info msg="PullImage \"registry.k8s.io/sig-storage/nfs-provisioner:v4.0.8\" returns image reference \"sha256:fd0b16f70b66b72bcb2f91d556fa33eba02729c44ffc5f2c16130e7f9fbed3c4\"" Mar 12 04:34:56.484974 containerd[1499]: time="2026-03-12T04:34:56.484917158Z" level=info msg="CreateContainer within sandbox \"24411c8652d2e8701cd2f34a291284c427494e4bd9df8be01db8bb7831b30603\" for container &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,}" Mar 12 04:34:56.509889 systemd[1]: var-lib-containerd-tmpmounts-containerd\x2dmount3064760995.mount: Deactivated successfully. Mar 12 04:34:56.515382 containerd[1499]: time="2026-03-12T04:34:56.515320164Z" level=info msg="CreateContainer within sandbox \"24411c8652d2e8701cd2f34a291284c427494e4bd9df8be01db8bb7831b30603\" for &ContainerMetadata{Name:nfs-server-provisioner,Attempt:0,} returns container id \"a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73\"" Mar 12 04:34:56.516135 containerd[1499]: time="2026-03-12T04:34:56.516102119Z" level=info msg="StartContainer for \"a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73\"" Mar 12 04:34:56.557317 systemd[1]: run-containerd-runc-k8s.io-a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73-runc.oYfeql.mount: Deactivated successfully. Mar 12 04:34:56.569197 systemd[1]: Started cri-containerd-a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73.scope - libcontainer container a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73. Mar 12 04:34:56.609730 containerd[1499]: time="2026-03-12T04:34:56.609654604Z" level=info msg="StartContainer for \"a68c3ff172d9acb0e27183fb16af94c5321fdc51f405f9bac627590b51b68b73\" returns successfully" Mar 12 04:34:56.911769 kubelet[1859]: E0312 04:34:56.911698 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:57.196824 sshd[2810]: Invalid user admin from 185.156.73.233 port 57016 Mar 12 04:34:57.253046 sshd[2810]: Connection closed by invalid user admin 185.156.73.233 port 57016 [preauth] Mar 12 04:34:57.255603 systemd[1]: sshd@7-10.230.9.230:22-185.156.73.233:57016.service: Deactivated successfully. Mar 12 04:34:57.911905 kubelet[1859]: E0312 04:34:57.911826 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:58.912958 kubelet[1859]: E0312 04:34:58.912855 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:34:59.913403 kubelet[1859]: E0312 04:34:59.913323 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:00.913858 kubelet[1859]: E0312 04:35:00.913784 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:01.900728 kubelet[1859]: I0312 04:35:01.900096 1859 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/nfs-server-provisioner-0" podStartSLOduration=6.79731328 podStartE2EDuration="12.900074628s" podCreationTimestamp="2026-03-12 04:34:49 +0000 UTC" firstStartedPulling="2026-03-12 04:34:50.378350053 +0000 UTC m=+26.742606588" lastFinishedPulling="2026-03-12 04:34:56.481111402 +0000 UTC m=+32.845367936" observedRunningTime="2026-03-12 04:34:57.161793315 +0000 UTC m=+33.526049879" watchObservedRunningTime="2026-03-12 04:35:01.900074628 +0000 UTC m=+38.264331168" Mar 12 04:35:01.912575 systemd[1]: Created slice kubepods-besteffort-podc0bf5a5d_0e46_4edb_8ad2_c58d64351e2d.slice - libcontainer container kubepods-besteffort-podc0bf5a5d_0e46_4edb_8ad2_c58d64351e2d.slice. Mar 12 04:35:01.914573 kubelet[1859]: E0312 04:35:01.913901 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:01.972567 kubelet[1859]: I0312 04:35:01.972398 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-9db41673-b102-4786-9d34-ed718d34750a\" (UniqueName: \"kubernetes.io/nfs/c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d-pvc-9db41673-b102-4786-9d34-ed718d34750a\") pod \"test-pod-1\" (UID: \"c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d\") " pod="default/test-pod-1" Mar 12 04:35:01.972567 kubelet[1859]: I0312 04:35:01.972485 1859 reconciler_common.go:251] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-46fnw\" (UniqueName: \"kubernetes.io/projected/c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d-kube-api-access-46fnw\") pod \"test-pod-1\" (UID: \"c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d\") " pod="default/test-pod-1" Mar 12 04:35:02.124319 kernel: FS-Cache: Loaded Mar 12 04:35:02.216468 kernel: RPC: Registered named UNIX socket transport module. Mar 12 04:35:02.216656 kernel: RPC: Registered udp transport module. Mar 12 04:35:02.217386 kernel: RPC: Registered tcp transport module. Mar 12 04:35:02.218373 kernel: RPC: Registered tcp-with-tls transport module. Mar 12 04:35:02.220607 kernel: RPC: Registered tcp NFSv4.1 backchannel transport module. Mar 12 04:35:02.551543 kernel: NFS: Registering the id_resolver key type Mar 12 04:35:02.552059 kernel: Key type id_resolver registered Mar 12 04:35:02.552115 kernel: Key type id_legacy registered Mar 12 04:35:02.638534 nfsidmap[2923]: nss_getpwnam: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'gb1.brightbox.com' Mar 12 04:35:02.650889 nfsidmap[2927]: nss_name_to_gid: name 'root@nfs-server-provisioner.default.svc.cluster.local' does not map into domain 'gb1.brightbox.com' Mar 12 04:35:02.874793 containerd[1499]: time="2026-03-12T04:35:02.874459202Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d,Namespace:default,Attempt:0,}" Mar 12 04:35:02.914857 kubelet[1859]: E0312 04:35:02.914346 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:02.923836 systemd-networkd[1411]: vethffc73362: Link UP Mar 12 04:35:02.932070 kernel: cni0: port 3(vethffc73362) entered blocking state Mar 12 04:35:02.932623 kernel: cni0: port 3(vethffc73362) entered disabled state Mar 12 04:35:02.932672 kernel: vethffc73362: entered allmulticast mode Mar 12 04:35:02.932722 kernel: vethffc73362: entered promiscuous mode Mar 12 04:35:02.942253 kernel: cni0: port 3(vethffc73362) entered blocking state Mar 12 04:35:02.942339 kernel: cni0: port 3(vethffc73362) entered forwarding state Mar 12 04:35:02.944088 systemd-networkd[1411]: vethffc73362: Gained carrier Mar 12 04:35:02.947953 containerd[1499]: 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"} Mar 12 04:35:02.947953 containerd[1499]: delegateAdd: netconf sent to delegate plugin: Mar 12 04:35:03.028242 containerd[1499]: {"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-03-12T04:35:03.028092045Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Mar 12 04:35:03.028242 containerd[1499]: time="2026-03-12T04:35:03.028177055Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Mar 12 04:35:03.028242 containerd[1499]: time="2026-03-12T04:35:03.028195627Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:35:03.028748 containerd[1499]: time="2026-03-12T04:35:03.028308067Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Mar 12 04:35:03.088215 systemd[1]: Started cri-containerd-535023070c143c15a851d0658230e7c5a89bed0de54199187545e6fc19e4e680.scope - libcontainer container 535023070c143c15a851d0658230e7c5a89bed0de54199187545e6fc19e4e680. Mar 12 04:35:03.149049 containerd[1499]: time="2026-03-12T04:35:03.148914366Z" level=info msg="RunPodSandbox for &PodSandboxMetadata{Name:test-pod-1,Uid:c0bf5a5d-0e46-4edb-8ad2-c58d64351e2d,Namespace:default,Attempt:0,} returns sandbox id \"535023070c143c15a851d0658230e7c5a89bed0de54199187545e6fc19e4e680\"" Mar 12 04:35:03.152078 containerd[1499]: time="2026-03-12T04:35:03.152044028Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\"" Mar 12 04:35:03.545594 containerd[1499]: time="2026-03-12T04:35:03.544656613Z" level=info msg="ImageUpdate event name:\"ghcr.io/flatcar/nginx:latest\" labels:{key:\"io.cri-containerd.image\" value:\"managed\"}" Mar 12 04:35:03.545594 containerd[1499]: time="2026-03-12T04:35:03.545359187Z" level=info msg="stop pulling image ghcr.io/flatcar/nginx:latest: active requests=0, bytes read=61" Mar 12 04:35:03.550294 containerd[1499]: time="2026-03-12T04:35:03.550254156Z" level=info msg="Pulled image \"ghcr.io/flatcar/nginx:latest\" with image id \"sha256:1f1a56031783bd6c9b1c02e432c6eabf091ec9558780f69aadad131b0d641a21\", repo tag \"ghcr.io/flatcar/nginx:latest\", repo digest \"ghcr.io/flatcar/nginx@sha256:94d84a302e569aca6fb7eed139af2d59a3cba208311ad18b69a7d799472c2b22\", size \"63907206\" in 398.15216ms" Mar 12 04:35:03.550404 containerd[1499]: time="2026-03-12T04:35:03.550303662Z" level=info msg="PullImage \"ghcr.io/flatcar/nginx:latest\" returns image reference \"sha256:1f1a56031783bd6c9b1c02e432c6eabf091ec9558780f69aadad131b0d641a21\"" Mar 12 04:35:03.555176 containerd[1499]: time="2026-03-12T04:35:03.555030620Z" level=info msg="CreateContainer within sandbox \"535023070c143c15a851d0658230e7c5a89bed0de54199187545e6fc19e4e680\" for container &ContainerMetadata{Name:test,Attempt:0,}" Mar 12 04:35:03.574178 containerd[1499]: time="2026-03-12T04:35:03.574109160Z" level=info msg="CreateContainer within sandbox \"535023070c143c15a851d0658230e7c5a89bed0de54199187545e6fc19e4e680\" for &ContainerMetadata{Name:test,Attempt:0,} returns container id \"62e7088fb3dae2ff627bad207c43c9ba96715a510c7b2a9eb85278f4618ee8fc\"" Mar 12 04:35:03.575165 containerd[1499]: time="2026-03-12T04:35:03.575088143Z" level=info msg="StartContainer for \"62e7088fb3dae2ff627bad207c43c9ba96715a510c7b2a9eb85278f4618ee8fc\"" Mar 12 04:35:03.614218 systemd[1]: Started cri-containerd-62e7088fb3dae2ff627bad207c43c9ba96715a510c7b2a9eb85278f4618ee8fc.scope - libcontainer container 62e7088fb3dae2ff627bad207c43c9ba96715a510c7b2a9eb85278f4618ee8fc. Mar 12 04:35:03.648276 containerd[1499]: time="2026-03-12T04:35:03.648130181Z" level=info msg="StartContainer for \"62e7088fb3dae2ff627bad207c43c9ba96715a510c7b2a9eb85278f4618ee8fc\" returns successfully" Mar 12 04:35:03.887411 kubelet[1859]: E0312 04:35:03.887308 1859 file.go:104] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:03.915362 kubelet[1859]: E0312 04:35:03.915300 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:04.178381 kubelet[1859]: I0312 04:35:04.178106 1859 pod_startup_latency_tracker.go:108] "Observed pod startup duration" pod="default/test-pod-1" podStartSLOduration=12.778067224 podStartE2EDuration="13.178089677s" podCreationTimestamp="2026-03-12 04:34:51 +0000 UTC" firstStartedPulling="2026-03-12 04:35:03.151253682 +0000 UTC m=+39.515510223" lastFinishedPulling="2026-03-12 04:35:03.551276131 +0000 UTC m=+39.915532676" observedRunningTime="2026-03-12 04:35:04.177916029 +0000 UTC m=+40.542172582" watchObservedRunningTime="2026-03-12 04:35:04.178089677 +0000 UTC m=+40.542346232" Mar 12 04:35:04.792198 systemd-networkd[1411]: vethffc73362: Gained IPv6LL Mar 12 04:35:04.916079 kubelet[1859]: E0312 04:35:04.916002 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:05.917186 kubelet[1859]: E0312 04:35:05.917098 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:06.917636 kubelet[1859]: E0312 04:35:06.917564 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests" Mar 12 04:35:07.917865 kubelet[1859]: E0312 04:35:07.917801 1859 file_linux.go:61] "Unable to read config path" err="path does not exist, ignoring" path="/etc/kubernetes/manifests"