Aug 5 21:37:07.904783 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 21:37:07.904805 kernel: Linux version 6.6.43-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-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 Mon Aug 5 20:24:20 -00 2024 Aug 5 21:37:07.904815 kernel: KASLR enabled Aug 5 21:37:07.904830 kernel: efi: EFI v2.7 by EDK II Aug 5 21:37:07.904836 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Aug 5 21:37:07.904842 kernel: random: crng init done Aug 5 21:37:07.904849 kernel: ACPI: Early table checksum verification disabled Aug 5 21:37:07.904855 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Aug 5 21:37:07.904861 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 5 21:37:07.904869 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904875 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904881 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904887 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904893 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904900 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904908 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904915 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904921 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 21:37:07.904927 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 21:37:07.904933 kernel: NUMA: Failed to initialise from firmware Aug 5 21:37:07.904940 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 21:37:07.904946 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Aug 5 21:37:07.904952 kernel: Zone ranges: Aug 5 21:37:07.904959 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 21:37:07.904965 kernel: DMA32 empty Aug 5 21:37:07.904972 kernel: Normal empty Aug 5 21:37:07.904978 kernel: Movable zone start for each node Aug 5 21:37:07.904984 kernel: Early memory node ranges Aug 5 21:37:07.904991 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Aug 5 21:37:07.904997 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Aug 5 21:37:07.905003 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 21:37:07.905010 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 21:37:07.905016 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 21:37:07.905022 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 21:37:07.905028 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 21:37:07.905035 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 21:37:07.905041 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 21:37:07.905048 kernel: psci: probing for conduit method from ACPI. Aug 5 21:37:07.905055 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 21:37:07.905061 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 21:37:07.905070 kernel: psci: Trusted OS migration not required Aug 5 21:37:07.905077 kernel: psci: SMC Calling Convention v1.1 Aug 5 21:37:07.905084 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 21:37:07.905091 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 21:37:07.905098 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 21:37:07.905105 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 21:37:07.905112 kernel: Detected PIPT I-cache on CPU0 Aug 5 21:37:07.905118 kernel: CPU features: detected: GIC system register CPU interface Aug 5 21:37:07.905125 kernel: CPU features: detected: Hardware dirty bit management Aug 5 21:37:07.905132 kernel: CPU features: detected: Spectre-v4 Aug 5 21:37:07.905138 kernel: CPU features: detected: Spectre-BHB Aug 5 21:37:07.905145 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 21:37:07.905152 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 21:37:07.905159 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 21:37:07.905166 kernel: alternatives: applying boot alternatives Aug 5 21:37:07.905174 kernel: 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 acpi=force verity.usrhash=bb6c4f94d40caa6d83ad7b7b3f8907e11ce677871c150228b9a5377ddab3341e Aug 5 21:37:07.905181 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 21:37:07.905187 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 21:37:07.905194 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 21:37:07.905201 kernel: Fallback order for Node 0: 0 Aug 5 21:37:07.905207 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 21:37:07.905214 kernel: Policy zone: DMA Aug 5 21:37:07.905221 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 21:37:07.905228 kernel: software IO TLB: area num 4. Aug 5 21:37:07.905236 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 21:37:07.905243 kernel: Memory: 2386852K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185436K reserved, 0K cma-reserved) Aug 5 21:37:07.905250 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 21:37:07.905256 kernel: trace event string verifier disabled Aug 5 21:37:07.905263 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 21:37:07.905270 kernel: rcu: RCU event tracing is enabled. Aug 5 21:37:07.905277 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 21:37:07.905284 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 21:37:07.905291 kernel: Tracing variant of Tasks RCU enabled. Aug 5 21:37:07.905297 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 21:37:07.905304 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 21:37:07.905311 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 21:37:07.905319 kernel: GICv3: 256 SPIs implemented Aug 5 21:37:07.905325 kernel: GICv3: 0 Extended SPIs implemented Aug 5 21:37:07.905332 kernel: Root IRQ handler: gic_handle_irq Aug 5 21:37:07.905339 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 21:37:07.905345 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 21:37:07.905352 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 21:37:07.905359 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 21:37:07.905366 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 21:37:07.905372 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 21:37:07.905379 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 21:37:07.905386 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 21:37:07.905394 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 21:37:07.905401 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 21:37:07.905408 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 21:37:07.905414 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 21:37:07.905421 kernel: arm-pv: using stolen time PV Aug 5 21:37:07.905428 kernel: Console: colour dummy device 80x25 Aug 5 21:37:07.905435 kernel: ACPI: Core revision 20230628 Aug 5 21:37:07.905442 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 21:37:07.905449 kernel: pid_max: default: 32768 minimum: 301 Aug 5 21:37:07.905456 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 21:37:07.905464 kernel: SELinux: Initializing. Aug 5 21:37:07.905470 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 21:37:07.905477 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 21:37:07.905484 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 21:37:07.905491 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 21:37:07.905498 kernel: rcu: Hierarchical SRCU implementation. Aug 5 21:37:07.905505 kernel: rcu: Max phase no-delay instances is 400. Aug 5 21:37:07.905512 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 21:37:07.905519 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 21:37:07.905527 kernel: Remapping and enabling EFI services. Aug 5 21:37:07.905534 kernel: smp: Bringing up secondary CPUs ... Aug 5 21:37:07.905540 kernel: Detected PIPT I-cache on CPU1 Aug 5 21:37:07.905547 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 21:37:07.905554 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 21:37:07.905561 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 21:37:07.905568 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 21:37:07.905575 kernel: Detected PIPT I-cache on CPU2 Aug 5 21:37:07.905582 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 21:37:07.905589 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 21:37:07.905597 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 21:37:07.905604 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 21:37:07.905615 kernel: Detected PIPT I-cache on CPU3 Aug 5 21:37:07.905624 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 21:37:07.905631 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 21:37:07.905638 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 21:37:07.905645 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 21:37:07.905652 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 21:37:07.905659 kernel: SMP: Total of 4 processors activated. Aug 5 21:37:07.905668 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 21:37:07.905675 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 21:37:07.905683 kernel: CPU features: detected: Common not Private translations Aug 5 21:37:07.905690 kernel: CPU features: detected: CRC32 instructions Aug 5 21:37:07.905697 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 21:37:07.905704 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 21:37:07.905712 kernel: CPU features: detected: LSE atomic instructions Aug 5 21:37:07.905719 kernel: CPU features: detected: Privileged Access Never Aug 5 21:37:07.905744 kernel: CPU features: detected: RAS Extension Support Aug 5 21:37:07.905752 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 21:37:07.905759 kernel: CPU: All CPU(s) started at EL1 Aug 5 21:37:07.905766 kernel: alternatives: applying system-wide alternatives Aug 5 21:37:07.905773 kernel: devtmpfs: initialized Aug 5 21:37:07.905780 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 21:37:07.905788 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 21:37:07.905795 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 21:37:07.905802 kernel: SMBIOS 3.0.0 present. Aug 5 21:37:07.905811 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 21:37:07.905822 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 21:37:07.905831 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 21:37:07.905839 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 21:37:07.905846 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 21:37:07.905854 kernel: audit: initializing netlink subsys (disabled) Aug 5 21:37:07.905861 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Aug 5 21:37:07.905868 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 21:37:07.905876 kernel: cpuidle: using governor menu Aug 5 21:37:07.905885 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 21:37:07.905892 kernel: ASID allocator initialised with 32768 entries Aug 5 21:37:07.905900 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 21:37:07.905907 kernel: Serial: AMBA PL011 UART driver Aug 5 21:37:07.905914 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 21:37:07.905921 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 21:37:07.905929 kernel: Modules: 509120 pages in range for PLT usage Aug 5 21:37:07.905936 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 21:37:07.905944 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 21:37:07.905952 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 21:37:07.905959 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 21:37:07.905967 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 21:37:07.905974 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 21:37:07.905981 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 21:37:07.905988 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 21:37:07.905995 kernel: ACPI: Added _OSI(Module Device) Aug 5 21:37:07.906003 kernel: ACPI: Added _OSI(Processor Device) Aug 5 21:37:07.906010 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 21:37:07.906018 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 21:37:07.906025 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 21:37:07.906033 kernel: ACPI: Interpreter enabled Aug 5 21:37:07.906040 kernel: ACPI: Using GIC for interrupt routing Aug 5 21:37:07.906047 kernel: ACPI: MCFG table detected, 1 entries Aug 5 21:37:07.906054 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 21:37:07.906061 kernel: printk: console [ttyAMA0] enabled Aug 5 21:37:07.906069 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 21:37:07.906199 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 21:37:07.906279 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 21:37:07.906348 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 21:37:07.906428 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 21:37:07.906494 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 21:37:07.906504 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 21:37:07.906512 kernel: PCI host bridge to bus 0000:00 Aug 5 21:37:07.906582 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 21:37:07.906646 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 21:37:07.906703 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 21:37:07.906869 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 21:37:07.906953 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 21:37:07.907026 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 21:37:07.907091 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 21:37:07.907162 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 21:37:07.907225 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 21:37:07.907290 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 21:37:07.907354 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 21:37:07.907431 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 21:37:07.907495 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 21:37:07.907568 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 21:37:07.907630 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 21:37:07.907640 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 21:37:07.907647 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 21:37:07.907655 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 21:37:07.907663 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 21:37:07.907670 kernel: iommu: Default domain type: Translated Aug 5 21:37:07.907677 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 21:37:07.907685 kernel: efivars: Registered efivars operations Aug 5 21:37:07.907692 kernel: vgaarb: loaded Aug 5 21:37:07.907702 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 21:37:07.907709 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 21:37:07.907717 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 21:37:07.907734 kernel: pnp: PnP ACPI init Aug 5 21:37:07.907814 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 21:37:07.907831 kernel: pnp: PnP ACPI: found 1 devices Aug 5 21:37:07.907839 kernel: NET: Registered PF_INET protocol family Aug 5 21:37:07.907846 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 21:37:07.907857 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 21:37:07.907864 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 21:37:07.907872 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 21:37:07.907879 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 21:37:07.907886 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 21:37:07.907894 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 21:37:07.907901 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 21:37:07.907908 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 21:37:07.907916 kernel: PCI: CLS 0 bytes, default 64 Aug 5 21:37:07.907924 kernel: kvm [1]: HYP mode not available Aug 5 21:37:07.907931 kernel: Initialise system trusted keyrings Aug 5 21:37:07.907938 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 21:37:07.907946 kernel: Key type asymmetric registered Aug 5 21:37:07.907953 kernel: Asymmetric key parser 'x509' registered Aug 5 21:37:07.907960 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 21:37:07.907967 kernel: io scheduler mq-deadline registered Aug 5 21:37:07.907974 kernel: io scheduler kyber registered Aug 5 21:37:07.907982 kernel: io scheduler bfq registered Aug 5 21:37:07.907990 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 21:37:07.907998 kernel: ACPI: button: Power Button [PWRB] Aug 5 21:37:07.908005 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 21:37:07.908077 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 21:37:07.908088 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 21:37:07.908095 kernel: thunder_xcv, ver 1.0 Aug 5 21:37:07.908102 kernel: thunder_bgx, ver 1.0 Aug 5 21:37:07.908109 kernel: nicpf, ver 1.0 Aug 5 21:37:07.908117 kernel: nicvf, ver 1.0 Aug 5 21:37:07.908192 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 21:37:07.908255 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T21:37:07 UTC (1722893827) Aug 5 21:37:07.908265 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 21:37:07.908276 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 21:37:07.908284 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 21:37:07.908294 kernel: watchdog: Hard watchdog permanently disabled Aug 5 21:37:07.908303 kernel: NET: Registered PF_INET6 protocol family Aug 5 21:37:07.908314 kernel: Segment Routing with IPv6 Aug 5 21:37:07.908323 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 21:37:07.908331 kernel: NET: Registered PF_PACKET protocol family Aug 5 21:37:07.908338 kernel: Key type dns_resolver registered Aug 5 21:37:07.908345 kernel: registered taskstats version 1 Aug 5 21:37:07.908352 kernel: Loading compiled-in X.509 certificates Aug 5 21:37:07.908360 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 7b6de7a842f23ac7c1bb6bedfb9546933daaea09' Aug 5 21:37:07.908367 kernel: Key type .fscrypt registered Aug 5 21:37:07.908374 kernel: Key type fscrypt-provisioning registered Aug 5 21:37:07.908381 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 21:37:07.908390 kernel: ima: Allocated hash algorithm: sha1 Aug 5 21:37:07.908397 kernel: ima: No architecture policies found Aug 5 21:37:07.908405 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 21:37:07.908412 kernel: clk: Disabling unused clocks Aug 5 21:37:07.908419 kernel: Freeing unused kernel memory: 39040K Aug 5 21:37:07.908426 kernel: Run /init as init process Aug 5 21:37:07.908433 kernel: with arguments: Aug 5 21:37:07.908440 kernel: /init Aug 5 21:37:07.908447 kernel: with environment: Aug 5 21:37:07.908456 kernel: HOME=/ Aug 5 21:37:07.908463 kernel: TERM=linux Aug 5 21:37:07.908470 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 21:37:07.908479 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 21:37:07.908488 systemd[1]: Detected virtualization kvm. Aug 5 21:37:07.908500 systemd[1]: Detected architecture arm64. Aug 5 21:37:07.908507 systemd[1]: Running in initrd. Aug 5 21:37:07.908516 systemd[1]: No hostname configured, using default hostname. Aug 5 21:37:07.908524 systemd[1]: Hostname set to . Aug 5 21:37:07.908532 systemd[1]: Initializing machine ID from VM UUID. Aug 5 21:37:07.908539 systemd[1]: Queued start job for default target initrd.target. Aug 5 21:37:07.908547 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 21:37:07.908555 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 21:37:07.908563 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 21:37:07.908571 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 21:37:07.908580 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 21:37:07.908588 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 21:37:07.908598 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 5 21:37:07.908606 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 21:37:07.908614 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 21:37:07.908623 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 21:37:07.908630 systemd[1]: Reached target paths.target - Path Units. Aug 5 21:37:07.908640 systemd[1]: Reached target slices.target - Slice Units. Aug 5 21:37:07.908648 systemd[1]: Reached target swap.target - Swaps. Aug 5 21:37:07.908656 systemd[1]: Reached target timers.target - Timer Units. Aug 5 21:37:07.908664 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 21:37:07.908672 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 21:37:07.908680 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 21:37:07.908688 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 21:37:07.908696 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 21:37:07.908704 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 21:37:07.908714 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 21:37:07.908731 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 21:37:07.908741 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 21:37:07.908749 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 21:37:07.908757 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 21:37:07.908765 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 21:37:07.908773 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 21:37:07.908781 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 21:37:07.908791 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 21:37:07.908799 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 21:37:07.908807 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 21:37:07.908815 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 21:37:07.908829 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 21:37:07.908859 systemd-journald[237]: Collecting audit messages is disabled. Aug 5 21:37:07.908878 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 21:37:07.908886 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 21:37:07.908894 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 21:37:07.908905 systemd-journald[237]: Journal started Aug 5 21:37:07.908924 systemd-journald[237]: Runtime Journal (/run/log/journal/8949419e3b6d4e928a69f5f280a1c9b9) is 5.9M, max 47.3M, 41.4M free. Aug 5 21:37:07.896829 systemd-modules-load[238]: Inserted module 'overlay' Aug 5 21:37:07.911744 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 5 21:37:07.911770 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 21:37:07.913757 kernel: Bridge firewalling registered Aug 5 21:37:07.913777 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 21:37:07.913775 systemd-modules-load[238]: Inserted module 'br_netfilter' Aug 5 21:37:07.917760 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 21:37:07.926892 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 21:37:07.930882 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 21:37:07.932020 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 21:37:07.933845 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 21:37:07.935738 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 21:37:07.945872 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 21:37:07.946867 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 21:37:07.950150 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 21:37:07.957682 dracut-cmdline[273]: dracut-dracut-053 Aug 5 21:37:07.962734 dracut-cmdline[273]: Using kernel command line parameters: rd.driver.pre=btrfs 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 acpi=force verity.usrhash=bb6c4f94d40caa6d83ad7b7b3f8907e11ce677871c150228b9a5377ddab3341e Aug 5 21:37:07.978805 systemd-resolved[275]: Positive Trust Anchors: Aug 5 21:37:07.978825 systemd-resolved[275]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 21:37:07.978856 systemd-resolved[275]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 21:37:07.983479 systemd-resolved[275]: Defaulting to hostname 'linux'. Aug 5 21:37:07.984901 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 21:37:07.986049 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 21:37:08.024750 kernel: SCSI subsystem initialized Aug 5 21:37:08.029743 kernel: Loading iSCSI transport class v2.0-870. Aug 5 21:37:08.037766 kernel: iscsi: registered transport (tcp) Aug 5 21:37:08.049908 kernel: iscsi: registered transport (qla4xxx) Aug 5 21:37:08.049935 kernel: QLogic iSCSI HBA Driver Aug 5 21:37:08.090607 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 21:37:08.098882 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 21:37:08.116398 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 21:37:08.117288 kernel: device-mapper: uevent: version 1.0.3 Aug 5 21:37:08.117308 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 21:37:08.166754 kernel: raid6: neonx8 gen() 14084 MB/s Aug 5 21:37:08.181739 kernel: raid6: neonx4 gen() 15673 MB/s Aug 5 21:37:08.198745 kernel: raid6: neonx2 gen() 13290 MB/s Aug 5 21:37:08.215742 kernel: raid6: neonx1 gen() 10500 MB/s Aug 5 21:37:08.232748 kernel: raid6: int64x8 gen() 6958 MB/s Aug 5 21:37:08.249749 kernel: raid6: int64x4 gen() 7352 MB/s Aug 5 21:37:08.266740 kernel: raid6: int64x2 gen() 6136 MB/s Aug 5 21:37:08.283739 kernel: raid6: int64x1 gen() 5062 MB/s Aug 5 21:37:08.283759 kernel: raid6: using algorithm neonx4 gen() 15673 MB/s Aug 5 21:37:08.300750 kernel: raid6: .... xor() 12098 MB/s, rmw enabled Aug 5 21:37:08.300764 kernel: raid6: using neon recovery algorithm Aug 5 21:37:08.305749 kernel: xor: measuring software checksum speed Aug 5 21:37:08.306740 kernel: 8regs : 19849 MB/sec Aug 5 21:37:08.307942 kernel: 32regs : 19673 MB/sec Aug 5 21:37:08.307958 kernel: arm64_neon : 27215 MB/sec Aug 5 21:37:08.307967 kernel: xor: using function: arm64_neon (27215 MB/sec) Aug 5 21:37:08.359600 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 21:37:08.370719 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 21:37:08.381874 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 21:37:08.392632 systemd-udevd[457]: Using default interface naming scheme 'v255'. Aug 5 21:37:08.395798 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 21:37:08.397940 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 21:37:08.412594 dracut-pre-trigger[464]: rd.md=0: removing MD RAID activation Aug 5 21:37:08.437056 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 21:37:08.451860 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 21:37:08.490594 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 21:37:08.495919 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 21:37:08.508662 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 21:37:08.511700 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 21:37:08.512973 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 21:37:08.514792 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 21:37:08.523919 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 21:37:08.533081 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 21:37:08.540797 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 21:37:08.551067 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 21:37:08.551236 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 21:37:08.554877 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 21:37:08.554997 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 21:37:08.556919 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 21:37:08.560337 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 21:37:08.560477 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 21:37:08.563678 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 21:37:08.568757 kernel: BTRFS: device fsid 8a9ab799-ab52-4671-9234-72d7c6e57b99 devid 1 transid 38 /dev/vda3 scanned by (udev-worker) (511) Aug 5 21:37:08.569744 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (520) Aug 5 21:37:08.575954 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 21:37:08.586807 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 21:37:08.594253 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 21:37:08.598385 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 21:37:08.601920 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. Aug 5 21:37:08.602796 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 21:37:08.608618 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 21:37:08.618908 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 21:37:08.620827 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 21:37:08.626750 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 21:37:08.643229 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 21:37:09.640607 disk-uuid[550]: The operation has completed successfully. Aug 5 21:37:09.641648 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 21:37:09.663020 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 21:37:09.663112 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 21:37:09.690921 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 21:37:09.693716 sh[574]: Success Aug 5 21:37:09.708316 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 21:37:09.756199 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 21:37:09.757741 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 21:37:09.758673 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 21:37:09.771305 kernel: BTRFS info (device dm-0): first mount of filesystem 8a9ab799-ab52-4671-9234-72d7c6e57b99 Aug 5 21:37:09.771345 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 21:37:09.771356 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 21:37:09.771374 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 21:37:09.772735 kernel: BTRFS info (device dm-0): using free space tree Aug 5 21:37:09.786411 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 21:37:09.787644 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 21:37:09.795912 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 21:37:09.797697 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 21:37:09.805773 kernel: BTRFS info (device vda6): first mount of filesystem 2fbfcd26-f9be-477f-9b31-7e91608e027d Aug 5 21:37:09.805810 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 21:37:09.805832 kernel: BTRFS info (device vda6): using free space tree Aug 5 21:37:09.811747 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 21:37:09.819503 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 21:37:09.821010 kernel: BTRFS info (device vda6): last unmount of filesystem 2fbfcd26-f9be-477f-9b31-7e91608e027d Aug 5 21:37:09.828524 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 21:37:09.835928 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 21:37:09.900030 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 21:37:09.911885 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 21:37:09.944773 systemd-networkd[759]: lo: Link UP Aug 5 21:37:09.944780 systemd-networkd[759]: lo: Gained carrier Aug 5 21:37:09.945442 systemd-networkd[759]: Enumeration completed Aug 5 21:37:09.945738 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 21:37:09.945970 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 21:37:09.945973 systemd-networkd[759]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 21:37:09.946772 systemd-networkd[759]: eth0: Link UP Aug 5 21:37:09.946776 systemd-networkd[759]: eth0: Gained carrier Aug 5 21:37:09.946783 systemd-networkd[759]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 21:37:09.947234 systemd[1]: Reached target network.target - Network. Aug 5 21:37:09.965452 ignition[677]: Ignition 2.19.0 Aug 5 21:37:09.965463 ignition[677]: Stage: fetch-offline Aug 5 21:37:09.965495 ignition[677]: no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:09.965503 ignition[677]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:09.965587 ignition[677]: parsed url from cmdline: "" Aug 5 21:37:09.965590 ignition[677]: no config URL provided Aug 5 21:37:09.965595 ignition[677]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 21:37:09.965602 ignition[677]: no config at "/usr/lib/ignition/user.ign" Aug 5 21:37:09.965632 ignition[677]: op(1): [started] loading QEMU firmware config module Aug 5 21:37:09.965637 ignition[677]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 21:37:09.971855 ignition[677]: op(1): [finished] loading QEMU firmware config module Aug 5 21:37:09.974776 systemd-networkd[759]: eth0: DHCPv4 address 10.0.0.43/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 21:37:09.976288 ignition[677]: parsing config with SHA512: f33e1ec160ac8970eff0fdebb1eec0fa67223d123665171cb57a195cc00260e7c7004d968408f4b3295ad587893bb41e971a289155171e4e08340c65fc56fda4 Aug 5 21:37:09.982298 unknown[677]: fetched base config from "system" Aug 5 21:37:09.982308 unknown[677]: fetched user config from "qemu" Aug 5 21:37:09.982478 ignition[677]: fetch-offline: fetch-offline passed Aug 5 21:37:09.984294 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 21:37:09.982549 ignition[677]: Ignition finished successfully Aug 5 21:37:09.985490 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 21:37:09.996880 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 21:37:10.007645 ignition[771]: Ignition 2.19.0 Aug 5 21:37:10.007654 ignition[771]: Stage: kargs Aug 5 21:37:10.007853 ignition[771]: no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:10.007864 ignition[771]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:10.008406 ignition[771]: kargs: kargs passed Aug 5 21:37:10.008449 ignition[771]: Ignition finished successfully Aug 5 21:37:10.011626 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 21:37:10.025119 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 21:37:10.035291 ignition[780]: Ignition 2.19.0 Aug 5 21:37:10.035301 ignition[780]: Stage: disks Aug 5 21:37:10.035458 ignition[780]: no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:10.035468 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:10.036043 ignition[780]: disks: disks passed Aug 5 21:37:10.038357 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 21:37:10.036086 ignition[780]: Ignition finished successfully Aug 5 21:37:10.040290 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 21:37:10.041810 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 21:37:10.043620 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 21:37:10.045118 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 21:37:10.046888 systemd[1]: Reached target basic.target - Basic System. Aug 5 21:37:10.061085 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 21:37:10.076113 systemd-fsck[790]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 21:37:10.081461 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 21:37:10.090893 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 21:37:10.136749 kernel: EXT4-fs (vda9): mounted filesystem ec701988-3dff-4e7d-a2a2-79d78965de5d r/w with ordered data mode. Quota mode: none. Aug 5 21:37:10.136912 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 21:37:10.138046 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 21:37:10.153850 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 21:37:10.156541 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 21:37:10.157422 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 21:37:10.157462 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 21:37:10.157482 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 21:37:10.163646 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 21:37:10.166832 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (798) Aug 5 21:37:10.165858 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 21:37:10.170351 kernel: BTRFS info (device vda6): first mount of filesystem 2fbfcd26-f9be-477f-9b31-7e91608e027d Aug 5 21:37:10.170371 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 21:37:10.170382 kernel: BTRFS info (device vda6): using free space tree Aug 5 21:37:10.172744 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 21:37:10.174213 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 21:37:10.225584 initrd-setup-root[822]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 21:37:10.230869 initrd-setup-root[829]: cut: /sysroot/etc/group: No such file or directory Aug 5 21:37:10.235586 initrd-setup-root[836]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 21:37:10.239441 initrd-setup-root[843]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 21:37:10.324531 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 21:37:10.332405 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 21:37:10.335247 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 21:37:10.342745 kernel: BTRFS info (device vda6): last unmount of filesystem 2fbfcd26-f9be-477f-9b31-7e91608e027d Aug 5 21:37:10.360507 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 21:37:10.362591 ignition[911]: INFO : Ignition 2.19.0 Aug 5 21:37:10.362591 ignition[911]: INFO : Stage: mount Aug 5 21:37:10.362591 ignition[911]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:10.362591 ignition[911]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:10.362591 ignition[911]: INFO : mount: mount passed Aug 5 21:37:10.362591 ignition[911]: INFO : Ignition finished successfully Aug 5 21:37:10.363937 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 21:37:10.370868 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 21:37:10.770198 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 21:37:10.782268 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 21:37:10.789774 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (926) Aug 5 21:37:10.792096 kernel: BTRFS info (device vda6): first mount of filesystem 2fbfcd26-f9be-477f-9b31-7e91608e027d Aug 5 21:37:10.792122 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 21:37:10.792133 kernel: BTRFS info (device vda6): using free space tree Aug 5 21:37:10.794746 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 21:37:10.795281 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 21:37:10.821054 ignition[944]: INFO : Ignition 2.19.0 Aug 5 21:37:10.821054 ignition[944]: INFO : Stage: files Aug 5 21:37:10.822477 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:10.822477 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:10.822477 ignition[944]: DEBUG : files: compiled without relabeling support, skipping Aug 5 21:37:10.825243 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 21:37:10.825243 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 21:37:10.828655 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 21:37:10.829900 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 21:37:10.829900 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 21:37:10.829299 unknown[944]: wrote ssh authorized keys file for user: core Aug 5 21:37:10.832974 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 21:37:10.832974 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(4): [started] processing unit "docker.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(4): [finished] processing unit "docker.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Aug 5 21:37:10.832974 ignition[944]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 21:37:10.857765 ignition[944]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 21:37:10.861754 ignition[944]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 21:37:10.862885 ignition[944]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 21:37:10.862885 ignition[944]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Aug 5 21:37:10.862885 ignition[944]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Aug 5 21:37:10.862885 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 21:37:10.862885 ignition[944]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 21:37:10.862885 ignition[944]: INFO : files: files passed Aug 5 21:37:10.862885 ignition[944]: INFO : Ignition finished successfully Aug 5 21:37:10.865788 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 21:37:10.876907 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 21:37:10.879015 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 21:37:10.881578 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 21:37:10.882552 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 21:37:10.887220 initrd-setup-root-after-ignition[972]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 21:37:10.890435 initrd-setup-root-after-ignition[974]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 21:37:10.890435 initrd-setup-root-after-ignition[974]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 21:37:10.893487 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 21:37:10.894095 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 21:37:10.896242 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 21:37:10.906056 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 21:37:10.924486 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 21:37:10.925491 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 21:37:10.926794 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 21:37:10.928429 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 21:37:10.929878 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 21:37:10.930691 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 21:37:10.946587 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 21:37:10.958375 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 21:37:10.967949 systemd[1]: Stopped target network.target - Network. Aug 5 21:37:10.968961 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 21:37:10.970971 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 21:37:10.972972 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 21:37:10.974605 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 21:37:10.974748 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 21:37:10.976856 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 21:37:10.978736 systemd[1]: Stopped target basic.target - Basic System. Aug 5 21:37:10.980217 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 21:37:10.981758 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 21:37:10.983338 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 21:37:10.984963 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 21:37:10.986312 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 21:37:10.988063 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 21:37:10.989762 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 21:37:10.991445 systemd[1]: Stopped target swap.target - Swaps. Aug 5 21:37:10.992899 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 21:37:10.993025 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 21:37:10.994864 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 21:37:10.996655 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 21:37:10.998174 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 21:37:10.998796 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 21:37:11.000235 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 21:37:11.000344 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 21:37:11.002554 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 21:37:11.002668 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 21:37:11.004375 systemd[1]: Stopped target paths.target - Path Units. Aug 5 21:37:11.005557 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 21:37:11.008794 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 21:37:11.011014 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 21:37:11.011888 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 21:37:11.013450 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 21:37:11.013534 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 21:37:11.015002 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 21:37:11.015082 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 21:37:11.016287 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 21:37:11.016392 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 21:37:11.017903 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 21:37:11.017996 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 21:37:11.028892 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 21:37:11.030459 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 21:37:11.031376 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 21:37:11.032743 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 21:37:11.034135 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 21:37:11.034259 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 21:37:11.036304 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 21:37:11.036407 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 21:37:11.041917 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 21:37:11.042759 systemd-networkd[759]: eth0: DHCPv6 lease lost Aug 5 21:37:11.043675 ignition[999]: INFO : Ignition 2.19.0 Aug 5 21:37:11.043675 ignition[999]: INFO : Stage: umount Aug 5 21:37:11.048104 ignition[999]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 21:37:11.048104 ignition[999]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 21:37:11.048104 ignition[999]: INFO : umount: umount passed Aug 5 21:37:11.048104 ignition[999]: INFO : Ignition finished successfully Aug 5 21:37:11.043751 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 21:37:11.045107 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 21:37:11.045188 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 21:37:11.048082 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 21:37:11.048526 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 21:37:11.048619 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 21:37:11.050960 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 21:37:11.051816 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 21:37:11.053884 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 21:37:11.053990 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 21:37:11.055695 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 21:37:11.055782 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 21:37:11.057621 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 21:37:11.057687 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 21:37:11.059017 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 21:37:11.059056 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 21:37:11.060351 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 21:37:11.060385 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 21:37:11.061986 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 21:37:11.062028 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 21:37:11.063586 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 21:37:11.063627 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 21:37:11.083985 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 21:37:11.084717 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 21:37:11.084794 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 21:37:11.086516 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 21:37:11.086558 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 21:37:11.088030 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 21:37:11.088066 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 21:37:11.090060 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 21:37:11.090107 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 21:37:11.091968 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 21:37:11.101777 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 21:37:11.101922 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 21:37:11.112514 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 21:37:11.112665 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 21:37:11.115083 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 21:37:11.115128 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 21:37:11.116759 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 21:37:11.116803 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 21:37:11.118437 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 21:37:11.118492 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 21:37:11.121145 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 21:37:11.121194 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 21:37:11.123822 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 21:37:11.123867 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 21:37:11.144473 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 21:37:11.145541 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 21:37:11.145602 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 21:37:11.147513 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Aug 5 21:37:11.147557 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 21:37:11.149440 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 21:37:11.149484 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 21:37:11.151473 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 21:37:11.151517 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 21:37:11.153689 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 21:37:11.155553 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 21:37:11.157063 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 21:37:11.159280 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 21:37:11.169318 systemd[1]: Switching root. Aug 5 21:37:11.203705 systemd-journald[237]: Journal stopped Aug 5 21:37:11.841691 systemd-journald[237]: Received SIGTERM from PID 1 (systemd). Aug 5 21:37:11.841763 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 21:37:11.841777 kernel: SELinux: policy capability open_perms=1 Aug 5 21:37:11.841790 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 21:37:11.841799 kernel: SELinux: policy capability always_check_network=0 Aug 5 21:37:11.841820 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 21:37:11.841833 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 21:37:11.841843 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 21:37:11.841852 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 21:37:11.841862 kernel: audit: type=1403 audit(1722893831.266:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 21:37:11.841877 systemd[1]: Successfully loaded SELinux policy in 30.537ms. Aug 5 21:37:11.841897 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 9.371ms. Aug 5 21:37:11.841910 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Aug 5 21:37:11.841922 systemd[1]: Detected virtualization kvm. Aug 5 21:37:11.841932 systemd[1]: Detected architecture arm64. Aug 5 21:37:11.841943 systemd[1]: Detected first boot. Aug 5 21:37:11.841953 systemd[1]: Initializing machine ID from VM UUID. Aug 5 21:37:11.841963 zram_generator::config[1043]: No configuration found. Aug 5 21:37:11.841975 systemd[1]: Populated /etc with preset unit settings. Aug 5 21:37:11.841986 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 21:37:11.841998 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 21:37:11.842009 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 21:37:11.842020 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 21:37:11.842031 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 21:37:11.842041 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 21:37:11.842051 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 21:37:11.842062 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 21:37:11.842077 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 21:37:11.842089 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 21:37:11.842100 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 21:37:11.842111 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 21:37:11.842121 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 21:37:11.842132 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 21:37:11.842146 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 21:37:11.842158 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 21:37:11.842169 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 21:37:11.842179 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 21:37:11.842190 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 21:37:11.842200 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 21:37:11.842211 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 21:37:11.842222 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 21:37:11.842232 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 21:37:11.842245 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 21:37:11.842256 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 21:37:11.842266 systemd[1]: Reached target slices.target - Slice Units. Aug 5 21:37:11.842277 systemd[1]: Reached target swap.target - Swaps. Aug 5 21:37:11.842288 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 21:37:11.842299 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 21:37:11.842309 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 21:37:11.842320 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 21:37:11.842331 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 21:37:11.842344 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 21:37:11.842355 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 21:37:11.842365 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 21:37:11.842375 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 21:37:11.842386 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 21:37:11.842396 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 21:37:11.842406 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 21:37:11.842417 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Aug 5 21:37:11.842428 systemd[1]: Reached target machines.target - Containers. Aug 5 21:37:11.842441 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 21:37:11.842451 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 21:37:11.842462 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 21:37:11.842473 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 21:37:11.842483 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 21:37:11.842494 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 21:37:11.842505 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 21:37:11.842515 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 21:37:11.842527 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 21:37:11.842541 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 21:37:11.842551 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 21:37:11.842562 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 21:37:11.842573 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 21:37:11.842585 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 21:37:11.842596 kernel: fuse: init (API version 7.39) Aug 5 21:37:11.842606 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 21:37:11.842617 kernel: loop: module loaded Aug 5 21:37:11.842629 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 21:37:11.842640 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 21:37:11.842651 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 21:37:11.842661 kernel: ACPI: bus type drm_connector registered Aug 5 21:37:11.842671 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 21:37:11.842681 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 21:37:11.842692 systemd[1]: Stopped verity-setup.service. Aug 5 21:37:11.842703 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 21:37:11.842713 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 21:37:11.842736 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 21:37:11.842766 systemd-journald[1109]: Collecting audit messages is disabled. Aug 5 21:37:11.842787 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 21:37:11.842798 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 21:37:11.842818 systemd-journald[1109]: Journal started Aug 5 21:37:11.842841 systemd-journald[1109]: Runtime Journal (/run/log/journal/8949419e3b6d4e928a69f5f280a1c9b9) is 5.9M, max 47.3M, 41.4M free. Aug 5 21:37:11.646923 systemd[1]: Queued start job for default target multi-user.target. Aug 5 21:37:11.663854 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 21:37:11.664200 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 21:37:11.845777 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 21:37:11.846261 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 21:37:11.847319 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 21:37:11.848432 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 21:37:11.849909 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 21:37:11.850051 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 21:37:11.851189 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 21:37:11.851337 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 21:37:11.852557 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 21:37:11.852713 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 21:37:11.853977 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 21:37:11.854105 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 21:37:11.855459 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 21:37:11.855587 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 21:37:11.858075 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 21:37:11.858212 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 21:37:11.859598 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 21:37:11.860846 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 21:37:11.862453 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 21:37:11.874116 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 21:37:11.885865 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 21:37:11.887712 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 21:37:11.888767 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 21:37:11.888815 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 21:37:11.890656 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 21:37:11.892846 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 21:37:11.894879 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 21:37:11.895961 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 21:37:11.897945 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 21:37:11.900911 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 21:37:11.901964 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 21:37:11.903505 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 21:37:11.904965 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 21:37:11.906142 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 21:37:11.910584 systemd-journald[1109]: Time spent on flushing to /var/log/journal/8949419e3b6d4e928a69f5f280a1c9b9 is 23.695ms for 824 entries. Aug 5 21:37:11.910584 systemd-journald[1109]: System Journal (/var/log/journal/8949419e3b6d4e928a69f5f280a1c9b9) is 8.0M, max 195.6M, 187.6M free. Aug 5 21:37:11.939888 systemd-journald[1109]: Received client request to flush runtime journal. Aug 5 21:37:11.940018 kernel: loop0: detected capacity change from 0 to 113712 Aug 5 21:37:11.940033 kernel: block loop0: the capability attribute has been deprecated. Aug 5 21:37:11.910955 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 21:37:11.916972 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 21:37:11.920205 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 21:37:11.922192 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 21:37:11.924943 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 21:37:11.928399 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 21:37:11.932249 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 21:37:11.937355 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 21:37:11.943761 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 21:37:11.947225 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 21:37:11.950857 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 21:37:11.952452 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 21:37:11.954925 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 21:37:11.959399 systemd-tmpfiles[1155]: ACLs are not supported, ignoring. Aug 5 21:37:11.959414 systemd-tmpfiles[1155]: ACLs are not supported, ignoring. Aug 5 21:37:11.964843 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 21:37:11.973750 kernel: loop1: detected capacity change from 0 to 59688 Aug 5 21:37:11.985043 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 21:37:11.986836 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 21:37:11.988755 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 21:37:11.991574 udevadm[1167]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 5 21:37:12.010754 kernel: loop2: detected capacity change from 0 to 113712 Aug 5 21:37:12.010961 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 21:37:12.022204 kernel: loop3: detected capacity change from 0 to 59688 Aug 5 21:37:12.020962 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 21:37:12.026017 (sd-merge)[1175]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 21:37:12.026362 (sd-merge)[1175]: Merged extensions into '/usr'. Aug 5 21:37:12.029347 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 21:37:12.039394 systemd[1]: Starting ensure-sysext.service... Aug 5 21:37:12.040929 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Aug 5 21:37:12.041187 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Aug 5 21:37:12.043063 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 21:37:12.047162 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 21:37:12.051942 systemd[1]: Reloading requested from client PID 1180 ('systemctl') (unit ensure-sysext.service)... Aug 5 21:37:12.051962 systemd[1]: Reloading... Aug 5 21:37:12.067193 systemd-tmpfiles[1181]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 21:37:12.067980 systemd-tmpfiles[1181]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 21:37:12.068573 systemd-tmpfiles[1181]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 21:37:12.069374 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Aug 5 21:37:12.070168 systemd-tmpfiles[1181]: ACLs are not supported, ignoring. Aug 5 21:37:12.073543 systemd-tmpfiles[1181]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 21:37:12.073553 systemd-tmpfiles[1181]: Skipping /boot Aug 5 21:37:12.086674 systemd-tmpfiles[1181]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 21:37:12.087034 systemd-tmpfiles[1181]: Skipping /boot Aug 5 21:37:12.105775 zram_generator::config[1209]: No configuration found. Aug 5 21:37:12.195786 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Aug 5 21:37:12.233537 systemd[1]: Reloading finished in 181 ms. Aug 5 21:37:12.236267 ldconfig[1148]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 21:37:12.276853 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 21:37:12.291232 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 21:37:12.299760 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 21:37:12.302304 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 21:37:12.304983 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 21:37:12.312064 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 21:37:12.320051 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 21:37:12.322874 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 21:37:12.325576 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 21:37:12.331750 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 21:37:12.335068 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 21:37:12.336285 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 21:37:12.339318 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 21:37:12.339510 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 21:37:12.341900 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 21:37:12.346686 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 21:37:12.350628 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 21:37:12.351388 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 21:37:12.353199 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 21:37:12.354890 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 21:37:12.355019 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 21:37:12.356519 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 21:37:12.357890 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 21:37:12.358003 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 21:37:12.361541 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 21:37:12.361668 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 21:37:12.363026 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 21:37:12.363150 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 21:37:12.366015 systemd[1]: Finished ensure-sysext.service. Aug 5 21:37:12.373579 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 21:37:12.373661 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 21:37:12.379963 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 21:37:12.382652 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 21:37:12.383647 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 5 21:37:12.401212 augenrules[1279]: No rules Aug 5 21:37:12.401226 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 21:37:12.421383 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 21:37:12.438201 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 21:37:12.441281 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 21:37:12.443914 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 21:37:12.456069 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 21:37:12.471192 systemd-udevd[1292]: Using default interface naming scheme 'v255'. Aug 5 21:37:12.480896 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 21:37:12.482284 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 21:37:12.488036 systemd-resolved[1250]: Positive Trust Anchors: Aug 5 21:37:12.488053 systemd-resolved[1250]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 21:37:12.488084 systemd-resolved[1250]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa corp home internal intranet lan local private test Aug 5 21:37:12.492281 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 21:37:12.497633 systemd-resolved[1250]: Defaulting to hostname 'linux'. Aug 5 21:37:12.503985 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 21:37:12.505130 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 21:37:12.509665 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 21:37:12.530782 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1301) Aug 5 21:37:12.532754 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1313) Aug 5 21:37:12.540375 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 21:37:12.551246 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 21:37:12.559996 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 21:37:12.578627 systemd-networkd[1302]: lo: Link UP Aug 5 21:37:12.578634 systemd-networkd[1302]: lo: Gained carrier Aug 5 21:37:12.580206 systemd-networkd[1302]: Enumeration completed Aug 5 21:37:12.580355 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 21:37:12.582075 systemd[1]: Reached target network.target - Network. Aug 5 21:37:12.583844 systemd-networkd[1302]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 21:37:12.583855 systemd-networkd[1302]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 21:37:12.585064 systemd-networkd[1302]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 21:37:12.585103 systemd-networkd[1302]: eth0: Link UP Aug 5 21:37:12.585107 systemd-networkd[1302]: eth0: Gained carrier Aug 5 21:37:12.585116 systemd-networkd[1302]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 21:37:12.593981 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 21:37:12.595965 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 21:37:12.604790 systemd-networkd[1302]: eth0: DHCPv4 address 10.0.0.43/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 21:37:12.606312 systemd-timesyncd[1276]: Network configuration changed, trying to establish connection. Aug 5 21:37:12.607935 systemd-timesyncd[1276]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 21:37:12.607993 systemd-timesyncd[1276]: Initial clock synchronization to Mon 2024-08-05 21:37:12.394518 UTC. Aug 5 21:37:12.627009 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 21:37:12.638567 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 21:37:12.641639 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 21:37:12.664471 lvm[1333]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 21:37:12.671616 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 21:37:12.689198 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 21:37:12.690645 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 21:37:12.691802 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 21:37:12.692952 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 21:37:12.694174 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 5 21:37:12.695546 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 21:37:12.696504 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 21:37:12.697654 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 21:37:12.698854 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 21:37:12.698888 systemd[1]: Reached target paths.target - Path Units. Aug 5 21:37:12.699539 systemd[1]: Reached target timers.target - Timer Units. Aug 5 21:37:12.700822 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 21:37:12.703026 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 21:37:12.721827 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 21:37:12.724056 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 21:37:12.725297 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 21:37:12.726224 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 21:37:12.726939 systemd[1]: Reached target basic.target - Basic System. Aug 5 21:37:12.727858 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 21:37:12.727897 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 21:37:12.728902 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 21:37:12.730701 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 21:37:12.733909 lvm[1340]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 21:37:12.732937 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 21:37:12.737914 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 21:37:12.739367 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Aug 5 21:37:12.740930 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 21:37:12.742913 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 21:37:12.744640 jq[1343]: false Aug 5 21:37:12.746992 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 21:37:12.751832 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 21:37:12.753482 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 21:37:12.754664 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 21:37:12.757651 extend-filesystems[1344]: Found loop2 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found loop3 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda1 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda2 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda3 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found usr Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda4 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda6 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda7 Aug 5 21:37:12.757651 extend-filesystems[1344]: Found vda9 Aug 5 21:37:12.757651 extend-filesystems[1344]: Checking size of /dev/vda9 Aug 5 21:37:12.756097 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 21:37:12.777684 extend-filesystems[1344]: Old size kept for /dev/vda9 Aug 5 21:37:12.758555 dbus-daemon[1342]: [system] SELinux support is enabled Aug 5 21:37:12.761865 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 21:37:12.763254 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 21:37:12.769878 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 21:37:12.781378 jq[1356]: true Aug 5 21:37:12.780291 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 21:37:12.780447 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 21:37:12.780697 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 21:37:12.780971 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 21:37:12.782494 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 21:37:12.782654 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 21:37:12.784411 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 21:37:12.784563 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 21:37:12.790440 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (1315) Aug 5 21:37:12.803047 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Aug 5 21:37:12.803092 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 21:37:12.805531 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Aug 5 21:37:12.805550 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 21:37:12.805904 (ntainerd)[1366]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 21:37:12.811848 jq[1365]: true Aug 5 21:37:12.817662 update_engine[1350]: I0805 21:37:12.817390 1350 main.cc:92] Flatcar Update Engine starting Aug 5 21:37:12.819161 systemd[1]: Started update-engine.service - Update Engine. Aug 5 21:37:12.819458 update_engine[1350]: I0805 21:37:12.819201 1350 update_check_scheduler.cc:74] Next update check in 9m8s Aug 5 21:37:12.824156 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 21:37:12.834476 systemd-logind[1349]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 21:37:12.834941 systemd-logind[1349]: New seat seat0. Aug 5 21:37:12.836122 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 21:37:12.878591 bash[1392]: Updated "/home/core/.ssh/authorized_keys" Aug 5 21:37:12.881161 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 21:37:12.884286 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 21:37:12.888050 locksmithd[1378]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 21:37:12.996259 containerd[1366]: time="2024-08-05T21:37:12.996104040Z" level=info msg="starting containerd" revision=cd7148ac666309abf41fd4a49a8a5895b905e7f3 version=v1.7.18 Aug 5 21:37:13.024330 containerd[1366]: time="2024-08-05T21:37:13.024272772Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 21:37:13.024635 containerd[1366]: time="2024-08-05T21:37:13.024447857Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.025857 containerd[1366]: time="2024-08-05T21:37:13.025812170Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:13.025857 containerd[1366]: time="2024-08-05T21:37:13.025851649Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026093 containerd[1366]: time="2024-08-05T21:37:13.026060333Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026093 containerd[1366]: time="2024-08-05T21:37:13.026085406Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 21:37:13.026196 containerd[1366]: time="2024-08-05T21:37:13.026180677Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026255 containerd[1366]: time="2024-08-05T21:37:13.026240946Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026275 containerd[1366]: time="2024-08-05T21:37:13.026256442Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026323 containerd[1366]: time="2024-08-05T21:37:13.026311338Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026525 containerd[1366]: time="2024-08-05T21:37:13.026500478Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026546 containerd[1366]: time="2024-08-05T21:37:13.026526992Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 21:37:13.026546 containerd[1366]: time="2024-08-05T21:37:13.026537504Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026646 containerd[1366]: time="2024-08-05T21:37:13.026630478Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:13.026669 containerd[1366]: time="2024-08-05T21:37:13.026647803Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 21:37:13.026719 containerd[1366]: time="2024-08-05T21:37:13.026705931Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 21:37:13.026746 containerd[1366]: time="2024-08-05T21:37:13.026720336Z" level=info msg="metadata content store policy set" policy=shared Aug 5 21:37:13.029866 containerd[1366]: time="2024-08-05T21:37:13.029835729Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 21:37:13.029930 containerd[1366]: time="2024-08-05T21:37:13.029871938Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 21:37:13.029930 containerd[1366]: time="2024-08-05T21:37:13.029886927Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 21:37:13.029930 containerd[1366]: time="2024-08-05T21:37:13.029926172Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 21:37:13.029993 containerd[1366]: time="2024-08-05T21:37:13.029940500Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 21:37:13.029993 containerd[1366]: time="2024-08-05T21:37:13.029951207Z" level=info msg="NRI interface is disabled by configuration." Aug 5 21:37:13.029993 containerd[1366]: time="2024-08-05T21:37:13.029964833Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 21:37:13.030159 containerd[1366]: time="2024-08-05T21:37:13.030137504Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 21:37:13.030184 containerd[1366]: time="2024-08-05T21:37:13.030164446Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 21:37:13.030184 containerd[1366]: time="2024-08-05T21:37:13.030178735Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 21:37:13.030217 containerd[1366]: time="2024-08-05T21:37:13.030193374Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 21:37:13.030217 containerd[1366]: time="2024-08-05T21:37:13.030207935Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030248 containerd[1366]: time="2024-08-05T21:37:13.030223898Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030248 containerd[1366]: time="2024-08-05T21:37:13.030237019Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030285 containerd[1366]: time="2024-08-05T21:37:13.030249361Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030285 containerd[1366]: time="2024-08-05T21:37:13.030263571Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030285 containerd[1366]: time="2024-08-05T21:37:13.030279729Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030332 containerd[1366]: time="2024-08-05T21:37:13.030292227Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030332 containerd[1366]: time="2024-08-05T21:37:13.030303517Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 21:37:13.030409 containerd[1366]: time="2024-08-05T21:37:13.030393065Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 21:37:13.030693 containerd[1366]: time="2024-08-05T21:37:13.030678448Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 21:37:13.030726 containerd[1366]: time="2024-08-05T21:37:13.030712710Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030799 containerd[1366]: time="2024-08-05T21:37:13.030738289Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 21:37:13.030799 containerd[1366]: time="2024-08-05T21:37:13.030761494Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 21:37:13.030886 containerd[1366]: time="2024-08-05T21:37:13.030874207Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030911 containerd[1366]: time="2024-08-05T21:37:13.030889975Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030911 containerd[1366]: time="2024-08-05T21:37:13.030901616Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030956 containerd[1366]: time="2024-08-05T21:37:13.030913063Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030956 containerd[1366]: time="2024-08-05T21:37:13.030927390Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030956 containerd[1366]: time="2024-08-05T21:37:13.030939927Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.030956 containerd[1366]: time="2024-08-05T21:37:13.030950906Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031031 containerd[1366]: time="2024-08-05T21:37:13.030961769Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031031 containerd[1366]: time="2024-08-05T21:37:13.030983338Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 21:37:13.031139 containerd[1366]: time="2024-08-05T21:37:13.031111624Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031139 containerd[1366]: time="2024-08-05T21:37:13.031135296Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031189 containerd[1366]: time="2024-08-05T21:37:13.031148378Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031189 containerd[1366]: time="2024-08-05T21:37:13.031162394Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031189 containerd[1366]: time="2024-08-05T21:37:13.031173801Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031189 containerd[1366]: time="2024-08-05T21:37:13.031186961Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031257 containerd[1366]: time="2024-08-05T21:37:13.031200432Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031257 containerd[1366]: time="2024-08-05T21:37:13.031211100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 21:37:13.031627 containerd[1366]: time="2024-08-05T21:37:13.031573183Z" 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}" Aug 5 21:37:13.031739 containerd[1366]: time="2024-08-05T21:37:13.031634892Z" level=info msg="Connect containerd service" Aug 5 21:37:13.031739 containerd[1366]: time="2024-08-05T21:37:13.031663431Z" level=info msg="using legacy CRI server" Aug 5 21:37:13.031739 containerd[1366]: time="2024-08-05T21:37:13.031670050Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 21:37:13.031851 containerd[1366]: time="2024-08-05T21:37:13.031831274Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 21:37:13.032482 containerd[1366]: time="2024-08-05T21:37:13.032450864Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 5 21:37:13.032519 containerd[1366]: time="2024-08-05T21:37:13.032508369Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 21:37:13.032540 containerd[1366]: time="2024-08-05T21:37:13.032527096Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 5 21:37:13.032560 containerd[1366]: time="2024-08-05T21:37:13.032540295Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 21:37:13.032560 containerd[1366]: time="2024-08-05T21:37:13.032552909Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.032782189Z" level=info msg="Start subscribing containerd event" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.032946995Z" level=info msg="Start recovering state" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033017426Z" level=info msg="Start event monitor" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033028912Z" level=info msg="Start snapshots syncer" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033038723Z" level=info msg="Start cni network conf syncer for default" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033045848Z" level=info msg="Start streaming server" Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033130646Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033179507Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 21:37:13.033746 containerd[1366]: time="2024-08-05T21:37:13.033238959Z" level=info msg="containerd successfully booted in 0.039873s" Aug 5 21:37:13.033340 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 21:37:13.309807 sshd_keygen[1364]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 21:37:13.327619 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 21:37:13.338009 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 21:37:13.343332 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 21:37:13.343521 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 21:37:13.347864 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 21:37:13.361822 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 21:37:13.364579 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 21:37:13.366943 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 21:37:13.368326 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 21:37:13.957859 systemd-networkd[1302]: eth0: Gained IPv6LL Aug 5 21:37:13.960152 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 21:37:13.961526 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 21:37:13.972988 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 21:37:13.974661 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 21:37:13.987754 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 21:37:13.987924 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 21:37:13.989610 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 21:37:13.992801 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 21:37:13.993992 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 21:37:13.997832 systemd[1]: Startup finished in 522ms (kernel) + 3.568s (initrd) + 2.763s (userspace) = 6.855s. Aug 5 21:37:20.658280 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 21:37:20.659392 systemd[1]: Started sshd@0-10.0.0.43:22-10.0.0.1:49682.service - OpenSSH per-connection server daemon (10.0.0.1:49682). Aug 5 21:37:20.708760 sshd[1443]: Accepted publickey for core from 10.0.0.1 port 49682 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:20.710615 sshd[1443]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:20.732367 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 21:37:20.742949 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 21:37:20.744856 systemd-logind[1349]: New session 1 of user core. Aug 5 21:37:20.751538 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 21:37:20.753594 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 21:37:20.759272 (systemd)[1447]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:20.830102 systemd[1447]: Queued start job for default target default.target. Aug 5 21:37:20.844663 systemd[1447]: Created slice app.slice - User Application Slice. Aug 5 21:37:20.844691 systemd[1447]: Reached target paths.target - Paths. Aug 5 21:37:20.844703 systemd[1447]: Reached target timers.target - Timers. Aug 5 21:37:20.845836 systemd[1447]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 21:37:20.854839 systemd[1447]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 21:37:20.854889 systemd[1447]: Reached target sockets.target - Sockets. Aug 5 21:37:20.854900 systemd[1447]: Reached target basic.target - Basic System. Aug 5 21:37:20.854933 systemd[1447]: Reached target default.target - Main User Target. Aug 5 21:37:20.854957 systemd[1447]: Startup finished in 88ms. Aug 5 21:37:20.855250 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 21:37:20.856479 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 21:37:20.915353 systemd[1]: Started sshd@1-10.0.0.43:22-10.0.0.1:49688.service - OpenSSH per-connection server daemon (10.0.0.1:49688). Aug 5 21:37:20.951087 sshd[1458]: Accepted publickey for core from 10.0.0.1 port 49688 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:20.952255 sshd[1458]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:20.956265 systemd-logind[1349]: New session 2 of user core. Aug 5 21:37:20.970874 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 21:37:21.021663 sshd[1458]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:21.031959 systemd[1]: sshd@1-10.0.0.43:22-10.0.0.1:49688.service: Deactivated successfully. Aug 5 21:37:21.033217 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 21:37:21.035929 systemd-logind[1349]: Session 2 logged out. Waiting for processes to exit. Aug 5 21:37:21.037492 systemd[1]: Started sshd@2-10.0.0.43:22-10.0.0.1:49700.service - OpenSSH per-connection server daemon (10.0.0.1:49700). Aug 5 21:37:21.040362 systemd-logind[1349]: Removed session 2. Aug 5 21:37:21.073203 sshd[1465]: Accepted publickey for core from 10.0.0.1 port 49700 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:21.074304 sshd[1465]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:21.078212 systemd-logind[1349]: New session 3 of user core. Aug 5 21:37:21.085858 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 21:37:21.133351 sshd[1465]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:21.142000 systemd[1]: sshd@2-10.0.0.43:22-10.0.0.1:49700.service: Deactivated successfully. Aug 5 21:37:21.143249 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 21:37:21.145773 systemd-logind[1349]: Session 3 logged out. Waiting for processes to exit. Aug 5 21:37:21.146770 systemd[1]: Started sshd@3-10.0.0.43:22-10.0.0.1:49716.service - OpenSSH per-connection server daemon (10.0.0.1:49716). Aug 5 21:37:21.148050 systemd-logind[1349]: Removed session 3. Aug 5 21:37:21.183099 sshd[1472]: Accepted publickey for core from 10.0.0.1 port 49716 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:21.184427 sshd[1472]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:21.187612 systemd-logind[1349]: New session 4 of user core. Aug 5 21:37:21.194878 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 21:37:21.244858 sshd[1472]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:21.252876 systemd[1]: sshd@3-10.0.0.43:22-10.0.0.1:49716.service: Deactivated successfully. Aug 5 21:37:21.254049 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 21:37:21.256014 systemd-logind[1349]: Session 4 logged out. Waiting for processes to exit. Aug 5 21:37:21.268158 systemd[1]: Started sshd@4-10.0.0.43:22-10.0.0.1:49718.service - OpenSSH per-connection server daemon (10.0.0.1:49718). Aug 5 21:37:21.269261 systemd-logind[1349]: Removed session 4. Aug 5 21:37:21.300566 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 49718 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:21.301658 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:21.305909 systemd-logind[1349]: New session 5 of user core. Aug 5 21:37:21.314867 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 21:37:21.379674 sudo[1482]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 21:37:21.381792 sudo[1482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 21:37:21.396408 sudo[1482]: pam_unix(sudo:session): session closed for user root Aug 5 21:37:21.397946 sshd[1479]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:21.410982 systemd[1]: sshd@4-10.0.0.43:22-10.0.0.1:49718.service: Deactivated successfully. Aug 5 21:37:21.412356 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 21:37:21.414785 systemd-logind[1349]: Session 5 logged out. Waiting for processes to exit. Aug 5 21:37:21.423052 systemd[1]: Started sshd@5-10.0.0.43:22-10.0.0.1:49730.service - OpenSSH per-connection server daemon (10.0.0.1:49730). Aug 5 21:37:21.425098 systemd-logind[1349]: Removed session 5. Aug 5 21:37:21.455829 sshd[1487]: Accepted publickey for core from 10.0.0.1 port 49730 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:21.457069 sshd[1487]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:21.461094 systemd-logind[1349]: New session 6 of user core. Aug 5 21:37:21.476920 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 21:37:21.526457 sudo[1492]: 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 Aug 5 21:37:21.526690 sudo[1492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 21:37:21.529428 sudo[1492]: pam_unix(sudo:session): session closed for user root Aug 5 21:37:21.533618 sudo[1491]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 21:37:21.533868 sudo[1491]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 21:37:21.550985 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 21:37:21.552097 auditctl[1495]: No rules Aug 5 21:37:21.552949 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 21:37:21.553818 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 21:37:21.555418 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 21:37:21.576717 augenrules[1513]: No rules Aug 5 21:37:21.577352 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 21:37:21.578924 sudo[1491]: pam_unix(sudo:session): session closed for user root Aug 5 21:37:21.580294 sshd[1487]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:21.590926 systemd[1]: sshd@5-10.0.0.43:22-10.0.0.1:49730.service: Deactivated successfully. Aug 5 21:37:21.592588 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 21:37:21.594740 systemd-logind[1349]: Session 6 logged out. Waiting for processes to exit. Aug 5 21:37:21.595823 systemd[1]: Started sshd@6-10.0.0.43:22-10.0.0.1:49738.service - OpenSSH per-connection server daemon (10.0.0.1:49738). Aug 5 21:37:21.597060 systemd-logind[1349]: Removed session 6. Aug 5 21:37:21.630988 sshd[1521]: Accepted publickey for core from 10.0.0.1 port 49738 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:21.632070 sshd[1521]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:21.635421 systemd-logind[1349]: New session 7 of user core. Aug 5 21:37:21.643939 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 21:37:21.707007 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 21:37:21.707087 (dockerd)[1525]: 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 Aug 5 21:37:21.928256 dockerd[1525]: time="2024-08-05T21:37:21.928194867Z" level=info msg="Starting up" Aug 5 21:37:21.958784 dockerd[1525]: time="2024-08-05T21:37:21.958517895Z" level=info msg="Loading containers: start." Aug 5 21:37:22.035744 kernel: Initializing XFRM netlink socket Aug 5 21:37:22.102229 systemd-networkd[1302]: docker0: Link UP Aug 5 21:37:22.121910 dockerd[1525]: time="2024-08-05T21:37:22.121869812Z" level=info msg="Loading containers: done." Aug 5 21:37:22.175193 dockerd[1525]: time="2024-08-05T21:37:22.175149914Z" 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 Aug 5 21:37:22.175362 dockerd[1525]: time="2024-08-05T21:37:22.175341328Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 21:37:22.175480 dockerd[1525]: time="2024-08-05T21:37:22.175454136Z" level=info msg="Daemon has completed initialization" Aug 5 21:37:22.199637 dockerd[1525]: time="2024-08-05T21:37:22.199538219Z" level=info msg="API listen on /run/docker.sock" Aug 5 21:37:22.199728 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 21:37:22.206873 sshd[1521]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:22.220051 systemd[1]: sshd@6-10.0.0.43:22-10.0.0.1:49738.service: Deactivated successfully. Aug 5 21:37:22.221457 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 21:37:22.222663 systemd-logind[1349]: Session 7 logged out. Waiting for processes to exit. Aug 5 21:37:22.223795 systemd[1]: Started sshd@7-10.0.0.43:22-10.0.0.1:54988.service - OpenSSH per-connection server daemon (10.0.0.1:54988). Aug 5 21:37:22.224814 systemd-logind[1349]: Removed session 7. Aug 5 21:37:22.260083 sshd[1653]: Accepted publickey for core from 10.0.0.1 port 54988 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:22.261174 sshd[1653]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:22.264681 systemd-logind[1349]: New session 8 of user core. Aug 5 21:37:22.279923 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 5 21:37:23.427803 systemd[1]: var-lib-docker-overlay2-924fc6961a512a27f74cc2bba8063686d6f2408f1df0d6c2a1571029b73a77fa\x2dinit-merged.mount: Deactivated successfully. Aug 5 21:37:23.453849 kernel: docker0: port 1(vethb00be15) entered blocking state Aug 5 21:37:23.453943 kernel: docker0: port 1(vethb00be15) entered disabled state Aug 5 21:37:23.453969 kernel: vethb00be15: entered allmulticast mode Aug 5 21:37:23.454736 kernel: vethb00be15: entered promiscuous mode Aug 5 21:37:23.454770 kernel: docker0: port 1(vethb00be15) entered blocking state Aug 5 21:37:23.454806 systemd-networkd[1302]: vethb00be15: Link UP Aug 5 21:37:23.455738 kernel: docker0: port 1(vethb00be15) entered forwarding state Aug 5 21:37:23.455844 kernel: docker0: port 1(vethb00be15) entered disabled state Aug 5 21:37:23.546599 containerd[1366]: time="2024-08-05T21:37:23.546185191Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 21:37:23.546599 containerd[1366]: time="2024-08-05T21:37:23.546567730Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:37:23.547079 containerd[1366]: time="2024-08-05T21:37:23.546594501Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 21:37:23.547079 containerd[1366]: time="2024-08-05T21:37:23.546610627Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:37:23.570925 systemd[1]: Started docker-24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb.scope - libcontainer container 24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb. Aug 5 21:37:23.626755 kernel: eth0: renamed from veth6a5e267 Aug 5 21:37:23.634066 kernel: docker0: port 1(vethb00be15) entered blocking state Aug 5 21:37:23.634145 kernel: docker0: port 1(vethb00be15) entered forwarding state Aug 5 21:37:23.634139 systemd-networkd[1302]: vethb00be15: Gained carrier Aug 5 21:37:23.634364 systemd-networkd[1302]: docker0: Gained carrier Aug 5 21:37:23.636804 systemd-resolved[1250]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 21:37:23.661047 sshd[1653]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:23.673065 systemd[1]: sshd@7-10.0.0.43:22-10.0.0.1:54988.service: Deactivated successfully. Aug 5 21:37:23.674455 systemd[1]: session-8.scope: Deactivated successfully. Aug 5 21:37:23.676817 systemd-logind[1349]: Session 8 logged out. Waiting for processes to exit. Aug 5 21:37:23.684981 systemd[1]: Started sshd@8-10.0.0.43:22-10.0.0.1:55002.service - OpenSSH per-connection server daemon (10.0.0.1:55002). Aug 5 21:37:23.686121 systemd-logind[1349]: Removed session 8. Aug 5 21:37:23.718063 sshd[1734]: Accepted publickey for core from 10.0.0.1 port 55002 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:23.719435 sshd[1734]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:23.722730 systemd-logind[1349]: New session 9 of user core. Aug 5 21:37:23.731879 systemd[1]: Started session-9.scope - Session 9 of User core. Aug 5 21:37:23.785796 sshd[1734]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:23.792036 systemd[1]: sshd@8-10.0.0.43:22-10.0.0.1:55002.service: Deactivated successfully. Aug 5 21:37:23.793433 systemd[1]: session-9.scope: Deactivated successfully. Aug 5 21:37:23.793984 systemd-logind[1349]: Session 9 logged out. Waiting for processes to exit. Aug 5 21:37:23.795606 systemd[1]: Started sshd@9-10.0.0.43:22-10.0.0.1:55012.service - OpenSSH per-connection server daemon (10.0.0.1:55012). Aug 5 21:37:23.797046 systemd-logind[1349]: Removed session 9. Aug 5 21:37:23.832913 sshd[1741]: Accepted publickey for core from 10.0.0.1 port 55012 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:23.834071 sshd[1741]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:23.837790 systemd-logind[1349]: New session 10 of user core. Aug 5 21:37:23.850893 systemd[1]: Started session-10.scope - Session 10 of User core. Aug 5 21:37:23.900681 sudo[1744]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGTERM 1366 Aug 5 21:37:23.901274 sudo[1744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 21:37:23.904254 sudo[1744]: pam_unix(sudo:session): session closed for user root Aug 5 21:37:23.905050 containerd[1366]: time="2024-08-05T21:37:23.904363854Z" level=info msg="Stop CRI service" Aug 5 21:37:23.905125 dockerd[1525]: time="2024-08-05T21:37:23.904468157Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Aug 5 21:37:23.905125 dockerd[1525]: time="2024-08-05T21:37:23.904515900Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Aug 5 21:37:23.905125 dockerd[1525]: time="2024-08-05T21:37:23.904523288Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Aug 5 21:37:23.905125 dockerd[1525]: time="2024-08-05T21:37:23.904549900Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Aug 5 21:37:23.905694 containerd[1366]: time="2024-08-05T21:37:23.905270133Z" level=info msg="Stop CRI service" Aug 5 21:37:23.905694 containerd[1366]: time="2024-08-05T21:37:23.905309415Z" level=info msg="Event monitor stopped" Aug 5 21:37:23.905694 containerd[1366]: time="2024-08-05T21:37:23.905317955Z" level=info msg="Stream server stopped" Aug 5 21:37:23.905766 sshd[1741]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:23.922032 systemd[1]: containerd.service: Deactivated successfully. Aug 5 21:37:23.922127 systemd[1]: containerd.service: Unit process 1688 (containerd-shim) remains running after unit stopped. Aug 5 21:37:23.922657 systemd[1]: sshd@9-10.0.0.43:22-10.0.0.1:55012.service: Deactivated successfully. Aug 5 21:37:23.923999 systemd[1]: session-10.scope: Deactivated successfully. Aug 5 21:37:23.924533 systemd-logind[1349]: Session 10 logged out. Waiting for processes to exit. Aug 5 21:37:23.943942 systemd[1]: Started sshd@10-10.0.0.43:22-10.0.0.1:55026.service - OpenSSH per-connection server daemon (10.0.0.1:55026). Aug 5 21:37:23.944664 systemd-logind[1349]: Removed session 10. Aug 5 21:37:23.975905 sshd[1750]: Accepted publickey for core from 10.0.0.1 port 55026 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:23.977581 sshd[1750]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:23.981560 systemd-logind[1349]: New session 11 of user core. Aug 5 21:37:23.997894 systemd[1]: Started session-11.scope - Session 11 of User core. Aug 5 21:37:24.051679 sshd[1750]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:24.055065 systemd[1]: sshd@10-10.0.0.43:22-10.0.0.1:55026.service: Deactivated successfully. Aug 5 21:37:24.058218 systemd[1]: session-11.scope: Deactivated successfully. Aug 5 21:37:24.058819 systemd-logind[1349]: Session 11 logged out. Waiting for processes to exit. Aug 5 21:37:24.059625 systemd-logind[1349]: Removed session 11. Aug 5 21:37:24.837840 systemd-networkd[1302]: vethb00be15: Gained IPv6LL Aug 5 21:37:25.349848 systemd-networkd[1302]: docker0: Gained IPv6LL Aug 5 21:37:28.976113 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Aug 5 21:37:28.976584 systemd[1]: Stopping docker.service - Docker Application Container Engine... Aug 5 21:37:28.978471 dockerd[1525]: time="2024-08-05T21:37:28.976588685Z" level=info msg="Processing signal 'terminated'" Aug 5 21:37:30.034991 systemd[1]: Started sshd@11-10.0.0.43:22-10.0.0.1:55028.service - OpenSSH per-connection server daemon (10.0.0.1:55028). Aug 5 21:37:30.073965 sshd[1758]: Accepted publickey for core from 10.0.0.1 port 55028 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:30.075329 sshd[1758]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:30.079287 systemd-logind[1349]: New session 12 of user core. Aug 5 21:37:30.083902 systemd[1]: Started session-12.scope - Session 12 of User core. Aug 5 21:37:30.137597 sshd[1758]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:30.141760 systemd[1]: sshd@11-10.0.0.43:22-10.0.0.1:55028.service: Deactivated successfully. Aug 5 21:37:30.143411 systemd[1]: session-12.scope: Deactivated successfully. Aug 5 21:37:30.144606 systemd-logind[1349]: Session 12 logged out. Waiting for processes to exit. Aug 5 21:37:30.145485 systemd-logind[1349]: Removed session 12. Aug 5 21:37:33.493804 dockerd[1525]: time="2024-08-05T21:37:33.493705193Z" level=error msg="Error sending stop (signal 15) to container" container=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb error="Cannot kill container 24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb: connection error: desc = \"transport: Error while dialing dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Aug 5 21:37:33.493804 dockerd[1525]: time="2024-08-05T21:37:33.493781132Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb Aug 5 21:37:36.139122 systemd[1]: Started sshd@12-10.0.0.43:22-10.0.0.1:33014.service - OpenSSH per-connection server daemon (10.0.0.1:33014). Aug 5 21:37:36.175608 sshd[1765]: Accepted publickey for core from 10.0.0.1 port 33014 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:36.176709 sshd[1765]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:36.180545 systemd-logind[1349]: New session 13 of user core. Aug 5 21:37:36.192915 systemd[1]: Started session-13.scope - Session 13 of User core. Aug 5 21:37:36.245867 sshd[1765]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:36.248080 systemd[1]: sshd@12-10.0.0.43:22-10.0.0.1:33014.service: Deactivated successfully. Aug 5 21:37:36.249706 systemd[1]: session-13.scope: Deactivated successfully. Aug 5 21:37:36.251023 systemd-logind[1349]: Session 13 logged out. Waiting for processes to exit. Aug 5 21:37:36.253146 systemd-logind[1349]: Removed session 13. Aug 5 21:37:42.251103 systemd[1]: Started sshd@13-10.0.0.43:22-10.0.0.1:37260.service - OpenSSH per-connection server daemon (10.0.0.1:37260). Aug 5 21:37:42.287697 sshd[1772]: Accepted publickey for core from 10.0.0.1 port 37260 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:42.288869 sshd[1772]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:42.292241 systemd-logind[1349]: New session 14 of user core. Aug 5 21:37:42.301894 systemd[1]: Started session-14.scope - Session 14 of User core. Aug 5 21:37:42.356348 sshd[1772]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:42.360622 systemd[1]: sshd@13-10.0.0.43:22-10.0.0.1:37260.service: Deactivated successfully. Aug 5 21:37:42.362217 systemd[1]: session-14.scope: Deactivated successfully. Aug 5 21:37:42.363515 systemd-logind[1349]: Session 14 logged out. Waiting for processes to exit. Aug 5 21:37:42.364438 systemd-logind[1349]: Removed session 14. Aug 5 21:37:43.494956 dockerd[1525]: time="2024-08-05T21:37:43.494742003Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb error="context deadline exceeded" Aug 5 21:37:43.495288 systemd[1]: docker-24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb.scope: Deactivated successfully. Aug 5 21:37:43.977738 dockerd[1525]: time="2024-08-05T21:37:43.977686279Z" level=error msg="Force shutdown daemon" Aug 5 21:37:43.977738 dockerd[1525]: time="2024-08-05T21:37:43.977740092Z" level=info msg="Daemon shutdown complete" Aug 5 21:37:43.981972 systemd[1]: docker.service: Deactivated successfully. Aug 5 21:37:43.982256 systemd[1]: Stopped docker.service - Docker Application Container Engine. Aug 5 21:37:43.982719 systemd[1]: docker.socket: Deactivated successfully. Aug 5 21:37:43.982988 systemd[1]: Closed docker.socket - Docker Socket for the API. Aug 5 21:37:43.983023 systemd[1]: Stopping docker.socket - Docker Socket for the API... Aug 5 21:37:43.984463 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 21:37:43.988965 systemd[1]: containerd.service: Found left-over process 1688 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 21:37:43.988975 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 21:37:43.989894 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 21:37:43.990127 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 21:37:44.000813 systemd[1]: containerd.service: Found left-over process 1688 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 21:37:44.000823 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 21:37:44.005000 (ntainerd)[1784]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 21:37:44.020449 containerd[1784]: time="2024-08-05T21:37:44.020367764Z" level=info msg="starting containerd" revision=cd7148ac666309abf41fd4a49a8a5895b905e7f3 version=v1.7.18 Aug 5 21:37:44.042692 containerd[1784]: time="2024-08-05T21:37:44.042633703Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 21:37:44.042692 containerd[1784]: time="2024-08-05T21:37:44.042681243Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.043927 containerd[1784]: time="2024-08-05T21:37:44.043891409Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:44.043927 containerd[1784]: time="2024-08-05T21:37:44.043921516Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044093 containerd[1784]: time="2024-08-05T21:37:44.044073491Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044093 containerd[1784]: time="2024-08-05T21:37:44.044091004Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 21:37:44.044137 containerd[1784]: time="2024-08-05T21:37:44.044110276Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044137 containerd[1784]: time="2024-08-05T21:37:44.044130067Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044181 containerd[1784]: time="2024-08-05T21:37:44.044139823Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044181 containerd[1784]: time="2024-08-05T21:37:44.044160494Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044271 containerd[1784]: time="2024-08-05T21:37:44.044255214Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044294 containerd[1784]: time="2024-08-05T21:37:44.044273886Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 21:37:44.044294 containerd[1784]: time="2024-08-05T21:37:44.044283602Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044387 containerd[1784]: time="2024-08-05T21:37:44.044371605Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:37:44.044423 containerd[1784]: time="2024-08-05T21:37:44.044386358Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 21:37:44.044423 containerd[1784]: time="2024-08-05T21:37:44.044401592Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 21:37:44.044423 containerd[1784]: time="2024-08-05T21:37:44.044410308Z" level=info msg="metadata content store policy set" policy=shared Aug 5 21:37:44.044600 containerd[1784]: time="2024-08-05T21:37:44.044569041Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 21:37:44.044600 containerd[1784]: time="2024-08-05T21:37:44.044592751Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 21:37:44.044652 containerd[1784]: time="2024-08-05T21:37:44.044604786Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 21:37:44.044652 containerd[1784]: time="2024-08-05T21:37:44.044627016Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 21:37:44.044652 containerd[1784]: time="2024-08-05T21:37:44.044640690Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 21:37:44.044652 containerd[1784]: time="2024-08-05T21:37:44.044650526Z" level=info msg="NRI interface is disabled by configuration." Aug 5 21:37:44.044735 containerd[1784]: time="2024-08-05T21:37:44.044666599Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 21:37:44.051074 containerd[1784]: time="2024-08-05T21:37:44.050775484Z" level=info msg="cleaning leaked shim process" id=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb namespace=moby Aug 5 21:37:44.058624 containerd[1784]: time="2024-08-05T21:37:44.058569532Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Aug 5 21:37:44.059256 containerd[1784]: time="2024-08-05T21:37:44.058921103Z" level=info msg="shim disconnected" id=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb namespace=moby Aug 5 21:37:44.059256 containerd[1784]: time="2024-08-05T21:37:44.058978278Z" level=warning msg="cleaning up after shim disconnected" id=24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb namespace=moby Aug 5 21:37:44.059256 containerd[1784]: time="2024-08-05T21:37:44.058987754Z" level=info msg="cleaning up dead shim" namespace=moby Aug 5 21:37:44.068443 containerd[1784]: time="2024-08-05T21:37:44.068402154Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 21:37:44.068527 containerd[1784]: time="2024-08-05T21:37:44.068452853Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 21:37:44.068527 containerd[1784]: time="2024-08-05T21:37:44.068469566Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 21:37:44.068527 containerd[1784]: time="2024-08-05T21:37:44.068483440Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 21:37:44.068527 containerd[1784]: time="2024-08-05T21:37:44.068500473Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068527 containerd[1784]: time="2024-08-05T21:37:44.068517345Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068529900Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068543294Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068558608Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068571882Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068584197Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068626 containerd[1784]: time="2024-08-05T21:37:44.068596512Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 21:37:44.068756 containerd[1784]: time="2024-08-05T21:37:44.068651089Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 21:37:44.068896 containerd[1784]: time="2024-08-05T21:37:44.068878552Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 21:37:44.068922 containerd[1784]: time="2024-08-05T21:37:44.068912418Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.068946 containerd[1784]: time="2024-08-05T21:37:44.068928131Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 21:37:44.068964 containerd[1784]: time="2024-08-05T21:37:44.068953920Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 21:37:44.069023 containerd[1784]: time="2024-08-05T21:37:44.069010896Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069060 containerd[1784]: time="2024-08-05T21:37:44.069047520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069095 containerd[1784]: time="2024-08-05T21:37:44.069064473Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069095 containerd[1784]: time="2024-08-05T21:37:44.069076428Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069095 containerd[1784]: time="2024-08-05T21:37:44.069088623Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069152 containerd[1784]: time="2024-08-05T21:37:44.069100977Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069152 containerd[1784]: time="2024-08-05T21:37:44.069112772Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069152 containerd[1784]: time="2024-08-05T21:37:44.069124248Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069152 containerd[1784]: time="2024-08-05T21:37:44.069136362Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069173627Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069186221Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069200935Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069212690Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069224645Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069238599Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069250034Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069267 containerd[1784]: time="2024-08-05T21:37:44.069260989Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 21:37:44.069618 containerd[1784]: time="2024-08-05T21:37:44.069473339Z" 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}" Aug 5 21:37:44.069618 containerd[1784]: time="2024-08-05T21:37:44.069536312Z" level=info msg="Connect containerd service" Aug 5 21:37:44.069618 containerd[1784]: time="2024-08-05T21:37:44.069562821Z" level=info msg="using legacy CRI server" Aug 5 21:37:44.069618 containerd[1784]: time="2024-08-05T21:37:44.069569458Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 21:37:44.069815 containerd[1784]: time="2024-08-05T21:37:44.069675693Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 21:37:44.070155 containerd[1784]: time="2024-08-05T21:37:44.070129980Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 5 21:37:44.070191 containerd[1784]: time="2024-08-05T21:37:44.070181238Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 21:37:44.070216 containerd[1784]: time="2024-08-05T21:37:44.070199151Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 5 21:37:44.070216 containerd[1784]: time="2024-08-05T21:37:44.070210506Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 21:37:44.070258 containerd[1784]: time="2024-08-05T21:37:44.070222741Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 21:37:44.070515 containerd[1784]: time="2024-08-05T21:37:44.070360682Z" level=info msg="Start subscribing containerd event" Aug 5 21:37:44.070515 containerd[1784]: time="2024-08-05T21:37:44.070433931Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 21:37:44.070515 containerd[1784]: time="2024-08-05T21:37:44.070442927Z" level=info msg="Start recovering state" Aug 5 21:37:44.070515 containerd[1784]: time="2024-08-05T21:37:44.070471635Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 21:37:44.070648 containerd[1784]: time="2024-08-05T21:37:44.070634326Z" level=info msg="Start event monitor" Aug 5 21:37:44.070707 containerd[1784]: time="2024-08-05T21:37:44.070696220Z" level=info msg="Start snapshots syncer" Aug 5 21:37:44.070849 containerd[1784]: time="2024-08-05T21:37:44.070756994Z" level=info msg="Start cni network conf syncer for default" Aug 5 21:37:44.070849 containerd[1784]: time="2024-08-05T21:37:44.070768989Z" level=info msg="Start streaming server" Aug 5 21:37:44.070959 containerd[1784]: time="2024-08-05T21:37:44.070945554Z" level=info msg="containerd successfully booted in 0.051027s" Aug 5 21:37:44.071085 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 21:37:44.077995 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 21:37:44.078093 (dockerd)[1818]: 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 Aug 5 21:37:44.111817 dockerd[1818]: time="2024-08-05T21:37:44.111757533Z" level=info msg="Starting up" Aug 5 21:37:44.127008 dockerd[1818]: time="2024-08-05T21:37:44.126963672Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Aug 5 21:37:44.132878 dockerd[1818]: time="2024-08-05T21:37:44.132849052Z" level=info msg="Loading containers: start." Aug 5 21:37:44.143806 systemd[1]: var-lib-docker-overlay2-924fc6961a512a27f74cc2bba8063686d6f2408f1df0d6c2a1571029b73a77fa-merged.mount: Deactivated successfully. Aug 5 21:37:44.310820 dockerd[1818]: time="2024-08-05T21:37:44.310459707Z" level=info msg="Removing stale sandbox 295aab362b8aaabdd994700b14f49a98874c13733803ffcae2c9f25953b4e4c3 (24a752175225a22ec6d9eaf61379a99e263506efadede6ded17219cd2fe3f3cb)" Aug 5 21:37:44.314380 dockerd[1818]: time="2024-08-05T21:37:44.314335940Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 8ea10a83ffbee01e6acf887ae5944e02001e0d18e8ad253b6ae1b0c119553991 9444319ae612e6228f9d15a2fdbb25c2e6a35c4366d977619a930299be5a89b5], retrying...." Aug 5 21:37:44.316971 systemd-networkd[1302]: vethb00be15: Link DOWN Aug 5 21:37:44.317821 kernel: docker0: port 1(vethb00be15) entered disabled state Aug 5 21:37:44.316976 systemd-networkd[1302]: vethb00be15: Lost carrier Aug 5 21:37:44.318991 kernel: vethb00be15 (unregistering): left allmulticast mode Aug 5 21:37:44.319041 kernel: vethb00be15 (unregistering): left promiscuous mode Aug 5 21:37:44.319063 kernel: docker0: port 1(vethb00be15) entered disabled state Aug 5 21:37:44.334631 systemd-networkd[1302]: docker0: Lost carrier Aug 5 21:37:44.409761 dockerd[1818]: time="2024-08-05T21:37:44.409695903Z" 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" Aug 5 21:37:44.457411 dockerd[1818]: time="2024-08-05T21:37:44.457319749Z" level=info msg="Loading containers: done." Aug 5 21:37:44.467694 dockerd[1818]: time="2024-08-05T21:37:44.467630608Z" 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 Aug 5 21:37:44.468062 dockerd[1818]: time="2024-08-05T21:37:44.467857631Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 21:37:44.468062 dockerd[1818]: time="2024-08-05T21:37:44.467910009Z" level=info msg="Daemon has completed initialization" Aug 5 21:37:44.484017 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 21:37:44.484293 dockerd[1818]: time="2024-08-05T21:37:44.484008409Z" level=info msg="API listen on /run/docker.sock" Aug 5 21:37:45.118846 systemd[1]: run-docker-netns-295aab362b8a.mount: Deactivated successfully. Aug 5 21:37:48.364025 systemd[1]: Started sshd@14-10.0.0.43:22-10.0.0.1:37272.service - OpenSSH per-connection server daemon (10.0.0.1:37272). Aug 5 21:37:48.404882 sshd[1958]: Accepted publickey for core from 10.0.0.1 port 37272 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:48.406228 sshd[1958]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:48.410343 systemd-logind[1349]: New session 15 of user core. Aug 5 21:37:48.430905 systemd[1]: Started session-15.scope - Session 15 of User core. Aug 5 21:37:48.484270 sshd[1958]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:48.498267 systemd[1]: sshd@14-10.0.0.43:22-10.0.0.1:37272.service: Deactivated successfully. Aug 5 21:37:48.499643 systemd[1]: session-15.scope: Deactivated successfully. Aug 5 21:37:48.501850 systemd-logind[1349]: Session 15 logged out. Waiting for processes to exit. Aug 5 21:37:48.502898 systemd[1]: Started sshd@15-10.0.0.43:22-10.0.0.1:37276.service - OpenSSH per-connection server daemon (10.0.0.1:37276). Aug 5 21:37:48.503698 systemd-logind[1349]: Removed session 15. Aug 5 21:37:48.539483 sshd[1965]: Accepted publickey for core from 10.0.0.1 port 37276 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:48.540894 sshd[1965]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:48.544800 systemd-logind[1349]: New session 16 of user core. Aug 5 21:37:48.553875 systemd[1]: Started session-16.scope - Session 16 of User core. Aug 5 21:37:48.606518 sshd[1965]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:48.619377 systemd[1]: sshd@15-10.0.0.43:22-10.0.0.1:37276.service: Deactivated successfully. Aug 5 21:37:48.620665 systemd[1]: session-16.scope: Deactivated successfully. Aug 5 21:37:48.623046 systemd-logind[1349]: Session 16 logged out. Waiting for processes to exit. Aug 5 21:37:48.624451 systemd-logind[1349]: Removed session 16. Aug 5 21:37:48.626712 systemd[1]: Started sshd@16-10.0.0.43:22-10.0.0.1:37286.service - OpenSSH per-connection server daemon (10.0.0.1:37286). Aug 5 21:37:48.662808 sshd[1972]: Accepted publickey for core from 10.0.0.1 port 37286 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:48.664044 sshd[1972]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:48.669076 systemd-logind[1349]: New session 17 of user core. Aug 5 21:37:48.678960 systemd[1]: Started session-17.scope - Session 17 of User core. Aug 5 21:37:48.735176 sshd[1972]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:48.749077 systemd[1]: sshd@16-10.0.0.43:22-10.0.0.1:37286.service: Deactivated successfully. Aug 5 21:37:48.750588 systemd[1]: session-17.scope: Deactivated successfully. Aug 5 21:37:48.752110 systemd-logind[1349]: Session 17 logged out. Waiting for processes to exit. Aug 5 21:37:48.758998 systemd[1]: Started sshd@17-10.0.0.43:22-10.0.0.1:37302.service - OpenSSH per-connection server daemon (10.0.0.1:37302). Aug 5 21:37:48.759928 systemd-logind[1349]: Removed session 17. Aug 5 21:37:48.792253 sshd[1986]: Accepted publickey for core from 10.0.0.1 port 37302 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:48.793447 sshd[1986]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:48.797311 systemd-logind[1349]: New session 18 of user core. Aug 5 21:37:48.804907 systemd[1]: Started session-18.scope - Session 18 of User core. Aug 5 21:37:48.890929 kernel: docker0: port 1(vethc0c3d97) entered blocking state Aug 5 21:37:48.891050 kernel: docker0: port 1(vethc0c3d97) entered disabled state Aug 5 21:37:48.891082 kernel: vethc0c3d97: entered allmulticast mode Aug 5 21:37:48.891100 kernel: vethc0c3d97: entered promiscuous mode Aug 5 21:37:48.891667 systemd-networkd[1302]: vethc0c3d97: Link UP Aug 5 21:37:48.892014 kernel: docker0: port 1(vethc0c3d97) entered blocking state Aug 5 21:37:48.892051 kernel: docker0: port 1(vethc0c3d97) entered forwarding state Aug 5 21:37:48.893244 kernel: docker0: port 1(vethc0c3d97) entered disabled state Aug 5 21:37:48.923517 containerd[1784]: time="2024-08-05T21:37:48.923417572Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 21:37:48.923517 containerd[1784]: time="2024-08-05T21:37:48.923482133Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:37:48.923946 containerd[1784]: time="2024-08-05T21:37:48.923502534Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 21:37:48.923946 containerd[1784]: time="2024-08-05T21:37:48.923518254Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:37:48.944891 systemd[1]: Started docker-effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc.scope - libcontainer container effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc. Aug 5 21:37:49.000841 kernel: eth0: renamed from veth0654117 Aug 5 21:37:49.011584 systemd-networkd[1302]: vethc0c3d97: Gained carrier Aug 5 21:37:49.011757 kernel: docker0: port 1(vethc0c3d97) entered blocking state Aug 5 21:37:49.011782 kernel: docker0: port 1(vethc0c3d97) entered forwarding state Aug 5 21:37:49.011814 systemd-networkd[1302]: docker0: Gained carrier Aug 5 21:37:49.024295 systemd-resolved[1250]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 21:37:49.067974 sshd[1986]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:49.085226 systemd[1]: sshd@17-10.0.0.43:22-10.0.0.1:37302.service: Deactivated successfully. Aug 5 21:37:49.086622 systemd[1]: session-18.scope: Deactivated successfully. Aug 5 21:37:49.090691 systemd-logind[1349]: Session 18 logged out. Waiting for processes to exit. Aug 5 21:37:49.094986 systemd[1]: Started sshd@18-10.0.0.43:22-10.0.0.1:37304.service - OpenSSH per-connection server daemon (10.0.0.1:37304). Aug 5 21:37:49.096459 systemd-logind[1349]: Removed session 18. Aug 5 21:37:49.127921 sshd[2060]: Accepted publickey for core from 10.0.0.1 port 37304 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:49.129171 sshd[2060]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:49.132922 systemd-logind[1349]: New session 19 of user core. Aug 5 21:37:49.140875 systemd[1]: Started session-19.scope - Session 19 of User core. Aug 5 21:37:49.196836 sshd[2060]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:49.216193 systemd[1]: sshd@18-10.0.0.43:22-10.0.0.1:37304.service: Deactivated successfully. Aug 5 21:37:49.217524 systemd[1]: session-19.scope: Deactivated successfully. Aug 5 21:37:49.220879 systemd-logind[1349]: Session 19 logged out. Waiting for processes to exit. Aug 5 21:37:49.225965 systemd[1]: Started sshd@19-10.0.0.43:22-10.0.0.1:37308.service - OpenSSH per-connection server daemon (10.0.0.1:37308). Aug 5 21:37:49.226758 systemd-logind[1349]: Removed session 19. Aug 5 21:37:49.264201 sshd[2067]: Accepted publickey for core from 10.0.0.1 port 37308 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:49.265482 sshd[2067]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:49.269694 systemd-logind[1349]: New session 20 of user core. Aug 5 21:37:49.275879 systemd[1]: Started session-20.scope - Session 20 of User core. Aug 5 21:37:49.326554 sudo[2070]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGHUP 1784 Aug 5 21:37:49.326822 sudo[2070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 21:37:49.329576 sudo[2070]: pam_unix(sudo:session): session closed for user root Aug 5 21:37:49.331907 sshd[2067]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:49.332566 dockerd[1818]: time="2024-08-05T21:37:49.332136026Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Aug 5 21:37:49.332566 dockerd[1818]: time="2024-08-05T21:37:49.332175387Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Aug 5 21:37:49.332566 dockerd[1818]: time="2024-08-05T21:37:49.332166667Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=plugins.moby Aug 5 21:37:49.332566 dockerd[1818]: time="2024-08-05T21:37:49.332236588Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Aug 5 21:37:49.343034 systemd[1]: containerd.service: Deactivated successfully. Aug 5 21:37:49.343190 systemd[1]: containerd.service: Unit process 2016 (containerd-shim) remains running after unit stopped. Aug 5 21:37:49.343780 systemd[1]: sshd@19-10.0.0.43:22-10.0.0.1:37308.service: Deactivated successfully. Aug 5 21:37:49.345232 systemd[1]: session-20.scope: Deactivated successfully. Aug 5 21:37:49.345778 systemd-logind[1349]: Session 20 logged out. Waiting for processes to exit. Aug 5 21:37:49.347965 systemd[1]: Started sshd@20-10.0.0.43:22-10.0.0.1:37322.service - OpenSSH per-connection server daemon (10.0.0.1:37322). Aug 5 21:37:49.349801 systemd-logind[1349]: Removed session 20. Aug 5 21:37:49.384944 sshd[2076]: Accepted publickey for core from 10.0.0.1 port 37322 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:49.386133 sshd[2076]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:49.389759 systemd-logind[1349]: New session 21 of user core. Aug 5 21:37:49.400882 systemd[1]: Started session-21.scope - Session 21 of User core. Aug 5 21:37:49.457561 sshd[2076]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:49.463080 systemd[1]: sshd@20-10.0.0.43:22-10.0.0.1:37322.service: Deactivated successfully. Aug 5 21:37:49.465257 systemd[1]: session-21.scope: Deactivated successfully. Aug 5 21:37:49.465861 systemd-logind[1349]: Session 21 logged out. Waiting for processes to exit. Aug 5 21:37:49.466772 systemd-logind[1349]: Removed session 21. Aug 5 21:37:50.949946 systemd-networkd[1302]: vethc0c3d97: Gained IPv6LL Aug 5 21:37:54.476272 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Aug 5 21:37:54.476687 systemd[1]: Stopping docker.service - Docker Application Container Engine... Aug 5 21:37:54.477620 dockerd[1818]: time="2024-08-05T21:37:54.476814913Z" level=info msg="Processing signal 'terminated'" Aug 5 21:37:55.471979 systemd[1]: Started sshd@21-10.0.0.43:22-10.0.0.1:49478.service - OpenSSH per-connection server daemon (10.0.0.1:49478). Aug 5 21:37:55.511027 sshd[2083]: Accepted publickey for core from 10.0.0.1 port 49478 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:37:55.512642 sshd[2083]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:37:55.516587 systemd-logind[1349]: New session 22 of user core. Aug 5 21:37:55.533920 systemd[1]: Started session-22.scope - Session 22 of User core. Aug 5 21:37:55.592963 sshd[2083]: pam_unix(sshd:session): session closed for user core Aug 5 21:37:55.596712 systemd[1]: sshd@21-10.0.0.43:22-10.0.0.1:49478.service: Deactivated successfully. Aug 5 21:37:55.598288 systemd[1]: session-22.scope: Deactivated successfully. Aug 5 21:37:55.600183 systemd-logind[1349]: Session 22 logged out. Waiting for processes to exit. Aug 5 21:37:55.601164 systemd-logind[1349]: Removed session 22. Aug 5 21:37:56.478241 dockerd[1818]: time="2024-08-05T21:37:56.478135738Z" level=error msg="Error sending stop (signal 15) to container" container=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc error="Cannot kill container effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc: connection error: desc = \"transport: Error while dialing dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Aug 5 21:37:56.478241 dockerd[1818]: time="2024-08-05T21:37:56.478206299Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc Aug 5 21:37:58.145800 update_engine[1350]: I0805 21:37:58.145707 1350 update_attempter.cc:509] Updating boot flags... Aug 5 21:37:58.164755 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (2096) Aug 5 21:37:58.193588 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (2095) Aug 5 21:37:58.215530 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 38 scanned by (udev-worker) (2095) Aug 5 21:38:01.607032 systemd[1]: Started sshd@22-10.0.0.43:22-10.0.0.1:49486.service - OpenSSH per-connection server daemon (10.0.0.1:49486). Aug 5 21:38:01.643938 sshd[2105]: Accepted publickey for core from 10.0.0.1 port 49486 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:01.645183 sshd[2105]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:01.648916 systemd-logind[1349]: New session 23 of user core. Aug 5 21:38:01.655886 systemd[1]: Started session-23.scope - Session 23 of User core. Aug 5 21:38:01.708753 sshd[2105]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:01.711891 systemd[1]: sshd@22-10.0.0.43:22-10.0.0.1:49486.service: Deactivated successfully. Aug 5 21:38:01.715057 systemd[1]: session-23.scope: Deactivated successfully. Aug 5 21:38:01.715557 systemd-logind[1349]: Session 23 logged out. Waiting for processes to exit. Aug 5 21:38:01.716303 systemd-logind[1349]: Removed session 23. Aug 5 21:38:06.478904 dockerd[1818]: time="2024-08-05T21:38:06.478843351Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc error="context deadline exceeded" Aug 5 21:38:06.479495 systemd[1]: docker-effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc.scope: Deactivated successfully. Aug 5 21:38:07.719036 systemd[1]: Started sshd@23-10.0.0.43:22-10.0.0.1:43526.service - OpenSSH per-connection server daemon (10.0.0.1:43526). Aug 5 21:38:07.756281 sshd[2113]: Accepted publickey for core from 10.0.0.1 port 43526 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:07.757494 sshd[2113]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:07.761363 systemd-logind[1349]: New session 24 of user core. Aug 5 21:38:07.771914 systemd[1]: Started session-24.scope - Session 24 of User core. Aug 5 21:38:07.826310 sshd[2113]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:07.829695 systemd[1]: sshd@23-10.0.0.43:22-10.0.0.1:43526.service: Deactivated successfully. Aug 5 21:38:07.831405 systemd[1]: session-24.scope: Deactivated successfully. Aug 5 21:38:07.832371 systemd-logind[1349]: Session 24 logged out. Waiting for processes to exit. Aug 5 21:38:07.833279 systemd-logind[1349]: Removed session 24. Aug 5 21:38:09.477079 dockerd[1818]: time="2024-08-05T21:38:09.477017134Z" level=error msg="Force shutdown daemon" Aug 5 21:38:09.477079 dockerd[1818]: time="2024-08-05T21:38:09.477056334Z" level=info msg="Daemon shutdown complete" Aug 5 21:38:09.480714 systemd[1]: docker.service: Deactivated successfully. Aug 5 21:38:09.481810 systemd[1]: Stopped docker.service - Docker Application Container Engine. Aug 5 21:38:09.482279 systemd[1]: docker.socket: Deactivated successfully. Aug 5 21:38:09.482512 systemd[1]: Closed docker.socket - Docker Socket for the API. Aug 5 21:38:09.482540 systemd[1]: Stopping docker.socket - Docker Socket for the API... Aug 5 21:38:09.483970 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 21:38:09.488033 systemd[1]: containerd.service: Found left-over process 2016 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 21:38:09.488042 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 21:38:09.488870 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 21:38:09.489100 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 21:38:09.499872 systemd[1]: containerd.service: Found left-over process 2016 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 21:38:09.499886 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 21:38:09.503906 (ntainerd)[2125]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 21:38:09.519146 containerd[2125]: time="2024-08-05T21:38:09.519069203Z" level=info msg="starting containerd" revision=cd7148ac666309abf41fd4a49a8a5895b905e7f3 version=v1.7.18 Aug 5 21:38:09.541192 containerd[2125]: time="2024-08-05T21:38:09.541144486Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 21:38:09.541192 containerd[2125]: time="2024-08-05T21:38:09.541181966Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542312 containerd[2125]: time="2024-08-05T21:38:09.542273414Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.43-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542312 containerd[2125]: time="2024-08-05T21:38:09.542303014Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542452 containerd[2125]: time="2024-08-05T21:38:09.542420495Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542452 containerd[2125]: time="2024-08-05T21:38:09.542440976Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 21:38:09.542507 containerd[2125]: time="2024-08-05T21:38:09.542460536Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542507 containerd[2125]: time="2024-08-05T21:38:09.542478136Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542507 containerd[2125]: time="2024-08-05T21:38:09.542488376Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542563 containerd[2125]: time="2024-08-05T21:38:09.542507576Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542603 containerd[2125]: time="2024-08-05T21:38:09.542588417Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542624 containerd[2125]: time="2024-08-05T21:38:09.542605857Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 21:38:09.542624 containerd[2125]: time="2024-08-05T21:38:09.542616977Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542732 containerd[2125]: time="2024-08-05T21:38:09.542706257Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Aug 5 21:38:09.542764 containerd[2125]: time="2024-08-05T21:38:09.542737178Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 21:38:09.542764 containerd[2125]: time="2024-08-05T21:38:09.542753298Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 21:38:09.542799 containerd[2125]: time="2024-08-05T21:38:09.542763378Z" level=info msg="metadata content store policy set" policy=shared Aug 5 21:38:09.542922 containerd[2125]: time="2024-08-05T21:38:09.542903779Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 21:38:09.542959 containerd[2125]: time="2024-08-05T21:38:09.542927419Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 21:38:09.542959 containerd[2125]: time="2024-08-05T21:38:09.542939819Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 21:38:09.542996 containerd[2125]: time="2024-08-05T21:38:09.542961259Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 21:38:09.542996 containerd[2125]: time="2024-08-05T21:38:09.542973739Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 21:38:09.542996 containerd[2125]: time="2024-08-05T21:38:09.542991780Z" level=info msg="NRI interface is disabled by configuration." Aug 5 21:38:09.543054 containerd[2125]: time="2024-08-05T21:38:09.543004300Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 21:38:09.548653 containerd[2125]: time="2024-08-05T21:38:09.548627181Z" level=info msg="cleaning leaked shim process" id=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc namespace=moby Aug 5 21:38:09.555935 containerd[2125]: time="2024-08-05T21:38:09.555887475Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Aug 5 21:38:09.556230 containerd[2125]: time="2024-08-05T21:38:09.556181037Z" level=info msg="shim disconnected" id=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc namespace=moby Aug 5 21:38:09.556302 containerd[2125]: time="2024-08-05T21:38:09.556232437Z" level=warning msg="cleaning up after shim disconnected" id=effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc namespace=moby Aug 5 21:38:09.556302 containerd[2125]: time="2024-08-05T21:38:09.556241277Z" level=info msg="cleaning up dead shim" namespace=moby Aug 5 21:38:09.565052 containerd[2125]: time="2024-08-05T21:38:09.565017662Z" level=warning msg="cleanup warnings time=\"2024-08-05T21:38:09Z\" level=warning msg=\"failed to remove runc container\" error=\"runc did not terminate successfully: exit status 255: \" runtime=io.containerd.runc.v2\n" namespace=moby Aug 5 21:38:09.565542 containerd[2125]: time="2024-08-05T21:38:09.565523186Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 21:38:09.565581 containerd[2125]: time="2024-08-05T21:38:09.565548506Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 21:38:09.565581 containerd[2125]: time="2024-08-05T21:38:09.565562426Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 21:38:09.565581 containerd[2125]: time="2024-08-05T21:38:09.565575106Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 21:38:09.565646 containerd[2125]: time="2024-08-05T21:38:09.565589466Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565646 containerd[2125]: time="2024-08-05T21:38:09.565604666Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565646 containerd[2125]: time="2024-08-05T21:38:09.565616866Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565646 containerd[2125]: time="2024-08-05T21:38:09.565628066Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565646 containerd[2125]: time="2024-08-05T21:38:09.565641106Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565802 containerd[2125]: time="2024-08-05T21:38:09.565653867Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565802 containerd[2125]: time="2024-08-05T21:38:09.565666787Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.565802 containerd[2125]: time="2024-08-05T21:38:09.565677987Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 21:38:09.565802 containerd[2125]: time="2024-08-05T21:38:09.565721187Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 21:38:09.566034 containerd[2125]: time="2024-08-05T21:38:09.566006909Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 21:38:09.566067 containerd[2125]: time="2024-08-05T21:38:09.566052789Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566087 containerd[2125]: time="2024-08-05T21:38:09.566067070Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 21:38:09.566106 containerd[2125]: time="2024-08-05T21:38:09.566090270Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 21:38:09.566164 containerd[2125]: time="2024-08-05T21:38:09.566151910Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566193 containerd[2125]: time="2024-08-05T21:38:09.566168830Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566193 containerd[2125]: time="2024-08-05T21:38:09.566181670Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566239 containerd[2125]: time="2024-08-05T21:38:09.566192310Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566239 containerd[2125]: time="2024-08-05T21:38:09.566203991Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566239 containerd[2125]: time="2024-08-05T21:38:09.566215911Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566239 containerd[2125]: time="2024-08-05T21:38:09.566226791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566239 containerd[2125]: time="2024-08-05T21:38:09.566237191Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566341 containerd[2125]: time="2024-08-05T21:38:09.566256031Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 21:38:09.566341 containerd[2125]: time="2024-08-05T21:38:09.566296071Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566341 containerd[2125]: time="2024-08-05T21:38:09.566308791Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566341 containerd[2125]: time="2024-08-05T21:38:09.566319831Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566341 containerd[2125]: time="2024-08-05T21:38:09.566331432Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566430 containerd[2125]: time="2024-08-05T21:38:09.566343072Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566430 containerd[2125]: time="2024-08-05T21:38:09.566355512Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566430 containerd[2125]: time="2024-08-05T21:38:09.566366632Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566430 containerd[2125]: time="2024-08-05T21:38:09.566376952Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 21:38:09.566702 containerd[2125]: time="2024-08-05T21:38:09.566573073Z" 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}" Aug 5 21:38:09.566702 containerd[2125]: time="2024-08-05T21:38:09.566633234Z" level=info msg="Connect containerd service" Aug 5 21:38:09.566702 containerd[2125]: time="2024-08-05T21:38:09.566658794Z" level=info msg="using legacy CRI server" Aug 5 21:38:09.566702 containerd[2125]: time="2024-08-05T21:38:09.566665674Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 21:38:09.567381 containerd[2125]: time="2024-08-05T21:38:09.566910796Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 21:38:09.567540 containerd[2125]: time="2024-08-05T21:38:09.567479000Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 5 21:38:09.567677 containerd[2125]: time="2024-08-05T21:38:09.567652921Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 21:38:09.567711 containerd[2125]: time="2024-08-05T21:38:09.567681521Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Aug 5 21:38:09.567711 containerd[2125]: time="2024-08-05T21:38:09.567693882Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 21:38:09.567711 containerd[2125]: time="2024-08-05T21:38:09.567706762Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Aug 5 21:38:09.567786 containerd[2125]: time="2024-08-05T21:38:09.567746842Z" level=info msg="Start subscribing containerd event" Aug 5 21:38:09.567814 containerd[2125]: time="2024-08-05T21:38:09.567802642Z" level=info msg="Start recovering state" Aug 5 21:38:09.567871 containerd[2125]: time="2024-08-05T21:38:09.567860443Z" level=info msg="Start event monitor" Aug 5 21:38:09.567897 containerd[2125]: time="2024-08-05T21:38:09.567874123Z" level=info msg="Start snapshots syncer" Aug 5 21:38:09.567897 containerd[2125]: time="2024-08-05T21:38:09.567883243Z" level=info msg="Start cni network conf syncer for default" Aug 5 21:38:09.567897 containerd[2125]: time="2024-08-05T21:38:09.567890483Z" level=info msg="Start streaming server" Aug 5 21:38:09.567961 containerd[2125]: time="2024-08-05T21:38:09.567906883Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 21:38:09.567961 containerd[2125]: time="2024-08-05T21:38:09.567943003Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 21:38:09.568004 containerd[2125]: time="2024-08-05T21:38:09.567988004Z" level=info msg="containerd successfully booted in 0.049420s" Aug 5 21:38:09.568086 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 21:38:09.574949 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 21:38:09.575042 (dockerd)[2160]: 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 Aug 5 21:38:09.605131 dockerd[2160]: time="2024-08-05T21:38:09.604805755Z" level=info msg="Starting up" Aug 5 21:38:09.620513 dockerd[2160]: time="2024-08-05T21:38:09.620481670Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Aug 5 21:38:09.626907 dockerd[2160]: time="2024-08-05T21:38:09.626711036Z" level=info msg="Loading containers: start." Aug 5 21:38:09.639741 systemd[1]: var-lib-docker-overlay2-6a6b5b5621b450aee28748ebfced1e1c58098752bebaea6ad2af75b77f90d621-merged.mount: Deactivated successfully. Aug 5 21:38:09.811947 dockerd[2160]: time="2024-08-05T21:38:09.811551558Z" level=info msg="Removing stale sandbox 3a7466c27765567a01b1fe84660b5d678b18d96caa87e34e15e67d293ac0e58a (effc052b57ca5d0c1b0339b8f0f51b54706cf86117bbebaf1b5f39c8c69143bc)" Aug 5 21:38:09.814989 systemd-networkd[1302]: vethc0c3d97: Link DOWN Aug 5 21:38:09.815922 kernel: docker0: port 1(vethc0c3d97) entered disabled state Aug 5 21:38:09.815953 kernel: vethc0c3d97 (unregistering): left allmulticast mode Aug 5 21:38:09.815968 dockerd[2160]: time="2024-08-05T21:38:09.815593868Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 6f2e56180f7fa6ec023a3bde0dc849ee27bf403219dac4c8b6030835b0a0f818 5c301ae92f21cb0e8868b7da45fe25ceec0249a7b92eadc8e07f79400466ccb2], retrying...." Aug 5 21:38:09.814999 systemd-networkd[1302]: vethc0c3d97: Lost carrier Aug 5 21:38:09.817237 kernel: vethc0c3d97 (unregistering): left promiscuous mode Aug 5 21:38:09.817280 kernel: docker0: port 1(vethc0c3d97) entered disabled state Aug 5 21:38:09.824173 systemd-networkd[1302]: docker0: Lost carrier Aug 5 21:38:09.923183 dockerd[2160]: time="2024-08-05T21:38:09.923068140Z" 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" Aug 5 21:38:09.971082 dockerd[2160]: time="2024-08-05T21:38:09.971035173Z" level=info msg="Loading containers: done." Aug 5 21:38:09.979915 dockerd[2160]: time="2024-08-05T21:38:09.979871678Z" 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 Aug 5 21:38:09.980058 dockerd[2160]: time="2024-08-05T21:38:09.980040199Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 21:38:09.980103 dockerd[2160]: time="2024-08-05T21:38:09.980086240Z" level=info msg="Daemon has completed initialization" Aug 5 21:38:09.998745 dockerd[2160]: time="2024-08-05T21:38:09.998681337Z" level=info msg="API listen on /run/docker.sock" Aug 5 21:38:09.998851 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 21:38:10.611975 systemd[1]: run-docker-netns-3a7466c27765.mount: Deactivated successfully. Aug 5 21:38:13.841009 systemd[1]: Started sshd@24-10.0.0.43:22-10.0.0.1:35386.service - OpenSSH per-connection server daemon (10.0.0.1:35386). Aug 5 21:38:13.878063 sshd[2300]: Accepted publickey for core from 10.0.0.1 port 35386 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:13.879368 sshd[2300]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:13.883683 systemd-logind[1349]: New session 25 of user core. Aug 5 21:38:13.893000 systemd[1]: Started session-25.scope - Session 25 of User core. Aug 5 21:38:13.949840 sshd[2300]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:13.958154 systemd[1]: sshd@24-10.0.0.43:22-10.0.0.1:35386.service: Deactivated successfully. Aug 5 21:38:13.960106 systemd[1]: session-25.scope: Deactivated successfully. Aug 5 21:38:13.962868 systemd-logind[1349]: Session 25 logged out. Waiting for processes to exit. Aug 5 21:38:13.964421 systemd[1]: Started sshd@25-10.0.0.43:22-10.0.0.1:35388.service - OpenSSH per-connection server daemon (10.0.0.1:35388). Aug 5 21:38:13.965111 systemd-logind[1349]: Removed session 25. Aug 5 21:38:14.001882 sshd[2307]: Accepted publickey for core from 10.0.0.1 port 35388 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:14.003153 sshd[2307]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:14.007142 systemd-logind[1349]: New session 26 of user core. Aug 5 21:38:14.016936 systemd[1]: Started session-26.scope - Session 26 of User core. Aug 5 21:38:14.070761 sshd[2307]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:14.081136 systemd[1]: sshd@25-10.0.0.43:22-10.0.0.1:35388.service: Deactivated successfully. Aug 5 21:38:14.082764 systemd[1]: session-26.scope: Deactivated successfully. Aug 5 21:38:14.084049 systemd-logind[1349]: Session 26 logged out. Waiting for processes to exit. Aug 5 21:38:14.090972 systemd[1]: Started sshd@26-10.0.0.43:22-10.0.0.1:35390.service - OpenSSH per-connection server daemon (10.0.0.1:35390). Aug 5 21:38:14.091773 systemd-logind[1349]: Removed session 26. Aug 5 21:38:14.124415 sshd[2314]: Accepted publickey for core from 10.0.0.1 port 35390 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:14.125864 sshd[2314]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:14.129985 systemd-logind[1349]: New session 27 of user core. Aug 5 21:38:14.145889 systemd[1]: Started session-27.scope - Session 27 of User core. Aug 5 21:38:14.202478 sshd[2314]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:14.211028 systemd[1]: sshd@26-10.0.0.43:22-10.0.0.1:35390.service: Deactivated successfully. Aug 5 21:38:14.212389 systemd[1]: session-27.scope: Deactivated successfully. Aug 5 21:38:14.214747 systemd-logind[1349]: Session 27 logged out. Waiting for processes to exit. Aug 5 21:38:14.221994 systemd[1]: Started sshd@27-10.0.0.43:22-10.0.0.1:35396.service - OpenSSH per-connection server daemon (10.0.0.1:35396). Aug 5 21:38:14.222845 systemd-logind[1349]: Removed session 27. Aug 5 21:38:14.255281 sshd[2328]: Accepted publickey for core from 10.0.0.1 port 35396 ssh2: RSA SHA256:vLb6+tqq+AN0xHsfmostacJPBc0ER3TTPjmoL0pNEEc Aug 5 21:38:14.256406 sshd[2328]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 21:38:14.259881 systemd-logind[1349]: New session 28 of user core. Aug 5 21:38:14.266901 systemd[1]: Started session-28.scope - Session 28 of User core. Aug 5 21:38:14.332145 systemd[1]: var-lib-docker-overlay2-2cfcfbce80ed95f875c87aa7d163a333364828ae7f16d2d274d06b01ba8210b3\x2dinit-merged.mount: Deactivated successfully. Aug 5 21:38:14.351482 kernel: docker0: port 1(veth5af125c) entered blocking state Aug 5 21:38:14.351584 kernel: docker0: port 1(veth5af125c) entered disabled state Aug 5 21:38:14.351649 kernel: veth5af125c: entered allmulticast mode Aug 5 21:38:14.351667 kernel: veth5af125c: entered promiscuous mode Aug 5 21:38:14.351202 systemd-networkd[1302]: veth5af125c: Link UP Aug 5 21:38:14.379329 containerd[2125]: time="2024-08-05T21:38:14.378878084Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 21:38:14.379329 containerd[2125]: time="2024-08-05T21:38:14.379313526Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:38:14.379814 containerd[2125]: time="2024-08-05T21:38:14.379333007Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 21:38:14.379814 containerd[2125]: time="2024-08-05T21:38:14.379345367Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 21:38:14.396903 systemd[1]: Started docker-01b9286cd26665d0008e4e7f4253a4de038ac8de56977d32c6d5d0be8a8a2e98.scope - libcontainer container 01b9286cd26665d0008e4e7f4253a4de038ac8de56977d32c6d5d0be8a8a2e98. Aug 5 21:38:14.449779 kernel: eth0: renamed from veth3d5996d Aug 5 21:38:14.456429 systemd-networkd[1302]: veth5af125c: Gained carrier Aug 5 21:38:14.456634 systemd-networkd[1302]: docker0: Gained carrier Aug 5 21:38:14.456770 kernel: docker0: port 1(veth5af125c) entered blocking state Aug 5 21:38:14.456800 kernel: docker0: port 1(veth5af125c) entered forwarding state Aug 5 21:38:14.458671 systemd-resolved[1250]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 21:38:14.480081 sshd[2328]: pam_unix(sshd:session): session closed for user core Aug 5 21:38:14.482604 systemd[1]: sshd@27-10.0.0.43:22-10.0.0.1:35396.service: Deactivated successfully. Aug 5 21:38:14.484334 systemd[1]: session-28.scope: Deactivated successfully. Aug 5 21:38:14.485611 systemd-logind[1349]: Session 28 logged out. Waiting for processes to exit. Aug 5 21:38:14.486664 systemd-logind[1349]: Removed session 28. Aug 5 21:38:15.973960 systemd-networkd[1302]: veth5af125c: Gained IPv6LL