Oct 9 07:12:55.980533 kernel: Linux version 6.6.54-flatcar (build@pony-truck.infra.kinvolk.io) (x86_64-cros-linux-gnu-gcc (Gentoo Hardened 13.2.1_p20240210 p14) 13.2.1 20240210, GNU ld (Gentoo 2.41 p5) 2.41.0) #1 SMP PREEMPT_DYNAMIC Tue Oct 8 18:19:34 -00 2024 Oct 9 07:12:55.980578 kernel: Command line: BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=1839da262570fb938be558d95db7fc3d986a0d71e1b77d40d35a3e2a1bac7dcd Oct 9 07:12:55.980593 kernel: BIOS-provided physical RAM map: Oct 9 07:12:55.980602 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009ffff] usable Oct 9 07:12:55.980611 kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000007fffff] usable Oct 9 07:12:55.980620 kernel: BIOS-e820: [mem 0x0000000000800000-0x0000000000807fff] ACPI NVS Oct 9 07:12:55.980630 kernel: BIOS-e820: [mem 0x0000000000808000-0x000000000080afff] usable Oct 9 07:12:55.980640 kernel: BIOS-e820: [mem 0x000000000080b000-0x000000000080bfff] ACPI NVS Oct 9 07:12:55.980649 kernel: BIOS-e820: [mem 0x000000000080c000-0x000000000080ffff] usable Oct 9 07:12:55.980658 kernel: BIOS-e820: [mem 0x0000000000810000-0x00000000008fffff] ACPI NVS Oct 9 07:12:55.980673 kernel: BIOS-e820: [mem 0x0000000000900000-0x000000009c8eefff] usable Oct 9 07:12:55.980682 kernel: BIOS-e820: [mem 0x000000009c8ef000-0x000000009c9eefff] reserved Oct 9 07:12:55.980691 kernel: BIOS-e820: [mem 0x000000009c9ef000-0x000000009caeefff] type 20 Oct 9 07:12:55.980700 kernel: BIOS-e820: [mem 0x000000009caef000-0x000000009cb6efff] reserved Oct 9 07:12:55.980712 kernel: BIOS-e820: [mem 0x000000009cb6f000-0x000000009cb7efff] ACPI data Oct 9 07:12:55.980728 kernel: BIOS-e820: [mem 0x000000009cb7f000-0x000000009cbfefff] ACPI NVS Oct 9 07:12:55.980738 kernel: BIOS-e820: [mem 0x000000009cbff000-0x000000009cf3ffff] usable Oct 9 07:12:55.980748 kernel: BIOS-e820: [mem 0x000000009cf40000-0x000000009cf5ffff] reserved Oct 9 07:12:55.980757 kernel: BIOS-e820: [mem 0x000000009cf60000-0x000000009cffffff] ACPI NVS Oct 9 07:12:55.980786 kernel: BIOS-e820: [mem 0x00000000b0000000-0x00000000bfffffff] reserved Oct 9 07:12:55.980797 kernel: NX (Execute Disable) protection: active Oct 9 07:12:55.980807 kernel: APIC: Static calls initialized Oct 9 07:12:55.980816 kernel: efi: EFI v2.7 by EDK II Oct 9 07:12:55.980826 kernel: efi: SMBIOS=0x9c9ab000 ACPI=0x9cb7e000 ACPI 2.0=0x9cb7e014 MEMATTR=0x9b674118 Oct 9 07:12:55.980836 kernel: SMBIOS 2.8 present. Oct 9 07:12:55.980846 kernel: DMI: QEMU Standard PC (Q35 + ICH9, 2009), BIOS 0.0.0 02/06/2015 Oct 9 07:12:55.980859 kernel: Hypervisor detected: KVM Oct 9 07:12:55.980869 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Oct 9 07:12:55.980879 kernel: kvm-clock: using sched offset of 5372726614 cycles Oct 9 07:12:55.980889 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Oct 9 07:12:55.980900 kernel: tsc: Detected 2794.748 MHz processor Oct 9 07:12:55.980910 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Oct 9 07:12:55.980921 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Oct 9 07:12:55.980931 kernel: last_pfn = 0x9cf40 max_arch_pfn = 0x400000000 Oct 9 07:12:55.980941 kernel: MTRR map: 4 entries (2 fixed + 2 variable; max 18), built from 8 variable MTRRs Oct 9 07:12:55.980951 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Oct 9 07:12:55.980964 kernel: Using GB pages for direct mapping Oct 9 07:12:55.980974 kernel: Secure boot disabled Oct 9 07:12:55.980984 kernel: ACPI: Early table checksum verification disabled Oct 9 07:12:55.980994 kernel: ACPI: RSDP 0x000000009CB7E014 000024 (v02 BOCHS ) Oct 9 07:12:55.981013 kernel: ACPI: XSDT 0x000000009CB7D0E8 000054 (v01 BOCHS BXPC 00000001 01000013) Oct 9 07:12:55.981023 kernel: ACPI: FACP 0x000000009CB79000 0000F4 (v03 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981034 kernel: ACPI: DSDT 0x000000009CB7A000 0021A8 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981048 kernel: ACPI: FACS 0x000000009CBDD000 000040 Oct 9 07:12:55.981059 kernel: ACPI: APIC 0x000000009CB78000 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981069 kernel: ACPI: HPET 0x000000009CB77000 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981080 kernel: ACPI: MCFG 0x000000009CB76000 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981091 kernel: ACPI: WAET 0x000000009CB75000 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Oct 9 07:12:55.981101 kernel: ACPI: BGRT 0x000000009CB74000 000038 (v01 INTEL EDK2 00000002 01000013) Oct 9 07:12:55.981112 kernel: ACPI: Reserving FACP table memory at [mem 0x9cb79000-0x9cb790f3] Oct 9 07:12:55.981126 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cb7a000-0x9cb7c1a7] Oct 9 07:12:55.981137 kernel: ACPI: Reserving FACS table memory at [mem 0x9cbdd000-0x9cbdd03f] Oct 9 07:12:55.981147 kernel: ACPI: Reserving APIC table memory at [mem 0x9cb78000-0x9cb7808f] Oct 9 07:12:55.981158 kernel: ACPI: Reserving HPET table memory at [mem 0x9cb77000-0x9cb77037] Oct 9 07:12:55.981168 kernel: ACPI: Reserving MCFG table memory at [mem 0x9cb76000-0x9cb7603b] Oct 9 07:12:55.981179 kernel: ACPI: Reserving WAET table memory at [mem 0x9cb75000-0x9cb75027] Oct 9 07:12:55.981189 kernel: ACPI: Reserving BGRT table memory at [mem 0x9cb74000-0x9cb74037] Oct 9 07:12:55.981202 kernel: No NUMA configuration found Oct 9 07:12:55.981213 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cf3ffff] Oct 9 07:12:55.981227 kernel: NODE_DATA(0) allocated [mem 0x9cea6000-0x9ceabfff] Oct 9 07:12:55.981237 kernel: Zone ranges: Oct 9 07:12:55.981248 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Oct 9 07:12:55.981258 kernel: DMA32 [mem 0x0000000001000000-0x000000009cf3ffff] Oct 9 07:12:55.981269 kernel: Normal empty Oct 9 07:12:55.981280 kernel: Movable zone start for each node Oct 9 07:12:55.981290 kernel: Early memory node ranges Oct 9 07:12:55.981300 kernel: node 0: [mem 0x0000000000001000-0x000000000009ffff] Oct 9 07:12:55.981311 kernel: node 0: [mem 0x0000000000100000-0x00000000007fffff] Oct 9 07:12:55.981322 kernel: node 0: [mem 0x0000000000808000-0x000000000080afff] Oct 9 07:12:55.981335 kernel: node 0: [mem 0x000000000080c000-0x000000000080ffff] Oct 9 07:12:55.981346 kernel: node 0: [mem 0x0000000000900000-0x000000009c8eefff] Oct 9 07:12:55.981356 kernel: node 0: [mem 0x000000009cbff000-0x000000009cf3ffff] Oct 9 07:12:55.981367 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cf3ffff] Oct 9 07:12:55.981380 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 9 07:12:55.981391 kernel: On node 0, zone DMA: 96 pages in unavailable ranges Oct 9 07:12:55.981401 kernel: On node 0, zone DMA: 8 pages in unavailable ranges Oct 9 07:12:55.981412 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Oct 9 07:12:55.981422 kernel: On node 0, zone DMA: 240 pages in unavailable ranges Oct 9 07:12:55.981435 kernel: On node 0, zone DMA32: 784 pages in unavailable ranges Oct 9 07:12:55.981446 kernel: On node 0, zone DMA32: 12480 pages in unavailable ranges Oct 9 07:12:55.981456 kernel: ACPI: PM-Timer IO Port: 0x608 Oct 9 07:12:55.981467 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Oct 9 07:12:55.981478 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Oct 9 07:12:55.981488 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Oct 9 07:12:55.981499 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Oct 9 07:12:55.981509 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Oct 9 07:12:55.981520 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Oct 9 07:12:55.981533 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Oct 9 07:12:55.981544 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Oct 9 07:12:55.981554 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Oct 9 07:12:55.981572 kernel: TSC deadline timer available Oct 9 07:12:55.981583 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Oct 9 07:12:55.981593 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Oct 9 07:12:55.981604 kernel: kvm-guest: KVM setup pv remote TLB flush Oct 9 07:12:55.981614 kernel: kvm-guest: setup PV sched yield Oct 9 07:12:55.981625 kernel: [mem 0xc0000000-0xffffffff] available for PCI devices Oct 9 07:12:55.981639 kernel: Booting paravirtualized kernel on KVM Oct 9 07:12:55.981650 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Oct 9 07:12:55.981661 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Oct 9 07:12:55.981671 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288 Oct 9 07:12:55.981682 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152 Oct 9 07:12:55.981693 kernel: pcpu-alloc: [0] 0 1 2 3 Oct 9 07:12:55.981703 kernel: kvm-guest: PV spinlocks enabled Oct 9 07:12:55.981714 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Oct 9 07:12:55.981729 kernel: Kernel command line: rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=1839da262570fb938be558d95db7fc3d986a0d71e1b77d40d35a3e2a1bac7dcd Oct 9 07:12:55.981743 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Oct 9 07:12:55.981754 kernel: random: crng init done Oct 9 07:12:55.981765 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Oct 9 07:12:55.981787 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Oct 9 07:12:55.981797 kernel: Fallback order for Node 0: 0 Oct 9 07:12:55.981807 kernel: Built 1 zonelists, mobility grouping on. Total pages: 629759 Oct 9 07:12:55.981817 kernel: Policy zone: DMA32 Oct 9 07:12:55.981827 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Oct 9 07:12:55.981842 kernel: Memory: 2389472K/2567000K available (12288K kernel code, 2304K rwdata, 22648K rodata, 49452K init, 1888K bss, 177268K reserved, 0K cma-reserved) Oct 9 07:12:55.981853 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Oct 9 07:12:55.981864 kernel: ftrace: allocating 37706 entries in 148 pages Oct 9 07:12:55.981875 kernel: ftrace: allocated 148 pages with 3 groups Oct 9 07:12:55.981886 kernel: Dynamic Preempt: voluntary Oct 9 07:12:55.981907 kernel: rcu: Preemptible hierarchical RCU implementation. Oct 9 07:12:55.981923 kernel: rcu: RCU event tracing is enabled. Oct 9 07:12:55.981935 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Oct 9 07:12:55.981946 kernel: Trampoline variant of Tasks RCU enabled. Oct 9 07:12:55.981957 kernel: Rude variant of Tasks RCU enabled. Oct 9 07:12:55.981969 kernel: Tracing variant of Tasks RCU enabled. Oct 9 07:12:55.981981 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Oct 9 07:12:55.981995 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Oct 9 07:12:55.982006 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Oct 9 07:12:55.982018 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Oct 9 07:12:55.982029 kernel: Console: colour dummy device 80x25 Oct 9 07:12:55.982044 kernel: printk: console [ttyS0] enabled Oct 9 07:12:55.982059 kernel: ACPI: Core revision 20230628 Oct 9 07:12:55.982071 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Oct 9 07:12:55.982085 kernel: APIC: Switch to symmetric I/O mode setup Oct 9 07:12:55.982098 kernel: x2apic enabled Oct 9 07:12:55.982110 kernel: APIC: Switched APIC routing to: physical x2apic Oct 9 07:12:55.982121 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Oct 9 07:12:55.982133 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Oct 9 07:12:55.982144 kernel: kvm-guest: setup PV IPIs Oct 9 07:12:55.982155 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Oct 9 07:12:55.982170 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Oct 9 07:12:55.982181 kernel: Calibrating delay loop (skipped) preset value.. 5589.49 BogoMIPS (lpj=2794748) Oct 9 07:12:55.982192 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Oct 9 07:12:55.982204 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Oct 9 07:12:55.982215 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Oct 9 07:12:55.982227 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Oct 9 07:12:55.982238 kernel: Spectre V2 : Mitigation: Retpolines Oct 9 07:12:55.982250 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Oct 9 07:12:55.982261 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Oct 9 07:12:55.982276 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Oct 9 07:12:55.982288 kernel: RETBleed: Mitigation: untrained return thunk Oct 9 07:12:55.982302 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Oct 9 07:12:55.982313 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Oct 9 07:12:55.982325 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Oct 9 07:12:55.982337 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Oct 9 07:12:55.982349 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Oct 9 07:12:55.982360 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Oct 9 07:12:55.982375 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Oct 9 07:12:55.982386 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Oct 9 07:12:55.982398 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Oct 9 07:12:55.982409 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Oct 9 07:12:55.982420 kernel: Freeing SMP alternatives memory: 32K Oct 9 07:12:55.982432 kernel: pid_max: default: 32768 minimum: 301 Oct 9 07:12:55.982443 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Oct 9 07:12:55.982454 kernel: SELinux: Initializing. Oct 9 07:12:55.982465 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 07:12:55.982480 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Oct 9 07:12:55.982491 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Oct 9 07:12:55.982501 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 07:12:55.982512 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 07:12:55.982523 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Oct 9 07:12:55.982534 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Oct 9 07:12:55.982545 kernel: ... version: 0 Oct 9 07:12:55.982555 kernel: ... bit width: 48 Oct 9 07:12:55.982573 kernel: ... generic registers: 6 Oct 9 07:12:55.982586 kernel: ... value mask: 0000ffffffffffff Oct 9 07:12:55.982597 kernel: ... max period: 00007fffffffffff Oct 9 07:12:55.982607 kernel: ... fixed-purpose events: 0 Oct 9 07:12:55.982617 kernel: ... event mask: 000000000000003f Oct 9 07:12:55.982628 kernel: signal: max sigframe size: 1776 Oct 9 07:12:55.982639 kernel: rcu: Hierarchical SRCU implementation. Oct 9 07:12:55.982651 kernel: rcu: Max phase no-delay instances is 400. Oct 9 07:12:55.982662 kernel: smp: Bringing up secondary CPUs ... Oct 9 07:12:55.982672 kernel: smpboot: x86: Booting SMP configuration: Oct 9 07:12:55.982686 kernel: .... node #0, CPUs: #1 #2 #3 Oct 9 07:12:55.982697 kernel: smp: Brought up 1 node, 4 CPUs Oct 9 07:12:55.982707 kernel: smpboot: Max logical packages: 1 Oct 9 07:12:55.982717 kernel: smpboot: Total of 4 processors activated (22357.98 BogoMIPS) Oct 9 07:12:55.982727 kernel: devtmpfs: initialized Oct 9 07:12:55.982737 kernel: x86/mm: Memory block size: 128MB Oct 9 07:12:55.982747 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00800000-0x00807fff] (32768 bytes) Oct 9 07:12:55.982757 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x0080b000-0x0080bfff] (4096 bytes) Oct 9 07:12:55.982793 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x00810000-0x008fffff] (983040 bytes) Oct 9 07:12:55.982809 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cb7f000-0x9cbfefff] (524288 bytes) Oct 9 07:12:55.982819 kernel: ACPI: PM: Registering ACPI NVS region [mem 0x9cf60000-0x9cffffff] (655360 bytes) Oct 9 07:12:55.982830 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Oct 9 07:12:55.982840 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Oct 9 07:12:55.982851 kernel: pinctrl core: initialized pinctrl subsystem Oct 9 07:12:55.982865 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Oct 9 07:12:55.982875 kernel: audit: initializing netlink subsys (disabled) Oct 9 07:12:55.982886 kernel: audit: type=2000 audit(1728457975.207:1): state=initialized audit_enabled=0 res=1 Oct 9 07:12:55.982896 kernel: thermal_sys: Registered thermal governor 'step_wise' Oct 9 07:12:55.982910 kernel: thermal_sys: Registered thermal governor 'user_space' Oct 9 07:12:55.982921 kernel: cpuidle: using governor menu Oct 9 07:12:55.982931 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Oct 9 07:12:55.982942 kernel: dca service started, version 1.12.1 Oct 9 07:12:55.982953 kernel: PCI: MMCONFIG for domain 0000 [bus 00-ff] at [mem 0xb0000000-0xbfffffff] (base 0xb0000000) Oct 9 07:12:55.982964 kernel: PCI: MMCONFIG at [mem 0xb0000000-0xbfffffff] reserved as E820 entry Oct 9 07:12:55.982974 kernel: PCI: Using configuration type 1 for base access Oct 9 07:12:55.982985 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Oct 9 07:12:55.982996 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Oct 9 07:12:55.983009 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Oct 9 07:12:55.983020 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Oct 9 07:12:55.983031 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Oct 9 07:12:55.983041 kernel: ACPI: Added _OSI(Module Device) Oct 9 07:12:55.983052 kernel: ACPI: Added _OSI(Processor Device) Oct 9 07:12:55.983062 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Oct 9 07:12:55.983073 kernel: ACPI: Added _OSI(Processor Aggregator Device) Oct 9 07:12:55.983084 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Oct 9 07:12:55.983094 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Oct 9 07:12:55.983108 kernel: ACPI: Interpreter enabled Oct 9 07:12:55.983118 kernel: ACPI: PM: (supports S0 S3 S5) Oct 9 07:12:55.983129 kernel: ACPI: Using IOAPIC for interrupt routing Oct 9 07:12:55.983140 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Oct 9 07:12:55.983150 kernel: PCI: Using E820 reservations for host bridge windows Oct 9 07:12:55.983161 kernel: ACPI: Enabled 2 GPEs in block 00 to 3F Oct 9 07:12:55.983171 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Oct 9 07:12:55.983492 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Oct 9 07:12:55.983674 kernel: acpi PNP0A08:00: _OSC: platform does not support [PCIeHotplug LTR] Oct 9 07:12:55.983846 kernel: acpi PNP0A08:00: _OSC: OS now controls [PME AER PCIeCapability] Oct 9 07:12:55.983861 kernel: PCI host bridge to bus 0000:00 Oct 9 07:12:55.984037 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Oct 9 07:12:55.984177 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Oct 9 07:12:55.984313 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Oct 9 07:12:55.984449 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xafffffff window] Oct 9 07:12:55.984601 kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Oct 9 07:12:55.984738 kernel: pci_bus 0000:00: root bus resource [mem 0x800000000-0xfffffffff window] Oct 9 07:12:55.984896 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Oct 9 07:12:55.985080 kernel: pci 0000:00:00.0: [8086:29c0] type 00 class 0x060000 Oct 9 07:12:55.985253 kernel: pci 0000:00:01.0: [1234:1111] type 00 class 0x030000 Oct 9 07:12:55.985408 kernel: pci 0000:00:01.0: reg 0x10: [mem 0xc0000000-0xc0ffffff pref] Oct 9 07:12:55.985592 kernel: pci 0000:00:01.0: reg 0x18: [mem 0xc1044000-0xc1044fff] Oct 9 07:12:55.985854 kernel: pci 0000:00:01.0: reg 0x30: [mem 0xffff0000-0xffffffff pref] Oct 9 07:12:55.986003 kernel: pci 0000:00:01.0: BAR 0: assigned to efifb Oct 9 07:12:55.986165 kernel: pci 0000:00:01.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Oct 9 07:12:55.986339 kernel: pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 Oct 9 07:12:55.986498 kernel: pci 0000:00:02.0: reg 0x10: [io 0x6100-0x611f] Oct 9 07:12:55.986669 kernel: pci 0000:00:02.0: reg 0x14: [mem 0xc1043000-0xc1043fff] Oct 9 07:12:55.986861 kernel: pci 0000:00:02.0: reg 0x20: [mem 0x800000000-0x800003fff 64bit pref] Oct 9 07:12:55.987066 kernel: pci 0000:00:03.0: [1af4:1001] type 00 class 0x010000 Oct 9 07:12:55.987225 kernel: pci 0000:00:03.0: reg 0x10: [io 0x6000-0x607f] Oct 9 07:12:55.987381 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xc1042000-0xc1042fff] Oct 9 07:12:55.987537 kernel: pci 0000:00:03.0: reg 0x20: [mem 0x800004000-0x800007fff 64bit pref] Oct 9 07:12:55.987718 kernel: pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000 Oct 9 07:12:55.987887 kernel: pci 0000:00:04.0: reg 0x10: [io 0x60e0-0x60ff] Oct 9 07:12:55.988033 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xc1041000-0xc1041fff] Oct 9 07:12:55.988175 kernel: pci 0000:00:04.0: reg 0x20: [mem 0x800008000-0x80000bfff 64bit pref] Oct 9 07:12:55.988312 kernel: pci 0000:00:04.0: reg 0x30: [mem 0xfffc0000-0xffffffff pref] Oct 9 07:12:55.988537 kernel: pci 0000:00:1f.0: [8086:2918] type 00 class 0x060100 Oct 9 07:12:55.988726 kernel: pci 0000:00:1f.0: quirk: [io 0x0600-0x067f] claimed by ICH6 ACPI/GPIO/TCO Oct 9 07:12:55.988968 kernel: pci 0000:00:1f.2: [8086:2922] type 00 class 0x010601 Oct 9 07:12:55.989137 kernel: pci 0000:00:1f.2: reg 0x20: [io 0x60c0-0x60df] Oct 9 07:12:55.989288 kernel: pci 0000:00:1f.2: reg 0x24: [mem 0xc1040000-0xc1040fff] Oct 9 07:12:55.989443 kernel: pci 0000:00:1f.3: [8086:2930] type 00 class 0x0c0500 Oct 9 07:12:55.989594 kernel: pci 0000:00:1f.3: reg 0x20: [io 0x6080-0x60bf] Oct 9 07:12:55.989607 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Oct 9 07:12:55.989618 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Oct 9 07:12:55.989628 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Oct 9 07:12:55.989637 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Oct 9 07:12:55.989651 kernel: ACPI: PCI: Interrupt link LNKE configured for IRQ 10 Oct 9 07:12:55.989661 kernel: ACPI: PCI: Interrupt link LNKF configured for IRQ 10 Oct 9 07:12:55.989671 kernel: ACPI: PCI: Interrupt link LNKG configured for IRQ 11 Oct 9 07:12:55.989681 kernel: ACPI: PCI: Interrupt link LNKH configured for IRQ 11 Oct 9 07:12:55.989691 kernel: ACPI: PCI: Interrupt link GSIA configured for IRQ 16 Oct 9 07:12:55.989701 kernel: ACPI: PCI: Interrupt link GSIB configured for IRQ 17 Oct 9 07:12:55.989711 kernel: ACPI: PCI: Interrupt link GSIC configured for IRQ 18 Oct 9 07:12:55.989720 kernel: ACPI: PCI: Interrupt link GSID configured for IRQ 19 Oct 9 07:12:55.989730 kernel: ACPI: PCI: Interrupt link GSIE configured for IRQ 20 Oct 9 07:12:55.989742 kernel: ACPI: PCI: Interrupt link GSIF configured for IRQ 21 Oct 9 07:12:55.989752 kernel: ACPI: PCI: Interrupt link GSIG configured for IRQ 22 Oct 9 07:12:55.989762 kernel: ACPI: PCI: Interrupt link GSIH configured for IRQ 23 Oct 9 07:12:55.989881 kernel: iommu: Default domain type: Translated Oct 9 07:12:55.989893 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Oct 9 07:12:55.989904 kernel: efivars: Registered efivars operations Oct 9 07:12:55.989914 kernel: PCI: Using ACPI for IRQ routing Oct 9 07:12:55.989925 kernel: PCI: pci_cache_line_size set to 64 bytes Oct 9 07:12:55.989935 kernel: e820: reserve RAM buffer [mem 0x0080b000-0x008fffff] Oct 9 07:12:55.989952 kernel: e820: reserve RAM buffer [mem 0x00810000-0x008fffff] Oct 9 07:12:55.989962 kernel: e820: reserve RAM buffer [mem 0x9c8ef000-0x9fffffff] Oct 9 07:12:55.989973 kernel: e820: reserve RAM buffer [mem 0x9cf40000-0x9fffffff] Oct 9 07:12:55.990150 kernel: pci 0000:00:01.0: vgaarb: setting as boot VGA device Oct 9 07:12:55.990315 kernel: pci 0000:00:01.0: vgaarb: bridge control possible Oct 9 07:12:55.990477 kernel: pci 0000:00:01.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Oct 9 07:12:55.990494 kernel: vgaarb: loaded Oct 9 07:12:55.990506 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Oct 9 07:12:55.990518 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Oct 9 07:12:55.990536 kernel: clocksource: Switched to clocksource kvm-clock Oct 9 07:12:55.990547 kernel: VFS: Disk quotas dquot_6.6.0 Oct 9 07:12:55.990568 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Oct 9 07:12:55.990579 kernel: pnp: PnP ACPI init Oct 9 07:12:55.990784 kernel: system 00:05: [mem 0xb0000000-0xbfffffff window] has been reserved Oct 9 07:12:55.990803 kernel: pnp: PnP ACPI: found 6 devices Oct 9 07:12:55.990814 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Oct 9 07:12:55.990825 kernel: NET: Registered PF_INET protocol family Oct 9 07:12:55.990843 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Oct 9 07:12:55.990855 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Oct 9 07:12:55.990866 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Oct 9 07:12:55.990878 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Oct 9 07:12:55.990890 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Oct 9 07:12:55.990901 kernel: TCP: Hash tables configured (established 32768 bind 32768) Oct 9 07:12:55.990913 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 07:12:55.990925 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Oct 9 07:12:55.990936 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Oct 9 07:12:55.990951 kernel: NET: Registered PF_XDP protocol family Oct 9 07:12:55.991119 kernel: pci 0000:00:04.0: can't claim BAR 6 [mem 0xfffc0000-0xffffffff pref]: no compatible bridge window Oct 9 07:12:55.991278 kernel: pci 0000:00:04.0: BAR 6: assigned [mem 0x9d000000-0x9d03ffff pref] Oct 9 07:12:55.991423 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Oct 9 07:12:55.991573 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Oct 9 07:12:55.991839 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Oct 9 07:12:55.992005 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xafffffff window] Oct 9 07:12:55.992155 kernel: pci_bus 0000:00: resource 8 [mem 0xc0000000-0xfebfffff window] Oct 9 07:12:55.992308 kernel: pci_bus 0000:00: resource 9 [mem 0x800000000-0xfffffffff window] Oct 9 07:12:55.992324 kernel: PCI: CLS 0 bytes, default 64 Oct 9 07:12:55.992336 kernel: Initialise system trusted keyrings Oct 9 07:12:55.992348 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Oct 9 07:12:55.992359 kernel: Key type asymmetric registered Oct 9 07:12:55.992371 kernel: Asymmetric key parser 'x509' registered Oct 9 07:12:55.992382 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Oct 9 07:12:55.992394 kernel: io scheduler mq-deadline registered Oct 9 07:12:55.992406 kernel: io scheduler kyber registered Oct 9 07:12:55.992422 kernel: io scheduler bfq registered Oct 9 07:12:55.992434 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Oct 9 07:12:55.992446 kernel: ACPI: \_SB_.GSIG: Enabled at IRQ 22 Oct 9 07:12:55.992458 kernel: ACPI: \_SB_.GSIH: Enabled at IRQ 23 Oct 9 07:12:55.992470 kernel: ACPI: \_SB_.GSIE: Enabled at IRQ 20 Oct 9 07:12:55.992481 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Oct 9 07:12:55.992493 kernel: 00:03: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Oct 9 07:12:55.992511 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Oct 9 07:12:55.992522 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Oct 9 07:12:55.992537 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Oct 9 07:12:55.992755 kernel: rtc_cmos 00:04: RTC can wake from S4 Oct 9 07:12:55.992931 kernel: rtc_cmos 00:04: registered as rtc0 Oct 9 07:12:55.993136 kernel: rtc_cmos 00:04: setting system clock to 2024-10-09T07:12:55 UTC (1728457975) Oct 9 07:12:55.993304 kernel: rtc_cmos 00:04: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Oct 9 07:12:55.993322 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Oct 9 07:12:55.993334 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Oct 9 07:12:55.993351 kernel: efifb: probing for efifb Oct 9 07:12:55.993363 kernel: efifb: framebuffer at 0xc0000000, using 1408k, total 1408k Oct 9 07:12:55.993375 kernel: efifb: mode is 800x600x24, linelength=2400, pages=1 Oct 9 07:12:55.993387 kernel: efifb: scrolling: redraw Oct 9 07:12:55.993398 kernel: efifb: Truecolor: size=0:8:8:8, shift=0:16:8:0 Oct 9 07:12:55.993410 kernel: Console: switching to colour frame buffer device 100x37 Oct 9 07:12:55.993422 kernel: fb0: EFI VGA frame buffer device Oct 9 07:12:55.993457 kernel: pstore: Using crash dump compression: deflate Oct 9 07:12:55.993472 kernel: pstore: Registered efi_pstore as persistent store backend Oct 9 07:12:55.993487 kernel: NET: Registered PF_INET6 protocol family Oct 9 07:12:55.993499 kernel: Segment Routing with IPv6 Oct 9 07:12:55.993511 kernel: In-situ OAM (IOAM) with IPv6 Oct 9 07:12:55.993523 kernel: NET: Registered PF_PACKET protocol family Oct 9 07:12:55.993535 kernel: Key type dns_resolver registered Oct 9 07:12:55.993547 kernel: IPI shorthand broadcast: enabled Oct 9 07:12:55.993572 kernel: sched_clock: Marking stable (1080003487, 113552835)->(1248055399, -54499077) Oct 9 07:12:55.993584 kernel: registered taskstats version 1 Oct 9 07:12:55.993596 kernel: Loading compiled-in X.509 certificates Oct 9 07:12:55.993609 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.54-flatcar: 0b7ba59a46acf969bcd97270f441857501641c76' Oct 9 07:12:55.993625 kernel: Key type .fscrypt registered Oct 9 07:12:55.993637 kernel: Key type fscrypt-provisioning registered Oct 9 07:12:55.993649 kernel: ima: No TPM chip found, activating TPM-bypass! Oct 9 07:12:55.993661 kernel: ima: Allocated hash algorithm: sha1 Oct 9 07:12:55.993673 kernel: ima: No architecture policies found Oct 9 07:12:55.993685 kernel: clk: Disabling unused clocks Oct 9 07:12:55.993697 kernel: Freeing unused kernel image (initmem) memory: 49452K Oct 9 07:12:55.993710 kernel: Write protecting the kernel read-only data: 36864k Oct 9 07:12:55.993725 kernel: Freeing unused kernel image (rodata/data gap) memory: 1928K Oct 9 07:12:55.993738 kernel: Run /init as init process Oct 9 07:12:55.993750 kernel: with arguments: Oct 9 07:12:55.993761 kernel: /init Oct 9 07:12:55.993789 kernel: with environment: Oct 9 07:12:55.993801 kernel: HOME=/ Oct 9 07:12:55.993813 kernel: TERM=linux Oct 9 07:12:55.993825 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Oct 9 07:12:55.993840 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) Oct 9 07:12:55.993859 systemd[1]: Detected virtualization kvm. Oct 9 07:12:55.993872 systemd[1]: Detected architecture x86-64. Oct 9 07:12:55.993885 systemd[1]: Running in initrd. Oct 9 07:12:55.993897 systemd[1]: No hostname configured, using default hostname. Oct 9 07:12:55.993917 systemd[1]: Hostname set to . Oct 9 07:12:55.993930 systemd[1]: Initializing machine ID from VM UUID. Oct 9 07:12:55.993942 systemd[1]: Queued start job for default target initrd.target. Oct 9 07:12:55.993955 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 07:12:55.993968 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 07:12:55.993982 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Oct 9 07:12:55.993995 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 07:12:55.994008 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Oct 9 07:12:55.994025 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Oct 9 07:12:55.994040 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Oct 9 07:12:55.994053 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Oct 9 07:12:55.994066 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 07:12:55.994079 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 07:12:55.994093 systemd[1]: Reached target paths.target - Path Units. Oct 9 07:12:55.994106 systemd[1]: Reached target slices.target - Slice Units. Oct 9 07:12:55.994122 systemd[1]: Reached target swap.target - Swaps. Oct 9 07:12:55.994135 systemd[1]: Reached target timers.target - Timer Units. Oct 9 07:12:55.994147 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 07:12:55.994160 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 07:12:55.994173 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Oct 9 07:12:55.994186 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Oct 9 07:12:55.994198 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 07:12:55.994211 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 07:12:55.994224 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 07:12:55.994240 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 07:12:55.994253 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Oct 9 07:12:55.994266 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 07:12:55.994279 systemd[1]: Finished network-cleanup.service - Network Cleanup. Oct 9 07:12:55.994291 systemd[1]: Starting systemd-fsck-usr.service... Oct 9 07:12:55.994304 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 07:12:55.994317 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 07:12:55.994330 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:12:55.994346 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Oct 9 07:12:55.994359 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 07:12:55.994371 systemd[1]: Finished systemd-fsck-usr.service. Oct 9 07:12:55.994385 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 07:12:55.994429 systemd-journald[193]: Collecting audit messages is disabled. Oct 9 07:12:55.994463 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:12:55.994476 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 07:12:55.994489 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 07:12:55.994506 systemd-journald[193]: Journal started Oct 9 07:12:55.994533 systemd-journald[193]: Runtime Journal (/run/log/journal/7fa1499653484d8da0ff1d6c63fa0b81) is 6.0M, max 48.3M, 42.3M free. Oct 9 07:12:55.989886 systemd-modules-load[194]: Inserted module 'overlay' Oct 9 07:12:56.014858 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 07:12:56.014880 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 07:12:56.024152 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 9 07:12:56.030103 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Oct 9 07:12:56.026839 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 07:12:56.032256 systemd-modules-load[194]: Inserted module 'br_netfilter' Oct 9 07:12:56.033200 kernel: Bridge firewalling registered Oct 9 07:12:56.034227 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 07:12:56.036427 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 07:12:56.048099 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Oct 9 07:12:56.051371 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 07:12:56.053789 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 9 07:12:56.063461 dracut-cmdline[223]: dracut-dracut-053 Oct 9 07:12:56.066089 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 07:12:56.068239 dracut-cmdline[223]: Using kernel command line parameters: rd.driver.pre=btrfs rootflags=rw mount.usrflags=ro BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=ttyS0,115200 flatcar.first_boot=detected verity.usrhash=1839da262570fb938be558d95db7fc3d986a0d71e1b77d40d35a3e2a1bac7dcd Oct 9 07:12:56.077016 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 07:12:56.111714 systemd-resolved[244]: Positive Trust Anchors: Oct 9 07:12:56.111742 systemd-resolved[244]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 07:12:56.111787 systemd-resolved[244]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Oct 9 07:12:56.114760 systemd-resolved[244]: Defaulting to hostname 'linux'. Oct 9 07:12:56.116530 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 07:12:56.123340 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 07:12:56.168838 kernel: SCSI subsystem initialized Oct 9 07:12:56.181834 kernel: Loading iSCSI transport class v2.0-870. Oct 9 07:12:56.197841 kernel: iscsi: registered transport (tcp) Oct 9 07:12:56.229844 kernel: iscsi: registered transport (qla4xxx) Oct 9 07:12:56.229948 kernel: QLogic iSCSI HBA Driver Oct 9 07:12:56.289130 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Oct 9 07:12:56.299049 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Oct 9 07:12:56.366848 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Oct 9 07:12:56.366969 kernel: device-mapper: uevent: version 1.0.3 Oct 9 07:12:56.366982 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Oct 9 07:12:56.415835 kernel: raid6: avx2x4 gen() 30048 MB/s Oct 9 07:12:56.432819 kernel: raid6: avx2x2 gen() 25740 MB/s Oct 9 07:12:56.449988 kernel: raid6: avx2x1 gen() 24679 MB/s Oct 9 07:12:56.450099 kernel: raid6: using algorithm avx2x4 gen() 30048 MB/s Oct 9 07:12:56.467965 kernel: raid6: .... xor() 6185 MB/s, rmw enabled Oct 9 07:12:56.468063 kernel: raid6: using avx2x2 recovery algorithm Oct 9 07:12:56.496829 kernel: xor: automatically using best checksumming function avx Oct 9 07:12:56.685822 kernel: Btrfs loaded, zoned=no, fsverity=no Oct 9 07:12:56.701145 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Oct 9 07:12:56.713107 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 07:12:56.731332 systemd-udevd[414]: Using default interface naming scheme 'v255'. Oct 9 07:12:56.737038 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 07:12:56.746020 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Oct 9 07:12:56.761363 dracut-pre-trigger[419]: rd.md=0: removing MD RAID activation Oct 9 07:12:56.797148 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 07:12:56.810919 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 07:12:56.882796 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 07:12:56.897930 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Oct 9 07:12:56.913722 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Oct 9 07:12:56.918462 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 07:12:56.924858 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Oct 9 07:12:56.925089 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Oct 9 07:12:56.925704 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 07:12:56.928532 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 07:12:56.929401 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 07:12:56.935941 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Oct 9 07:12:56.944178 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 07:12:56.946955 kernel: cryptd: max_cpu_qlen set to 1000 Oct 9 07:12:56.945451 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 07:12:56.948764 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 07:12:56.952835 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 07:12:56.952913 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:12:56.954360 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:12:56.970797 kernel: libata version 3.00 loaded. Oct 9 07:12:56.973871 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:12:56.977671 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Oct 9 07:12:56.982795 kernel: AVX2 version of gcm_enc/dec engaged. Oct 9 07:12:56.984790 kernel: AES CTR mode by8 optimization enabled Oct 9 07:12:57.001818 kernel: ahci 0000:00:1f.2: version 3.0 Oct 9 07:12:57.003827 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (465) Oct 9 07:12:57.006921 kernel: ACPI: \_SB_.GSIA: Enabled at IRQ 16 Oct 9 07:12:57.006968 kernel: ahci 0000:00:1f.2: AHCI 0001.0000 32 slots 6 ports 1.5 Gbps 0x3f impl SATA mode Oct 9 07:12:57.007173 kernel: BTRFS: device fsid a442e753-4749-4732-ba27-ea845965fe4a devid 1 transid 34 /dev/vda3 scanned by (udev-worker) (459) Oct 9 07:12:57.007189 kernel: ahci 0000:00:1f.2: flags: 64bit ncq only Oct 9 07:12:57.006859 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Oct 9 07:12:57.014810 kernel: scsi host0: ahci Oct 9 07:12:57.018191 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Oct 9 07:12:57.021589 kernel: scsi host1: ahci Oct 9 07:12:57.026007 kernel: scsi host2: ahci Oct 9 07:12:57.026806 kernel: scsi host3: ahci Oct 9 07:12:57.029817 kernel: scsi host4: ahci Oct 9 07:12:57.032716 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Oct 9 07:12:57.041597 kernel: scsi host5: ahci Oct 9 07:12:57.041843 kernel: ata1: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040100 irq 34 Oct 9 07:12:57.041855 kernel: ata2: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040180 irq 34 Oct 9 07:12:57.041865 kernel: ata3: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040200 irq 34 Oct 9 07:12:57.041875 kernel: ata4: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040280 irq 34 Oct 9 07:12:57.041885 kernel: ata5: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040300 irq 34 Oct 9 07:12:57.041900 kernel: ata6: SATA max UDMA/133 abar m4096@0xc1040000 port 0xc1040380 irq 34 Oct 9 07:12:57.043204 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Oct 9 07:12:57.050673 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 07:12:57.063955 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Oct 9 07:12:57.066588 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 07:12:57.066661 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:12:57.069015 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:12:57.073843 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:12:57.077132 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 07:12:57.079786 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 07:12:57.083796 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 07:12:57.100171 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:12:57.107940 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Oct 9 07:12:57.135472 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 07:12:57.354036 kernel: ata5: SATA link down (SStatus 0 SControl 300) Oct 9 07:12:57.354130 kernel: ata4: SATA link down (SStatus 0 SControl 300) Oct 9 07:12:57.354144 kernel: ata2: SATA link down (SStatus 0 SControl 300) Oct 9 07:12:57.354156 kernel: ata3: SATA link up 1.5 Gbps (SStatus 113 SControl 300) Oct 9 07:12:57.355793 kernel: ata6: SATA link down (SStatus 0 SControl 300) Oct 9 07:12:57.355818 kernel: ata1: SATA link down (SStatus 0 SControl 300) Oct 9 07:12:57.356794 kernel: ata3.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Oct 9 07:12:57.358240 kernel: ata3.00: applying bridge limits Oct 9 07:12:57.358268 kernel: ata3.00: configured for UDMA/100 Oct 9 07:12:57.358801 kernel: scsi 2:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Oct 9 07:12:57.400805 kernel: sr 2:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Oct 9 07:12:57.401186 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Oct 9 07:12:57.418807 kernel: sr 2:0:0:0: Attached scsi CD-ROM sr0 Oct 9 07:12:58.088757 disk-uuid[568]: The operation has completed successfully. Oct 9 07:12:58.090158 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Oct 9 07:12:58.114426 systemd[1]: disk-uuid.service: Deactivated successfully. Oct 9 07:12:58.114576 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Oct 9 07:12:58.149933 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Oct 9 07:12:58.154017 sh[600]: Success Oct 9 07:12:58.169796 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Oct 9 07:12:58.207992 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Oct 9 07:12:58.223041 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Oct 9 07:12:58.225905 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Oct 9 07:12:58.252802 kernel: BTRFS info (device dm-0): first mount of filesystem a442e753-4749-4732-ba27-ea845965fe4a Oct 9 07:12:58.252868 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Oct 9 07:12:58.252883 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Oct 9 07:12:58.255165 kernel: BTRFS info (device dm-0): disabling log replay at mount time Oct 9 07:12:58.255193 kernel: BTRFS info (device dm-0): using free space tree Oct 9 07:12:58.259359 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Oct 9 07:12:58.261129 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Oct 9 07:12:58.281085 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Oct 9 07:12:58.283006 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Oct 9 07:12:58.293401 kernel: BTRFS info (device vda6): first mount of filesystem aa256cb8-f25c-41d0-8582-dc8cedfde7ce Oct 9 07:12:58.293443 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 07:12:58.293455 kernel: BTRFS info (device vda6): using free space tree Oct 9 07:12:58.296956 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 07:12:58.308463 systemd[1]: mnt-oem.mount: Deactivated successfully. Oct 9 07:12:58.310795 kernel: BTRFS info (device vda6): last unmount of filesystem aa256cb8-f25c-41d0-8582-dc8cedfde7ce Oct 9 07:12:58.320839 systemd[1]: Finished ignition-setup.service - Ignition (setup). Oct 9 07:12:58.328005 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Oct 9 07:12:58.387419 ignition[694]: Ignition 2.18.0 Oct 9 07:12:58.387435 ignition[694]: Stage: fetch-offline Oct 9 07:12:58.387511 ignition[694]: no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:58.387524 ignition[694]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:58.387758 ignition[694]: parsed url from cmdline: "" Oct 9 07:12:58.387762 ignition[694]: no config URL provided Oct 9 07:12:58.387782 ignition[694]: reading system config file "/usr/lib/ignition/user.ign" Oct 9 07:12:58.387792 ignition[694]: no config at "/usr/lib/ignition/user.ign" Oct 9 07:12:58.387834 ignition[694]: op(1): [started] loading QEMU firmware config module Oct 9 07:12:58.387840 ignition[694]: op(1): executing: "modprobe" "qemu_fw_cfg" Oct 9 07:12:58.403094 ignition[694]: op(1): [finished] loading QEMU firmware config module Oct 9 07:12:58.404712 ignition[694]: parsing config with SHA512: cc1a629e8914eacf7df23e21a5fa6a7b34c2a8524a19a9736974ab3807e1685b5aab3aad7146635b4929623658791275dfa83ff130f1f1d69328075f4e05291a Oct 9 07:12:58.411903 unknown[694]: fetched base config from "system" Oct 9 07:12:58.411922 unknown[694]: fetched user config from "qemu" Oct 9 07:12:58.413162 ignition[694]: fetch-offline: fetch-offline passed Oct 9 07:12:58.415153 ignition[694]: Ignition finished successfully Oct 9 07:12:58.416348 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 07:12:58.429061 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 07:12:58.429672 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 07:12:58.457851 systemd-networkd[789]: lo: Link UP Oct 9 07:12:58.457862 systemd-networkd[789]: lo: Gained carrier Oct 9 07:12:58.459829 systemd-networkd[789]: Enumeration completed Oct 9 07:12:58.460349 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 07:12:58.460354 systemd-networkd[789]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 07:12:58.462431 systemd-networkd[789]: eth0: Link UP Oct 9 07:12:58.462435 systemd-networkd[789]: eth0: Gained carrier Oct 9 07:12:58.462444 systemd-networkd[789]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 07:12:58.463422 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 07:12:58.470384 systemd[1]: Reached target network.target - Network. Oct 9 07:12:58.472131 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Oct 9 07:12:58.478896 systemd-networkd[789]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 07:12:58.481959 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Oct 9 07:12:58.501839 ignition[792]: Ignition 2.18.0 Oct 9 07:12:58.501855 ignition[792]: Stage: kargs Oct 9 07:12:58.502053 ignition[792]: no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:58.502068 ignition[792]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:58.502705 ignition[792]: kargs: kargs passed Oct 9 07:12:58.502760 ignition[792]: Ignition finished successfully Oct 9 07:12:58.509886 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Oct 9 07:12:58.521128 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Oct 9 07:12:58.537116 ignition[802]: Ignition 2.18.0 Oct 9 07:12:58.537128 ignition[802]: Stage: disks Oct 9 07:12:58.537329 ignition[802]: no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:58.537342 ignition[802]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:58.538029 ignition[802]: disks: disks passed Oct 9 07:12:58.538081 ignition[802]: Ignition finished successfully Oct 9 07:12:58.544397 systemd[1]: Finished ignition-disks.service - Ignition (disks). Oct 9 07:12:58.545338 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Oct 9 07:12:58.548851 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Oct 9 07:12:58.551266 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 07:12:58.553283 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 07:12:58.555275 systemd[1]: Reached target basic.target - Basic System. Oct 9 07:12:58.563908 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Oct 9 07:12:58.579698 systemd-resolved[244]: Detected conflict on linux IN A 10.0.0.15 Oct 9 07:12:58.579724 systemd-resolved[244]: Hostname conflict, changing published hostname from 'linux' to 'linux10'. Oct 9 07:12:58.581671 systemd-fsck[813]: ROOT: clean, 14/553520 files, 52654/553472 blocks Oct 9 07:12:58.588834 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Oct 9 07:12:58.603035 systemd[1]: Mounting sysroot.mount - /sysroot... Oct 9 07:12:58.726811 kernel: EXT4-fs (vda9): mounted filesystem ef891253-2811-499a-a9aa-02f0764c1b95 r/w with ordered data mode. Quota mode: none. Oct 9 07:12:58.727737 systemd[1]: Mounted sysroot.mount - /sysroot. Oct 9 07:12:58.728749 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Oct 9 07:12:58.740985 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 07:12:58.742545 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Oct 9 07:12:58.743640 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Oct 9 07:12:58.743686 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Oct 9 07:12:58.743712 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 07:12:58.753712 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Oct 9 07:12:58.760677 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (821) Oct 9 07:12:58.760706 kernel: BTRFS info (device vda6): first mount of filesystem aa256cb8-f25c-41d0-8582-dc8cedfde7ce Oct 9 07:12:58.760717 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 07:12:58.761028 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Oct 9 07:12:58.765867 kernel: BTRFS info (device vda6): using free space tree Oct 9 07:12:58.765882 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 07:12:58.768144 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 07:12:58.800974 initrd-setup-root[845]: cut: /sysroot/etc/passwd: No such file or directory Oct 9 07:12:58.806846 initrd-setup-root[852]: cut: /sysroot/etc/group: No such file or directory Oct 9 07:12:58.811010 initrd-setup-root[859]: cut: /sysroot/etc/shadow: No such file or directory Oct 9 07:12:58.815659 initrd-setup-root[866]: cut: /sysroot/etc/gshadow: No such file or directory Oct 9 07:12:58.912948 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Oct 9 07:12:58.924038 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Oct 9 07:12:58.925641 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Oct 9 07:12:58.937793 kernel: BTRFS info (device vda6): last unmount of filesystem aa256cb8-f25c-41d0-8582-dc8cedfde7ce Oct 9 07:12:58.955004 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Oct 9 07:12:58.963846 ignition[936]: INFO : Ignition 2.18.0 Oct 9 07:12:58.963846 ignition[936]: INFO : Stage: mount Oct 9 07:12:58.965515 ignition[936]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:58.965515 ignition[936]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:58.965515 ignition[936]: INFO : mount: mount passed Oct 9 07:12:58.965515 ignition[936]: INFO : Ignition finished successfully Oct 9 07:12:58.967013 systemd[1]: Finished ignition-mount.service - Ignition (mount). Oct 9 07:12:58.982018 systemd[1]: Starting ignition-files.service - Ignition (files)... Oct 9 07:12:59.252234 systemd[1]: sysroot-oem.mount: Deactivated successfully. Oct 9 07:12:59.269183 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Oct 9 07:12:59.277561 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (950) Oct 9 07:12:59.277613 kernel: BTRFS info (device vda6): first mount of filesystem aa256cb8-f25c-41d0-8582-dc8cedfde7ce Oct 9 07:12:59.277631 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Oct 9 07:12:59.278581 kernel: BTRFS info (device vda6): using free space tree Oct 9 07:12:59.282809 kernel: BTRFS info (device vda6): auto enabling async discard Oct 9 07:12:59.284312 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Oct 9 07:12:59.317683 ignition[967]: INFO : Ignition 2.18.0 Oct 9 07:12:59.317683 ignition[967]: INFO : Stage: files Oct 9 07:12:59.319845 ignition[967]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:59.319845 ignition[967]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:59.319845 ignition[967]: DEBUG : files: compiled without relabeling support, skipping Oct 9 07:12:59.319845 ignition[967]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Oct 9 07:12:59.319845 ignition[967]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Oct 9 07:12:59.326642 ignition[967]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Oct 9 07:12:59.326642 ignition[967]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Oct 9 07:12:59.326642 ignition[967]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Oct 9 07:12:59.326642 ignition[967]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 07:12:59.326642 ignition[967]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Oct 9 07:12:59.326642 ignition[967]: INFO : files: op(4): [started] processing unit "docker.service" Oct 9 07:12:59.326642 ignition[967]: INFO : files: op(4): [finished] processing unit "docker.service" Oct 9 07:12:59.326642 ignition[967]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Oct 9 07:12:59.326642 ignition[967]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 07:12:59.323573 unknown[967]: wrote ssh authorized keys file for user: core Oct 9 07:12:59.343387 ignition[967]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Oct 9 07:12:59.343387 ignition[967]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Oct 9 07:12:59.343387 ignition[967]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Oct 9 07:12:59.355226 ignition[967]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 07:12:59.361521 ignition[967]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Oct 9 07:12:59.363296 ignition[967]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Oct 9 07:12:59.363296 ignition[967]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Oct 9 07:12:59.366413 ignition[967]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Oct 9 07:12:59.367921 ignition[967]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Oct 9 07:12:59.369751 ignition[967]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Oct 9 07:12:59.371484 ignition[967]: INFO : files: files passed Oct 9 07:12:59.372274 ignition[967]: INFO : Ignition finished successfully Oct 9 07:12:59.375420 systemd[1]: Finished ignition-files.service - Ignition (files). Oct 9 07:12:59.384086 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Oct 9 07:12:59.386333 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Oct 9 07:12:59.388238 systemd[1]: ignition-quench.service: Deactivated successfully. Oct 9 07:12:59.388392 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Oct 9 07:12:59.398024 initrd-setup-root-after-ignition[996]: grep: /sysroot/oem/oem-release: No such file or directory Oct 9 07:12:59.401293 initrd-setup-root-after-ignition[998]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 07:12:59.401293 initrd-setup-root-after-ignition[998]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Oct 9 07:12:59.404739 initrd-setup-root-after-ignition[1002]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Oct 9 07:12:59.404373 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 07:12:59.406282 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Oct 9 07:12:59.421035 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Oct 9 07:12:59.462300 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Oct 9 07:12:59.462460 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Oct 9 07:12:59.464951 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Oct 9 07:12:59.467221 systemd[1]: Reached target initrd.target - Initrd Default Target. Oct 9 07:12:59.467533 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Oct 9 07:12:59.468431 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Oct 9 07:12:59.489912 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 07:12:59.503077 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Oct 9 07:12:59.514753 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Oct 9 07:12:59.515178 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 07:12:59.515635 systemd[1]: Stopped target timers.target - Timer Units. Oct 9 07:12:59.516248 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Oct 9 07:12:59.516398 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Oct 9 07:12:59.524370 systemd[1]: Stopped target initrd.target - Initrd Default Target. Oct 9 07:12:59.527117 systemd[1]: Stopped target basic.target - Basic System. Oct 9 07:12:59.527761 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Oct 9 07:12:59.528391 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Oct 9 07:12:59.528832 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Oct 9 07:12:59.529458 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Oct 9 07:12:59.530075 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Oct 9 07:12:59.530506 systemd[1]: Stopped target sysinit.target - System Initialization. Oct 9 07:12:59.531135 systemd[1]: Stopped target local-fs.target - Local File Systems. Oct 9 07:12:59.531813 systemd[1]: Stopped target swap.target - Swaps. Oct 9 07:12:59.532387 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Oct 9 07:12:59.532547 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Oct 9 07:12:59.550815 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Oct 9 07:12:59.551369 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 07:12:59.551805 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Oct 9 07:12:59.552260 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 07:12:59.559713 systemd[1]: dracut-initqueue.service: Deactivated successfully. Oct 9 07:12:59.559918 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Oct 9 07:12:59.567481 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Oct 9 07:12:59.567653 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Oct 9 07:12:59.568432 systemd[1]: Stopped target paths.target - Path Units. Oct 9 07:12:59.568804 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Oct 9 07:12:59.570904 systemd-networkd[789]: eth0: Gained IPv6LL Oct 9 07:12:59.572901 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 07:12:59.574664 systemd[1]: Stopped target slices.target - Slice Units. Oct 9 07:12:59.575375 systemd[1]: Stopped target sockets.target - Socket Units. Oct 9 07:12:59.575870 systemd[1]: iscsid.socket: Deactivated successfully. Oct 9 07:12:59.576006 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Oct 9 07:12:59.582604 systemd[1]: iscsiuio.socket: Deactivated successfully. Oct 9 07:12:59.582728 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Oct 9 07:12:59.584936 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Oct 9 07:12:59.585092 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Oct 9 07:12:59.587415 systemd[1]: ignition-files.service: Deactivated successfully. Oct 9 07:12:59.587634 systemd[1]: Stopped ignition-files.service - Ignition (files). Oct 9 07:12:59.600013 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Oct 9 07:12:59.602808 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Oct 9 07:12:59.604055 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Oct 9 07:12:59.604276 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 07:12:59.604854 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Oct 9 07:12:59.604963 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Oct 9 07:12:59.614703 ignition[1023]: INFO : Ignition 2.18.0 Oct 9 07:12:59.614703 ignition[1023]: INFO : Stage: umount Oct 9 07:12:59.614703 ignition[1023]: INFO : no configs at "/usr/lib/ignition/base.d" Oct 9 07:12:59.614703 ignition[1023]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Oct 9 07:12:59.614703 ignition[1023]: INFO : umount: umount passed Oct 9 07:12:59.614703 ignition[1023]: INFO : Ignition finished successfully Oct 9 07:12:59.609435 systemd[1]: initrd-cleanup.service: Deactivated successfully. Oct 9 07:12:59.609560 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Oct 9 07:12:59.617930 systemd[1]: ignition-mount.service: Deactivated successfully. Oct 9 07:12:59.618155 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Oct 9 07:12:59.621226 systemd[1]: Stopped target network.target - Network. Oct 9 07:12:59.621726 systemd[1]: ignition-disks.service: Deactivated successfully. Oct 9 07:12:59.621808 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Oct 9 07:12:59.625419 systemd[1]: ignition-kargs.service: Deactivated successfully. Oct 9 07:12:59.625497 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Oct 9 07:12:59.626123 systemd[1]: ignition-setup.service: Deactivated successfully. Oct 9 07:12:59.626183 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Oct 9 07:12:59.626835 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Oct 9 07:12:59.626897 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Oct 9 07:12:59.627691 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Oct 9 07:12:59.634851 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Oct 9 07:12:59.642905 systemd-networkd[789]: eth0: DHCPv6 lease lost Oct 9 07:12:59.643207 systemd[1]: systemd-resolved.service: Deactivated successfully. Oct 9 07:12:59.643361 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Oct 9 07:12:59.646097 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Oct 9 07:12:59.646225 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 9 07:12:59.647542 systemd[1]: systemd-networkd.service: Deactivated successfully. Oct 9 07:12:59.647684 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Oct 9 07:12:59.650699 systemd[1]: systemd-networkd.socket: Deactivated successfully. Oct 9 07:12:59.650791 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Oct 9 07:12:59.656908 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Oct 9 07:12:59.657695 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Oct 9 07:12:59.657758 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Oct 9 07:12:59.660109 systemd[1]: systemd-sysctl.service: Deactivated successfully. Oct 9 07:12:59.660161 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Oct 9 07:12:59.660548 systemd[1]: systemd-modules-load.service: Deactivated successfully. Oct 9 07:12:59.660603 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Oct 9 07:12:59.661310 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 07:12:59.685545 systemd[1]: network-cleanup.service: Deactivated successfully. Oct 9 07:12:59.685676 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Oct 9 07:12:59.687682 systemd[1]: systemd-udevd.service: Deactivated successfully. Oct 9 07:12:59.687876 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 07:12:59.689641 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Oct 9 07:12:59.689692 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Oct 9 07:12:59.692113 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Oct 9 07:12:59.692163 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 07:12:59.695151 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Oct 9 07:12:59.695209 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Oct 9 07:12:59.700091 systemd[1]: dracut-cmdline.service: Deactivated successfully. Oct 9 07:12:59.700164 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Oct 9 07:12:59.700963 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Oct 9 07:12:59.701029 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Oct 9 07:12:59.713033 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Oct 9 07:12:59.713320 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Oct 9 07:12:59.713405 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 07:12:59.713857 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Oct 9 07:12:59.713923 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 07:12:59.714481 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Oct 9 07:12:59.714532 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 07:12:59.715156 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 07:12:59.715207 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:12:59.734453 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Oct 9 07:12:59.734620 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Oct 9 07:12:59.780166 systemd[1]: sysroot-boot.mount: Deactivated successfully. Oct 9 07:12:59.786135 systemd[1]: sysroot-boot.service: Deactivated successfully. Oct 9 07:12:59.786273 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Oct 9 07:12:59.786928 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Oct 9 07:12:59.787237 systemd[1]: initrd-setup-root.service: Deactivated successfully. Oct 9 07:12:59.787286 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Oct 9 07:12:59.804022 systemd[1]: Starting initrd-switch-root.service - Switch Root... Oct 9 07:12:59.814515 systemd[1]: Switching root. Oct 9 07:12:59.851926 systemd-journald[193]: Journal stopped Oct 9 07:13:00.792949 systemd-journald[193]: Received SIGTERM from PID 1 (systemd). Oct 9 07:13:00.793027 kernel: SELinux: policy capability network_peer_controls=1 Oct 9 07:13:00.793049 kernel: SELinux: policy capability open_perms=1 Oct 9 07:13:00.793064 kernel: SELinux: policy capability extended_socket_class=1 Oct 9 07:13:00.793076 kernel: SELinux: policy capability always_check_network=0 Oct 9 07:13:00.793092 kernel: SELinux: policy capability cgroup_seclabel=1 Oct 9 07:13:00.793104 kernel: SELinux: policy capability nnp_nosuid_transition=1 Oct 9 07:13:00.793115 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Oct 9 07:13:00.793140 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Oct 9 07:13:00.793153 kernel: audit: type=1403 audit(1728457979.944:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Oct 9 07:13:00.793175 systemd[1]: Successfully loaded SELinux policy in 45.468ms. Oct 9 07:13:00.793203 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 13.617ms. Oct 9 07:13:00.793216 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) Oct 9 07:13:00.793229 systemd[1]: Detected virtualization kvm. Oct 9 07:13:00.793242 systemd[1]: Detected architecture x86-64. Oct 9 07:13:00.793254 systemd[1]: Detected first boot. Oct 9 07:13:00.793266 systemd[1]: Initializing machine ID from VM UUID. Oct 9 07:13:00.793278 zram_generator::config[1066]: No configuration found. Oct 9 07:13:00.793292 systemd[1]: Populated /etc with preset unit settings. Oct 9 07:13:00.793310 systemd[1]: initrd-switch-root.service: Deactivated successfully. Oct 9 07:13:00.793327 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Oct 9 07:13:00.793339 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Oct 9 07:13:00.793354 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Oct 9 07:13:00.793366 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Oct 9 07:13:00.793383 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Oct 9 07:13:00.793396 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Oct 9 07:13:00.793409 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Oct 9 07:13:00.793421 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Oct 9 07:13:00.793440 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Oct 9 07:13:00.793453 systemd[1]: Created slice user.slice - User and Session Slice. Oct 9 07:13:00.793466 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Oct 9 07:13:00.793479 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Oct 9 07:13:00.793491 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Oct 9 07:13:00.793509 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Oct 9 07:13:00.793522 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Oct 9 07:13:00.793537 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Oct 9 07:13:00.793555 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Oct 9 07:13:00.793568 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Oct 9 07:13:00.793581 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Oct 9 07:13:00.793593 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Oct 9 07:13:00.793606 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Oct 9 07:13:00.793622 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Oct 9 07:13:00.793635 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Oct 9 07:13:00.793648 systemd[1]: Reached target remote-fs.target - Remote File Systems. Oct 9 07:13:00.793660 systemd[1]: Reached target slices.target - Slice Units. Oct 9 07:13:00.793672 systemd[1]: Reached target swap.target - Swaps. Oct 9 07:13:00.793685 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Oct 9 07:13:00.793699 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Oct 9 07:13:00.793716 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Oct 9 07:13:00.793733 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Oct 9 07:13:00.793754 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Oct 9 07:13:00.793787 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Oct 9 07:13:00.793806 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Oct 9 07:13:00.793823 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Oct 9 07:13:00.793835 systemd[1]: Mounting media.mount - External Media Directory... Oct 9 07:13:00.793849 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:00.793861 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Oct 9 07:13:00.793873 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Oct 9 07:13:00.793885 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Oct 9 07:13:00.793903 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). Oct 9 07:13:00.793915 systemd[1]: Reached target machines.target - Containers. Oct 9 07:13:00.793928 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Oct 9 07:13:00.793940 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 07:13:00.793952 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Oct 9 07:13:00.793966 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Oct 9 07:13:00.793978 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 07:13:00.793991 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 07:13:00.794006 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 07:13:00.794019 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Oct 9 07:13:00.794032 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 07:13:00.794045 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Oct 9 07:13:00.794057 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Oct 9 07:13:00.794070 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Oct 9 07:13:00.794083 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Oct 9 07:13:00.794095 systemd[1]: Stopped systemd-fsck-usr.service. Oct 9 07:13:00.794108 systemd[1]: Starting systemd-journald.service - Journal Service... Oct 9 07:13:00.794122 kernel: fuse: init (API version 7.39) Oct 9 07:13:00.794134 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Oct 9 07:13:00.794147 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Oct 9 07:13:00.794159 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Oct 9 07:13:00.794172 kernel: loop: module loaded Oct 9 07:13:00.794184 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Oct 9 07:13:00.794196 systemd[1]: verity-setup.service: Deactivated successfully. Oct 9 07:13:00.794208 systemd[1]: Stopped verity-setup.service. Oct 9 07:13:00.794222 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:00.794236 kernel: ACPI: bus type drm_connector registered Oct 9 07:13:00.794248 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Oct 9 07:13:00.794260 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Oct 9 07:13:00.794273 systemd[1]: Mounted media.mount - External Media Directory. Oct 9 07:13:00.794288 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Oct 9 07:13:00.794300 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Oct 9 07:13:00.794312 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Oct 9 07:13:00.794325 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Oct 9 07:13:00.794337 systemd[1]: modprobe@configfs.service: Deactivated successfully. Oct 9 07:13:00.794350 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Oct 9 07:13:00.794362 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 07:13:00.794374 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 07:13:00.794387 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 07:13:00.794401 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 07:13:00.794442 systemd-journald[1135]: Collecting audit messages is disabled. Oct 9 07:13:00.794469 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 07:13:00.794481 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 07:13:00.794496 systemd-journald[1135]: Journal started Oct 9 07:13:00.794524 systemd-journald[1135]: Runtime Journal (/run/log/journal/7fa1499653484d8da0ff1d6c63fa0b81) is 6.0M, max 48.3M, 42.3M free. Oct 9 07:13:00.488015 systemd[1]: Queued start job for default target multi-user.target. Oct 9 07:13:00.509194 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Oct 9 07:13:00.509699 systemd[1]: systemd-journald.service: Deactivated successfully. Oct 9 07:13:00.797852 systemd[1]: Started systemd-journald.service - Journal Service. Oct 9 07:13:00.798790 systemd[1]: modprobe@fuse.service: Deactivated successfully. Oct 9 07:13:00.798972 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Oct 9 07:13:00.800460 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 07:13:00.800631 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 07:13:00.802058 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Oct 9 07:13:00.803502 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Oct 9 07:13:00.805065 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Oct 9 07:13:00.818537 systemd[1]: Reached target network-pre.target - Preparation for Network. Oct 9 07:13:00.849953 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Oct 9 07:13:00.852596 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Oct 9 07:13:00.853753 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Oct 9 07:13:00.853796 systemd[1]: Reached target local-fs.target - Local File Systems. Oct 9 07:13:00.855879 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Oct 9 07:13:00.858282 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Oct 9 07:13:00.860978 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Oct 9 07:13:00.862126 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 07:13:00.883153 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Oct 9 07:13:00.886446 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Oct 9 07:13:00.887704 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 07:13:00.889837 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Oct 9 07:13:00.891824 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 07:13:00.895451 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Oct 9 07:13:00.898067 systemd-journald[1135]: Time spent on flushing to /var/log/journal/7fa1499653484d8da0ff1d6c63fa0b81 is 42.413ms for 967 entries. Oct 9 07:13:00.898067 systemd-journald[1135]: System Journal (/var/log/journal/7fa1499653484d8da0ff1d6c63fa0b81) is 8.0M, max 195.6M, 187.6M free. Oct 9 07:13:01.453619 systemd-journald[1135]: Received client request to flush runtime journal. Oct 9 07:13:01.453718 kernel: loop0: detected capacity change from 0 to 80568 Oct 9 07:13:01.453754 kernel: block loop0: the capability attribute has been deprecated. Oct 9 07:13:01.453971 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Oct 9 07:13:01.454003 kernel: loop1: detected capacity change from 0 to 139904 Oct 9 07:13:01.454031 kernel: loop2: detected capacity change from 0 to 80568 Oct 9 07:13:01.454057 kernel: loop3: detected capacity change from 0 to 139904 Oct 9 07:13:00.901902 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Oct 9 07:13:00.905965 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Oct 9 07:13:00.915661 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Oct 9 07:13:00.917601 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Oct 9 07:13:00.918897 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Oct 9 07:13:00.920396 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Oct 9 07:13:00.934157 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Oct 9 07:13:00.939009 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Oct 9 07:13:00.982940 udevadm[1186]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Oct 9 07:13:00.992138 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Oct 9 07:13:00.995122 systemd-tmpfiles[1179]: ACLs are not supported, ignoring. Oct 9 07:13:00.995139 systemd-tmpfiles[1179]: ACLs are not supported, ignoring. Oct 9 07:13:01.001455 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Oct 9 07:13:01.038990 systemd[1]: Starting systemd-sysusers.service - Create System Users... Oct 9 07:13:01.121200 systemd[1]: Finished systemd-sysusers.service - Create System Users. Oct 9 07:13:01.132101 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Oct 9 07:13:01.191053 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Oct 9 07:13:01.191068 systemd-tmpfiles[1193]: ACLs are not supported, ignoring. Oct 9 07:13:01.197194 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Oct 9 07:13:01.371837 (sd-merge)[1196]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Oct 9 07:13:01.372406 (sd-merge)[1196]: Merged extensions into '/usr'. Oct 9 07:13:01.382277 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Oct 9 07:13:01.391012 systemd[1]: Starting ensure-sysext.service... Oct 9 07:13:01.393258 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Oct 9 07:13:01.396628 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Oct 9 07:13:01.401019 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Oct 9 07:13:01.424994 systemd[1]: Reloading requested from client PID 1198 ('systemctl') (unit ensure-sysext.service)... Oct 9 07:13:01.425004 systemd[1]: Reloading... Oct 9 07:13:01.496879 zram_generator::config[1226]: No configuration found. Oct 9 07:13:01.631894 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. Oct 9 07:13:01.688075 systemd[1]: Reloading finished in 262 ms. Oct 9 07:13:01.723040 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Oct 9 07:13:01.778975 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Oct 9 07:13:01.784276 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.784463 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 07:13:01.787420 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Oct 9 07:13:01.817321 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Oct 9 07:13:01.821240 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Oct 9 07:13:01.822930 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 07:13:01.823051 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.831089 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.831692 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 07:13:01.831887 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 07:13:01.831977 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.838691 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.839942 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Oct 9 07:13:01.845865 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Oct 9 07:13:01.846582 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Oct 9 07:13:01.846748 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Oct 9 07:13:01.847630 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Oct 9 07:13:01.847912 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Oct 9 07:13:01.850105 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Oct 9 07:13:01.850324 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Oct 9 07:13:01.855279 systemd[1]: modprobe@loop.service: Deactivated successfully. Oct 9 07:13:01.855689 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Oct 9 07:13:01.883219 systemd[1]: Finished ensure-sysext.service. Oct 9 07:13:01.884651 systemd[1]: modprobe@drm.service: Deactivated successfully. Oct 9 07:13:01.885030 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Oct 9 07:13:01.892359 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Oct 9 07:13:01.892509 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Oct 9 07:13:01.936738 systemd-tmpfiles[1266]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Oct 9 07:13:01.937148 systemd-tmpfiles[1266]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Oct 9 07:13:01.938325 systemd-tmpfiles[1266]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Oct 9 07:13:01.938753 systemd-tmpfiles[1266]: ACLs are not supported, ignoring. Oct 9 07:13:01.939519 systemd-tmpfiles[1266]: ACLs are not supported, ignoring. Oct 9 07:13:01.943566 systemd-tmpfiles[1266]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 07:13:01.943580 systemd-tmpfiles[1266]: Skipping /boot Oct 9 07:13:01.958333 systemd-tmpfiles[1266]: Detected autofs mount point /boot during canonicalization of boot. Oct 9 07:13:01.958460 systemd-tmpfiles[1266]: Skipping /boot Oct 9 07:13:01.992463 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Oct 9 07:13:02.037956 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 9 07:13:02.119128 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Oct 9 07:13:02.121874 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Oct 9 07:13:02.125100 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Oct 9 07:13:02.128026 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Oct 9 07:13:02.134339 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Oct 9 07:13:02.194063 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Oct 9 07:13:02.199044 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Oct 9 07:13:02.218179 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Oct 9 07:13:02.219236 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Oct 9 07:13:02.228456 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Oct 9 07:13:02.264071 ldconfig[1173]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Oct 9 07:13:02.315918 augenrules[1303]: No rules Oct 9 07:13:02.317165 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 9 07:13:02.328188 systemd[1]: Started systemd-userdbd.service - User Database Manager. Oct 9 07:13:02.331388 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Oct 9 07:13:02.333187 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). Oct 9 07:13:02.375311 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Oct 9 07:13:02.468065 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Oct 9 07:13:02.469895 systemd[1]: Reached target time-set.target - System Time Set. Oct 9 07:13:02.479759 systemd-resolved[1288]: Positive Trust Anchors: Oct 9 07:13:02.479798 systemd-resolved[1288]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Oct 9 07:13:02.479831 systemd-resolved[1288]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Oct 9 07:13:02.484092 systemd-resolved[1288]: Defaulting to hostname 'linux'. Oct 9 07:13:02.489441 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Oct 9 07:13:02.490764 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Oct 9 07:13:02.640314 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Oct 9 07:13:02.657160 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Oct 9 07:13:02.660484 systemd[1]: Starting systemd-update-done.service - Update is Completed... Oct 9 07:13:02.681661 systemd[1]: Finished systemd-update-done.service - Update is Completed. Oct 9 07:13:02.686840 systemd-udevd[1319]: Using default interface naming scheme 'v255'. Oct 9 07:13:02.705738 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Oct 9 07:13:02.719804 systemd[1]: Starting systemd-networkd.service - Network Configuration... Oct 9 07:13:02.750867 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Oct 9 07:13:02.794816 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1330) Oct 9 07:13:02.818824 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1335) Oct 9 07:13:02.847721 systemd-networkd[1327]: lo: Link UP Oct 9 07:13:02.847733 systemd-networkd[1327]: lo: Gained carrier Oct 9 07:13:02.850023 systemd-networkd[1327]: Enumeration completed Oct 9 07:13:02.850645 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 07:13:02.850650 systemd-networkd[1327]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Oct 9 07:13:02.852623 systemd-networkd[1327]: eth0: Link UP Oct 9 07:13:02.852689 systemd-networkd[1327]: eth0: Gained carrier Oct 9 07:13:02.852751 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 07:13:02.869502 systemd[1]: Started systemd-networkd.service - Network Configuration. Oct 9 07:13:02.871346 systemd[1]: Reached target network.target - Network. Oct 9 07:13:02.878807 systemd-networkd[1327]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Oct 9 07:13:02.880062 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Oct 9 07:13:02.884909 systemd-networkd[1327]: eth0: DHCPv4 address 10.0.0.15/16, gateway 10.0.0.1 acquired from 10.0.0.1 Oct 9 07:13:02.885863 systemd-timesyncd[1289]: Network configuration changed, trying to establish connection. Oct 9 07:13:03.503961 systemd-timesyncd[1289]: Contacted time server 10.0.0.1:123 (10.0.0.1). Oct 9 07:13:03.504024 systemd-timesyncd[1289]: Initial clock synchronization to Wed 2024-10-09 07:13:03.503488 UTC. Oct 9 07:13:03.504663 systemd-resolved[1288]: Clock change detected. Flushing caches. Oct 9 07:13:03.514874 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Oct 9 07:13:03.519201 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Oct 9 07:13:03.523893 kernel: ACPI: button: Power Button [PWRF] Oct 9 07:13:03.524364 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Oct 9 07:13:03.578168 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Oct 9 07:13:03.581443 kernel: i801_smbus 0000:00:1f.3: Enabling SMBus device Oct 9 07:13:03.585530 kernel: i801_smbus 0000:00:1f.3: SMBus using PCI interrupt Oct 9 07:13:03.585710 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Oct 9 07:13:03.585731 kernel: i2c i2c-0: 1/1 memory slots populated (from DMI) Oct 9 07:13:03.587108 kernel: i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD Oct 9 07:13:03.622866 kernel: mousedev: PS/2 mouse device common for all mice Oct 9 07:13:03.624249 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:13:03.633455 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Oct 9 07:13:03.633872 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:13:03.649160 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Oct 9 07:13:03.724394 kernel: kvm_amd: TSC scaling supported Oct 9 07:13:03.724473 kernel: kvm_amd: Nested Virtualization enabled Oct 9 07:13:03.724511 kernel: kvm_amd: Nested Paging enabled Oct 9 07:13:03.724527 kernel: kvm_amd: LBR virtualization supported Oct 9 07:13:03.725426 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Oct 9 07:13:03.725476 kernel: kvm_amd: Virtual GIF supported Oct 9 07:13:03.747856 kernel: EDAC MC: Ver: 3.0.0 Oct 9 07:13:03.765024 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Oct 9 07:13:03.787886 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Oct 9 07:13:03.804237 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Oct 9 07:13:03.817155 lvm[1369]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 07:13:03.852189 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Oct 9 07:13:03.853813 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Oct 9 07:13:03.855011 systemd[1]: Reached target sysinit.target - System Initialization. Oct 9 07:13:03.856196 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Oct 9 07:13:03.857484 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Oct 9 07:13:03.858957 systemd[1]: Started logrotate.timer - Daily rotation of log files. Oct 9 07:13:03.860421 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Oct 9 07:13:03.861740 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Oct 9 07:13:03.863027 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Oct 9 07:13:03.863060 systemd[1]: Reached target paths.target - Path Units. Oct 9 07:13:03.864137 systemd[1]: Reached target timers.target - Timer Units. Oct 9 07:13:03.866028 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Oct 9 07:13:03.868853 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 07:13:03.892468 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Oct 9 07:13:03.896028 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Oct 9 07:13:03.897863 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 07:13:03.899670 systemd[1]: Reached target sockets.target - Socket Units. Oct 9 07:13:03.900916 systemd[1]: Reached target basic.target - Basic System. Oct 9 07:13:03.902396 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Oct 9 07:13:03.902447 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Oct 9 07:13:03.903998 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 07:13:03.907005 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Oct 9 07:13:03.909954 lvm[1373]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Oct 9 07:13:03.911988 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Oct 9 07:13:03.915036 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Oct 9 07:13:03.916293 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). Oct 9 07:13:03.918875 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Oct 9 07:13:03.922589 jq[1376]: false Oct 9 07:13:03.926038 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Oct 9 07:13:03.929030 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Oct 9 07:13:03.961102 systemd[1]: Starting systemd-logind.service - User Login Management... Oct 9 07:13:03.965765 extend-filesystems[1377]: Found loop2 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found loop3 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found sr0 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda1 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda2 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda3 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found usr Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda4 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda6 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda7 Oct 9 07:13:03.980396 extend-filesystems[1377]: Found vda9 Oct 9 07:13:03.980396 extend-filesystems[1377]: Checking size of /dev/vda9 Oct 9 07:13:03.980369 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Oct 9 07:13:03.989116 dbus-daemon[1375]: [system] SELinux support is enabled Oct 9 07:13:03.991092 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Oct 9 07:13:03.994078 systemd[1]: Starting update-engine.service - Update Engine... Oct 9 07:13:03.997410 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Oct 9 07:13:04.015896 systemd[1]: Started dbus.service - D-Bus System Message Bus. Oct 9 07:13:04.016615 extend-filesystems[1377]: Old size kept for /dev/vda9 Oct 9 07:13:04.020241 jq[1394]: true Oct 9 07:13:04.030351 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (1335) Oct 9 07:13:04.026451 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Oct 9 07:13:04.039608 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Oct 9 07:13:04.039979 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Oct 9 07:13:04.040457 systemd[1]: extend-filesystems.service: Deactivated successfully. Oct 9 07:13:04.040749 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Oct 9 07:13:04.043636 systemd[1]: motdgen.service: Deactivated successfully. Oct 9 07:13:04.044196 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Oct 9 07:13:04.048475 update_engine[1393]: I1009 07:13:04.048399 1393 main.cc:92] Flatcar Update Engine starting Oct 9 07:13:04.048502 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Oct 9 07:13:04.048803 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Oct 9 07:13:04.055805 update_engine[1393]: I1009 07:13:04.055773 1393 update_check_scheduler.cc:74] Next update check in 3m16s Oct 9 07:13:04.065028 jq[1399]: true Oct 9 07:13:04.079538 (ntainerd)[1407]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 9 07:13:04.099067 systemd[1]: Started update-engine.service - Update Engine. Oct 9 07:13:04.100927 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). Oct 9 07:13:04.100977 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Oct 9 07:13:04.102657 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). Oct 9 07:13:04.102678 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Oct 9 07:13:04.115025 systemd[1]: Started locksmithd.service - Cluster reboot manager. Oct 9 07:13:04.118482 systemd-logind[1384]: Watching system buttons on /dev/input/event1 (Power Button) Oct 9 07:13:04.118515 systemd-logind[1384]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Oct 9 07:13:04.118755 systemd-logind[1384]: New seat seat0. Oct 9 07:13:04.120218 systemd[1]: Started systemd-logind.service - User Login Management. Oct 9 07:13:04.145893 bash[1425]: Updated "/home/core/.ssh/authorized_keys" Oct 9 07:13:04.147063 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Oct 9 07:13:04.177233 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Oct 9 07:13:04.205464 locksmithd[1424]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Oct 9 07:13:04.483333 sshd_keygen[1391]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Oct 9 07:13:04.565342 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Oct 9 07:13:04.584564 systemd[1]: Starting issuegen.service - Generate /run/issue... Oct 9 07:13:04.593672 systemd[1]: issuegen.service: Deactivated successfully. Oct 9 07:13:04.594007 systemd[1]: Finished issuegen.service - Generate /run/issue. Oct 9 07:13:04.603132 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Oct 9 07:13:04.622120 containerd[1407]: time="2024-10-09T07:13:04.621961414Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 9 07:13:04.625442 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Oct 9 07:13:04.669286 systemd[1]: Started getty@tty1.service - Getty on tty1. Oct 9 07:13:04.671733 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Oct 9 07:13:04.673082 systemd[1]: Reached target getty.target - Login Prompts. Oct 9 07:13:04.681928 containerd[1407]: time="2024-10-09T07:13:04.681881125Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 07:13:04.681977 containerd[1407]: time="2024-10-09T07:13:04.681939184Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.683693 containerd[1407]: time="2024-10-09T07:13:04.683655733Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:04.683693 containerd[1407]: time="2024-10-09T07:13:04.683682223Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684017 containerd[1407]: time="2024-10-09T07:13:04.683991192Z" 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 Oct 9 07:13:04.684017 containerd[1407]: time="2024-10-09T07:13:04.684009757Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 07:13:04.684140 containerd[1407]: time="2024-10-09T07:13:04.684120965Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684210 containerd[1407]: time="2024-10-09T07:13:04.684194563Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684230 containerd[1407]: time="2024-10-09T07:13:04.684209742Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684344 containerd[1407]: time="2024-10-09T07:13:04.684324948Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684615 containerd[1407]: time="2024-10-09T07:13:04.684593652Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684637 containerd[1407]: time="2024-10-09T07:13:04.684615733Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 9 07:13:04.684637 containerd[1407]: time="2024-10-09T07:13:04.684625421Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:04.684765 containerd[1407]: time="2024-10-09T07:13:04.684744605Z" 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 Oct 9 07:13:04.684765 containerd[1407]: time="2024-10-09T07:13:04.684759693Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 07:13:04.684909 containerd[1407]: time="2024-10-09T07:13:04.684889006Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 9 07:13:04.684909 containerd[1407]: time="2024-10-09T07:13:04.684904465Z" level=info msg="metadata content store policy set" policy=shared Oct 9 07:13:04.691261 containerd[1407]: time="2024-10-09T07:13:04.691219377Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 07:13:04.691301 containerd[1407]: time="2024-10-09T07:13:04.691268099Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 07:13:04.691301 containerd[1407]: time="2024-10-09T07:13:04.691284229Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 07:13:04.691360 containerd[1407]: time="2024-10-09T07:13:04.691324034Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 07:13:04.691360 containerd[1407]: time="2024-10-09T07:13:04.691339733Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 07:13:04.691360 containerd[1407]: time="2024-10-09T07:13:04.691354240Z" level=info msg="NRI interface is disabled by configuration." Oct 9 07:13:04.691423 containerd[1407]: time="2024-10-09T07:13:04.691367044Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 07:13:04.691558 containerd[1407]: time="2024-10-09T07:13:04.691533857Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 07:13:04.691594 containerd[1407]: time="2024-10-09T07:13:04.691557722Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 07:13:04.691594 containerd[1407]: time="2024-10-09T07:13:04.691571508Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 07:13:04.691594 containerd[1407]: time="2024-10-09T07:13:04.691591756Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 07:13:04.691654 containerd[1407]: time="2024-10-09T07:13:04.691605401Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691654 containerd[1407]: time="2024-10-09T07:13:04.691622704Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691654 containerd[1407]: time="2024-10-09T07:13:04.691635698Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691654 containerd[1407]: time="2024-10-09T07:13:04.691647420Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691724 containerd[1407]: time="2024-10-09T07:13:04.691660755Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691724 containerd[1407]: time="2024-10-09T07:13:04.691676044Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691724 containerd[1407]: time="2024-10-09T07:13:04.691688447Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.691724 containerd[1407]: time="2024-10-09T07:13:04.691701051Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 07:13:04.691858 containerd[1407]: time="2024-10-09T07:13:04.691821106Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 07:13:04.692125 containerd[1407]: time="2024-10-09T07:13:04.692098045Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 07:13:04.692172 containerd[1407]: time="2024-10-09T07:13:04.692129675Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692172 containerd[1407]: time="2024-10-09T07:13:04.692143841Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 07:13:04.692172 containerd[1407]: time="2024-10-09T07:13:04.692164971Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692235142Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692248788Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692260941Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692272573Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692285276Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692303 containerd[1407]: time="2024-10-09T07:13:04.692298501Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692433 containerd[1407]: time="2024-10-09T07:13:04.692311556Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692433 containerd[1407]: time="2024-10-09T07:13:04.692324310Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692433 containerd[1407]: time="2024-10-09T07:13:04.692338546Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 07:13:04.692549 containerd[1407]: time="2024-10-09T07:13:04.692508836Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692549 containerd[1407]: time="2024-10-09T07:13:04.692544402Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692613 containerd[1407]: time="2024-10-09T07:13:04.692560142Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692613 containerd[1407]: time="2024-10-09T07:13:04.692573667Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692613 containerd[1407]: time="2024-10-09T07:13:04.692586331Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692613 containerd[1407]: time="2024-10-09T07:13:04.692603844Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692723 containerd[1407]: time="2024-10-09T07:13:04.692616407Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.692723 containerd[1407]: time="2024-10-09T07:13:04.692628380Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 07:13:04.693015 containerd[1407]: time="2024-10-09T07:13:04.692955543Z" 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}" Oct 9 07:13:04.693015 containerd[1407]: time="2024-10-09T07:13:04.693013612Z" level=info msg="Connect containerd service" Oct 9 07:13:04.693185 containerd[1407]: time="2024-10-09T07:13:04.693043518Z" level=info msg="using legacy CRI server" Oct 9 07:13:04.693185 containerd[1407]: time="2024-10-09T07:13:04.693050381Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 07:13:04.693185 containerd[1407]: time="2024-10-09T07:13:04.693139388Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 07:13:04.693803 containerd[1407]: time="2024-10-09T07:13:04.693756976Z" 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" Oct 9 07:13:04.693849 containerd[1407]: time="2024-10-09T07:13:04.693816238Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 07:13:04.693888 containerd[1407]: time="2024-10-09T07:13:04.693850672Z" 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 Oct 9 07:13:04.693888 containerd[1407]: time="2024-10-09T07:13:04.693863406Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 07:13:04.693888 containerd[1407]: time="2024-10-09T07:13:04.693876030Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 07:13:04.693989 containerd[1407]: time="2024-10-09T07:13:04.693882842Z" level=info msg="Start subscribing containerd event" Oct 9 07:13:04.693989 containerd[1407]: time="2024-10-09T07:13:04.693946161Z" level=info msg="Start recovering state" Oct 9 07:13:04.694053 containerd[1407]: time="2024-10-09T07:13:04.694032944Z" level=info msg="Start event monitor" Oct 9 07:13:04.694095 containerd[1407]: time="2024-10-09T07:13:04.694066086Z" level=info msg="Start snapshots syncer" Oct 9 07:13:04.694095 containerd[1407]: time="2024-10-09T07:13:04.694076756Z" level=info msg="Start cni network conf syncer for default" Oct 9 07:13:04.694095 containerd[1407]: time="2024-10-09T07:13:04.694088548Z" level=info msg="Start streaming server" Oct 9 07:13:04.694276 containerd[1407]: time="2024-10-09T07:13:04.694230935Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 07:13:04.694399 containerd[1407]: time="2024-10-09T07:13:04.694294034Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 07:13:04.694399 containerd[1407]: time="2024-10-09T07:13:04.694364586Z" level=info msg="containerd successfully booted in 0.073881s" Oct 9 07:13:04.694445 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 07:13:05.499121 systemd-networkd[1327]: eth0: Gained IPv6LL Oct 9 07:13:05.503412 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Oct 9 07:13:05.505603 systemd[1]: Reached target network-online.target - Network is Online. Oct 9 07:13:05.520111 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Oct 9 07:13:05.523088 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Oct 9 07:13:05.565184 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Oct 9 07:13:05.569306 systemd[1]: coreos-metadata.service: Deactivated successfully. Oct 9 07:13:05.569537 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Oct 9 07:13:05.571180 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Oct 9 07:13:05.571313 systemd[1]: Reached target multi-user.target - Multi-User System. Oct 9 07:13:05.573928 systemd[1]: Startup finished in 1.217s (kernel) + 4.227s (initrd) + 5.056s (userspace) = 10.501s. Oct 9 07:13:09.507773 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Oct 9 07:13:09.509007 systemd[1]: Started sshd@0-10.0.0.15:22-10.0.0.1:53522.service - OpenSSH per-connection server daemon (10.0.0.1:53522). Oct 9 07:13:09.556852 sshd[1476]: Accepted publickey for core from 10.0.0.1 port 53522 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:09.558663 sshd[1476]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:09.567666 systemd-logind[1384]: New session 1 of user core. Oct 9 07:13:09.569014 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Oct 9 07:13:09.587041 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Oct 9 07:13:09.599103 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Oct 9 07:13:09.617170 systemd[1]: Starting user@500.service - User Manager for UID 500... Oct 9 07:13:09.620329 (systemd)[1480]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:09.722448 systemd[1480]: Queued start job for default target default.target. Oct 9 07:13:09.734336 systemd[1480]: Created slice app.slice - User Application Slice. Oct 9 07:13:09.734364 systemd[1480]: Reached target paths.target - Paths. Oct 9 07:13:09.734378 systemd[1480]: Reached target timers.target - Timers. Oct 9 07:13:09.735940 systemd[1480]: Starting dbus.socket - D-Bus User Message Bus Socket... Oct 9 07:13:09.748228 systemd[1480]: Listening on dbus.socket - D-Bus User Message Bus Socket. Oct 9 07:13:09.748366 systemd[1480]: Reached target sockets.target - Sockets. Oct 9 07:13:09.748385 systemd[1480]: Reached target basic.target - Basic System. Oct 9 07:13:09.748423 systemd[1480]: Reached target default.target - Main User Target. Oct 9 07:13:09.748458 systemd[1480]: Startup finished in 120ms. Oct 9 07:13:09.748916 systemd[1]: Started user@500.service - User Manager for UID 500. Oct 9 07:13:09.750585 systemd[1]: Started session-1.scope - Session 1 of User core. Oct 9 07:13:09.812604 systemd[1]: Started sshd@1-10.0.0.15:22-10.0.0.1:53534.service - OpenSSH per-connection server daemon (10.0.0.1:53534). Oct 9 07:13:09.848859 sshd[1491]: Accepted publickey for core from 10.0.0.1 port 53534 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:09.850404 sshd[1491]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:09.854550 systemd-logind[1384]: New session 2 of user core. Oct 9 07:13:09.866947 systemd[1]: Started session-2.scope - Session 2 of User core. Oct 9 07:13:09.921032 sshd[1491]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:09.928686 systemd[1]: sshd@1-10.0.0.15:22-10.0.0.1:53534.service: Deactivated successfully. Oct 9 07:13:09.930613 systemd[1]: session-2.scope: Deactivated successfully. Oct 9 07:13:09.932504 systemd-logind[1384]: Session 2 logged out. Waiting for processes to exit. Oct 9 07:13:09.943158 systemd[1]: Started sshd@2-10.0.0.15:22-10.0.0.1:53540.service - OpenSSH per-connection server daemon (10.0.0.1:53540). Oct 9 07:13:09.944092 systemd-logind[1384]: Removed session 2. Oct 9 07:13:09.975721 sshd[1498]: Accepted publickey for core from 10.0.0.1 port 53540 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:09.977220 sshd[1498]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:09.981291 systemd-logind[1384]: New session 3 of user core. Oct 9 07:13:09.993951 systemd[1]: Started session-3.scope - Session 3 of User core. Oct 9 07:13:10.043723 sshd[1498]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:10.056661 systemd[1]: sshd@2-10.0.0.15:22-10.0.0.1:53540.service: Deactivated successfully. Oct 9 07:13:10.058518 systemd[1]: session-3.scope: Deactivated successfully. Oct 9 07:13:10.060218 systemd-logind[1384]: Session 3 logged out. Waiting for processes to exit. Oct 9 07:13:10.061571 systemd[1]: Started sshd@3-10.0.0.15:22-10.0.0.1:53552.service - OpenSSH per-connection server daemon (10.0.0.1:53552). Oct 9 07:13:10.062526 systemd-logind[1384]: Removed session 3. Oct 9 07:13:10.111455 sshd[1505]: Accepted publickey for core from 10.0.0.1 port 53552 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:10.112961 sshd[1505]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:10.116650 systemd-logind[1384]: New session 4 of user core. Oct 9 07:13:10.125949 systemd[1]: Started session-4.scope - Session 4 of User core. Oct 9 07:13:10.181676 sshd[1505]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:10.188564 systemd[1]: sshd@3-10.0.0.15:22-10.0.0.1:53552.service: Deactivated successfully. Oct 9 07:13:10.190414 systemd[1]: session-4.scope: Deactivated successfully. Oct 9 07:13:10.192130 systemd-logind[1384]: Session 4 logged out. Waiting for processes to exit. Oct 9 07:13:10.209094 systemd[1]: Started sshd@4-10.0.0.15:22-10.0.0.1:53568.service - OpenSSH per-connection server daemon (10.0.0.1:53568). Oct 9 07:13:10.209993 systemd-logind[1384]: Removed session 4. Oct 9 07:13:10.240844 sshd[1512]: Accepted publickey for core from 10.0.0.1 port 53568 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:10.242336 sshd[1512]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:10.246486 systemd-logind[1384]: New session 5 of user core. Oct 9 07:13:10.259964 systemd[1]: Started session-5.scope - Session 5 of User core. Oct 9 07:13:10.318178 sudo[1515]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Oct 9 07:13:10.318502 sudo[1515]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 07:13:10.333530 sudo[1515]: pam_unix(sudo:session): session closed for user root Oct 9 07:13:10.336206 sshd[1512]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:10.361000 systemd[1]: sshd@4-10.0.0.15:22-10.0.0.1:53568.service: Deactivated successfully. Oct 9 07:13:10.363083 systemd[1]: session-5.scope: Deactivated successfully. Oct 9 07:13:10.364933 systemd-logind[1384]: Session 5 logged out. Waiting for processes to exit. Oct 9 07:13:10.374281 systemd[1]: Started sshd@5-10.0.0.15:22-10.0.0.1:53576.service - OpenSSH per-connection server daemon (10.0.0.1:53576). Oct 9 07:13:10.375312 systemd-logind[1384]: Removed session 5. Oct 9 07:13:10.406341 sshd[1520]: Accepted publickey for core from 10.0.0.1 port 53576 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:10.407991 sshd[1520]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:10.412117 systemd-logind[1384]: New session 6 of user core. Oct 9 07:13:10.421980 systemd[1]: Started session-6.scope - Session 6 of User core. Oct 9 07:13:10.478290 sudo[1524]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Oct 9 07:13:10.478602 sudo[1524]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 07:13:10.482774 sudo[1524]: pam_unix(sudo:session): session closed for user root Oct 9 07:13:10.489646 sudo[1523]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Oct 9 07:13:10.490034 sudo[1523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 07:13:10.508061 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Oct 9 07:13:10.509887 auditctl[1527]: No rules Oct 9 07:13:10.510478 systemd[1]: audit-rules.service: Deactivated successfully. Oct 9 07:13:10.510743 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Oct 9 07:13:10.513804 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Oct 9 07:13:10.546473 augenrules[1545]: No rules Oct 9 07:13:10.548469 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Oct 9 07:13:10.549959 sudo[1523]: pam_unix(sudo:session): session closed for user root Oct 9 07:13:10.551818 sshd[1520]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:10.571571 systemd[1]: sshd@5-10.0.0.15:22-10.0.0.1:53576.service: Deactivated successfully. Oct 9 07:13:10.573348 systemd[1]: session-6.scope: Deactivated successfully. Oct 9 07:13:10.575005 systemd-logind[1384]: Session 6 logged out. Waiting for processes to exit. Oct 9 07:13:10.585201 systemd[1]: Started sshd@6-10.0.0.15:22-10.0.0.1:57946.service - OpenSSH per-connection server daemon (10.0.0.1:57946). Oct 9 07:13:10.586124 systemd-logind[1384]: Removed session 6. Oct 9 07:13:10.617823 sshd[1553]: Accepted publickey for core from 10.0.0.1 port 57946 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:10.619294 sshd[1553]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:10.623143 systemd-logind[1384]: New session 7 of user core. Oct 9 07:13:10.632961 systemd[1]: Started session-7.scope - Session 7 of User core. Oct 9 07:13:10.701042 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 9 07:13:10.701243 (dockerd)[1557]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 9 07:13:10.953022 dockerd[1557]: time="2024-10-09T07:13:10.952818631Z" level=info msg="Starting up" Oct 9 07:13:11.135490 systemd[1]: var-lib-docker-metacopy\x2dcheck2664333369-merged.mount: Deactivated successfully. Oct 9 07:13:11.166169 dockerd[1557]: time="2024-10-09T07:13:11.166105430Z" level=info msg="Loading containers: start." Oct 9 07:13:11.300857 kernel: Initializing XFRM netlink socket Oct 9 07:13:11.400631 systemd-networkd[1327]: docker0: Link UP Oct 9 07:13:11.427541 dockerd[1557]: time="2024-10-09T07:13:11.427479790Z" level=info msg="Loading containers: done." Oct 9 07:13:11.541004 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3643462427-merged.mount: Deactivated successfully. Oct 9 07:13:11.543536 dockerd[1557]: time="2024-10-09T07:13:11.543499048Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 9 07:13:11.543709 dockerd[1557]: time="2024-10-09T07:13:11.543687832Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Oct 9 07:13:11.543814 dockerd[1557]: time="2024-10-09T07:13:11.543796155Z" level=info msg="Daemon has completed initialization" Oct 9 07:13:11.580727 dockerd[1557]: time="2024-10-09T07:13:11.580663905Z" level=info msg="API listen on /run/docker.sock" Oct 9 07:13:11.580893 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 9 07:13:11.590654 sshd[1553]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:11.606459 systemd[1]: sshd@6-10.0.0.15:22-10.0.0.1:57946.service: Deactivated successfully. Oct 9 07:13:11.609636 systemd[1]: session-7.scope: Deactivated successfully. Oct 9 07:13:11.611426 systemd-logind[1384]: Session 7 logged out. Waiting for processes to exit. Oct 9 07:13:11.624057 systemd[1]: Started sshd@7-10.0.0.15:22-10.0.0.1:57956.service - OpenSSH per-connection server daemon (10.0.0.1:57956). Oct 9 07:13:11.624914 systemd-logind[1384]: Removed session 7. Oct 9 07:13:11.656013 sshd[1685]: Accepted publickey for core from 10.0.0.1 port 57956 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:11.657666 sshd[1685]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:11.661431 systemd-logind[1384]: New session 8 of user core. Oct 9 07:13:11.673987 systemd[1]: Started session-8.scope - Session 8 of User core. Oct 9 07:13:13.053038 systemd[1]: var-lib-docker-overlay2-82f7c31e1d30596fdb8084c2fccc8eb4dd5f6a59d98790f0794d83b22c1a5bd8\x2dinit-merged.mount: Deactivated successfully. Oct 9 07:13:13.093457 kernel: docker0: port 1(vethd9600ad) entered blocking state Oct 9 07:13:13.093583 kernel: docker0: port 1(vethd9600ad) entered disabled state Oct 9 07:13:13.093607 kernel: vethd9600ad: entered allmulticast mode Oct 9 07:13:13.094874 kernel: vethd9600ad: entered promiscuous mode Oct 9 07:13:13.095079 systemd-networkd[1327]: vethd9600ad: Link UP Oct 9 07:13:13.197498 containerd[1407]: time="2024-10-09T07:13:13.197177575Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 9 07:13:13.197498 containerd[1407]: time="2024-10-09T07:13:13.197260591Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:13:13.197498 containerd[1407]: time="2024-10-09T07:13:13.197310014Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 9 07:13:13.197498 containerd[1407]: time="2024-10-09T07:13:13.197327326Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:13:13.219010 systemd[1]: Started docker-d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda.scope - libcontainer container d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda. Oct 9 07:13:13.286869 kernel: eth0: renamed from vethaef4d05 Oct 9 07:13:13.298015 kernel: docker0: port 1(vethd9600ad) entered blocking state Oct 9 07:13:13.298059 kernel: docker0: port 1(vethd9600ad) entered forwarding state Oct 9 07:13:13.298170 systemd-networkd[1327]: vethd9600ad: Gained carrier Oct 9 07:13:13.298529 systemd-networkd[1327]: docker0: Gained carrier Oct 9 07:13:13.302479 systemd-resolved[1288]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 9 07:13:13.341934 sshd[1685]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:13.350110 systemd[1]: sshd@7-10.0.0.15:22-10.0.0.1:57956.service: Deactivated successfully. Oct 9 07:13:13.352543 systemd[1]: session-8.scope: Deactivated successfully. Oct 9 07:13:13.353317 systemd-logind[1384]: Session 8 logged out. Waiting for processes to exit. Oct 9 07:13:13.379308 systemd[1]: Started sshd@8-10.0.0.15:22-10.0.0.1:57962.service - OpenSSH per-connection server daemon (10.0.0.1:57962). Oct 9 07:13:13.380109 systemd-logind[1384]: Removed session 8. Oct 9 07:13:13.415886 sshd[1766]: Accepted publickey for core from 10.0.0.1 port 57962 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:13.417478 sshd[1766]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:13.421701 systemd-logind[1384]: New session 9 of user core. Oct 9 07:13:13.436957 systemd[1]: Started session-9.scope - Session 9 of User core. Oct 9 07:13:13.495961 sshd[1766]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:13.509275 systemd[1]: sshd@8-10.0.0.15:22-10.0.0.1:57962.service: Deactivated successfully. Oct 9 07:13:13.511029 systemd[1]: session-9.scope: Deactivated successfully. Oct 9 07:13:13.511586 systemd-logind[1384]: Session 9 logged out. Waiting for processes to exit. Oct 9 07:13:13.534084 systemd[1]: Started sshd@9-10.0.0.15:22-10.0.0.1:57972.service - OpenSSH per-connection server daemon (10.0.0.1:57972). Oct 9 07:13:13.535095 systemd-logind[1384]: Removed session 9. Oct 9 07:13:13.568457 sshd[1773]: Accepted publickey for core from 10.0.0.1 port 57972 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:13.569974 sshd[1773]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:13.574111 systemd-logind[1384]: New session 10 of user core. Oct 9 07:13:13.583931 systemd[1]: Started session-10.scope - Session 10 of User core. Oct 9 07:13:13.640608 sudo[1776]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGTERM 1407 Oct 9 07:13:13.641213 sudo[1776]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 07:13:13.644735 sudo[1776]: pam_unix(sudo:session): session closed for user root Oct 9 07:13:13.644986 containerd[1407]: time="2024-10-09T07:13:13.644800228Z" level=info msg="Stop CRI service" Oct 9 07:13:13.645124 dockerd[1557]: time="2024-10-09T07:13:13.645050447Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 9 07:13:13.645124 dockerd[1557]: time="2024-10-09T07:13:13.645118354Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 9 07:13:13.645417 dockerd[1557]: time="2024-10-09T07:13:13.645089811Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 9 07:13:13.645417 dockerd[1557]: time="2024-10-09T07:13:13.645159131Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 9 07:13:13.646653 sshd[1773]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:13.651008 containerd[1407]: time="2024-10-09T07:13:13.650931255Z" level=info msg="Stop CRI service" Oct 9 07:13:13.651008 containerd[1407]: time="2024-10-09T07:13:13.651003992Z" level=info msg="Event monitor stopped" Oct 9 07:13:13.651008 containerd[1407]: time="2024-10-09T07:13:13.651012007Z" level=info msg="Stream server stopped" Oct 9 07:13:13.658795 systemd[1]: containerd.service: Deactivated successfully. Oct 9 07:13:13.658908 systemd[1]: containerd.service: Unit process 1718 (containerd-shim) remains running after unit stopped. Oct 9 07:13:13.659889 systemd[1]: sshd@9-10.0.0.15:22-10.0.0.1:57972.service: Deactivated successfully. Oct 9 07:13:13.662056 systemd[1]: session-10.scope: Deactivated successfully. Oct 9 07:13:13.662730 systemd-logind[1384]: Session 10 logged out. Waiting for processes to exit. Oct 9 07:13:13.678118 systemd[1]: Started sshd@10-10.0.0.15:22-10.0.0.1:57978.service - OpenSSH per-connection server daemon (10.0.0.1:57978). Oct 9 07:13:13.678781 systemd-logind[1384]: Removed session 10. Oct 9 07:13:13.712638 sshd[1783]: Accepted publickey for core from 10.0.0.1 port 57978 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:13.714560 sshd[1783]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:13.719002 systemd-logind[1384]: New session 11 of user core. Oct 9 07:13:13.726009 systemd[1]: Started session-11.scope - Session 11 of User core. Oct 9 07:13:13.783201 sshd[1783]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:13.788370 systemd[1]: sshd@10-10.0.0.15:22-10.0.0.1:57978.service: Deactivated successfully. Oct 9 07:13:13.790880 systemd[1]: session-11.scope: Deactivated successfully. Oct 9 07:13:13.791544 systemd-logind[1384]: Session 11 logged out. Waiting for processes to exit. Oct 9 07:13:13.792357 systemd-logind[1384]: Removed session 11. Oct 9 07:13:14.907117 systemd-networkd[1327]: vethd9600ad: Gained IPv6LL Oct 9 07:13:15.227057 systemd-networkd[1327]: docker0: Gained IPv6LL Oct 9 07:13:18.904913 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Oct 9 07:13:18.905593 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 9 07:13:18.905812 dockerd[1557]: time="2024-10-09T07:13:18.905631755Z" level=info msg="Processing signal 'terminated'" Oct 9 07:13:19.795126 systemd[1]: Started sshd@11-10.0.0.15:22-10.0.0.1:57982.service - OpenSSH per-connection server daemon (10.0.0.1:57982). Oct 9 07:13:19.837511 sshd[1790]: Accepted publickey for core from 10.0.0.1 port 57982 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:19.839437 sshd[1790]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:19.844386 systemd-logind[1384]: New session 12 of user core. Oct 9 07:13:19.862136 systemd[1]: Started session-12.scope - Session 12 of User core. Oct 9 07:13:19.920483 sshd[1790]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:19.925235 systemd[1]: sshd@11-10.0.0.15:22-10.0.0.1:57982.service: Deactivated successfully. Oct 9 07:13:19.928632 systemd[1]: session-12.scope: Deactivated successfully. Oct 9 07:13:19.929257 systemd-logind[1384]: Session 12 logged out. Waiting for processes to exit. Oct 9 07:13:19.930818 systemd-logind[1384]: Removed session 12. Oct 9 07:13:23.328478 dockerd[1557]: time="2024-10-09T07:13:23.328337456Z" level=error msg="Error sending stop (signal 15) to container" container=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda error="Cannot kill container d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda: connection error: desc = \"transport: Error while dialing dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Oct 9 07:13:23.328478 dockerd[1557]: time="2024-10-09T07:13:23.328456780Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda Oct 9 07:13:25.936943 systemd[1]: Started sshd@12-10.0.0.15:22-10.0.0.1:42706.service - OpenSSH per-connection server daemon (10.0.0.1:42706). Oct 9 07:13:25.978317 sshd[1797]: Accepted publickey for core from 10.0.0.1 port 42706 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:25.979945 sshd[1797]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:25.984171 systemd-logind[1384]: New session 13 of user core. Oct 9 07:13:25.999998 systemd[1]: Started session-13.scope - Session 13 of User core. Oct 9 07:13:26.057301 sshd[1797]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:26.062545 systemd[1]: sshd@12-10.0.0.15:22-10.0.0.1:42706.service: Deactivated successfully. Oct 9 07:13:26.065215 systemd[1]: session-13.scope: Deactivated successfully. Oct 9 07:13:26.065875 systemd-logind[1384]: Session 13 logged out. Waiting for processes to exit. Oct 9 07:13:26.066732 systemd-logind[1384]: Removed session 13. Oct 9 07:13:32.068797 systemd[1]: Started sshd@13-10.0.0.15:22-10.0.0.1:37986.service - OpenSSH per-connection server daemon (10.0.0.1:37986). Oct 9 07:13:32.106372 sshd[1804]: Accepted publickey for core from 10.0.0.1 port 37986 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:32.108227 sshd[1804]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:32.112281 systemd-logind[1384]: New session 14 of user core. Oct 9 07:13:32.121983 systemd[1]: Started session-14.scope - Session 14 of User core. Oct 9 07:13:32.179590 sshd[1804]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:32.183851 systemd[1]: sshd@13-10.0.0.15:22-10.0.0.1:37986.service: Deactivated successfully. Oct 9 07:13:32.185927 systemd[1]: session-14.scope: Deactivated successfully. Oct 9 07:13:32.186522 systemd-logind[1384]: Session 14 logged out. Waiting for processes to exit. Oct 9 07:13:32.187623 systemd-logind[1384]: Removed session 14. Oct 9 07:13:33.329472 dockerd[1557]: time="2024-10-09T07:13:33.329392945Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda error="context deadline exceeded" Oct 9 07:13:33.330288 systemd[1]: docker-d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda.scope: Deactivated successfully. Oct 9 07:13:33.907008 dockerd[1557]: time="2024-10-09T07:13:33.906919794Z" level=error msg="Force shutdown daemon" Oct 9 07:13:33.907008 dockerd[1557]: time="2024-10-09T07:13:33.906984185Z" level=info msg="Daemon shutdown complete" Oct 9 07:13:33.915614 systemd[1]: docker.service: Deactivated successfully. Oct 9 07:13:33.916079 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 9 07:13:33.916158 systemd[1]: docker.service: Consumed 1.470s CPU time. Oct 9 07:13:33.916870 systemd[1]: docker.socket: Deactivated successfully. Oct 9 07:13:33.917272 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 9 07:13:33.917320 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 9 07:13:33.919558 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 07:13:33.925182 systemd[1]: containerd.service: Found left-over process 1718 (containerd-shim) in control group while starting unit. Ignoring. Oct 9 07:13:33.925192 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 9 07:13:33.926324 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 07:13:33.926638 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 07:13:33.944861 systemd[1]: containerd.service: Found left-over process 1718 (containerd-shim) in control group while starting unit. Ignoring. Oct 9 07:13:33.944874 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 9 07:13:33.951145 (ntainerd)[1816]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 9 07:13:33.975339 containerd[1816]: time="2024-10-09T07:13:33.975246672Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 9 07:13:34.003096 containerd[1816]: time="2024-10-09T07:13:34.003022201Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 07:13:34.003096 containerd[1816]: time="2024-10-09T07:13:34.003090689Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005146 containerd[1816]: time="2024-10-09T07:13:34.005103664Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005146 containerd[1816]: time="2024-10-09T07:13:34.005134712Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005382 containerd[1816]: time="2024-10-09T07:13:34.005354825Z" 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 Oct 9 07:13:34.005382 containerd[1816]: time="2024-10-09T07:13:34.005372498Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 07:13:34.005443 containerd[1816]: time="2024-10-09T07:13:34.005394309Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005443 containerd[1816]: time="2024-10-09T07:13:34.005415108Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005443 containerd[1816]: time="2024-10-09T07:13:34.005425237Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005539 containerd[1816]: time="2024-10-09T07:13:34.005447128Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005607 containerd[1816]: time="2024-10-09T07:13:34.005587912Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005646 containerd[1816]: time="2024-10-09T07:13:34.005605936Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 9 07:13:34.005646 containerd[1816]: time="2024-10-09T07:13:34.005615825Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:34.005785 containerd[1816]: time="2024-10-09T07:13:34.005763522Z" 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 Oct 9 07:13:34.005785 containerd[1816]: time="2024-10-09T07:13:34.005781445Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 07:13:34.005880 containerd[1816]: time="2024-10-09T07:13:34.005801182Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 9 07:13:34.005880 containerd[1816]: time="2024-10-09T07:13:34.005812413Z" level=info msg="metadata content store policy set" policy=shared Oct 9 07:13:34.006023 containerd[1816]: time="2024-10-09T07:13:34.006003061Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 07:13:34.006073 containerd[1816]: time="2024-10-09T07:13:34.006027707Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 07:13:34.006073 containerd[1816]: time="2024-10-09T07:13:34.006041212Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 07:13:34.006073 containerd[1816]: time="2024-10-09T07:13:34.006065809Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 07:13:34.006170 containerd[1816]: time="2024-10-09T07:13:34.006079574Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 07:13:34.006170 containerd[1816]: time="2024-10-09T07:13:34.006091998Z" level=info msg="NRI interface is disabled by configuration." Oct 9 07:13:34.006170 containerd[1816]: time="2024-10-09T07:13:34.006104311Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 07:13:34.017601 containerd[1816]: time="2024-10-09T07:13:34.017574201Z" level=info msg="cleaning leaked shim process" id=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda namespace=moby Oct 9 07:13:34.029052 containerd[1816]: time="2024-10-09T07:13:34.028956677Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Oct 9 07:13:34.029367 containerd[1816]: time="2024-10-09T07:13:34.029265005Z" level=info msg="shim disconnected" id=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda namespace=moby Oct 9 07:13:34.029433 containerd[1816]: time="2024-10-09T07:13:34.029369922Z" level=warning msg="cleaning up after shim disconnected" id=d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda namespace=moby Oct 9 07:13:34.029433 containerd[1816]: time="2024-10-09T07:13:34.029383297Z" level=info msg="cleaning up dead shim" namespace=moby Oct 9 07:13:34.045024 containerd[1816]: time="2024-10-09T07:13:34.044967914Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 07:13:34.045024 containerd[1816]: time="2024-10-09T07:13:34.045005975Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 07:13:34.045024 containerd[1816]: time="2024-10-09T07:13:34.045019961Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 07:13:34.045024 containerd[1816]: time="2024-10-09T07:13:34.045041893Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045057853Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045076137Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045089412Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045101424Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045118887Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045133384Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045145537Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045157429Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 07:13:34.045337 containerd[1816]: time="2024-10-09T07:13:34.045215268Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 07:13:34.045618 containerd[1816]: time="2024-10-09T07:13:34.045577257Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 07:13:34.045656 containerd[1816]: time="2024-10-09T07:13:34.045637880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045678 containerd[1816]: time="2024-10-09T07:13:34.045664590Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 07:13:34.045705 containerd[1816]: time="2024-10-09T07:13:34.045695899Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 07:13:34.045795 containerd[1816]: time="2024-10-09T07:13:34.045778203Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045821 containerd[1816]: time="2024-10-09T07:13:34.045795646Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045821 containerd[1816]: time="2024-10-09T07:13:34.045808560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045888 containerd[1816]: time="2024-10-09T07:13:34.045820022Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045914 containerd[1816]: time="2024-10-09T07:13:34.045890915Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045914 containerd[1816]: time="2024-10-09T07:13:34.045904741Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045958 containerd[1816]: time="2024-10-09T07:13:34.045916813Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045958 containerd[1816]: time="2024-10-09T07:13:34.045928956Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.045958 containerd[1816]: time="2024-10-09T07:13:34.045942862Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 07:13:34.046024 containerd[1816]: time="2024-10-09T07:13:34.045981535Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046024 containerd[1816]: time="2024-10-09T07:13:34.045994750Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046024 containerd[1816]: time="2024-10-09T07:13:34.046007794Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046024 containerd[1816]: time="2024-10-09T07:13:34.046019326Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046107 containerd[1816]: time="2024-10-09T07:13:34.046032150Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046107 containerd[1816]: time="2024-10-09T07:13:34.046046607Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046107 containerd[1816]: time="2024-10-09T07:13:34.046058319Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046107 containerd[1816]: time="2024-10-09T07:13:34.046069400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 07:13:34.046336 containerd[1816]: time="2024-10-09T07:13:34.046277470Z" 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}" Oct 9 07:13:34.046336 containerd[1816]: time="2024-10-09T07:13:34.046334427Z" level=info msg="Connect containerd service" Oct 9 07:13:34.046476 containerd[1816]: time="2024-10-09T07:13:34.046366366Z" level=info msg="using legacy CRI server" Oct 9 07:13:34.046476 containerd[1816]: time="2024-10-09T07:13:34.046374482Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 07:13:34.046476 containerd[1816]: time="2024-10-09T07:13:34.046462427Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 07:13:34.047068 containerd[1816]: time="2024-10-09T07:13:34.047033508Z" 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" Oct 9 07:13:34.047105 containerd[1816]: time="2024-10-09T07:13:34.047080396Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 07:13:34.047141 containerd[1816]: time="2024-10-09T07:13:34.047104561Z" 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 Oct 9 07:13:34.047141 containerd[1816]: time="2024-10-09T07:13:34.047119218Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 07:13:34.047141 containerd[1816]: time="2024-10-09T07:13:34.047135459Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 07:13:34.047209 containerd[1816]: time="2024-10-09T07:13:34.047172879Z" level=info msg="Start subscribing containerd event" Oct 9 07:13:34.047251 containerd[1816]: time="2024-10-09T07:13:34.047232861Z" level=info msg="Start recovering state" Oct 9 07:13:34.047342 containerd[1816]: time="2024-10-09T07:13:34.047320015Z" level=info msg="Start event monitor" Oct 9 07:13:34.047371 containerd[1816]: time="2024-10-09T07:13:34.047347166Z" level=info msg="Start snapshots syncer" Oct 9 07:13:34.047371 containerd[1816]: time="2024-10-09T07:13:34.047364909Z" level=info msg="Start cni network conf syncer for default" Oct 9 07:13:34.047414 containerd[1816]: time="2024-10-09T07:13:34.047379196Z" level=info msg="Start streaming server" Oct 9 07:13:34.047544 containerd[1816]: time="2024-10-09T07:13:34.047515081Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 07:13:34.047600 containerd[1816]: time="2024-10-09T07:13:34.047583950Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 07:13:34.047709 containerd[1816]: time="2024-10-09T07:13:34.047667006Z" level=info msg="containerd successfully booted in 0.073145s" Oct 9 07:13:34.047791 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 07:13:34.053180 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 9 07:13:34.056538 (dockerd)[1850]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 9 07:13:34.105918 dockerd[1850]: time="2024-10-09T07:13:34.105855640Z" level=info msg="Starting up" Oct 9 07:13:34.126818 dockerd[1850]: time="2024-10-09T07:13:34.126774771Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 9 07:13:34.150567 dockerd[1850]: time="2024-10-09T07:13:34.150515824Z" level=info msg="Loading containers: start." Oct 9 07:13:34.167306 systemd[1]: var-lib-docker-overlay2-82f7c31e1d30596fdb8084c2fccc8eb4dd5f6a59d98790f0794d83b22c1a5bd8-merged.mount: Deactivated successfully. Oct 9 07:13:34.355729 dockerd[1850]: time="2024-10-09T07:13:34.355673217Z" level=info msg="Removing stale sandbox c1a089f81491a74a6b5663118f27cdbbb87d4b9047cfeeff4f87f8eaaca850cb (d699b7433b8d0ab4ee79b3b63aca501253a21c7a9b3d78481e7f043c3a387fda)" Oct 9 07:13:34.361124 systemd-networkd[1327]: vethd9600ad: Link DOWN Oct 9 07:13:34.364985 kernel: docker0: port 1(vethd9600ad) entered disabled state Oct 9 07:13:34.361135 systemd-networkd[1327]: vethd9600ad: Lost carrier Oct 9 07:13:34.367298 kernel: vethd9600ad (unregistering): left allmulticast mode Oct 9 07:13:34.367333 kernel: vethd9600ad (unregistering): left promiscuous mode Oct 9 07:13:34.367356 kernel: docker0: port 1(vethd9600ad) entered disabled state Oct 9 07:13:34.382400 systemd-networkd[1327]: docker0: Lost carrier Oct 9 07:13:34.407096 dockerd[1850]: time="2024-10-09T07:13:34.407056760Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 603609efbef0dceb551c7b885153bbb45cf9e4e8ec8812303e798af5320e956d 28eaf714ca484d8c5125b7deb44ea91200f9c31567b62afb9a9c4628aa351f37], retrying...." Oct 9 07:13:34.696809 dockerd[1850]: time="2024-10-09T07:13:34.696755598Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Oct 9 07:13:34.787869 dockerd[1850]: time="2024-10-09T07:13:34.787805289Z" level=info msg="Loading containers: done." Oct 9 07:13:34.802030 dockerd[1850]: time="2024-10-09T07:13:34.801988498Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 9 07:13:34.802216 dockerd[1850]: time="2024-10-09T07:13:34.802193442Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Oct 9 07:13:34.802252 dockerd[1850]: time="2024-10-09T07:13:34.802241051Z" level=info msg="Daemon has completed initialization" Oct 9 07:13:34.822579 dockerd[1850]: time="2024-10-09T07:13:34.822496007Z" level=info msg="API listen on /run/docker.sock" Oct 9 07:13:34.822707 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 9 07:13:35.115442 systemd[1]: run-docker-netns-c1a089f81491.mount: Deactivated successfully. Oct 9 07:13:38.195013 systemd[1]: Started sshd@14-10.0.0.15:22-10.0.0.1:37988.service - OpenSSH per-connection server daemon (10.0.0.1:37988). Oct 9 07:13:38.233215 sshd[1990]: Accepted publickey for core from 10.0.0.1 port 37988 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:38.234698 sshd[1990]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:38.238556 systemd-logind[1384]: New session 15 of user core. Oct 9 07:13:38.247958 systemd[1]: Started session-15.scope - Session 15 of User core. Oct 9 07:13:38.304448 sshd[1990]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:38.316675 systemd[1]: sshd@14-10.0.0.15:22-10.0.0.1:37988.service: Deactivated successfully. Oct 9 07:13:38.318473 systemd[1]: session-15.scope: Deactivated successfully. Oct 9 07:13:38.320027 systemd-logind[1384]: Session 15 logged out. Waiting for processes to exit. Oct 9 07:13:38.335321 systemd[1]: Started sshd@15-10.0.0.15:22-10.0.0.1:37990.service - OpenSSH per-connection server daemon (10.0.0.1:37990). Oct 9 07:13:38.336465 systemd-logind[1384]: Removed session 15. Oct 9 07:13:38.369067 sshd[1997]: Accepted publickey for core from 10.0.0.1 port 37990 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:38.370586 sshd[1997]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:38.374397 systemd-logind[1384]: New session 16 of user core. Oct 9 07:13:38.383955 systemd[1]: Started session-16.scope - Session 16 of User core. Oct 9 07:13:38.440457 sshd[1997]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:38.447527 systemd[1]: sshd@15-10.0.0.15:22-10.0.0.1:37990.service: Deactivated successfully. Oct 9 07:13:38.449380 systemd[1]: session-16.scope: Deactivated successfully. Oct 9 07:13:38.450797 systemd-logind[1384]: Session 16 logged out. Waiting for processes to exit. Oct 9 07:13:38.461156 systemd[1]: Started sshd@16-10.0.0.15:22-10.0.0.1:38004.service - OpenSSH per-connection server daemon (10.0.0.1:38004). Oct 9 07:13:38.462090 systemd-logind[1384]: Removed session 16. Oct 9 07:13:38.494257 sshd[2004]: Accepted publickey for core from 10.0.0.1 port 38004 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:38.495750 sshd[2004]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:38.499867 systemd-logind[1384]: New session 17 of user core. Oct 9 07:13:38.507971 systemd[1]: Started session-17.scope - Session 17 of User core. Oct 9 07:13:38.569723 sshd[2004]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:38.585986 systemd[1]: sshd@16-10.0.0.15:22-10.0.0.1:38004.service: Deactivated successfully. Oct 9 07:13:38.588198 systemd[1]: session-17.scope: Deactivated successfully. Oct 9 07:13:38.590178 systemd-logind[1384]: Session 17 logged out. Waiting for processes to exit. Oct 9 07:13:38.599146 systemd[1]: Started sshd@17-10.0.0.15:22-10.0.0.1:38020.service - OpenSSH per-connection server daemon (10.0.0.1:38020). Oct 9 07:13:38.600242 systemd-logind[1384]: Removed session 17. Oct 9 07:13:38.631776 sshd[2018]: Accepted publickey for core from 10.0.0.1 port 38020 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:38.633341 sshd[2018]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:38.638276 systemd-logind[1384]: New session 18 of user core. Oct 9 07:13:38.645979 systemd[1]: Started session-18.scope - Session 18 of User core. Oct 9 07:13:38.723768 systemd[1]: var-lib-docker-overlay2-36b14228530ab95acc96d77fa2d30de6799689e36012efab5f58e70e95475604\x2dinit-merged.mount: Deactivated successfully. Oct 9 07:13:38.750369 kernel: docker0: port 1(veth0b4f09e) entered blocking state Oct 9 07:13:38.750529 kernel: docker0: port 1(veth0b4f09e) entered disabled state Oct 9 07:13:38.750557 kernel: veth0b4f09e: entered allmulticast mode Oct 9 07:13:38.751878 kernel: veth0b4f09e: entered promiscuous mode Oct 9 07:13:38.752393 systemd-networkd[1327]: veth0b4f09e: Link UP Oct 9 07:13:38.791545 containerd[1816]: time="2024-10-09T07:13:38.791390490Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 9 07:13:38.791545 containerd[1816]: time="2024-10-09T07:13:38.791456155Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:13:38.791545 containerd[1816]: time="2024-10-09T07:13:38.791472096Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 9 07:13:38.791545 containerd[1816]: time="2024-10-09T07:13:38.791481425Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:13:38.813114 systemd[1]: Started docker-90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2.scope - libcontainer container 90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2. Oct 9 07:13:38.889864 kernel: eth0: renamed from veth4695d03 Oct 9 07:13:38.896859 kernel: docker0: port 1(veth0b4f09e) entered blocking state Oct 9 07:13:38.896898 kernel: docker0: port 1(veth0b4f09e) entered forwarding state Oct 9 07:13:38.896690 systemd-networkd[1327]: veth0b4f09e: Gained carrier Oct 9 07:13:38.897062 systemd-networkd[1327]: docker0: Gained carrier Oct 9 07:13:38.901612 systemd-resolved[1288]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 9 07:13:38.937930 sshd[2018]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:38.948627 systemd[1]: sshd@17-10.0.0.15:22-10.0.0.1:38020.service: Deactivated successfully. Oct 9 07:13:38.951218 systemd[1]: session-18.scope: Deactivated successfully. Oct 9 07:13:38.951984 systemd-logind[1384]: Session 18 logged out. Waiting for processes to exit. Oct 9 07:13:38.968245 systemd[1]: Started sshd@18-10.0.0.15:22-10.0.0.1:38032.service - OpenSSH per-connection server daemon (10.0.0.1:38032). Oct 9 07:13:38.968981 systemd-logind[1384]: Removed session 18. Oct 9 07:13:39.002424 sshd[2095]: Accepted publickey for core from 10.0.0.1 port 38032 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:39.004180 sshd[2095]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:39.009173 systemd-logind[1384]: New session 19 of user core. Oct 9 07:13:39.020032 systemd[1]: Started session-19.scope - Session 19 of User core. Oct 9 07:13:39.078678 sshd[2095]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:39.096819 systemd[1]: sshd@18-10.0.0.15:22-10.0.0.1:38032.service: Deactivated successfully. Oct 9 07:13:39.099058 systemd[1]: session-19.scope: Deactivated successfully. Oct 9 07:13:39.099689 systemd-logind[1384]: Session 19 logged out. Waiting for processes to exit. Oct 9 07:13:39.119080 systemd[1]: Started sshd@19-10.0.0.15:22-10.0.0.1:38040.service - OpenSSH per-connection server daemon (10.0.0.1:38040). Oct 9 07:13:39.119627 systemd-logind[1384]: Removed session 19. Oct 9 07:13:39.152565 sshd[2102]: Accepted publickey for core from 10.0.0.1 port 38040 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:39.154242 sshd[2102]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:39.158372 systemd-logind[1384]: New session 20 of user core. Oct 9 07:13:39.173941 systemd[1]: Started session-20.scope - Session 20 of User core. Oct 9 07:13:39.228187 sudo[2105]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGHUP 1816 Oct 9 07:13:39.228510 sudo[2105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Oct 9 07:13:39.232037 sudo[2105]: pam_unix(sudo:session): session closed for user root Oct 9 07:13:39.233796 sshd[2102]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:39.237018 dockerd[1850]: time="2024-10-09T07:13:39.236921361Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Oct 9 07:13:39.237018 dockerd[1850]: time="2024-10-09T07:13:39.236957590Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Oct 9 07:13:39.239084 dockerd[1850]: time="2024-10-09T07:13:39.236931029Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Oct 9 07:13:39.239084 dockerd[1850]: time="2024-10-09T07:13:39.237076377Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Oct 9 07:13:39.241378 systemd[1]: sshd@19-10.0.0.15:22-10.0.0.1:38040.service: Deactivated successfully. Oct 9 07:13:39.243349 systemd[1]: containerd.service: Deactivated successfully. Oct 9 07:13:39.243429 systemd[1]: containerd.service: Unit process 2048 (containerd-shim) remains running after unit stopped. Oct 9 07:13:39.244087 systemd[1]: session-20.scope: Deactivated successfully. Oct 9 07:13:39.244637 systemd-logind[1384]: Session 20 logged out. Waiting for processes to exit. Oct 9 07:13:39.248232 systemd[1]: Started sshd@20-10.0.0.15:22-10.0.0.1:38042.service - OpenSSH per-connection server daemon (10.0.0.1:38042). Oct 9 07:13:39.248786 systemd-logind[1384]: Removed session 20. Oct 9 07:13:39.286194 sshd[2111]: Accepted publickey for core from 10.0.0.1 port 38042 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:39.287741 sshd[2111]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:39.291883 systemd-logind[1384]: New session 21 of user core. Oct 9 07:13:39.302954 systemd[1]: Started session-21.scope - Session 21 of User core. Oct 9 07:13:39.360300 sshd[2111]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:39.364325 systemd[1]: sshd@20-10.0.0.15:22-10.0.0.1:38042.service: Deactivated successfully. Oct 9 07:13:39.366365 systemd[1]: session-21.scope: Deactivated successfully. Oct 9 07:13:39.367024 systemd-logind[1384]: Session 21 logged out. Waiting for processes to exit. Oct 9 07:13:39.367918 systemd-logind[1384]: Removed session 21. Oct 9 07:13:40.763148 systemd-networkd[1327]: veth0b4f09e: Gained IPv6LL Oct 9 07:13:44.405034 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Oct 9 07:13:44.405694 systemd[1]: Stopping docker.service - Docker Application Container Engine... Oct 9 07:13:44.405933 dockerd[1850]: time="2024-10-09T07:13:44.405865770Z" level=info msg="Processing signal 'terminated'" Oct 9 07:13:45.371600 systemd[1]: Started sshd@21-10.0.0.15:22-10.0.0.1:34514.service - OpenSSH per-connection server daemon (10.0.0.1:34514). Oct 9 07:13:45.409247 sshd[2118]: Accepted publickey for core from 10.0.0.1 port 34514 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:45.410979 sshd[2118]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:45.415326 systemd-logind[1384]: New session 22 of user core. Oct 9 07:13:45.424978 systemd[1]: Started session-22.scope - Session 22 of User core. Oct 9 07:13:45.482133 sshd[2118]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:45.485738 systemd[1]: sshd@21-10.0.0.15:22-10.0.0.1:34514.service: Deactivated successfully. Oct 9 07:13:45.487661 systemd[1]: session-22.scope: Deactivated successfully. Oct 9 07:13:45.488293 systemd-logind[1384]: Session 22 logged out. Waiting for processes to exit. Oct 9 07:13:45.489254 systemd-logind[1384]: Removed session 22. Oct 9 07:13:46.407200 dockerd[1850]: time="2024-10-09T07:13:46.407013246Z" level=error msg="Error sending stop (signal 15) to container" container=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 error="Cannot kill container 90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2: connection error: desc = \"transport: Error while dialing dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Oct 9 07:13:46.407200 dockerd[1850]: time="2024-10-09T07:13:46.407180614Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 Oct 9 07:13:49.076954 update_engine[1393]: I1009 07:13:49.076774 1393 update_attempter.cc:509] Updating boot flags... Oct 9 07:13:49.110878 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2131) Oct 9 07:13:49.151875 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2130) Oct 9 07:13:49.177862 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 34 scanned by (udev-worker) (2130) Oct 9 07:13:51.499365 systemd[1]: Started sshd@22-10.0.0.15:22-10.0.0.1:55084.service - OpenSSH per-connection server daemon (10.0.0.1:55084). Oct 9 07:13:51.544028 sshd[2140]: Accepted publickey for core from 10.0.0.1 port 55084 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:51.546172 sshd[2140]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:51.550671 systemd-logind[1384]: New session 23 of user core. Oct 9 07:13:51.565131 systemd[1]: Started session-23.scope - Session 23 of User core. Oct 9 07:13:51.624637 sshd[2140]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:51.628687 systemd[1]: sshd@22-10.0.0.15:22-10.0.0.1:55084.service: Deactivated successfully. Oct 9 07:13:51.630821 systemd[1]: session-23.scope: Deactivated successfully. Oct 9 07:13:51.631469 systemd-logind[1384]: Session 23 logged out. Waiting for processes to exit. Oct 9 07:13:51.632689 systemd-logind[1384]: Removed session 23. Oct 9 07:13:56.408081 dockerd[1850]: time="2024-10-09T07:13:56.407976974Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 error="context deadline exceeded" Oct 9 07:13:56.409071 systemd[1]: docker-90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2.scope: Deactivated successfully. Oct 9 07:13:57.637513 systemd[1]: Started sshd@23-10.0.0.15:22-10.0.0.1:55086.service - OpenSSH per-connection server daemon (10.0.0.1:55086). Oct 9 07:13:57.675667 sshd[2147]: Accepted publickey for core from 10.0.0.1 port 55086 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:13:57.677029 sshd[2147]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:13:57.682094 systemd-logind[1384]: New session 24 of user core. Oct 9 07:13:57.694141 systemd[1]: Started session-24.scope - Session 24 of User core. Oct 9 07:13:57.755696 sshd[2147]: pam_unix(sshd:session): session closed for user core Oct 9 07:13:57.760522 systemd[1]: sshd@23-10.0.0.15:22-10.0.0.1:55086.service: Deactivated successfully. Oct 9 07:13:57.762811 systemd[1]: session-24.scope: Deactivated successfully. Oct 9 07:13:57.763679 systemd-logind[1384]: Session 24 logged out. Waiting for processes to exit. Oct 9 07:13:57.765303 systemd-logind[1384]: Removed session 24. Oct 9 07:13:59.406805 dockerd[1850]: time="2024-10-09T07:13:59.406707035Z" level=error msg="Force shutdown daemon" Oct 9 07:13:59.406805 dockerd[1850]: time="2024-10-09T07:13:59.406774883Z" level=info msg="Daemon shutdown complete" Oct 9 07:13:59.414868 systemd[1]: docker.service: Deactivated successfully. Oct 9 07:13:59.415324 systemd[1]: Stopped docker.service - Docker Application Container Engine. Oct 9 07:13:59.416139 systemd[1]: docker.socket: Deactivated successfully. Oct 9 07:13:59.416549 systemd[1]: Closed docker.socket - Docker Socket for the API. Oct 9 07:13:59.416633 systemd[1]: Stopping docker.socket - Docker Socket for the API... Oct 9 07:13:59.419302 systemd[1]: Starting docker.socket - Docker Socket for the API... Oct 9 07:13:59.434168 systemd[1]: containerd.service: Found left-over process 2048 (containerd-shim) in control group while starting unit. Ignoring. Oct 9 07:13:59.434180 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 9 07:13:59.436023 systemd[1]: Starting containerd.service - containerd container runtime... Oct 9 07:13:59.436478 systemd[1]: Listening on docker.socket - Docker Socket for the API. Oct 9 07:13:59.454362 systemd[1]: containerd.service: Found left-over process 2048 (containerd-shim) in control group while starting unit. Ignoring. Oct 9 07:13:59.454377 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Oct 9 07:13:59.461936 (ntainerd)[2159]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Oct 9 07:13:59.487797 containerd[2159]: time="2024-10-09T07:13:59.487694321Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Oct 9 07:13:59.517354 containerd[2159]: time="2024-10-09T07:13:59.517253335Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Oct 9 07:13:59.517354 containerd[2159]: time="2024-10-09T07:13:59.517323929Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.519768 containerd[2159]: time="2024-10-09T07:13:59.519717084Z" 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.54-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:59.519768 containerd[2159]: time="2024-10-09T07:13:59.519755646Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520076 containerd[2159]: time="2024-10-09T07:13:59.520039421Z" 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 Oct 9 07:13:59.520076 containerd[2159]: time="2024-10-09T07:13:59.520065932Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Oct 9 07:13:59.520158 containerd[2159]: time="2024-10-09T07:13:59.520095627Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520158 containerd[2159]: time="2024-10-09T07:13:59.520121957Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520158 containerd[2159]: time="2024-10-09T07:13:59.520134430Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520243 containerd[2159]: time="2024-10-09T07:13:59.520163856Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520326 containerd[2159]: time="2024-10-09T07:13:59.520303209Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520362 containerd[2159]: time="2024-10-09T07:13:59.520325992Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Oct 9 07:13:59.520362 containerd[2159]: time="2024-10-09T07:13:59.520337714Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Oct 9 07:13:59.520544 containerd[2159]: time="2024-10-09T07:13:59.520504970Z" 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 Oct 9 07:13:59.520544 containerd[2159]: time="2024-10-09T07:13:59.520529065Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Oct 9 07:13:59.520643 containerd[2159]: time="2024-10-09T07:13:59.520555785Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Oct 9 07:13:59.520643 containerd[2159]: time="2024-10-09T07:13:59.520567998Z" level=info msg="metadata content store policy set" policy=shared Oct 9 07:13:59.520814 containerd[2159]: time="2024-10-09T07:13:59.520789927Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Oct 9 07:13:59.520866 containerd[2159]: time="2024-10-09T07:13:59.520816567Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Oct 9 07:13:59.520866 containerd[2159]: time="2024-10-09T07:13:59.520854318Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Oct 9 07:13:59.520936 containerd[2159]: time="2024-10-09T07:13:59.520898492Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Oct 9 07:13:59.520936 containerd[2159]: time="2024-10-09T07:13:59.520921375Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Oct 9 07:13:59.521005 containerd[2159]: time="2024-10-09T07:13:59.520936804Z" level=info msg="NRI interface is disabled by configuration." Oct 9 07:13:59.521005 containerd[2159]: time="2024-10-09T07:13:59.520955239Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Oct 9 07:13:59.532359 containerd[2159]: time="2024-10-09T07:13:59.532277909Z" level=info msg="cleaning leaked shim process" id=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 namespace=moby Oct 9 07:13:59.545457 containerd[2159]: time="2024-10-09T07:13:59.545366211Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Oct 9 07:13:59.545623 containerd[2159]: time="2024-10-09T07:13:59.545549467Z" level=info msg="shim disconnected" id=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 namespace=moby Oct 9 07:13:59.545671 containerd[2159]: time="2024-10-09T07:13:59.545629047Z" level=warning msg="cleaning up after shim disconnected" id=90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2 namespace=moby Oct 9 07:13:59.545671 containerd[2159]: time="2024-10-09T07:13:59.545638695Z" level=info msg="cleaning up dead shim" namespace=moby Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.560899795Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.560944209Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.560963946Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.560988522Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561007999Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561026755Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561040000Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561054036Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561068784Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561082980Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561095604Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561112587Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Oct 9 07:13:59.561216 containerd[2159]: time="2024-10-09T07:13:59.561167470Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561498775Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561557496Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561574118Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561616076Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561697941Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561711787Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561724430Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561736404Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561749769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.561765 containerd[2159]: time="2024-10-09T07:13:59.561763465Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561779214Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561792729Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561806716Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561871268Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561886106Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561901615Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561914069Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561927975Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561942773Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561954906Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562080 containerd[2159]: time="2024-10-09T07:13:59.561966908Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Oct 9 07:13:59.562359 containerd[2159]: time="2024-10-09T07:13:59.562182025Z" 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}" Oct 9 07:13:59.562359 containerd[2159]: time="2024-10-09T07:13:59.562242438Z" level=info msg="Connect containerd service" Oct 9 07:13:59.562359 containerd[2159]: time="2024-10-09T07:13:59.562282995Z" level=info msg="using legacy CRI server" Oct 9 07:13:59.562359 containerd[2159]: time="2024-10-09T07:13:59.562293264Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Oct 9 07:13:59.562692 containerd[2159]: time="2024-10-09T07:13:59.562393954Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Oct 9 07:13:59.563025 containerd[2159]: time="2024-10-09T07:13:59.562981994Z" 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" Oct 9 07:13:59.563155 containerd[2159]: time="2024-10-09T07:13:59.563111137Z" level=info msg="Start subscribing containerd event" Oct 9 07:13:59.563428 containerd[2159]: time="2024-10-09T07:13:59.563372079Z" level=info msg="Start recovering state" Oct 9 07:13:59.563574 containerd[2159]: time="2024-10-09T07:13:59.563501393Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Oct 9 07:13:59.563655 containerd[2159]: time="2024-10-09T07:13:59.563625978Z" 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 Oct 9 07:13:59.563690 containerd[2159]: time="2024-10-09T07:13:59.563661435Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Oct 9 07:13:59.563712 containerd[2159]: time="2024-10-09T07:13:59.563693124Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Oct 9 07:13:59.564324 containerd[2159]: time="2024-10-09T07:13:59.563537632Z" level=info msg="Start event monitor" Oct 9 07:13:59.564324 containerd[2159]: time="2024-10-09T07:13:59.564075937Z" level=info msg="Start snapshots syncer" Oct 9 07:13:59.564324 containerd[2159]: time="2024-10-09T07:13:59.564161669Z" level=info msg="Start cni network conf syncer for default" Oct 9 07:13:59.564324 containerd[2159]: time="2024-10-09T07:13:59.564185013Z" level=info msg="Start streaming server" Oct 9 07:13:59.564324 containerd[2159]: time="2024-10-09T07:13:59.564287887Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Oct 9 07:13:59.564463 containerd[2159]: time="2024-10-09T07:13:59.564355695Z" level=info msg=serving... address=/run/containerd/containerd.sock Oct 9 07:13:59.564768 containerd[2159]: time="2024-10-09T07:13:59.564747424Z" level=info msg="containerd successfully booted in 0.077776s" Oct 9 07:13:59.564804 systemd[1]: Started containerd.service - containerd container runtime. Oct 9 07:13:59.572253 systemd[1]: Starting docker.service - Docker Application Container Engine... Oct 9 07:13:59.573092 (dockerd)[2194]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Oct 9 07:13:59.624457 dockerd[2194]: time="2024-10-09T07:13:59.624355094Z" level=info msg="Starting up" Oct 9 07:13:59.680742 dockerd[2194]: time="2024-10-09T07:13:59.680593177Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Oct 9 07:13:59.707634 dockerd[2194]: time="2024-10-09T07:13:59.707557756Z" level=info msg="Loading containers: start." Oct 9 07:13:59.839193 systemd[1]: var-lib-docker-overlay2-36b14228530ab95acc96d77fa2d30de6799689e36012efab5f58e70e95475604-merged.mount: Deactivated successfully. Oct 9 07:14:00.225752 dockerd[2194]: time="2024-10-09T07:14:00.225692493Z" level=info msg="Removing stale sandbox 14f5d651769ccaad87d43e85d6cca47572e71a1f90c03896fe785fa149180aa9 (90e012c5658249c68d902f2d56e407881bba2abe648cb2852809bb9f833269c2)" Oct 9 07:14:00.231187 systemd-networkd[1327]: veth0b4f09e: Link DOWN Oct 9 07:14:00.231196 systemd-networkd[1327]: veth0b4f09e: Lost carrier Oct 9 07:14:00.233616 kernel: docker0: port 1(veth0b4f09e) entered disabled state Oct 9 07:14:00.233686 kernel: veth0b4f09e (unregistering): left allmulticast mode Oct 9 07:14:00.233722 kernel: veth0b4f09e (unregistering): left promiscuous mode Oct 9 07:14:00.234480 kernel: docker0: port 1(veth0b4f09e) entered disabled state Oct 9 07:14:00.241503 systemd-networkd[1327]: docker0: Lost carrier Oct 9 07:14:00.250848 dockerd[2194]: time="2024-10-09T07:14:00.250781877Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 9d5a68e771ecdef2fa07489c800d6dfbc7573a437a68a4cb949fa1bdb9d934f5 059a07f1084adc7cbd33bdee29d5f6a7fb0b54cab4538a3c83cab42ea2aa7d90], retrying...." Oct 9 07:14:00.478208 dockerd[2194]: time="2024-10-09T07:14:00.478075809Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Oct 9 07:14:00.582687 dockerd[2194]: time="2024-10-09T07:14:00.582632523Z" level=info msg="Loading containers: done." Oct 9 07:14:00.619100 dockerd[2194]: time="2024-10-09T07:14:00.619042325Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Oct 9 07:14:00.619304 dockerd[2194]: time="2024-10-09T07:14:00.619234908Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Oct 9 07:14:00.619304 dockerd[2194]: time="2024-10-09T07:14:00.619283921Z" level=info msg="Daemon has completed initialization" Oct 9 07:14:00.649794 dockerd[2194]: time="2024-10-09T07:14:00.649742810Z" level=info msg="API listen on /run/docker.sock" Oct 9 07:14:00.650053 systemd[1]: Started docker.service - Docker Application Container Engine. Oct 9 07:14:00.661426 systemd[1]: run-docker-netns-14f5d651769c.mount: Deactivated successfully. Oct 9 07:14:03.768577 systemd[1]: Started sshd@24-10.0.0.15:22-10.0.0.1:34818.service - OpenSSH per-connection server daemon (10.0.0.1:34818). Oct 9 07:14:03.811504 sshd[2333]: Accepted publickey for core from 10.0.0.1 port 34818 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:14:03.813441 sshd[2333]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:14:03.818166 systemd-logind[1384]: New session 25 of user core. Oct 9 07:14:03.841182 systemd[1]: Started session-25.scope - Session 25 of User core. Oct 9 07:14:03.901765 sshd[2333]: pam_unix(sshd:session): session closed for user core Oct 9 07:14:03.916876 systemd[1]: sshd@24-10.0.0.15:22-10.0.0.1:34818.service: Deactivated successfully. Oct 9 07:14:03.918650 systemd[1]: session-25.scope: Deactivated successfully. Oct 9 07:14:03.919968 systemd-logind[1384]: Session 25 logged out. Waiting for processes to exit. Oct 9 07:14:03.921211 systemd[1]: Started sshd@25-10.0.0.15:22-10.0.0.1:34820.service - OpenSSH per-connection server daemon (10.0.0.1:34820). Oct 9 07:14:03.921884 systemd-logind[1384]: Removed session 25. Oct 9 07:14:03.958855 sshd[2340]: Accepted publickey for core from 10.0.0.1 port 34820 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:14:03.960589 sshd[2340]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:14:03.965023 systemd-logind[1384]: New session 26 of user core. Oct 9 07:14:03.977027 systemd[1]: Started session-26.scope - Session 26 of User core. Oct 9 07:14:04.035236 sshd[2340]: pam_unix(sshd:session): session closed for user core Oct 9 07:14:04.050379 systemd[1]: sshd@25-10.0.0.15:22-10.0.0.1:34820.service: Deactivated successfully. Oct 9 07:14:04.052263 systemd[1]: session-26.scope: Deactivated successfully. Oct 9 07:14:04.055207 systemd-logind[1384]: Session 26 logged out. Waiting for processes to exit. Oct 9 07:14:04.059363 systemd[1]: Started sshd@26-10.0.0.15:22-10.0.0.1:34826.service - OpenSSH per-connection server daemon (10.0.0.1:34826). Oct 9 07:14:04.060403 systemd-logind[1384]: Removed session 26. Oct 9 07:14:04.096395 sshd[2347]: Accepted publickey for core from 10.0.0.1 port 34826 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:14:04.098443 sshd[2347]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:14:04.102855 systemd-logind[1384]: New session 27 of user core. Oct 9 07:14:04.113085 systemd[1]: Started session-27.scope - Session 27 of User core. Oct 9 07:14:04.175217 sshd[2347]: pam_unix(sshd:session): session closed for user core Oct 9 07:14:04.188255 systemd[1]: sshd@26-10.0.0.15:22-10.0.0.1:34826.service: Deactivated successfully. Oct 9 07:14:04.190323 systemd[1]: session-27.scope: Deactivated successfully. Oct 9 07:14:04.191849 systemd-logind[1384]: Session 27 logged out. Waiting for processes to exit. Oct 9 07:14:04.200144 systemd[1]: Started sshd@27-10.0.0.15:22-10.0.0.1:34832.service - OpenSSH per-connection server daemon (10.0.0.1:34832). Oct 9 07:14:04.201152 systemd-logind[1384]: Removed session 27. Oct 9 07:14:04.234049 sshd[2361]: Accepted publickey for core from 10.0.0.1 port 34832 ssh2: RSA SHA256:WUwW0BIGVpmLb0JbqOuUi3u8OpR0rDp6Veh7R76D0+8 Oct 9 07:14:04.235906 sshd[2361]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Oct 9 07:14:04.240188 systemd-logind[1384]: New session 28 of user core. Oct 9 07:14:04.250072 systemd[1]: Started session-28.scope - Session 28 of User core. Oct 9 07:14:04.328852 systemd[1]: var-lib-docker-overlay2-54cb8b4d342a40806d494d3c3b52cf9807f089b84013621d47fc6457315cbd92\x2dinit-merged.mount: Deactivated successfully. Oct 9 07:14:04.358968 kernel: docker0: port 1(veth46d48f3) entered blocking state Oct 9 07:14:04.359122 kernel: docker0: port 1(veth46d48f3) entered disabled state Oct 9 07:14:04.359153 kernel: veth46d48f3: entered allmulticast mode Oct 9 07:14:04.363101 kernel: veth46d48f3: entered promiscuous mode Oct 9 07:14:04.361659 systemd-networkd[1327]: veth46d48f3: Link UP Oct 9 07:14:04.404876 containerd[2159]: time="2024-10-09T07:14:04.404069130Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Oct 9 07:14:04.404876 containerd[2159]: time="2024-10-09T07:14:04.404790820Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:14:04.404876 containerd[2159]: time="2024-10-09T07:14:04.404812070Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Oct 9 07:14:04.404876 containerd[2159]: time="2024-10-09T07:14:04.404850111Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Oct 9 07:14:04.430163 systemd[1]: Started docker-270e8f35bf2fe1dc96be3849b38a602425f43f69ddc627753f6004f659c237fb.scope - libcontainer container 270e8f35bf2fe1dc96be3849b38a602425f43f69ddc627753f6004f659c237fb. Oct 9 07:14:04.495859 kernel: eth0: renamed from vethd3fcdf6 Oct 9 07:14:04.505316 kernel: docker0: port 1(veth46d48f3) entered blocking state Oct 9 07:14:04.505405 kernel: docker0: port 1(veth46d48f3) entered forwarding state Oct 9 07:14:04.505429 systemd-networkd[1327]: veth46d48f3: Gained carrier Oct 9 07:14:04.505819 systemd-networkd[1327]: docker0: Gained carrier Oct 9 07:14:04.512838 systemd-resolved[1288]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Oct 9 07:14:04.547985 sshd[2361]: pam_unix(sshd:session): session closed for user core Oct 9 07:14:04.552225 systemd[1]: sshd@27-10.0.0.15:22-10.0.0.1:34832.service: Deactivated successfully. Oct 9 07:14:04.554877 systemd[1]: session-28.scope: Deactivated successfully. Oct 9 07:14:04.555599 systemd-logind[1384]: Session 28 logged out. Waiting for processes to exit. Oct 9 07:14:04.556714 systemd-logind[1384]: Removed session 28. Oct 9 07:14:05.595132 systemd-networkd[1327]: veth46d48f3: Gained IPv6LL