May 16 00:03:37.972810 kernel: Booting Linux on physical CPU 0x0000000000 [0x413fd0c1] May 16 00:03:37.972833 kernel: Linux version 6.6.90-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p1) 13.3.1 20240614, GNU ld (Gentoo 2.42 p6) 2.42.0) #1 SMP PREEMPT Thu May 15 22:19:24 -00 2025 May 16 00:03:37.972845 kernel: KASLR enabled May 16 00:03:37.972850 kernel: efi: EFI v2.7 by EDK II May 16 00:03:37.972856 kernel: efi: SMBIOS 3.0=0xdced0000 MEMATTR=0xdbbbf018 ACPI 2.0=0xd9b43018 RNG=0xd9b43a18 MEMRESERVE=0xd9b40d98 May 16 00:03:37.972862 kernel: random: crng init done May 16 00:03:37.972869 kernel: secureboot: Secure boot disabled May 16 00:03:37.972875 kernel: ACPI: Early table checksum verification disabled May 16 00:03:37.972881 kernel: ACPI: RSDP 0x00000000D9B43018 000024 (v02 BOCHS ) May 16 00:03:37.972889 kernel: ACPI: XSDT 0x00000000D9B43F18 000064 (v01 BOCHS BXPC 00000001 01000013) May 16 00:03:37.972895 kernel: ACPI: FACP 0x00000000D9B43B18 000114 (v06 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972901 kernel: ACPI: DSDT 0x00000000D9B41018 0014A2 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972907 kernel: ACPI: APIC 0x00000000D9B43C98 0001A8 (v04 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972914 kernel: ACPI: PPTT 0x00000000D9B43098 00009C (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972921 kernel: ACPI: GTDT 0x00000000D9B43818 000060 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972929 kernel: ACPI: MCFG 0x00000000D9B43A98 00003C (v01 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972936 kernel: ACPI: SPCR 0x00000000D9B43918 000050 (v02 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972942 kernel: ACPI: DBG2 0x00000000D9B43998 000057 (v00 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972948 kernel: ACPI: IORT 0x00000000D9B43198 000080 (v03 BOCHS BXPC 00000001 BXPC 00000001) May 16 00:03:37.972954 kernel: ACPI: SPCR: console: pl011,mmio,0x9000000,9600 May 16 00:03:37.972961 kernel: NUMA: Failed to initialise from firmware May 16 00:03:37.972967 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000000dcffffff] May 16 00:03:37.972973 kernel: NUMA: NODE_DATA [mem 0xdc957800-0xdc95cfff] May 16 00:03:37.972979 kernel: Zone ranges: May 16 00:03:37.972985 kernel: DMA [mem 0x0000000040000000-0x00000000dcffffff] May 16 00:03:37.972993 kernel: DMA32 empty May 16 00:03:37.972999 kernel: Normal empty May 16 00:03:37.973005 kernel: Movable zone start for each node May 16 00:03:37.973011 kernel: Early memory node ranges May 16 00:03:37.973018 kernel: node 0: [mem 0x0000000040000000-0x00000000d976ffff] May 16 00:03:37.973024 kernel: node 0: [mem 0x00000000d9770000-0x00000000d9b3ffff] May 16 00:03:37.973030 kernel: node 0: [mem 0x00000000d9b40000-0x00000000dce1ffff] May 16 00:03:37.973036 kernel: node 0: [mem 0x00000000dce20000-0x00000000dceaffff] May 16 00:03:37.973042 kernel: node 0: [mem 0x00000000dceb0000-0x00000000dcebffff] May 16 00:03:37.973049 kernel: node 0: [mem 0x00000000dcec0000-0x00000000dcfdffff] May 16 00:03:37.973054 kernel: node 0: [mem 0x00000000dcfe0000-0x00000000dcffffff] May 16 00:03:37.973061 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000000dcffffff] May 16 00:03:37.973068 kernel: On node 0, zone DMA: 12288 pages in unavailable ranges May 16 00:03:37.973075 kernel: psci: probing for conduit method from ACPI. May 16 00:03:37.973081 kernel: psci: PSCIv1.1 detected in firmware. May 16 00:03:37.973090 kernel: psci: Using standard PSCI v0.2 function IDs May 16 00:03:37.973097 kernel: psci: Trusted OS migration not required May 16 00:03:37.973103 kernel: psci: SMC Calling Convention v1.1 May 16 00:03:37.973111 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003) May 16 00:03:37.973118 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 May 16 00:03:37.973125 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 May 16 00:03:37.973132 kernel: pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 May 16 00:03:37.973139 kernel: Detected PIPT I-cache on CPU0 May 16 00:03:37.973145 kernel: CPU features: detected: GIC system register CPU interface May 16 00:03:37.973152 kernel: CPU features: detected: Hardware dirty bit management May 16 00:03:37.973159 kernel: CPU features: detected: Spectre-v4 May 16 00:03:37.973165 kernel: CPU features: detected: Spectre-BHB May 16 00:03:37.973172 kernel: CPU features: kernel page table isolation forced ON by KASLR May 16 00:03:37.973180 kernel: CPU features: detected: Kernel page table isolation (KPTI) May 16 00:03:37.973187 kernel: CPU features: detected: ARM erratum 1418040 May 16 00:03:37.973194 kernel: CPU features: detected: SSBS not fully self-synchronizing May 16 00:03:37.973200 kernel: alternatives: applying boot alternatives May 16 00:03:37.973208 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=a39d79b1d2ff9998339b60958cf17b8dfae5bd16f05fb844c0e06a5d7107915a May 16 00:03:37.973215 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. May 16 00:03:37.973221 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) May 16 00:03:37.973228 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) May 16 00:03:37.973235 kernel: Fallback order for Node 0: 0 May 16 00:03:37.973242 kernel: Built 1 zonelists, mobility grouping on. Total pages: 633024 May 16 00:03:37.973248 kernel: Policy zone: DMA May 16 00:03:37.973258 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off May 16 00:03:37.973265 kernel: software IO TLB: area num 4. May 16 00:03:37.973271 kernel: software IO TLB: mapped [mem 0x00000000d2e00000-0x00000000d6e00000] (64MB) May 16 00:03:37.973278 kernel: Memory: 2386256K/2572288K available (10240K kernel code, 2186K rwdata, 8108K rodata, 39744K init, 897K bss, 186032K reserved, 0K cma-reserved) May 16 00:03:37.973285 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 May 16 00:03:37.973292 kernel: rcu: Preemptible hierarchical RCU implementation. May 16 00:03:37.973300 kernel: rcu: RCU event tracing is enabled. May 16 00:03:37.973307 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4. May 16 00:03:37.973314 kernel: Trampoline variant of Tasks RCU enabled. May 16 00:03:37.973322 kernel: Tracing variant of Tasks RCU enabled. May 16 00:03:37.973329 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. May 16 00:03:37.973335 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 May 16 00:03:37.973344 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 May 16 00:03:37.973351 kernel: GICv3: 256 SPIs implemented May 16 00:03:37.973358 kernel: GICv3: 0 Extended SPIs implemented May 16 00:03:37.973364 kernel: Root IRQ handler: gic_handle_irq May 16 00:03:37.973371 kernel: GICv3: GICv3 features: 16 PPIs, DirectLPI May 16 00:03:37.973377 kernel: GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000 May 16 00:03:37.973384 kernel: ITS [mem 0x08080000-0x0809ffff] May 16 00:03:37.973391 kernel: ITS@0x0000000008080000: allocated 8192 Devices @400c0000 (indirect, esz 8, psz 64K, shr 1) May 16 00:03:37.973398 kernel: ITS@0x0000000008080000: allocated 8192 Interrupt Collections @400d0000 (flat, esz 8, psz 64K, shr 1) May 16 00:03:37.973404 kernel: GICv3: using LPI property table @0x00000000400f0000 May 16 00:03:37.973411 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000040100000 May 16 00:03:37.973481 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. May 16 00:03:37.973490 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 00:03:37.973497 kernel: arch_timer: cp15 timer(s) running at 25.00MHz (virt). May 16 00:03:37.973504 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x5c40939b5, max_idle_ns: 440795202646 ns May 16 00:03:37.973511 kernel: sched_clock: 56 bits at 25MHz, resolution 40ns, wraps every 4398046511100ns May 16 00:03:37.973518 kernel: arm-pv: using stolen time PV May 16 00:03:37.973525 kernel: Console: colour dummy device 80x25 May 16 00:03:37.973532 kernel: ACPI: Core revision 20230628 May 16 00:03:37.973539 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 50.00 BogoMIPS (lpj=25000) May 16 00:03:37.973546 kernel: pid_max: default: 32768 minimum: 301 May 16 00:03:37.973555 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity May 16 00:03:37.973562 kernel: landlock: Up and running. May 16 00:03:37.973569 kernel: SELinux: Initializing. May 16 00:03:37.973576 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 00:03:37.973583 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) May 16 00:03:37.973589 kernel: ACPI PPTT: PPTT table found, but unable to locate core 3 (3) May 16 00:03:37.973597 kernel: RCU Tasks: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 16 00:03:37.973603 kernel: RCU Tasks Trace: Setting shift to 2 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=4. May 16 00:03:37.973610 kernel: rcu: Hierarchical SRCU implementation. May 16 00:03:37.973618 kernel: rcu: Max phase no-delay instances is 400. May 16 00:03:37.973625 kernel: Platform MSI: ITS@0x8080000 domain created May 16 00:03:37.973632 kernel: PCI/MSI: ITS@0x8080000 domain created May 16 00:03:37.973639 kernel: Remapping and enabling EFI services. May 16 00:03:37.973645 kernel: smp: Bringing up secondary CPUs ... May 16 00:03:37.973655 kernel: Detected PIPT I-cache on CPU1 May 16 00:03:37.973662 kernel: GICv3: CPU1: found redistributor 1 region 0:0x00000000080c0000 May 16 00:03:37.973669 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000040110000 May 16 00:03:37.973676 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 00:03:37.973683 kernel: CPU1: Booted secondary processor 0x0000000001 [0x413fd0c1] May 16 00:03:37.973691 kernel: Detected PIPT I-cache on CPU2 May 16 00:03:37.973698 kernel: GICv3: CPU2: found redistributor 2 region 0:0x00000000080e0000 May 16 00:03:37.973710 kernel: GICv3: CPU2: using allocated LPI pending table @0x0000000040120000 May 16 00:03:37.973718 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 00:03:37.973725 kernel: CPU2: Booted secondary processor 0x0000000002 [0x413fd0c1] May 16 00:03:37.973732 kernel: Detected PIPT I-cache on CPU3 May 16 00:03:37.973739 kernel: GICv3: CPU3: found redistributor 3 region 0:0x0000000008100000 May 16 00:03:37.973747 kernel: GICv3: CPU3: using allocated LPI pending table @0x0000000040130000 May 16 00:03:37.973754 kernel: arch_timer: Enabling local workaround for ARM erratum 1418040 May 16 00:03:37.973761 kernel: CPU3: Booted secondary processor 0x0000000003 [0x413fd0c1] May 16 00:03:37.973771 kernel: smp: Brought up 1 node, 4 CPUs May 16 00:03:37.973778 kernel: SMP: Total of 4 processors activated. May 16 00:03:37.973786 kernel: CPU features: detected: 32-bit EL0 Support May 16 00:03:37.973793 kernel: CPU features: detected: Data cache clean to the PoU not required for I/D coherence May 16 00:03:37.973800 kernel: CPU features: detected: Common not Private translations May 16 00:03:37.973808 kernel: CPU features: detected: CRC32 instructions May 16 00:03:37.973815 kernel: CPU features: detected: Enhanced Virtualization Traps May 16 00:03:37.973824 kernel: CPU features: detected: RCpc load-acquire (LDAPR) May 16 00:03:37.973831 kernel: CPU features: detected: LSE atomic instructions May 16 00:03:37.973838 kernel: CPU features: detected: Privileged Access Never May 16 00:03:37.973846 kernel: CPU features: detected: RAS Extension Support May 16 00:03:37.973853 kernel: CPU features: detected: Speculative Store Bypassing Safe (SSBS) May 16 00:03:37.973861 kernel: CPU: All CPU(s) started at EL1 May 16 00:03:37.973868 kernel: alternatives: applying system-wide alternatives May 16 00:03:37.973876 kernel: devtmpfs: initialized May 16 00:03:37.973883 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns May 16 00:03:37.973892 kernel: futex hash table entries: 1024 (order: 4, 65536 bytes, linear) May 16 00:03:37.973899 kernel: pinctrl core: initialized pinctrl subsystem May 16 00:03:37.973906 kernel: SMBIOS 3.0.0 present. May 16 00:03:37.973914 kernel: DMI: QEMU KVM Virtual Machine, BIOS unknown 02/02/2022 May 16 00:03:37.973921 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family May 16 00:03:37.973929 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations May 16 00:03:37.973936 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations May 16 00:03:37.973944 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations May 16 00:03:37.973951 kernel: audit: initializing netlink subsys (disabled) May 16 00:03:37.973960 kernel: audit: type=2000 audit(0.026:1): state=initialized audit_enabled=0 res=1 May 16 00:03:37.973967 kernel: thermal_sys: Registered thermal governor 'step_wise' May 16 00:03:37.973975 kernel: cpuidle: using governor menu May 16 00:03:37.973982 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. May 16 00:03:37.973989 kernel: ASID allocator initialised with 32768 entries May 16 00:03:37.973997 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 May 16 00:03:37.974005 kernel: Serial: AMBA PL011 UART driver May 16 00:03:37.974012 kernel: Modules: 2G module region forced by RANDOMIZE_MODULE_REGION_FULL May 16 00:03:37.974030 kernel: Modules: 0 pages in range for non-PLT usage May 16 00:03:37.974040 kernel: Modules: 508944 pages in range for PLT usage May 16 00:03:37.974048 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages May 16 00:03:37.974055 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page May 16 00:03:37.974063 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages May 16 00:03:37.974070 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page May 16 00:03:37.974077 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages May 16 00:03:37.974085 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page May 16 00:03:37.974092 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages May 16 00:03:37.974099 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page May 16 00:03:37.974108 kernel: ACPI: Added _OSI(Module Device) May 16 00:03:37.974117 kernel: ACPI: Added _OSI(Processor Device) May 16 00:03:37.974124 kernel: ACPI: Added _OSI(3.0 _SCP Extensions) May 16 00:03:37.974132 kernel: ACPI: Added _OSI(Processor Aggregator Device) May 16 00:03:37.974140 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded May 16 00:03:37.974147 kernel: ACPI: Interpreter enabled May 16 00:03:37.974154 kernel: ACPI: Using GIC for interrupt routing May 16 00:03:37.974161 kernel: ACPI: MCFG table detected, 1 entries May 16 00:03:37.974169 kernel: ARMH0011:00: ttyAMA0 at MMIO 0x9000000 (irq = 12, base_baud = 0) is a SBSA May 16 00:03:37.974190 kernel: printk: console [ttyAMA0] enabled May 16 00:03:37.974197 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) May 16 00:03:37.974342 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] May 16 00:03:37.974509 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] May 16 00:03:37.974591 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] May 16 00:03:37.974671 kernel: acpi PNP0A08:00: ECAM area [mem 0x4010000000-0x401fffffff] reserved by PNP0C02:00 May 16 00:03:37.974735 kernel: acpi PNP0A08:00: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff] May 16 00:03:37.974749 kernel: ACPI: Remapped I/O 0x000000003eff0000 to [io 0x0000-0xffff window] May 16 00:03:37.974757 kernel: PCI host bridge to bus 0000:00 May 16 00:03:37.974828 kernel: pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff window] May 16 00:03:37.974888 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] May 16 00:03:37.974946 kernel: pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff window] May 16 00:03:37.975002 kernel: pci_bus 0000:00: root bus resource [bus 00-ff] May 16 00:03:37.975089 kernel: pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 May 16 00:03:37.975172 kernel: pci 0000:00:01.0: [1af4:1005] type 00 class 0x00ff00 May 16 00:03:37.975237 kernel: pci 0000:00:01.0: reg 0x10: [io 0x0000-0x001f] May 16 00:03:37.975303 kernel: pci 0000:00:01.0: reg 0x14: [mem 0x10000000-0x10000fff] May 16 00:03:37.975368 kernel: pci 0000:00:01.0: reg 0x20: [mem 0x8000000000-0x8000003fff 64bit pref] May 16 00:03:37.975457 kernel: pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] May 16 00:03:37.975526 kernel: pci 0000:00:01.0: BAR 1: assigned [mem 0x10000000-0x10000fff] May 16 00:03:37.975595 kernel: pci 0000:00:01.0: BAR 0: assigned [io 0x1000-0x101f] May 16 00:03:37.975658 kernel: pci_bus 0000:00: resource 4 [mem 0x10000000-0x3efeffff window] May 16 00:03:37.975715 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] May 16 00:03:37.975774 kernel: pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff window] May 16 00:03:37.975784 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 May 16 00:03:37.975802 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 May 16 00:03:37.975809 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 May 16 00:03:37.975816 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 May 16 00:03:37.975825 kernel: iommu: Default domain type: Translated May 16 00:03:37.975833 kernel: iommu: DMA domain TLB invalidation policy: strict mode May 16 00:03:37.975840 kernel: efivars: Registered efivars operations May 16 00:03:37.975847 kernel: vgaarb: loaded May 16 00:03:37.975854 kernel: clocksource: Switched to clocksource arch_sys_counter May 16 00:03:37.975861 kernel: VFS: Disk quotas dquot_6.6.0 May 16 00:03:37.975869 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) May 16 00:03:37.975876 kernel: pnp: PnP ACPI init May 16 00:03:37.975948 kernel: system 00:00: [mem 0x4010000000-0x401fffffff window] could not be reserved May 16 00:03:37.975960 kernel: pnp: PnP ACPI: found 1 devices May 16 00:03:37.975967 kernel: NET: Registered PF_INET protocol family May 16 00:03:37.975975 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) May 16 00:03:37.975982 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) May 16 00:03:37.975989 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) May 16 00:03:37.975997 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) May 16 00:03:37.976004 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) May 16 00:03:37.976011 kernel: TCP: Hash tables configured (established 32768 bind 32768) May 16 00:03:37.976019 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 00:03:37.976028 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) May 16 00:03:37.976035 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family May 16 00:03:37.976042 kernel: PCI: CLS 0 bytes, default 64 May 16 00:03:37.976049 kernel: kvm [1]: HYP mode not available May 16 00:03:37.976057 kernel: Initialise system trusted keyrings May 16 00:03:37.976064 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 May 16 00:03:37.976071 kernel: Key type asymmetric registered May 16 00:03:37.976078 kernel: Asymmetric key parser 'x509' registered May 16 00:03:37.976086 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) May 16 00:03:37.976095 kernel: io scheduler mq-deadline registered May 16 00:03:37.976102 kernel: io scheduler kyber registered May 16 00:03:37.976110 kernel: io scheduler bfq registered May 16 00:03:37.976117 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 May 16 00:03:37.976124 kernel: ACPI: button: Power Button [PWRB] May 16 00:03:37.976132 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 May 16 00:03:37.976195 kernel: virtio-pci 0000:00:01.0: enabling device (0005 -> 0007) May 16 00:03:37.976205 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled May 16 00:03:37.976212 kernel: thunder_xcv, ver 1.0 May 16 00:03:37.976221 kernel: thunder_bgx, ver 1.0 May 16 00:03:37.976228 kernel: nicpf, ver 1.0 May 16 00:03:37.976235 kernel: nicvf, ver 1.0 May 16 00:03:37.976306 kernel: rtc-efi rtc-efi.0: registered as rtc0 May 16 00:03:37.976367 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-05-16T00:03:37 UTC (1747353817) May 16 00:03:37.976377 kernel: hid: raw HID events driver (C) Jiri Kosina May 16 00:03:37.976384 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 7 counters available May 16 00:03:37.976391 kernel: watchdog: Delayed init of the lockup detector failed: -19 May 16 00:03:37.976400 kernel: watchdog: Hard watchdog permanently disabled May 16 00:03:37.976407 kernel: NET: Registered PF_INET6 protocol family May 16 00:03:37.976421 kernel: Segment Routing with IPv6 May 16 00:03:37.976450 kernel: In-situ OAM (IOAM) with IPv6 May 16 00:03:37.976457 kernel: NET: Registered PF_PACKET protocol family May 16 00:03:37.976464 kernel: Key type dns_resolver registered May 16 00:03:37.976471 kernel: registered taskstats version 1 May 16 00:03:37.976479 kernel: Loading compiled-in X.509 certificates May 16 00:03:37.976486 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.90-flatcar: c5ee9c587519d4ef57ff0de9630e786a4c7faded' May 16 00:03:37.976496 kernel: Key type .fscrypt registered May 16 00:03:37.976503 kernel: Key type fscrypt-provisioning registered May 16 00:03:37.976510 kernel: ima: No TPM chip found, activating TPM-bypass! May 16 00:03:37.976517 kernel: ima: Allocated hash algorithm: sha1 May 16 00:03:37.976524 kernel: ima: No architecture policies found May 16 00:03:37.976532 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) May 16 00:03:37.976539 kernel: clk: Disabling unused clocks May 16 00:03:37.976546 kernel: Freeing unused kernel memory: 39744K May 16 00:03:37.976554 kernel: Run /init as init process May 16 00:03:37.976562 kernel: with arguments: May 16 00:03:37.976569 kernel: /init May 16 00:03:37.976577 kernel: with environment: May 16 00:03:37.976583 kernel: HOME=/ May 16 00:03:37.976591 kernel: TERM=linux May 16 00:03:37.976597 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a May 16 00:03:37.976606 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) May 16 00:03:37.976615 systemd[1]: Detected virtualization kvm. May 16 00:03:37.976625 systemd[1]: Detected architecture arm64. May 16 00:03:37.976632 systemd[1]: Running in initrd. May 16 00:03:37.976639 systemd[1]: No hostname configured, using default hostname. May 16 00:03:37.976647 systemd[1]: Hostname set to . May 16 00:03:37.976655 systemd[1]: Initializing machine ID from VM UUID. May 16 00:03:37.976662 systemd[1]: Queued start job for default target initrd.target. May 16 00:03:37.976670 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 00:03:37.976678 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 00:03:37.976687 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... May 16 00:03:37.976695 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 00:03:37.976703 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... May 16 00:03:37.976711 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... May 16 00:03:37.976720 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... May 16 00:03:37.976728 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... May 16 00:03:37.976737 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 00:03:37.976746 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 00:03:37.976753 systemd[1]: Reached target paths.target - Path Units. May 16 00:03:37.976761 systemd[1]: Reached target slices.target - Slice Units. May 16 00:03:37.976769 systemd[1]: Reached target swap.target - Swaps. May 16 00:03:37.976777 systemd[1]: Reached target timers.target - Timer Units. May 16 00:03:37.976784 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. May 16 00:03:37.976792 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 00:03:37.976800 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). May 16 00:03:37.976809 systemd[1]: Listening on systemd-journald.socket - Journal Socket. May 16 00:03:37.976817 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 00:03:37.976825 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 00:03:37.976834 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 00:03:37.976842 systemd[1]: Reached target sockets.target - Socket Units. May 16 00:03:37.976849 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... May 16 00:03:37.976858 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 00:03:37.976865 systemd[1]: Finished network-cleanup.service - Network Cleanup. May 16 00:03:37.976875 systemd[1]: Starting systemd-fsck-usr.service... May 16 00:03:37.976883 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 00:03:37.976891 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 00:03:37.976899 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 00:03:37.976908 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. May 16 00:03:37.976916 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 00:03:37.976923 systemd[1]: Finished systemd-fsck-usr.service. May 16 00:03:37.976934 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... May 16 00:03:37.976966 systemd-journald[238]: Collecting audit messages is disabled. May 16 00:03:37.976988 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. May 16 00:03:37.976997 systemd-journald[238]: Journal started May 16 00:03:37.977015 systemd-journald[238]: Runtime Journal (/run/log/journal/c89ab2337ec44786ae2a815a0a27083b) is 5.9M, max 47.3M, 41.4M free. May 16 00:03:37.967257 systemd-modules-load[240]: Inserted module 'overlay' May 16 00:03:37.981595 systemd[1]: Started systemd-journald.service - Journal Service. May 16 00:03:37.983446 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. May 16 00:03:37.983522 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 00:03:37.985911 systemd-modules-load[240]: Inserted module 'br_netfilter' May 16 00:03:37.986699 kernel: Bridge firewalling registered May 16 00:03:37.993849 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 00:03:37.995607 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 00:03:37.999636 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 00:03:38.000848 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 00:03:38.004304 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 00:03:38.011696 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 00:03:38.014265 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 00:03:38.021291 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 00:03:38.034759 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 00:03:38.035926 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 00:03:38.038492 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... May 16 00:03:38.057545 dracut-cmdline[282]: dracut-dracut-053 May 16 00:03:38.060656 dracut-cmdline[282]: 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=a39d79b1d2ff9998339b60958cf17b8dfae5bd16f05fb844c0e06a5d7107915a May 16 00:03:38.065716 systemd-resolved[279]: Positive Trust Anchors: May 16 00:03:38.065800 systemd-resolved[279]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 00:03:38.065831 systemd-resolved[279]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 16 00:03:38.070870 systemd-resolved[279]: Defaulting to hostname 'linux'. May 16 00:03:38.071947 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 00:03:38.074843 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 00:03:38.155459 kernel: SCSI subsystem initialized May 16 00:03:38.164459 kernel: Loading iSCSI transport class v2.0-870. May 16 00:03:38.172447 kernel: iscsi: registered transport (tcp) May 16 00:03:38.186464 kernel: iscsi: registered transport (qla4xxx) May 16 00:03:38.186529 kernel: QLogic iSCSI HBA Driver May 16 00:03:38.233495 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. May 16 00:03:38.243621 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... May 16 00:03:38.266298 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. May 16 00:03:38.266377 kernel: device-mapper: uevent: version 1.0.3 May 16 00:03:38.266388 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com May 16 00:03:38.314446 kernel: raid6: neonx8 gen() 15754 MB/s May 16 00:03:38.331437 kernel: raid6: neonx4 gen() 15656 MB/s May 16 00:03:38.348445 kernel: raid6: neonx2 gen() 13278 MB/s May 16 00:03:38.365437 kernel: raid6: neonx1 gen() 10476 MB/s May 16 00:03:38.382438 kernel: raid6: int64x8 gen() 6972 MB/s May 16 00:03:38.399436 kernel: raid6: int64x4 gen() 7344 MB/s May 16 00:03:38.416435 kernel: raid6: int64x2 gen() 6130 MB/s May 16 00:03:38.433437 kernel: raid6: int64x1 gen() 5055 MB/s May 16 00:03:38.433455 kernel: raid6: using algorithm neonx8 gen() 15754 MB/s May 16 00:03:38.450436 kernel: raid6: .... xor() 11919 MB/s, rmw enabled May 16 00:03:38.450454 kernel: raid6: using neon recovery algorithm May 16 00:03:38.455440 kernel: xor: measuring software checksum speed May 16 00:03:38.455466 kernel: 8regs : 19812 MB/sec May 16 00:03:38.456450 kernel: 32regs : 17518 MB/sec May 16 00:03:38.456471 kernel: arm64_neon : 26972 MB/sec May 16 00:03:38.456480 kernel: xor: using function: arm64_neon (26972 MB/sec) May 16 00:03:38.507469 kernel: Btrfs loaded, zoned=no, fsverity=no May 16 00:03:38.519316 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. May 16 00:03:38.541618 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 00:03:38.560332 systemd-udevd[463]: Using default interface naming scheme 'v255'. May 16 00:03:38.563490 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 00:03:38.569622 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... May 16 00:03:38.583033 dracut-pre-trigger[470]: rd.md=0: removing MD RAID activation May 16 00:03:38.613489 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. May 16 00:03:38.621617 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 00:03:38.664872 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 00:03:38.673682 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... May 16 00:03:38.695485 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. May 16 00:03:38.696577 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. May 16 00:03:38.698272 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 00:03:38.700015 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 00:03:38.712693 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... May 16 00:03:38.722486 kernel: virtio_blk virtio1: 1/0/0 default/read/poll queues May 16 00:03:38.724444 kernel: virtio_blk virtio1: [vda] 9289728 512-byte logical blocks (4.76 GB/4.43 GiB) May 16 00:03:38.726199 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. May 16 00:03:38.728057 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 00:03:38.729689 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 16 00:03:38.729813 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 00:03:38.732676 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 00:03:38.733643 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 00:03:38.733791 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 00:03:38.737170 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... May 16 00:03:38.747456 kernel: BTRFS: device fsid 462ff9f1-7a02-4839-b355-edf30dab0598 devid 1 transid 39 /dev/vda3 scanned by (udev-worker) (517) May 16 00:03:38.749445 kernel: BTRFS: device label OEM devid 1 transid 14 /dev/vda6 scanned by (udev-worker) (507) May 16 00:03:38.750827 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 00:03:38.758622 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM. May 16 00:03:38.763328 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 00:03:38.773850 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT. May 16 00:03:38.783072 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A. May 16 00:03:38.785208 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132. May 16 00:03:38.789908 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 00:03:38.804624 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... May 16 00:03:38.806268 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... May 16 00:03:38.812441 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 00:03:38.831702 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 00:03:39.828478 kernel: vda: vda1 vda2 vda3 vda4 vda6 vda7 vda9 May 16 00:03:39.829436 disk-uuid[552]: The operation has completed successfully. May 16 00:03:39.864154 systemd[1]: disk-uuid.service: Deactivated successfully. May 16 00:03:39.864264 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. May 16 00:03:39.887623 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... May 16 00:03:39.892230 sh[573]: Success May 16 00:03:39.911669 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" May 16 00:03:39.949821 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. May 16 00:03:39.971855 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... May 16 00:03:39.975823 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. May 16 00:03:39.983189 kernel: BTRFS info (device dm-0): first mount of filesystem 462ff9f1-7a02-4839-b355-edf30dab0598 May 16 00:03:39.983230 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm May 16 00:03:39.983240 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead May 16 00:03:39.984104 kernel: BTRFS info (device dm-0): disabling log replay at mount time May 16 00:03:39.984756 kernel: BTRFS info (device dm-0): using free space tree May 16 00:03:39.988844 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. May 16 00:03:39.990051 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. May 16 00:03:40.002601 systemd[1]: Starting ignition-setup.service - Ignition (setup)... May 16 00:03:40.004194 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... May 16 00:03:40.014809 kernel: BTRFS info (device vda6): first mount of filesystem bb522e90-8598-4687-8a48-65ed6b798a46 May 16 00:03:40.014857 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 00:03:40.015440 kernel: BTRFS info (device vda6): using free space tree May 16 00:03:40.018490 kernel: BTRFS info (device vda6): auto enabling async discard May 16 00:03:40.026490 systemd[1]: mnt-oem.mount: Deactivated successfully. May 16 00:03:40.028552 kernel: BTRFS info (device vda6): last unmount of filesystem bb522e90-8598-4687-8a48-65ed6b798a46 May 16 00:03:40.033954 systemd[1]: Finished ignition-setup.service - Ignition (setup). May 16 00:03:40.041681 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... May 16 00:03:40.123915 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 00:03:40.136612 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 00:03:40.173935 ignition[663]: Ignition 2.20.0 May 16 00:03:40.173946 ignition[663]: Stage: fetch-offline May 16 00:03:40.173983 ignition[663]: no configs at "/usr/lib/ignition/base.d" May 16 00:03:40.177366 systemd-networkd[764]: lo: Link UP May 16 00:03:40.173992 ignition[663]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:40.177370 systemd-networkd[764]: lo: Gained carrier May 16 00:03:40.174162 ignition[663]: parsed url from cmdline: "" May 16 00:03:40.178397 systemd-networkd[764]: Enumeration completed May 16 00:03:40.174165 ignition[663]: no config URL provided May 16 00:03:40.178946 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 00:03:40.174170 ignition[663]: reading system config file "/usr/lib/ignition/user.ign" May 16 00:03:40.179725 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 00:03:40.174177 ignition[663]: no config at "/usr/lib/ignition/user.ign" May 16 00:03:40.179728 systemd-networkd[764]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 00:03:40.174204 ignition[663]: op(1): [started] loading QEMU firmware config module May 16 00:03:40.180098 systemd[1]: Reached target network.target - Network. May 16 00:03:40.174208 ignition[663]: op(1): executing: "modprobe" "qemu_fw_cfg" May 16 00:03:40.180594 systemd-networkd[764]: eth0: Link UP May 16 00:03:40.183867 ignition[663]: op(1): [finished] loading QEMU firmware config module May 16 00:03:40.180597 systemd-networkd[764]: eth0: Gained carrier May 16 00:03:40.180603 systemd-networkd[764]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 00:03:40.195954 ignition[663]: parsing config with SHA512: bcb4d8338261807a8a790c2b7c4036eccd0152df6746844b82e95b4a85de3a9c9dca6ac2a018835551ce60a4fcc4eb4026ad0d796b47eb995465fbe1bad6b855 May 16 00:03:40.197478 systemd-networkd[764]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 16 00:03:40.205545 unknown[663]: fetched base config from "system" May 16 00:03:40.206301 unknown[663]: fetched user config from "qemu" May 16 00:03:40.206535 ignition[663]: fetch-offline: fetch-offline passed May 16 00:03:40.206640 ignition[663]: Ignition finished successfully May 16 00:03:40.208183 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). May 16 00:03:40.209872 systemd[1]: ignition-fetch.service - Ignition (fetch) was skipped because of an unmet condition check (ConditionPathExists=!/run/ignition.json). May 16 00:03:40.219673 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... May 16 00:03:40.230210 ignition[770]: Ignition 2.20.0 May 16 00:03:40.230219 ignition[770]: Stage: kargs May 16 00:03:40.230382 ignition[770]: no configs at "/usr/lib/ignition/base.d" May 16 00:03:40.230392 ignition[770]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:40.231044 ignition[770]: kargs: kargs passed May 16 00:03:40.234404 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). May 16 00:03:40.231087 ignition[770]: Ignition finished successfully May 16 00:03:40.246602 systemd[1]: Starting ignition-disks.service - Ignition (disks)... May 16 00:03:40.256044 ignition[780]: Ignition 2.20.0 May 16 00:03:40.256054 ignition[780]: Stage: disks May 16 00:03:40.256223 ignition[780]: no configs at "/usr/lib/ignition/base.d" May 16 00:03:40.258502 systemd[1]: Finished ignition-disks.service - Ignition (disks). May 16 00:03:40.256233 ignition[780]: no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:40.259611 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. May 16 00:03:40.256921 ignition[780]: disks: disks passed May 16 00:03:40.260994 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. May 16 00:03:40.256967 ignition[780]: Ignition finished successfully May 16 00:03:40.262501 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 00:03:40.263920 systemd[1]: Reached target sysinit.target - System Initialization. May 16 00:03:40.265101 systemd[1]: Reached target basic.target - Basic System. May 16 00:03:40.272698 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... May 16 00:03:40.290962 systemd-fsck[792]: ROOT: clean, 14/553520 files, 52654/553472 blocks May 16 00:03:40.296632 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. May 16 00:03:40.310578 systemd[1]: Mounting sysroot.mount - /sysroot... May 16 00:03:40.363454 kernel: EXT4-fs (vda9): mounted filesystem 759e3456-2e58-4307-81e1-19f20d3141c2 r/w with ordered data mode. Quota mode: none. May 16 00:03:40.363562 systemd[1]: Mounted sysroot.mount - /sysroot. May 16 00:03:40.364780 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. May 16 00:03:40.376577 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 00:03:40.378964 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... May 16 00:03:40.380708 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. May 16 00:03:40.380763 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). May 16 00:03:40.380788 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. May 16 00:03:40.385292 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. May 16 00:03:40.388001 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... May 16 00:03:40.394919 kernel: BTRFS: device label OEM devid 1 transid 15 /dev/vda6 scanned by mount (800) May 16 00:03:40.394984 kernel: BTRFS info (device vda6): first mount of filesystem bb522e90-8598-4687-8a48-65ed6b798a46 May 16 00:03:40.394995 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 00:03:40.396458 kernel: BTRFS info (device vda6): using free space tree May 16 00:03:40.399719 kernel: BTRFS info (device vda6): auto enabling async discard May 16 00:03:40.401318 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 00:03:40.447936 initrd-setup-root[824]: cut: /sysroot/etc/passwd: No such file or directory May 16 00:03:40.453484 initrd-setup-root[831]: cut: /sysroot/etc/group: No such file or directory May 16 00:03:40.458820 initrd-setup-root[838]: cut: /sysroot/etc/shadow: No such file or directory May 16 00:03:40.463163 initrd-setup-root[845]: cut: /sysroot/etc/gshadow: No such file or directory May 16 00:03:40.548727 systemd-resolved[279]: Detected conflict on linux IN A 10.0.0.5 May 16 00:03:40.548743 systemd-resolved[279]: Hostname conflict, changing published hostname from 'linux' to 'linux7'. May 16 00:03:40.568048 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. May 16 00:03:40.577625 systemd[1]: Starting ignition-mount.service - Ignition (mount)... May 16 00:03:40.579224 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... May 16 00:03:40.585450 kernel: BTRFS info (device vda6): last unmount of filesystem bb522e90-8598-4687-8a48-65ed6b798a46 May 16 00:03:40.615366 ignition[913]: INFO : Ignition 2.20.0 May 16 00:03:40.615366 ignition[913]: INFO : Stage: mount May 16 00:03:40.618204 ignition[913]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 00:03:40.618204 ignition[913]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:40.618204 ignition[913]: INFO : mount: mount passed May 16 00:03:40.618204 ignition[913]: INFO : Ignition finished successfully May 16 00:03:40.615877 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. May 16 00:03:40.620134 systemd[1]: Finished ignition-mount.service - Ignition (mount). May 16 00:03:40.629651 systemd[1]: Starting ignition-files.service - Ignition (files)... May 16 00:03:40.982720 systemd[1]: sysroot-oem.mount: Deactivated successfully. May 16 00:03:40.992827 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... May 16 00:03:41.000440 kernel: BTRFS: device label OEM devid 1 transid 16 /dev/vda6 scanned by mount (927) May 16 00:03:41.002490 kernel: BTRFS info (device vda6): first mount of filesystem bb522e90-8598-4687-8a48-65ed6b798a46 May 16 00:03:41.002510 kernel: BTRFS info (device vda6): using crc32c (crc32c-generic) checksum algorithm May 16 00:03:41.002521 kernel: BTRFS info (device vda6): using free space tree May 16 00:03:41.006448 kernel: BTRFS info (device vda6): auto enabling async discard May 16 00:03:41.008328 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. May 16 00:03:41.025749 ignition[944]: INFO : Ignition 2.20.0 May 16 00:03:41.025749 ignition[944]: INFO : Stage: files May 16 00:03:41.027280 ignition[944]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 00:03:41.027280 ignition[944]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:41.027280 ignition[944]: DEBUG : files: compiled without relabeling support, skipping May 16 00:03:41.030186 ignition[944]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" May 16 00:03:41.030186 ignition[944]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" May 16 00:03:41.032738 ignition[944]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" May 16 00:03:41.032738 ignition[944]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" May 16 00:03:41.032738 ignition[944]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" May 16 00:03:41.032010 unknown[944]: wrote ssh authorized keys file for user: core May 16 00:03:41.037080 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" May 16 00:03:41.037080 ignition[944]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" May 16 00:03:41.037080 ignition[944]: INFO : files: op(4): [started] processing unit "etcd-member.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(4): op(5): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 16 00:03:41.037080 ignition[944]: INFO : files: op(4): op(5): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" May 16 00:03:41.037080 ignition[944]: INFO : files: op(4): [finished] processing unit "etcd-member.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(6): [started] processing unit "coreos-metadata.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(6): op(7): [started] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(6): op(7): [finished] writing unit "coreos-metadata.service" at "/sysroot/etc/systemd/system/coreos-metadata.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(6): [finished] processing unit "coreos-metadata.service" May 16 00:03:41.037080 ignition[944]: INFO : files: op(8): [started] setting preset to disabled for "coreos-metadata.service" May 16 00:03:41.061980 ignition[944]: INFO : files: op(8): op(9): [started] removing enablement symlink(s) for "coreos-metadata.service" May 16 00:03:41.066183 ignition[944]: INFO : files: op(8): op(9): [finished] removing enablement symlink(s) for "coreos-metadata.service" May 16 00:03:41.067546 ignition[944]: INFO : files: op(8): [finished] setting preset to disabled for "coreos-metadata.service" May 16 00:03:41.067546 ignition[944]: INFO : files: op(a): [started] setting preset to enabled for "etcd-member.service" May 16 00:03:41.067546 ignition[944]: INFO : files: op(a): [finished] setting preset to enabled for "etcd-member.service" May 16 00:03:41.067546 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [started] writing file "/sysroot/etc/.ignition-result.json" May 16 00:03:41.067546 ignition[944]: INFO : files: createResultFile: createFiles: op(b): [finished] writing file "/sysroot/etc/.ignition-result.json" May 16 00:03:41.067546 ignition[944]: INFO : files: files passed May 16 00:03:41.067546 ignition[944]: INFO : Ignition finished successfully May 16 00:03:41.069505 systemd[1]: Finished ignition-files.service - Ignition (files). May 16 00:03:41.076613 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... May 16 00:03:41.078328 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... May 16 00:03:41.079629 systemd[1]: ignition-quench.service: Deactivated successfully. May 16 00:03:41.079733 systemd[1]: Finished ignition-quench.service - Ignition (record completion). May 16 00:03:41.087005 initrd-setup-root-after-ignition[972]: grep: /sysroot/oem/oem-release: No such file or directory May 16 00:03:41.089517 initrd-setup-root-after-ignition[974]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 00:03:41.089517 initrd-setup-root-after-ignition[974]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory May 16 00:03:41.092187 initrd-setup-root-after-ignition[978]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory May 16 00:03:41.092707 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 00:03:41.094785 systemd[1]: Reached target ignition-complete.target - Ignition Complete. May 16 00:03:41.110648 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... May 16 00:03:41.132592 systemd[1]: initrd-parse-etc.service: Deactivated successfully. May 16 00:03:41.132737 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. May 16 00:03:41.134636 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. May 16 00:03:41.136188 systemd[1]: Reached target initrd.target - Initrd Default Target. May 16 00:03:41.137721 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. May 16 00:03:41.147634 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... May 16 00:03:41.161146 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 00:03:41.169650 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... May 16 00:03:41.179526 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. May 16 00:03:41.180655 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 00:03:41.182543 systemd[1]: Stopped target timers.target - Timer Units. May 16 00:03:41.184208 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. May 16 00:03:41.184348 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. May 16 00:03:41.186612 systemd[1]: Stopped target initrd.target - Initrd Default Target. May 16 00:03:41.188381 systemd[1]: Stopped target basic.target - Basic System. May 16 00:03:41.189892 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. May 16 00:03:41.191472 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. May 16 00:03:41.193354 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. May 16 00:03:41.195195 systemd[1]: Stopped target remote-fs.target - Remote File Systems. May 16 00:03:41.196932 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. May 16 00:03:41.198712 systemd[1]: Stopped target sysinit.target - System Initialization. May 16 00:03:41.200501 systemd[1]: Stopped target local-fs.target - Local File Systems. May 16 00:03:41.202151 systemd[1]: Stopped target swap.target - Swaps. May 16 00:03:41.203501 systemd[1]: dracut-pre-mount.service: Deactivated successfully. May 16 00:03:41.203641 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. May 16 00:03:41.205930 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. May 16 00:03:41.207714 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 00:03:41.209471 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. May 16 00:03:41.210527 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 00:03:41.212181 systemd[1]: dracut-initqueue.service: Deactivated successfully. May 16 00:03:41.212317 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. May 16 00:03:41.214943 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. May 16 00:03:41.215070 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). May 16 00:03:41.216768 systemd[1]: Stopped target paths.target - Path Units. May 16 00:03:41.218195 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. May 16 00:03:41.218304 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 00:03:41.220209 systemd[1]: Stopped target slices.target - Slice Units. May 16 00:03:41.221567 systemd[1]: Stopped target sockets.target - Socket Units. May 16 00:03:41.223146 systemd[1]: iscsid.socket: Deactivated successfully. May 16 00:03:41.223248 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. May 16 00:03:41.225024 systemd[1]: iscsiuio.socket: Deactivated successfully. May 16 00:03:41.225118 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. May 16 00:03:41.226454 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. May 16 00:03:41.226580 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. May 16 00:03:41.228065 systemd[1]: ignition-files.service: Deactivated successfully. May 16 00:03:41.228172 systemd[1]: Stopped ignition-files.service - Ignition (files). May 16 00:03:41.239662 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... May 16 00:03:41.240442 systemd[1]: kmod-static-nodes.service: Deactivated successfully. May 16 00:03:41.240592 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. May 16 00:03:41.243241 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... May 16 00:03:41.244127 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. May 16 00:03:41.244269 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. May 16 00:03:41.245516 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. May 16 00:03:41.245634 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. May 16 00:03:41.254251 ignition[998]: INFO : Ignition 2.20.0 May 16 00:03:41.254251 ignition[998]: INFO : Stage: umount May 16 00:03:41.254251 ignition[998]: INFO : no configs at "/usr/lib/ignition/base.d" May 16 00:03:41.254251 ignition[998]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/qemu" May 16 00:03:41.254251 ignition[998]: INFO : umount: umount passed May 16 00:03:41.254251 ignition[998]: INFO : Ignition finished successfully May 16 00:03:41.257679 systemd[1]: initrd-cleanup.service: Deactivated successfully. May 16 00:03:41.257794 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. May 16 00:03:41.259710 systemd[1]: ignition-mount.service: Deactivated successfully. May 16 00:03:41.259812 systemd[1]: Stopped ignition-mount.service - Ignition (mount). May 16 00:03:41.261979 systemd[1]: Stopped target network.target - Network. May 16 00:03:41.263772 systemd[1]: ignition-disks.service: Deactivated successfully. May 16 00:03:41.263851 systemd[1]: Stopped ignition-disks.service - Ignition (disks). May 16 00:03:41.265672 systemd[1]: ignition-kargs.service: Deactivated successfully. May 16 00:03:41.265723 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). May 16 00:03:41.267259 systemd[1]: ignition-setup.service: Deactivated successfully. May 16 00:03:41.267300 systemd[1]: Stopped ignition-setup.service - Ignition (setup). May 16 00:03:41.268877 systemd[1]: ignition-setup-pre.service: Deactivated successfully. May 16 00:03:41.268927 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. May 16 00:03:41.270983 systemd[1]: Stopping systemd-networkd.service - Network Configuration... May 16 00:03:41.272995 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... May 16 00:03:41.275520 systemd[1]: sysroot-boot.mount: Deactivated successfully. May 16 00:03:41.276124 systemd[1]: sysroot-boot.service: Deactivated successfully. May 16 00:03:41.276223 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. May 16 00:03:41.276505 systemd-networkd[764]: eth0: DHCPv6 lease lost May 16 00:03:41.278074 systemd[1]: systemd-networkd.service: Deactivated successfully. May 16 00:03:41.278177 systemd[1]: Stopped systemd-networkd.service - Network Configuration. May 16 00:03:41.280514 systemd[1]: systemd-networkd.socket: Deactivated successfully. May 16 00:03:41.280584 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. May 16 00:03:41.281672 systemd[1]: initrd-setup-root.service: Deactivated successfully. May 16 00:03:41.281725 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. May 16 00:03:41.289577 systemd[1]: Stopping network-cleanup.service - Network Cleanup... May 16 00:03:41.291092 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. May 16 00:03:41.291161 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. May 16 00:03:41.293032 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 00:03:41.295863 systemd[1]: systemd-resolved.service: Deactivated successfully. May 16 00:03:41.295972 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. May 16 00:03:41.299803 systemd[1]: systemd-sysctl.service: Deactivated successfully. May 16 00:03:41.299865 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. May 16 00:03:41.301107 systemd[1]: systemd-modules-load.service: Deactivated successfully. May 16 00:03:41.301169 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. May 16 00:03:41.303250 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. May 16 00:03:41.303299 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 00:03:41.312759 systemd[1]: systemd-udevd.service: Deactivated successfully. May 16 00:03:41.312943 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 00:03:41.314815 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. May 16 00:03:41.314918 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. May 16 00:03:41.316024 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. May 16 00:03:41.316058 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. May 16 00:03:41.317786 systemd[1]: dracut-pre-udev.service: Deactivated successfully. May 16 00:03:41.317838 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. May 16 00:03:41.320333 systemd[1]: dracut-cmdline.service: Deactivated successfully. May 16 00:03:41.320380 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. May 16 00:03:41.323119 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. May 16 00:03:41.323174 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. May 16 00:03:41.339638 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... May 16 00:03:41.340648 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. May 16 00:03:41.340718 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 00:03:41.342717 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. May 16 00:03:41.342776 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. May 16 00:03:41.344898 systemd[1]: network-cleanup.service: Deactivated successfully. May 16 00:03:41.346459 systemd[1]: Stopped network-cleanup.service - Network Cleanup. May 16 00:03:41.348529 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. May 16 00:03:41.348626 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. May 16 00:03:41.351088 systemd[1]: Reached target initrd-switch-root.target - Switch Root. May 16 00:03:41.353523 systemd[1]: Starting initrd-switch-root.service - Switch Root... May 16 00:03:41.365083 systemd[1]: Switching root. May 16 00:03:41.396303 systemd-journald[238]: Journal stopped May 16 00:03:42.150628 systemd-journald[238]: Received SIGTERM from PID 1 (systemd). May 16 00:03:42.150691 kernel: SELinux: policy capability network_peer_controls=1 May 16 00:03:42.150713 kernel: SELinux: policy capability open_perms=1 May 16 00:03:42.150724 kernel: SELinux: policy capability extended_socket_class=1 May 16 00:03:42.150734 kernel: SELinux: policy capability always_check_network=0 May 16 00:03:42.150744 kernel: SELinux: policy capability cgroup_seclabel=1 May 16 00:03:42.150754 kernel: SELinux: policy capability nnp_nosuid_transition=1 May 16 00:03:42.150764 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 May 16 00:03:42.150773 kernel: SELinux: policy capability ioctl_skip_cloexec=0 May 16 00:03:42.150784 kernel: audit: type=1403 audit(1747353821.465:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 May 16 00:03:42.150795 systemd[1]: Successfully loaded SELinux policy in 34.037ms. May 16 00:03:42.150823 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 12.082ms. May 16 00:03:42.150835 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) May 16 00:03:42.150846 systemd[1]: Detected virtualization kvm. May 16 00:03:42.150857 systemd[1]: Detected architecture arm64. May 16 00:03:42.150868 systemd[1]: Detected first boot. May 16 00:03:42.150879 systemd[1]: Initializing machine ID from VM UUID. May 16 00:03:42.150889 zram_generator::config[1043]: No configuration found. May 16 00:03:42.150904 systemd[1]: Populated /etc with preset unit settings. May 16 00:03:42.150917 systemd[1]: initrd-switch-root.service: Deactivated successfully. May 16 00:03:42.150928 systemd[1]: Stopped initrd-switch-root.service - Switch Root. May 16 00:03:42.150939 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. May 16 00:03:42.150950 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. May 16 00:03:42.150962 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. May 16 00:03:42.150973 systemd[1]: Created slice system-getty.slice - Slice /system/getty. May 16 00:03:42.150987 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. May 16 00:03:42.150998 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. May 16 00:03:42.151010 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. May 16 00:03:42.151021 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. May 16 00:03:42.151032 systemd[1]: Created slice user.slice - User and Session Slice. May 16 00:03:42.151043 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. May 16 00:03:42.151055 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. May 16 00:03:42.151067 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. May 16 00:03:42.151079 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. May 16 00:03:42.151091 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. May 16 00:03:42.151102 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... May 16 00:03:42.151114 systemd[1]: Expecting device dev-ttyAMA0.device - /dev/ttyAMA0... May 16 00:03:42.151125 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). May 16 00:03:42.151139 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. May 16 00:03:42.151153 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. May 16 00:03:42.151166 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. May 16 00:03:42.151179 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. May 16 00:03:42.151190 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. May 16 00:03:42.151201 systemd[1]: Reached target remote-fs.target - Remote File Systems. May 16 00:03:42.151212 systemd[1]: Reached target slices.target - Slice Units. May 16 00:03:42.151223 systemd[1]: Reached target swap.target - Swaps. May 16 00:03:42.151235 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. May 16 00:03:42.151246 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. May 16 00:03:42.151257 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. May 16 00:03:42.151268 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. May 16 00:03:42.151281 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. May 16 00:03:42.151293 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. May 16 00:03:42.151303 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... May 16 00:03:42.151315 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... May 16 00:03:42.151326 systemd[1]: Mounting media.mount - External Media Directory... May 16 00:03:42.151337 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... May 16 00:03:42.151348 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... May 16 00:03:42.151361 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... May 16 00:03:42.151375 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). May 16 00:03:42.151388 systemd[1]: Reached target machines.target - Containers. May 16 00:03:42.151407 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... May 16 00:03:42.151419 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 00:03:42.151441 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... May 16 00:03:42.151454 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... May 16 00:03:42.151466 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 00:03:42.151477 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 00:03:42.151488 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 00:03:42.151502 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... May 16 00:03:42.151513 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 00:03:42.151525 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). May 16 00:03:42.151536 systemd[1]: systemd-fsck-root.service: Deactivated successfully. May 16 00:03:42.151547 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. May 16 00:03:42.151558 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. May 16 00:03:42.151569 systemd[1]: Stopped systemd-fsck-usr.service. May 16 00:03:42.151603 systemd[1]: Starting systemd-journald.service - Journal Service... May 16 00:03:42.151619 kernel: ACPI: bus type drm_connector registered May 16 00:03:42.151633 kernel: fuse: init (API version 7.39) May 16 00:03:42.151643 kernel: loop: module loaded May 16 00:03:42.151653 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... May 16 00:03:42.151665 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... May 16 00:03:42.151676 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... May 16 00:03:42.151692 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... May 16 00:03:42.151704 systemd[1]: verity-setup.service: Deactivated successfully. May 16 00:03:42.151715 systemd[1]: Stopped verity-setup.service. May 16 00:03:42.151726 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. May 16 00:03:42.151739 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. May 16 00:03:42.151777 systemd-journald[1121]: Collecting audit messages is disabled. May 16 00:03:42.151801 systemd[1]: Mounted media.mount - External Media Directory. May 16 00:03:42.151812 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. May 16 00:03:42.151824 systemd-journald[1121]: Journal started May 16 00:03:42.151847 systemd-journald[1121]: Runtime Journal (/run/log/journal/c89ab2337ec44786ae2a815a0a27083b) is 5.9M, max 47.3M, 41.4M free. May 16 00:03:41.887116 systemd[1]: Queued start job for default target multi-user.target. May 16 00:03:41.921508 systemd[1]: Unnecessary job was removed for dev-vda6.device - /dev/vda6. May 16 00:03:41.921916 systemd[1]: systemd-journald.service: Deactivated successfully. May 16 00:03:42.154461 systemd[1]: Started systemd-journald.service - Journal Service. May 16 00:03:42.155008 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. May 16 00:03:42.156211 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. May 16 00:03:42.158513 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. May 16 00:03:42.159826 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. May 16 00:03:42.161215 systemd[1]: modprobe@configfs.service: Deactivated successfully. May 16 00:03:42.161391 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. May 16 00:03:42.162787 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 00:03:42.162954 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 00:03:42.164247 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 00:03:42.164415 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 00:03:42.165608 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 00:03:42.165749 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 00:03:42.167445 systemd[1]: modprobe@fuse.service: Deactivated successfully. May 16 00:03:42.167590 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. May 16 00:03:42.168786 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 00:03:42.168946 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 00:03:42.170395 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. May 16 00:03:42.171756 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. May 16 00:03:42.173221 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. May 16 00:03:42.188010 systemd[1]: Reached target network-pre.target - Preparation for Network. May 16 00:03:42.194549 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... May 16 00:03:42.196756 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... May 16 00:03:42.197631 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). May 16 00:03:42.197680 systemd[1]: Reached target local-fs.target - Local File Systems. May 16 00:03:42.199409 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). May 16 00:03:42.201686 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... May 16 00:03:42.206707 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... May 16 00:03:42.207635 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 00:03:42.211706 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... May 16 00:03:42.214034 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... May 16 00:03:42.215129 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 00:03:42.218661 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... May 16 00:03:42.219845 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 00:03:42.223773 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... May 16 00:03:42.228835 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... May 16 00:03:42.233768 systemd-journald[1121]: Time spent on flushing to /var/log/journal/c89ab2337ec44786ae2a815a0a27083b is 15.210ms for 830 entries. May 16 00:03:42.233768 systemd-journald[1121]: System Journal (/var/log/journal/c89ab2337ec44786ae2a815a0a27083b) is 8.0M, max 195.6M, 187.6M free. May 16 00:03:42.265504 systemd-journald[1121]: Received client request to flush runtime journal. May 16 00:03:42.248621 systemd[1]: Starting systemd-sysusers.service - Create System Users... May 16 00:03:42.251197 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. May 16 00:03:42.252504 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. May 16 00:03:42.253647 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. May 16 00:03:42.255106 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. May 16 00:03:42.256763 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. May 16 00:03:42.271528 kernel: loop0: detected capacity change from 0 to 116808 May 16 00:03:42.272500 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. May 16 00:03:42.275752 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. May 16 00:03:42.279194 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. May 16 00:03:42.288538 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher May 16 00:03:42.288814 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... May 16 00:03:42.293654 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... May 16 00:03:42.308046 udevadm[1173]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation.service, lvm2-activation-early.service not to pull it in. May 16 00:03:42.319884 kernel: loop1: detected capacity change from 0 to 113536 May 16 00:03:42.317773 systemd[1]: Finished systemd-sysusers.service - Create System Users. May 16 00:03:42.328619 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... May 16 00:03:42.330371 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. May 16 00:03:42.332518 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. May 16 00:03:42.364608 kernel: loop2: detected capacity change from 0 to 116808 May 16 00:03:42.366513 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. May 16 00:03:42.369491 kernel: loop3: detected capacity change from 0 to 113536 May 16 00:03:42.367002 systemd-tmpfiles[1175]: ACLs are not supported, ignoring. May 16 00:03:42.372339 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. May 16 00:03:42.374875 (sd-merge)[1179]: Using extensions 'containerd-flatcar', 'docker-flatcar'. May 16 00:03:42.375229 (sd-merge)[1179]: Merged extensions into '/usr'. May 16 00:03:42.377897 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. May 16 00:03:42.394764 systemd[1]: Starting ensure-sysext.service... May 16 00:03:42.399726 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... May 16 00:03:42.420893 systemd[1]: Reloading requested from client PID 1182 ('systemctl') (unit ensure-sysext.service)... May 16 00:03:42.420913 systemd[1]: Reloading... May 16 00:03:42.445824 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. May 16 00:03:42.446119 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. May 16 00:03:42.446882 systemd-tmpfiles[1183]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. May 16 00:03:42.447138 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. May 16 00:03:42.447186 systemd-tmpfiles[1183]: ACLs are not supported, ignoring. May 16 00:03:42.450880 systemd-tmpfiles[1183]: Detected autofs mount point /boot during canonicalization of boot. May 16 00:03:42.451086 systemd-tmpfiles[1183]: Skipping /boot May 16 00:03:42.458951 systemd-tmpfiles[1183]: Detected autofs mount point /boot during canonicalization of boot. May 16 00:03:42.459114 systemd-tmpfiles[1183]: Skipping /boot May 16 00:03:42.510847 zram_generator::config[1213]: No configuration found. May 16 00:03:42.522509 ldconfig[1150]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. May 16 00:03:42.636550 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. May 16 00:03:42.673468 systemd[1]: Reloading finished in 252 ms. May 16 00:03:42.707601 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. May 16 00:03:42.708876 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. May 16 00:03:42.728159 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 00:03:42.730542 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... May 16 00:03:42.735626 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... May 16 00:03:42.738722 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... May 16 00:03:42.754170 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... May 16 00:03:42.759658 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 00:03:42.760971 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 00:03:42.771213 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 00:03:42.773547 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 00:03:42.774632 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 00:03:42.780715 systemd[1]: Starting systemd-userdbd.service - User Database Manager... May 16 00:03:42.782943 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 00:03:42.784883 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 00:03:42.786757 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. May 16 00:03:42.789970 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 00:03:42.790115 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 00:03:42.791738 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 00:03:42.791869 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 00:03:42.801901 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. May 16 00:03:42.809980 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 00:03:42.812102 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 00:03:42.814949 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 00:03:42.817504 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... May 16 00:03:42.819051 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 00:03:42.821840 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... May 16 00:03:42.826767 systemd[1]: Starting systemd-update-done.service - Update is Completed... May 16 00:03:42.828634 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. May 16 00:03:42.837782 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. May 16 00:03:42.839189 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 00:03:42.839320 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 00:03:42.840688 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 00:03:42.840817 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 00:03:42.873492 systemd[1]: Finished systemd-update-done.service - Update is Completed. May 16 00:03:42.876081 systemd[1]: Started systemd-userdbd.service - User Database Manager. May 16 00:03:42.877819 systemd[1]: modprobe@loop.service: Deactivated successfully. May 16 00:03:42.877995 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. May 16 00:03:42.878133 systemd-udevd[1279]: Using default interface naming scheme 'v255'. May 16 00:03:42.882482 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. May 16 00:03:42.884565 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... May 16 00:03:42.888792 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... May 16 00:03:42.894214 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... May 16 00:03:42.895557 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. May 16 00:03:42.895643 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). May 16 00:03:42.896222 systemd[1]: Finished ensure-sysext.service. May 16 00:03:42.897373 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. May 16 00:03:42.897540 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. May 16 00:03:42.899178 augenrules[1301]: No rules May 16 00:03:42.900746 systemd[1]: audit-rules.service: Deactivated successfully. May 16 00:03:42.900930 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 00:03:42.902274 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. May 16 00:03:42.902464 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. May 16 00:03:42.903702 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. May 16 00:03:42.904984 systemd[1]: modprobe@drm.service: Deactivated successfully. May 16 00:03:42.905131 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. May 16 00:03:42.920919 systemd[1]: Starting systemd-networkd.service - Network Configuration... May 16 00:03:42.921837 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). May 16 00:03:42.921917 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. May 16 00:03:42.925356 systemd[1]: Starting systemd-timesyncd.service - Network Time Synchronization... May 16 00:03:42.958376 systemd-resolved[1252]: Positive Trust Anchors: May 16 00:03:42.961906 systemd-resolved[1252]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d May 16 00:03:42.961959 systemd-resolved[1252]: Negative trust anchors: home.arpa 10.in-addr.arpa 16.172.in-addr.arpa 17.172.in-addr.arpa 18.172.in-addr.arpa 19.172.in-addr.arpa 20.172.in-addr.arpa 21.172.in-addr.arpa 22.172.in-addr.arpa 23.172.in-addr.arpa 24.172.in-addr.arpa 25.172.in-addr.arpa 26.172.in-addr.arpa 27.172.in-addr.arpa 28.172.in-addr.arpa 29.172.in-addr.arpa 30.172.in-addr.arpa 31.172.in-addr.arpa 170.0.0.192.in-addr.arpa 171.0.0.192.in-addr.arpa 168.192.in-addr.arpa d.f.ip6.arpa ipv4only.arpa resolver.arpa corp home internal intranet lan local private test May 16 00:03:42.966148 systemd[1]: Condition check resulted in dev-ttyAMA0.device - /dev/ttyAMA0 being skipped. May 16 00:03:42.985458 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1317) May 16 00:03:43.035761 systemd-resolved[1252]: Defaulting to hostname 'linux'. May 16 00:03:43.038363 systemd-networkd[1320]: lo: Link UP May 16 00:03:43.038372 systemd-networkd[1320]: lo: Gained carrier May 16 00:03:43.043095 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM. May 16 00:03:43.044606 systemd[1]: Started systemd-resolved.service - Network Name Resolution. May 16 00:03:43.044972 systemd-networkd[1320]: Enumeration completed May 16 00:03:43.045652 systemd[1]: Started systemd-networkd.service - Network Configuration. May 16 00:03:43.046840 systemd[1]: Reached target network.target - Network. May 16 00:03:43.047626 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. May 16 00:03:43.049240 systemd-networkd[1320]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 00:03:43.049249 systemd-networkd[1320]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. May 16 00:03:43.050089 systemd-networkd[1320]: eth0: Link UP May 16 00:03:43.050101 systemd-networkd[1320]: eth0: Gained carrier May 16 00:03:43.050117 systemd-networkd[1320]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. May 16 00:03:43.065783 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... May 16 00:03:43.069030 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... May 16 00:03:43.074608 systemd[1]: Started systemd-timesyncd.service - Network Time Synchronization. May 16 00:03:43.075669 systemd[1]: Reached target time-set.target - System Time Set. May 16 00:03:43.083637 systemd-networkd[1320]: eth0: DHCPv4 address 10.0.0.5/16, gateway 10.0.0.1 acquired from 10.0.0.1 May 16 00:03:43.086617 systemd-timesyncd[1328]: Network configuration changed, trying to establish connection. May 16 00:03:43.087575 systemd-timesyncd[1328]: Contacted time server 10.0.0.1:123 (10.0.0.1). May 16 00:03:43.087638 systemd-timesyncd[1328]: Initial clock synchronization to Fri 2025-05-16 00:03:43.030528 UTC. May 16 00:03:43.093768 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. May 16 00:03:43.108620 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... May 16 00:03:43.109880 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. May 16 00:03:43.116136 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... May 16 00:03:43.153063 lvm[1349]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 16 00:03:43.160846 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. May 16 00:03:43.192966 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. May 16 00:03:43.194181 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. May 16 00:03:43.195112 systemd[1]: Reached target sysinit.target - System Initialization. May 16 00:03:43.196057 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. May 16 00:03:43.197034 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. May 16 00:03:43.198135 systemd[1]: Started logrotate.timer - Daily rotation of log files. May 16 00:03:43.199065 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. May 16 00:03:43.200242 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. May 16 00:03:43.201187 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). May 16 00:03:43.201224 systemd[1]: Reached target paths.target - Path Units. May 16 00:03:43.201942 systemd[1]: Reached target timers.target - Timer Units. May 16 00:03:43.203543 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. May 16 00:03:43.205819 systemd[1]: Starting docker.socket - Docker Socket for the API... May 16 00:03:43.223720 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. May 16 00:03:43.226373 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... May 16 00:03:43.228095 systemd[1]: Listening on docker.socket - Docker Socket for the API. May 16 00:03:43.229122 systemd[1]: Reached target sockets.target - Socket Units. May 16 00:03:43.229938 systemd[1]: Reached target basic.target - Basic System. May 16 00:03:43.230694 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. May 16 00:03:43.230732 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. May 16 00:03:43.231857 systemd[1]: Starting containerd.service - containerd container runtime... May 16 00:03:43.233906 systemd[1]: Starting dbus.service - D-Bus System Message Bus... May 16 00:03:43.236594 lvm[1357]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. May 16 00:03:43.237620 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... May 16 00:03:43.241795 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... May 16 00:03:43.242855 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). May 16 00:03:43.244277 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... May 16 00:03:43.249707 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... May 16 00:03:43.257672 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... May 16 00:03:43.264542 extend-filesystems[1361]: Found loop2 May 16 00:03:43.264542 extend-filesystems[1361]: Found loop3 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda May 16 00:03:43.264542 extend-filesystems[1361]: Found vda1 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda2 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda3 May 16 00:03:43.264542 extend-filesystems[1361]: Found usr May 16 00:03:43.264542 extend-filesystems[1361]: Found vda4 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda6 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda7 May 16 00:03:43.264542 extend-filesystems[1361]: Found vda9 May 16 00:03:43.264542 extend-filesystems[1361]: Checking size of /dev/vda9 May 16 00:03:43.276449 jq[1360]: false May 16 00:03:43.265769 systemd[1]: Starting systemd-logind.service - User Login Management... May 16 00:03:43.282900 extend-filesystems[1361]: Old size kept for /dev/vda9 May 16 00:03:43.275107 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). May 16 00:03:43.280803 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. May 16 00:03:43.283078 systemd[1]: Starting update-engine.service - Update Engine... May 16 00:03:43.290611 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... May 16 00:03:43.291675 dbus-daemon[1359]: [system] SELinux support is enabled May 16 00:03:43.293411 systemd[1]: Started dbus.service - D-Bus System Message Bus. May 16 00:03:43.296446 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1325) May 16 00:03:43.297748 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. May 16 00:03:43.303121 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. May 16 00:03:43.303310 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. May 16 00:03:43.303732 systemd[1]: extend-filesystems.service: Deactivated successfully. May 16 00:03:43.305013 jq[1380]: true May 16 00:03:43.306408 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. May 16 00:03:43.307730 systemd[1]: motdgen.service: Deactivated successfully. May 16 00:03:43.307905 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. May 16 00:03:43.311130 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. May 16 00:03:43.311302 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. May 16 00:03:43.323626 (ntainerd)[1384]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR May 16 00:03:43.327023 jq[1383]: true May 16 00:03:43.342620 systemd-logind[1371]: Watching system buttons on /dev/input/event0 (Power Button) May 16 00:03:43.346614 systemd-logind[1371]: New seat seat0. May 16 00:03:43.353863 systemd[1]: Started systemd-logind.service - User Login Management. May 16 00:03:43.355223 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). May 16 00:03:43.355263 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. May 16 00:03:43.356304 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). May 16 00:03:43.356330 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. May 16 00:03:43.400577 update_engine[1379]: I20250516 00:03:43.400164 1379 main.cc:92] Flatcar Update Engine starting May 16 00:03:43.404212 systemd[1]: Started update-engine.service - Update Engine. May 16 00:03:43.404351 update_engine[1379]: I20250516 00:03:43.404232 1379 update_check_scheduler.cc:74] Next update check in 7m58s May 16 00:03:43.411983 bash[1408]: Updated "/home/core/.ssh/authorized_keys" May 16 00:03:43.415017 systemd[1]: Started locksmithd.service - Cluster reboot manager. May 16 00:03:43.416545 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. May 16 00:03:43.418733 systemd[1]: sshkeys.service was skipped because no trigger condition checks were met. May 16 00:03:43.451940 locksmithd[1414]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="etcd-lock" May 16 00:03:43.547842 containerd[1384]: time="2025-05-16T00:03:43.545855160Z" level=info msg="starting containerd" revision=9b2ad7760328148397346d10c7b2004271249db4 version=v1.7.23 May 16 00:03:43.576597 containerd[1384]: time="2025-05-16T00:03:43.576525760Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578196 containerd[1384]: time="2025-05-16T00:03:43.578130440Z" 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.90-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 May 16 00:03:43.578196 containerd[1384]: time="2025-05-16T00:03:43.578171560Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 May 16 00:03:43.578196 containerd[1384]: time="2025-05-16T00:03:43.578189440Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 May 16 00:03:43.578378 containerd[1384]: time="2025-05-16T00:03:43.578358400Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 May 16 00:03:43.578421 containerd[1384]: time="2025-05-16T00:03:43.578381280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578487 containerd[1384]: time="2025-05-16T00:03:43.578470080Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 May 16 00:03:43.578507 containerd[1384]: time="2025-05-16T00:03:43.578488240Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578685 containerd[1384]: time="2025-05-16T00:03:43.578654120Z" 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 May 16 00:03:43.578685 containerd[1384]: time="2025-05-16T00:03:43.578675520Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578725 containerd[1384]: time="2025-05-16T00:03:43.578689440Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 May 16 00:03:43.578725 containerd[1384]: time="2025-05-16T00:03:43.578700400Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578786 containerd[1384]: time="2025-05-16T00:03:43.578771880Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.578993 containerd[1384]: time="2025-05-16T00:03:43.578966480Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 May 16 00:03:43.579080 containerd[1384]: time="2025-05-16T00:03:43.579065000Z" 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 May 16 00:03:43.579102 containerd[1384]: time="2025-05-16T00:03:43.579082080Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 May 16 00:03:43.579165 containerd[1384]: time="2025-05-16T00:03:43.579151880Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 May 16 00:03:43.579211 containerd[1384]: time="2025-05-16T00:03:43.579199960Z" level=info msg="metadata content store policy set" policy=shared May 16 00:03:43.582385 containerd[1384]: time="2025-05-16T00:03:43.582349000Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 May 16 00:03:43.582472 containerd[1384]: time="2025-05-16T00:03:43.582410600Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 May 16 00:03:43.582472 containerd[1384]: time="2025-05-16T00:03:43.582444880Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 May 16 00:03:43.582472 containerd[1384]: time="2025-05-16T00:03:43.582462480Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 May 16 00:03:43.582542 containerd[1384]: time="2025-05-16T00:03:43.582482800Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 May 16 00:03:43.582682 containerd[1384]: time="2025-05-16T00:03:43.582644920Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 May 16 00:03:43.583011 containerd[1384]: time="2025-05-16T00:03:43.582980320Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 May 16 00:03:43.583111 containerd[1384]: time="2025-05-16T00:03:43.583086520Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 May 16 00:03:43.583135 containerd[1384]: time="2025-05-16T00:03:43.583109720Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 May 16 00:03:43.583135 containerd[1384]: time="2025-05-16T00:03:43.583124320Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583139440Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583152760Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583165600Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583178240Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583191880Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583204560Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583220 containerd[1384]: time="2025-05-16T00:03:43.583217360Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583229480Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583250240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583264200Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583276000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583287800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583299600Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583312440Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583323840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583334 containerd[1384]: time="2025-05-16T00:03:43.583335960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583349480Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583364240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583377040Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583389080Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583410520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583444040Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583467240Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583480360Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583521 containerd[1384]: time="2025-05-16T00:03:43.583498640Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 May 16 00:03:43.583738 containerd[1384]: time="2025-05-16T00:03:43.583707640Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 May 16 00:03:43.583738 containerd[1384]: time="2025-05-16T00:03:43.583730720Z" 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 May 16 00:03:43.583787 containerd[1384]: time="2025-05-16T00:03:43.583742720Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 May 16 00:03:43.583787 containerd[1384]: time="2025-05-16T00:03:43.583754160Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 May 16 00:03:43.583787 containerd[1384]: time="2025-05-16T00:03:43.583763320Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 May 16 00:03:43.583787 containerd[1384]: time="2025-05-16T00:03:43.583774760Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 May 16 00:03:43.583787 containerd[1384]: time="2025-05-16T00:03:43.583784880Z" level=info msg="NRI interface is disabled by configuration." May 16 00:03:43.583871 containerd[1384]: time="2025-05-16T00:03:43.583794840Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 May 16 00:03:43.584176 containerd[1384]: time="2025-05-16T00:03:43.584126600Z" 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}" May 16 00:03:43.584176 containerd[1384]: time="2025-05-16T00:03:43.584176640Z" level=info msg="Connect containerd service" May 16 00:03:43.584303 containerd[1384]: time="2025-05-16T00:03:43.584210240Z" level=info msg="using legacy CRI server" May 16 00:03:43.584303 containerd[1384]: time="2025-05-16T00:03:43.584217000Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" May 16 00:03:43.584488 containerd[1384]: time="2025-05-16T00:03:43.584472400Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" May 16 00:03:43.585180 containerd[1384]: time="2025-05-16T00:03:43.585154560Z" 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" May 16 00:03:43.585866 containerd[1384]: time="2025-05-16T00:03:43.585720920Z" level=info msg="Start subscribing containerd event" May 16 00:03:43.585866 containerd[1384]: time="2025-05-16T00:03:43.585790760Z" level=info msg="Start recovering state" May 16 00:03:43.585937 containerd[1384]: time="2025-05-16T00:03:43.585906960Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc May 16 00:03:43.585997 containerd[1384]: time="2025-05-16T00:03:43.585983240Z" level=info msg="Start event monitor" May 16 00:03:43.586077 containerd[1384]: time="2025-05-16T00:03:43.586063440Z" level=info msg="Start snapshots syncer" May 16 00:03:43.586124 containerd[1384]: time="2025-05-16T00:03:43.586113200Z" level=info msg="Start cni network conf syncer for default" May 16 00:03:43.586182 containerd[1384]: time="2025-05-16T00:03:43.586169240Z" level=info msg="Start streaming server" May 16 00:03:43.586288 containerd[1384]: time="2025-05-16T00:03:43.586002560Z" level=info msg=serving... address=/run/containerd/containerd.sock May 16 00:03:43.586527 systemd[1]: Started containerd.service - containerd container runtime. May 16 00:03:43.588933 containerd[1384]: time="2025-05-16T00:03:43.587582560Z" level=info msg="containerd successfully booted in 0.043282s" May 16 00:03:44.703828 sshd_keygen[1378]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 May 16 00:03:44.710599 systemd-networkd[1320]: eth0: Gained IPv6LL May 16 00:03:44.716067 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. May 16 00:03:44.717581 systemd[1]: Reached target network-online.target - Network is Online. May 16 00:03:44.725718 systemd[1]: Starting coreos-metadata.service - QEMU metadata agent... May 16 00:03:44.727503 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... May 16 00:03:44.728652 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. May 16 00:03:44.732657 systemd[1]: Starting issuegen.service - Generate /run/issue... May 16 00:03:44.741852 systemd[1]: issuegen.service: Deactivated successfully. May 16 00:03:44.742053 systemd[1]: Finished issuegen.service - Generate /run/issue. May 16 00:03:44.743400 systemd[1]: coreos-metadata.service: Deactivated successfully. May 16 00:03:44.743601 systemd[1]: Finished coreos-metadata.service - QEMU metadata agent. May 16 00:03:44.746719 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... May 16 00:03:44.748597 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. May 16 00:03:44.749779 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... May 16 00:03:44.751107 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. May 16 00:03:44.751415 (-wrapper)[1450]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS May 16 00:03:44.763964 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. May 16 00:03:44.778848 systemd[1]: Started getty@tty1.service - Getty on tty1. May 16 00:03:44.781758 systemd[1]: Started serial-getty@ttyAMA0.service - Serial Getty on ttyAMA0. May 16 00:03:44.782818 systemd[1]: Reached target getty.target - Login Prompts. May 16 00:03:44.888697 systemd[1]: Starting docker.service - Docker Application Container Engine... May 16 00:03:44.888880 (dockerd)[1468]: 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 May 16 00:03:45.157797 dockerd[1468]: time="2025-05-16T00:03:45.157678780Z" level=info msg="Starting up" May 16 00:03:45.254715 dockerd[1468]: time="2025-05-16T00:03:45.254668783Z" level=info msg="Loading containers: start." May 16 00:03:45.411453 kernel: Initializing XFRM netlink socket May 16 00:03:45.489943 systemd-networkd[1320]: docker0: Link UP May 16 00:03:45.528840 dockerd[1468]: time="2025-05-16T00:03:45.528776084Z" level=info msg="Loading containers: done." May 16 00:03:45.542606 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1787907933-merged.mount: Deactivated successfully. May 16 00:03:45.543864 dockerd[1468]: time="2025-05-16T00:03:45.543789843Z" 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 May 16 00:03:45.543952 dockerd[1468]: time="2025-05-16T00:03:45.543914861Z" level=info msg="Docker daemon" commit=8b539b8df24032dabeaaa099cf1d0535ef0286a3 containerd-snapshotter=false storage-driver=overlay2 version=27.2.1 May 16 00:03:45.544042 dockerd[1468]: time="2025-05-16T00:03:45.544023501Z" level=info msg="Daemon has completed initialization" May 16 00:03:45.573201 dockerd[1468]: time="2025-05-16T00:03:45.573107642Z" level=info msg="API listen on /run/docker.sock" May 16 00:03:45.573285 systemd[1]: Started docker.service - Docker Application Container Engine. May 16 00:03:45.574545 etcd-wrapper[1456]: Error response from daemon: No such container: etcd-member May 16 00:03:45.587820 etcd-wrapper[1644]: Error response from daemon: No such container: etcd-member May 16 00:03:45.622292 etcd-wrapper[1665]: Unable to find image 'quay.io/coreos/etcd:v3.5.0' locally May 16 00:03:46.620044 etcd-wrapper[1665]: v3.5.0: Pulling from coreos/etcd May 16 00:03:46.867736 etcd-wrapper[1665]: 6022c6b01d76: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 1d97b1ec77fc: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 99ef4b690837: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 435b7bf0967c: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 17e4a5f7c1b5: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 5b0292999756: Pulling fs layer May 16 00:03:46.867736 etcd-wrapper[1665]: 435b7bf0967c: Waiting May 16 00:03:46.867736 etcd-wrapper[1665]: 17e4a5f7c1b5: Waiting May 16 00:03:46.867736 etcd-wrapper[1665]: 5b0292999756: Waiting May 16 00:03:47.065584 etcd-wrapper[1665]: 1d97b1ec77fc: Verifying Checksum May 16 00:03:47.065584 etcd-wrapper[1665]: 1d97b1ec77fc: Download complete May 16 00:03:47.216741 etcd-wrapper[1665]: 6022c6b01d76: Verifying Checksum May 16 00:03:47.216741 etcd-wrapper[1665]: 6022c6b01d76: Download complete May 16 00:03:47.321044 etcd-wrapper[1665]: 99ef4b690837: Verifying Checksum May 16 00:03:47.321044 etcd-wrapper[1665]: 99ef4b690837: Download complete May 16 00:03:47.350072 etcd-wrapper[1665]: 17e4a5f7c1b5: Verifying Checksum May 16 00:03:47.350226 etcd-wrapper[1665]: 17e4a5f7c1b5: Download complete May 16 00:03:47.592507 etcd-wrapper[1665]: 435b7bf0967c: Verifying Checksum May 16 00:03:47.592507 etcd-wrapper[1665]: 435b7bf0967c: Download complete May 16 00:03:47.670257 etcd-wrapper[1665]: 5b0292999756: Verifying Checksum May 16 00:03:47.670654 etcd-wrapper[1665]: 5b0292999756: Download complete May 16 00:03:47.796404 etcd-wrapper[1665]: 6022c6b01d76: Pull complete May 16 00:03:47.881516 systemd[1]: var-lib-docker-overlay2-afbf68505c27c72b66acee83aaa235461d5c555e68f151d4e094a39572590f83-merged.mount: Deactivated successfully. May 16 00:03:48.043150 etcd-wrapper[1665]: 1d97b1ec77fc: Pull complete May 16 00:03:48.114355 systemd[1]: var-lib-docker-overlay2-c3293b27086cbe34895600d00879d45ed029fb37084f681ec45a78129cbfc325-merged.mount: Deactivated successfully. May 16 00:03:48.165305 etcd-wrapper[1665]: 99ef4b690837: Pull complete May 16 00:03:48.254480 etcd-wrapper[1665]: 435b7bf0967c: Pull complete May 16 00:03:48.271393 etcd-wrapper[1665]: 17e4a5f7c1b5: Pull complete May 16 00:03:48.286960 etcd-wrapper[1665]: 5b0292999756: Pull complete May 16 00:03:48.293061 etcd-wrapper[1665]: Digest: sha256:28759af54acd6924b2191dc1a1d096e2fa2e219717a21b9d8edf89717db3631b May 16 00:03:48.295194 etcd-wrapper[1665]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0 May 16 00:03:48.453950 locksmithd[1414]: Unlocking old locks failed: error setting up lock: Error initializing etcd client: no etcd endpoints available, tried: http://127.0.0.1:2379,http://127.0.0.1:4001. Retrying in 10s. May 16 00:03:48.456585 containerd[1384]: time="2025-05-16T00:03:48.456482828Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 May 16 00:03:48.456585 containerd[1384]: time="2025-05-16T00:03:48.456541662Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 May 16 00:03:48.456585 containerd[1384]: time="2025-05-16T00:03:48.456553253Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 00:03:48.457073 containerd[1384]: time="2025-05-16T00:03:48.456622324Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 May 16 00:03:48.476581 systemd[1]: Started docker-e8866dbbaad72b249cad45e3d8f49e5f688825e7e2d0d7268593e74d1bca4ab1.scope - libcontainer container e8866dbbaad72b249cad45e3d8f49e5f688825e7e2d0d7268593e74d1bca4ab1. May 16 00:03:48.488929 systemd-resolved[1252]: Failed to determine the local hostname and LLMNR/mDNS names, ignoring: No such device or address May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"info","ts":1747353828.5568075,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"info","ts":1747353828.5568912,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"c89ab2337ec44786ae2a815a0a27083b"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"warn","ts":1747353828.5569155,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"warn","ts":1747353828.5569227,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"warn","ts":1747353828.556928,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"warn","ts":1747353828.5569322,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"warn","ts":1747353828.5569372,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} May 16 00:03:48.557144 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.557Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://10.0.0.5:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://10.0.0.5:2380","--advertise-client-urls=http://10.0.0.5:2379","--discovery=http://10.0.0.1:34303/v2/keys/discovery/7093638687355712455","--enable-v2=true"]} May 16 00:03:48.557698 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.557Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://10.0.0.5:2380"]} May 16 00:03:48.557698 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.557Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} May 16 00:03:48.557698 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.557Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":4,"max-cpu-available":4,"member-initialized":false,"name":"c89ab2337ec44786ae2a815a0a27083b","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://10.0.0.5:2380"],"listen-peer-urls":["http://10.0.0.5:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"c89ab2337ec44786ae2a815a0a27083b=http://10.0.0.5:2380","initial-cluster-state":"new","initial-cluster-token":"http://10.0.0.1:34303/v2/keys/discovery/7093638687355712455","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"http://10.0.0.1:34303/v2/keys/discovery/7093638687355712455","discovery-proxy":"","downgrade-check-interval":"5s"} May 16 00:03:48.559881 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.559Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.78294ms"} May 16 00:03:48.563142 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.562Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"http://10.0.0.1:34303","self":"df32afb9f4da98ab"} May 16 00:03:48.563142 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.562Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:34303","found-peers":1,"needed-peers":2} May 16 00:03:48.574760 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.574Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:34303","peer":"ef4444803e161db9"} May 16 00:03:48.574760 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.574Z","caller":"v2discovery/discovery.go:352","msg":"found peers from discovery server; waiting for more","discovery-url":"http://10.0.0.1:34303","found-peers":2,"needed-peers":1} May 16 00:03:48.685478 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.685Z","caller":"v2discovery/discovery.go:371","msg":"found peer from discovery server","discovery-url":"http://10.0.0.1:34303","peer":"f4db7ff082ef6592"} May 16 00:03:48.685478 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.685Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"http://10.0.0.1:34303","found-peers":3} May 16 00:03:48.688633 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"df32afb9f4da98ab","cluster-id":"17443957d0c52b5e"} May 16 00:03:48.688633 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=()"} May 16 00:03:48.688633 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab became follower at term 0"} May 16 00:03:48.688633 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft df32afb9f4da98ab [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} May 16 00:03:48.688633 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab became follower at term 1"} May 16 00:03:48.688920 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723)"} May 16 00:03:48.688920 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723 17240980591069240761)"} May 16 00:03:48.688920 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723 17240980591069240761 17643836636119655826)"} May 16 00:03:48.689458 etcd-wrapper[1665]: {"level":"warn","ts":"2025-05-16T00:03:48.689Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} May 16 00:03:48.690762 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.690Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} May 16 00:03:48.691471 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.691Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} May 16 00:03:48.692004 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.691Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.692004 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.691Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.692788 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.692Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.693119 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.692Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.694179 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.693Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.694179 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.693Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.694179 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.694Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9","remote-peer-urls":["http://10.0.0.7:2380"]} May 16 00:03:48.694321 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.694Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.694321 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.694Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.694580 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.694Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.695180 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.694Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.696230 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.695Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.697055 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.696Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.697055 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.696Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592","remote-peer-urls":["http://10.0.0.6:2380"]} May 16 00:03:48.697055 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.696Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"df32afb9f4da98ab","local-server-version":"3.5.0","cluster-version":"to_be_decided"} May 16 00:03:48.697055 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.696Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.697055 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.696Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.697639 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} May 16 00:03:48.697956 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723 17240980591069240761 17643836636119655826)"} May 16 00:03:48.698094 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"17443957d0c52b5e","local-member-id":"df32afb9f4da98ab","added-peer-id":"df32afb9f4da98ab","added-peer-peer-urls":["http://10.0.0.5:2380"]} May 16 00:03:48.698094 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723 17240980591069240761 17643836636119655826)"} May 16 00:03:48.698094 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"17443957d0c52b5e","local-member-id":"df32afb9f4da98ab","added-peer-id":"ef4444803e161db9","added-peer-peer-urls":["http://10.0.0.7:2380"]} May 16 00:03:48.698312 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"ef4444803e161db9"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.697Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab switched to configuration voters=(16083110432505239723 17240980591069240761 17643836636119655826)"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"10.0.0.5:2380"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"warn","ts":"2025-05-16T00:03:48.698Z","caller":"embed/etcd.go:700","msg":"Flag `enable-v2` is deprecated and will get removed in etcd 3.6."} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"10.0.0.5:2380"} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"17443957d0c52b5e","local-member-id":"df32afb9f4da98ab","added-peer-id":"f4db7ff082ef6592","added-peer-peer-urls":["http://10.0.0.6:2380"]} May 16 00:03:48.698828 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"df32afb9f4da98ab","initial-advertise-peer-urls":["http://10.0.0.5:2380"],"listen-peer-urls":["http://10.0.0.5:2380"],"advertise-client-urls":["http://10.0.0.5:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"df32afb9f4da98ab","to":"ef4444803e161db9","stream-type":"stream Message"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"df32afb9f4da98ab","to":"f4db7ff082ef6592","stream-type":"stream MsgApp v2"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"f4db7ff082ef6592"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"df32afb9f4da98ab","to":"f4db7ff082ef6592","stream-type":"stream Message"} May 16 00:03:48.699594 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.698Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.702091 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.701Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.702227 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.701Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"f4db7ff082ef6592"} May 16 00:03:48.702312 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.701Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"df32afb9f4da98ab","to":"ef4444803e161db9","stream-type":"stream MsgApp v2"} May 16 00:03:48.702312 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.702Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"df32afb9f4da98ab","remote-peer-id":"ef4444803e161db9"} May 16 00:03:48.747867 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.747Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"df32afb9f4da98ab","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} May 16 00:03:48.804654 systemd[1]: var-lib-docker-overlay2-736a4b32dba656787d4163fd21e302006a26930f5036319e33a60891ce56afab-merged.mount: Deactivated successfully. May 16 00:03:48.889834 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab [logterm: 1, index: 3, vote: 0] cast MsgPreVote for f4db7ff082ef6592 [logterm: 1, index: 3] at term 1"} May 16 00:03:48.896690 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab [term: 1] received a MsgVote message with higher term from f4db7ff082ef6592 [term: 2]"} May 16 00:03:48.896690 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab became follower at term 2"} May 16 00:03:48.896690 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"df32afb9f4da98ab [logterm: 1, index: 3, vote: 0] cast MsgVote for f4db7ff082ef6592 [logterm: 1, index: 3] at term 2"} May 16 00:03:48.903341 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: df32afb9f4da98ab elected leader f4db7ff082ef6592 at term 2"} May 16 00:03:48.928908 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.928Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"df32afb9f4da98ab","local-member-attributes":"{Name:c89ab2337ec44786ae2a815a0a27083b ClientURLs:[http://10.0.0.5:2379]}","request-path":"/0/members/df32afb9f4da98ab/attributes","cluster-id":"17443957d0c52b5e","publish-timeout":"7s"} May 16 00:03:48.928908 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.928Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} May 16 00:03:48.929042 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.928Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} May 16 00:03:48.929125 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.929Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} May 16 00:03:48.929292 systemd[1]: Started etcd-member.service - etcd (System Application Container). May 16 00:03:48.930650 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.929Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} May 16 00:03:48.930650 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.930Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"17443957d0c52b5e","local-member-id":"df32afb9f4da98ab","cluster-version":"3.5"} May 16 00:03:48.930650 etcd-wrapper[1665]: {"level":"info","ts":"2025-05-16T00:03:48.930Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} May 16 00:03:48.931004 systemd[1]: Reached target multi-user.target - Multi-User System. May 16 00:03:48.935484 systemd[1]: Startup finished in 618ms (kernel) + 3.751s (initrd) + 7.503s (userspace) = 11.874s. May 16 00:03:50.390343 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. May 16 00:03:50.391681 systemd[1]: Started sshd@0-10.0.0.5:22-10.0.0.1:35308.service - OpenSSH per-connection server daemon (10.0.0.1:35308). May 16 00:03:50.466532 sshd[1764]: Accepted publickey for core from 10.0.0.1 port 35308 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:50.468606 sshd-session[1764]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:50.482492 systemd[1]: Created slice user-500.slice - User Slice of UID 500. May 16 00:03:50.496737 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... May 16 00:03:50.501631 systemd-logind[1371]: New session 1 of user core. May 16 00:03:50.512595 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. May 16 00:03:50.514502 systemd[1]: Starting user@500.service - User Manager for UID 500... May 16 00:03:50.522222 (systemd)[1768]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) May 16 00:03:50.600704 systemd[1768]: Queued start job for default target default.target. May 16 00:03:50.611472 systemd[1768]: Created slice app.slice - User Application Slice. May 16 00:03:50.611501 systemd[1768]: Reached target paths.target - Paths. May 16 00:03:50.611514 systemd[1768]: Reached target timers.target - Timers. May 16 00:03:50.612823 systemd[1768]: Starting dbus.socket - D-Bus User Message Bus Socket... May 16 00:03:50.626811 systemd[1768]: Listening on dbus.socket - D-Bus User Message Bus Socket. May 16 00:03:50.627520 systemd[1768]: Reached target sockets.target - Sockets. May 16 00:03:50.627537 systemd[1768]: Reached target basic.target - Basic System. May 16 00:03:50.627588 systemd[1768]: Reached target default.target - Main User Target. May 16 00:03:50.627620 systemd[1768]: Startup finished in 97ms. May 16 00:03:50.627715 systemd[1]: Started user@500.service - User Manager for UID 500. May 16 00:03:50.628939 systemd[1]: Started session-1.scope - Session 1 of User core. May 16 00:03:50.688997 systemd[1]: Started sshd@1-10.0.0.5:22-10.0.0.1:35316.service - OpenSSH per-connection server daemon (10.0.0.1:35316). May 16 00:03:50.742309 sshd[1779]: Accepted publickey for core from 10.0.0.1 port 35316 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:50.743564 sshd-session[1779]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:50.747500 systemd-logind[1371]: New session 2 of user core. May 16 00:03:50.769623 systemd[1]: Started session-2.scope - Session 2 of User core. May 16 00:03:50.821338 sshd[1781]: Connection closed by 10.0.0.1 port 35316 May 16 00:03:50.821868 sshd-session[1779]: pam_unix(sshd:session): session closed for user core May 16 00:03:50.835872 systemd[1]: sshd@1-10.0.0.5:22-10.0.0.1:35316.service: Deactivated successfully. May 16 00:03:50.837303 systemd[1]: session-2.scope: Deactivated successfully. May 16 00:03:50.838511 systemd-logind[1371]: Session 2 logged out. Waiting for processes to exit. May 16 00:03:50.852118 systemd[1]: Started sshd@2-10.0.0.5:22-10.0.0.1:35332.service - OpenSSH per-connection server daemon (10.0.0.1:35332). May 16 00:03:50.853433 systemd-logind[1371]: Removed session 2. May 16 00:03:50.893317 sshd[1786]: Accepted publickey for core from 10.0.0.1 port 35332 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:50.894622 sshd-session[1786]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:50.898456 systemd-logind[1371]: New session 3 of user core. May 16 00:03:50.919601 systemd[1]: Started session-3.scope - Session 3 of User core. May 16 00:03:50.968536 sshd[1788]: Connection closed by 10.0.0.1 port 35332 May 16 00:03:50.968799 sshd-session[1786]: pam_unix(sshd:session): session closed for user core May 16 00:03:50.981779 systemd[1]: sshd@2-10.0.0.5:22-10.0.0.1:35332.service: Deactivated successfully. May 16 00:03:50.983707 systemd[1]: session-3.scope: Deactivated successfully. May 16 00:03:50.984941 systemd-logind[1371]: Session 3 logged out. Waiting for processes to exit. May 16 00:03:50.986090 systemd[1]: Started sshd@3-10.0.0.5:22-10.0.0.1:35342.service - OpenSSH per-connection server daemon (10.0.0.1:35342). May 16 00:03:50.986901 systemd-logind[1371]: Removed session 3. May 16 00:03:51.029148 sshd[1793]: Accepted publickey for core from 10.0.0.1 port 35342 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:51.030563 sshd-session[1793]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:51.034664 systemd-logind[1371]: New session 4 of user core. May 16 00:03:51.054608 systemd[1]: Started session-4.scope - Session 4 of User core. May 16 00:03:51.106494 sshd[1795]: Connection closed by 10.0.0.1 port 35342 May 16 00:03:51.106940 sshd-session[1793]: pam_unix(sshd:session): session closed for user core May 16 00:03:51.126111 systemd[1]: sshd@3-10.0.0.5:22-10.0.0.1:35342.service: Deactivated successfully. May 16 00:03:51.128008 systemd[1]: session-4.scope: Deactivated successfully. May 16 00:03:51.130266 systemd-logind[1371]: Session 4 logged out. Waiting for processes to exit. May 16 00:03:51.130834 systemd[1]: Started sshd@4-10.0.0.5:22-10.0.0.1:35350.service - OpenSSH per-connection server daemon (10.0.0.1:35350). May 16 00:03:51.132026 systemd-logind[1371]: Removed session 4. May 16 00:03:51.170937 sshd[1800]: Accepted publickey for core from 10.0.0.1 port 35350 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:51.172202 sshd-session[1800]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:51.175886 systemd-logind[1371]: New session 5 of user core. May 16 00:03:51.191628 systemd[1]: Started session-5.scope - Session 5 of User core. May 16 00:03:51.251303 sudo[1803]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 May 16 00:03:51.253387 sudo[1803]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 00:03:51.270401 sudo[1803]: pam_unix(sudo:session): session closed for user root May 16 00:03:51.271968 sshd[1802]: Connection closed by 10.0.0.1 port 35350 May 16 00:03:51.272342 sshd-session[1800]: pam_unix(sshd:session): session closed for user core May 16 00:03:51.283838 systemd[1]: sshd@4-10.0.0.5:22-10.0.0.1:35350.service: Deactivated successfully. May 16 00:03:51.285385 systemd[1]: session-5.scope: Deactivated successfully. May 16 00:03:51.286973 systemd-logind[1371]: Session 5 logged out. Waiting for processes to exit. May 16 00:03:51.288301 systemd[1]: Started sshd@5-10.0.0.5:22-10.0.0.1:35362.service - OpenSSH per-connection server daemon (10.0.0.1:35362). May 16 00:03:51.289097 systemd-logind[1371]: Removed session 5. May 16 00:03:51.328383 sshd[1808]: Accepted publickey for core from 10.0.0.1 port 35362 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:51.329689 sshd-session[1808]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:51.333231 systemd-logind[1371]: New session 6 of user core. May 16 00:03:51.341560 systemd[1]: Started session-6.scope - Session 6 of User core. May 16 00:03:51.392735 sudo[1812]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules May 16 00:03:51.393008 sudo[1812]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 00:03:51.395949 sudo[1812]: pam_unix(sudo:session): session closed for user root May 16 00:03:51.400575 sudo[1811]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules May 16 00:03:51.400838 sudo[1811]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 00:03:51.423786 systemd[1]: Starting audit-rules.service - Load Audit Rules... May 16 00:03:51.446578 augenrules[1834]: No rules May 16 00:03:51.448071 systemd[1]: audit-rules.service: Deactivated successfully. May 16 00:03:51.448302 systemd[1]: Finished audit-rules.service - Load Audit Rules. May 16 00:03:51.449473 sudo[1811]: pam_unix(sudo:session): session closed for user root May 16 00:03:51.451107 sshd[1810]: Connection closed by 10.0.0.1 port 35362 May 16 00:03:51.451036 sshd-session[1808]: pam_unix(sshd:session): session closed for user core May 16 00:03:51.455274 systemd[1]: sshd@5-10.0.0.5:22-10.0.0.1:35362.service: Deactivated successfully. May 16 00:03:51.456813 systemd[1]: session-6.scope: Deactivated successfully. May 16 00:03:51.457507 systemd-logind[1371]: Session 6 logged out. Waiting for processes to exit. May 16 00:03:51.458563 systemd-logind[1371]: Removed session 6. May 16 00:03:51.915650 systemd[1]: Started sshd@6-10.0.0.5:22-10.0.0.1:35370.service - OpenSSH per-connection server daemon (10.0.0.1:35370). May 16 00:03:51.955015 sshd[1842]: Accepted publickey for core from 10.0.0.1 port 35370 ssh2: RSA SHA256:G96kOUXlqnxtuktKPkl2+y6uGgycpsI/r7TAghSdoa0 May 16 00:03:51.956173 sshd-session[1842]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) May 16 00:03:51.960036 systemd-logind[1371]: New session 7 of user core. May 16 00:03:51.966624 systemd[1]: Started session-7.scope - Session 7 of User core. May 16 00:03:52.018463 sudo[1846]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl stop sshd.socket May 16 00:03:52.018730 sudo[1846]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 00:03:52.026409 systemd[1]: sshd.socket: Deactivated successfully. May 16 00:03:52.027002 systemd[1]: Closed sshd.socket - OpenSSH Server Socket. May 16 00:03:52.028692 sudo[1846]: pam_unix(sudo:session): session closed for user root May 16 00:03:52.033865 sudo[1845]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/locksmithctl send-need-reboot May 16 00:03:52.034130 sudo[1845]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) May 16 00:03:52.039171 locksmithd[1414]: LastCheckedTime=0 Progress=0 CurrentOperation="UPDATE_STATUS_UPDATED_NEED_REBOOT" NewVersion= NewSize=0 May 16 00:03:52.039181 locksmithd[1414]: No configured reboot window May 16 00:03:52.044462 locksmithd[1414]: Logins detected, delaying reboot for 5 minutes. May 16 00:03:53.039779 sudo[1845]: pam_unix(sudo:session): session closed for user root May 16 00:03:53.041040 sshd[1844]: Connection closed by 10.0.0.1 port 35370 May 16 00:03:53.041447 sshd-session[1842]: pam_unix(sshd:session): session closed for user core May 16 00:03:53.044690 systemd[1]: sshd@6-10.0.0.5:22-10.0.0.1:35370.service: Deactivated successfully. May 16 00:03:53.046255 systemd[1]: session-7.scope: Deactivated successfully. May 16 00:03:53.047963 systemd-logind[1371]: Session 7 logged out. Waiting for processes to exit. May 16 00:03:53.048747 systemd-logind[1371]: Removed session 7. May 16 00:04:29.082167 update_engine[1379]: I20250516 00:04:29.081931 1379 update_attempter.cc:509] Updating boot flags... May 16 00:04:29.101441 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1864) May 16 00:04:29.122471 kernel: BTRFS warning: duplicate device /dev/vda3 devid 1 generation 39 scanned by (udev-worker) (1863)