Sep 4 17:14:40.925152 kernel: Linux version 6.6.48-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 Wed Sep 4 15:49:08 -00 2024 Sep 4 17:14:40.925175 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=6662bd39fec77da4c9a5c59d2cba257325976309ed96904c83697df1825085bf Sep 4 17:14:40.925239 kernel: BIOS-provided physical RAM map: Sep 4 17:14:40.925248 kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Sep 4 17:14:40.925256 kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Sep 4 17:14:40.925264 kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Sep 4 17:14:40.925274 kernel: BIOS-e820: [mem 0x0000000000100000-0x000000009cfdcfff] usable Sep 4 17:14:40.925283 kernel: BIOS-e820: [mem 0x000000009cfdd000-0x000000009cffffff] reserved Sep 4 17:14:40.925290 kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Sep 4 17:14:40.925300 kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Sep 4 17:14:40.925306 kernel: BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved Sep 4 17:14:40.925312 kernel: NX (Execute Disable) protection: active Sep 4 17:14:40.925319 kernel: APIC: Static calls initialized Sep 4 17:14:40.925325 kernel: SMBIOS 2.8 present. Sep 4 17:14:40.925333 kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014 Sep 4 17:14:40.925342 kernel: Hypervisor detected: KVM Sep 4 17:14:40.925349 kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Sep 4 17:14:40.925355 kernel: kvm-clock: using sched offset of 2253582467 cycles Sep 4 17:14:40.925362 kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Sep 4 17:14:40.925369 kernel: tsc: Detected 2794.744 MHz processor Sep 4 17:14:40.925376 kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Sep 4 17:14:40.925384 kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Sep 4 17:14:40.925391 kernel: last_pfn = 0x9cfdd max_arch_pfn = 0x400000000 Sep 4 17:14:40.925398 kernel: MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs Sep 4 17:14:40.925407 kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT Sep 4 17:14:40.925414 kernel: Using GB pages for direct mapping Sep 4 17:14:40.925421 kernel: ACPI: Early table checksum verification disabled Sep 4 17:14:40.925427 kernel: ACPI: RSDP 0x00000000000F59C0 000014 (v00 BOCHS ) Sep 4 17:14:40.925434 kernel: ACPI: RSDT 0x000000009CFE1BDD 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925441 kernel: ACPI: FACP 0x000000009CFE1A79 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925448 kernel: ACPI: DSDT 0x000000009CFE0040 001A39 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925455 kernel: ACPI: FACS 0x000000009CFE0000 000040 Sep 4 17:14:40.925461 kernel: ACPI: APIC 0x000000009CFE1AED 000090 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925471 kernel: ACPI: HPET 0x000000009CFE1B7D 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925478 kernel: ACPI: WAET 0x000000009CFE1BB5 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) Sep 4 17:14:40.925484 kernel: ACPI: Reserving FACP table memory at [mem 0x9cfe1a79-0x9cfe1aec] Sep 4 17:14:40.925491 kernel: ACPI: Reserving DSDT table memory at [mem 0x9cfe0040-0x9cfe1a78] Sep 4 17:14:40.925498 kernel: ACPI: Reserving FACS table memory at [mem 0x9cfe0000-0x9cfe003f] Sep 4 17:14:40.925505 kernel: ACPI: Reserving APIC table memory at [mem 0x9cfe1aed-0x9cfe1b7c] Sep 4 17:14:40.925512 kernel: ACPI: Reserving HPET table memory at [mem 0x9cfe1b7d-0x9cfe1bb4] Sep 4 17:14:40.925524 kernel: ACPI: Reserving WAET table memory at [mem 0x9cfe1bb5-0x9cfe1bdc] Sep 4 17:14:40.925531 kernel: No NUMA configuration found Sep 4 17:14:40.925538 kernel: Faking a node at [mem 0x0000000000000000-0x000000009cfdcfff] Sep 4 17:14:40.925545 kernel: NODE_DATA(0) allocated [mem 0x9cfd7000-0x9cfdcfff] Sep 4 17:14:40.925552 kernel: Zone ranges: Sep 4 17:14:40.925566 kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Sep 4 17:14:40.925573 kernel: DMA32 [mem 0x0000000001000000-0x000000009cfdcfff] Sep 4 17:14:40.925582 kernel: Normal empty Sep 4 17:14:40.925589 kernel: Movable zone start for each node Sep 4 17:14:40.925596 kernel: Early memory node ranges Sep 4 17:14:40.925604 kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Sep 4 17:14:40.925611 kernel: node 0: [mem 0x0000000000100000-0x000000009cfdcfff] Sep 4 17:14:40.925618 kernel: Initmem setup node 0 [mem 0x0000000000001000-0x000000009cfdcfff] Sep 4 17:14:40.925625 kernel: On node 0, zone DMA: 1 pages in unavailable ranges Sep 4 17:14:40.925632 kernel: On node 0, zone DMA: 97 pages in unavailable ranges Sep 4 17:14:40.925639 kernel: On node 0, zone DMA32: 12323 pages in unavailable ranges Sep 4 17:14:40.925649 kernel: ACPI: PM-Timer IO Port: 0x608 Sep 4 17:14:40.925656 kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Sep 4 17:14:40.925663 kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Sep 4 17:14:40.925670 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Sep 4 17:14:40.925677 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Sep 4 17:14:40.925684 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Sep 4 17:14:40.925691 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Sep 4 17:14:40.925698 kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Sep 4 17:14:40.925705 kernel: ACPI: Using ACPI (MADT) for SMP configuration information Sep 4 17:14:40.925712 kernel: ACPI: HPET id: 0x8086a201 base: 0xfed00000 Sep 4 17:14:40.925722 kernel: TSC deadline timer available Sep 4 17:14:40.925729 kernel: smpboot: Allowing 4 CPUs, 0 hotplug CPUs Sep 4 17:14:40.925736 kernel: kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() Sep 4 17:14:40.925743 kernel: kvm-guest: KVM setup pv remote TLB flush Sep 4 17:14:40.925750 kernel: kvm-guest: setup PV sched yield Sep 4 17:14:40.925757 kernel: [mem 0x9d000000-0xfeffbfff] available for PCI devices Sep 4 17:14:40.925764 kernel: Booting paravirtualized kernel on KVM Sep 4 17:14:40.925772 kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns Sep 4 17:14:40.925779 kernel: setup_percpu: NR_CPUS:512 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1 Sep 4 17:14:40.925789 kernel: percpu: Embedded 58 pages/cpu s196904 r8192 d32472 u524288 Sep 4 17:14:40.925796 kernel: pcpu-alloc: s196904 r8192 d32472 u524288 alloc=1*2097152 Sep 4 17:14:40.925803 kernel: pcpu-alloc: [0] 0 1 2 3 Sep 4 17:14:40.925810 kernel: kvm-guest: PV spinlocks enabled Sep 4 17:14:40.925817 kernel: PV qspinlock hash table entries: 256 (order: 0, 4096 bytes, linear) Sep 4 17:14:40.925825 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=6662bd39fec77da4c9a5c59d2cba257325976309ed96904c83697df1825085bf Sep 4 17:14:40.925833 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 4 17:14:40.925840 kernel: random: crng init done Sep 4 17:14:40.925849 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 4 17:14:40.925857 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 4 17:14:40.925864 kernel: Fallback order for Node 0: 0 Sep 4 17:14:40.925871 kernel: Built 1 zonelists, mobility grouping on. Total pages: 632733 Sep 4 17:14:40.925878 kernel: Policy zone: DMA32 Sep 4 17:14:40.925885 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 4 17:14:40.925892 kernel: Memory: 2428448K/2571756K available (12288K kernel code, 2303K rwdata, 22640K rodata, 49336K init, 2008K bss, 143048K reserved, 0K cma-reserved) Sep 4 17:14:40.925900 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Sep 4 17:14:40.925907 kernel: ftrace: allocating 37670 entries in 148 pages Sep 4 17:14:40.925916 kernel: ftrace: allocated 148 pages with 3 groups Sep 4 17:14:40.925923 kernel: Dynamic Preempt: voluntary Sep 4 17:14:40.925930 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 4 17:14:40.925938 kernel: rcu: RCU event tracing is enabled. Sep 4 17:14:40.925946 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Sep 4 17:14:40.925953 kernel: Trampoline variant of Tasks RCU enabled. Sep 4 17:14:40.925960 kernel: Rude variant of Tasks RCU enabled. Sep 4 17:14:40.925967 kernel: Tracing variant of Tasks RCU enabled. Sep 4 17:14:40.925974 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 4 17:14:40.925984 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Sep 4 17:14:40.925991 kernel: NR_IRQS: 33024, nr_irqs: 456, preallocated irqs: 16 Sep 4 17:14:40.925998 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 4 17:14:40.926005 kernel: Console: colour VGA+ 80x25 Sep 4 17:14:40.926012 kernel: printk: console [ttyS0] enabled Sep 4 17:14:40.926031 kernel: ACPI: Core revision 20230628 Sep 4 17:14:40.926049 kernel: clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns Sep 4 17:14:40.926067 kernel: APIC: Switch to symmetric I/O mode setup Sep 4 17:14:40.926075 kernel: x2apic enabled Sep 4 17:14:40.926085 kernel: APIC: Switched APIC routing to: physical x2apic Sep 4 17:14:40.926092 kernel: kvm-guest: APIC: send_IPI_mask() replaced with kvm_send_ipi_mask() Sep 4 17:14:40.926099 kernel: kvm-guest: APIC: send_IPI_mask_allbutself() replaced with kvm_send_ipi_mask_allbutself() Sep 4 17:14:40.926106 kernel: kvm-guest: setup PV IPIs Sep 4 17:14:40.926113 kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Sep 4 17:14:40.926126 kernel: tsc: Marking TSC unstable due to TSCs unsynchronized Sep 4 17:14:40.926136 kernel: Calibrating delay loop (skipped) preset value.. 5589.48 BogoMIPS (lpj=2794744) Sep 4 17:14:40.926146 kernel: x86/cpu: User Mode Instruction Prevention (UMIP) activated Sep 4 17:14:40.926164 kernel: Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 Sep 4 17:14:40.926171 kernel: Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 Sep 4 17:14:40.926179 kernel: Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization Sep 4 17:14:40.926200 kernel: Spectre V2 : Mitigation: Retpolines Sep 4 17:14:40.926214 kernel: Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch Sep 4 17:14:40.926225 kernel: Spectre V2 : Spectre v2 / SpectreRSB : Filling RSB on VMEXIT Sep 4 17:14:40.926235 kernel: Spectre V2 : Enabling Speculation Barrier for firmware calls Sep 4 17:14:40.926244 kernel: RETBleed: Mitigation: untrained return thunk Sep 4 17:14:40.926252 kernel: Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier Sep 4 17:14:40.926262 kernel: Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl Sep 4 17:14:40.926270 kernel: Speculative Return Stack Overflow: IBPB-extending microcode not applied! Sep 4 17:14:40.926278 kernel: Speculative Return Stack Overflow: WARNING: See https://kernel.org/doc/html/latest/admin-guide/hw-vuln/srso.html for mitigation options. Sep 4 17:14:40.926285 kernel: Speculative Return Stack Overflow: Vulnerable: Safe RET, no microcode Sep 4 17:14:40.926293 kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Sep 4 17:14:40.926300 kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Sep 4 17:14:40.926308 kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Sep 4 17:14:40.926315 kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Sep 4 17:14:40.926325 kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'compacted' format. Sep 4 17:14:40.926333 kernel: Freeing SMP alternatives memory: 32K Sep 4 17:14:40.926340 kernel: pid_max: default: 32768 minimum: 301 Sep 4 17:14:40.926347 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Sep 4 17:14:40.926355 kernel: SELinux: Initializing. Sep 4 17:14:40.926362 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:14:40.926370 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 4 17:14:40.926377 kernel: smpboot: CPU0: AMD EPYC 7402P 24-Core Processor (family: 0x17, model: 0x31, stepping: 0x0) Sep 4 17:14:40.926385 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:14:40.926395 kernel: RCU Tasks Rude: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:14:40.926402 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Sep 4 17:14:40.926410 kernel: Performance Events: Fam17h+ core perfctr, AMD PMU driver. Sep 4 17:14:40.926417 kernel: ... version: 0 Sep 4 17:14:40.926424 kernel: ... bit width: 48 Sep 4 17:14:40.926432 kernel: ... generic registers: 6 Sep 4 17:14:40.926439 kernel: ... value mask: 0000ffffffffffff Sep 4 17:14:40.926447 kernel: ... max period: 00007fffffffffff Sep 4 17:14:40.926454 kernel: ... fixed-purpose events: 0 Sep 4 17:14:40.926464 kernel: ... event mask: 000000000000003f Sep 4 17:14:40.926471 kernel: signal: max sigframe size: 1776 Sep 4 17:14:40.926480 kernel: rcu: Hierarchical SRCU implementation. Sep 4 17:14:40.926489 kernel: rcu: Max phase no-delay instances is 400. Sep 4 17:14:40.926498 kernel: smp: Bringing up secondary CPUs ... Sep 4 17:14:40.926506 kernel: smpboot: x86: Booting SMP configuration: Sep 4 17:14:40.926514 kernel: .... node #0, CPUs: #1 #2 #3 Sep 4 17:14:40.926521 kernel: smp: Brought up 1 node, 4 CPUs Sep 4 17:14:40.926528 kernel: smpboot: Max logical packages: 1 Sep 4 17:14:40.926538 kernel: smpboot: Total of 4 processors activated (22357.95 BogoMIPS) Sep 4 17:14:40.926545 kernel: devtmpfs: initialized Sep 4 17:14:40.926553 kernel: x86/mm: Memory block size: 128MB Sep 4 17:14:40.926566 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 4 17:14:40.926574 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Sep 4 17:14:40.926581 kernel: pinctrl core: initialized pinctrl subsystem Sep 4 17:14:40.926589 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 4 17:14:40.926596 kernel: audit: initializing netlink subsys (disabled) Sep 4 17:14:40.926604 kernel: audit: type=2000 audit(1725470079.623:1): state=initialized audit_enabled=0 res=1 Sep 4 17:14:40.926613 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 4 17:14:40.926621 kernel: thermal_sys: Registered thermal governor 'user_space' Sep 4 17:14:40.926628 kernel: cpuidle: using governor menu Sep 4 17:14:40.926636 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 4 17:14:40.926643 kernel: dca service started, version 1.12.1 Sep 4 17:14:40.926651 kernel: PCI: Using configuration type 1 for base access Sep 4 17:14:40.926658 kernel: PCI: Using configuration type 1 for extended access Sep 4 17:14:40.926666 kernel: kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. Sep 4 17:14:40.926673 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 4 17:14:40.926683 kernel: HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page Sep 4 17:14:40.926690 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 4 17:14:40.926698 kernel: HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page Sep 4 17:14:40.926705 kernel: ACPI: Added _OSI(Module Device) Sep 4 17:14:40.926712 kernel: ACPI: Added _OSI(Processor Device) Sep 4 17:14:40.926720 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Sep 4 17:14:40.926727 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 4 17:14:40.926735 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 4 17:14:40.926742 kernel: ACPI: _OSC evaluation for CPUs failed, trying _PDC Sep 4 17:14:40.926752 kernel: ACPI: Interpreter enabled Sep 4 17:14:40.926759 kernel: ACPI: PM: (supports S0 S3 S5) Sep 4 17:14:40.926766 kernel: ACPI: Using IOAPIC for interrupt routing Sep 4 17:14:40.926774 kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Sep 4 17:14:40.926782 kernel: PCI: Using E820 reservations for host bridge windows Sep 4 17:14:40.926789 kernel: ACPI: Enabled 2 GPEs in block 00 to 0F Sep 4 17:14:40.926796 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Sep 4 17:14:40.926984 kernel: acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 4 17:14:40.927000 kernel: acpiphp: Slot [3] registered Sep 4 17:14:40.927008 kernel: acpiphp: Slot [4] registered Sep 4 17:14:40.927015 kernel: acpiphp: Slot [5] registered Sep 4 17:14:40.927022 kernel: acpiphp: Slot [6] registered Sep 4 17:14:40.927030 kernel: acpiphp: Slot [7] registered Sep 4 17:14:40.927037 kernel: acpiphp: Slot [8] registered Sep 4 17:14:40.927044 kernel: acpiphp: Slot [9] registered Sep 4 17:14:40.927051 kernel: acpiphp: Slot [10] registered Sep 4 17:14:40.927059 kernel: acpiphp: Slot [11] registered Sep 4 17:14:40.927066 kernel: acpiphp: Slot [12] registered Sep 4 17:14:40.927076 kernel: acpiphp: Slot [13] registered Sep 4 17:14:40.927084 kernel: acpiphp: Slot [14] registered Sep 4 17:14:40.927091 kernel: acpiphp: Slot [15] registered Sep 4 17:14:40.927098 kernel: acpiphp: Slot [16] registered Sep 4 17:14:40.927106 kernel: acpiphp: Slot [17] registered Sep 4 17:14:40.927113 kernel: acpiphp: Slot [18] registered Sep 4 17:14:40.927121 kernel: acpiphp: Slot [19] registered Sep 4 17:14:40.927128 kernel: acpiphp: Slot [20] registered Sep 4 17:14:40.927135 kernel: acpiphp: Slot [21] registered Sep 4 17:14:40.927145 kernel: acpiphp: Slot [22] registered Sep 4 17:14:40.927152 kernel: acpiphp: Slot [23] registered Sep 4 17:14:40.927160 kernel: acpiphp: Slot [24] registered Sep 4 17:14:40.927167 kernel: acpiphp: Slot [25] registered Sep 4 17:14:40.927175 kernel: acpiphp: Slot [26] registered Sep 4 17:14:40.927182 kernel: acpiphp: Slot [27] registered Sep 4 17:14:40.927322 kernel: acpiphp: Slot [28] registered Sep 4 17:14:40.927333 kernel: acpiphp: Slot [29] registered Sep 4 17:14:40.927341 kernel: acpiphp: Slot [30] registered Sep 4 17:14:40.927348 kernel: acpiphp: Slot [31] registered Sep 4 17:14:40.927359 kernel: PCI host bridge to bus 0000:00 Sep 4 17:14:40.927498 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Sep 4 17:14:40.927618 kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Sep 4 17:14:40.927728 kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Sep 4 17:14:40.927837 kernel: pci_bus 0000:00: root bus resource [mem 0x9d000000-0xfebfffff window] Sep 4 17:14:40.927945 kernel: pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] Sep 4 17:14:40.928053 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Sep 4 17:14:40.928211 kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Sep 4 17:14:40.928349 kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Sep 4 17:14:40.928478 kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Sep 4 17:14:40.928612 kernel: pci 0000:00:01.1: reg 0x20: [io 0xc0c0-0xc0cf] Sep 4 17:14:40.928732 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Sep 4 17:14:40.928850 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Sep 4 17:14:40.928974 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Sep 4 17:14:40.929093 kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Sep 4 17:14:40.929249 kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Sep 4 17:14:40.929372 kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Sep 4 17:14:40.929490 kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Sep 4 17:14:40.929626 kernel: pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 Sep 4 17:14:40.929751 kernel: pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] Sep 4 17:14:40.929870 kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff] Sep 4 17:14:40.929988 kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref] Sep 4 17:14:40.930106 kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Sep 4 17:14:40.930255 kernel: pci 0000:00:03.0: [1af4:1005] type 00 class 0x00ff00 Sep 4 17:14:40.930379 kernel: pci 0000:00:03.0: reg 0x10: [io 0xc080-0xc09f] Sep 4 17:14:40.930500 kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff] Sep 4 17:14:40.930636 kernel: pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref] Sep 4 17:14:40.930765 kernel: pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000 Sep 4 17:14:40.930886 kernel: pci 0000:00:04.0: reg 0x10: [io 0xc000-0xc07f] Sep 4 17:14:40.931005 kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff] Sep 4 17:14:40.931125 kernel: pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref] Sep 4 17:14:40.931276 kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 Sep 4 17:14:40.931401 kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf] Sep 4 17:14:40.931525 kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff] Sep 4 17:14:40.931652 kernel: pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref] Sep 4 17:14:40.931772 kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] Sep 4 17:14:40.931782 kernel: ACPI: PCI: Interrupt link LNKA configured for IRQ 10 Sep 4 17:14:40.931790 kernel: ACPI: PCI: Interrupt link LNKB configured for IRQ 10 Sep 4 17:14:40.931798 kernel: ACPI: PCI: Interrupt link LNKC configured for IRQ 11 Sep 4 17:14:40.931805 kernel: ACPI: PCI: Interrupt link LNKD configured for IRQ 11 Sep 4 17:14:40.931813 kernel: ACPI: PCI: Interrupt link LNKS configured for IRQ 9 Sep 4 17:14:40.931821 kernel: iommu: Default domain type: Translated Sep 4 17:14:40.931832 kernel: iommu: DMA domain TLB invalidation policy: lazy mode Sep 4 17:14:40.931840 kernel: PCI: Using ACPI for IRQ routing Sep 4 17:14:40.931848 kernel: PCI: pci_cache_line_size set to 64 bytes Sep 4 17:14:40.931857 kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Sep 4 17:14:40.931864 kernel: e820: reserve RAM buffer [mem 0x9cfdd000-0x9fffffff] Sep 4 17:14:40.931983 kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Sep 4 17:14:40.932102 kernel: pci 0000:00:02.0: vgaarb: bridge control possible Sep 4 17:14:40.932271 kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Sep 4 17:14:40.932290 kernel: vgaarb: loaded Sep 4 17:14:40.932301 kernel: hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 Sep 4 17:14:40.932311 kernel: hpet0: 3 comparators, 64-bit 100.000000 MHz counter Sep 4 17:14:40.932322 kernel: clocksource: Switched to clocksource kvm-clock Sep 4 17:14:40.932330 kernel: VFS: Disk quotas dquot_6.6.0 Sep 4 17:14:40.932338 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 4 17:14:40.932346 kernel: pnp: PnP ACPI init Sep 4 17:14:40.932478 kernel: pnp 00:02: [dma 2] Sep 4 17:14:40.932493 kernel: pnp: PnP ACPI: found 6 devices Sep 4 17:14:40.932502 kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Sep 4 17:14:40.932510 kernel: NET: Registered PF_INET protocol family Sep 4 17:14:40.932518 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 4 17:14:40.932526 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 4 17:14:40.932533 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 4 17:14:40.932541 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 4 17:14:40.932549 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 4 17:14:40.932557 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 4 17:14:40.932577 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:14:40.932584 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 4 17:14:40.932592 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 4 17:14:40.932600 kernel: NET: Registered PF_XDP protocol family Sep 4 17:14:40.932714 kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Sep 4 17:14:40.932824 kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Sep 4 17:14:40.932933 kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Sep 4 17:14:40.933041 kernel: pci_bus 0000:00: resource 7 [mem 0x9d000000-0xfebfffff window] Sep 4 17:14:40.933153 kernel: pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] Sep 4 17:14:40.933296 kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Sep 4 17:14:40.933422 kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Sep 4 17:14:40.933432 kernel: PCI: CLS 0 bytes, default 64 Sep 4 17:14:40.933440 kernel: Initialise system trusted keyrings Sep 4 17:14:40.933448 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 4 17:14:40.933456 kernel: Key type asymmetric registered Sep 4 17:14:40.933463 kernel: Asymmetric key parser 'x509' registered Sep 4 17:14:40.933471 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) Sep 4 17:14:40.933483 kernel: io scheduler mq-deadline registered Sep 4 17:14:40.933492 kernel: io scheduler kyber registered Sep 4 17:14:40.933501 kernel: io scheduler bfq registered Sep 4 17:14:40.933510 kernel: ioatdma: Intel(R) QuickData Technology Driver 5.00 Sep 4 17:14:40.933520 kernel: ACPI: \_SB_.LNKC: Enabled at IRQ 11 Sep 4 17:14:40.933528 kernel: ACPI: \_SB_.LNKD: Enabled at IRQ 10 Sep 4 17:14:40.933536 kernel: ACPI: \_SB_.LNKA: Enabled at IRQ 10 Sep 4 17:14:40.933544 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 4 17:14:40.933552 kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Sep 4 17:14:40.933572 kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Sep 4 17:14:40.933580 kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Sep 4 17:14:40.933588 kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Sep 4 17:14:40.933718 kernel: rtc_cmos 00:05: RTC can wake from S4 Sep 4 17:14:40.933730 kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 Sep 4 17:14:40.933841 kernel: rtc_cmos 00:05: registered as rtc0 Sep 4 17:14:40.933953 kernel: rtc_cmos 00:05: setting system clock to 2024-09-04T17:14:40 UTC (1725470080) Sep 4 17:14:40.934065 kernel: rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs Sep 4 17:14:40.934079 kernel: amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled Sep 4 17:14:40.934086 kernel: NET: Registered PF_INET6 protocol family Sep 4 17:14:40.934094 kernel: Segment Routing with IPv6 Sep 4 17:14:40.934102 kernel: In-situ OAM (IOAM) with IPv6 Sep 4 17:14:40.934109 kernel: NET: Registered PF_PACKET protocol family Sep 4 17:14:40.934117 kernel: Key type dns_resolver registered Sep 4 17:14:40.934124 kernel: IPI shorthand broadcast: enabled Sep 4 17:14:40.934132 kernel: sched_clock: Marking stable (694002414, 104157311)->(813679552, -15519827) Sep 4 17:14:40.934140 kernel: registered taskstats version 1 Sep 4 17:14:40.934150 kernel: Loading compiled-in X.509 certificates Sep 4 17:14:40.934158 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.48-flatcar: a53bb4e7e3319f75620f709d8a6c7aef0adb3b02' Sep 4 17:14:40.934165 kernel: Key type .fscrypt registered Sep 4 17:14:40.934173 kernel: Key type fscrypt-provisioning registered Sep 4 17:14:40.934181 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 4 17:14:40.934213 kernel: ima: Allocated hash algorithm: sha1 Sep 4 17:14:40.934221 kernel: ima: No architecture policies found Sep 4 17:14:40.934229 kernel: clk: Disabling unused clocks Sep 4 17:14:40.934240 kernel: Freeing unused kernel image (initmem) memory: 49336K Sep 4 17:14:40.934248 kernel: Write protecting the kernel read-only data: 36864k Sep 4 17:14:40.934255 kernel: Freeing unused kernel image (rodata/data gap) memory: 1936K Sep 4 17:14:40.934263 kernel: Run /init as init process Sep 4 17:14:40.934271 kernel: with arguments: Sep 4 17:14:40.934278 kernel: /init Sep 4 17:14:40.934286 kernel: with environment: Sep 4 17:14:40.934293 kernel: HOME=/ Sep 4 17:14:40.934319 kernel: TERM=linux Sep 4 17:14:40.934329 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 4 17:14:40.934342 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) Sep 4 17:14:40.934353 systemd[1]: Detected virtualization kvm. Sep 4 17:14:40.934361 systemd[1]: Detected architecture x86-64. Sep 4 17:14:40.934369 systemd[1]: Running in initrd. Sep 4 17:14:40.934378 systemd[1]: No hostname configured, using default hostname. Sep 4 17:14:40.934386 systemd[1]: Hostname set to . Sep 4 17:14:40.934396 systemd[1]: Initializing machine ID from VM UUID. Sep 4 17:14:40.934405 systemd[1]: Queued start job for default target initrd.target. Sep 4 17:14:40.934413 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:14:40.934422 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:14:40.934431 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 4 17:14:40.934439 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:14:40.934448 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 4 17:14:40.934457 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 4 17:14:40.934469 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 4 17:14:40.934477 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 4 17:14:40.934486 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:14:40.934494 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:14:40.934503 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:14:40.934511 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:14:40.934519 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:14:40.934530 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:14:40.934539 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:14:40.934547 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:14:40.934556 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 4 17:14:40.934571 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 4 17:14:40.934580 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:14:40.934588 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:14:40.934597 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:14:40.934605 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:14:40.934616 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 4 17:14:40.934625 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:14:40.934633 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 4 17:14:40.934642 systemd[1]: Starting systemd-fsck-usr.service... Sep 4 17:14:40.934650 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:14:40.934661 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:14:40.934669 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:14:40.934678 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 4 17:14:40.934686 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:14:40.934694 systemd[1]: Finished systemd-fsck-usr.service. Sep 4 17:14:40.934704 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 17:14:40.934740 systemd-journald[192]: Collecting audit messages is disabled. Sep 4 17:14:40.934761 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:14:40.934775 systemd-journald[192]: Journal started Sep 4 17:14:40.934793 systemd-journald[192]: Runtime Journal (/run/log/journal/c54c1ace1ad543c699802668b4878305) is 6.0M, max 48.4M, 42.3M free. Sep 4 17:14:40.923396 systemd-modules-load[194]: Inserted module 'overlay' Sep 4 17:14:40.965241 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:14:40.965304 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 4 17:14:40.965716 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:14:40.969208 kernel: Bridge firewalling registered Sep 4 17:14:40.969238 systemd-modules-load[194]: Inserted module 'br_netfilter' Sep 4 17:14:40.976529 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:14:40.978820 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:14:40.983424 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Sep 4 17:14:40.988148 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:14:40.990621 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:14:41.000471 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:14:41.001972 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:14:41.005398 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 4 17:14:41.013114 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:14:41.021612 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Sep 4 17:14:41.024315 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 17:14:41.030430 dracut-cmdline[225]: dracut-dracut-053 Sep 4 17:14:41.053236 dracut-cmdline[225]: 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=6662bd39fec77da4c9a5c59d2cba257325976309ed96904c83697df1825085bf Sep 4 17:14:41.092334 systemd-resolved[234]: Positive Trust Anchors: Sep 4 17:14:41.092350 systemd-resolved[234]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 17:14:41.092393 systemd-resolved[234]: 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 Sep 4 17:14:41.095804 systemd-resolved[234]: Defaulting to hostname 'linux'. Sep 4 17:14:41.097163 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 17:14:41.097725 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:14:41.163236 kernel: SCSI subsystem initialized Sep 4 17:14:41.175221 kernel: Loading iSCSI transport class v2.0-870. Sep 4 17:14:41.188232 kernel: iscsi: registered transport (tcp) Sep 4 17:14:41.217231 kernel: iscsi: registered transport (qla4xxx) Sep 4 17:14:41.217302 kernel: QLogic iSCSI HBA Driver Sep 4 17:14:41.272328 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 4 17:14:41.277458 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 4 17:14:41.327238 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 4 17:14:41.327323 kernel: device-mapper: uevent: version 1.0.3 Sep 4 17:14:41.327339 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 4 17:14:41.382241 kernel: raid6: avx2x4 gen() 18899 MB/s Sep 4 17:14:41.399227 kernel: raid6: avx2x2 gen() 19541 MB/s Sep 4 17:14:41.416485 kernel: raid6: avx2x1 gen() 16833 MB/s Sep 4 17:14:41.416575 kernel: raid6: using algorithm avx2x2 gen() 19541 MB/s Sep 4 17:14:41.434490 kernel: raid6: .... xor() 12601 MB/s, rmw enabled Sep 4 17:14:41.434613 kernel: raid6: using avx2x2 recovery algorithm Sep 4 17:14:41.464226 kernel: xor: automatically using best checksumming function avx Sep 4 17:14:41.637223 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 4 17:14:41.651006 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:14:41.659444 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:14:41.676924 systemd-udevd[414]: Using default interface naming scheme 'v255'. Sep 4 17:14:41.682492 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:14:41.694429 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 4 17:14:41.707824 dracut-pre-trigger[422]: rd.md=0: removing MD RAID activation Sep 4 17:14:41.741825 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:14:41.751461 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:14:41.828589 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:14:41.842373 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 4 17:14:41.858674 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 4 17:14:41.861679 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:14:41.863340 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:14:41.864596 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:14:41.872218 kernel: virtio_blk virtio1: 4/0/0 default/read/poll queues Sep 4 17:14:41.878345 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Sep 4 17:14:41.891474 kernel: cryptd: max_cpu_qlen set to 1000 Sep 4 17:14:41.891510 kernel: AVX2 version of gcm_enc/dec engaged. Sep 4 17:14:41.876064 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 4 17:14:41.894208 kernel: AES CTR mode by8 optimization enabled Sep 4 17:14:41.906885 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:14:41.907570 kernel: libata version 3.00 loaded. Sep 4 17:14:41.907045 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:14:41.910642 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:14:41.916069 kernel: ata_piix 0000:00:01.1: version 2.13 Sep 4 17:14:41.916326 kernel: scsi host0: ata_piix Sep 4 17:14:41.916519 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:14:41.916544 kernel: scsi host1: ata_piix Sep 4 17:14:41.916744 kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14 Sep 4 17:14:41.913862 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:14:41.920621 kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15 Sep 4 17:14:41.914061 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:14:41.922684 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:14:41.934271 kernel: BTRFS: device fsid d110be6f-93a3-451a-b365-11b5d04e0602 devid 1 transid 33 /dev/vda3 scanned by (udev-worker) (469) Sep 4 17:14:41.939321 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (468) Sep 4 17:14:41.935256 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:14:41.938178 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:14:41.966387 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Sep 4 17:14:41.982972 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:14:41.987699 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Sep 4 17:14:41.988001 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Sep 4 17:14:41.995619 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Sep 4 17:14:42.000594 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:14:42.016436 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 4 17:14:42.017666 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 4 17:14:42.041210 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:14:42.072275 kernel: ata2: found unknown device (class 0) Sep 4 17:14:42.074211 kernel: ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 Sep 4 17:14:42.076314 kernel: scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 Sep 4 17:14:42.076393 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:14:42.115229 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:14:42.155264 kernel: sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray Sep 4 17:14:42.155554 kernel: cdrom: Uniform CD-ROM driver Revision: 3.20 Sep 4 17:14:42.173225 kernel: sr 1:0:0:0: Attached scsi CD-ROM sr0 Sep 4 17:14:43.141219 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Sep 4 17:14:43.141682 disk-uuid[551]: The operation has completed successfully. Sep 4 17:14:43.168232 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 4 17:14:43.168371 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 4 17:14:43.222579 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 4 17:14:43.226011 sh[580]: Success Sep 4 17:14:43.241213 kernel: device-mapper: verity: sha256 using implementation "sha256-ni" Sep 4 17:14:43.280361 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 4 17:14:43.298047 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 4 17:14:43.300455 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 4 17:14:43.319253 kernel: BTRFS info (device dm-0): first mount of filesystem d110be6f-93a3-451a-b365-11b5d04e0602 Sep 4 17:14:43.319318 kernel: BTRFS info (device dm-0): using crc32c (crc32c-intel) checksum algorithm Sep 4 17:14:43.319329 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 4 17:14:43.320259 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 4 17:14:43.321612 kernel: BTRFS info (device dm-0): using free space tree Sep 4 17:14:43.327625 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 4 17:14:43.330107 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 4 17:14:43.349357 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 4 17:14:43.352101 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 4 17:14:43.361307 kernel: BTRFS info (device vda6): first mount of filesystem 50e7422b-f0c7-4536-902a-3ab4c864240b Sep 4 17:14:43.361336 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 17:14:43.361347 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:14:43.365240 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:14:43.375015 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 4 17:14:43.376983 kernel: BTRFS info (device vda6): last unmount of filesystem 50e7422b-f0c7-4536-902a-3ab4c864240b Sep 4 17:14:43.385090 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 4 17:14:43.396396 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 4 17:14:43.570333 ignition[672]: Ignition 2.18.0 Sep 4 17:14:43.570345 ignition[672]: Stage: fetch-offline Sep 4 17:14:43.570386 ignition[672]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:43.570396 ignition[672]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:43.570614 ignition[672]: parsed url from cmdline: "" Sep 4 17:14:43.570618 ignition[672]: no config URL provided Sep 4 17:14:43.570624 ignition[672]: reading system config file "/usr/lib/ignition/user.ign" Sep 4 17:14:43.570633 ignition[672]: no config at "/usr/lib/ignition/user.ign" Sep 4 17:14:43.570667 ignition[672]: op(1): [started] loading QEMU firmware config module Sep 4 17:14:43.570673 ignition[672]: op(1): executing: "modprobe" "qemu_fw_cfg" Sep 4 17:14:43.584897 ignition[672]: op(1): [finished] loading QEMU firmware config module Sep 4 17:14:43.586392 ignition[672]: parsing config with SHA512: 4068450cb6824c00e5b0139ce718debd003b29556ea1b676bacaf6db72893890517714d7122b866d8776f24351869e5192310d305fc0e28af78e677924ed91cf Sep 4 17:14:43.595948 unknown[672]: fetched base config from "system" Sep 4 17:14:43.595965 unknown[672]: fetched user config from "qemu" Sep 4 17:14:43.596211 ignition[672]: fetch-offline: fetch-offline passed Sep 4 17:14:43.599324 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 17:14:43.596303 ignition[672]: Ignition finished successfully Sep 4 17:14:43.601491 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 17:14:43.618364 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 17:14:43.641148 systemd-networkd[771]: lo: Link UP Sep 4 17:14:43.641159 systemd-networkd[771]: lo: Gained carrier Sep 4 17:14:43.642812 systemd-networkd[771]: Enumeration completed Sep 4 17:14:43.642929 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 17:14:43.643203 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:14:43.643207 systemd-networkd[771]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 17:14:43.645223 systemd[1]: Reached target network.target - Network. Sep 4 17:14:43.645311 systemd-networkd[771]: eth0: Link UP Sep 4 17:14:43.645316 systemd-networkd[771]: eth0: Gained carrier Sep 4 17:14:43.645324 systemd-networkd[771]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:14:43.647120 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Sep 4 17:14:43.654479 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 4 17:14:43.678314 systemd-networkd[771]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 17:14:43.687806 ignition[774]: Ignition 2.18.0 Sep 4 17:14:43.687819 ignition[774]: Stage: kargs Sep 4 17:14:43.687996 ignition[774]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:43.688007 ignition[774]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:43.688607 ignition[774]: kargs: kargs passed Sep 4 17:14:43.688653 ignition[774]: Ignition finished successfully Sep 4 17:14:43.693177 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 4 17:14:43.716404 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 4 17:14:43.731433 ignition[784]: Ignition 2.18.0 Sep 4 17:14:43.731444 ignition[784]: Stage: disks Sep 4 17:14:43.731640 ignition[784]: no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:43.731651 ignition[784]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:43.734734 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 4 17:14:43.732327 ignition[784]: disks: disks passed Sep 4 17:14:43.736948 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 4 17:14:43.732375 ignition[784]: Ignition finished successfully Sep 4 17:14:43.738907 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 4 17:14:43.740318 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:14:43.742173 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:14:43.743416 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:14:43.758341 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 4 17:14:43.770543 systemd-resolved[234]: Detected conflict on linux IN A 10.0.0.19 Sep 4 17:14:43.770557 systemd-resolved[234]: Hostname conflict, changing published hostname from 'linux' to 'linux9'. Sep 4 17:14:43.773892 systemd-fsck[795]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 4 17:14:43.779506 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 4 17:14:43.789286 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 4 17:14:43.892220 kernel: EXT4-fs (vda9): mounted filesystem 84a5cefa-c3c7-47d7-9305-7e6877f73628 r/w with ordered data mode. Quota mode: none. Sep 4 17:14:43.893157 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 4 17:14:43.894875 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 4 17:14:43.903388 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 17:14:43.905481 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 4 17:14:43.906838 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 4 17:14:43.911864 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (803) Sep 4 17:14:43.911895 kernel: BTRFS info (device vda6): first mount of filesystem 50e7422b-f0c7-4536-902a-3ab4c864240b Sep 4 17:14:43.906879 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 4 17:14:43.918373 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 17:14:43.918408 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:14:43.918420 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:14:43.906902 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 17:14:43.915299 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 4 17:14:43.919590 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 17:14:43.937440 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 4 17:14:43.974553 initrd-setup-root[827]: cut: /sysroot/etc/passwd: No such file or directory Sep 4 17:14:43.980292 initrd-setup-root[834]: cut: /sysroot/etc/group: No such file or directory Sep 4 17:14:43.985858 initrd-setup-root[841]: cut: /sysroot/etc/shadow: No such file or directory Sep 4 17:14:43.989726 initrd-setup-root[848]: cut: /sysroot/etc/gshadow: No such file or directory Sep 4 17:14:44.088709 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 4 17:14:44.101349 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 4 17:14:44.103329 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 4 17:14:44.113242 kernel: BTRFS info (device vda6): last unmount of filesystem 50e7422b-f0c7-4536-902a-3ab4c864240b Sep 4 17:14:44.137875 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 4 17:14:44.145576 ignition[918]: INFO : Ignition 2.18.0 Sep 4 17:14:44.145576 ignition[918]: INFO : Stage: mount Sep 4 17:14:44.147507 ignition[918]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:44.147507 ignition[918]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:44.150859 ignition[918]: INFO : mount: mount passed Sep 4 17:14:44.151635 ignition[918]: INFO : Ignition finished successfully Sep 4 17:14:44.154645 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 4 17:14:44.165447 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 4 17:14:44.318840 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 4 17:14:44.330510 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 4 17:14:44.338228 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (931) Sep 4 17:14:44.338302 kernel: BTRFS info (device vda6): first mount of filesystem 50e7422b-f0c7-4536-902a-3ab4c864240b Sep 4 17:14:44.339611 kernel: BTRFS info (device vda6): using crc32c (crc32c-intel) checksum algorithm Sep 4 17:14:44.339633 kernel: BTRFS info (device vda6): using free space tree Sep 4 17:14:44.343213 kernel: BTRFS info (device vda6): auto enabling async discard Sep 4 17:14:44.344964 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 4 17:14:44.374046 ignition[949]: INFO : Ignition 2.18.0 Sep 4 17:14:44.374046 ignition[949]: INFO : Stage: files Sep 4 17:14:44.376201 ignition[949]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:44.376201 ignition[949]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:44.376201 ignition[949]: DEBUG : files: compiled without relabeling support, skipping Sep 4 17:14:44.380296 ignition[949]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 4 17:14:44.380296 ignition[949]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 4 17:14:44.383831 ignition[949]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 4 17:14:44.383831 ignition[949]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 4 17:14:44.383831 ignition[949]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 4 17:14:44.383831 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 17:14:44.383831 ignition[949]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(4): [started] processing unit "docker.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(4): [finished] processing unit "docker.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Sep 4 17:14:44.383831 ignition[949]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Sep 4 17:14:44.381311 unknown[949]: wrote ssh authorized keys file for user: core Sep 4 17:14:44.410090 ignition[949]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 17:14:44.416513 ignition[949]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Sep 4 17:14:44.418646 ignition[949]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Sep 4 17:14:44.418646 ignition[949]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Sep 4 17:14:44.421791 ignition[949]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Sep 4 17:14:44.423455 ignition[949]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 4 17:14:44.425654 ignition[949]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 4 17:14:44.427619 ignition[949]: INFO : files: files passed Sep 4 17:14:44.428493 ignition[949]: INFO : Ignition finished successfully Sep 4 17:14:44.432164 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 4 17:14:44.444539 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 4 17:14:44.446044 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 4 17:14:44.454670 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 4 17:14:44.454836 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 4 17:14:44.461656 initrd-setup-root-after-ignition[978]: grep: /sysroot/oem/oem-release: No such file or directory Sep 4 17:14:44.465886 initrd-setup-root-after-ignition[980]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:14:44.465886 initrd-setup-root-after-ignition[980]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:14:44.469387 initrd-setup-root-after-ignition[984]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 4 17:14:44.473421 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:14:44.476120 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 4 17:14:44.482492 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 4 17:14:44.512267 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 4 17:14:44.513369 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 4 17:14:44.516075 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 4 17:14:44.518106 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 4 17:14:44.520170 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 4 17:14:44.537489 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 4 17:14:44.552525 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:14:44.560483 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 4 17:14:44.573213 systemd[1]: Stopped target network.target - Network. Sep 4 17:14:44.575332 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:14:44.575828 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:14:44.576174 systemd[1]: Stopped target timers.target - Timer Units. Sep 4 17:14:44.580644 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 4 17:14:44.580829 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 4 17:14:44.581673 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 4 17:14:44.582066 systemd[1]: Stopped target basic.target - Basic System. Sep 4 17:14:44.582557 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 4 17:14:44.582899 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 4 17:14:44.583216 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 4 17:14:44.583738 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 4 17:14:44.584094 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 4 17:14:44.584633 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 4 17:14:44.584972 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 4 17:14:44.585312 systemd[1]: Stopped target swap.target - Swaps. Sep 4 17:14:44.585772 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 4 17:14:44.585918 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 4 17:14:44.605124 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:14:44.605769 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:14:44.606058 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 4 17:14:44.606165 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:14:44.610711 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 4 17:14:44.610855 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 4 17:14:44.613117 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 4 17:14:44.613281 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 4 17:14:44.613740 systemd[1]: Stopped target paths.target - Path Units. Sep 4 17:14:44.617982 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 4 17:14:44.621237 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:14:44.621852 systemd[1]: Stopped target slices.target - Slice Units. Sep 4 17:14:44.622166 systemd[1]: Stopped target sockets.target - Socket Units. Sep 4 17:14:44.626680 systemd[1]: iscsid.socket: Deactivated successfully. Sep 4 17:14:44.626785 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 4 17:14:44.627280 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 4 17:14:44.627363 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 4 17:14:44.627800 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 4 17:14:44.627907 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 4 17:14:44.631491 systemd[1]: ignition-files.service: Deactivated successfully. Sep 4 17:14:44.631597 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 4 17:14:44.643333 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 4 17:14:44.645306 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 4 17:14:44.645894 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 4 17:14:44.647586 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 4 17:14:44.649490 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 4 17:14:44.649619 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:14:44.649966 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 4 17:14:44.650107 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 4 17:14:44.653512 systemd-networkd[771]: eth0: DHCPv6 lease lost Sep 4 17:14:44.660974 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 4 17:14:44.661214 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 4 17:14:44.664750 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 4 17:14:44.664934 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 4 17:14:44.669624 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 4 17:14:44.669737 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 4 17:14:44.673159 ignition[1004]: INFO : Ignition 2.18.0 Sep 4 17:14:44.673159 ignition[1004]: INFO : Stage: umount Sep 4 17:14:44.673159 ignition[1004]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 4 17:14:44.673159 ignition[1004]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Sep 4 17:14:44.673159 ignition[1004]: INFO : umount: umount passed Sep 4 17:14:44.677561 ignition[1004]: INFO : Ignition finished successfully Sep 4 17:14:44.673307 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 4 17:14:44.673380 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:14:44.683279 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 4 17:14:44.683718 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 4 17:14:44.683774 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 4 17:14:44.685719 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 4 17:14:44.685767 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:14:44.686078 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 4 17:14:44.686119 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 4 17:14:44.690789 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 4 17:14:44.690834 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Sep 4 17:14:44.691939 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 4 17:14:44.692046 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 4 17:14:44.695920 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 4 17:14:44.695994 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 4 17:14:44.696575 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 4 17:14:44.696624 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 4 17:14:44.698546 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 4 17:14:44.698594 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 4 17:14:44.698864 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 4 17:14:44.698907 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 4 17:14:44.699290 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:14:44.709643 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 4 17:14:44.709774 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 4 17:14:44.722145 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 4 17:14:44.722341 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:14:44.722988 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 4 17:14:44.723037 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 4 17:14:44.726485 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 4 17:14:44.726535 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:14:44.728608 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 4 17:14:44.728666 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 4 17:14:44.732693 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 4 17:14:44.732746 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 4 17:14:44.735690 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 4 17:14:44.735751 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 4 17:14:44.750444 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 4 17:14:44.752723 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 4 17:14:44.752804 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:14:44.755072 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 4 17:14:44.755122 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:14:44.757738 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 4 17:14:44.757793 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:14:44.760158 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 4 17:14:44.760218 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:14:44.763702 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 4 17:14:44.764271 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 4 17:14:44.764381 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 4 17:14:44.766303 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 4 17:14:44.766405 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 4 17:14:44.769427 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 4 17:14:44.770625 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 4 17:14:44.770686 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 4 17:14:44.781419 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 4 17:14:44.790382 systemd[1]: Switching root. Sep 4 17:14:44.824532 systemd-journald[192]: Journal stopped Sep 4 17:14:45.636136 systemd-journald[192]: Received SIGTERM from PID 1 (systemd). Sep 4 17:14:45.637109 kernel: SELinux: policy capability network_peer_controls=1 Sep 4 17:14:45.637135 kernel: SELinux: policy capability open_perms=1 Sep 4 17:14:45.637158 kernel: SELinux: policy capability extended_socket_class=1 Sep 4 17:14:45.637172 kernel: SELinux: policy capability always_check_network=0 Sep 4 17:14:45.637200 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 4 17:14:45.637220 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 4 17:14:45.637239 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 4 17:14:45.637253 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 4 17:14:45.637268 kernel: audit: type=1403 audit(1725470084.916:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 4 17:14:45.637285 systemd[1]: Successfully loaded SELinux policy in 44.352ms. Sep 4 17:14:45.637316 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 16.509ms. Sep 4 17:14:45.637334 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) Sep 4 17:14:45.637350 systemd[1]: Detected virtualization kvm. Sep 4 17:14:45.637365 systemd[1]: Detected architecture x86-64. Sep 4 17:14:45.637382 systemd[1]: Detected first boot. Sep 4 17:14:45.637403 systemd[1]: Initializing machine ID from VM UUID. Sep 4 17:14:45.637418 zram_generator::config[1047]: No configuration found. Sep 4 17:14:45.637434 systemd[1]: Populated /etc with preset unit settings. Sep 4 17:14:45.637458 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 4 17:14:45.637473 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 4 17:14:45.637489 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 4 17:14:45.637513 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 4 17:14:45.637538 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 4 17:14:45.637557 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 4 17:14:45.637574 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 4 17:14:45.637590 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 4 17:14:45.637605 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 4 17:14:45.637620 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 4 17:14:45.637636 systemd[1]: Created slice user.slice - User and Session Slice. Sep 4 17:14:45.637654 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 4 17:14:45.637670 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 4 17:14:45.637686 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 4 17:14:45.637701 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 4 17:14:45.637716 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 4 17:14:45.637732 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 4 17:14:45.637747 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 4 17:14:45.637762 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 4 17:14:45.637777 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 4 17:14:45.637796 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 4 17:14:45.637812 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 4 17:14:45.637828 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 4 17:14:45.637843 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 4 17:14:45.637859 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 4 17:14:45.637876 systemd[1]: Reached target slices.target - Slice Units. Sep 4 17:14:45.637891 systemd[1]: Reached target swap.target - Swaps. Sep 4 17:14:45.637906 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 4 17:14:45.637925 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 4 17:14:45.637940 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 4 17:14:45.637956 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 4 17:14:45.637971 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 4 17:14:45.637986 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 4 17:14:45.638001 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 4 17:14:45.638016 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 4 17:14:45.638032 systemd[1]: Mounting media.mount - External Media Directory... Sep 4 17:14:45.638047 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:45.638066 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 4 17:14:45.638081 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 4 17:14:45.638096 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 4 17:14:45.638112 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). Sep 4 17:14:45.638128 systemd[1]: Reached target machines.target - Containers. Sep 4 17:14:45.638143 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 4 17:14:45.638159 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:14:45.638174 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 4 17:14:45.638207 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 4 17:14:45.638224 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:14:45.638239 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:14:45.638254 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:14:45.638270 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 4 17:14:45.638285 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:14:45.638302 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 4 17:14:45.638317 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 4 17:14:45.638336 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 4 17:14:45.638351 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 4 17:14:45.638366 systemd[1]: Stopped systemd-fsck-usr.service. Sep 4 17:14:45.638383 kernel: loop: module loaded Sep 4 17:14:45.638400 kernel: fuse: init (API version 7.39) Sep 4 17:14:45.638415 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 4 17:14:45.638430 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 4 17:14:45.638453 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 4 17:14:45.638468 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 4 17:14:45.638487 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 4 17:14:45.638538 systemd-journald[1116]: Collecting audit messages is disabled. Sep 4 17:14:45.638565 systemd[1]: verity-setup.service: Deactivated successfully. Sep 4 17:14:45.638581 systemd[1]: Stopped verity-setup.service. Sep 4 17:14:45.638595 systemd-journald[1116]: Journal started Sep 4 17:14:45.638635 systemd-journald[1116]: Runtime Journal (/run/log/journal/c54c1ace1ad543c699802668b4878305) is 6.0M, max 48.4M, 42.3M free. Sep 4 17:14:45.426158 systemd[1]: Queued start job for default target multi-user.target. Sep 4 17:14:45.445090 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Sep 4 17:14:45.445562 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 4 17:14:45.643235 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:45.643286 systemd[1]: Started systemd-journald.service - Journal Service. Sep 4 17:14:45.645249 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 4 17:14:45.646575 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 4 17:14:45.647911 systemd[1]: Mounted media.mount - External Media Directory. Sep 4 17:14:45.649051 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 4 17:14:45.650275 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 4 17:14:45.651648 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 4 17:14:45.652974 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 4 17:14:45.654500 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 4 17:14:45.656058 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 4 17:14:45.656260 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 4 17:14:45.657773 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:14:45.657947 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:14:45.659393 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:14:45.659569 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:14:45.661088 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 4 17:14:45.661272 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 4 17:14:45.662661 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:14:45.662826 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:14:45.664379 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 4 17:14:45.666222 kernel: ACPI: bus type drm_connector registered Sep 4 17:14:45.666428 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 4 17:14:45.668142 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:14:45.668359 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:14:45.669847 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 4 17:14:45.684838 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 4 17:14:45.692353 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 4 17:14:45.695406 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 4 17:14:45.696734 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 4 17:14:45.696771 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 4 17:14:45.699023 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 4 17:14:45.702405 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 4 17:14:45.705419 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 4 17:14:45.706881 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:14:45.711583 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 4 17:14:45.715504 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 4 17:14:45.716990 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:14:45.720906 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 4 17:14:45.722643 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:14:45.724703 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 4 17:14:45.728057 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 4 17:14:45.734878 systemd-journald[1116]: Time spent on flushing to /var/log/journal/c54c1ace1ad543c699802668b4878305 is 15.907ms for 919 entries. Sep 4 17:14:45.734878 systemd-journald[1116]: System Journal (/var/log/journal/c54c1ace1ad543c699802668b4878305) is 8.0M, max 195.6M, 187.6M free. Sep 4 17:14:45.797558 systemd-journald[1116]: Received client request to flush runtime journal. Sep 4 17:14:45.797613 kernel: loop0: detected capacity change from 0 to 139904 Sep 4 17:14:45.797632 kernel: block loop0: the capability attribute has been deprecated. Sep 4 17:14:45.733917 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 4 17:14:45.739149 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 4 17:14:45.744897 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 4 17:14:45.746597 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 4 17:14:45.748649 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 4 17:14:45.787417 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 4 17:14:45.789491 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 4 17:14:45.792061 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 4 17:14:45.804839 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 4 17:14:45.809926 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 4 17:14:45.814345 systemd-tmpfiles[1161]: ACLs are not supported, ignoring. Sep 4 17:14:45.814358 systemd-tmpfiles[1161]: ACLs are not supported, ignoring. Sep 4 17:14:45.818914 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 4 17:14:45.820988 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 4 17:14:45.822856 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 4 17:14:45.836464 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 4 17:14:45.838723 udevadm[1168]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 4 17:14:45.853975 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 4 17:14:45.855149 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 4 17:14:45.857207 kernel: loop1: detected capacity change from 0 to 80568 Sep 4 17:14:45.899653 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 4 17:14:45.915224 kernel: loop2: detected capacity change from 0 to 139904 Sep 4 17:14:45.925169 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 4 17:14:45.927631 kernel: loop3: detected capacity change from 0 to 80568 Sep 4 17:14:45.949731 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Sep 4 17:14:45.949762 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. Sep 4 17:14:45.961047 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 4 17:14:45.967728 (sd-merge)[1184]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Sep 4 17:14:45.968272 (sd-merge)[1184]: Merged extensions into '/usr'. Sep 4 17:14:45.979586 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 4 17:14:45.990872 systemd[1]: Starting ensure-sysext.service... Sep 4 17:14:45.992894 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Sep 4 17:14:46.025390 systemd[1]: Reloading requested from client PID 1188 ('systemctl') (unit ensure-sysext.service)... Sep 4 17:14:46.025411 systemd[1]: Reloading... Sep 4 17:14:46.081264 systemd-tmpfiles[1189]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 4 17:14:46.081765 systemd-tmpfiles[1189]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 4 17:14:46.083201 systemd-tmpfiles[1189]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 4 17:14:46.084175 systemd-tmpfiles[1189]: ACLs are not supported, ignoring. Sep 4 17:14:46.084553 systemd-tmpfiles[1189]: ACLs are not supported, ignoring. Sep 4 17:14:46.095056 systemd-tmpfiles[1189]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:14:46.095290 systemd-tmpfiles[1189]: Skipping /boot Sep 4 17:14:46.132870 systemd-tmpfiles[1189]: Detected autofs mount point /boot during canonicalization of boot. Sep 4 17:14:46.133031 systemd-tmpfiles[1189]: Skipping /boot Sep 4 17:14:46.138213 zram_generator::config[1223]: No configuration found. Sep 4 17:14:46.271261 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. Sep 4 17:14:46.292320 ldconfig[1155]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 4 17:14:46.320671 systemd[1]: Reloading finished in 294 ms. Sep 4 17:14:46.355739 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 4 17:14:46.357602 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Sep 4 17:14:46.376722 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 17:14:46.390308 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 4 17:14:46.394308 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 4 17:14:46.400478 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 4 17:14:46.403565 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 4 17:14:46.412754 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.413122 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:14:46.436455 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:14:46.442462 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:14:46.445664 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:14:46.447051 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:14:46.451546 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 4 17:14:46.453405 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.457399 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:14:46.459025 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:14:46.462459 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:14:46.462958 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:14:46.465785 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 4 17:14:46.469475 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:14:46.469735 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:14:46.481738 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.482150 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:14:46.489641 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:14:46.491591 augenrules[1282]: No rules Sep 4 17:14:46.493522 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:14:46.497540 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:14:46.499363 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:14:46.499527 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.502717 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 17:14:46.504910 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 4 17:14:46.507023 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 4 17:14:46.509453 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:14:46.509760 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:14:46.511812 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:14:46.512122 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:14:46.521503 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 4 17:14:46.527521 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:14:46.527840 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:14:46.538235 systemd[1]: proc-xen.mount - /proc/xen was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.538565 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 4 17:14:46.543706 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 4 17:14:46.549826 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 4 17:14:46.554675 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 4 17:14:46.575459 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 4 17:14:46.577215 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 4 17:14:46.577478 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). Sep 4 17:14:46.577604 systemd[1]: xenserver-pv-version.service - Set fake PV driver version for XenServer was skipped because of an unmet condition check (ConditionVirtualization=xen). Sep 4 17:14:46.578657 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 4 17:14:46.578830 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 4 17:14:46.581697 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 4 17:14:46.581958 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 4 17:14:46.584089 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 4 17:14:46.584290 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 4 17:14:46.589311 systemd[1]: Finished ensure-sysext.service. Sep 4 17:14:46.590729 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 4 17:14:46.590905 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 4 17:14:46.595802 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 4 17:14:46.595883 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 4 17:14:46.598255 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Sep 4 17:14:46.603945 systemd-resolved[1257]: Positive Trust Anchors: Sep 4 17:14:46.603969 systemd-resolved[1257]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 4 17:14:46.604009 systemd-resolved[1257]: 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 Sep 4 17:14:46.608151 systemd-resolved[1257]: Defaulting to hostname 'linux'. Sep 4 17:14:46.610297 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 4 17:14:46.611905 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 4 17:14:46.695809 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Sep 4 17:14:46.697672 systemd[1]: Reached target time-set.target - System Time Set. Sep 4 17:14:46.727605 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 4 17:14:46.738523 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 4 17:14:46.741300 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 4 17:14:46.756490 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 4 17:14:46.761178 systemd-udevd[1313]: Using default interface naming scheme 'v255'. Sep 4 17:14:46.776388 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 4 17:14:46.789533 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 4 17:14:46.814283 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1320) Sep 4 17:14:46.818379 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 4 17:14:46.867494 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1332) Sep 4 17:14:46.897676 systemd-networkd[1326]: lo: Link UP Sep 4 17:14:46.897689 systemd-networkd[1326]: lo: Gained carrier Sep 4 17:14:46.899875 systemd-networkd[1326]: Enumeration completed Sep 4 17:14:46.900198 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 4 17:14:46.901201 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:14:46.901211 systemd-networkd[1326]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 4 17:14:46.902210 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:14:46.902243 systemd-networkd[1326]: eth0: Link UP Sep 4 17:14:46.902247 systemd-networkd[1326]: eth0: Gained carrier Sep 4 17:14:46.902257 systemd-networkd[1326]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 4 17:14:46.904528 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Sep 4 17:14:46.906007 systemd[1]: Reached target network.target - Network. Sep 4 17:14:46.914294 systemd-networkd[1326]: eth0: DHCPv4 address 10.0.0.19/16, gateway 10.0.0.1 acquired from 10.0.0.1 Sep 4 17:14:46.914547 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 4 17:14:46.915064 systemd-timesyncd[1310]: Network configuration changed, trying to establish connection. Sep 4 17:14:46.917537 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 Sep 4 17:14:46.917068 systemd-timesyncd[1310]: Contacted time server 10.0.0.1:123 (10.0.0.1). Sep 4 17:14:46.917107 systemd-timesyncd[1310]: Initial clock synchronization to Wed 2024-09-04 17:14:46.731189 UTC. Sep 4 17:14:46.918032 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 4 17:14:46.926204 kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Sep 4 17:14:46.927232 kernel: ACPI: button: Power Button [PWRF] Sep 4 17:14:46.933980 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 4 17:14:46.937233 kernel: input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4 Sep 4 17:14:46.974252 kernel: mousedev: PS/2 mouse device common for all mice Sep 4 17:14:46.980432 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 4 17:14:47.054338 kernel: kvm_amd: TSC scaling supported Sep 4 17:14:47.054402 kernel: kvm_amd: Nested Virtualization enabled Sep 4 17:14:47.054416 kernel: kvm_amd: Nested Paging enabled Sep 4 17:14:47.055464 kernel: kvm_amd: LBR virtualization supported Sep 4 17:14:47.055483 kernel: kvm_amd: Virtual VMLOAD VMSAVE supported Sep 4 17:14:47.056662 kernel: kvm_amd: Virtual GIF supported Sep 4 17:14:47.077625 kernel: EDAC MC: Ver: 3.0.0 Sep 4 17:14:47.107677 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 4 17:14:47.115210 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 4 17:14:47.132371 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 4 17:14:47.141841 lvm[1359]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:14:47.177287 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 4 17:14:47.178945 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 4 17:14:47.180049 systemd[1]: Reached target sysinit.target - System Initialization. Sep 4 17:14:47.181223 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 4 17:14:47.182482 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 4 17:14:47.183892 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 4 17:14:47.185059 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 4 17:14:47.186274 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 4 17:14:47.187483 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 4 17:14:47.187508 systemd[1]: Reached target paths.target - Path Units. Sep 4 17:14:47.188393 systemd[1]: Reached target timers.target - Timer Units. Sep 4 17:14:47.190067 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 4 17:14:47.192752 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 17:14:47.205641 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 4 17:14:47.208099 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 4 17:14:47.209652 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 17:14:47.210793 systemd[1]: Reached target sockets.target - Socket Units. Sep 4 17:14:47.211743 systemd[1]: Reached target basic.target - Basic System. Sep 4 17:14:47.212702 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:14:47.212726 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 4 17:14:47.213670 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 17:14:47.216016 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 4 17:14:47.218265 lvm[1364]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 4 17:14:47.221302 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 4 17:14:47.223818 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 4 17:14:47.225102 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). Sep 4 17:14:47.227467 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 4 17:14:47.230254 jq[1367]: false Sep 4 17:14:47.233153 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 4 17:14:47.237395 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 4 17:14:47.242319 extend-filesystems[1368]: Found loop2 Sep 4 17:14:47.242319 extend-filesystems[1368]: Found loop3 Sep 4 17:14:47.242319 extend-filesystems[1368]: Found sr0 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda1 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda2 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda3 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found usr Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda4 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda6 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda7 Sep 4 17:14:47.246347 extend-filesystems[1368]: Found vda9 Sep 4 17:14:47.246347 extend-filesystems[1368]: Checking size of /dev/vda9 Sep 4 17:14:47.253953 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 4 17:14:47.248864 dbus-daemon[1366]: [system] SELinux support is enabled Sep 4 17:14:47.257756 extend-filesystems[1368]: Old size kept for /dev/vda9 Sep 4 17:14:47.259230 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 4 17:14:47.259838 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 4 17:14:47.260686 systemd[1]: Starting update-engine.service - Update Engine... Sep 4 17:14:47.264227 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 4 17:14:47.266917 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 4 17:14:47.271876 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 4 17:14:47.279084 jq[1386]: true Sep 4 17:14:47.280943 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 4 17:14:47.281512 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 4 17:14:47.281895 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 4 17:14:47.282486 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 4 17:14:47.285627 systemd[1]: motdgen.service: Deactivated successfully. Sep 4 17:14:47.289475 update_engine[1384]: I0904 17:14:47.287202 1384 main.cc:92] Flatcar Update Engine starting Sep 4 17:14:47.285869 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 4 17:14:47.287554 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 4 17:14:47.287792 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 4 17:14:47.293215 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (1317) Sep 4 17:14:47.294046 update_engine[1384]: I0904 17:14:47.293896 1384 update_check_scheduler.cc:74] Next update check in 7m5s Sep 4 17:14:47.300312 jq[1389]: true Sep 4 17:14:47.303425 (ntainerd)[1390]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 17:14:47.317278 systemd-logind[1373]: Watching system buttons on /dev/input/event1 (Power Button) Sep 4 17:14:47.317304 systemd-logind[1373]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) Sep 4 17:14:47.319451 systemd-logind[1373]: New seat seat0. Sep 4 17:14:47.326690 systemd[1]: Started systemd-logind.service - User Login Management. Sep 4 17:14:47.331646 systemd[1]: Started update-engine.service - Update Engine. Sep 4 17:14:47.335662 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). Sep 4 17:14:47.335817 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 4 17:14:47.337451 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). Sep 4 17:14:47.337558 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 4 17:14:47.347727 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 4 17:14:47.352082 bash[1415]: Updated "/home/core/.ssh/authorized_keys" Sep 4 17:14:47.353140 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 4 17:14:47.356178 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Sep 4 17:14:47.374059 locksmithd[1416]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 4 17:14:47.421623 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 4 17:14:47.449725 sshd_keygen[1387]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 4 17:14:47.472615 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 4 17:14:47.481408 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 4 17:14:47.483466 systemd[1]: Started sshd@0-10.0.0.19:22-10.0.0.1:40290.service - OpenSSH per-connection server daemon (10.0.0.1:40290). Sep 4 17:14:47.488362 systemd[1]: issuegen.service: Deactivated successfully. Sep 4 17:14:47.488648 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 4 17:14:47.493429 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 4 17:14:47.508697 containerd[1390]: time="2024-09-04T17:14:47.508378406Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Sep 4 17:14:47.510149 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 4 17:14:47.516635 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 4 17:14:47.521576 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 4 17:14:47.523406 systemd[1]: Reached target getty.target - Login Prompts. Sep 4 17:14:47.533792 containerd[1390]: time="2024-09-04T17:14:47.533746426Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 17:14:47.533837 containerd[1390]: time="2024-09-04T17:14:47.533795620Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.535757 containerd[1390]: time="2024-09-04T17:14:47.535702905Z" 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.48-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:14:47.535757 containerd[1390]: time="2024-09-04T17:14:47.535747256Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536042 containerd[1390]: time="2024-09-04T17:14:47.536012176Z" 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 Sep 4 17:14:47.536042 containerd[1390]: time="2024-09-04T17:14:47.536031376Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 17:14:47.536147 containerd[1390]: time="2024-09-04T17:14:47.536123062Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536240 containerd[1390]: time="2024-09-04T17:14:47.536211206Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536240 containerd[1390]: time="2024-09-04T17:14:47.536230025Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536341 containerd[1390]: time="2024-09-04T17:14:47.536317708Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536583 containerd[1390]: time="2024-09-04T17:14:47.536557624Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536583 containerd[1390]: time="2024-09-04T17:14:47.536579281Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Sep 4 17:14:47.536629 containerd[1390]: time="2024-09-04T17:14:47.536590320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:14:47.536740 containerd[1390]: time="2024-09-04T17:14:47.536712108Z" 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 Sep 4 17:14:47.536740 containerd[1390]: time="2024-09-04T17:14:47.536729341Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 17:14:47.536810 containerd[1390]: time="2024-09-04T17:14:47.536785328Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Sep 4 17:14:47.536810 containerd[1390]: time="2024-09-04T17:14:47.536801700Z" level=info msg="metadata content store policy set" policy=shared Sep 4 17:14:47.541034 sshd[1439]: Accepted publickey for core from 10.0.0.1 port 40290 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:47.542763 containerd[1390]: time="2024-09-04T17:14:47.542659611Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 17:14:47.542763 containerd[1390]: time="2024-09-04T17:14:47.542703844Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 17:14:47.542763 containerd[1390]: time="2024-09-04T17:14:47.542717936Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 17:14:47.542763 containerd[1390]: time="2024-09-04T17:14:47.542752784Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 17:14:47.542763 containerd[1390]: time="2024-09-04T17:14:47.542766231Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 17:14:47.542925 containerd[1390]: time="2024-09-04T17:14:47.542776750Z" level=info msg="NRI interface is disabled by configuration." Sep 4 17:14:47.542925 containerd[1390]: time="2024-09-04T17:14:47.542788269Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 17:14:47.542978 containerd[1390]: time="2024-09-04T17:14:47.542944269Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 17:14:47.542978 containerd[1390]: time="2024-09-04T17:14:47.542958968Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 17:14:47.542978 containerd[1390]: time="2024-09-04T17:14:47.542970975Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.542982993Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.542996595Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.543011989Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.543025093Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.543036827Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543052 containerd[1390]: time="2024-09-04T17:14:47.543050203Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543210 containerd[1390]: time="2024-09-04T17:14:47.543065010Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543210 containerd[1390]: time="2024-09-04T17:14:47.543076421Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543210 containerd[1390]: time="2024-09-04T17:14:47.543087626Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 17:14:47.543277 containerd[1390]: time="2024-09-04T17:14:47.543214776Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 17:14:47.543464 containerd[1390]: time="2024-09-04T17:14:47.543439672Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 17:14:47.543577 containerd[1390]: time="2024-09-04T17:14:47.543466103Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543577 containerd[1390]: time="2024-09-04T17:14:47.543492086Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 17:14:47.543577 containerd[1390]: time="2024-09-04T17:14:47.543512588Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 17:14:47.543577 containerd[1390]: time="2024-09-04T17:14:47.543566637Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543577 containerd[1390]: time="2024-09-04T17:14:47.543578214Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543590260Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543600937Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543614266Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543626244Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543637370Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543647979Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.543678 containerd[1390]: time="2024-09-04T17:14:47.543660231Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 17:14:47.543640 sshd[1439]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543811035Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543827211Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543847596Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543859437Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543873636Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543886163Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543897466Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544217 containerd[1390]: time="2024-09-04T17:14:47.543907644Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 17:14:47.544361 containerd[1390]: time="2024-09-04T17:14:47.544149341Z" 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}" Sep 4 17:14:47.544361 containerd[1390]: time="2024-09-04T17:14:47.544215427Z" level=info msg="Connect containerd service" Sep 4 17:14:47.544361 containerd[1390]: time="2024-09-04T17:14:47.544236839Z" level=info msg="using legacy CRI server" Sep 4 17:14:47.544361 containerd[1390]: time="2024-09-04T17:14:47.544243425Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 17:14:47.544361 containerd[1390]: time="2024-09-04T17:14:47.544320021Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 17:14:47.544907 containerd[1390]: time="2024-09-04T17:14:47.544875461Z" 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" Sep 4 17:14:47.544942 containerd[1390]: time="2024-09-04T17:14:47.544924225Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 17:14:47.544962 containerd[1390]: time="2024-09-04T17:14:47.544940148Z" 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 Sep 4 17:14:47.544962 containerd[1390]: time="2024-09-04T17:14:47.544951040Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 17:14:47.545000 containerd[1390]: time="2024-09-04T17:14:47.544962420Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 17:14:47.545139 containerd[1390]: time="2024-09-04T17:14:47.545052903Z" level=info msg="Start subscribing containerd event" Sep 4 17:14:47.545219 containerd[1390]: time="2024-09-04T17:14:47.545161881Z" level=info msg="Start recovering state" Sep 4 17:14:47.545282 containerd[1390]: time="2024-09-04T17:14:47.545255935Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 17:14:47.545307 containerd[1390]: time="2024-09-04T17:14:47.545279618Z" level=info msg="Start event monitor" Sep 4 17:14:47.545307 containerd[1390]: time="2024-09-04T17:14:47.545302420Z" level=info msg="Start snapshots syncer" Sep 4 17:14:47.545359 containerd[1390]: time="2024-09-04T17:14:47.545310581Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 17:14:47.545359 containerd[1390]: time="2024-09-04T17:14:47.545314379Z" level=info msg="Start cni network conf syncer for default" Sep 4 17:14:47.545394 containerd[1390]: time="2024-09-04T17:14:47.545364209Z" level=info msg="Start streaming server" Sep 4 17:14:47.545909 containerd[1390]: time="2024-09-04T17:14:47.545473207Z" level=info msg="containerd successfully booted in 0.038336s" Sep 4 17:14:47.545560 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 17:14:47.553933 systemd-logind[1373]: New session 1 of user core. Sep 4 17:14:47.555326 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 4 17:14:47.566518 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 4 17:14:47.580205 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 4 17:14:47.594407 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 4 17:14:47.598623 (systemd)[1453]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:47.699244 systemd[1453]: Queued start job for default target default.target. Sep 4 17:14:47.709733 systemd[1453]: Created slice app.slice - User Application Slice. Sep 4 17:14:47.709765 systemd[1453]: Reached target paths.target - Paths. Sep 4 17:14:47.709779 systemd[1453]: Reached target timers.target - Timers. Sep 4 17:14:47.711403 systemd[1453]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 4 17:14:47.722343 systemd[1453]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 4 17:14:47.722545 systemd[1453]: Reached target sockets.target - Sockets. Sep 4 17:14:47.722563 systemd[1453]: Reached target basic.target - Basic System. Sep 4 17:14:47.722608 systemd[1453]: Reached target default.target - Main User Target. Sep 4 17:14:47.722642 systemd[1453]: Startup finished in 116ms. Sep 4 17:14:47.722933 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 4 17:14:47.725580 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 4 17:14:47.784977 systemd[1]: Started sshd@1-10.0.0.19:22-10.0.0.1:40298.service - OpenSSH per-connection server daemon (10.0.0.1:40298). Sep 4 17:14:47.825614 sshd[1464]: Accepted publickey for core from 10.0.0.1 port 40298 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:47.827234 sshd[1464]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:47.831018 systemd-logind[1373]: New session 2 of user core. Sep 4 17:14:47.846427 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 4 17:14:47.900550 sshd[1464]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:47.915795 systemd[1]: sshd@1-10.0.0.19:22-10.0.0.1:40298.service: Deactivated successfully. Sep 4 17:14:47.917449 systemd[1]: session-2.scope: Deactivated successfully. Sep 4 17:14:47.919087 systemd-logind[1373]: Session 2 logged out. Waiting for processes to exit. Sep 4 17:14:47.926710 systemd[1]: Started sshd@2-10.0.0.19:22-10.0.0.1:40310.service - OpenSSH per-connection server daemon (10.0.0.1:40310). Sep 4 17:14:47.929121 systemd-logind[1373]: Removed session 2. Sep 4 17:14:47.954927 sshd[1471]: Accepted publickey for core from 10.0.0.1 port 40310 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:47.956290 sshd[1471]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:47.960008 systemd-logind[1373]: New session 3 of user core. Sep 4 17:14:47.970497 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 4 17:14:48.024356 sshd[1471]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:48.028101 systemd[1]: sshd@2-10.0.0.19:22-10.0.0.1:40310.service: Deactivated successfully. Sep 4 17:14:48.029761 systemd[1]: session-3.scope: Deactivated successfully. Sep 4 17:14:48.030332 systemd-logind[1373]: Session 3 logged out. Waiting for processes to exit. Sep 4 17:14:48.031256 systemd-logind[1373]: Removed session 3. Sep 4 17:14:48.655375 systemd-networkd[1326]: eth0: Gained IPv6LL Sep 4 17:14:48.658916 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 4 17:14:48.661011 systemd[1]: Reached target network-online.target - Network is Online. Sep 4 17:14:48.671605 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Sep 4 17:14:48.674049 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 4 17:14:48.693483 systemd[1]: coreos-metadata.service: Deactivated successfully. Sep 4 17:14:48.693760 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Sep 4 17:14:48.695676 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 4 17:14:48.699263 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 4 17:14:48.701015 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 4 17:14:48.702790 systemd[1]: Startup finished in 829ms (kernel) + 4.215s (initrd) + 3.828s (userspace) = 8.873s. Sep 4 17:14:57.914474 systemd[1]: Started sshd@3-10.0.0.19:22-10.0.0.1:40352.service - OpenSSH per-connection server daemon (10.0.0.1:40352). Sep 4 17:14:57.946077 sshd[1496]: Accepted publickey for core from 10.0.0.1 port 40352 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:57.947321 sshd[1496]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:57.950844 systemd-logind[1373]: New session 4 of user core. Sep 4 17:14:57.960308 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 4 17:14:58.012976 sshd[1496]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:58.032437 systemd[1]: sshd@3-10.0.0.19:22-10.0.0.1:40352.service: Deactivated successfully. Sep 4 17:14:58.033982 systemd[1]: session-4.scope: Deactivated successfully. Sep 4 17:14:58.035393 systemd-logind[1373]: Session 4 logged out. Waiting for processes to exit. Sep 4 17:14:58.036649 systemd[1]: Started sshd@4-10.0.0.19:22-10.0.0.1:40362.service - OpenSSH per-connection server daemon (10.0.0.1:40362). Sep 4 17:14:58.037460 systemd-logind[1373]: Removed session 4. Sep 4 17:14:58.069356 sshd[1503]: Accepted publickey for core from 10.0.0.1 port 40362 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:58.070898 sshd[1503]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:58.074546 systemd-logind[1373]: New session 5 of user core. Sep 4 17:14:58.089302 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 4 17:14:58.138274 sshd[1503]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:58.145526 systemd[1]: sshd@4-10.0.0.19:22-10.0.0.1:40362.service: Deactivated successfully. Sep 4 17:14:58.149437 systemd[1]: session-5.scope: Deactivated successfully. Sep 4 17:14:58.150862 systemd-logind[1373]: Session 5 logged out. Waiting for processes to exit. Sep 4 17:14:58.151998 systemd[1]: Started sshd@5-10.0.0.19:22-10.0.0.1:40374.service - OpenSSH per-connection server daemon (10.0.0.1:40374). Sep 4 17:14:58.152981 systemd-logind[1373]: Removed session 5. Sep 4 17:14:58.185412 sshd[1510]: Accepted publickey for core from 10.0.0.1 port 40374 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:58.186947 sshd[1510]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:58.191288 systemd-logind[1373]: New session 6 of user core. Sep 4 17:14:58.201313 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 4 17:14:58.255595 sshd[1510]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:58.270893 systemd[1]: sshd@5-10.0.0.19:22-10.0.0.1:40374.service: Deactivated successfully. Sep 4 17:14:58.273264 systemd[1]: session-6.scope: Deactivated successfully. Sep 4 17:14:58.275347 systemd-logind[1373]: Session 6 logged out. Waiting for processes to exit. Sep 4 17:14:58.286599 systemd[1]: Started sshd@6-10.0.0.19:22-10.0.0.1:40376.service - OpenSSH per-connection server daemon (10.0.0.1:40376). Sep 4 17:14:58.287901 systemd-logind[1373]: Removed session 6. Sep 4 17:14:58.317594 sshd[1517]: Accepted publickey for core from 10.0.0.1 port 40376 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:58.319307 sshd[1517]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:58.323523 systemd-logind[1373]: New session 7 of user core. Sep 4 17:14:58.333417 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 4 17:14:58.391752 sudo[1520]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Sep 4 17:14:58.392046 sudo[1520]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 4 17:14:58.408510 sudo[1520]: pam_unix(sudo:session): session closed for user root Sep 4 17:14:58.410817 sshd[1517]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:58.420311 systemd[1]: sshd@6-10.0.0.19:22-10.0.0.1:40376.service: Deactivated successfully. Sep 4 17:14:58.421985 systemd[1]: session-7.scope: Deactivated successfully. Sep 4 17:14:58.423570 systemd-logind[1373]: Session 7 logged out. Waiting for processes to exit. Sep 4 17:14:58.431692 systemd[1]: Started sshd@7-10.0.0.19:22-10.0.0.1:40384.service - OpenSSH per-connection server daemon (10.0.0.1:40384). Sep 4 17:14:58.432853 systemd-logind[1373]: Removed session 7. Sep 4 17:14:58.461339 sshd[1525]: Accepted publickey for core from 10.0.0.1 port 40384 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:58.463203 sshd[1525]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:58.467286 systemd-logind[1373]: New session 8 of user core. Sep 4 17:14:58.478361 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 4 17:14:58.533002 sudo[1529]: 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 Sep 4 17:14:58.533315 sudo[1529]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 4 17:14:58.537100 sudo[1529]: pam_unix(sudo:session): session closed for user root Sep 4 17:14:58.543478 sudo[1528]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Sep 4 17:14:58.543768 sudo[1528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 4 17:14:58.565548 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Sep 4 17:14:58.567244 auditctl[1532]: No rules Sep 4 17:14:58.568518 systemd[1]: audit-rules.service: Deactivated successfully. Sep 4 17:14:58.568852 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Sep 4 17:14:58.570912 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 4 17:14:58.604721 augenrules[1550]: No rules Sep 4 17:14:58.606537 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 4 17:14:58.607872 sudo[1528]: pam_unix(sudo:session): session closed for user root Sep 4 17:14:58.609647 sshd[1525]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:58.621803 systemd[1]: sshd@7-10.0.0.19:22-10.0.0.1:40384.service: Deactivated successfully. Sep 4 17:14:58.623514 systemd[1]: session-8.scope: Deactivated successfully. Sep 4 17:14:58.625053 systemd-logind[1373]: Session 8 logged out. Waiting for processes to exit. Sep 4 17:14:58.641423 systemd[1]: Started sshd@8-10.0.0.19:22-10.0.0.1:40388.service - OpenSSH per-connection server daemon (10.0.0.1:40388). Sep 4 17:14:58.642532 systemd-logind[1373]: Removed session 8. Sep 4 17:14:58.670202 sshd[1558]: Accepted publickey for core from 10.0.0.1 port 40388 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:58.671675 sshd[1558]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:58.675569 systemd-logind[1373]: New session 9 of user core. Sep 4 17:14:58.689441 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 4 17:14:58.756499 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 17:14:58.756646 (dockerd)[1562]: 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 Sep 4 17:14:59.196538 dockerd[1562]: time="2024-09-04T17:14:59.196405311Z" level=info msg="Starting up" Sep 4 17:14:59.232089 systemd[1]: var-lib-docker-metacopy\x2dcheck3165401915-merged.mount: Deactivated successfully. Sep 4 17:14:59.259496 dockerd[1562]: time="2024-09-04T17:14:59.259449844Z" level=info msg="Loading containers: start." Sep 4 17:14:59.409222 kernel: Initializing XFRM netlink socket Sep 4 17:14:59.502694 systemd-networkd[1326]: docker0: Link UP Sep 4 17:14:59.525140 dockerd[1562]: time="2024-09-04T17:14:59.525091050Z" level=info msg="Loading containers: done." Sep 4 17:14:59.616324 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck881342480-merged.mount: Deactivated successfully. Sep 4 17:14:59.623661 dockerd[1562]: time="2024-09-04T17:14:59.623584939Z" 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 Sep 4 17:14:59.623902 dockerd[1562]: time="2024-09-04T17:14:59.623854909Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Sep 4 17:14:59.624066 dockerd[1562]: time="2024-09-04T17:14:59.624036118Z" level=info msg="Daemon has completed initialization" Sep 4 17:14:59.753233 dockerd[1562]: time="2024-09-04T17:14:59.753065528Z" level=info msg="API listen on /run/docker.sock" Sep 4 17:14:59.753308 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 17:14:59.767727 sshd[1558]: pam_unix(sshd:session): session closed for user core Sep 4 17:14:59.785038 systemd[1]: sshd@8-10.0.0.19:22-10.0.0.1:40388.service: Deactivated successfully. Sep 4 17:14:59.786943 systemd[1]: session-9.scope: Deactivated successfully. Sep 4 17:14:59.788694 systemd-logind[1373]: Session 9 logged out. Waiting for processes to exit. Sep 4 17:14:59.803466 systemd[1]: Started sshd@9-10.0.0.19:22-10.0.0.1:40392.service - OpenSSH per-connection server daemon (10.0.0.1:40392). Sep 4 17:14:59.804350 systemd-logind[1373]: Removed session 9. Sep 4 17:14:59.832031 sshd[1691]: Accepted publickey for core from 10.0.0.1 port 40392 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:14:59.833478 sshd[1691]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:14:59.837656 systemd-logind[1373]: New session 10 of user core. Sep 4 17:14:59.853325 systemd[1]: Started session-10.scope - Session 10 of User core. Sep 4 17:15:01.512929 systemd[1]: var-lib-docker-overlay2-3ee5582c12e1259e6d661a98b567587d0c3f12ca28a49cb667de376a148a8b65\x2dinit-merged.mount: Deactivated successfully. Sep 4 17:15:01.559839 kernel: docker0: port 1(vetha7bc29e) entered blocking state Sep 4 17:15:01.559978 kernel: docker0: port 1(vetha7bc29e) entered disabled state Sep 4 17:15:01.560000 kernel: vetha7bc29e: entered allmulticast mode Sep 4 17:15:01.561325 kernel: vetha7bc29e: entered promiscuous mode Sep 4 17:15:01.561584 systemd-networkd[1326]: vetha7bc29e: Link UP Sep 4 17:15:01.827877 containerd[1390]: time="2024-09-04T17:15:01.827549777Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 17:15:01.827877 containerd[1390]: time="2024-09-04T17:15:01.827624410Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:01.827877 containerd[1390]: time="2024-09-04T17:15:01.827641660Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 17:15:01.827877 containerd[1390]: time="2024-09-04T17:15:01.827654668Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:01.872314 systemd[1]: Started docker-b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a.scope - libcontainer container b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a. Sep 4 17:15:02.003215 kernel: eth0: renamed from veth2c7b0d2 Sep 4 17:15:02.014296 kernel: docker0: port 1(vetha7bc29e) entered blocking state Sep 4 17:15:02.014341 kernel: docker0: port 1(vetha7bc29e) entered forwarding state Sep 4 17:15:02.014482 systemd-networkd[1326]: vetha7bc29e: Gained carrier Sep 4 17:15:02.015000 systemd-networkd[1326]: docker0: Gained carrier Sep 4 17:15:02.019506 systemd-resolved[1257]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 17:15:02.053399 sshd[1691]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:02.061007 systemd[1]: sshd@9-10.0.0.19:22-10.0.0.1:40392.service: Deactivated successfully. Sep 4 17:15:02.062681 systemd[1]: session-10.scope: Deactivated successfully. Sep 4 17:15:02.063383 systemd-logind[1373]: Session 10 logged out. Waiting for processes to exit. Sep 4 17:15:02.077743 systemd[1]: Started sshd@10-10.0.0.19:22-10.0.0.1:40394.service - OpenSSH per-connection server daemon (10.0.0.1:40394). Sep 4 17:15:02.079462 systemd-logind[1373]: Removed session 10. Sep 4 17:15:02.109572 sshd[1772]: Accepted publickey for core from 10.0.0.1 port 40394 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:02.111234 sshd[1772]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:02.115791 systemd-logind[1373]: New session 11 of user core. Sep 4 17:15:02.122346 systemd[1]: Started session-11.scope - Session 11 of User core. Sep 4 17:15:02.181231 sshd[1772]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:02.199051 systemd[1]: sshd@10-10.0.0.19:22-10.0.0.1:40394.service: Deactivated successfully. Sep 4 17:15:02.200701 systemd[1]: session-11.scope: Deactivated successfully. Sep 4 17:15:02.201384 systemd-logind[1373]: Session 11 logged out. Waiting for processes to exit. Sep 4 17:15:02.213449 systemd[1]: Started sshd@11-10.0.0.19:22-10.0.0.1:40400.service - OpenSSH per-connection server daemon (10.0.0.1:40400). Sep 4 17:15:02.214312 systemd-logind[1373]: Removed session 11. Sep 4 17:15:02.242426 sshd[1779]: Accepted publickey for core from 10.0.0.1 port 40400 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:02.243998 sshd[1779]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:02.248244 systemd-logind[1373]: New session 12 of user core. Sep 4 17:15:02.258499 systemd[1]: Started session-12.scope - Session 12 of User core. Sep 4 17:15:02.312047 sudo[1782]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGTERM 1390 Sep 4 17:15:02.312350 sudo[1782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 4 17:15:02.329269 sudo[1782]: pam_unix(sudo:session): session closed for user root Sep 4 17:15:02.329476 containerd[1390]: time="2024-09-04T17:15:02.329320227Z" level=info msg="Stop CRI service" Sep 4 17:15:02.330284 dockerd[1562]: time="2024-09-04T17:15:02.329568045Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 4 17:15:02.330284 dockerd[1562]: time="2024-09-04T17:15:02.329624633Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 4 17:15:02.330284 dockerd[1562]: time="2024-09-04T17:15:02.329720642Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 4 17:15:02.330284 dockerd[1562]: time="2024-09-04T17:15:02.329757855Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 4 17:15:02.330878 sshd[1779]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:02.341503 systemd[1]: containerd.service: Deactivated successfully. Sep 4 17:15:02.341578 systemd[1]: containerd.service: Unit process 1726 (containerd-shim) remains running after unit stopped. Sep 4 17:15:02.342249 systemd[1]: sshd@11-10.0.0.19:22-10.0.0.1:40400.service: Deactivated successfully. Sep 4 17:15:02.343789 systemd[1]: session-12.scope: Deactivated successfully. Sep 4 17:15:02.345010 systemd-logind[1373]: Session 12 logged out. Waiting for processes to exit. Sep 4 17:15:02.361434 systemd[1]: Started sshd@12-10.0.0.19:22-10.0.0.1:40402.service - OpenSSH per-connection server daemon (10.0.0.1:40402). Sep 4 17:15:02.362216 systemd-logind[1373]: Removed session 12. Sep 4 17:15:02.391273 sshd[1788]: Accepted publickey for core from 10.0.0.1 port 40402 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:02.392712 sshd[1788]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:02.396356 systemd-logind[1373]: New session 13 of user core. Sep 4 17:15:02.405299 systemd[1]: Started session-13.scope - Session 13 of User core. Sep 4 17:15:02.460199 sshd[1788]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:02.464089 systemd[1]: sshd@12-10.0.0.19:22-10.0.0.1:40402.service: Deactivated successfully. Sep 4 17:15:02.465986 systemd[1]: session-13.scope: Deactivated successfully. Sep 4 17:15:02.466590 systemd-logind[1373]: Session 13 logged out. Waiting for processes to exit. Sep 4 17:15:02.467438 systemd-logind[1373]: Removed session 13. Sep 4 17:15:03.439428 systemd-networkd[1326]: docker0: Gained IPv6LL Sep 4 17:15:04.015363 systemd-networkd[1326]: vetha7bc29e: Gained IPv6LL Sep 4 17:15:07.592062 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Sep 4 17:15:07.592570 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 4 17:15:07.592721 dockerd[1562]: time="2024-09-04T17:15:07.592649285Z" level=info msg="Processing signal 'terminated'" Sep 4 17:15:08.458270 systemd[1]: Started sshd@13-10.0.0.19:22-10.0.0.1:41890.service - OpenSSH per-connection server daemon (10.0.0.1:41890). Sep 4 17:15:08.494929 sshd[1795]: Accepted publickey for core from 10.0.0.1 port 41890 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:08.496911 sshd[1795]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:08.501471 systemd-logind[1373]: New session 14 of user core. Sep 4 17:15:08.511349 systemd[1]: Started session-14.scope - Session 14 of User core. Sep 4 17:15:08.568115 sshd[1795]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:08.572164 systemd[1]: sshd@13-10.0.0.19:22-10.0.0.1:41890.service: Deactivated successfully. Sep 4 17:15:08.574049 systemd[1]: session-14.scope: Deactivated successfully. Sep 4 17:15:08.574670 systemd-logind[1373]: Session 14 logged out. Waiting for processes to exit. Sep 4 17:15:08.575599 systemd-logind[1373]: Removed session 14. Sep 4 17:15:11.559756 dockerd[1562]: time="2024-09-04T17:15:11.559666332Z" level=error msg="Error sending stop (signal 15) to container" container=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a error="Cannot kill container b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a: connection error: desc = \"transport: Error while dialing dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Sep 4 17:15:11.559756 dockerd[1562]: time="2024-09-04T17:15:11.559740071Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a Sep 4 17:15:14.575002 systemd[1]: Started sshd@14-10.0.0.19:22-10.0.0.1:41906.service - OpenSSH per-connection server daemon (10.0.0.1:41906). Sep 4 17:15:14.608028 sshd[1802]: Accepted publickey for core from 10.0.0.1 port 41906 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:14.609447 sshd[1802]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:14.613401 systemd-logind[1373]: New session 15 of user core. Sep 4 17:15:14.622323 systemd[1]: Started session-15.scope - Session 15 of User core. Sep 4 17:15:14.677955 sshd[1802]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:14.681554 systemd[1]: sshd@14-10.0.0.19:22-10.0.0.1:41906.service: Deactivated successfully. Sep 4 17:15:14.683827 systemd[1]: session-15.scope: Deactivated successfully. Sep 4 17:15:14.684461 systemd-logind[1373]: Session 15 logged out. Waiting for processes to exit. Sep 4 17:15:14.685295 systemd-logind[1373]: Removed session 15. Sep 4 17:15:20.687008 systemd[1]: Started sshd@15-10.0.0.19:22-10.0.0.1:33738.service - OpenSSH per-connection server daemon (10.0.0.1:33738). Sep 4 17:15:20.721703 sshd[1809]: Accepted publickey for core from 10.0.0.1 port 33738 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:20.723288 sshd[1809]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:20.727724 systemd-logind[1373]: New session 16 of user core. Sep 4 17:15:20.739526 systemd[1]: Started session-16.scope - Session 16 of User core. Sep 4 17:15:20.797293 sshd[1809]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:20.801699 systemd[1]: sshd@15-10.0.0.19:22-10.0.0.1:33738.service: Deactivated successfully. Sep 4 17:15:20.804081 systemd[1]: session-16.scope: Deactivated successfully. Sep 4 17:15:20.804824 systemd-logind[1373]: Session 16 logged out. Waiting for processes to exit. Sep 4 17:15:20.805640 systemd-logind[1373]: Removed session 16. Sep 4 17:15:21.560953 dockerd[1562]: time="2024-09-04T17:15:21.560894002Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a error="context deadline exceeded" Sep 4 17:15:21.561667 systemd[1]: docker-b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a.scope: Deactivated successfully. Sep 4 17:15:22.593467 dockerd[1562]: time="2024-09-04T17:15:22.593367003Z" level=error msg="Force shutdown daemon" Sep 4 17:15:22.593467 dockerd[1562]: time="2024-09-04T17:15:22.593452018Z" level=info msg="Daemon shutdown complete" Sep 4 17:15:22.601563 systemd[1]: docker.service: Deactivated successfully. Sep 4 17:15:22.601886 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 4 17:15:22.601947 systemd[1]: docker.service: Consumed 1.688s CPU time. Sep 4 17:15:22.602506 systemd[1]: docker.socket: Deactivated successfully. Sep 4 17:15:22.602815 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 4 17:15:22.602858 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 4 17:15:22.604621 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 17:15:22.615522 systemd[1]: containerd.service: Found left-over process 1726 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 17:15:22.615534 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 17:15:22.616586 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 17:15:22.616935 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 17:15:22.632181 systemd[1]: containerd.service: Found left-over process 1726 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 17:15:22.632231 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 17:15:22.637675 (ntainerd)[1821]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 17:15:22.658648 containerd[1821]: time="2024-09-04T17:15:22.658578290Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Sep 4 17:15:22.681047 containerd[1821]: time="2024-09-04T17:15:22.680955901Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 17:15:22.681047 containerd[1821]: time="2024-09-04T17:15:22.681020587Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.682844 containerd[1821]: time="2024-09-04T17:15:22.682790841Z" 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.48-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:15:22.682844 containerd[1821]: time="2024-09-04T17:15:22.682820026Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683058 containerd[1821]: time="2024-09-04T17:15:22.683021356Z" 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 Sep 4 17:15:22.683058 containerd[1821]: time="2024-09-04T17:15:22.683040263Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 17:15:22.683058 containerd[1821]: time="2024-09-04T17:15:22.683061383Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683166 containerd[1821]: time="2024-09-04T17:15:22.683082634Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683166 containerd[1821]: time="2024-09-04T17:15:22.683092674Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683166 containerd[1821]: time="2024-09-04T17:15:22.683115378Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683290 containerd[1821]: time="2024-09-04T17:15:22.683251692Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683290 containerd[1821]: time="2024-09-04T17:15:22.683268214Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Sep 4 17:15:22.683290 containerd[1821]: time="2024-09-04T17:15:22.683277322Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:22.683457 containerd[1821]: time="2024-09-04T17:15:22.683423494Z" 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 Sep 4 17:15:22.683457 containerd[1821]: time="2024-09-04T17:15:22.683442200Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 17:15:22.683526 containerd[1821]: time="2024-09-04T17:15:22.683459033Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Sep 4 17:15:22.683526 containerd[1821]: time="2024-09-04T17:15:22.683469173Z" level=info msg="metadata content store policy set" policy=shared Sep 4 17:15:22.683677 containerd[1821]: time="2024-09-04T17:15:22.683645574Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 17:15:22.683677 containerd[1821]: time="2024-09-04T17:15:22.683668277Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 17:15:22.683742 containerd[1821]: time="2024-09-04T17:15:22.683682966Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 17:15:22.683742 containerd[1821]: time="2024-09-04T17:15:22.683719286Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 17:15:22.683742 containerd[1821]: time="2024-09-04T17:15:22.683737431Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 17:15:22.683826 containerd[1821]: time="2024-09-04T17:15:22.683752090Z" level=info msg="NRI interface is disabled by configuration." Sep 4 17:15:22.683826 containerd[1821]: time="2024-09-04T17:15:22.683767449Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 17:15:22.691783 containerd[1821]: time="2024-09-04T17:15:22.691745850Z" level=info msg="cleaning leaked shim process" id=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a namespace=moby Sep 4 17:15:22.701833 containerd[1821]: time="2024-09-04T17:15:22.701735412Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 4 17:15:22.702724 containerd[1821]: time="2024-09-04T17:15:22.702356794Z" level=info msg="shim disconnected" id=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a namespace=moby Sep 4 17:15:22.702724 containerd[1821]: time="2024-09-04T17:15:22.702508327Z" level=warning msg="cleaning up after shim disconnected" id=b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a namespace=moby Sep 4 17:15:22.702724 containerd[1821]: time="2024-09-04T17:15:22.702528426Z" level=info msg="cleaning up dead shim" namespace=moby Sep 4 17:15:22.716644 containerd[1821]: time="2024-09-04T17:15:22.716589121Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 17:15:22.716644 containerd[1821]: time="2024-09-04T17:15:22.716624750Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 17:15:22.716644 containerd[1821]: time="2024-09-04T17:15:22.716639087Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 17:15:22.716644 containerd[1821]: time="2024-09-04T17:15:22.716652042Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716666080Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716683163Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716695797Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716707970Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716720906Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716733290Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716744471Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716755623Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 17:15:22.716830 containerd[1821]: time="2024-09-04T17:15:22.716808595Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 17:15:22.717171 containerd[1821]: time="2024-09-04T17:15:22.717119216Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 17:15:22.717235 containerd[1821]: time="2024-09-04T17:15:22.717214029Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717276 containerd[1821]: time="2024-09-04T17:15:22.717243446Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 17:15:22.717305 containerd[1821]: time="2024-09-04T17:15:22.717284074Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 17:15:22.717414 containerd[1821]: time="2024-09-04T17:15:22.717384178Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717449 containerd[1821]: time="2024-09-04T17:15:22.717418114Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717449 containerd[1821]: time="2024-09-04T17:15:22.717437632Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717509 containerd[1821]: time="2024-09-04T17:15:22.717454484Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717509 containerd[1821]: time="2024-09-04T17:15:22.717476277Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717509 containerd[1821]: time="2024-09-04T17:15:22.717496897Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717594 containerd[1821]: time="2024-09-04T17:15:22.717522346Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717594 containerd[1821]: time="2024-09-04T17:15:22.717540841Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717594 containerd[1821]: time="2024-09-04T17:15:22.717562613Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 17:15:22.717678 containerd[1821]: time="2024-09-04T17:15:22.717616729Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717678 containerd[1821]: time="2024-09-04T17:15:22.717635495Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717678 containerd[1821]: time="2024-09-04T17:15:22.717652418Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717678 containerd[1821]: time="2024-09-04T17:15:22.717672436Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717790 containerd[1821]: time="2024-09-04T17:15:22.717690932Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717790 containerd[1821]: time="2024-09-04T17:15:22.717710740Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717790 containerd[1821]: time="2024-09-04T17:15:22.717727432Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.717790 containerd[1821]: time="2024-09-04T17:15:22.717742993Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 17:15:22.718110 containerd[1821]: time="2024-09-04T17:15:22.718039917Z" 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}" Sep 4 17:15:22.718322 containerd[1821]: time="2024-09-04T17:15:22.718112828Z" level=info msg="Connect containerd service" Sep 4 17:15:22.718322 containerd[1821]: time="2024-09-04T17:15:22.718149048Z" level=info msg="using legacy CRI server" Sep 4 17:15:22.718322 containerd[1821]: time="2024-09-04T17:15:22.718168615Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 17:15:22.718413 containerd[1821]: time="2024-09-04T17:15:22.718352932Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 17:15:22.718947 containerd[1821]: time="2024-09-04T17:15:22.718914097Z" 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" Sep 4 17:15:22.718999 containerd[1821]: time="2024-09-04T17:15:22.718976008Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 17:15:22.719035 containerd[1821]: time="2024-09-04T17:15:22.719000454Z" 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 Sep 4 17:15:22.719035 containerd[1821]: time="2024-09-04T17:15:22.719014943Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 17:15:22.719096 containerd[1821]: time="2024-09-04T17:15:22.719032166Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 17:15:22.719096 containerd[1821]: time="2024-09-04T17:15:22.719058577Z" level=info msg="Start subscribing containerd event" Sep 4 17:15:22.719150 containerd[1821]: time="2024-09-04T17:15:22.719100999Z" level=info msg="Start recovering state" Sep 4 17:15:22.719183 containerd[1821]: time="2024-09-04T17:15:22.719161085Z" level=info msg="Start event monitor" Sep 4 17:15:22.719183 containerd[1821]: time="2024-09-04T17:15:22.719182497Z" level=info msg="Start snapshots syncer" Sep 4 17:15:22.719183 containerd[1821]: time="2024-09-04T17:15:22.719201664Z" level=info msg="Start cni network conf syncer for default" Sep 4 17:15:22.719295 containerd[1821]: time="2024-09-04T17:15:22.719210962Z" level=info msg="Start streaming server" Sep 4 17:15:22.719417 containerd[1821]: time="2024-09-04T17:15:22.719362695Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 17:15:22.719528 containerd[1821]: time="2024-09-04T17:15:22.719446728Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 17:15:22.719528 containerd[1821]: time="2024-09-04T17:15:22.719514830Z" level=info msg="containerd successfully booted in 0.061570s" Sep 4 17:15:22.719651 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 17:15:22.727615 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 17:15:22.727628 (dockerd)[1855]: 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 Sep 4 17:15:22.767514 dockerd[1855]: time="2024-09-04T17:15:22.767447728Z" level=info msg="Starting up" Sep 4 17:15:22.793539 dockerd[1855]: time="2024-09-04T17:15:22.793496470Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 4 17:15:22.813470 dockerd[1855]: time="2024-09-04T17:15:22.813430485Z" level=info msg="Loading containers: start." Sep 4 17:15:22.827716 systemd[1]: var-lib-docker-overlay2-3ee5582c12e1259e6d661a98b567587d0c3f12ca28a49cb667de376a148a8b65-merged.mount: Deactivated successfully. Sep 4 17:15:23.024455 dockerd[1855]: time="2024-09-04T17:15:23.024385369Z" level=info msg="Removing stale sandbox d3a0e2e0d25f51b0504d6ff56861e66def7a5fb6e49a872b20c87205b8d82958 (b899d3e929f9c9b1485a24165662f0d3d1f1c0b976187fdb9d07dcc961e7ed9a)" Sep 4 17:15:23.030531 systemd-networkd[1326]: vetha7bc29e: Link DOWN Sep 4 17:15:23.030544 systemd-networkd[1326]: vetha7bc29e: Lost carrier Sep 4 17:15:23.031679 dockerd[1855]: time="2024-09-04T17:15:23.031640158Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 2bc586763e44f7f38f6c050c8518836cd41a659793eab493edce3bd4a4789f08 5ca4216db9b6880f55684b7a104dc1c43180627b3c1e97426d45035cfe702f94], retrying...." Sep 4 17:15:23.032850 kernel: docker0: port 1(vetha7bc29e) entered disabled state Sep 4 17:15:23.032917 kernel: vetha7bc29e (unregistering): left allmulticast mode Sep 4 17:15:23.032936 kernel: vetha7bc29e (unregistering): left promiscuous mode Sep 4 17:15:23.034578 kernel: docker0: port 1(vetha7bc29e) entered disabled state Sep 4 17:15:23.041133 systemd-networkd[1326]: docker0: Lost carrier Sep 4 17:15:23.144439 dockerd[1855]: time="2024-09-04T17:15:23.144378756Z" 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" Sep 4 17:15:23.205883 dockerd[1855]: time="2024-09-04T17:15:23.205845851Z" level=info msg="Loading containers: done." Sep 4 17:15:23.220603 dockerd[1855]: time="2024-09-04T17:15:23.220557599Z" 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 Sep 4 17:15:23.220802 dockerd[1855]: time="2024-09-04T17:15:23.220776552Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Sep 4 17:15:23.220844 dockerd[1855]: time="2024-09-04T17:15:23.220829393Z" level=info msg="Daemon has completed initialization" Sep 4 17:15:23.238988 dockerd[1855]: time="2024-09-04T17:15:23.238928623Z" level=info msg="API listen on /run/docker.sock" Sep 4 17:15:23.239126 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 17:15:23.779736 systemd[1]: run-docker-netns-d3a0e2e0d25f.mount: Deactivated successfully. Sep 4 17:15:26.811909 systemd[1]: Started sshd@16-10.0.0.19:22-10.0.0.1:45396.service - OpenSSH per-connection server daemon (10.0.0.1:45396). Sep 4 17:15:26.844362 sshd[1995]: Accepted publickey for core from 10.0.0.1 port 45396 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:26.845740 sshd[1995]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:26.849253 systemd-logind[1373]: New session 17 of user core. Sep 4 17:15:26.859326 systemd[1]: Started session-17.scope - Session 17 of User core. Sep 4 17:15:26.914099 sshd[1995]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:26.931673 systemd[1]: sshd@16-10.0.0.19:22-10.0.0.1:45396.service: Deactivated successfully. Sep 4 17:15:26.933344 systemd[1]: session-17.scope: Deactivated successfully. Sep 4 17:15:26.934673 systemd-logind[1373]: Session 17 logged out. Waiting for processes to exit. Sep 4 17:15:26.943482 systemd[1]: Started sshd@17-10.0.0.19:22-10.0.0.1:45410.service - OpenSSH per-connection server daemon (10.0.0.1:45410). Sep 4 17:15:26.944288 systemd-logind[1373]: Removed session 17. Sep 4 17:15:26.971468 sshd[2002]: Accepted publickey for core from 10.0.0.1 port 45410 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:26.972902 sshd[2002]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:26.976552 systemd-logind[1373]: New session 18 of user core. Sep 4 17:15:26.987322 systemd[1]: Started session-18.scope - Session 18 of User core. Sep 4 17:15:27.042801 sshd[2002]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.055782 systemd[1]: sshd@17-10.0.0.19:22-10.0.0.1:45410.service: Deactivated successfully. Sep 4 17:15:27.057465 systemd[1]: session-18.scope: Deactivated successfully. Sep 4 17:15:27.058704 systemd-logind[1373]: Session 18 logged out. Waiting for processes to exit. Sep 4 17:15:27.059918 systemd[1]: Started sshd@18-10.0.0.19:22-10.0.0.1:45420.service - OpenSSH per-connection server daemon (10.0.0.1:45420). Sep 4 17:15:27.060622 systemd-logind[1373]: Removed session 18. Sep 4 17:15:27.092123 sshd[2009]: Accepted publickey for core from 10.0.0.1 port 45420 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:27.093557 sshd[2009]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:27.097168 systemd-logind[1373]: New session 19 of user core. Sep 4 17:15:27.107359 systemd[1]: Started session-19.scope - Session 19 of User core. Sep 4 17:15:27.166987 sshd[2009]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.182920 systemd[1]: sshd@18-10.0.0.19:22-10.0.0.1:45420.service: Deactivated successfully. Sep 4 17:15:27.184599 systemd[1]: session-19.scope: Deactivated successfully. Sep 4 17:15:27.185931 systemd-logind[1373]: Session 19 logged out. Waiting for processes to exit. Sep 4 17:15:27.187208 systemd[1]: Started sshd@19-10.0.0.19:22-10.0.0.1:45434.service - OpenSSH per-connection server daemon (10.0.0.1:45434). Sep 4 17:15:27.187928 systemd-logind[1373]: Removed session 19. Sep 4 17:15:27.234862 sshd[2023]: Accepted publickey for core from 10.0.0.1 port 45434 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:27.236475 sshd[2023]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:27.240637 systemd-logind[1373]: New session 20 of user core. Sep 4 17:15:27.250363 systemd[1]: Started session-20.scope - Session 20 of User core. Sep 4 17:15:27.327279 systemd[1]: var-lib-docker-overlay2-28401a71e81e517580ffc12f65176bb2348028a5c77db1832c1f75cea082304f\x2dinit-merged.mount: Deactivated successfully. Sep 4 17:15:27.361649 kernel: docker0: port 1(vethc16ec5a) entered blocking state Sep 4 17:15:27.361776 kernel: docker0: port 1(vethc16ec5a) entered disabled state Sep 4 17:15:27.361794 kernel: vethc16ec5a: entered allmulticast mode Sep 4 17:15:27.363298 kernel: vethc16ec5a: entered promiscuous mode Sep 4 17:15:27.363444 systemd-networkd[1326]: vethc16ec5a: Link UP Sep 4 17:15:27.398589 containerd[1821]: time="2024-09-04T17:15:27.398453906Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 17:15:27.398589 containerd[1821]: time="2024-09-04T17:15:27.398523730Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:27.398589 containerd[1821]: time="2024-09-04T17:15:27.398540783Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 17:15:27.398589 containerd[1821]: time="2024-09-04T17:15:27.398553298Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:27.423328 systemd[1]: Started docker-fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340.scope - libcontainer container fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340. Sep 4 17:15:27.491228 kernel: eth0: renamed from veth3b136e2 Sep 4 17:15:27.507223 kernel: docker0: port 1(vethc16ec5a) entered blocking state Sep 4 17:15:27.507259 kernel: docker0: port 1(vethc16ec5a) entered forwarding state Sep 4 17:15:27.507182 systemd-networkd[1326]: vethc16ec5a: Gained carrier Sep 4 17:15:27.507492 systemd-networkd[1326]: docker0: Gained carrier Sep 4 17:15:27.512007 systemd-resolved[1257]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 17:15:27.544324 sshd[2023]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.552843 systemd[1]: sshd@19-10.0.0.19:22-10.0.0.1:45434.service: Deactivated successfully. Sep 4 17:15:27.554533 systemd[1]: session-20.scope: Deactivated successfully. Sep 4 17:15:27.555185 systemd-logind[1373]: Session 20 logged out. Waiting for processes to exit. Sep 4 17:15:27.570407 systemd[1]: Started sshd@20-10.0.0.19:22-10.0.0.1:45444.service - OpenSSH per-connection server daemon (10.0.0.1:45444). Sep 4 17:15:27.570884 systemd-logind[1373]: Removed session 20. Sep 4 17:15:27.598877 sshd[2098]: Accepted publickey for core from 10.0.0.1 port 45444 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:27.600367 sshd[2098]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:27.604297 systemd-logind[1373]: New session 21 of user core. Sep 4 17:15:27.615319 systemd[1]: Started session-21.scope - Session 21 of User core. Sep 4 17:15:27.671282 sshd[2098]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.688026 systemd[1]: sshd@20-10.0.0.19:22-10.0.0.1:45444.service: Deactivated successfully. Sep 4 17:15:27.689658 systemd[1]: session-21.scope: Deactivated successfully. Sep 4 17:15:27.690335 systemd-logind[1373]: Session 21 logged out. Waiting for processes to exit. Sep 4 17:15:27.692601 systemd[1]: Started sshd@21-10.0.0.19:22-10.0.0.1:45450.service - OpenSSH per-connection server daemon (10.0.0.1:45450). Sep 4 17:15:27.693051 systemd-logind[1373]: Removed session 21. Sep 4 17:15:27.726631 sshd[2105]: Accepted publickey for core from 10.0.0.1 port 45450 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:27.728223 sshd[2105]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:27.731988 systemd-logind[1373]: New session 22 of user core. Sep 4 17:15:27.741292 systemd[1]: Started session-22.scope - Session 22 of User core. Sep 4 17:15:27.794010 sudo[2108]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGHUP 1821 Sep 4 17:15:27.794311 sudo[2108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Sep 4 17:15:27.797997 sudo[2108]: pam_unix(sudo:session): session closed for user root Sep 4 17:15:27.799889 sshd[2105]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.802675 dockerd[1855]: time="2024-09-04T17:15:27.802528300Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Sep 4 17:15:27.802675 dockerd[1855]: time="2024-09-04T17:15:27.802567134Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Sep 4 17:15:27.802675 dockerd[1855]: time="2024-09-04T17:15:27.802633011Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Sep 4 17:15:27.802675 dockerd[1855]: time="2024-09-04T17:15:27.802666185Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Sep 4 17:15:27.811811 systemd[1]: containerd.service: Deactivated successfully. Sep 4 17:15:27.811881 systemd[1]: containerd.service: Unit process 2052 (containerd-shim) remains running after unit stopped. Sep 4 17:15:27.812544 systemd[1]: sshd@21-10.0.0.19:22-10.0.0.1:45450.service: Deactivated successfully. Sep 4 17:15:27.814234 systemd[1]: session-22.scope: Deactivated successfully. Sep 4 17:15:27.816558 systemd-logind[1373]: Session 22 logged out. Waiting for processes to exit. Sep 4 17:15:27.827405 systemd[1]: Started sshd@22-10.0.0.19:22-10.0.0.1:45460.service - OpenSSH per-connection server daemon (10.0.0.1:45460). Sep 4 17:15:27.828179 systemd-logind[1373]: Removed session 22. Sep 4 17:15:27.855887 sshd[2114]: Accepted publickey for core from 10.0.0.1 port 45460 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:27.857339 sshd[2114]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:27.861059 systemd-logind[1373]: New session 23 of user core. Sep 4 17:15:27.870299 systemd[1]: Started session-23.scope - Session 23 of User core. Sep 4 17:15:27.926135 sshd[2114]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:27.929972 systemd[1]: sshd@22-10.0.0.19:22-10.0.0.1:45460.service: Deactivated successfully. Sep 4 17:15:27.931840 systemd[1]: session-23.scope: Deactivated successfully. Sep 4 17:15:27.932487 systemd-logind[1373]: Session 23 logged out. Waiting for processes to exit. Sep 4 17:15:27.933330 systemd-logind[1373]: Removed session 23. Sep 4 17:15:29.551373 systemd-networkd[1326]: vethc16ec5a: Gained IPv6LL Sep 4 17:15:32.835017 update_engine[1384]: I0904 17:15:32.834928 1384 update_attempter.cc:509] Updating boot flags... Sep 4 17:15:32.854496 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Sep 4 17:15:32.855089 systemd[1]: Stopping docker.service - Docker Application Container Engine... Sep 4 17:15:32.855741 dockerd[1855]: time="2024-09-04T17:15:32.855662914Z" level=info msg="Processing signal 'terminated'" Sep 4 17:15:32.874254 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2127) Sep 4 17:15:32.912209 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2125) Sep 4 17:15:32.945332 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 33 scanned by (udev-worker) (2125) Sep 4 17:15:33.945023 systemd[1]: Started sshd@23-10.0.0.19:22-10.0.0.1:45476.service - OpenSSH per-connection server daemon (10.0.0.1:45476). Sep 4 17:15:33.977681 sshd[2136]: Accepted publickey for core from 10.0.0.1 port 45476 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:33.979038 sshd[2136]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:33.982486 systemd-logind[1373]: New session 24 of user core. Sep 4 17:15:33.995313 systemd[1]: Started session-24.scope - Session 24 of User core. Sep 4 17:15:34.050693 sshd[2136]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:34.054718 systemd[1]: sshd@23-10.0.0.19:22-10.0.0.1:45476.service: Deactivated successfully. Sep 4 17:15:34.056534 systemd[1]: session-24.scope: Deactivated successfully. Sep 4 17:15:34.057156 systemd-logind[1373]: Session 24 logged out. Waiting for processes to exit. Sep 4 17:15:34.057970 systemd-logind[1373]: Removed session 24. Sep 4 17:15:34.857083 dockerd[1855]: time="2024-09-04T17:15:34.856979184Z" level=error msg="Error sending stop (signal 15) to container" container=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 error="Cannot kill container fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340: connection error: desc = \"transport: Error while dialing dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Sep 4 17:15:34.857083 dockerd[1855]: time="2024-09-04T17:15:34.857057112Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 Sep 4 17:15:40.061906 systemd[1]: Started sshd@24-10.0.0.19:22-10.0.0.1:35340.service - OpenSSH per-connection server daemon (10.0.0.1:35340). Sep 4 17:15:40.094395 sshd[2143]: Accepted publickey for core from 10.0.0.1 port 35340 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:40.095850 sshd[2143]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:40.099500 systemd-logind[1373]: New session 25 of user core. Sep 4 17:15:40.110296 systemd[1]: Started session-25.scope - Session 25 of User core. Sep 4 17:15:40.165085 sshd[2143]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:40.168311 systemd[1]: sshd@24-10.0.0.19:22-10.0.0.1:35340.service: Deactivated successfully. Sep 4 17:15:40.169956 systemd[1]: session-25.scope: Deactivated successfully. Sep 4 17:15:40.170494 systemd-logind[1373]: Session 25 logged out. Waiting for processes to exit. Sep 4 17:15:40.171379 systemd-logind[1373]: Removed session 25. Sep 4 17:15:44.859216 dockerd[1855]: time="2024-09-04T17:15:44.859113035Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 error="context deadline exceeded" Sep 4 17:15:44.860065 systemd[1]: docker-fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340.scope: Deactivated successfully. Sep 4 17:15:46.177103 systemd[1]: Started sshd@25-10.0.0.19:22-10.0.0.1:35348.service - OpenSSH per-connection server daemon (10.0.0.1:35348). Sep 4 17:15:46.209968 sshd[2150]: Accepted publickey for core from 10.0.0.1 port 35348 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:46.211422 sshd[2150]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:46.215129 systemd-logind[1373]: New session 26 of user core. Sep 4 17:15:46.231343 systemd[1]: Started session-26.scope - Session 26 of User core. Sep 4 17:15:46.286886 sshd[2150]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:46.290693 systemd[1]: sshd@25-10.0.0.19:22-10.0.0.1:35348.service: Deactivated successfully. Sep 4 17:15:46.292479 systemd[1]: session-26.scope: Deactivated successfully. Sep 4 17:15:46.293077 systemd-logind[1373]: Session 26 logged out. Waiting for processes to exit. Sep 4 17:15:46.293956 systemd-logind[1373]: Removed session 26. Sep 4 17:15:47.856311 dockerd[1855]: time="2024-09-04T17:15:47.856233946Z" level=error msg="Force shutdown daemon" Sep 4 17:15:47.856311 dockerd[1855]: time="2024-09-04T17:15:47.856290273Z" level=info msg="Daemon shutdown complete" Sep 4 17:15:47.862483 systemd[1]: docker.service: Deactivated successfully. Sep 4 17:15:47.862864 systemd[1]: Stopped docker.service - Docker Application Container Engine. Sep 4 17:15:47.863478 systemd[1]: docker.socket: Deactivated successfully. Sep 4 17:15:47.863792 systemd[1]: Closed docker.socket - Docker Socket for the API. Sep 4 17:15:47.863836 systemd[1]: Stopping docker.socket - Docker Socket for the API... Sep 4 17:15:47.865873 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 4 17:15:47.866066 systemd[1]: containerd.service: Found left-over process 2052 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 17:15:47.866076 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 17:15:47.876428 systemd[1]: Starting containerd.service - containerd container runtime... Sep 4 17:15:47.877382 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 4 17:15:47.886595 systemd[1]: containerd.service: Found left-over process 2052 (containerd-shim) in control group while starting unit. Ignoring. Sep 4 17:15:47.886607 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Sep 4 17:15:47.891668 (ntainerd)[2162]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 4 17:15:47.910051 containerd[2162]: time="2024-09-04T17:15:47.909962915Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Sep 4 17:15:47.932842 containerd[2162]: time="2024-09-04T17:15:47.932804264Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 4 17:15:47.932888 containerd[2162]: time="2024-09-04T17:15:47.932843449Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934453 containerd[2162]: time="2024-09-04T17:15:47.934381933Z" 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.48-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934453 containerd[2162]: time="2024-09-04T17:15:47.934443971Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934707 containerd[2162]: time="2024-09-04T17:15:47.934678104Z" 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 Sep 4 17:15:47.934707 containerd[2162]: time="2024-09-04T17:15:47.934700767Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 4 17:15:47.934770 containerd[2162]: time="2024-09-04T17:15:47.934725022Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934770 containerd[2162]: time="2024-09-04T17:15:47.934748587Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934770 containerd[2162]: time="2024-09-04T17:15:47.934760119Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934824 containerd[2162]: time="2024-09-04T17:15:47.934782661Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934920 containerd[2162]: time="2024-09-04T17:15:47.934894383Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.934942 containerd[2162]: time="2024-09-04T17:15:47.934920964Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Sep 4 17:15:47.934942 containerd[2162]: time="2024-09-04T17:15:47.934936343Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 4 17:15:47.935111 containerd[2162]: time="2024-09-04T17:15:47.935086738Z" 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 Sep 4 17:15:47.935111 containerd[2162]: time="2024-09-04T17:15:47.935104461Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 4 17:15:47.935156 containerd[2162]: time="2024-09-04T17:15:47.935121734Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Sep 4 17:15:47.935156 containerd[2162]: time="2024-09-04T17:15:47.935132454Z" level=info msg="metadata content store policy set" policy=shared Sep 4 17:15:47.935361 containerd[2162]: time="2024-09-04T17:15:47.935337192Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 4 17:15:47.935389 containerd[2162]: time="2024-09-04T17:15:47.935366868Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 4 17:15:47.935389 containerd[2162]: time="2024-09-04T17:15:47.935381516Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 4 17:15:47.935426 containerd[2162]: time="2024-09-04T17:15:47.935411392Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 4 17:15:47.935453 containerd[2162]: time="2024-09-04T17:15:47.935427032Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 4 17:15:47.935453 containerd[2162]: time="2024-09-04T17:15:47.935438624Z" level=info msg="NRI interface is disabled by configuration." Sep 4 17:15:47.935453 containerd[2162]: time="2024-09-04T17:15:47.935449685Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 4 17:15:47.942885 containerd[2162]: time="2024-09-04T17:15:47.942858026Z" level=info msg="cleaning leaked shim process" id=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 namespace=moby Sep 4 17:15:47.951795 containerd[2162]: time="2024-09-04T17:15:47.951731192Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Sep 4 17:15:47.952097 containerd[2162]: time="2024-09-04T17:15:47.952031390Z" level=info msg="shim disconnected" id=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 namespace=moby Sep 4 17:15:47.952139 containerd[2162]: time="2024-09-04T17:15:47.952098717Z" level=warning msg="cleaning up after shim disconnected" id=fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340 namespace=moby Sep 4 17:15:47.952139 containerd[2162]: time="2024-09-04T17:15:47.952108105Z" level=info msg="cleaning up dead shim" namespace=moby Sep 4 17:15:47.965501 containerd[2162]: time="2024-09-04T17:15:47.965475302Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 4 17:15:47.965545 containerd[2162]: time="2024-09-04T17:15:47.965501822Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 4 17:15:47.965545 containerd[2162]: time="2024-09-04T17:15:47.965520236Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 4 17:15:47.965545 containerd[2162]: time="2024-09-04T17:15:47.965533793Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 4 17:15:47.965622 containerd[2162]: time="2024-09-04T17:15:47.965548921Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965622 containerd[2162]: time="2024-09-04T17:15:47.965566163Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965622 containerd[2162]: time="2024-09-04T17:15:47.965587414Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965622 containerd[2162]: time="2024-09-04T17:15:47.965600068Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965622 containerd[2162]: time="2024-09-04T17:15:47.965613413Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965804 containerd[2162]: time="2024-09-04T17:15:47.965626969Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965804 containerd[2162]: time="2024-09-04T17:15:47.965638510Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.965804 containerd[2162]: time="2024-09-04T17:15:47.965649141Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 4 17:15:47.965804 containerd[2162]: time="2024-09-04T17:15:47.965697732Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 4 17:15:47.966056 containerd[2162]: time="2024-09-04T17:15:47.966026475Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 4 17:15:47.966083 containerd[2162]: time="2024-09-04T17:15:47.966064618Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966083 containerd[2162]: time="2024-09-04T17:15:47.966078865Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 4 17:15:47.966122 containerd[2162]: time="2024-09-04T17:15:47.966102058Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 4 17:15:47.966170 containerd[2162]: time="2024-09-04T17:15:47.966158094Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966205 containerd[2162]: time="2024-09-04T17:15:47.966172623Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966205 containerd[2162]: time="2024-09-04T17:15:47.966184064Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966249 containerd[2162]: time="2024-09-04T17:15:47.966207769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966249 containerd[2162]: time="2024-09-04T17:15:47.966219951Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966249 containerd[2162]: time="2024-09-04T17:15:47.966231885Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966249 containerd[2162]: time="2024-09-04T17:15:47.966243216Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966320 containerd[2162]: time="2024-09-04T17:15:47.966253856Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966320 containerd[2162]: time="2024-09-04T17:15:47.966267101Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 4 17:15:47.966320 containerd[2162]: time="2024-09-04T17:15:47.966297008Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966320 containerd[2162]: time="2024-09-04T17:15:47.966309231Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966320512Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966332214Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966343807Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966356160Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966368273Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966393 containerd[2162]: time="2024-09-04T17:15:47.966378201Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 4 17:15:47.966626 containerd[2162]: time="2024-09-04T17:15:47.966581136Z" 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}" Sep 4 17:15:47.966717 containerd[2162]: time="2024-09-04T17:15:47.966632673Z" level=info msg="Connect containerd service" Sep 4 17:15:47.966717 containerd[2162]: time="2024-09-04T17:15:47.966652802Z" level=info msg="using legacy CRI server" Sep 4 17:15:47.966717 containerd[2162]: time="2024-09-04T17:15:47.966659404Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 4 17:15:47.966786 containerd[2162]: time="2024-09-04T17:15:47.966736410Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 4 17:15:47.967125 containerd[2162]: time="2024-09-04T17:15:47.967099298Z" 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" Sep 4 17:15:47.967164 containerd[2162]: time="2024-09-04T17:15:47.967146677Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 4 17:15:47.967196 containerd[2162]: time="2024-09-04T17:15:47.967164501Z" 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 Sep 4 17:15:47.967196 containerd[2162]: time="2024-09-04T17:15:47.967174269Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 4 17:15:47.967234 containerd[2162]: time="2024-09-04T17:15:47.967201300Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 4 17:15:47.967326 containerd[2162]: time="2024-09-04T17:15:47.967267686Z" level=info msg="Start subscribing containerd event" Sep 4 17:15:47.967353 containerd[2162]: time="2024-09-04T17:15:47.967339783Z" level=info msg="Start recovering state" Sep 4 17:15:47.967426 containerd[2162]: time="2024-09-04T17:15:47.967407221Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 4 17:15:47.967426 containerd[2162]: time="2024-09-04T17:15:47.967419053Z" level=info msg="Start event monitor" Sep 4 17:15:47.967464 containerd[2162]: time="2024-09-04T17:15:47.967443168Z" level=info msg="Start snapshots syncer" Sep 4 17:15:47.967464 containerd[2162]: time="2024-09-04T17:15:47.967456073Z" level=info msg="Start cni network conf syncer for default" Sep 4 17:15:47.967506 containerd[2162]: time="2024-09-04T17:15:47.967460171Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 4 17:15:47.967506 containerd[2162]: time="2024-09-04T17:15:47.967464980Z" level=info msg="Start streaming server" Sep 4 17:15:47.967546 containerd[2162]: time="2024-09-04T17:15:47.967535694Z" level=info msg="containerd successfully booted in 0.058144s" Sep 4 17:15:47.967652 systemd[1]: Started containerd.service - containerd container runtime. Sep 4 17:15:47.980448 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 4 17:15:47.980636 (dockerd)[2196]: 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 Sep 4 17:15:48.019092 dockerd[2196]: time="2024-09-04T17:15:48.019037133Z" level=info msg="Starting up" Sep 4 17:15:48.036504 systemd[1]: var-lib-docker-overlay2-check\x2doverlayfs\x2dsupport3143668753-merged.mount: Deactivated successfully. Sep 4 17:15:48.051450 dockerd[2196]: time="2024-09-04T17:15:48.051405365Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Sep 4 17:15:48.072542 dockerd[2196]: time="2024-09-04T17:15:48.072504974Z" level=info msg="Loading containers: start." Sep 4 17:15:48.089324 systemd[1]: var-lib-docker-overlay2-28401a71e81e517580ffc12f65176bb2348028a5c77db1832c1f75cea082304f-merged.mount: Deactivated successfully. Sep 4 17:15:48.292829 dockerd[2196]: time="2024-09-04T17:15:48.292793628Z" level=info msg="Removing stale sandbox f27d7e23164a194c93d77692cbd8b43b3cdf29bf2d57d1aab647dd2c9a616135 (fe69be56c867f704cecf86e52080c97d638720bcb1326824cb37883c3655b340)" Sep 4 17:15:48.298907 dockerd[2196]: time="2024-09-04T17:15:48.298861556Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 996cdbee2040d9e6382831c5569cf553e386c9dc3e058386c18243f5744a3c27 d27b8fb2ec6d051977fe1dceafdd3fe3894818dbdeeb514a3f8d4b566b18ec82], retrying...." Sep 4 17:15:48.301633 systemd-networkd[1326]: vethc16ec5a: Link DOWN Sep 4 17:15:48.301646 systemd-networkd[1326]: vethc16ec5a: Lost carrier Sep 4 17:15:48.305161 kernel: docker0: port 1(vethc16ec5a) entered disabled state Sep 4 17:15:48.305280 kernel: vethc16ec5a (unregistering): left allmulticast mode Sep 4 17:15:48.305308 kernel: vethc16ec5a (unregistering): left promiscuous mode Sep 4 17:15:48.305784 kernel: docker0: port 1(vethc16ec5a) entered disabled state Sep 4 17:15:48.326003 systemd-networkd[1326]: docker0: Lost carrier Sep 4 17:15:48.487641 dockerd[2196]: time="2024-09-04T17:15:48.487558667Z" 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" Sep 4 17:15:48.602162 dockerd[2196]: time="2024-09-04T17:15:48.601967969Z" level=info msg="Loading containers: done." Sep 4 17:15:48.640938 dockerd[2196]: time="2024-09-04T17:15:48.640851348Z" 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 Sep 4 17:15:48.641242 dockerd[2196]: time="2024-09-04T17:15:48.641121098Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Sep 4 17:15:48.641242 dockerd[2196]: time="2024-09-04T17:15:48.641174910Z" level=info msg="Daemon has completed initialization" Sep 4 17:15:48.675181 dockerd[2196]: time="2024-09-04T17:15:48.675047421Z" level=info msg="API listen on /run/docker.sock" Sep 4 17:15:48.675299 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 4 17:15:49.034015 systemd[1]: run-docker-netns-f27d7e23164a.mount: Deactivated successfully. Sep 4 17:15:52.298052 systemd[1]: Started sshd@26-10.0.0.19:22-10.0.0.1:46720.service - OpenSSH per-connection server daemon (10.0.0.1:46720). Sep 4 17:15:52.334501 sshd[2335]: Accepted publickey for core from 10.0.0.1 port 46720 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:52.336445 sshd[2335]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:52.340540 systemd-logind[1373]: New session 27 of user core. Sep 4 17:15:52.350350 systemd[1]: Started session-27.scope - Session 27 of User core. Sep 4 17:15:52.409571 sshd[2335]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:52.432472 systemd[1]: sshd@26-10.0.0.19:22-10.0.0.1:46720.service: Deactivated successfully. Sep 4 17:15:52.435016 systemd[1]: session-27.scope: Deactivated successfully. Sep 4 17:15:52.437030 systemd-logind[1373]: Session 27 logged out. Waiting for processes to exit. Sep 4 17:15:52.454718 systemd[1]: Started sshd@27-10.0.0.19:22-10.0.0.1:46724.service - OpenSSH per-connection server daemon (10.0.0.1:46724). Sep 4 17:15:52.455942 systemd-logind[1373]: Removed session 27. Sep 4 17:15:52.484596 sshd[2342]: Accepted publickey for core from 10.0.0.1 port 46724 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:52.486369 sshd[2342]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:52.490466 systemd-logind[1373]: New session 28 of user core. Sep 4 17:15:52.502508 systemd[1]: Started session-28.scope - Session 28 of User core. Sep 4 17:15:52.559133 sshd[2342]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:52.570466 systemd[1]: sshd@27-10.0.0.19:22-10.0.0.1:46724.service: Deactivated successfully. Sep 4 17:15:52.572558 systemd[1]: session-28.scope: Deactivated successfully. Sep 4 17:15:52.574430 systemd-logind[1373]: Session 28 logged out. Waiting for processes to exit. Sep 4 17:15:52.584493 systemd[1]: Started sshd@28-10.0.0.19:22-10.0.0.1:46738.service - OpenSSH per-connection server daemon (10.0.0.1:46738). Sep 4 17:15:52.585419 systemd-logind[1373]: Removed session 28. Sep 4 17:15:52.615545 sshd[2349]: Accepted publickey for core from 10.0.0.1 port 46738 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:52.617502 sshd[2349]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:52.621598 systemd-logind[1373]: New session 29 of user core. Sep 4 17:15:52.632315 systemd[1]: Started session-29.scope - Session 29 of User core. Sep 4 17:15:52.693510 sshd[2349]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:52.709406 systemd[1]: sshd@28-10.0.0.19:22-10.0.0.1:46738.service: Deactivated successfully. Sep 4 17:15:52.711279 systemd[1]: session-29.scope: Deactivated successfully. Sep 4 17:15:52.712642 systemd-logind[1373]: Session 29 logged out. Waiting for processes to exit. Sep 4 17:15:52.722675 systemd[1]: Started sshd@29-10.0.0.19:22-10.0.0.1:46748.service - OpenSSH per-connection server daemon (10.0.0.1:46748). Sep 4 17:15:52.723752 systemd-logind[1373]: Removed session 29. Sep 4 17:15:52.751245 sshd[2364]: Accepted publickey for core from 10.0.0.1 port 46748 ssh2: RSA SHA256:F28rWYKmlRLaaLngTatJxElJeb4TR248U8nI6dv5iIw Sep 4 17:15:52.752932 sshd[2364]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Sep 4 17:15:52.757335 systemd-logind[1373]: New session 30 of user core. Sep 4 17:15:52.764340 systemd[1]: Started session-30.scope - Session 30 of User core. Sep 4 17:15:52.913846 systemd[1]: var-lib-docker-overlay2-3e5b8f36317d35cba3df81a0b0f685559c8dfd6be3d45501e119c55e0e805fc1\x2dinit-merged.mount: Deactivated successfully. Sep 4 17:15:52.942498 kernel: docker0: port 1(veth6b0cb2d) entered blocking state Sep 4 17:15:52.942623 kernel: docker0: port 1(veth6b0cb2d) entered disabled state Sep 4 17:15:52.942662 kernel: veth6b0cb2d: entered allmulticast mode Sep 4 17:15:52.942688 kernel: veth6b0cb2d: entered promiscuous mode Sep 4 17:15:52.942731 systemd-networkd[1326]: veth6b0cb2d: Link UP Sep 4 17:15:52.980595 containerd[2162]: time="2024-09-04T17:15:52.980500388Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 4 17:15:52.980595 containerd[2162]: time="2024-09-04T17:15:52.980561233Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:52.980595 containerd[2162]: time="2024-09-04T17:15:52.980575510Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 4 17:15:52.980595 containerd[2162]: time="2024-09-04T17:15:52.980586261Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 4 17:15:53.003341 systemd[1]: Started docker-4435dd43e49523f45a0666669ef303bd59d96923cf94315caca5ddcf2ff6dbc6.scope - libcontainer container 4435dd43e49523f45a0666669ef303bd59d96923cf94315caca5ddcf2ff6dbc6. Sep 4 17:15:53.068216 kernel: eth0: renamed from veth83e28a8 Sep 4 17:15:53.079488 kernel: docker0: port 1(veth6b0cb2d) entered blocking state Sep 4 17:15:53.079557 kernel: docker0: port 1(veth6b0cb2d) entered forwarding state Sep 4 17:15:53.079585 systemd-networkd[1326]: veth6b0cb2d: Gained carrier Sep 4 17:15:53.079862 systemd-networkd[1326]: docker0: Gained carrier Sep 4 17:15:53.083198 systemd-resolved[1257]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Sep 4 17:15:53.115980 sshd[2364]: pam_unix(sshd:session): session closed for user core Sep 4 17:15:53.119654 systemd[1]: sshd@29-10.0.0.19:22-10.0.0.1:46748.service: Deactivated successfully. Sep 4 17:15:53.121623 systemd[1]: session-30.scope: Deactivated successfully. Sep 4 17:15:53.122167 systemd-logind[1373]: Session 30 logged out. Waiting for processes to exit. Sep 4 17:15:53.122971 systemd-logind[1373]: Removed session 30. Sep 4 17:15:54.383365 systemd-networkd[1326]: veth6b0cb2d: Gained IPv6LL