Aug 5 22:17:24.892737 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] Aug 5 22:17:24.892758 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:37:57 -00 2024 Aug 5 22:17:24.892767 kernel: KASLR enabled Aug 5 22:17:24.892773 kernel: efi: EFI v2.7 by EDK II Aug 5 22:17:24.892779 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdb8fd018 ACPI 2.0=0xd9710018 RNG=0xd971e498 MEMRESERVE=0xd9b43d18 Aug 5 22:17:24.892785 kernel: random: crng init done Aug 5 22:17:24.892792 kernel: ACPI: Early table checksum verification disabled Aug 5 22:17:24.892798 kernel: ACPI: RSDP 0x00000000D9710018 000024 (v02 BOCHS ) Aug 5 22:17:24.892804 kernel: ACPI: XSDT 0x00000000D971FE98 000064 (v01 BOCHS BXPC 00000001 01000013) Aug 5 22:17:24.892811 kernel: ACPI: FACP 0x00000000D971FA98 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892817 kernel: ACPI: DSDT 0x00000000D9717518 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892823 kernel: ACPI: APIC 0x00000000D971FC18 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892829 kernel: ACPI: PPTT 0x00000000D971D898 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892835 kernel: ACPI: GTDT 0x00000000D971E818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892842 kernel: ACPI: MCFG 0x00000000D971E918 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892850 kernel: ACPI: SPCR 0x00000000D971FF98 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892857 kernel: ACPI: DBG2 0x00000000D971E418 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892863 kernel: ACPI: IORT 0x00000000D971E718 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) Aug 5 22:17:24.892869 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 Aug 5 22:17:24.892875 kernel: NUMA: Failed to initialise from firmware Aug 5 22:17:24.892882 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:17:24.892888 kernel: NUMA: NODE_DATA [mem 0xdc958800-0xdc95dfff] Aug 5 22:17:24.892894 kernel: Zone ranges: Aug 5 22:17:24.892901 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:17:24.892907 kernel: DMA32 empty Aug 5 22:17:24.892914 kernel: Normal empty Aug 5 22:17:24.892921 kernel: Movable zone start for each node Aug 5 22:17:24.892927 kernel: Early memory node ranges Aug 5 22:17:24.892933 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] Aug 5 22:17:24.892940 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] Aug 5 22:17:24.892946 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] Aug 5 22:17:24.892953 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] Aug 5 22:17:24.892959 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] Aug 5 22:17:24.892965 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] Aug 5 22:17:24.892971 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] Aug 5 22:17:24.892978 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] Aug 5 22:17:24.892984 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges Aug 5 22:17:24.892992 kernel: psci: probing for conduit method from ACPI. Aug 5 22:17:24.892998 kernel: psci: PSCIv1.1 detected in firmware. Aug 5 22:17:24.893005 kernel: psci: Using standard PSCI v0.2 function IDs Aug 5 22:17:24.893014 kernel: psci: Trusted OS migration not required Aug 5 22:17:24.893020 kernel: psci: SMC Calling Convention v1.1 Aug 5 22:17:24.893027 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) Aug 5 22:17:24.893035 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Aug 5 22:17:24.893042 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Aug 5 22:17:24.893049 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 Aug 5 22:17:24.893056 kernel: Detected PIPT I-cache on CPU0 Aug 5 22:17:24.893062 kernel: CPU features: detected: GIC system register CPU interface Aug 5 22:17:24.893069 kernel: CPU features: detected: Hardware dirty bit management Aug 5 22:17:24.893076 kernel: CPU features: detected: Spectre-v4 Aug 5 22:17:24.893082 kernel: CPU features: detected: Spectre-BHB Aug 5 22:17:24.893089 kernel: CPU features: kernel page table isolation forced ON by KASLR Aug 5 22:17:24.893096 kernel: CPU features: detected: Kernel page table isolation (KPTI) Aug 5 22:17:24.893104 kernel: CPU features: detected: ARM erratum 1418040 Aug 5 22:17:24.893110 kernel: alternatives: applying boot alternatives Aug 5 22:17:24.893118 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:17:24.893125 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 5 22:17:24.893132 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 5 22:17:24.893139 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 5 22:17:24.893146 kernel: Fallback order for Node 0: 0 Aug 5 22:17:24.893153 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 Aug 5 22:17:24.893159 kernel: Policy zone: DMA Aug 5 22:17:24.893166 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 5 22:17:24.893172 kernel: software IO TLB: area num 4. Aug 5 22:17:24.893180 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) Aug 5 22:17:24.893187 kernel: Memory: 2386852K/2572288K available (10240K kernel code, 2182K rwdata, 8072K rodata, 39040K init, 897K bss, 185436K reserved, 0K cma-reserved) Aug 5 22:17:24.893194 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 Aug 5 22:17:24.893201 kernel: trace event string verifier disabled Aug 5 22:17:24.893208 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 5 22:17:24.893215 kernel: rcu: RCU event tracing is enabled. Aug 5 22:17:24.893222 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. Aug 5 22:17:24.893229 kernel: Trampoline variant of Tasks RCU enabled. Aug 5 22:17:24.893236 kernel: Tracing variant of Tasks RCU enabled. Aug 5 22:17:24.893242 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 5 22:17:24.893249 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 Aug 5 22:17:24.893329 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 5 22:17:24.893340 kernel: GICv3: 256 SPIs implemented Aug 5 22:17:24.893346 kernel: GICv3: 0 Extended SPIs implemented Aug 5 22:17:24.893353 kernel: Root IRQ handler: gic_handle_irq Aug 5 22:17:24.893360 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI Aug 5 22:17:24.893367 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 Aug 5 22:17:24.893374 kernel: ITS [mem 0x08080000-0x0809ffff] Aug 5 22:17:24.893381 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400d0000 (indirect, esz 8, psz 64K, shr 1) Aug 5 22:17:24.893391 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400e0000 (flat, esz 8, psz 64K, shr 1) Aug 5 22:17:24.893400 kernel: GICv3: using LPI property table @0x00000000400f0000 Aug 5 22:17:24.893408 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 Aug 5 22:17:24.893417 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 5 22:17:24.893425 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:17:24.893431 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). Aug 5 22:17:24.893438 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns Aug 5 22:17:24.893445 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns Aug 5 22:17:24.893452 kernel: arm-pv: using stolen time PV Aug 5 22:17:24.893459 kernel: Console: colour dummy device 80x25 Aug 5 22:17:24.893466 kernel: ACPI: Core revision 20230628 Aug 5 22:17:24.893473 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) Aug 5 22:17:24.893480 kernel: pid_max: default: 32768 minimum: 301 Aug 5 22:17:24.893487 kernel: LSM: initializing lsm=lockdown,capability,selinux,integrity Aug 5 22:17:24.893495 kernel: SELinux: Initializing. Aug 5 22:17:24.893502 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:17:24.893509 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 5 22:17:24.893516 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:17:24.893523 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1. Aug 5 22:17:24.893530 kernel: rcu: Hierarchical SRCU implementation. Aug 5 22:17:24.893537 kernel: rcu: Max phase no-delay instances is 400. Aug 5 22:17:24.893544 kernel: Platform MSI: ITS@0x8080000 domain created Aug 5 22:17:24.893551 kernel: PCI/MSI: ITS@0x8080000 domain created Aug 5 22:17:24.893559 kernel: Remapping and enabling EFI services. Aug 5 22:17:24.893566 kernel: smp: Bringing up secondary CPUs ... Aug 5 22:17:24.893573 kernel: Detected PIPT I-cache on CPU1 Aug 5 22:17:24.893580 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 Aug 5 22:17:24.893587 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 Aug 5 22:17:24.893594 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:17:24.893601 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] Aug 5 22:17:24.893607 kernel: Detected PIPT I-cache on CPU2 Aug 5 22:17:24.893614 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 Aug 5 22:17:24.893621 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 Aug 5 22:17:24.893630 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:17:24.893637 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] Aug 5 22:17:24.893649 kernel: Detected PIPT I-cache on CPU3 Aug 5 22:17:24.893657 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 Aug 5 22:17:24.893665 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 Aug 5 22:17:24.893673 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 Aug 5 22:17:24.893680 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] Aug 5 22:17:24.893687 kernel: smp: Brought up 1 node, 4 CPUs Aug 5 22:17:24.893695 kernel: SMP: Total of 4 processors activated. Aug 5 22:17:24.893703 kernel: CPU features: detected: 32-bit EL0 Support Aug 5 22:17:24.893711 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence Aug 5 22:17:24.893718 kernel: CPU features: detected: Common not Private translations Aug 5 22:17:24.893725 kernel: CPU features: detected: CRC32 instructions Aug 5 22:17:24.893733 kernel: CPU features: detected: Enhanced Virtualization Traps Aug 5 22:17:24.893740 kernel: CPU features: detected: RCpc load-acquire (LDAPR) Aug 5 22:17:24.893747 kernel: CPU features: detected: LSE atomic instructions Aug 5 22:17:24.893755 kernel: CPU features: detected: Privileged Access Never Aug 5 22:17:24.893763 kernel: CPU features: detected: RAS Extension Support Aug 5 22:17:24.893771 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) Aug 5 22:17:24.893778 kernel: CPU: All CPU(s) started at EL1 Aug 5 22:17:24.893785 kernel: alternatives: applying system-wide alternatives Aug 5 22:17:24.893792 kernel: devtmpfs: initialized Aug 5 22:17:24.893800 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 5 22:17:24.893807 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) Aug 5 22:17:24.893814 kernel: pinctrl core: initialized pinctrl subsystem Aug 5 22:17:24.893822 kernel: SMBIOS 3.0.0 present. Aug 5 22:17:24.893830 kernel: DMI: QEMU KVM Virtual Machine, BIOS edk2-20230524-3.fc38 05/24/2023 Aug 5 22:17:24.893837 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 5 22:17:24.893845 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 5 22:17:24.893852 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 5 22:17:24.893859 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 5 22:17:24.893867 kernel: audit: initializing netlink subsys (disabled) Aug 5 22:17:24.893874 kernel: audit: type=2000 audit(0.024:1): state=initialized audit_enabled=0 res=1 Aug 5 22:17:24.893882 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 5 22:17:24.893889 kernel: cpuidle: using governor menu Aug 5 22:17:24.893898 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 5 22:17:24.893905 kernel: ASID allocator initialised with 32768 entries Aug 5 22:17:24.893913 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 5 22:17:24.893920 kernel: Serial: AMBA PL011 UART driver Aug 5 22:17:24.893927 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL Aug 5 22:17:24.893934 kernel: Modules: 0 pages in range for non-PLT usage Aug 5 22:17:24.893942 kernel: Modules: 509120 pages in range for PLT usage Aug 5 22:17:24.893949 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 5 22:17:24.893957 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 5 22:17:24.893965 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 5 22:17:24.893973 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 5 22:17:24.893980 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 5 22:17:24.893987 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 5 22:17:24.893994 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 5 22:17:24.894002 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 5 22:17:24.894009 kernel: ACPI: Added _OSI(Module Device) Aug 5 22:17:24.894016 kernel: ACPI: Added _OSI(Processor Device) Aug 5 22:17:24.894024 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Aug 5 22:17:24.894032 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 5 22:17:24.894039 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 5 22:17:24.894047 kernel: ACPI: Interpreter enabled Aug 5 22:17:24.894054 kernel: ACPI: Using GIC for interrupt routing Aug 5 22:17:24.894061 kernel: ACPI: MCFG table detected, 1 entries Aug 5 22:17:24.894069 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA Aug 5 22:17:24.894076 kernel: printk: console [ttyAMA0] enabled Aug 5 22:17:24.894083 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Aug 5 22:17:24.894219 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 5 22:17:24.894326 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 5 22:17:24.894396 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 5 22:17:24.894459 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 Aug 5 22:17:24.894521 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] Aug 5 22:17:24.894531 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] Aug 5 22:17:24.894538 kernel: PCI host bridge to bus 0000:00 Aug 5 22:17:24.894607 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] Aug 5 22:17:24.894668 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 5 22:17:24.894725 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] Aug 5 22:17:24.894780 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Aug 5 22:17:24.894858 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 Aug 5 22:17:24.894938 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 Aug 5 22:17:24.895004 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] Aug 5 22:17:24.895071 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] Aug 5 22:17:24.895136 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:17:24.895199 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] Aug 5 22:17:24.895295 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] Aug 5 22:17:24.895392 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] Aug 5 22:17:24.895455 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] Aug 5 22:17:24.895510 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 5 22:17:24.895571 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] Aug 5 22:17:24.895581 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 5 22:17:24.895589 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 5 22:17:24.895596 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 5 22:17:24.895604 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 5 22:17:24.895611 kernel: iommu: Default domain type: Translated Aug 5 22:17:24.895618 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 5 22:17:24.895626 kernel: efivars: Registered efivars operations Aug 5 22:17:24.895633 kernel: vgaarb: loaded Aug 5 22:17:24.895642 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 5 22:17:24.895650 kernel: VFS: Disk quotas dquot_6.6.0 Aug 5 22:17:24.895657 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 5 22:17:24.895664 kernel: pnp: PnP ACPI init Aug 5 22:17:24.895732 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved Aug 5 22:17:24.895743 kernel: pnp: PnP ACPI: found 1 devices Aug 5 22:17:24.895750 kernel: NET: Registered PF_INET protocol family Aug 5 22:17:24.895758 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 5 22:17:24.895767 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 5 22:17:24.895775 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 5 22:17:24.895782 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 5 22:17:24.895789 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 5 22:17:24.895797 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 5 22:17:24.895804 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:17:24.895812 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 5 22:17:24.895819 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 5 22:17:24.895826 kernel: PCI: CLS 0 bytes, default 64 Aug 5 22:17:24.895835 kernel: kvm [1]: HYP mode not available Aug 5 22:17:24.895842 kernel: Initialise system trusted keyrings Aug 5 22:17:24.895849 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 5 22:17:24.895857 kernel: Key type asymmetric registered Aug 5 22:17:24.895864 kernel: Asymmetric key parser 'x509' registered Aug 5 22:17:24.895871 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Aug 5 22:17:24.895879 kernel: io scheduler mq-deadline registered Aug 5 22:17:24.895886 kernel: io scheduler kyber registered Aug 5 22:17:24.895893 kernel: io scheduler bfq registered Aug 5 22:17:24.895902 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 5 22:17:24.895910 kernel: ACPI: button: Power Button [PWRB] Aug 5 22:17:24.895917 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 5 22:17:24.895981 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) Aug 5 22:17:24.895991 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 5 22:17:24.895999 kernel: thunder_xcv, ver 1.0 Aug 5 22:17:24.896006 kernel: thunder_bgx, ver 1.0 Aug 5 22:17:24.896013 kernel: nicpf, ver 1.0 Aug 5 22:17:24.896021 kernel: nicvf, ver 1.0 Aug 5 22:17:24.896092 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 5 22:17:24.896156 kernel: rtc-efi rtc-efi.0: setting system clock to 2024-08-05T22:17:24 UTC (1722896244) Aug 5 22:17:24.896166 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 5 22:17:24.896173 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available Aug 5 22:17:24.896181 kernel: watchdog: Delayed init of the lockup detector failed: -19 Aug 5 22:17:24.896188 kernel: watchdog: Hard watchdog permanently disabled Aug 5 22:17:24.896195 kernel: NET: Registered PF_INET6 protocol family Aug 5 22:17:24.896203 kernel: Segment Routing with IPv6 Aug 5 22:17:24.896212 kernel: In-situ OAM (IOAM) with IPv6 Aug 5 22:17:24.896219 kernel: NET: Registered PF_PACKET protocol family Aug 5 22:17:24.896227 kernel: Key type dns_resolver registered Aug 5 22:17:24.896234 kernel: registered taskstats version 1 Aug 5 22:17:24.896242 kernel: Loading compiled-in X.509 certificates Aug 5 22:17:24.896249 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.43-flatcar: 99cab5c9e2f0f3a5ca972c2df7b3d6ed64d627d4' Aug 5 22:17:24.896287 kernel: Key type .fscrypt registered Aug 5 22:17:24.896296 kernel: Key type fscrypt-provisioning registered Aug 5 22:17:24.896303 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 5 22:17:24.896313 kernel: ima: Allocated hash algorithm: sha1 Aug 5 22:17:24.896321 kernel: ima: No architecture policies found Aug 5 22:17:24.896328 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 5 22:17:24.896336 kernel: clk: Disabling unused clocks Aug 5 22:17:24.896343 kernel: Freeing unused kernel memory: 39040K Aug 5 22:17:24.896351 kernel: Run /init as init process Aug 5 22:17:24.896358 kernel: with arguments: Aug 5 22:17:24.896366 kernel: /init Aug 5 22:17:24.896373 kernel: with environment: Aug 5 22:17:24.896385 kernel: HOME=/ Aug 5 22:17:24.896392 kernel: TERM=linux Aug 5 22:17:24.896399 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 5 22:17:24.896408 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 22:17:24.896418 systemd[1]: Detected virtualization kvm. Aug 5 22:17:24.896426 systemd[1]: Detected architecture arm64. Aug 5 22:17:24.896434 systemd[1]: Running in initrd. Aug 5 22:17:24.896441 systemd[1]: No hostname configured, using default hostname. Aug 5 22:17:24.896450 systemd[1]: Hostname set to . Aug 5 22:17:24.896458 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:17:24.896466 systemd[1]: Queued start job for default target initrd.target. Aug 5 22:17:24.896474 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:17:24.896482 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:17:24.896490 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 5 22:17:24.896498 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:17:24.896508 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 5 22:17:24.896516 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 5 22:17:24.896526 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 22:17:24.896534 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 5 22:17:24.896542 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:17:24.896550 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:17:24.896558 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:17:24.896567 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:17:24.896575 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:17:24.896583 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:17:24.896591 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:17:24.896599 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:17:24.896607 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 5 22:17:24.896615 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Aug 5 22:17:24.896622 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:17:24.896630 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:17:24.896639 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:17:24.896647 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:17:24.896655 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 5 22:17:24.896663 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:17:24.896671 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 5 22:17:24.896679 systemd[1]: Starting systemd-fsck-usr.service... Aug 5 22:17:24.896687 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:17:24.896694 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:17:24.896702 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:17:24.896712 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 5 22:17:24.896720 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:17:24.896727 systemd[1]: Finished systemd-fsck-usr.service. Aug 5 22:17:24.896736 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 5 22:17:24.896746 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:17:24.896770 systemd-journald[238]: Collecting audit messages is disabled. Aug 5 22:17:24.896789 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:17:24.896798 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 5 22:17:24.896808 systemd-journald[238]: Journal started Aug 5 22:17:24.896827 systemd-journald[238]: Runtime Journal (/run/log/journal/6c8600e3509e4bdc9408a7d04080b6ac) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:17:24.884158 systemd-modules-load[239]: Inserted module 'overlay' Aug 5 22:17:24.898767 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:17:24.902292 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 22:17:24.902460 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:17:24.904438 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:17:24.906936 kernel: Bridge firewalling registered Aug 5 22:17:24.904802 systemd-modules-load[239]: Inserted module 'br_netfilter' Aug 5 22:17:24.907293 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:17:24.910526 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:17:24.914401 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:17:24.917721 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:17:24.920064 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 5 22:17:24.922335 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:17:24.923568 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:17:24.927261 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:17:24.937252 dracut-cmdline[272]: dracut-dracut-053 Aug 5 22:17:24.940384 dracut-cmdline[272]: 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=4052403b8e39e55d48e6afcca927358798017aa0d33c868bc3038260a8d9be90 Aug 5 22:17:24.953741 systemd-resolved[276]: Positive Trust Anchors: Aug 5 22:17:24.953757 systemd-resolved[276]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:17:24.953786 systemd-resolved[276]: 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 22:17:24.958270 systemd-resolved[276]: Defaulting to hostname 'linux'. Aug 5 22:17:24.960400 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:17:24.963107 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:17:25.024292 kernel: SCSI subsystem initialized Aug 5 22:17:25.028284 kernel: Loading iSCSI transport class v2.0-870. Aug 5 22:17:25.036302 kernel: iscsi: registered transport (tcp) Aug 5 22:17:25.049312 kernel: iscsi: registered transport (qla4xxx) Aug 5 22:17:25.049350 kernel: QLogic iSCSI HBA Driver Aug 5 22:17:25.105393 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 5 22:17:25.115468 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 5 22:17:25.132953 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 5 22:17:25.132984 kernel: device-mapper: uevent: version 1.0.3 Aug 5 22:17:25.132997 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Aug 5 22:17:25.183292 kernel: raid6: neonx8 gen() 15750 MB/s Aug 5 22:17:25.200285 kernel: raid6: neonx4 gen() 15651 MB/s Aug 5 22:17:25.217290 kernel: raid6: neonx2 gen() 13221 MB/s Aug 5 22:17:25.234288 kernel: raid6: neonx1 gen() 10451 MB/s Aug 5 22:17:25.251290 kernel: raid6: int64x8 gen() 6950 MB/s Aug 5 22:17:25.268288 kernel: raid6: int64x4 gen() 7333 MB/s Aug 5 22:17:25.285287 kernel: raid6: int64x2 gen() 6127 MB/s Aug 5 22:17:25.302289 kernel: raid6: int64x1 gen() 5056 MB/s Aug 5 22:17:25.302314 kernel: raid6: using algorithm neonx8 gen() 15750 MB/s Aug 5 22:17:25.319283 kernel: raid6: .... xor() 12051 MB/s, rmw enabled Aug 5 22:17:25.319300 kernel: raid6: using neon recovery algorithm Aug 5 22:17:25.324382 kernel: xor: measuring software checksum speed Aug 5 22:17:25.324398 kernel: 8regs : 19854 MB/sec Aug 5 22:17:25.325283 kernel: 32regs : 19678 MB/sec Aug 5 22:17:25.326380 kernel: arm64_neon : 27234 MB/sec Aug 5 22:17:25.326393 kernel: xor: using function: arm64_neon (27234 MB/sec) Aug 5 22:17:25.376283 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 5 22:17:25.386857 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:17:25.402416 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:17:25.414009 systemd-udevd[458]: Using default interface naming scheme 'v255'. Aug 5 22:17:25.417158 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:17:25.428489 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 5 22:17:25.440104 dracut-pre-trigger[466]: rd.md=0: removing MD RAID activation Aug 5 22:17:25.473320 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:17:25.485404 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:17:25.524477 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:17:25.534426 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 5 22:17:25.546559 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 5 22:17:25.548081 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:17:25.549767 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:17:25.552934 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:17:25.563438 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 5 22:17:25.575308 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues Aug 5 22:17:25.581840 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) Aug 5 22:17:25.581955 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:17:25.575418 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:17:25.584634 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:17:25.584755 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:17:25.587376 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:17:25.592816 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:17:25.592956 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:17:25.596064 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:17:25.605486 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:17:25.613331 kernel: BTRFS: device fsid 278882ec-4175-45f0-a12b-7fddc0d6d9a3 devid 1 transid 41 /dev/vda3 scanned by (udev-worker) (509) Aug 5 22:17:25.617292 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/vda6 scanned by (udev-worker) (524) Aug 5 22:17:25.618887 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. Aug 5 22:17:25.623358 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:17:25.627900 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. Aug 5 22:17:25.634011 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. Aug 5 22:17:25.634915 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 22:17:25.639932 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:17:25.654414 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 5 22:17:25.656473 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 5 22:17:25.669260 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:17:25.683832 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:17:26.683321 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 Aug 5 22:17:26.683377 disk-uuid[554]: The operation has completed successfully. Aug 5 22:17:26.708499 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 5 22:17:26.708595 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 5 22:17:26.728475 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 5 22:17:26.732199 sh[575]: Success Aug 5 22:17:26.749693 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Aug 5 22:17:26.778805 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 5 22:17:26.799603 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 5 22:17:26.810069 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 5 22:17:26.818604 kernel: BTRFS info (device dm-0): first mount of filesystem 278882ec-4175-45f0-a12b-7fddc0d6d9a3 Aug 5 22:17:26.818645 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:17:26.818656 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Aug 5 22:17:26.820302 kernel: BTRFS info (device dm-0): disabling log replay at mount time Aug 5 22:17:26.820337 kernel: BTRFS info (device dm-0): using free space tree Aug 5 22:17:26.830798 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 5 22:17:26.831978 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 5 22:17:26.843406 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 5 22:17:26.844857 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 5 22:17:26.854904 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:17:26.854942 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:17:26.854953 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:17:26.864500 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:17:26.872952 systemd[1]: mnt-oem.mount: Deactivated successfully. Aug 5 22:17:26.874324 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:17:26.880355 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 5 22:17:26.886456 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 5 22:17:26.968974 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:17:26.980484 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:17:26.996396 ignition[676]: Ignition 2.18.0 Aug 5 22:17:26.996410 ignition[676]: Stage: fetch-offline Aug 5 22:17:26.996447 ignition[676]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:26.996455 ignition[676]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:26.996550 ignition[676]: parsed url from cmdline: "" Aug 5 22:17:26.996554 ignition[676]: no config URL provided Aug 5 22:17:26.996559 ignition[676]: reading system config file "/usr/lib/ignition/user.ign" Aug 5 22:17:26.996565 ignition[676]: no config at "/usr/lib/ignition/user.ign" Aug 5 22:17:26.996587 ignition[676]: op(1): [started] loading QEMU firmware config module Aug 5 22:17:26.996591 ignition[676]: op(1): executing: "modprobe" "qemu_fw_cfg" Aug 5 22:17:27.006917 systemd-networkd[767]: lo: Link UP Aug 5 22:17:27.006929 systemd-networkd[767]: lo: Gained carrier Aug 5 22:17:27.007591 systemd-networkd[767]: Enumeration completed Aug 5 22:17:27.007983 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:17:27.008181 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:17:27.008184 systemd-networkd[767]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:17:27.009471 systemd[1]: Reached target network.target - Network. Aug 5 22:17:27.016606 ignition[676]: op(1): [finished] loading QEMU firmware config module Aug 5 22:17:27.010458 systemd-networkd[767]: eth0: Link UP Aug 5 22:17:27.010461 systemd-networkd[767]: eth0: Gained carrier Aug 5 22:17:27.010467 systemd-networkd[767]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:17:27.023363 ignition[676]: parsing config with SHA512: 374ecc04894c98c1ecf415871e18d28185c19e8e0fb8f954b500fab81790ec19029ec7c7bb81eb3a25cdbfd4b05777e35b9aea7ca19fbd28410b1db6db6ac685 Aug 5 22:17:27.027842 unknown[676]: fetched base config from "system" Aug 5 22:17:27.027851 unknown[676]: fetched user config from "qemu" Aug 5 22:17:27.028026 ignition[676]: fetch-offline: fetch-offline passed Aug 5 22:17:27.029637 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:17:27.028097 ignition[676]: Ignition finished successfully Aug 5 22:17:27.031310 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). Aug 5 22:17:27.032436 systemd-networkd[767]: eth0: DHCPv4 address 10.0.0.128/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:17:27.040095 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 5 22:17:27.050598 ignition[774]: Ignition 2.18.0 Aug 5 22:17:27.051191 ignition[774]: Stage: kargs Aug 5 22:17:27.051380 ignition[774]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:27.051390 ignition[774]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:27.051959 ignition[774]: kargs: kargs passed Aug 5 22:17:27.054086 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 5 22:17:27.052002 ignition[774]: Ignition finished successfully Aug 5 22:17:27.056883 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 5 22:17:27.070577 ignition[784]: Ignition 2.18.0 Aug 5 22:17:27.070588 ignition[784]: Stage: disks Aug 5 22:17:27.070751 ignition[784]: no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:27.070761 ignition[784]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:27.072849 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 5 22:17:27.071334 ignition[784]: disks: disks passed Aug 5 22:17:27.074389 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 5 22:17:27.071378 ignition[784]: Ignition finished successfully Aug 5 22:17:27.075642 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 5 22:17:27.076903 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:17:27.078599 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:17:27.079967 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:17:27.095482 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 5 22:17:27.107549 systemd-fsck[795]: ROOT: clean, 14/553520 files, 52654/553472 blocks Aug 5 22:17:27.113155 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 5 22:17:27.124408 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 5 22:17:27.175302 kernel: EXT4-fs (vda9): mounted filesystem 44c9fced-dca5-4347-a15f-96911c2e5e61 r/w with ordered data mode. Quota mode: none. Aug 5 22:17:27.175461 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 5 22:17:27.176595 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 5 22:17:27.187360 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:17:27.189671 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 5 22:17:27.190650 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 5 22:17:27.190691 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 5 22:17:27.190713 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:17:27.196628 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 5 22:17:27.198945 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 5 22:17:27.204711 kernel: BTRFS: device label OEM devid 1 transid 13 /dev/vda6 scanned by mount (804) Aug 5 22:17:27.204754 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:17:27.204765 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:17:27.206329 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:17:27.212284 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:17:27.213284 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:17:27.259561 initrd-setup-root[828]: cut: /sysroot/etc/passwd: No such file or directory Aug 5 22:17:27.265757 initrd-setup-root[835]: cut: /sysroot/etc/group: No such file or directory Aug 5 22:17:27.269503 initrd-setup-root[842]: cut: /sysroot/etc/shadow: No such file or directory Aug 5 22:17:27.273144 initrd-setup-root[849]: cut: /sysroot/etc/gshadow: No such file or directory Aug 5 22:17:27.359648 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 5 22:17:27.371694 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 5 22:17:27.377482 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 5 22:17:27.382013 kernel: BTRFS info (device vda6): last unmount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:17:27.400333 ignition[916]: INFO : Ignition 2.18.0 Aug 5 22:17:27.400333 ignition[916]: INFO : Stage: mount Aug 5 22:17:27.400333 ignition[916]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:27.400333 ignition[916]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:27.400333 ignition[916]: INFO : mount: mount passed Aug 5 22:17:27.400333 ignition[916]: INFO : Ignition finished successfully Aug 5 22:17:27.402611 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 5 22:17:27.407444 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 5 22:17:27.409175 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 5 22:17:27.817814 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 5 22:17:27.828514 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 5 22:17:27.833293 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by mount (930) Aug 5 22:17:27.835486 kernel: BTRFS info (device vda6): first mount of filesystem 47327e03-a391-4166-b35e-18ba93a1f298 Aug 5 22:17:27.835506 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm Aug 5 22:17:27.835517 kernel: BTRFS info (device vda6): using free space tree Aug 5 22:17:27.837283 kernel: BTRFS info (device vda6): auto enabling async discard Aug 5 22:17:27.838338 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 5 22:17:27.854159 ignition[947]: INFO : Ignition 2.18.0 Aug 5 22:17:27.854159 ignition[947]: INFO : Stage: files Aug 5 22:17:27.855735 ignition[947]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:27.855735 ignition[947]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:27.855735 ignition[947]: DEBUG : files: compiled without relabeling support, skipping Aug 5 22:17:27.858871 ignition[947]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 5 22:17:27.858871 ignition[947]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 5 22:17:27.861686 ignition[947]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 5 22:17:27.862983 ignition[947]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 5 22:17:27.862983 ignition[947]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 5 22:17:27.862196 unknown[947]: wrote ssh authorized keys file for user: core Aug 5 22:17:27.866587 ignition[947]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:17:27.866587 ignition[947]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(4): [started] processing unit "docker.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(4): [finished] processing unit "docker.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(5): [started] processing unit "coreos-metadata.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(5): op(6): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(5): op(6): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(5): [finished] processing unit "coreos-metadata.service" Aug 5 22:17:27.866587 ignition[947]: INFO : files: op(7): [started] setting preset to disabled for "coreos-metadata.service" Aug 5 22:17:27.895021 ignition[947]: INFO : files: op(7): op(8): [started] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:17:27.898656 ignition[947]: INFO : files: op(7): op(8): [finished] removing enablement symlink(s) for "coreos-metadata.service" Aug 5 22:17:27.900034 ignition[947]: INFO : files: op(7): [finished] setting preset to disabled for "coreos-metadata.service" Aug 5 22:17:27.900034 ignition[947]: INFO : files: op(9): [started] setting preset to enabled for "docker.service" Aug 5 22:17:27.900034 ignition[947]: INFO : files: op(9): [finished] setting preset to enabled for "docker.service" Aug 5 22:17:27.900034 ignition[947]: INFO : files: createResultFile: createFiles: op(a): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:17:27.900034 ignition[947]: INFO : files: createResultFile: createFiles: op(a): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 5 22:17:27.900034 ignition[947]: INFO : files: files passed Aug 5 22:17:27.900034 ignition[947]: INFO : Ignition finished successfully Aug 5 22:17:27.900565 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 5 22:17:27.910476 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 5 22:17:27.912054 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 5 22:17:27.913742 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 5 22:17:27.913815 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 5 22:17:27.919551 initrd-setup-root-after-ignition[976]: grep: /sysroot/oem/oem-release: No such file or directory Aug 5 22:17:27.922384 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:17:27.922384 initrd-setup-root-after-ignition[978]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:17:27.925540 initrd-setup-root-after-ignition[982]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 5 22:17:27.926863 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:17:27.929021 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 5 22:17:27.947392 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 5 22:17:27.965535 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 5 22:17:27.965631 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 5 22:17:27.967668 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 5 22:17:27.969205 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 5 22:17:27.970702 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 5 22:17:27.971390 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 5 22:17:27.986302 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:17:27.988529 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 5 22:17:27.999037 systemd[1]: Stopped target network.target - Network. Aug 5 22:17:27.999954 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:17:28.001342 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:17:28.003077 systemd[1]: Stopped target timers.target - Timer Units. Aug 5 22:17:28.004550 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 5 22:17:28.004658 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 5 22:17:28.006831 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 5 22:17:28.008672 systemd[1]: Stopped target basic.target - Basic System. Aug 5 22:17:28.010095 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 5 22:17:28.011484 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 5 22:17:28.013117 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 5 22:17:28.015007 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 5 22:17:28.016616 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 5 22:17:28.018332 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 5 22:17:28.020037 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 5 22:17:28.021463 systemd[1]: Stopped target swap.target - Swaps. Aug 5 22:17:28.022875 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 5 22:17:28.022985 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 5 22:17:28.024785 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:17:28.026373 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:17:28.027892 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 5 22:17:28.031338 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:17:28.032542 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 5 22:17:28.032649 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 5 22:17:28.034953 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 5 22:17:28.035058 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 5 22:17:28.036915 systemd[1]: Stopped target paths.target - Path Units. Aug 5 22:17:28.038588 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 5 22:17:28.043337 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:17:28.044593 systemd[1]: Stopped target slices.target - Slice Units. Aug 5 22:17:28.046498 systemd[1]: Stopped target sockets.target - Socket Units. Aug 5 22:17:28.047781 systemd[1]: iscsid.socket: Deactivated successfully. Aug 5 22:17:28.047866 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 5 22:17:28.048951 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 5 22:17:28.049024 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 5 22:17:28.050249 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 5 22:17:28.050371 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 5 22:17:28.051924 systemd[1]: ignition-files.service: Deactivated successfully. Aug 5 22:17:28.052017 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 5 22:17:28.064497 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 5 22:17:28.065333 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 5 22:17:28.065465 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:17:28.070524 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 5 22:17:28.071545 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 5 22:17:28.074227 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 5 22:17:28.075736 ignition[1002]: INFO : Ignition 2.18.0 Aug 5 22:17:28.075736 ignition[1002]: INFO : Stage: umount Aug 5 22:17:28.075736 ignition[1002]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 5 22:17:28.075736 ignition[1002]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" Aug 5 22:17:28.075736 ignition[1002]: INFO : umount: umount passed Aug 5 22:17:28.082918 ignition[1002]: INFO : Ignition finished successfully Aug 5 22:17:28.077260 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 5 22:17:28.077404 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:17:28.078989 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 5 22:17:28.079086 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 5 22:17:28.082864 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 5 22:17:28.084297 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 5 22:17:28.084694 systemd-networkd[767]: eth0: DHCPv6 lease lost Aug 5 22:17:28.089352 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 5 22:17:28.089903 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 5 22:17:28.091381 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 5 22:17:28.093447 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 5 22:17:28.093528 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 5 22:17:28.094885 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 5 22:17:28.094960 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 5 22:17:28.097649 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 5 22:17:28.097728 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 5 22:17:28.101223 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 5 22:17:28.101288 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:17:28.102356 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 5 22:17:28.102400 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 5 22:17:28.104188 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 5 22:17:28.104231 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 5 22:17:28.105849 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 5 22:17:28.105887 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 5 22:17:28.107543 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 5 22:17:28.107586 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 5 22:17:28.109130 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 5 22:17:28.109172 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 5 22:17:28.122385 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 5 22:17:28.123203 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 5 22:17:28.123286 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 5 22:17:28.125018 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 5 22:17:28.125061 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:17:28.126645 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 5 22:17:28.126688 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 5 22:17:28.128623 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 5 22:17:28.128665 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:17:28.130278 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:17:28.142179 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 5 22:17:28.142309 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 5 22:17:28.155004 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 5 22:17:28.155138 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:17:28.156974 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 5 22:17:28.157010 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 5 22:17:28.158609 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 5 22:17:28.158640 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:17:28.160219 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 5 22:17:28.160293 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 5 22:17:28.162525 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 5 22:17:28.162566 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 5 22:17:28.164640 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 5 22:17:28.164694 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 5 22:17:28.167427 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 5 22:17:28.168364 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 5 22:17:28.168419 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:17:28.170011 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 5 22:17:28.170050 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:17:28.175884 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 5 22:17:28.175965 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 5 22:17:28.177713 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 5 22:17:28.186426 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 5 22:17:28.192251 systemd[1]: Switching root. Aug 5 22:17:28.212068 systemd-journald[238]: Journal stopped Aug 5 22:17:28.789225 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). Aug 5 22:17:28.789296 kernel: SELinux: policy capability network_peer_controls=1 Aug 5 22:17:28.789311 kernel: SELinux: policy capability open_perms=1 Aug 5 22:17:28.789320 kernel: SELinux: policy capability extended_socket_class=1 Aug 5 22:17:28.789329 kernel: SELinux: policy capability always_check_network=0 Aug 5 22:17:28.789339 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 5 22:17:28.789352 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 5 22:17:28.789364 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 5 22:17:28.789374 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 5 22:17:28.789384 kernel: audit: type=1403 audit(1722896248.275:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 5 22:17:28.789394 systemd[1]: Successfully loaded SELinux policy in 31.166ms. Aug 5 22:17:28.789415 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 8.679ms. Aug 5 22:17:28.789426 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 22:17:28.789437 systemd[1]: Detected virtualization kvm. Aug 5 22:17:28.789448 systemd[1]: Detected architecture arm64. Aug 5 22:17:28.789460 systemd[1]: Detected first boot. Aug 5 22:17:28.789471 systemd[1]: Initializing machine ID from VM UUID. Aug 5 22:17:28.789481 zram_generator::config[1047]: No configuration found. Aug 5 22:17:28.789493 systemd[1]: Populated /etc with preset unit settings. Aug 5 22:17:28.789503 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 5 22:17:28.789513 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 5 22:17:28.789524 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 5 22:17:28.789535 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 5 22:17:28.789547 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 5 22:17:28.789558 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 5 22:17:28.789568 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 5 22:17:28.789579 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 5 22:17:28.789589 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 5 22:17:28.789601 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 5 22:17:28.789614 systemd[1]: Created slice user.slice - User and Session Slice. Aug 5 22:17:28.789625 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 5 22:17:28.789636 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 5 22:17:28.789646 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 5 22:17:28.789656 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 5 22:17:28.789667 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 5 22:17:28.789678 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 5 22:17:28.789688 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... Aug 5 22:17:28.789700 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 5 22:17:28.789711 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 5 22:17:28.789721 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 5 22:17:28.789731 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 5 22:17:28.789742 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 5 22:17:28.789752 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 5 22:17:28.789763 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 5 22:17:28.789773 systemd[1]: Reached target slices.target - Slice Units. Aug 5 22:17:28.789785 systemd[1]: Reached target swap.target - Swaps. Aug 5 22:17:28.789796 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 5 22:17:28.789806 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 5 22:17:28.789817 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 5 22:17:28.789828 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 5 22:17:28.789839 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 5 22:17:28.789849 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 5 22:17:28.789860 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 5 22:17:28.789873 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 5 22:17:28.789885 systemd[1]: Mounting media.mount - External Media Directory... Aug 5 22:17:28.789896 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 5 22:17:28.789907 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 5 22:17:28.789917 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 5 22:17:28.789929 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 22:17:28.789939 systemd[1]: Reached target machines.target - Containers. Aug 5 22:17:28.789950 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 5 22:17:28.789960 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:17:28.789971 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 5 22:17:28.789983 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 5 22:17:28.789993 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:17:28.790004 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:17:28.790014 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:17:28.790024 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 5 22:17:28.790035 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:17:28.790045 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 5 22:17:28.790057 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 5 22:17:28.790069 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 5 22:17:28.790079 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 5 22:17:28.790089 systemd[1]: Stopped systemd-fsck-usr.service. Aug 5 22:17:28.790100 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 5 22:17:28.790110 kernel: fuse: init (API version 7.39) Aug 5 22:17:28.790120 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 5 22:17:28.790130 kernel: loop: module loaded Aug 5 22:17:28.790140 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 5 22:17:28.790150 kernel: ACPI: bus type drm_connector registered Aug 5 22:17:28.790164 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 5 22:17:28.790174 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 5 22:17:28.790185 systemd[1]: verity-setup.service: Deactivated successfully. Aug 5 22:17:28.790195 systemd[1]: Stopped verity-setup.service. Aug 5 22:17:28.790206 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 5 22:17:28.790216 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 5 22:17:28.790227 systemd[1]: Mounted media.mount - External Media Directory. Aug 5 22:17:28.790243 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 5 22:17:28.790259 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 5 22:17:28.790294 systemd-journald[1117]: Collecting audit messages is disabled. Aug 5 22:17:28.790314 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 5 22:17:28.790327 systemd-journald[1117]: Journal started Aug 5 22:17:28.790349 systemd-journald[1117]: Runtime Journal (/run/log/journal/6c8600e3509e4bdc9408a7d04080b6ac) is 5.9M, max 47.3M, 41.4M free. Aug 5 22:17:28.610959 systemd[1]: Queued start job for default target multi-user.target. Aug 5 22:17:28.625053 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. Aug 5 22:17:28.625440 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 5 22:17:28.791751 systemd[1]: Started systemd-journald.service - Journal Service. Aug 5 22:17:28.794287 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 5 22:17:28.795572 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 5 22:17:28.796731 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 5 22:17:28.796863 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 5 22:17:28.797945 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:17:28.798071 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:17:28.799407 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:17:28.799534 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:17:28.800536 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:17:28.800654 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:17:28.801828 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 5 22:17:28.801957 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 5 22:17:28.803032 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:17:28.803156 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:17:28.804212 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 5 22:17:28.805307 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 5 22:17:28.806526 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 5 22:17:28.818295 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 5 22:17:28.831392 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 5 22:17:28.833080 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 5 22:17:28.834107 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 5 22:17:28.834143 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 5 22:17:28.835887 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Aug 5 22:17:28.837838 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 5 22:17:28.839832 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 5 22:17:28.840719 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:17:28.841987 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 5 22:17:28.844438 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 5 22:17:28.845629 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:17:28.848681 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 5 22:17:28.849701 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:17:28.852484 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 5 22:17:28.855491 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 5 22:17:28.856951 systemd-journald[1117]: Time spent on flushing to /var/log/journal/6c8600e3509e4bdc9408a7d04080b6ac is 21.646ms for 823 entries. Aug 5 22:17:28.856951 systemd-journald[1117]: System Journal (/var/log/journal/6c8600e3509e4bdc9408a7d04080b6ac) is 8.0M, max 195.6M, 187.6M free. Aug 5 22:17:28.894118 systemd-journald[1117]: Received client request to flush runtime journal. Aug 5 22:17:28.894410 kernel: loop0: detected capacity change from 0 to 59688 Aug 5 22:17:28.894454 kernel: block loop0: the capability attribute has been deprecated. Aug 5 22:17:28.894624 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 5 22:17:28.859522 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 5 22:17:28.861938 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 5 22:17:28.863192 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 5 22:17:28.866486 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 5 22:17:28.867819 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 5 22:17:28.869010 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 5 22:17:28.872591 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 5 22:17:28.883459 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Aug 5 22:17:28.886456 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Aug 5 22:17:28.889162 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 5 22:17:28.900301 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 5 22:17:28.903455 udevadm[1171]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Aug 5 22:17:28.912028 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 5 22:17:28.912685 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 5 22:17:28.915279 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Aug 5 22:17:28.923292 kernel: loop1: detected capacity change from 0 to 113672 Aug 5 22:17:28.925023 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 5 22:17:28.942734 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Aug 5 22:17:28.942748 systemd-tmpfiles[1177]: ACLs are not supported, ignoring. Aug 5 22:17:28.950657 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 5 22:17:28.959314 kernel: loop2: detected capacity change from 0 to 59688 Aug 5 22:17:28.964291 kernel: loop3: detected capacity change from 0 to 113672 Aug 5 22:17:28.966469 (sd-merge)[1183]: Using extensions 'containerd-flatcar', 'docker-flatcar'. Aug 5 22:17:28.966793 (sd-merge)[1183]: Merged extensions into '/usr'. Aug 5 22:17:28.969645 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 5 22:17:28.978722 systemd[1]: Starting ensure-sysext.service... Aug 5 22:17:28.980310 systemd[1]: Starting systemd-tmpfiles-setup.service - Create Volatile Files and Directories... Aug 5 22:17:28.990156 systemd[1]: Reloading requested from client PID 1185 ('systemctl') (unit ensure-sysext.service)... Aug 5 22:17:28.990174 systemd[1]: Reloading... Aug 5 22:17:29.003406 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 5 22:17:29.003668 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 5 22:17:29.004391 systemd-tmpfiles[1186]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 5 22:17:29.004613 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Aug 5 22:17:29.004658 systemd-tmpfiles[1186]: ACLs are not supported, ignoring. Aug 5 22:17:29.007858 systemd-tmpfiles[1186]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:17:29.007872 systemd-tmpfiles[1186]: Skipping /boot Aug 5 22:17:29.018197 systemd-tmpfiles[1186]: Detected autofs mount point /boot during canonicalization of boot. Aug 5 22:17:29.018215 systemd-tmpfiles[1186]: Skipping /boot Aug 5 22:17:29.046292 zram_generator::config[1215]: No configuration found. Aug 5 22:17:29.127124 ldconfig[1152]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 5 22:17:29.129947 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 22:17:29.166942 systemd[1]: Reloading finished in 176 ms. Aug 5 22:17:29.196334 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 5 22:17:29.206326 systemd[1]: Finished systemd-tmpfiles-setup.service - Create Volatile Files and Directories. Aug 5 22:17:29.214503 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:17:29.216862 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 5 22:17:29.221556 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 5 22:17:29.227976 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 5 22:17:29.230622 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 5 22:17:29.233225 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:17:29.237314 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:17:29.239979 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:17:29.245507 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:17:29.246341 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:17:29.246998 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:17:29.247153 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:17:29.253600 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 5 22:17:29.257303 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 5 22:17:29.259188 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:17:29.259488 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:17:29.261084 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:17:29.261195 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:17:29.266970 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:17:29.279568 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:17:29.284551 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:17:29.286784 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:17:29.288036 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:17:29.289943 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 5 22:17:29.291792 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:17:29.291929 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:17:29.293332 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:17:29.293461 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:17:29.295417 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:17:29.295533 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:17:29.301173 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 5 22:17:29.305518 augenrules[1283]: No rules Aug 5 22:17:29.306697 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 5 22:17:29.308067 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:17:29.310568 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 5 22:17:29.325572 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 5 22:17:29.327530 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 5 22:17:29.330571 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 5 22:17:29.336714 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 5 22:17:29.337805 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 5 22:17:29.337958 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 22:17:29.341319 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 5 22:17:29.342891 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 5 22:17:29.343017 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 5 22:17:29.344566 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 5 22:17:29.344778 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 5 22:17:29.346022 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 5 22:17:29.346220 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 5 22:17:29.347909 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 5 22:17:29.348030 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 5 22:17:29.351519 systemd[1]: Finished ensure-sysext.service. Aug 5 22:17:29.355173 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 5 22:17:29.355249 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 5 22:17:29.364431 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... Aug 5 22:17:29.369674 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 5 22:17:29.371538 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 5 22:17:29.371938 systemd-resolved[1253]: Positive Trust Anchors: Aug 5 22:17:29.371948 systemd-resolved[1253]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 5 22:17:29.371978 systemd-resolved[1253]: 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 22:17:29.382905 systemd-resolved[1253]: Defaulting to hostname 'linux'. Aug 5 22:17:29.384399 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 5 22:17:29.385462 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 5 22:17:29.395335 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 5 22:17:29.401539 systemd-udevd[1306]: Using default interface naming scheme 'v255'. Aug 5 22:17:29.408511 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. Aug 5 22:17:29.409808 systemd[1]: Reached target time-set.target - System Time Set. Aug 5 22:17:29.414458 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 5 22:17:29.425506 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 5 22:17:29.441007 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. Aug 5 22:17:29.470633 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1324) Aug 5 22:17:29.470713 kernel: BTRFS info: devid 1 device path /dev/mapper/usr changed to /dev/dm-0 scanned by (udev-worker) (1311) Aug 5 22:17:29.474354 systemd-networkd[1317]: lo: Link UP Aug 5 22:17:29.474362 systemd-networkd[1317]: lo: Gained carrier Aug 5 22:17:29.475917 systemd-networkd[1317]: Enumeration completed Aug 5 22:17:29.476035 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 5 22:17:29.477912 systemd[1]: Reached target network.target - Network. Aug 5 22:17:29.483679 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:17:29.483689 systemd-networkd[1317]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 5 22:17:29.487187 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:17:29.487230 systemd-networkd[1317]: eth0: Link UP Aug 5 22:17:29.487233 systemd-networkd[1317]: eth0: Gained carrier Aug 5 22:17:29.487252 systemd-networkd[1317]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 5 22:17:29.489503 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 5 22:17:29.497338 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. Aug 5 22:17:29.504355 systemd-networkd[1317]: eth0: DHCPv4 address 10.0.0.128/16, gateway 10.0.0.1 acquired from 10.0.0.1 Aug 5 22:17:29.504421 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 5 22:17:29.505448 systemd-timesyncd[1305]: Network configuration changed, trying to establish connection. Aug 5 22:17:29.507145 systemd-timesyncd[1305]: Contacted time server 10.0.0.1:123 (10.0.0.1). Aug 5 22:17:29.507201 systemd-timesyncd[1305]: Initial clock synchronization to Mon 2024-08-05 22:17:29.651356 UTC. Aug 5 22:17:29.526332 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 5 22:17:29.541482 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 5 22:17:29.551442 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Aug 5 22:17:29.553982 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Aug 5 22:17:29.572075 lvm[1346]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:17:29.588906 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 5 22:17:29.602308 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Aug 5 22:17:29.603785 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 5 22:17:29.604861 systemd[1]: Reached target sysinit.target - System Initialization. Aug 5 22:17:29.605941 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 5 22:17:29.607120 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 22:17:29.608600 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 5 22:17:29.609708 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 5 22:17:29.610695 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 5 22:17:29.611850 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 5 22:17:29.611887 systemd[1]: Reached target paths.target - Path Units. Aug 5 22:17:29.612568 systemd[1]: Reached target timers.target - Timer Units. Aug 5 22:17:29.614298 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 5 22:17:29.616590 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:17:29.627199 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 5 22:17:29.629478 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Aug 5 22:17:29.631015 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:17:29.631942 systemd[1]: Reached target sockets.target - Socket Units. Aug 5 22:17:29.632769 systemd[1]: Reached target basic.target - Basic System. Aug 5 22:17:29.633568 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:17:29.633596 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 5 22:17:29.634464 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:17:29.636333 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 5 22:17:29.638443 lvm[1354]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Aug 5 22:17:29.640399 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 5 22:17:29.642291 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 5 22:17:29.643286 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 22:17:29.644477 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 5 22:17:29.650457 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 5 22:17:29.652573 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 5 22:17:29.655670 jq[1357]: false Aug 5 22:17:29.659431 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 5 22:17:29.664703 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 5 22:17:29.665119 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 5 22:17:29.666633 systemd[1]: Starting update-engine.service - Update Engine... Aug 5 22:17:29.668199 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 5 22:17:29.669728 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Aug 5 22:17:29.671581 extend-filesystems[1358]: Found loop2 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found loop3 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda1 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda2 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda3 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found usr Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda4 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda6 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda7 Aug 5 22:17:29.671581 extend-filesystems[1358]: Found vda9 Aug 5 22:17:29.671581 extend-filesystems[1358]: Checking size of /dev/vda9 Aug 5 22:17:29.672932 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 5 22:17:29.679969 dbus-daemon[1356]: [system] SELinux support is enabled Aug 5 22:17:29.673078 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 5 22:17:29.673374 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 5 22:17:29.691592 jq[1372]: true Aug 5 22:17:29.673503 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 5 22:17:29.681945 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 5 22:17:29.688590 systemd[1]: motdgen.service: Deactivated successfully. Aug 5 22:17:29.690696 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 5 22:17:29.698077 extend-filesystems[1358]: Old size kept for /dev/vda9 Aug 5 22:17:29.699620 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 5 22:17:29.699788 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 5 22:17:29.708301 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 22:17:29.708336 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 5 22:17:29.709135 jq[1382]: true Aug 5 22:17:29.711538 (ntainerd)[1384]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:17:29.712655 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 22:17:29.712684 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 5 22:17:29.731788 update_engine[1369]: I0805 22:17:29.731529 1369 main.cc:92] Flatcar Update Engine starting Aug 5 22:17:29.732521 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (1314) Aug 5 22:17:29.734700 update_engine[1369]: I0805 22:17:29.734656 1369 update_check_scheduler.cc:74] Next update check in 8m3s Aug 5 22:17:29.735424 systemd-logind[1364]: Watching system buttons on /dev/input/event0 (Power Button) Aug 5 22:17:29.736132 systemd[1]: Started update-engine.service - Update Engine. Aug 5 22:17:29.736526 systemd-logind[1364]: New seat seat0. Aug 5 22:17:29.754494 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 5 22:17:29.755734 systemd[1]: Started systemd-logind.service - User Login Management. Aug 5 22:17:29.759308 bash[1405]: Updated "/home/core/.ssh/authorized_keys" Aug 5 22:17:29.761316 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 5 22:17:29.764847 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. Aug 5 22:17:29.793278 locksmithd[1406]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 5 22:17:29.900911 containerd[1384]: time="2024-08-05T22:17:29.900783960Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:17:29.924500 containerd[1384]: time="2024-08-05T22:17:29.924460680Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:17:29.924500 containerd[1384]: time="2024-08-05T22:17:29.924500320Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.925762 containerd[1384]: time="2024-08-05T22:17:29.925734760Z" 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 22:17:29.925810 containerd[1384]: time="2024-08-05T22:17:29.925762160Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.925951 containerd[1384]: time="2024-08-05T22:17:29.925932760Z" 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 22:17:29.925983 containerd[1384]: time="2024-08-05T22:17:29.925952720Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:17:29.926044 containerd[1384]: time="2024-08-05T22:17:29.926029440Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.926096 containerd[1384]: time="2024-08-05T22:17:29.926081960Z" 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 22:17:29.926121 containerd[1384]: time="2024-08-05T22:17:29.926097960Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.926167 containerd[1384]: time="2024-08-05T22:17:29.926154840Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.926394 containerd[1384]: time="2024-08-05T22:17:29.926374760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.926418 containerd[1384]: time="2024-08-05T22:17:29.926400000Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:17:29.926418 containerd[1384]: time="2024-08-05T22:17:29.926410640Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:17:29.926519 containerd[1384]: time="2024-08-05T22:17:29.926501600Z" 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 22:17:29.926545 containerd[1384]: time="2024-08-05T22:17:29.926518560Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:17:29.926581 containerd[1384]: time="2024-08-05T22:17:29.926567600Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:17:29.926602 containerd[1384]: time="2024-08-05T22:17:29.926584480Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:17:29.927572 sshd_keygen[1379]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 5 22:17:29.930598 containerd[1384]: time="2024-08-05T22:17:29.930558240Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:17:29.930598 containerd[1384]: time="2024-08-05T22:17:29.930594080Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:17:29.930666 containerd[1384]: time="2024-08-05T22:17:29.930607400Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:17:29.930666 containerd[1384]: time="2024-08-05T22:17:29.930636800Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:17:29.930666 containerd[1384]: time="2024-08-05T22:17:29.930650640Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:17:29.930666 containerd[1384]: time="2024-08-05T22:17:29.930660480Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:17:29.930758 containerd[1384]: time="2024-08-05T22:17:29.930671760Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930788680Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930819040Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930832720Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930845960Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930860080Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930875920Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930887960Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930899720Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930912720Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930925040Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930937360Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.930948360Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:17:29.931478 containerd[1384]: time="2024-08-05T22:17:29.931030360Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931245000Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931300360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931316560Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931337920Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931463560Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931478080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931489920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931502040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931513880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931525840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931536880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931548240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931560800Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:17:29.931798 containerd[1384]: time="2024-08-05T22:17:29.931700120Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931718880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931730960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931742840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931755240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931768920Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931782880Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932036 containerd[1384]: time="2024-08-05T22:17:29.931796280Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:17:29.932204 containerd[1384]: time="2024-08-05T22:17:29.932146680Z" 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 22:17:29.932317 containerd[1384]: time="2024-08-05T22:17:29.932210080Z" level=info msg="Connect containerd service" Aug 5 22:17:29.932317 containerd[1384]: time="2024-08-05T22:17:29.932245440Z" level=info msg="using legacy CRI server" Aug 5 22:17:29.932317 containerd[1384]: time="2024-08-05T22:17:29.932253080Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:17:29.932459 containerd[1384]: time="2024-08-05T22:17:29.932438080Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:17:29.933012 containerd[1384]: time="2024-08-05T22:17:29.932986320Z" 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 22:17:29.933061 containerd[1384]: time="2024-08-05T22:17:29.933047920Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:17:29.933090 containerd[1384]: time="2024-08-05T22:17:29.933068080Z" 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 22:17:29.933090 containerd[1384]: time="2024-08-05T22:17:29.933078840Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:17:29.933142 containerd[1384]: time="2024-08-05T22:17:29.933090600Z" 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 22:17:29.933448 containerd[1384]: time="2024-08-05T22:17:29.933304040Z" level=info msg="Start subscribing containerd event" Aug 5 22:17:29.933481 containerd[1384]: time="2024-08-05T22:17:29.933466360Z" level=info msg="Start recovering state" Aug 5 22:17:29.933541 containerd[1384]: time="2024-08-05T22:17:29.933527880Z" level=info msg="Start event monitor" Aug 5 22:17:29.933582 containerd[1384]: time="2024-08-05T22:17:29.933545200Z" level=info msg="Start snapshots syncer" Aug 5 22:17:29.933582 containerd[1384]: time="2024-08-05T22:17:29.933555320Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:17:29.933582 containerd[1384]: time="2024-08-05T22:17:29.933562720Z" level=info msg="Start streaming server" Aug 5 22:17:29.933647 containerd[1384]: time="2024-08-05T22:17:29.933635760Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:17:29.934695 containerd[1384]: time="2024-08-05T22:17:29.933674200Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:17:29.934695 containerd[1384]: time="2024-08-05T22:17:29.933725360Z" level=info msg="containerd successfully booted in 0.035639s" Aug 5 22:17:29.933795 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:17:29.948303 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 5 22:17:29.965536 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 5 22:17:29.971333 systemd[1]: issuegen.service: Deactivated successfully. Aug 5 22:17:29.971500 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 5 22:17:29.974100 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 5 22:17:29.986939 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 5 22:17:29.989575 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 5 22:17:29.991491 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. Aug 5 22:17:29.992458 systemd[1]: Reached target getty.target - Login Prompts. Aug 5 22:17:31.328109 systemd-networkd[1317]: eth0: Gained IPv6LL Aug 5 22:17:31.334536 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 5 22:17:31.337863 systemd[1]: Reached target network-online.target - Network is Online. Aug 5 22:17:31.347603 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... Aug 5 22:17:31.349515 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 5 22:17:31.363107 systemd[1]: coreos-metadata.service: Deactivated successfully. Aug 5 22:17:31.363530 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. Aug 5 22:17:31.364934 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 5 22:17:31.367957 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 5 22:17:31.369329 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 5 22:17:31.373456 systemd[1]: Startup finished in 540ms (kernel) + 3.574s (initrd) + 3.131s (userspace) = 7.246s. Aug 5 22:17:37.835924 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 5 22:17:37.837085 systemd[1]: Started sshd@0-10.0.0.128:22-10.0.0.1:52096.service - OpenSSH per-connection server daemon (10.0.0.1:52096). Aug 5 22:17:37.897129 sshd[1457]: Accepted publickey for core from 10.0.0.1 port 52096 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:37.898836 sshd[1457]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:37.908814 systemd-logind[1364]: New session 1 of user core. Aug 5 22:17:37.909820 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 5 22:17:37.921479 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 5 22:17:37.930447 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 5 22:17:37.932507 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 5 22:17:37.939114 (systemd)[1461]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.009335 systemd[1461]: Queued start job for default target default.target. Aug 5 22:17:38.020119 systemd[1461]: Created slice app.slice - User Application Slice. Aug 5 22:17:38.020144 systemd[1461]: Reached target paths.target - Paths. Aug 5 22:17:38.020155 systemd[1461]: Reached target timers.target - Timers. Aug 5 22:17:38.021344 systemd[1461]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 5 22:17:38.030452 systemd[1461]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 5 22:17:38.030513 systemd[1461]: Reached target sockets.target - Sockets. Aug 5 22:17:38.030525 systemd[1461]: Reached target basic.target - Basic System. Aug 5 22:17:38.030558 systemd[1461]: Reached target default.target - Main User Target. Aug 5 22:17:38.030583 systemd[1461]: Startup finished in 86ms. Aug 5 22:17:38.030811 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 5 22:17:38.032002 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 5 22:17:38.095606 systemd[1]: Started sshd@1-10.0.0.128:22-10.0.0.1:52108.service - OpenSSH per-connection server daemon (10.0.0.1:52108). Aug 5 22:17:38.131223 sshd[1472]: Accepted publickey for core from 10.0.0.1 port 52108 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.132439 sshd[1472]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.136801 systemd-logind[1364]: New session 2 of user core. Aug 5 22:17:38.147414 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 5 22:17:38.198481 sshd[1472]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:38.212615 systemd[1]: sshd@1-10.0.0.128:22-10.0.0.1:52108.service: Deactivated successfully. Aug 5 22:17:38.213890 systemd[1]: session-2.scope: Deactivated successfully. Aug 5 22:17:38.216324 systemd-logind[1364]: Session 2 logged out. Waiting for processes to exit. Aug 5 22:17:38.217462 systemd[1]: Started sshd@2-10.0.0.128:22-10.0.0.1:52112.service - OpenSSH per-connection server daemon (10.0.0.1:52112). Aug 5 22:17:38.218192 systemd-logind[1364]: Removed session 2. Aug 5 22:17:38.252936 sshd[1479]: Accepted publickey for core from 10.0.0.1 port 52112 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.254084 sshd[1479]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.257481 systemd-logind[1364]: New session 3 of user core. Aug 5 22:17:38.263468 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 5 22:17:38.310744 sshd[1479]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:38.319584 systemd[1]: sshd@2-10.0.0.128:22-10.0.0.1:52112.service: Deactivated successfully. Aug 5 22:17:38.320863 systemd[1]: session-3.scope: Deactivated successfully. Aug 5 22:17:38.323404 systemd-logind[1364]: Session 3 logged out. Waiting for processes to exit. Aug 5 22:17:38.324457 systemd[1]: Started sshd@3-10.0.0.128:22-10.0.0.1:52116.service - OpenSSH per-connection server daemon (10.0.0.1:52116). Aug 5 22:17:38.325204 systemd-logind[1364]: Removed session 3. Aug 5 22:17:38.360815 sshd[1486]: Accepted publickey for core from 10.0.0.1 port 52116 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.361949 sshd[1486]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.365769 systemd-logind[1364]: New session 4 of user core. Aug 5 22:17:38.381421 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 5 22:17:38.434204 sshd[1486]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:38.445633 systemd[1]: sshd@3-10.0.0.128:22-10.0.0.1:52116.service: Deactivated successfully. Aug 5 22:17:38.446959 systemd[1]: session-4.scope: Deactivated successfully. Aug 5 22:17:38.449295 systemd-logind[1364]: Session 4 logged out. Waiting for processes to exit. Aug 5 22:17:38.450485 systemd[1]: Started sshd@4-10.0.0.128:22-10.0.0.1:52130.service - OpenSSH per-connection server daemon (10.0.0.1:52130). Aug 5 22:17:38.451279 systemd-logind[1364]: Removed session 4. Aug 5 22:17:38.486136 sshd[1493]: Accepted publickey for core from 10.0.0.1 port 52130 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.487301 sshd[1493]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.491226 systemd-logind[1364]: New session 5 of user core. Aug 5 22:17:38.504447 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 5 22:17:38.572166 sudo[1496]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 5 22:17:38.572495 sudo[1496]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:17:38.592823 sudo[1496]: pam_unix(sudo:session): session closed for user root Aug 5 22:17:38.594541 sshd[1493]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:38.608678 systemd[1]: sshd@4-10.0.0.128:22-10.0.0.1:52130.service: Deactivated successfully. Aug 5 22:17:38.611658 systemd[1]: session-5.scope: Deactivated successfully. Aug 5 22:17:38.613705 systemd-logind[1364]: Session 5 logged out. Waiting for processes to exit. Aug 5 22:17:38.624640 systemd[1]: Started sshd@5-10.0.0.128:22-10.0.0.1:52136.service - OpenSSH per-connection server daemon (10.0.0.1:52136). Aug 5 22:17:38.625408 systemd-logind[1364]: Removed session 5. Aug 5 22:17:38.656702 sshd[1501]: Accepted publickey for core from 10.0.0.1 port 52136 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.657861 sshd[1501]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.661507 systemd-logind[1364]: New session 6 of user core. Aug 5 22:17:38.668399 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 5 22:17:38.718663 sudo[1506]: 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 22:17:38.718898 sudo[1506]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:17:38.721840 sudo[1506]: pam_unix(sudo:session): session closed for user root Aug 5 22:17:38.726381 sudo[1505]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Aug 5 22:17:38.726629 sudo[1505]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:17:38.744613 systemd[1]: Stopping audit-rules.service - Load Security Auditing Rules... Aug 5 22:17:38.745766 auditctl[1509]: No rules Aug 5 22:17:38.746637 systemd[1]: audit-rules.service: Deactivated successfully. Aug 5 22:17:38.748316 systemd[1]: Stopped audit-rules.service - Load Security Auditing Rules. Aug 5 22:17:38.750116 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Aug 5 22:17:38.773494 augenrules[1527]: No rules Aug 5 22:17:38.774641 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Aug 5 22:17:38.775666 sudo[1505]: pam_unix(sudo:session): session closed for user root Aug 5 22:17:38.777158 sshd[1501]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:38.788833 systemd[1]: sshd@5-10.0.0.128:22-10.0.0.1:52136.service: Deactivated successfully. Aug 5 22:17:38.791676 systemd[1]: session-6.scope: Deactivated successfully. Aug 5 22:17:38.792953 systemd-logind[1364]: Session 6 logged out. Waiting for processes to exit. Aug 5 22:17:38.806609 systemd[1]: Started sshd@6-10.0.0.128:22-10.0.0.1:52142.service - OpenSSH per-connection server daemon (10.0.0.1:52142). Aug 5 22:17:38.807697 systemd-logind[1364]: Removed session 6. Aug 5 22:17:38.839048 sshd[1535]: Accepted publickey for core from 10.0.0.1 port 52142 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:38.840157 sshd[1535]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:38.843945 systemd-logind[1364]: New session 7 of user core. Aug 5 22:17:38.855402 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 5 22:17:38.920531 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 22:17:38.920712 (dockerd)[1539]: 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 22:17:39.152089 dockerd[1539]: time="2024-08-05T22:17:39.152024891Z" level=info msg="Starting up" Aug 5 22:17:39.181919 dockerd[1539]: time="2024-08-05T22:17:39.181825315Z" level=info msg="Loading containers: start." Aug 5 22:17:39.264309 kernel: Initializing XFRM netlink socket Aug 5 22:17:39.333710 systemd-networkd[1317]: docker0: Link UP Aug 5 22:17:39.351958 dockerd[1539]: time="2024-08-05T22:17:39.351919385Z" level=info msg="Loading containers: done." Aug 5 22:17:39.405726 dockerd[1539]: time="2024-08-05T22:17:39.405677947Z" 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 22:17:39.405882 dockerd[1539]: time="2024-08-05T22:17:39.405861549Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 22:17:39.405996 dockerd[1539]: time="2024-08-05T22:17:39.405970858Z" level=info msg="Daemon has completed initialization" Aug 5 22:17:39.434016 dockerd[1539]: time="2024-08-05T22:17:39.433336701Z" level=info msg="API listen on /run/docker.sock" Aug 5 22:17:39.434226 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 22:17:39.441292 sshd[1535]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:39.449546 systemd[1]: sshd@6-10.0.0.128:22-10.0.0.1:52142.service: Deactivated successfully. Aug 5 22:17:39.451062 systemd[1]: session-7.scope: Deactivated successfully. Aug 5 22:17:39.452306 systemd-logind[1364]: Session 7 logged out. Waiting for processes to exit. Aug 5 22:17:39.453362 systemd[1]: Started sshd@7-10.0.0.128:22-10.0.0.1:52158.service - OpenSSH per-connection server daemon (10.0.0.1:52158). Aug 5 22:17:39.454045 systemd-logind[1364]: Removed session 7. Aug 5 22:17:39.489303 sshd[1667]: Accepted publickey for core from 10.0.0.1 port 52158 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:39.490664 sshd[1667]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:39.494935 systemd-logind[1364]: New session 8 of user core. Aug 5 22:17:39.504421 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 5 22:17:40.164786 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2420279273-merged.mount: Deactivated successfully. Aug 5 22:17:40.710443 kernel: docker0: port 1(vethc53f6ee) entered blocking state Aug 5 22:17:40.710546 kernel: docker0: port 1(vethc53f6ee) entered disabled state Aug 5 22:17:40.710570 kernel: vethc53f6ee: entered allmulticast mode Aug 5 22:17:40.710588 kernel: vethc53f6ee: entered promiscuous mode Aug 5 22:17:40.711358 systemd-networkd[1317]: vethc53f6ee: Link UP Aug 5 22:17:40.805066 containerd[1384]: time="2024-08-05T22:17:40.804923221Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:17:40.805066 containerd[1384]: time="2024-08-05T22:17:40.804968273Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:17:40.805066 containerd[1384]: time="2024-08-05T22:17:40.804981455Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:17:40.805066 containerd[1384]: time="2024-08-05T22:17:40.804990538Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:17:40.825421 systemd[1]: Started docker-51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d.scope - libcontainer container 51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d. Aug 5 22:17:40.879300 kernel: eth0: renamed from veth82207ad Aug 5 22:17:40.885655 kernel: docker0: port 1(vethc53f6ee) entered blocking state Aug 5 22:17:40.885700 kernel: docker0: port 1(vethc53f6ee) entered forwarding state Aug 5 22:17:40.885725 systemd-networkd[1317]: vethc53f6ee: Gained carrier Aug 5 22:17:40.886048 systemd-networkd[1317]: docker0: Gained carrier Aug 5 22:17:40.888166 systemd-resolved[1253]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:17:40.913788 sshd[1667]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:40.924502 systemd[1]: sshd@7-10.0.0.128:22-10.0.0.1:52158.service: Deactivated successfully. Aug 5 22:17:40.925814 systemd[1]: session-8.scope: Deactivated successfully. Aug 5 22:17:40.926518 systemd-logind[1364]: Session 8 logged out. Waiting for processes to exit. Aug 5 22:17:40.928129 systemd[1]: Started sshd@8-10.0.0.128:22-10.0.0.1:52162.service - OpenSSH per-connection server daemon (10.0.0.1:52162). Aug 5 22:17:40.928825 systemd-logind[1364]: Removed session 8. Aug 5 22:17:40.964300 sshd[1745]: Accepted publickey for core from 10.0.0.1 port 52162 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:40.965424 sshd[1745]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:40.969211 systemd-logind[1364]: New session 9 of user core. Aug 5 22:17:40.980427 systemd[1]: Started session-9.scope - Session 9 of User core. Aug 5 22:17:41.035570 sshd[1745]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:41.044492 systemd[1]: sshd@8-10.0.0.128:22-10.0.0.1:52162.service: Deactivated successfully. Aug 5 22:17:41.045983 systemd[1]: session-9.scope: Deactivated successfully. Aug 5 22:17:41.046664 systemd-logind[1364]: Session 9 logged out. Waiting for processes to exit. Aug 5 22:17:41.048505 systemd[1]: Started sshd@9-10.0.0.128:22-10.0.0.1:52176.service - OpenSSH per-connection server daemon (10.0.0.1:52176). Aug 5 22:17:41.049414 systemd-logind[1364]: Removed session 9. Aug 5 22:17:41.084040 sshd[1752]: Accepted publickey for core from 10.0.0.1 port 52176 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:41.085215 sshd[1752]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:41.090044 systemd-logind[1364]: New session 10 of user core. Aug 5 22:17:41.100412 systemd[1]: Started session-10.scope - Session 10 of User core. Aug 5 22:17:41.150322 sudo[1755]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGTERM 1384 Aug 5 22:17:41.150565 sudo[1755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:17:41.155403 sudo[1755]: pam_unix(sudo:session): session closed for user root Aug 5 22:17:41.155818 containerd[1384]: time="2024-08-05T22:17:41.155531641Z" level=info msg="Stop CRI service" Aug 5 22:17:41.155889 dockerd[1539]: time="2024-08-05T22:17:41.155645424Z" 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 22:17:41.155889 dockerd[1539]: time="2024-08-05T22:17:41.155700748Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Aug 5 22:17:41.156216 dockerd[1539]: time="2024-08-05T22:17:41.156178537Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Aug 5 22:17:41.156216 dockerd[1539]: time="2024-08-05T22:17:41.156207103Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Aug 5 22:17:41.156934 sshd[1752]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:41.172825 systemd[1]: containerd.service: Deactivated successfully. Aug 5 22:17:41.172879 systemd[1]: containerd.service: Unit process 1700 (containerd-shim) remains running after unit stopped. Aug 5 22:17:41.173498 systemd[1]: sshd@9-10.0.0.128:22-10.0.0.1:52176.service: Deactivated successfully. Aug 5 22:17:41.174872 systemd[1]: session-10.scope: Deactivated successfully. Aug 5 22:17:41.175449 systemd-logind[1364]: Session 10 logged out. Waiting for processes to exit. Aug 5 22:17:41.178761 systemd[1]: Started sshd@10-10.0.0.128:22-10.0.0.1:52178.service - OpenSSH per-connection server daemon (10.0.0.1:52178). Aug 5 22:17:41.179342 systemd-logind[1364]: Removed session 10. Aug 5 22:17:41.213777 sshd[1761]: Accepted publickey for core from 10.0.0.1 port 52178 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:41.214839 sshd[1761]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:41.219254 systemd-logind[1364]: New session 11 of user core. Aug 5 22:17:41.232479 systemd[1]: Started session-11.scope - Session 11 of User core. Aug 5 22:17:41.284928 sshd[1761]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:41.287715 systemd[1]: sshd@10-10.0.0.128:22-10.0.0.1:52178.service: Deactivated successfully. Aug 5 22:17:41.289212 systemd[1]: session-11.scope: Deactivated successfully. Aug 5 22:17:41.289715 systemd-logind[1364]: Session 11 logged out. Waiting for processes to exit. Aug 5 22:17:41.290536 systemd-logind[1364]: Removed session 11. Aug 5 22:17:42.463729 systemd-networkd[1317]: vethc53f6ee: Gained IPv6LL Aug 5 22:17:42.847594 systemd-networkd[1317]: docker0: Gained IPv6LL Aug 5 22:17:46.423367 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 1. Aug 5 22:17:46.423842 systemd[1]: Stopping docker.service - Docker Application Container Engine... Aug 5 22:17:46.424002 dockerd[1539]: time="2024-08-05T22:17:46.423898539Z" level=info msg="Processing signal 'terminated'" Aug 5 22:17:47.321535 systemd[1]: Started sshd@11-10.0.0.128:22-10.0.0.1:47362.service - OpenSSH per-connection server daemon (10.0.0.1:47362). Aug 5 22:17:47.357174 sshd[1768]: Accepted publickey for core from 10.0.0.1 port 47362 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:47.358303 sshd[1768]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:47.361855 systemd-logind[1364]: New session 12 of user core. Aug 5 22:17:47.374446 systemd[1]: Started session-12.scope - Session 12 of User core. Aug 5 22:17:47.427222 sshd[1768]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:47.430794 systemd[1]: sshd@11-10.0.0.128:22-10.0.0.1:47362.service: Deactivated successfully. Aug 5 22:17:47.432256 systemd[1]: session-12.scope: Deactivated successfully. Aug 5 22:17:47.432823 systemd-logind[1364]: Session 12 logged out. Waiting for processes to exit. Aug 5 22:17:47.433487 systemd-logind[1364]: Removed session 12. Aug 5 22:17:50.556735 dockerd[1539]: time="2024-08-05T22:17:50.556631155Z" level=error msg="Error sending stop (signal 15) to container" container=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d error="Cannot kill container 51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d: connection error: desc = \"transport: Error while dialing dial unix:///var/run/docker/libcontainerd/docker-containerd.sock: timeout\": unavailable" Aug 5 22:17:50.556735 dockerd[1539]: time="2024-08-05T22:17:50.556694030Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d Aug 5 22:17:53.452558 systemd[1]: Started sshd@12-10.0.0.128:22-10.0.0.1:59862.service - OpenSSH per-connection server daemon (10.0.0.1:59862). Aug 5 22:17:53.488217 sshd[1775]: Accepted publickey for core from 10.0.0.1 port 59862 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:53.489394 sshd[1775]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:53.493874 systemd-logind[1364]: New session 13 of user core. Aug 5 22:17:53.505495 systemd[1]: Started session-13.scope - Session 13 of User core. Aug 5 22:17:53.558438 sshd[1775]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:53.561286 systemd[1]: sshd@12-10.0.0.128:22-10.0.0.1:59862.service: Deactivated successfully. Aug 5 22:17:53.563746 systemd[1]: session-13.scope: Deactivated successfully. Aug 5 22:17:53.564352 systemd-logind[1364]: Session 13 logged out. Waiting for processes to exit. Aug 5 22:17:53.565075 systemd-logind[1364]: Removed session 13. Aug 5 22:17:59.582525 systemd[1]: Started sshd@13-10.0.0.128:22-10.0.0.1:59868.service - OpenSSH per-connection server daemon (10.0.0.1:59868). Aug 5 22:17:59.618186 sshd[1782]: Accepted publickey for core from 10.0.0.1 port 59868 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:17:59.619317 sshd[1782]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:17:59.622983 systemd-logind[1364]: New session 14 of user core. Aug 5 22:17:59.631466 systemd[1]: Started session-14.scope - Session 14 of User core. Aug 5 22:17:59.684432 sshd[1782]: pam_unix(sshd:session): session closed for user core Aug 5 22:17:59.687583 systemd[1]: sshd@13-10.0.0.128:22-10.0.0.1:59868.service: Deactivated successfully. Aug 5 22:17:59.689203 systemd[1]: session-14.scope: Deactivated successfully. Aug 5 22:17:59.690479 systemd-logind[1364]: Session 14 logged out. Waiting for processes to exit. Aug 5 22:17:59.691334 systemd-logind[1364]: Removed session 14. Aug 5 22:18:00.557111 dockerd[1539]: time="2024-08-05T22:18:00.556972307Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d error="context deadline exceeded" Aug 5 22:18:00.557507 systemd[1]: docker-51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d.scope: Deactivated successfully. Aug 5 22:18:01.425116 dockerd[1539]: time="2024-08-05T22:18:01.425027917Z" level=error msg="Force shutdown daemon" Aug 5 22:18:01.425116 dockerd[1539]: time="2024-08-05T22:18:01.425107974Z" level=info msg="Daemon shutdown complete" Aug 5 22:18:01.428633 systemd[1]: docker.service: Deactivated successfully. Aug 5 22:18:01.428859 systemd[1]: Stopped docker.service - Docker Application Container Engine. Aug 5 22:18:01.429850 systemd[1]: docker.socket: Deactivated successfully. Aug 5 22:18:01.430165 systemd[1]: Closed docker.socket - Docker Socket for the API. Aug 5 22:18:01.430202 systemd[1]: Stopping docker.socket - Docker Socket for the API... Aug 5 22:18:01.431649 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:18:01.441446 systemd[1]: containerd.service: Found left-over process 1700 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 22:18:01.441455 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 22:18:01.442350 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:18:01.442621 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:18:01.453543 systemd[1]: containerd.service: Found left-over process 1700 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 22:18:01.453553 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 22:18:01.457502 (ntainerd)[1794]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:18:01.472602 containerd[1794]: time="2024-08-05T22:18:01.472546319Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:18:01.494527 containerd[1794]: time="2024-08-05T22:18:01.494489248Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:18:01.494527 containerd[1794]: time="2024-08-05T22:18:01.494523930Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495641 containerd[1794]: time="2024-08-05T22:18:01.495591230Z" 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 22:18:01.495641 containerd[1794]: time="2024-08-05T22:18:01.495619265Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495771 containerd[1794]: time="2024-08-05T22:18:01.495746540Z" 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 22:18:01.495771 containerd[1794]: time="2024-08-05T22:18:01.495766324Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:18:01.495830 containerd[1794]: time="2024-08-05T22:18:01.495785227Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495830 containerd[1794]: time="2024-08-05T22:18:01.495803169Z" 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 22:18:01.495830 containerd[1794]: time="2024-08-05T22:18:01.495813221Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495884 containerd[1794]: time="2024-08-05T22:18:01.495832885Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495934 containerd[1794]: time="2024-08-05T22:18:01.495919190Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.495955 containerd[1794]: time="2024-08-05T22:18:01.495938453Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:18:01.495955 containerd[1794]: time="2024-08-05T22:18:01.495948065Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:01.496052 containerd[1794]: time="2024-08-05T22:18:01.496037895Z" 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 22:18:01.496075 containerd[1794]: time="2024-08-05T22:18:01.496054034Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:18:01.496075 containerd[1794]: time="2024-08-05T22:18:01.496069773Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:18:01.496109 containerd[1794]: time="2024-08-05T22:18:01.496077703Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:18:01.496312 containerd[1794]: time="2024-08-05T22:18:01.496295969Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:18:01.496344 containerd[1794]: time="2024-08-05T22:18:01.496317275Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:18:01.496344 containerd[1794]: time="2024-08-05T22:18:01.496329330Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:18:01.496379 containerd[1794]: time="2024-08-05T22:18:01.496349795Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:18:01.496379 containerd[1794]: time="2024-08-05T22:18:01.496362130Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:18:01.496379 containerd[1794]: time="2024-08-05T22:18:01.496371581Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:18:01.496428 containerd[1794]: time="2024-08-05T22:18:01.496383195Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:18:01.502176 containerd[1794]: time="2024-08-05T22:18:01.502138926Z" level=info msg="cleaning leaked shim process" id=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d namespace=moby Aug 5 22:18:01.509200 containerd[1794]: time="2024-08-05T22:18:01.509114944Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Aug 5 22:18:01.509329 containerd[1794]: time="2024-08-05T22:18:01.509276501Z" level=info msg="shim disconnected" id=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d namespace=moby Aug 5 22:18:01.509375 containerd[1794]: time="2024-08-05T22:18:01.509333009Z" level=warning msg="cleaning up after shim disconnected" id=51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d namespace=moby Aug 5 22:18:01.509375 containerd[1794]: time="2024-08-05T22:18:01.509341660Z" level=info msg="cleaning up dead shim" namespace=moby Aug 5 22:18:01.518499 containerd[1794]: time="2024-08-05T22:18:01.518462931Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:18:01.518499 containerd[1794]: time="2024-08-05T22:18:01.518492887Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518508026Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518521762Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518534979Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518550117Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518562852Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518574507Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518599 containerd[1794]: time="2024-08-05T22:18:01.518591648Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518735 containerd[1794]: time="2024-08-05T22:18:01.518605344Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518735 containerd[1794]: time="2024-08-05T22:18:01.518618200Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518735 containerd[1794]: time="2024-08-05T22:18:01.518629494Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:18:01.518735 containerd[1794]: time="2024-08-05T22:18:01.518675269Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:18:01.518928 containerd[1794]: time="2024-08-05T22:18:01.518895418Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:18:01.518928 containerd[1794]: time="2024-08-05T22:18:01.518925574Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.518971 containerd[1794]: time="2024-08-05T22:18:01.518940392Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:18:01.518971 containerd[1794]: time="2024-08-05T22:18:01.518963180Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:18:01.519048 containerd[1794]: time="2024-08-05T22:18:01.519007594Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519048 containerd[1794]: time="2024-08-05T22:18:01.519020210Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519048 containerd[1794]: time="2024-08-05T22:18:01.519031503Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519048 containerd[1794]: time="2024-08-05T22:18:01.519042236Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519118 containerd[1794]: time="2024-08-05T22:18:01.519054011Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519118 containerd[1794]: time="2024-08-05T22:18:01.519066506Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519118 containerd[1794]: time="2024-08-05T22:18:01.519077439Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519118 containerd[1794]: time="2024-08-05T22:18:01.519088333Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519118 containerd[1794]: time="2024-08-05T22:18:01.519100347Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519134309Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519148726Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519169872Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519184370Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519196264Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519215 containerd[1794]: time="2024-08-05T22:18:01.519211122Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519343 containerd[1794]: time="2024-08-05T22:18:01.519228303Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519343 containerd[1794]: time="2024-08-05T22:18:01.519239276Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:18:01.519591 containerd[1794]: time="2024-08-05T22:18:01.519459184Z" 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 22:18:01.519591 containerd[1794]: time="2024-08-05T22:18:01.519520179Z" level=info msg="Connect containerd service" Aug 5 22:18:01.519591 containerd[1794]: time="2024-08-05T22:18:01.519545049Z" level=info msg="using legacy CRI server" Aug 5 22:18:01.519591 containerd[1794]: time="2024-08-05T22:18:01.519552418Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:18:01.520078 containerd[1794]: time="2024-08-05T22:18:01.520042174Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:18:01.520977 containerd[1794]: time="2024-08-05T22:18:01.520939147Z" 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 22:18:01.521029 containerd[1794]: time="2024-08-05T22:18:01.520985163Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:18:01.521029 containerd[1794]: time="2024-08-05T22:18:01.521002544Z" 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 22:18:01.521029 containerd[1794]: time="2024-08-05T22:18:01.521012516Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:18:01.521029 containerd[1794]: time="2024-08-05T22:18:01.521023650Z" 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 22:18:01.521130 containerd[1794]: time="2024-08-05T22:18:01.521070026Z" level=info msg="Start subscribing containerd event" Aug 5 22:18:01.521130 containerd[1794]: time="2024-08-05T22:18:01.521116403Z" level=info msg="Start recovering state" Aug 5 22:18:01.521200 containerd[1794]: time="2024-08-05T22:18:01.521176316Z" level=info msg="Start event monitor" Aug 5 22:18:01.521200 containerd[1794]: time="2024-08-05T22:18:01.521192215Z" level=info msg="Start snapshots syncer" Aug 5 22:18:01.521200 containerd[1794]: time="2024-08-05T22:18:01.521200866Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:18:01.521328 containerd[1794]: time="2024-08-05T22:18:01.521208755Z" level=info msg="Start streaming server" Aug 5 22:18:01.521328 containerd[1794]: time="2024-08-05T22:18:01.521225576Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:18:01.521365 containerd[1794]: time="2024-08-05T22:18:01.521260298Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:18:01.521418 containerd[1794]: time="2024-08-05T22:18:01.521383889Z" level=info msg="containerd successfully booted in 0.049297s" Aug 5 22:18:01.521454 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:18:01.531522 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 22:18:01.531689 (dockerd)[1829]: 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 22:18:01.567423 dockerd[1829]: time="2024-08-05T22:18:01.567379156Z" level=info msg="Starting up" Aug 5 22:18:01.585339 dockerd[1829]: time="2024-08-05T22:18:01.585297943Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Aug 5 22:18:01.591190 dockerd[1829]: time="2024-08-05T22:18:01.591171338Z" level=info msg="Loading containers: start." Aug 5 22:18:01.600431 systemd[1]: var-lib-docker-overlay2-bfa0c61b64bd5d120e9d60a0fb49938ae6ce813a66e8083ea030687fe91080cb-merged.mount: Deactivated successfully. Aug 5 22:18:01.773149 dockerd[1829]: time="2024-08-05T22:18:01.773100828Z" level=info msg="Removing stale sandbox fd8ef8244ebee5097ea2b2e52090983790c72299de72af8fac555d6205096290 (51e9285068c76b7aeaf6468a4e2c668ab0b181ff9df552d3022440efce6df41d)" Aug 5 22:18:01.776098 dockerd[1829]: time="2024-08-05T22:18:01.776059271Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 1d4a94f5744d3737449f2c4256409e37d306ed23e794acdca0010326a2d349a3 24ae17017dc3d1d2713cff92127ba5a502a8d91977acb6a3d1b8f3fefa181bd5], retrying...." Aug 5 22:18:01.777664 systemd-networkd[1317]: vethc53f6ee: Link DOWN Aug 5 22:18:01.777671 systemd-networkd[1317]: vethc53f6ee: Lost carrier Aug 5 22:18:01.779692 kernel: docker0: port 1(vethc53f6ee) entered disabled state Aug 5 22:18:01.779750 kernel: vethc53f6ee (unregistering): left allmulticast mode Aug 5 22:18:01.779768 kernel: vethc53f6ee (unregistering): left promiscuous mode Aug 5 22:18:01.779787 kernel: docker0: port 1(vethc53f6ee) entered disabled state Aug 5 22:18:01.794080 systemd-networkd[1317]: docker0: Lost carrier Aug 5 22:18:01.872307 dockerd[1829]: time="2024-08-05T22:18:01.872242433Z" 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 22:18:01.942807 dockerd[1829]: time="2024-08-05T22:18:01.942763615Z" level=info msg="Loading containers: done." Aug 5 22:18:01.952379 dockerd[1829]: time="2024-08-05T22:18:01.952332151Z" 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 22:18:01.952577 dockerd[1829]: time="2024-08-05T22:18:01.952547694Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 22:18:01.952614 dockerd[1829]: time="2024-08-05T22:18:01.952595312Z" level=info msg="Daemon has completed initialization" Aug 5 22:18:01.967699 dockerd[1829]: time="2024-08-05T22:18:01.967641319Z" level=info msg="API listen on /run/docker.sock" Aug 5 22:18:01.967857 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 22:18:02.576678 systemd[1]: run-docker-netns-fd8ef8244ebe.mount: Deactivated successfully. Aug 5 22:18:05.704511 systemd[1]: Started sshd@14-10.0.0.128:22-10.0.0.1:54772.service - OpenSSH per-connection server daemon (10.0.0.1:54772). Aug 5 22:18:05.740105 sshd[1969]: Accepted publickey for core from 10.0.0.1 port 54772 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:05.741314 sshd[1969]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:05.744726 systemd-logind[1364]: New session 15 of user core. Aug 5 22:18:05.757410 systemd[1]: Started session-15.scope - Session 15 of User core. Aug 5 22:18:05.809087 sshd[1969]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:05.818385 systemd[1]: sshd@14-10.0.0.128:22-10.0.0.1:54772.service: Deactivated successfully. Aug 5 22:18:05.819640 systemd[1]: session-15.scope: Deactivated successfully. Aug 5 22:18:05.821498 systemd-logind[1364]: Session 15 logged out. Waiting for processes to exit. Aug 5 22:18:05.822957 systemd[1]: Started sshd@15-10.0.0.128:22-10.0.0.1:54776.service - OpenSSH per-connection server daemon (10.0.0.1:54776). Aug 5 22:18:05.823927 systemd-logind[1364]: Removed session 15. Aug 5 22:18:05.857361 sshd[1976]: Accepted publickey for core from 10.0.0.1 port 54776 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:05.858422 sshd[1976]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:05.861536 systemd-logind[1364]: New session 16 of user core. Aug 5 22:18:05.874393 systemd[1]: Started session-16.scope - Session 16 of User core. Aug 5 22:18:05.926424 sshd[1976]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:05.939412 systemd[1]: sshd@15-10.0.0.128:22-10.0.0.1:54776.service: Deactivated successfully. Aug 5 22:18:05.940723 systemd[1]: session-16.scope: Deactivated successfully. Aug 5 22:18:05.941920 systemd-logind[1364]: Session 16 logged out. Waiting for processes to exit. Aug 5 22:18:05.942908 systemd[1]: Started sshd@16-10.0.0.128:22-10.0.0.1:54780.service - OpenSSH per-connection server daemon (10.0.0.1:54780). Aug 5 22:18:05.943531 systemd-logind[1364]: Removed session 16. Aug 5 22:18:05.977032 sshd[1983]: Accepted publickey for core from 10.0.0.1 port 54780 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:05.978084 sshd[1983]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:05.981191 systemd-logind[1364]: New session 17 of user core. Aug 5 22:18:05.995460 systemd[1]: Started session-17.scope - Session 17 of User core. Aug 5 22:18:06.050829 sshd[1983]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:06.063670 systemd[1]: sshd@16-10.0.0.128:22-10.0.0.1:54780.service: Deactivated successfully. Aug 5 22:18:06.065071 systemd[1]: session-17.scope: Deactivated successfully. Aug 5 22:18:06.066331 systemd-logind[1364]: Session 17 logged out. Waiting for processes to exit. Aug 5 22:18:06.067385 systemd[1]: Started sshd@17-10.0.0.128:22-10.0.0.1:54788.service - OpenSSH per-connection server daemon (10.0.0.1:54788). Aug 5 22:18:06.069667 systemd-logind[1364]: Removed session 17. Aug 5 22:18:06.102812 sshd[1997]: Accepted publickey for core from 10.0.0.1 port 54788 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:06.103924 sshd[1997]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:06.108455 systemd-logind[1364]: New session 18 of user core. Aug 5 22:18:06.115479 systemd[1]: Started session-18.scope - Session 18 of User core. Aug 5 22:18:06.180671 systemd[1]: var-lib-docker-overlay2-5de1492144f7cd836982cb3b0953a4677b2bbcefade746f2a80b5ea278fdebdc\x2dinit-merged.mount: Deactivated successfully. Aug 5 22:18:06.200972 kernel: docker0: port 1(vethac1f804) entered blocking state Aug 5 22:18:06.201089 kernel: docker0: port 1(vethac1f804) entered disabled state Aug 5 22:18:06.201111 kernel: vethac1f804: entered allmulticast mode Aug 5 22:18:06.201128 kernel: vethac1f804: entered promiscuous mode Aug 5 22:18:06.200354 systemd-networkd[1317]: vethac1f804: Link UP Aug 5 22:18:06.228122 containerd[1794]: time="2024-08-05T22:18:06.227945334Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:18:06.228122 containerd[1794]: time="2024-08-05T22:18:06.228014875Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:06.228544 containerd[1794]: time="2024-08-05T22:18:06.228494338Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:18:06.228544 containerd[1794]: time="2024-08-05T22:18:06.228520361Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:06.246424 systemd[1]: Started docker-43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46.scope - libcontainer container 43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46. Aug 5 22:18:06.298299 kernel: eth0: renamed from vethe38c108 Aug 5 22:18:06.305129 systemd-networkd[1317]: vethac1f804: Gained carrier Aug 5 22:18:06.305629 kernel: docker0: port 1(vethac1f804) entered blocking state Aug 5 22:18:06.305719 kernel: docker0: port 1(vethac1f804) entered forwarding state Aug 5 22:18:06.305475 systemd-networkd[1317]: docker0: Gained carrier Aug 5 22:18:06.307857 systemd-resolved[1253]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:18:06.331437 sshd[1997]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:06.342585 systemd[1]: sshd@17-10.0.0.128:22-10.0.0.1:54788.service: Deactivated successfully. Aug 5 22:18:06.343967 systemd[1]: session-18.scope: Deactivated successfully. Aug 5 22:18:06.344524 systemd-logind[1364]: Session 18 logged out. Waiting for processes to exit. Aug 5 22:18:06.346157 systemd[1]: Started sshd@18-10.0.0.128:22-10.0.0.1:54796.service - OpenSSH per-connection server daemon (10.0.0.1:54796). Aug 5 22:18:06.347539 systemd-logind[1364]: Removed session 18. Aug 5 22:18:06.381841 sshd[2072]: Accepted publickey for core from 10.0.0.1 port 54796 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:06.382930 sshd[2072]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:06.386630 systemd-logind[1364]: New session 19 of user core. Aug 5 22:18:06.396460 systemd[1]: Started session-19.scope - Session 19 of User core. Aug 5 22:18:06.449143 sshd[2072]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:06.462583 systemd[1]: sshd@18-10.0.0.128:22-10.0.0.1:54796.service: Deactivated successfully. Aug 5 22:18:06.463952 systemd[1]: session-19.scope: Deactivated successfully. Aug 5 22:18:06.464497 systemd-logind[1364]: Session 19 logged out. Waiting for processes to exit. Aug 5 22:18:06.466104 systemd[1]: Started sshd@19-10.0.0.128:22-10.0.0.1:54800.service - OpenSSH per-connection server daemon (10.0.0.1:54800). Aug 5 22:18:06.466989 systemd-logind[1364]: Removed session 19. Aug 5 22:18:06.502452 sshd[2079]: Accepted publickey for core from 10.0.0.1 port 54800 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:06.503574 sshd[2079]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:06.506907 systemd-logind[1364]: New session 20 of user core. Aug 5 22:18:06.514406 systemd[1]: Started session-20.scope - Session 20 of User core. Aug 5 22:18:06.563199 sudo[2082]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/kill -SIGHUP 1794 Aug 5 22:18:06.563469 sudo[2082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Aug 5 22:18:06.565873 sudo[2082]: pam_unix(sudo:session): session closed for user root Aug 5 22:18:06.567931 sshd[2079]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:06.568338 dockerd[1829]: time="2024-08-05T22:18:06.568280021Z" level=error msg="Failed to get event" error="rpc error: code = Unavailable desc = error reading from server: EOF" module=libcontainerd namespace=moby Aug 5 22:18:06.568338 dockerd[1829]: time="2024-08-05T22:18:06.568331787Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=moby Aug 5 22:18:06.572645 dockerd[1829]: time="2024-08-05T22:18:06.568410056Z" 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 22:18:06.572645 dockerd[1829]: time="2024-08-05T22:18:06.568431315Z" level=info msg="Waiting for containerd to be ready to restart event processing" module=libcontainerd namespace=plugins.moby Aug 5 22:18:06.574316 systemd[1]: containerd.service: Deactivated successfully. Aug 5 22:18:06.574368 systemd[1]: containerd.service: Unit process 2025 (containerd-shim) remains running after unit stopped. Aug 5 22:18:06.574881 systemd[1]: sshd@19-10.0.0.128:22-10.0.0.1:54800.service: Deactivated successfully. Aug 5 22:18:06.576133 systemd[1]: session-20.scope: Deactivated successfully. Aug 5 22:18:06.576615 systemd-logind[1364]: Session 20 logged out. Waiting for processes to exit. Aug 5 22:18:06.578702 systemd[1]: Started sshd@20-10.0.0.128:22-10.0.0.1:54812.service - OpenSSH per-connection server daemon (10.0.0.1:54812). Aug 5 22:18:06.580623 systemd-logind[1364]: Removed session 20. Aug 5 22:18:06.613756 sshd[2088]: Accepted publickey for core from 10.0.0.1 port 54812 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:06.614781 sshd[2088]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:06.618312 systemd-logind[1364]: New session 21 of user core. Aug 5 22:18:06.628410 systemd[1]: Started session-21.scope - Session 21 of User core. Aug 5 22:18:06.679825 sshd[2088]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:06.682517 systemd[1]: sshd@20-10.0.0.128:22-10.0.0.1:54812.service: Deactivated successfully. Aug 5 22:18:06.684627 systemd[1]: session-21.scope: Deactivated successfully. Aug 5 22:18:06.685106 systemd-logind[1364]: Session 21 logged out. Waiting for processes to exit. Aug 5 22:18:06.685757 systemd-logind[1364]: Removed session 21. Aug 5 22:18:07.999912 systemd-networkd[1317]: vethac1f804: Gained IPv6LL Aug 5 22:18:11.734013 systemd[1]: containerd.service: Scheduled restart job, restart counter is at 2. Aug 5 22:18:11.734763 systemd[1]: Stopping docker.service - Docker Application Container Engine... Aug 5 22:18:11.734896 dockerd[1829]: time="2024-08-05T22:18:11.734804413Z" level=info msg="Processing signal 'terminated'" Aug 5 22:18:12.694460 systemd[1]: Started sshd@21-10.0.0.128:22-10.0.0.1:57530.service - OpenSSH per-connection server daemon (10.0.0.1:57530). Aug 5 22:18:12.729753 sshd[2095]: Accepted publickey for core from 10.0.0.1 port 57530 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:12.730899 sshd[2095]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:12.734422 systemd-logind[1364]: New session 22 of user core. Aug 5 22:18:12.752412 systemd[1]: Started session-22.scope - Session 22 of User core. Aug 5 22:18:12.804521 sshd[2095]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:12.807458 systemd[1]: sshd@21-10.0.0.128:22-10.0.0.1:57530.service: Deactivated successfully. Aug 5 22:18:12.808867 systemd[1]: session-22.scope: Deactivated successfully. Aug 5 22:18:12.810646 systemd-logind[1364]: Session 22 logged out. Waiting for processes to exit. Aug 5 22:18:12.811383 systemd-logind[1364]: Removed session 22. Aug 5 22:18:13.736510 dockerd[1829]: time="2024-08-05T22:18:13.736387042Z" level=error msg="Error sending stop (signal 15) to container" container=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 error="Cannot kill container 43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46: connection error: desc = \"transport: Error while dialing dial unix /var/run/docker/libcontainerd/docker-containerd.sock: connect: connection refused\": unavailable" Aug 5 22:18:13.736510 dockerd[1829]: time="2024-08-05T22:18:13.736487779Z" level=info msg="Container failed to exit within 2s of signal 15 - using the force" container=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 Aug 5 22:18:15.129957 update_engine[1369]: I0805 22:18:15.129884 1369 update_attempter.cc:509] Updating boot flags... Aug 5 22:18:15.149295 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2108) Aug 5 22:18:15.174449 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2112) Aug 5 22:18:15.195306 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 41 scanned by (udev-worker) (2112) Aug 5 22:18:18.817511 systemd[1]: Started sshd@22-10.0.0.128:22-10.0.0.1:57546.service - OpenSSH per-connection server daemon (10.0.0.1:57546). Aug 5 22:18:18.853012 sshd[2117]: Accepted publickey for core from 10.0.0.1 port 57546 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:18.854153 sshd[2117]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:18.857778 systemd-logind[1364]: New session 23 of user core. Aug 5 22:18:18.866399 systemd[1]: Started session-23.scope - Session 23 of User core. Aug 5 22:18:18.918471 sshd[2117]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:18.921258 systemd[1]: sshd@22-10.0.0.128:22-10.0.0.1:57546.service: Deactivated successfully. Aug 5 22:18:18.922765 systemd[1]: session-23.scope: Deactivated successfully. Aug 5 22:18:18.923258 systemd-logind[1364]: Session 23 logged out. Waiting for processes to exit. Aug 5 22:18:18.923949 systemd-logind[1364]: Removed session 23. Aug 5 22:18:23.737106 dockerd[1829]: time="2024-08-05T22:18:23.737044278Z" level=error msg="Container failed to exit within 10s of kill - trying direct SIGKILL" container=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 error="context deadline exceeded" Aug 5 22:18:23.737812 systemd[1]: docker-43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46.scope: Deactivated successfully. Aug 5 22:18:24.930562 systemd[1]: Started sshd@23-10.0.0.128:22-10.0.0.1:34118.service - OpenSSH per-connection server daemon (10.0.0.1:34118). Aug 5 22:18:24.966803 sshd[2124]: Accepted publickey for core from 10.0.0.1 port 34118 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:24.968084 sshd[2124]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:24.971944 systemd-logind[1364]: New session 24 of user core. Aug 5 22:18:24.983438 systemd[1]: Started session-24.scope - Session 24 of User core. Aug 5 22:18:25.037454 sshd[2124]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:25.040451 systemd[1]: sshd@23-10.0.0.128:22-10.0.0.1:34118.service: Deactivated successfully. Aug 5 22:18:25.041998 systemd[1]: session-24.scope: Deactivated successfully. Aug 5 22:18:25.042602 systemd-logind[1364]: Session 24 logged out. Waiting for processes to exit. Aug 5 22:18:25.043485 systemd-logind[1364]: Removed session 24. Aug 5 22:18:26.736513 dockerd[1829]: time="2024-08-05T22:18:26.736418155Z" level=error msg="Force shutdown daemon" Aug 5 22:18:26.736513 dockerd[1829]: time="2024-08-05T22:18:26.736468728Z" level=info msg="Daemon shutdown complete" Aug 5 22:18:26.740687 systemd[1]: docker.service: Deactivated successfully. Aug 5 22:18:26.741017 systemd[1]: Stopped docker.service - Docker Application Container Engine. Aug 5 22:18:26.741582 systemd[1]: docker.socket: Deactivated successfully. Aug 5 22:18:26.741861 systemd[1]: Closed docker.socket - Docker Socket for the API. Aug 5 22:18:26.741899 systemd[1]: Stopping docker.socket - Docker Socket for the API... Aug 5 22:18:26.743425 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 5 22:18:26.752430 systemd[1]: containerd.service: Found left-over process 2025 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 22:18:26.752439 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 22:18:26.753341 systemd[1]: Starting containerd.service - containerd container runtime... Aug 5 22:18:26.753565 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 5 22:18:26.764410 systemd[1]: containerd.service: Found left-over process 2025 (containerd-shim) in control group while starting unit. Ignoring. Aug 5 22:18:26.764423 systemd[1]: containerd.service: This usually indicates unclean termination of a previous run, or service implementation deficiencies. Aug 5 22:18:26.768440 (ntainerd)[2136]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 5 22:18:26.783942 containerd[2136]: time="2024-08-05T22:18:26.783850676Z" level=info msg="starting containerd" revision=1fbfc07f8d28210e62bdbcbf7b950bac8028afbf version=v1.7.17 Aug 5 22:18:26.806102 containerd[2136]: time="2024-08-05T22:18:26.806050828Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Aug 5 22:18:26.806102 containerd[2136]: time="2024-08-05T22:18:26.806085676Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807247 containerd[2136]: time="2024-08-05T22:18:26.807209149Z" 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 22:18:26.807247 containerd[2136]: time="2024-08-05T22:18:26.807242677Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807439 containerd[2136]: time="2024-08-05T22:18:26.807405237Z" 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 22:18:26.807439 containerd[2136]: time="2024-08-05T22:18:26.807427522Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Aug 5 22:18:26.807489 containerd[2136]: time="2024-08-05T22:18:26.807446687Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807489 containerd[2136]: time="2024-08-05T22:18:26.807465291Z" 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 22:18:26.807489 containerd[2136]: time="2024-08-05T22:18:26.807475014Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807547 containerd[2136]: time="2024-08-05T22:18:26.807494618Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807594 containerd[2136]: time="2024-08-05T22:18:26.807578599Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807616 containerd[2136]: time="2024-08-05T22:18:26.807598284Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Aug 5 22:18:26.807616 containerd[2136]: time="2024-08-05T22:18:26.807608446Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Aug 5 22:18:26.807714 containerd[2136]: time="2024-08-05T22:18:26.807699108Z" 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 22:18:26.807739 containerd[2136]: time="2024-08-05T22:18:26.807715112Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Aug 5 22:18:26.807739 containerd[2136]: time="2024-08-05T22:18:26.807730156Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Aug 5 22:18:26.807784 containerd[2136]: time="2024-08-05T22:18:26.807740078Z" level=info msg="metadata content store policy set" policy=shared Aug 5 22:18:26.807916 containerd[2136]: time="2024-08-05T22:18:26.807893435Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Aug 5 22:18:26.807947 containerd[2136]: time="2024-08-05T22:18:26.807916761Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Aug 5 22:18:26.807947 containerd[2136]: time="2024-08-05T22:18:26.807928364Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Aug 5 22:18:26.808027 containerd[2136]: time="2024-08-05T22:18:26.807948649Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Aug 5 22:18:26.808027 containerd[2136]: time="2024-08-05T22:18:26.807961132Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Aug 5 22:18:26.808027 containerd[2136]: time="2024-08-05T22:18:26.807970294Z" level=info msg="NRI interface is disabled by configuration." Aug 5 22:18:26.808027 containerd[2136]: time="2024-08-05T22:18:26.807980456Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Aug 5 22:18:26.814066 containerd[2136]: time="2024-08-05T22:18:26.814026045Z" level=info msg="cleaning leaked shim process" id=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 namespace=moby Aug 5 22:18:26.821151 containerd[2136]: time="2024-08-05T22:18:26.821072596Z" level=error msg="post event" error="failed to connect: dial unix /run/containerd/containerd.sock.ttrpc: connect: connection refused" Aug 5 22:18:26.821814 containerd[2136]: time="2024-08-05T22:18:26.821354225Z" level=info msg="shim disconnected" id=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 namespace=moby Aug 5 22:18:26.821814 containerd[2136]: time="2024-08-05T22:18:26.821401556Z" level=warning msg="cleaning up after shim disconnected" id=43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46 namespace=moby Aug 5 22:18:26.821814 containerd[2136]: time="2024-08-05T22:18:26.821409598Z" level=info msg="cleaning up dead shim" namespace=moby Aug 5 22:18:26.831476 containerd[2136]: time="2024-08-05T22:18:26.831439914Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Aug 5 22:18:26.831476 containerd[2136]: time="2024-08-05T22:18:26.831477803Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831491487Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831505010Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831519974Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831536138Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831549341Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831561504Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831574 containerd[2136]: time="2024-08-05T22:18:26.831575147Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831722 containerd[2136]: time="2024-08-05T22:18:26.831587950Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831722 containerd[2136]: time="2024-08-05T22:18:26.831600473Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831722 containerd[2136]: time="2024-08-05T22:18:26.831612596Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Aug 5 22:18:26.831722 containerd[2136]: time="2024-08-05T22:18:26.831658527Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Aug 5 22:18:26.831887 containerd[2136]: time="2024-08-05T22:18:26.831872099Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Aug 5 22:18:26.831916 containerd[2136]: time="2024-08-05T22:18:26.831900506Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.831935 containerd[2136]: time="2024-08-05T22:18:26.831914109Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Aug 5 22:18:26.831961 containerd[2136]: time="2024-08-05T22:18:26.831935915Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Aug 5 22:18:26.832004 containerd[2136]: time="2024-08-05T22:18:26.831990248Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832037 containerd[2136]: time="2024-08-05T22:18:26.832007452Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832037 containerd[2136]: time="2024-08-05T22:18:26.832020135Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832037 containerd[2136]: time="2024-08-05T22:18:26.832031938Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832104 containerd[2136]: time="2024-08-05T22:18:26.832045021Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832104 containerd[2136]: time="2024-08-05T22:18:26.832056984Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832104 containerd[2136]: time="2024-08-05T22:18:26.832072428Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832104 containerd[2136]: time="2024-08-05T22:18:26.832086711Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832104 containerd[2136]: time="2024-08-05T22:18:26.832098714Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832128642Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832142725Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832153968Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832169611Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832180734Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832198 containerd[2136]: time="2024-08-05T22:18:26.832193337Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832329 containerd[2136]: time="2024-08-05T22:18:26.832204980Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832329 containerd[2136]: time="2024-08-05T22:18:26.832215423Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Aug 5 22:18:26.832510 containerd[2136]: time="2024-08-05T22:18:26.832452360Z" 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 22:18:26.832601 containerd[2136]: time="2024-08-05T22:18:26.832514855Z" level=info msg="Connect containerd service" Aug 5 22:18:26.832601 containerd[2136]: time="2024-08-05T22:18:26.832541102Z" level=info msg="using legacy CRI server" Aug 5 22:18:26.832601 containerd[2136]: time="2024-08-05T22:18:26.832547423Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 5 22:18:26.832657 containerd[2136]: time="2024-08-05T22:18:26.832628963Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Aug 5 22:18:26.833004 containerd[2136]: time="2024-08-05T22:18:26.832982009Z" 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 22:18:26.833046 containerd[2136]: time="2024-08-05T22:18:26.833029820Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Aug 5 22:18:26.833084 containerd[2136]: time="2024-08-05T22:18:26.833046865Z" 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 22:18:26.833084 containerd[2136]: time="2024-08-05T22:18:26.833057027Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Aug 5 22:18:26.833084 containerd[2136]: time="2024-08-05T22:18:26.833075712Z" 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 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833162413Z" level=info msg="Start subscribing containerd event" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833209784Z" level=info msg="Start recovering state" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833261357Z" level=info msg="Start event monitor" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833291604Z" level=info msg="Start snapshots syncer" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833300606Z" level=info msg="Start cni network conf syncer for default" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833307568Z" level=info msg="Start streaming server" Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833307848Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833401831Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 5 22:18:26.833455 containerd[2136]: time="2024-08-05T22:18:26.833449042Z" level=info msg="containerd successfully booted in 0.050064s" Aug 5 22:18:26.833528 systemd[1]: Started containerd.service - containerd container runtime. Aug 5 22:18:26.844545 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 5 22:18:26.844707 (dockerd)[2172]: 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 22:18:26.876744 dockerd[2172]: time="2024-08-05T22:18:26.876693705Z" level=info msg="Starting up" Aug 5 22:18:26.892666 dockerd[2172]: time="2024-08-05T22:18:26.892626055Z" level=info msg="[graphdriver] using prior storage driver: overlay2" Aug 5 22:18:26.898588 dockerd[2172]: time="2024-08-05T22:18:26.898568018Z" level=info msg="Loading containers: start." Aug 5 22:18:26.911833 systemd[1]: var-lib-docker-overlay2-5de1492144f7cd836982cb3b0953a4677b2bbcefade746f2a80b5ea278fdebdc-merged.mount: Deactivated successfully. Aug 5 22:18:27.077368 dockerd[2172]: time="2024-08-05T22:18:27.076588553Z" level=info msg="Removing stale sandbox 77a7a99653856ba1d58740fcdfa05f46011b9b83621b005ca955796d4c76963b (43bac4b2643de819925b81d892bd670a2ce13edef206973c04a5256d02bf4d46)" Aug 5 22:18:27.076794 systemd[1]: run-docker-netns-77a7a9965385.mount: Deactivated successfully. Aug 5 22:18:27.079931 dockerd[2172]: time="2024-08-05T22:18:27.079882503Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint 4742bd68b37169f4f9a4ca39c5844bb149f82da6ba778b12c20efea128e1249b 8c7465bc32a8a59699ac56f163abfabe5fb5abeb0e023e5af49c6c5db1c0c6a6], retrying...." Aug 5 22:18:27.083166 systemd-networkd[1317]: vethac1f804: Link DOWN Aug 5 22:18:27.083742 kernel: docker0: port 1(vethac1f804) entered disabled state Aug 5 22:18:27.083781 kernel: vethac1f804 (unregistering): left allmulticast mode Aug 5 22:18:27.083172 systemd-networkd[1317]: vethac1f804: Lost carrier Aug 5 22:18:27.084769 kernel: vethac1f804 (unregistering): left promiscuous mode Aug 5 22:18:27.084825 kernel: docker0: port 1(vethac1f804) entered disabled state Aug 5 22:18:27.092361 systemd-networkd[1317]: docker0: Lost carrier Aug 5 22:18:27.180474 dockerd[2172]: time="2024-08-05T22:18:27.180426757Z" 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 22:18:27.229679 dockerd[2172]: time="2024-08-05T22:18:27.229637723Z" level=info msg="Loading containers: done." Aug 5 22:18:27.238913 dockerd[2172]: time="2024-08-05T22:18:27.238866904Z" 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 22:18:27.239112 dockerd[2172]: time="2024-08-05T22:18:27.239048346Z" level=info msg="Docker daemon" commit=fca702de7f71362c8d103073c7e4a1d0a467fadd graphdriver=overlay2 version=24.0.9 Aug 5 22:18:27.239112 dockerd[2172]: time="2024-08-05T22:18:27.239088555Z" level=info msg="Daemon has completed initialization" Aug 5 22:18:27.258365 dockerd[2172]: time="2024-08-05T22:18:27.258309291Z" level=info msg="API listen on /run/docker.sock" Aug 5 22:18:27.258463 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 5 22:18:31.049474 systemd[1]: Started sshd@24-10.0.0.128:22-10.0.0.1:34122.service - OpenSSH per-connection server daemon (10.0.0.1:34122). Aug 5 22:18:31.084775 sshd[2311]: Accepted publickey for core from 10.0.0.1 port 34122 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:31.085872 sshd[2311]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:31.089243 systemd-logind[1364]: New session 25 of user core. Aug 5 22:18:31.099463 systemd[1]: Started session-25.scope - Session 25 of User core. Aug 5 22:18:31.151178 sshd[2311]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:31.167554 systemd[1]: sshd@24-10.0.0.128:22-10.0.0.1:34122.service: Deactivated successfully. Aug 5 22:18:31.168966 systemd[1]: session-25.scope: Deactivated successfully. Aug 5 22:18:31.170056 systemd-logind[1364]: Session 25 logged out. Waiting for processes to exit. Aug 5 22:18:31.171087 systemd[1]: Started sshd@25-10.0.0.128:22-10.0.0.1:34130.service - OpenSSH per-connection server daemon (10.0.0.1:34130). Aug 5 22:18:31.171981 systemd-logind[1364]: Removed session 25. Aug 5 22:18:31.206426 sshd[2318]: Accepted publickey for core from 10.0.0.1 port 34130 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:31.207551 sshd[2318]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:31.211326 systemd-logind[1364]: New session 26 of user core. Aug 5 22:18:31.219461 systemd[1]: Started session-26.scope - Session 26 of User core. Aug 5 22:18:31.272258 sshd[2318]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:31.280555 systemd[1]: sshd@25-10.0.0.128:22-10.0.0.1:34130.service: Deactivated successfully. Aug 5 22:18:31.281905 systemd[1]: session-26.scope: Deactivated successfully. Aug 5 22:18:31.282955 systemd-logind[1364]: Session 26 logged out. Waiting for processes to exit. Aug 5 22:18:31.291482 systemd[1]: Started sshd@26-10.0.0.128:22-10.0.0.1:34146.service - OpenSSH per-connection server daemon (10.0.0.1:34146). Aug 5 22:18:31.292201 systemd-logind[1364]: Removed session 26. Aug 5 22:18:31.323323 sshd[2325]: Accepted publickey for core from 10.0.0.1 port 34146 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:31.324470 sshd[2325]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:31.328257 systemd-logind[1364]: New session 27 of user core. Aug 5 22:18:31.337380 systemd[1]: Started session-27.scope - Session 27 of User core. Aug 5 22:18:31.392909 sshd[2325]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:31.401612 systemd[1]: sshd@26-10.0.0.128:22-10.0.0.1:34146.service: Deactivated successfully. Aug 5 22:18:31.403003 systemd[1]: session-27.scope: Deactivated successfully. Aug 5 22:18:31.405379 systemd-logind[1364]: Session 27 logged out. Waiting for processes to exit. Aug 5 22:18:31.419579 systemd[1]: Started sshd@27-10.0.0.128:22-10.0.0.1:34148.service - OpenSSH per-connection server daemon (10.0.0.1:34148). Aug 5 22:18:31.420911 systemd-logind[1364]: Removed session 27. Aug 5 22:18:31.451575 sshd[2339]: Accepted publickey for core from 10.0.0.1 port 34148 ssh2: RSA SHA256:m+vSf9MZ8jyHy+Dz2uz+ngzM5NRoRVVH/LZDa5ltoPE Aug 5 22:18:31.452610 sshd[2339]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Aug 5 22:18:31.455667 systemd-logind[1364]: New session 28 of user core. Aug 5 22:18:31.463454 systemd[1]: Started session-28.scope - Session 28 of User core. Aug 5 22:18:31.545812 kernel: docker0: port 1(vetha967ec4) entered blocking state Aug 5 22:18:31.546001 kernel: docker0: port 1(vetha967ec4) entered disabled state Aug 5 22:18:31.546037 kernel: vetha967ec4: entered allmulticast mode Aug 5 22:18:31.546316 kernel: vetha967ec4: entered promiscuous mode Aug 5 22:18:31.546766 systemd-networkd[1317]: vetha967ec4: Link UP Aug 5 22:18:31.547715 kernel: docker0: port 1(vetha967ec4) entered blocking state Aug 5 22:18:31.547750 kernel: docker0: port 1(vetha967ec4) entered forwarding state Aug 5 22:18:31.548299 kernel: docker0: port 1(vetha967ec4) entered disabled state Aug 5 22:18:31.575599 containerd[2136]: time="2024-08-05T22:18:31.575453140Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Aug 5 22:18:31.575599 containerd[2136]: time="2024-08-05T22:18:31.575497307Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:31.575599 containerd[2136]: time="2024-08-05T22:18:31.575511590Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Aug 5 22:18:31.575599 containerd[2136]: time="2024-08-05T22:18:31.575521552Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Aug 5 22:18:31.598465 systemd[1]: Started docker-dc132edfcd318bb00b67e8e64f7534e789159f5c9386eab8f650c9e04c2a634a.scope - libcontainer container dc132edfcd318bb00b67e8e64f7534e789159f5c9386eab8f650c9e04c2a634a. Aug 5 22:18:31.653304 kernel: eth0: renamed from veth1abe8f2 Aug 5 22:18:31.659575 kernel: docker0: port 1(vetha967ec4) entered blocking state Aug 5 22:18:31.659628 kernel: docker0: port 1(vetha967ec4) entered forwarding state Aug 5 22:18:31.659676 systemd-networkd[1317]: vetha967ec4: Gained carrier Aug 5 22:18:31.659879 systemd-networkd[1317]: docker0: Gained carrier Aug 5 22:18:31.662866 systemd-resolved[1253]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address Aug 5 22:18:31.683164 sshd[2339]: pam_unix(sshd:session): session closed for user core Aug 5 22:18:31.685769 systemd-logind[1364]: Session 28 logged out. Waiting for processes to exit. Aug 5 22:18:31.685926 systemd[1]: sshd@27-10.0.0.128:22-10.0.0.1:34148.service: Deactivated successfully. Aug 5 22:18:31.687360 systemd[1]: session-28.scope: Deactivated successfully. Aug 5 22:18:31.689382 systemd-logind[1364]: Removed session 28. Aug 5 22:18:32.525813 systemd[1]: run-docker-runtime\x2drunc-moby-dc132edfcd318bb00b67e8e64f7534e789159f5c9386eab8f650c9e04c2a634a-runc.sAkb3q.mount: Deactivated successfully. Aug 5 22:18:33.151453 systemd-networkd[1317]: vetha967ec4: Gained IPv6LL