Jul 15 04:38:17.156635 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Jul 15 04:38:17.156680 kernel: Linux version 6.12.36-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 14.3.0 p8) 14.3.0, GNU ld (Gentoo 2.44 p1) 2.44.0) #1 SMP PREEMPT Tue Jul 15 03:28:41 -00 2025 Jul 15 04:38:17.156704 kernel: KASLR disabled due to lack of seed Jul 15 04:38:17.156721 kernel: efi: EFI v2.7 by EDK II Jul 15 04:38:17.156737 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a731a98 MEMRESERVE=0x78557598 Jul 15 04:38:17.156752 kernel: secureboot: Secure boot disabled Jul 15 04:38:17.156769 kernel: ACPI: Early table checksum verification disabled Jul 15 04:38:17.156784 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Jul 15 04:38:17.156800 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Jul 15 04:38:17.156815 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Jul 15 04:38:17.156831 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Jul 15 04:38:17.156851 kernel: ACPI: FACS 0x0000000078630000 000040 Jul 15 04:38:17.156866 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Jul 15 04:38:17.156881 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Jul 15 04:38:17.156899 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Jul 15 04:38:17.156915 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Jul 15 04:38:17.156935 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Jul 15 04:38:17.156952 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Jul 15 04:38:17.156968 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Jul 15 04:38:17.156984 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Jul 15 04:38:17.157000 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Jul 15 04:38:17.157016 kernel: printk: legacy bootconsole [uart0] enabled Jul 15 04:38:17.157032 kernel: ACPI: Use ACPI SPCR as default console: Yes Jul 15 04:38:17.157049 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Jul 15 04:38:17.157065 kernel: NODE_DATA(0) allocated [mem 0x4b584ca00-0x4b5853fff] Jul 15 04:38:17.157081 kernel: Zone ranges: Jul 15 04:38:17.157099 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Jul 15 04:38:17.157120 kernel: DMA32 empty Jul 15 04:38:17.157136 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Jul 15 04:38:17.160210 kernel: Device empty Jul 15 04:38:17.160256 kernel: Movable zone start for each node Jul 15 04:38:17.160273 kernel: Early memory node ranges Jul 15 04:38:17.160290 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Jul 15 04:38:17.160307 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Jul 15 04:38:17.160324 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Jul 15 04:38:17.160340 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Jul 15 04:38:17.160356 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Jul 15 04:38:17.160372 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Jul 15 04:38:17.160388 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Jul 15 04:38:17.160414 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Jul 15 04:38:17.160437 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Jul 15 04:38:17.160455 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Jul 15 04:38:17.160472 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Jul 15 04:38:17.160490 kernel: psci: probing for conduit method from ACPI. Jul 15 04:38:17.160511 kernel: psci: PSCIv1.0 detected in firmware. Jul 15 04:38:17.160528 kernel: psci: Using standard PSCI v0.2 function IDs Jul 15 04:38:17.160545 kernel: psci: Trusted OS migration not required Jul 15 04:38:17.160562 kernel: psci: SMC Calling Convention v1.1 Jul 15 04:38:17.160580 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Jul 15 04:38:17.160597 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Jul 15 04:38:17.160614 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Jul 15 04:38:17.160631 kernel: pcpu-alloc: [0] 0 [0] 1 Jul 15 04:38:17.160648 kernel: Detected PIPT I-cache on CPU0 Jul 15 04:38:17.160666 kernel: CPU features: detected: GIC system register CPU interface Jul 15 04:38:17.160683 kernel: CPU features: detected: Spectre-v2 Jul 15 04:38:17.160704 kernel: CPU features: detected: Spectre-v3a Jul 15 04:38:17.160721 kernel: CPU features: detected: Spectre-BHB Jul 15 04:38:17.160738 kernel: CPU features: detected: ARM erratum 1742098 Jul 15 04:38:17.160755 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Jul 15 04:38:17.160772 kernel: alternatives: applying boot alternatives Jul 15 04:38:17.160791 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=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=71133d47dc7355ed63f3db64861b54679726ebf08c2975c3bf327e76b39a3acd Jul 15 04:38:17.160811 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Jul 15 04:38:17.160828 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Jul 15 04:38:17.160845 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Jul 15 04:38:17.160862 kernel: Fallback order for Node 0: 0 Jul 15 04:38:17.160883 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Jul 15 04:38:17.160900 kernel: Policy zone: Normal Jul 15 04:38:17.160917 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Jul 15 04:38:17.160933 kernel: software IO TLB: area num 2. Jul 15 04:38:17.160950 kernel: software IO TLB: mapped [mem 0x0000000074557000-0x0000000078557000] (64MB) Jul 15 04:38:17.160968 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Jul 15 04:38:17.160984 kernel: rcu: Preemptible hierarchical RCU implementation. Jul 15 04:38:17.161003 kernel: rcu: RCU event tracing is enabled. Jul 15 04:38:17.161020 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Jul 15 04:38:17.161037 kernel: Trampoline variant of Tasks RCU enabled. Jul 15 04:38:17.161054 kernel: Tracing variant of Tasks RCU enabled. Jul 15 04:38:17.161071 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Jul 15 04:38:17.161092 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Jul 15 04:38:17.161110 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jul 15 04:38:17.161129 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Jul 15 04:38:17.161146 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Jul 15 04:38:17.162864 kernel: GICv3: 96 SPIs implemented Jul 15 04:38:17.162895 kernel: GICv3: 0 Extended SPIs implemented Jul 15 04:38:17.162913 kernel: Root IRQ handler: gic_handle_irq Jul 15 04:38:17.162933 kernel: GICv3: GICv3 features: 16 PPIs Jul 15 04:38:17.162951 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Jul 15 04:38:17.162971 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Jul 15 04:38:17.162990 kernel: ITS [mem 0x10080000-0x1009ffff] Jul 15 04:38:17.163008 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000f0000 (indirect, esz 8, psz 64K, shr 1) Jul 15 04:38:17.163043 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @400100000 (flat, esz 8, psz 64K, shr 1) Jul 15 04:38:17.163060 kernel: GICv3: using LPI property table @0x0000000400110000 Jul 15 04:38:17.163078 kernel: ITS: Using hypervisor restricted LPI range [128] Jul 15 04:38:17.163096 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000400120000 Jul 15 04:38:17.163114 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Jul 15 04:38:17.163132 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Jul 15 04:38:17.163150 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Jul 15 04:38:17.163205 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Jul 15 04:38:17.163224 kernel: Console: colour dummy device 80x25 Jul 15 04:38:17.163243 kernel: printk: legacy console [tty1] enabled Jul 15 04:38:17.163262 kernel: ACPI: Core revision 20240827 Jul 15 04:38:17.163289 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Jul 15 04:38:17.163307 kernel: pid_max: default: 32768 minimum: 301 Jul 15 04:38:17.163325 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Jul 15 04:38:17.163343 kernel: landlock: Up and running. Jul 15 04:38:17.163360 kernel: SELinux: Initializing. Jul 15 04:38:17.163378 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 15 04:38:17.163397 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Jul 15 04:38:17.163415 kernel: rcu: Hierarchical SRCU implementation. Jul 15 04:38:17.163434 kernel: rcu: Max phase no-delay instances is 400. Jul 15 04:38:17.163458 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Jul 15 04:38:17.163477 kernel: Remapping and enabling EFI services. Jul 15 04:38:17.163495 kernel: smp: Bringing up secondary CPUs ... Jul 15 04:38:17.163513 kernel: Detected PIPT I-cache on CPU1 Jul 15 04:38:17.163532 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Jul 15 04:38:17.163550 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400130000 Jul 15 04:38:17.163567 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Jul 15 04:38:17.163585 kernel: smp: Brought up 1 node, 2 CPUs Jul 15 04:38:17.163604 kernel: SMP: Total of 2 processors activated. Jul 15 04:38:17.163635 kernel: CPU: All CPU(s) started at EL1 Jul 15 04:38:17.163654 kernel: CPU features: detected: 32-bit EL0 Support Jul 15 04:38:17.163676 kernel: CPU features: detected: 32-bit EL1 Support Jul 15 04:38:17.163695 kernel: CPU features: detected: CRC32 instructions Jul 15 04:38:17.163713 kernel: alternatives: applying system-wide alternatives Jul 15 04:38:17.163733 kernel: Memory: 3796580K/4030464K available (11136K kernel code, 2436K rwdata, 9056K rodata, 39424K init, 1038K bss, 212536K reserved, 16384K cma-reserved) Jul 15 04:38:17.163752 kernel: devtmpfs: initialized Jul 15 04:38:17.163774 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Jul 15 04:38:17.163792 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Jul 15 04:38:17.163810 kernel: 16928 pages in range for non-PLT usage Jul 15 04:38:17.163829 kernel: 508448 pages in range for PLT usage Jul 15 04:38:17.163848 kernel: pinctrl core: initialized pinctrl subsystem Jul 15 04:38:17.163866 kernel: SMBIOS 3.0.0 present. Jul 15 04:38:17.163884 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Jul 15 04:38:17.163902 kernel: DMI: Memory slots populated: 0/0 Jul 15 04:38:17.163920 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Jul 15 04:38:17.163943 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Jul 15 04:38:17.163962 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Jul 15 04:38:17.163980 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Jul 15 04:38:17.163998 kernel: audit: initializing netlink subsys (disabled) Jul 15 04:38:17.164016 kernel: audit: type=2000 audit(0.283:1): state=initialized audit_enabled=0 res=1 Jul 15 04:38:17.164035 kernel: thermal_sys: Registered thermal governor 'step_wise' Jul 15 04:38:17.164053 kernel: cpuidle: using governor menu Jul 15 04:38:17.164072 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Jul 15 04:38:17.164090 kernel: ASID allocator initialised with 65536 entries Jul 15 04:38:17.164114 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jul 15 04:38:17.164133 kernel: Serial: AMBA PL011 UART driver Jul 15 04:38:17.164151 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Jul 15 04:38:17.166290 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Jul 15 04:38:17.166311 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Jul 15 04:38:17.166331 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Jul 15 04:38:17.166350 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Jul 15 04:38:17.166368 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Jul 15 04:38:17.166388 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Jul 15 04:38:17.166420 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Jul 15 04:38:17.166439 kernel: ACPI: Added _OSI(Module Device) Jul 15 04:38:17.166458 kernel: ACPI: Added _OSI(Processor Device) Jul 15 04:38:17.166476 kernel: ACPI: Added _OSI(Processor Aggregator Device) Jul 15 04:38:17.166495 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Jul 15 04:38:17.166513 kernel: ACPI: Interpreter enabled Jul 15 04:38:17.166531 kernel: ACPI: Using GIC for interrupt routing Jul 15 04:38:17.166550 kernel: ACPI: MCFG table detected, 1 entries Jul 15 04:38:17.166568 kernel: ACPI: CPU0 has been hot-added Jul 15 04:38:17.166592 kernel: ACPI: CPU1 has been hot-added Jul 15 04:38:17.166611 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Jul 15 04:38:17.166926 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Jul 15 04:38:17.167147 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Jul 15 04:38:17.169575 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Jul 15 04:38:17.169809 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Jul 15 04:38:17.170029 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Jul 15 04:38:17.170072 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Jul 15 04:38:17.170092 kernel: acpiphp: Slot [1] registered Jul 15 04:38:17.170111 kernel: acpiphp: Slot [2] registered Jul 15 04:38:17.170130 kernel: acpiphp: Slot [3] registered Jul 15 04:38:17.172221 kernel: acpiphp: Slot [4] registered Jul 15 04:38:17.172273 kernel: acpiphp: Slot [5] registered Jul 15 04:38:17.172293 kernel: acpiphp: Slot [6] registered Jul 15 04:38:17.172313 kernel: acpiphp: Slot [7] registered Jul 15 04:38:17.172333 kernel: acpiphp: Slot [8] registered Jul 15 04:38:17.172352 kernel: acpiphp: Slot [9] registered Jul 15 04:38:17.172823 kernel: acpiphp: Slot [10] registered Jul 15 04:38:17.173560 kernel: acpiphp: Slot [11] registered Jul 15 04:38:17.173935 kernel: acpiphp: Slot [12] registered Jul 15 04:38:17.178253 kernel: acpiphp: Slot [13] registered Jul 15 04:38:17.178278 kernel: acpiphp: Slot [14] registered Jul 15 04:38:17.178298 kernel: acpiphp: Slot [15] registered Jul 15 04:38:17.178317 kernel: acpiphp: Slot [16] registered Jul 15 04:38:17.178335 kernel: acpiphp: Slot [17] registered Jul 15 04:38:17.178354 kernel: acpiphp: Slot [18] registered Jul 15 04:38:17.178385 kernel: acpiphp: Slot [19] registered Jul 15 04:38:17.178404 kernel: acpiphp: Slot [20] registered Jul 15 04:38:17.178422 kernel: acpiphp: Slot [21] registered Jul 15 04:38:17.178440 kernel: acpiphp: Slot [22] registered Jul 15 04:38:17.178459 kernel: acpiphp: Slot [23] registered Jul 15 04:38:17.178478 kernel: acpiphp: Slot [24] registered Jul 15 04:38:17.178496 kernel: acpiphp: Slot [25] registered Jul 15 04:38:17.178514 kernel: acpiphp: Slot [26] registered Jul 15 04:38:17.178532 kernel: acpiphp: Slot [27] registered Jul 15 04:38:17.178550 kernel: acpiphp: Slot [28] registered Jul 15 04:38:17.178574 kernel: acpiphp: Slot [29] registered Jul 15 04:38:17.178593 kernel: acpiphp: Slot [30] registered Jul 15 04:38:17.178611 kernel: acpiphp: Slot [31] registered Jul 15 04:38:17.178630 kernel: PCI host bridge to bus 0000:00 Jul 15 04:38:17.178919 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Jul 15 04:38:17.179137 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Jul 15 04:38:17.179380 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Jul 15 04:38:17.179568 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Jul 15 04:38:17.179817 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Jul 15 04:38:17.180069 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Jul 15 04:38:17.182404 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Jul 15 04:38:17.182652 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Jul 15 04:38:17.182847 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Jul 15 04:38:17.183037 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Jul 15 04:38:17.183303 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Jul 15 04:38:17.183499 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Jul 15 04:38:17.183697 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Jul 15 04:38:17.183907 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Jul 15 04:38:17.184129 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Jul 15 04:38:17.186544 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref]: assigned Jul 15 04:38:17.186793 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff]: assigned Jul 15 04:38:17.187006 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80110000-0x80113fff]: assigned Jul 15 04:38:17.187250 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80114000-0x80117fff]: assigned Jul 15 04:38:17.187451 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff]: assigned Jul 15 04:38:17.187628 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Jul 15 04:38:17.187797 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Jul 15 04:38:17.187974 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Jul 15 04:38:17.188002 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Jul 15 04:38:17.188031 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Jul 15 04:38:17.188051 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Jul 15 04:38:17.188070 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Jul 15 04:38:17.188091 kernel: iommu: Default domain type: Translated Jul 15 04:38:17.188110 kernel: iommu: DMA domain TLB invalidation policy: strict mode Jul 15 04:38:17.188129 kernel: efivars: Registered efivars operations Jul 15 04:38:17.188147 kernel: vgaarb: loaded Jul 15 04:38:17.188360 kernel: clocksource: Switched to clocksource arch_sys_counter Jul 15 04:38:17.188380 kernel: VFS: Disk quotas dquot_6.6.0 Jul 15 04:38:17.188406 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jul 15 04:38:17.188425 kernel: pnp: PnP ACPI init Jul 15 04:38:17.188688 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Jul 15 04:38:17.188720 kernel: pnp: PnP ACPI: found 1 devices Jul 15 04:38:17.188740 kernel: NET: Registered PF_INET protocol family Jul 15 04:38:17.188760 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Jul 15 04:38:17.188779 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Jul 15 04:38:17.188799 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Jul 15 04:38:17.188828 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Jul 15 04:38:17.188849 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Jul 15 04:38:17.188869 kernel: TCP: Hash tables configured (established 32768 bind 32768) Jul 15 04:38:17.188888 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 15 04:38:17.188908 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Jul 15 04:38:17.188927 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Jul 15 04:38:17.188946 kernel: PCI: CLS 0 bytes, default 64 Jul 15 04:38:17.188965 kernel: kvm [1]: HYP mode not available Jul 15 04:38:17.188985 kernel: Initialise system trusted keyrings Jul 15 04:38:17.189010 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Jul 15 04:38:17.189030 kernel: Key type asymmetric registered Jul 15 04:38:17.189048 kernel: Asymmetric key parser 'x509' registered Jul 15 04:38:17.189067 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Jul 15 04:38:17.189086 kernel: io scheduler mq-deadline registered Jul 15 04:38:17.189105 kernel: io scheduler kyber registered Jul 15 04:38:17.189124 kernel: io scheduler bfq registered Jul 15 04:38:17.189439 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Jul 15 04:38:17.189518 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Jul 15 04:38:17.189538 kernel: ACPI: button: Power Button [PWRB] Jul 15 04:38:17.189557 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Jul 15 04:38:17.189575 kernel: ACPI: button: Sleep Button [SLPB] Jul 15 04:38:17.189594 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Jul 15 04:38:17.189613 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Jul 15 04:38:17.189844 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Jul 15 04:38:17.189873 kernel: printk: legacy console [ttyS0] disabled Jul 15 04:38:17.189893 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Jul 15 04:38:17.189918 kernel: printk: legacy console [ttyS0] enabled Jul 15 04:38:17.189937 kernel: printk: legacy bootconsole [uart0] disabled Jul 15 04:38:17.189955 kernel: thunder_xcv, ver 1.0 Jul 15 04:38:17.189973 kernel: thunder_bgx, ver 1.0 Jul 15 04:38:17.189991 kernel: nicpf, ver 1.0 Jul 15 04:38:17.190009 kernel: nicvf, ver 1.0 Jul 15 04:38:17.190321 kernel: rtc-efi rtc-efi.0: registered as rtc0 Jul 15 04:38:17.190518 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-07-15T04:38:16 UTC (1752554296) Jul 15 04:38:17.190554 kernel: hid: raw HID events driver (C) Jiri Kosina Jul 15 04:38:17.190574 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Jul 15 04:38:17.190592 kernel: watchdog: NMI not fully supported Jul 15 04:38:17.190611 kernel: NET: Registered PF_INET6 protocol family Jul 15 04:38:17.190628 kernel: watchdog: Hard watchdog permanently disabled Jul 15 04:38:17.190646 kernel: Segment Routing with IPv6 Jul 15 04:38:17.190664 kernel: In-situ OAM (IOAM) with IPv6 Jul 15 04:38:17.190682 kernel: NET: Registered PF_PACKET protocol family Jul 15 04:38:17.190700 kernel: Key type dns_resolver registered Jul 15 04:38:17.190722 kernel: registered taskstats version 1 Jul 15 04:38:17.190740 kernel: Loading compiled-in X.509 certificates Jul 15 04:38:17.190758 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.36-flatcar: b5c59c413839929aea5bd4b52ae6eaff0e245cd2' Jul 15 04:38:17.190775 kernel: Demotion targets for Node 0: null Jul 15 04:38:17.190794 kernel: Key type .fscrypt registered Jul 15 04:38:17.190811 kernel: Key type fscrypt-provisioning registered Jul 15 04:38:17.190829 kernel: ima: No TPM chip found, activating TPM-bypass! Jul 15 04:38:17.190847 kernel: ima: Allocated hash algorithm: sha1 Jul 15 04:38:17.190865 kernel: ima: No architecture policies found Jul 15 04:38:17.190887 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Jul 15 04:38:17.190906 kernel: clk: Disabling unused clocks Jul 15 04:38:17.190923 kernel: PM: genpd: Disabling unused power domains Jul 15 04:38:17.190941 kernel: Warning: unable to open an initial console. Jul 15 04:38:17.190960 kernel: Freeing unused kernel memory: 39424K Jul 15 04:38:17.190977 kernel: Run /init as init process Jul 15 04:38:17.190996 kernel: with arguments: Jul 15 04:38:17.191014 kernel: /init Jul 15 04:38:17.191031 kernel: with environment: Jul 15 04:38:17.191049 kernel: HOME=/ Jul 15 04:38:17.191070 kernel: TERM=linux Jul 15 04:38:17.191088 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Jul 15 04:38:17.191110 systemd[1]: Successfully made /usr/ read-only. Jul 15 04:38:17.191135 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jul 15 04:38:17.191191 systemd[1]: Detected virtualization amazon. Jul 15 04:38:17.191216 systemd[1]: Detected architecture arm64. Jul 15 04:38:17.191236 systemd[1]: Running in initrd. Jul 15 04:38:17.191690 systemd[1]: No hostname configured, using default hostname. Jul 15 04:38:17.192044 systemd[1]: Hostname set to . Jul 15 04:38:17.192688 systemd[1]: Initializing machine ID from VM UUID. Jul 15 04:38:17.192723 systemd[1]: Queued start job for default target initrd.target. Jul 15 04:38:17.192745 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 04:38:17.192765 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 04:38:17.192787 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Jul 15 04:38:17.192807 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 04:38:17.192838 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Jul 15 04:38:17.192859 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Jul 15 04:38:17.192882 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Jul 15 04:38:17.192902 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Jul 15 04:38:17.192922 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 04:38:17.192942 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 04:38:17.192962 systemd[1]: Reached target paths.target - Path Units. Jul 15 04:38:17.192988 systemd[1]: Reached target slices.target - Slice Units. Jul 15 04:38:17.193008 systemd[1]: Reached target swap.target - Swaps. Jul 15 04:38:17.193028 systemd[1]: Reached target timers.target - Timer Units. Jul 15 04:38:17.193048 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 04:38:17.193068 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 04:38:17.193088 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Jul 15 04:38:17.193108 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Jul 15 04:38:17.193128 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 04:38:17.193179 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 04:38:17.193208 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 04:38:17.193228 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 04:38:17.193247 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Jul 15 04:38:17.193267 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 04:38:17.193286 systemd[1]: Finished network-cleanup.service - Network Cleanup. Jul 15 04:38:17.193307 systemd[1]: systemd-battery-check.service - Check battery level during early boot was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/class/power_supply). Jul 15 04:38:17.193326 systemd[1]: Starting systemd-fsck-usr.service... Jul 15 04:38:17.193346 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 04:38:17.193372 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 04:38:17.193392 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 04:38:17.193411 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Jul 15 04:38:17.193432 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 04:38:17.193531 systemd[1]: Finished systemd-fsck-usr.service. Jul 15 04:38:17.193559 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Jul 15 04:38:17.193638 systemd-journald[258]: Collecting audit messages is disabled. Jul 15 04:38:17.193682 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 04:38:17.193711 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Jul 15 04:38:17.193746 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Jul 15 04:38:17.193769 kernel: Bridge firewalling registered Jul 15 04:38:17.193789 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 04:38:17.193810 systemd-journald[258]: Journal started Jul 15 04:38:17.193851 systemd-journald[258]: Runtime Journal (/run/log/journal/ec27f816bab735a4b3315e4bedc25686) is 8M, max 75.3M, 67.3M free. Jul 15 04:38:17.130336 systemd-modules-load[259]: Inserted module 'overlay' Jul 15 04:38:17.188018 systemd-modules-load[259]: Inserted module 'br_netfilter' Jul 15 04:38:17.201219 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 04:38:17.201334 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Jul 15 04:38:17.210747 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 04:38:17.219436 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 04:38:17.229984 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 04:38:17.262082 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 04:38:17.265714 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 04:38:17.280471 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Jul 15 04:38:17.286315 systemd-tmpfiles[284]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Jul 15 04:38:17.300260 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 04:38:17.313650 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 04:38:17.325103 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 04:38:17.348549 dracut-cmdline[294]: Using kernel command line parameters: rd.driver.pre=btrfs SYSTEMD_SULOGIN_FORCE=1 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=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=71133d47dc7355ed63f3db64861b54679726ebf08c2975c3bf327e76b39a3acd Jul 15 04:38:17.443129 systemd-resolved[302]: Positive Trust Anchors: Jul 15 04:38:17.444023 systemd-resolved[302]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 04:38:17.444096 systemd-resolved[302]: 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 Jul 15 04:38:17.544197 kernel: SCSI subsystem initialized Jul 15 04:38:17.550199 kernel: Loading iSCSI transport class v2.0-870. Jul 15 04:38:17.563196 kernel: iscsi: registered transport (tcp) Jul 15 04:38:17.585920 kernel: iscsi: registered transport (qla4xxx) Jul 15 04:38:17.585994 kernel: QLogic iSCSI HBA Driver Jul 15 04:38:17.622331 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 04:38:17.664971 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 04:38:17.678821 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 04:38:17.724196 kernel: random: crng init done Jul 15 04:38:17.724661 systemd-resolved[302]: Defaulting to hostname 'linux'. Jul 15 04:38:17.729079 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 04:38:17.734434 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 04:38:17.785397 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Jul 15 04:38:17.792371 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Jul 15 04:38:17.885207 kernel: raid6: neonx8 gen() 6559 MB/s Jul 15 04:38:17.901196 kernel: raid6: neonx4 gen() 6585 MB/s Jul 15 04:38:17.918192 kernel: raid6: neonx2 gen() 5478 MB/s Jul 15 04:38:17.935191 kernel: raid6: neonx1 gen() 3968 MB/s Jul 15 04:38:17.952189 kernel: raid6: int64x8 gen() 3682 MB/s Jul 15 04:38:17.969190 kernel: raid6: int64x4 gen() 3723 MB/s Jul 15 04:38:17.986190 kernel: raid6: int64x2 gen() 3618 MB/s Jul 15 04:38:18.004189 kernel: raid6: int64x1 gen() 2775 MB/s Jul 15 04:38:18.004227 kernel: raid6: using algorithm neonx4 gen() 6585 MB/s Jul 15 04:38:18.022191 kernel: raid6: .... xor() 4893 MB/s, rmw enabled Jul 15 04:38:18.022226 kernel: raid6: using neon recovery algorithm Jul 15 04:38:18.031825 kernel: xor: measuring software checksum speed Jul 15 04:38:18.031897 kernel: 8regs : 13002 MB/sec Jul 15 04:38:18.033034 kernel: 32regs : 13011 MB/sec Jul 15 04:38:18.035440 kernel: arm64_neon : 8656 MB/sec Jul 15 04:38:18.035494 kernel: xor: using function: 32regs (13011 MB/sec) Jul 15 04:38:18.129203 kernel: Btrfs loaded, zoned=no, fsverity=no Jul 15 04:38:18.141337 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Jul 15 04:38:18.149067 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 04:38:18.199322 systemd-udevd[508]: Using default interface naming scheme 'v255'. Jul 15 04:38:18.211230 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 04:38:18.216920 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Jul 15 04:38:18.261148 dracut-pre-trigger[516]: rd.md=0: removing MD RAID activation Jul 15 04:38:18.312184 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 04:38:18.319538 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 04:38:18.446596 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 04:38:18.462466 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Jul 15 04:38:18.637242 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Jul 15 04:38:18.637320 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Jul 15 04:38:18.647273 kernel: ena 0000:00:05.0: ENA device version: 0.10 Jul 15 04:38:18.647648 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Jul 15 04:38:18.660219 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Jul 15 04:38:18.674224 kernel: nvme nvme0: pci function 0000:00:04.0 Jul 15 04:38:18.680202 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:67:92:a0:0c:71 Jul 15 04:38:18.685218 kernel: nvme nvme0: 2/0/0 default/read/poll queues Jul 15 04:38:18.685886 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 04:38:18.686194 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 04:38:18.698613 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Jul 15 04:38:18.698653 kernel: GPT:9289727 != 16777215 Jul 15 04:38:18.698679 kernel: GPT:Alternate GPT header not at the end of the disk. Jul 15 04:38:18.698704 kernel: GPT:9289727 != 16777215 Jul 15 04:38:18.698630 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 04:38:18.705864 kernel: GPT: Use GNU Parted to correct GPT errors. Jul 15 04:38:18.705903 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 15 04:38:18.708610 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 04:38:18.715302 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 15 04:38:18.719335 (udev-worker)[565]: Network interface NamePolicy= disabled on kernel command line. Jul 15 04:38:18.771930 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 04:38:18.777987 kernel: nvme nvme0: using unchecked data buffer Jul 15 04:38:18.898469 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Jul 15 04:38:18.964192 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Jul 15 04:38:19.012892 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jul 15 04:38:19.020331 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Jul 15 04:38:19.061453 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Jul 15 04:38:19.067562 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Jul 15 04:38:19.070613 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 04:38:19.073672 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 04:38:19.082741 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 04:38:19.089123 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Jul 15 04:38:19.099449 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Jul 15 04:38:19.126674 disk-uuid[689]: Primary Header is updated. Jul 15 04:38:19.126674 disk-uuid[689]: Secondary Entries is updated. Jul 15 04:38:19.126674 disk-uuid[689]: Secondary Header is updated. Jul 15 04:38:19.141227 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 15 04:38:19.151607 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 15 04:38:19.149786 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Jul 15 04:38:20.161219 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Jul 15 04:38:20.161289 disk-uuid[691]: The operation has completed successfully. Jul 15 04:38:20.371929 systemd[1]: disk-uuid.service: Deactivated successfully. Jul 15 04:38:20.374482 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Jul 15 04:38:20.479398 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Jul 15 04:38:20.503116 sh[955]: Success Jul 15 04:38:20.533731 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Jul 15 04:38:20.533813 kernel: device-mapper: uevent: version 1.0.3 Jul 15 04:38:20.533854 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Jul 15 04:38:20.548209 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Jul 15 04:38:20.662979 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Jul 15 04:38:20.674369 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Jul 15 04:38:20.694771 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Jul 15 04:38:20.721151 kernel: BTRFS info: 'norecovery' is for compatibility only, recommended to use 'rescue=nologreplay' Jul 15 04:38:20.721250 kernel: BTRFS: device fsid a7b7592d-2d1d-4236-b04f-dc58147b4692 devid 1 transid 37 /dev/mapper/usr (254:0) scanned by mount (978) Jul 15 04:38:20.725860 kernel: BTRFS info (device dm-0): first mount of filesystem a7b7592d-2d1d-4236-b04f-dc58147b4692 Jul 15 04:38:20.725931 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Jul 15 04:38:20.727147 kernel: BTRFS info (device dm-0): using free-space-tree Jul 15 04:38:20.869661 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Jul 15 04:38:20.876368 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Jul 15 04:38:20.881714 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Jul 15 04:38:20.887439 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Jul 15 04:38:20.897877 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Jul 15 04:38:20.949218 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1007) Jul 15 04:38:20.954050 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1ba6da34-80a1-4a8c-bd4d-0f30640013e8 Jul 15 04:38:20.954139 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 15 04:38:20.955754 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Jul 15 04:38:20.971374 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1ba6da34-80a1-4a8c-bd4d-0f30640013e8 Jul 15 04:38:20.973370 systemd[1]: Finished ignition-setup.service - Ignition (setup). Jul 15 04:38:20.979191 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Jul 15 04:38:21.111054 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 04:38:21.121542 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 04:38:21.194267 systemd-networkd[1147]: lo: Link UP Jul 15 04:38:21.194282 systemd-networkd[1147]: lo: Gained carrier Jul 15 04:38:21.200189 systemd-networkd[1147]: Enumeration completed Jul 15 04:38:21.201498 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 04:38:21.207876 systemd[1]: Reached target network.target - Network. Jul 15 04:38:21.212627 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 04:38:21.212649 systemd-networkd[1147]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 04:38:21.223421 systemd-networkd[1147]: eth0: Link UP Jul 15 04:38:21.223435 systemd-networkd[1147]: eth0: Gained carrier Jul 15 04:38:21.223456 systemd-networkd[1147]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 04:38:21.245271 systemd-networkd[1147]: eth0: DHCPv4 address 172.31.29.20/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jul 15 04:38:21.909307 ignition[1056]: Ignition 2.21.0 Jul 15 04:38:21.909363 ignition[1056]: Stage: fetch-offline Jul 15 04:38:21.911823 ignition[1056]: no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:21.915407 ignition[1056]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:21.918739 ignition[1056]: Ignition finished successfully Jul 15 04:38:21.923608 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 04:38:21.930847 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Jul 15 04:38:21.987697 ignition[1160]: Ignition 2.21.0 Jul 15 04:38:21.987733 ignition[1160]: Stage: fetch Jul 15 04:38:21.989124 ignition[1160]: no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:21.989544 ignition[1160]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:21.990922 ignition[1160]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:22.010146 ignition[1160]: PUT result: OK Jul 15 04:38:22.013821 ignition[1160]: parsed url from cmdline: "" Jul 15 04:38:22.013846 ignition[1160]: no config URL provided Jul 15 04:38:22.013863 ignition[1160]: reading system config file "/usr/lib/ignition/user.ign" Jul 15 04:38:22.013888 ignition[1160]: no config at "/usr/lib/ignition/user.ign" Jul 15 04:38:22.013924 ignition[1160]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:22.018350 ignition[1160]: PUT result: OK Jul 15 04:38:22.018523 ignition[1160]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Jul 15 04:38:22.027298 ignition[1160]: GET result: OK Jul 15 04:38:22.028013 ignition[1160]: parsing config with SHA512: a35c6c20983b827784a69ded643c3178a1326bd9c423ae1be8c9483e15a491084fc9944fc92c8922207f827052e5804c2cbb2934158e190e04d226e16263c03e Jul 15 04:38:22.042893 unknown[1160]: fetched base config from "system" Jul 15 04:38:22.044909 unknown[1160]: fetched base config from "system" Jul 15 04:38:22.044943 unknown[1160]: fetched user config from "aws" Jul 15 04:38:22.047180 ignition[1160]: fetch: fetch complete Jul 15 04:38:22.047199 ignition[1160]: fetch: fetch passed Jul 15 04:38:22.049036 ignition[1160]: Ignition finished successfully Jul 15 04:38:22.058001 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Jul 15 04:38:22.069192 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Jul 15 04:38:22.125229 ignition[1166]: Ignition 2.21.0 Jul 15 04:38:22.125263 ignition[1166]: Stage: kargs Jul 15 04:38:22.127052 ignition[1166]: no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:22.127104 ignition[1166]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:22.127320 ignition[1166]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:22.133775 ignition[1166]: PUT result: OK Jul 15 04:38:22.140577 ignition[1166]: kargs: kargs passed Jul 15 04:38:22.140708 ignition[1166]: Ignition finished successfully Jul 15 04:38:22.146999 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Jul 15 04:38:22.152036 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Jul 15 04:38:22.209268 ignition[1173]: Ignition 2.21.0 Jul 15 04:38:22.209809 ignition[1173]: Stage: disks Jul 15 04:38:22.210772 ignition[1173]: no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:22.210799 ignition[1173]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:22.210958 ignition[1173]: PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:22.215647 ignition[1173]: PUT result: OK Jul 15 04:38:22.223801 ignition[1173]: disks: disks passed Jul 15 04:38:22.223931 ignition[1173]: Ignition finished successfully Jul 15 04:38:22.231247 systemd[1]: Finished ignition-disks.service - Ignition (disks). Jul 15 04:38:22.231849 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Jul 15 04:38:22.239031 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Jul 15 04:38:22.244442 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 04:38:22.246893 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 04:38:22.252078 systemd[1]: Reached target basic.target - Basic System. Jul 15 04:38:22.261670 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Jul 15 04:38:22.324405 systemd-fsck[1181]: ROOT: clean, 15/553520 files, 52789/553472 blocks Jul 15 04:38:22.328322 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Jul 15 04:38:22.337537 systemd[1]: Mounting sysroot.mount - /sysroot... Jul 15 04:38:22.462192 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 4818953b-9d82-47bd-ab58-d0aa5641a19a r/w with ordered data mode. Quota mode: none. Jul 15 04:38:22.463947 systemd[1]: Mounted sysroot.mount - /sysroot. Jul 15 04:38:22.468077 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Jul 15 04:38:22.477701 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 04:38:22.481910 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Jul 15 04:38:22.486385 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Jul 15 04:38:22.490475 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Jul 15 04:38:22.490526 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 04:38:22.520421 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Jul 15 04:38:22.527768 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Jul 15 04:38:22.546805 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1200) Jul 15 04:38:22.553022 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1ba6da34-80a1-4a8c-bd4d-0f30640013e8 Jul 15 04:38:22.553100 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 15 04:38:22.553127 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Jul 15 04:38:22.561880 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 04:38:23.101362 systemd-networkd[1147]: eth0: Gained IPv6LL Jul 15 04:38:23.269876 initrd-setup-root[1224]: cut: /sysroot/etc/passwd: No such file or directory Jul 15 04:38:23.309962 initrd-setup-root[1231]: cut: /sysroot/etc/group: No such file or directory Jul 15 04:38:23.319511 initrd-setup-root[1238]: cut: /sysroot/etc/shadow: No such file or directory Jul 15 04:38:23.328133 initrd-setup-root[1245]: cut: /sysroot/etc/gshadow: No such file or directory Jul 15 04:38:23.962235 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Jul 15 04:38:23.968539 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Jul 15 04:38:23.977877 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Jul 15 04:38:24.002779 systemd[1]: sysroot-oem.mount: Deactivated successfully. Jul 15 04:38:24.005893 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1ba6da34-80a1-4a8c-bd4d-0f30640013e8 Jul 15 04:38:24.049267 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Jul 15 04:38:24.051131 ignition[1313]: INFO : Ignition 2.21.0 Jul 15 04:38:24.051665 ignition[1313]: INFO : Stage: mount Jul 15 04:38:24.052560 ignition[1313]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:24.052839 ignition[1313]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:24.053355 ignition[1313]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:24.064914 ignition[1313]: INFO : PUT result: OK Jul 15 04:38:24.070993 ignition[1313]: INFO : mount: mount passed Jul 15 04:38:24.072911 ignition[1313]: INFO : Ignition finished successfully Jul 15 04:38:24.077765 systemd[1]: Finished ignition-mount.service - Ignition (mount). Jul 15 04:38:24.084307 systemd[1]: Starting ignition-files.service - Ignition (files)... Jul 15 04:38:24.125292 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Jul 15 04:38:24.166194 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1324) Jul 15 04:38:24.170547 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1ba6da34-80a1-4a8c-bd4d-0f30640013e8 Jul 15 04:38:24.170630 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Jul 15 04:38:24.172016 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Jul 15 04:38:24.180465 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Jul 15 04:38:24.225658 ignition[1341]: INFO : Ignition 2.21.0 Jul 15 04:38:24.227874 ignition[1341]: INFO : Stage: files Jul 15 04:38:24.227874 ignition[1341]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:24.227874 ignition[1341]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:24.227874 ignition[1341]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:24.237804 ignition[1341]: INFO : PUT result: OK Jul 15 04:38:24.242575 ignition[1341]: DEBUG : files: compiled without relabeling support, skipping Jul 15 04:38:24.246382 ignition[1341]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Jul 15 04:38:24.246382 ignition[1341]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Jul 15 04:38:24.256182 ignition[1341]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Jul 15 04:38:24.259600 ignition[1341]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Jul 15 04:38:24.263242 unknown[1341]: wrote ssh authorized keys file for user: core Jul 15 04:38:24.265906 ignition[1341]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Jul 15 04:38:24.304712 ignition[1341]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 04:38:24.309358 ignition[1341]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Jul 15 04:38:24.309358 ignition[1341]: INFO : files: op(4): [started] processing unit "etcd-member.service" Jul 15 04:38:24.309358 ignition[1341]: 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" Jul 15 04:38:24.321803 ignition[1341]: 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" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Jul 15 04:38:24.321803 ignition[1341]: INFO : files: files passed Jul 15 04:38:24.321803 ignition[1341]: INFO : Ignition finished successfully Jul 15 04:38:24.342399 systemd[1]: Finished ignition-files.service - Ignition (files). Jul 15 04:38:24.355384 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Jul 15 04:38:24.382464 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Jul 15 04:38:24.396037 systemd[1]: ignition-quench.service: Deactivated successfully. Jul 15 04:38:24.401963 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Jul 15 04:38:24.426592 initrd-setup-root-after-ignition[1370]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 04:38:24.426592 initrd-setup-root-after-ignition[1370]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Jul 15 04:38:24.435435 initrd-setup-root-after-ignition[1373]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Jul 15 04:38:24.440963 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 04:38:24.444694 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Jul 15 04:38:24.449251 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Jul 15 04:38:24.538625 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Jul 15 04:38:24.540260 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Jul 15 04:38:24.545801 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Jul 15 04:38:24.549992 systemd[1]: Reached target initrd.target - Initrd Default Target. Jul 15 04:38:24.552740 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Jul 15 04:38:24.560747 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Jul 15 04:38:24.599955 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 04:38:24.606207 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Jul 15 04:38:24.647083 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Jul 15 04:38:24.653252 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 04:38:24.653677 systemd[1]: Stopped target timers.target - Timer Units. Jul 15 04:38:24.661185 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Jul 15 04:38:24.661467 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Jul 15 04:38:24.676426 systemd[1]: Stopped target initrd.target - Initrd Default Target. Jul 15 04:38:24.679140 systemd[1]: Stopped target basic.target - Basic System. Jul 15 04:38:24.679407 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Jul 15 04:38:24.686604 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Jul 15 04:38:24.690399 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Jul 15 04:38:24.697768 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Jul 15 04:38:24.706522 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Jul 15 04:38:24.712073 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Jul 15 04:38:24.720135 systemd[1]: Stopped target sysinit.target - System Initialization. Jul 15 04:38:24.723977 systemd[1]: Stopped target local-fs.target - Local File Systems. Jul 15 04:38:24.730550 systemd[1]: Stopped target swap.target - Swaps. Jul 15 04:38:24.733533 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Jul 15 04:38:24.733817 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Jul 15 04:38:24.742306 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Jul 15 04:38:24.745212 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 04:38:24.754035 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Jul 15 04:38:24.756334 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 04:38:24.760904 systemd[1]: dracut-initqueue.service: Deactivated successfully. Jul 15 04:38:24.761172 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Jul 15 04:38:24.770862 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Jul 15 04:38:24.771413 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Jul 15 04:38:24.779814 systemd[1]: ignition-files.service: Deactivated successfully. Jul 15 04:38:24.780061 systemd[1]: Stopped ignition-files.service - Ignition (files). Jul 15 04:38:24.788315 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Jul 15 04:38:24.790597 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Jul 15 04:38:24.792480 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 04:38:24.807274 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Jul 15 04:38:24.811104 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Jul 15 04:38:24.811511 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 04:38:24.811835 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Jul 15 04:38:24.812039 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Jul 15 04:38:24.843763 systemd[1]: initrd-cleanup.service: Deactivated successfully. Jul 15 04:38:24.851475 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Jul 15 04:38:24.871080 ignition[1394]: INFO : Ignition 2.21.0 Jul 15 04:38:24.874280 ignition[1394]: INFO : Stage: umount Jul 15 04:38:24.874280 ignition[1394]: INFO : no configs at "/usr/lib/ignition/base.d" Jul 15 04:38:24.874280 ignition[1394]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Jul 15 04:38:24.874280 ignition[1394]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Jul 15 04:38:24.884563 ignition[1394]: INFO : PUT result: OK Jul 15 04:38:24.889925 ignition[1394]: INFO : umount: umount passed Jul 15 04:38:24.892072 ignition[1394]: INFO : Ignition finished successfully Jul 15 04:38:24.897300 systemd[1]: ignition-mount.service: Deactivated successfully. Jul 15 04:38:24.899916 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Jul 15 04:38:24.913928 systemd[1]: sysroot-boot.mount: Deactivated successfully. Jul 15 04:38:24.915038 systemd[1]: sysroot-boot.service: Deactivated successfully. Jul 15 04:38:24.915279 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Jul 15 04:38:24.927775 systemd[1]: ignition-disks.service: Deactivated successfully. Jul 15 04:38:24.927957 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Jul 15 04:38:24.937840 systemd[1]: ignition-kargs.service: Deactivated successfully. Jul 15 04:38:24.937957 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Jul 15 04:38:24.943518 systemd[1]: ignition-fetch.service: Deactivated successfully. Jul 15 04:38:24.943646 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Jul 15 04:38:24.947213 systemd[1]: Stopped target network.target - Network. Jul 15 04:38:24.950050 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Jul 15 04:38:24.950226 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Jul 15 04:38:24.958967 systemd[1]: Stopped target paths.target - Path Units. Jul 15 04:38:24.966117 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Jul 15 04:38:24.970863 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 04:38:24.973790 systemd[1]: Stopped target slices.target - Slice Units. Jul 15 04:38:24.977691 systemd[1]: Stopped target sockets.target - Socket Units. Jul 15 04:38:24.984887 systemd[1]: iscsid.socket: Deactivated successfully. Jul 15 04:38:24.984975 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Jul 15 04:38:24.988216 systemd[1]: iscsiuio.socket: Deactivated successfully. Jul 15 04:38:24.988298 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Jul 15 04:38:24.995192 systemd[1]: ignition-setup.service: Deactivated successfully. Jul 15 04:38:24.995313 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Jul 15 04:38:24.999882 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Jul 15 04:38:24.999989 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Jul 15 04:38:25.004393 systemd[1]: initrd-setup-root.service: Deactivated successfully. Jul 15 04:38:25.004516 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Jul 15 04:38:25.011278 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Jul 15 04:38:25.018630 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Jul 15 04:38:25.050237 systemd[1]: systemd-resolved.service: Deactivated successfully. Jul 15 04:38:25.050446 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Jul 15 04:38:25.070817 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Jul 15 04:38:25.077264 systemd[1]: systemd-networkd.service: Deactivated successfully. Jul 15 04:38:25.077514 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Jul 15 04:38:25.086792 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Jul 15 04:38:25.088687 systemd[1]: Stopped target network-pre.target - Preparation for Network. Jul 15 04:38:25.095738 systemd[1]: systemd-networkd.socket: Deactivated successfully. Jul 15 04:38:25.096057 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Jul 15 04:38:25.104979 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Jul 15 04:38:25.112465 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Jul 15 04:38:25.112774 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Jul 15 04:38:25.125517 systemd[1]: systemd-sysctl.service: Deactivated successfully. Jul 15 04:38:25.125655 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Jul 15 04:38:25.133979 systemd[1]: systemd-modules-load.service: Deactivated successfully. Jul 15 04:38:25.134096 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Jul 15 04:38:25.137409 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Jul 15 04:38:25.137518 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 04:38:25.150458 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 04:38:25.162595 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Jul 15 04:38:25.162752 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Jul 15 04:38:25.187747 systemd[1]: systemd-udevd.service: Deactivated successfully. Jul 15 04:38:25.189986 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 04:38:25.193899 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Jul 15 04:38:25.193983 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Jul 15 04:38:25.198428 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Jul 15 04:38:25.198512 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 04:38:25.201265 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Jul 15 04:38:25.201419 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Jul 15 04:38:25.204641 systemd[1]: dracut-cmdline.service: Deactivated successfully. Jul 15 04:38:25.204749 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Jul 15 04:38:25.204934 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Jul 15 04:38:25.205019 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Jul 15 04:38:25.219788 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Jul 15 04:38:25.231983 systemd[1]: systemd-network-generator.service: Deactivated successfully. Jul 15 04:38:25.232120 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 04:38:25.243374 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Jul 15 04:38:25.243491 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 04:38:25.255354 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Jul 15 04:38:25.255463 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 04:38:25.269343 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Jul 15 04:38:25.269499 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Jul 15 04:38:25.269599 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Jul 15 04:38:25.271057 systemd[1]: network-cleanup.service: Deactivated successfully. Jul 15 04:38:25.272839 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Jul 15 04:38:25.313200 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Jul 15 04:38:25.313524 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Jul 15 04:38:25.320737 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Jul 15 04:38:25.328939 systemd[1]: Starting initrd-switch-root.service - Switch Root... Jul 15 04:38:25.367567 systemd[1]: Switching root. Jul 15 04:38:25.443756 systemd-journald[258]: Journal stopped Jul 15 04:38:28.808488 systemd-journald[258]: Received SIGTERM from PID 1 (systemd). Jul 15 04:38:28.808638 kernel: SELinux: policy capability network_peer_controls=1 Jul 15 04:38:28.808695 kernel: SELinux: policy capability open_perms=1 Jul 15 04:38:28.808727 kernel: SELinux: policy capability extended_socket_class=1 Jul 15 04:38:28.808761 kernel: SELinux: policy capability always_check_network=0 Jul 15 04:38:28.808793 kernel: SELinux: policy capability cgroup_seclabel=1 Jul 15 04:38:28.808824 kernel: SELinux: policy capability nnp_nosuid_transition=1 Jul 15 04:38:28.808858 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Jul 15 04:38:28.808890 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Jul 15 04:38:28.808919 kernel: SELinux: policy capability userspace_initial_context=0 Jul 15 04:38:28.808949 kernel: audit: type=1403 audit(1752554306.042:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Jul 15 04:38:28.808995 systemd[1]: Successfully loaded SELinux policy in 181.721ms. Jul 15 04:38:28.809042 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.364ms. Jul 15 04:38:28.824925 systemd[1]: systemd 256.8 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) Jul 15 04:38:28.824963 systemd[1]: Detected virtualization amazon. Jul 15 04:38:28.824993 systemd[1]: Detected architecture arm64. Jul 15 04:38:28.825026 systemd[1]: Detected first boot. Jul 15 04:38:28.825060 systemd[1]: Initializing machine ID from VM UUID. Jul 15 04:38:28.825090 zram_generator::config[1438]: No configuration found. Jul 15 04:38:28.825134 kernel: NET: Registered PF_VSOCK protocol family Jul 15 04:38:28.825238 systemd[1]: Populated /etc with preset unit settings. Jul 15 04:38:28.825280 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Jul 15 04:38:28.825316 systemd[1]: initrd-switch-root.service: Deactivated successfully. Jul 15 04:38:28.825369 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Jul 15 04:38:28.825405 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Jul 15 04:38:28.825435 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Jul 15 04:38:28.825469 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Jul 15 04:38:28.825500 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Jul 15 04:38:28.825547 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Jul 15 04:38:28.825581 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Jul 15 04:38:28.825650 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Jul 15 04:38:28.825691 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Jul 15 04:38:28.825726 systemd[1]: Created slice user.slice - User and Session Slice. Jul 15 04:38:28.825761 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Jul 15 04:38:28.825793 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Jul 15 04:38:28.825824 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Jul 15 04:38:28.825861 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Jul 15 04:38:28.825892 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Jul 15 04:38:28.825924 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Jul 15 04:38:28.825956 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Jul 15 04:38:28.825990 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Jul 15 04:38:28.826023 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Jul 15 04:38:28.826054 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Jul 15 04:38:28.826086 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Jul 15 04:38:28.826124 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Jul 15 04:38:28.826181 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Jul 15 04:38:28.826220 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Jul 15 04:38:28.826253 systemd[1]: Reached target remote-fs.target - Remote File Systems. Jul 15 04:38:28.826282 systemd[1]: Reached target slices.target - Slice Units. Jul 15 04:38:28.826312 systemd[1]: Reached target swap.target - Swaps. Jul 15 04:38:28.826342 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Jul 15 04:38:28.826373 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Jul 15 04:38:28.826401 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Jul 15 04:38:28.826437 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Jul 15 04:38:28.826465 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Jul 15 04:38:28.839146 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Jul 15 04:38:28.839263 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Jul 15 04:38:28.839304 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Jul 15 04:38:28.839338 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Jul 15 04:38:28.839367 systemd[1]: Mounting media.mount - External Media Directory... Jul 15 04:38:28.839401 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Jul 15 04:38:28.839431 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Jul 15 04:38:28.839472 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Jul 15 04:38:28.839506 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). Jul 15 04:38:28.839537 systemd[1]: Reached target machines.target - Containers. Jul 15 04:38:28.839567 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Jul 15 04:38:28.839598 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 04:38:28.839630 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Jul 15 04:38:28.839662 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Jul 15 04:38:28.839695 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 04:38:28.839733 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 04:38:28.839765 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 04:38:28.839795 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Jul 15 04:38:28.839825 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 04:38:28.839855 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Jul 15 04:38:28.839885 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Jul 15 04:38:28.839918 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Jul 15 04:38:28.840000 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Jul 15 04:38:28.840050 systemd[1]: Stopped systemd-fsck-usr.service. Jul 15 04:38:28.840098 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 15 04:38:28.840128 systemd[1]: Starting systemd-journald.service - Journal Service... Jul 15 04:38:28.840186 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Jul 15 04:38:28.840224 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Jul 15 04:38:28.840254 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Jul 15 04:38:28.840283 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Jul 15 04:38:28.840321 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Jul 15 04:38:28.840351 systemd[1]: verity-setup.service: Deactivated successfully. Jul 15 04:38:28.840385 systemd[1]: Stopped verity-setup.service. Jul 15 04:38:28.840428 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Jul 15 04:38:28.840460 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Jul 15 04:38:28.840495 systemd[1]: Mounted media.mount - External Media Directory. Jul 15 04:38:28.840524 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Jul 15 04:38:28.840552 kernel: fuse: init (API version 7.41) Jul 15 04:38:28.840587 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Jul 15 04:38:28.840617 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Jul 15 04:38:28.840650 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Jul 15 04:38:28.840683 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 04:38:28.840713 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 04:38:28.840748 kernel: loop: module loaded Jul 15 04:38:28.840776 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 04:38:28.840806 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 04:38:28.840835 systemd[1]: modprobe@fuse.service: Deactivated successfully. Jul 15 04:38:28.853246 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Jul 15 04:38:28.853281 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 04:38:28.853312 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 04:38:28.853370 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Jul 15 04:38:28.853404 systemd[1]: modprobe@configfs.service: Deactivated successfully. Jul 15 04:38:28.853450 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Jul 15 04:38:28.853556 systemd-journald[1517]: Collecting audit messages is disabled. Jul 15 04:38:28.853610 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Jul 15 04:38:28.853641 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Jul 15 04:38:28.853671 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Jul 15 04:38:28.853705 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Jul 15 04:38:28.853737 systemd[1]: Reached target local-fs.target - Local File Systems. Jul 15 04:38:28.853772 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Jul 15 04:38:28.853802 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Jul 15 04:38:28.853832 systemd-journald[1517]: Journal started Jul 15 04:38:28.853878 systemd-journald[1517]: Runtime Journal (/run/log/journal/ec27f816bab735a4b3315e4bedc25686) is 8M, max 75.3M, 67.3M free. Jul 15 04:38:28.141468 systemd[1]: Queued start job for default target multi-user.target. Jul 15 04:38:28.168440 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Jul 15 04:38:28.870303 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 04:38:28.870386 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Jul 15 04:38:28.169303 systemd[1]: systemd-journald.service: Deactivated successfully. Jul 15 04:38:28.892440 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 04:38:28.892527 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Jul 15 04:38:28.903204 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 04:38:28.914303 kernel: ACPI: bus type drm_connector registered Jul 15 04:38:28.914426 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Jul 15 04:38:28.927213 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Jul 15 04:38:28.940334 systemd[1]: Started systemd-journald.service - Journal Service. Jul 15 04:38:28.947289 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 04:38:28.949275 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 04:38:28.955255 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Jul 15 04:38:28.960268 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Jul 15 04:38:28.966976 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Jul 15 04:38:28.973496 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Jul 15 04:38:28.984231 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Jul 15 04:38:29.012727 kernel: loop0: detected capacity change from 0 to 61256 Jul 15 04:38:29.042854 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Jul 15 04:38:29.049848 systemd[1]: Reached target network-pre.target - Preparation for Network. Jul 15 04:38:29.060603 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Jul 15 04:38:29.075003 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Jul 15 04:38:29.101199 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jul 15 04:38:29.105106 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Jul 15 04:38:29.136777 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Jul 15 04:38:29.163338 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Jul 15 04:38:29.172278 systemd-journald[1517]: Time spent on flushing to /var/log/journal/ec27f816bab735a4b3315e4bedc25686 is 46.016ms for 916 entries. Jul 15 04:38:29.172278 systemd-journald[1517]: System Journal (/var/log/journal/ec27f816bab735a4b3315e4bedc25686) is 8M, max 195.6M, 187.6M free. Jul 15 04:38:29.235559 systemd-journald[1517]: Received client request to flush runtime journal. Jul 15 04:38:29.235657 kernel: loop1: detected capacity change from 0 to 105936 Jul 15 04:38:29.176378 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Jul 15 04:38:29.181122 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Jul 15 04:38:29.194715 systemd[1]: Starting systemd-sysusers.service - Create System Users... Jul 15 04:38:29.239446 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Jul 15 04:38:29.303325 systemd[1]: Finished systemd-sysusers.service - Create System Users. Jul 15 04:38:29.311716 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Jul 15 04:38:29.374941 systemd-tmpfiles[1590]: ACLs are not supported, ignoring. Jul 15 04:38:29.374989 systemd-tmpfiles[1590]: ACLs are not supported, ignoring. Jul 15 04:38:29.389304 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Jul 15 04:38:29.471227 kernel: loop2: detected capacity change from 0 to 134232 Jul 15 04:38:29.584223 kernel: loop3: detected capacity change from 0 to 61256 Jul 15 04:38:29.607211 kernel: loop4: detected capacity change from 0 to 105936 Jul 15 04:38:29.623286 kernel: loop5: detected capacity change from 0 to 134232 Jul 15 04:38:29.643147 (sd-merge)[1596]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Jul 15 04:38:29.644978 (sd-merge)[1596]: Merged extensions into '/usr'. Jul 15 04:38:29.650197 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Jul 15 04:38:29.661271 systemd[1]: Starting ensure-sysext.service... Jul 15 04:38:29.669648 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Jul 15 04:38:29.739400 systemd-tmpfiles[1599]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Jul 15 04:38:29.741759 systemd-tmpfiles[1599]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Jul 15 04:38:29.742493 systemd-tmpfiles[1599]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Jul 15 04:38:29.742993 systemd-tmpfiles[1599]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Jul 15 04:38:29.746151 systemd-tmpfiles[1599]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Jul 15 04:38:29.746566 systemd[1]: Reload requested from client PID 1598 ('systemctl') (unit ensure-sysext.service)... Jul 15 04:38:29.746593 systemd[1]: Reloading... Jul 15 04:38:29.748742 systemd-tmpfiles[1599]: ACLs are not supported, ignoring. Jul 15 04:38:29.748922 systemd-tmpfiles[1599]: ACLs are not supported, ignoring. Jul 15 04:38:29.772208 systemd-tmpfiles[1599]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 04:38:29.772240 systemd-tmpfiles[1599]: Skipping /boot Jul 15 04:38:29.819027 systemd-tmpfiles[1599]: Detected autofs mount point /boot during canonicalization of boot. Jul 15 04:38:29.819437 systemd-tmpfiles[1599]: Skipping /boot Jul 15 04:38:29.991204 zram_generator::config[1630]: No configuration found. Jul 15 04:38:30.261227 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. Jul 15 04:38:30.469839 systemd[1]: Reloading finished in 722 ms. Jul 15 04:38:30.491265 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Jul 15 04:38:31.156205 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Jul 15 04:38:31.173661 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 04:38:31.184403 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Jul 15 04:38:31.192791 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Jul 15 04:38:31.208111 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Jul 15 04:38:31.215346 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Jul 15 04:38:31.225048 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Jul 15 04:38:31.239122 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 04:38:31.249245 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Jul 15 04:38:31.267139 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Jul 15 04:38:31.271967 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Jul 15 04:38:31.274558 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 04:38:31.274817 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 15 04:38:31.286640 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 04:38:31.287084 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 04:38:31.287356 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 15 04:38:31.296143 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Jul 15 04:38:31.298484 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Jul 15 04:38:31.301133 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Jul 15 04:38:31.301470 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). Jul 15 04:38:31.301844 systemd[1]: Reached target time-set.target - System Time Set. Jul 15 04:38:31.308983 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Jul 15 04:38:31.330710 systemd[1]: Finished ensure-sysext.service. Jul 15 04:38:31.336115 systemd[1]: modprobe@loop.service: Deactivated successfully. Jul 15 04:38:31.336779 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Jul 15 04:38:31.359266 systemd[1]: modprobe@drm.service: Deactivated successfully. Jul 15 04:38:31.359744 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Jul 15 04:38:31.397518 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Jul 15 04:38:31.412009 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Jul 15 04:38:31.415541 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Jul 15 04:38:31.420670 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Jul 15 04:38:31.422617 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Jul 15 04:38:31.427934 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Jul 15 04:38:31.428058 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Jul 15 04:38:31.464186 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Jul 15 04:38:31.478403 ldconfig[1536]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Jul 15 04:38:31.490116 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Jul 15 04:38:31.502669 systemd[1]: Starting systemd-update-done.service - Update is Completed... Jul 15 04:38:31.508658 systemd-udevd[1686]: Using default interface naming scheme 'v255'. Jul 15 04:38:31.538820 augenrules[1720]: No rules Jul 15 04:38:31.545052 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 04:38:31.548423 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 04:38:31.570293 systemd[1]: Finished systemd-update-done.service - Update is Completed. Jul 15 04:38:31.574931 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Jul 15 04:38:31.580547 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). Jul 15 04:38:31.601581 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Jul 15 04:38:31.612749 systemd[1]: Starting systemd-networkd.service - Network Configuration... Jul 15 04:38:31.617747 systemd[1]: Started systemd-userdbd.service - User Database Manager. Jul 15 04:38:31.822523 (udev-worker)[1746]: Network interface NamePolicy= disabled on kernel command line. Jul 15 04:38:31.884022 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Jul 15 04:38:32.157315 systemd-networkd[1730]: lo: Link UP Jul 15 04:38:32.157338 systemd-networkd[1730]: lo: Gained carrier Jul 15 04:38:32.160354 systemd-networkd[1730]: Enumeration completed Jul 15 04:38:32.160588 systemd[1]: Started systemd-networkd.service - Network Configuration. Jul 15 04:38:32.163186 systemd-networkd[1730]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 04:38:32.163199 systemd-networkd[1730]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Jul 15 04:38:32.169635 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Jul 15 04:38:32.169659 systemd-networkd[1730]: eth0: Link UP Jul 15 04:38:32.172339 systemd-networkd[1730]: eth0: Gained carrier Jul 15 04:38:32.172378 systemd-networkd[1730]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Jul 15 04:38:32.176617 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Jul 15 04:38:32.188289 systemd-networkd[1730]: eth0: DHCPv4 address 172.31.29.20/20, gateway 172.31.16.1 acquired from 172.31.16.1 Jul 15 04:38:32.292996 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Jul 15 04:38:32.383479 systemd-resolved[1685]: Positive Trust Anchors: Jul 15 04:38:32.383516 systemd-resolved[1685]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Jul 15 04:38:32.383579 systemd-resolved[1685]: 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 Jul 15 04:38:32.402116 systemd-resolved[1685]: Defaulting to hostname 'linux'. Jul 15 04:38:32.406830 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Jul 15 04:38:32.409620 systemd[1]: Reached target network.target - Network. Jul 15 04:38:32.417526 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Jul 15 04:38:32.420356 systemd[1]: Reached target sysinit.target - System Initialization. Jul 15 04:38:32.423013 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Jul 15 04:38:32.426465 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Jul 15 04:38:32.433831 systemd[1]: Started logrotate.timer - Daily rotation of log files. Jul 15 04:38:32.436596 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Jul 15 04:38:32.439483 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jul 15 04:38:32.445542 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Jul 15 04:38:32.445602 systemd[1]: Reached target paths.target - Path Units. Jul 15 04:38:32.447838 systemd[1]: Reached target timers.target - Timer Units. Jul 15 04:38:32.452074 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Jul 15 04:38:32.463849 systemd[1]: Starting docker.socket - Docker Socket for the API... Jul 15 04:38:32.474903 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Jul 15 04:38:32.478949 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Jul 15 04:38:32.487370 systemd[1]: Reached target ssh-access.target - SSH Access Available. Jul 15 04:38:32.500368 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Jul 15 04:38:32.504189 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Jul 15 04:38:32.508140 systemd[1]: Listening on docker.socket - Docker Socket for the API. Jul 15 04:38:32.524743 systemd[1]: Reached target sockets.target - Socket Units. Jul 15 04:38:32.527046 systemd[1]: Reached target basic.target - Basic System. Jul 15 04:38:32.529437 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Jul 15 04:38:32.529492 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Jul 15 04:38:32.531989 systemd[1]: Starting containerd.service - containerd container runtime... Jul 15 04:38:32.543494 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Jul 15 04:38:32.550611 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Jul 15 04:38:32.558448 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Jul 15 04:38:32.567878 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Jul 15 04:38:32.578634 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Jul 15 04:38:32.581120 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). Jul 15 04:38:32.587575 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Jul 15 04:38:32.594604 systemd[1]: Started ntpd.service - Network Time Service. Jul 15 04:38:32.600613 systemd[1]: Starting setup-oem.service - Setup OEM... Jul 15 04:38:32.611600 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Jul 15 04:38:32.619741 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Jul 15 04:38:32.629644 systemd[1]: Starting systemd-logind.service - User Login Management... Jul 15 04:38:32.636382 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Jul 15 04:38:32.637353 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Jul 15 04:38:32.646681 systemd[1]: Starting update-engine.service - Update Engine... Jul 15 04:38:32.657903 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Jul 15 04:38:32.667695 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Jul 15 04:38:32.678047 jq[1872]: false Jul 15 04:38:32.686518 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Jul 15 04:38:32.724553 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Jul 15 04:38:32.794753 jq[1883]: true Jul 15 04:38:32.795962 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Jul 15 04:38:32.796533 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Jul 15 04:38:32.838869 (ntainerd)[1902]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Jul 15 04:38:32.851970 jq[1907]: true Jul 15 04:38:32.892039 dbus-daemon[1870]: [system] SELinux support is enabled Jul 15 04:38:32.892401 systemd[1]: Started dbus.service - D-Bus System Message Bus. Jul 15 04:38:32.902451 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). Jul 15 04:38:32.913605 dbus-daemon[1870]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1730 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Jul 15 04:38:32.902528 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Jul 15 04:38:32.905730 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). Jul 15 04:38:32.905770 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Jul 15 04:38:32.918655 systemd[1]: motdgen.service: Deactivated successfully. Jul 15 04:38:32.919194 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Jul 15 04:38:32.922864 dbus-daemon[1870]: [system] Successfully activated service 'org.freedesktop.systemd1' Jul 15 04:38:32.930629 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Jul 15 04:38:32.939737 extend-filesystems[1873]: Found /dev/nvme0n1p6 Jul 15 04:38:32.948068 update_engine[1882]: I20250715 04:38:32.945667 1882 main.cc:92] Flatcar Update Engine starting Jul 15 04:38:32.968203 extend-filesystems[1873]: Found /dev/nvme0n1p9 Jul 15 04:38:32.970185 coreos-metadata[1869]: Jul 15 04:38:32.968 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jul 15 04:38:32.973544 systemd[1]: Started update-engine.service - Update Engine. Jul 15 04:38:32.983507 coreos-metadata[1869]: Jul 15 04:38:32.975 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Jul 15 04:38:32.980457 systemd[1]: Started locksmithd.service - Cluster reboot manager. Jul 15 04:38:32.994671 coreos-metadata[1869]: Jul 15 04:38:32.993 INFO Fetch successful Jul 15 04:38:32.994671 coreos-metadata[1869]: Jul 15 04:38:32.993 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Jul 15 04:38:32.994671 coreos-metadata[1869]: Jul 15 04:38:32.994 INFO Fetch successful Jul 15 04:38:32.994671 coreos-metadata[1869]: Jul 15 04:38:32.994 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Jul 15 04:38:32.994965 update_engine[1882]: I20250715 04:38:32.993911 1882 update_check_scheduler.cc:74] Next update check in 10m22s Jul 15 04:38:33.002681 coreos-metadata[1869]: Jul 15 04:38:32.997 INFO Fetch successful Jul 15 04:38:33.002681 coreos-metadata[1869]: Jul 15 04:38:32.997 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Jul 15 04:38:33.002681 coreos-metadata[1869]: Jul 15 04:38:33.002 INFO Fetch successful Jul 15 04:38:33.002681 coreos-metadata[1869]: Jul 15 04:38:33.002 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Jul 15 04:38:33.003058 extend-filesystems[1873]: Checking size of /dev/nvme0n1p9 Jul 15 04:38:33.010395 coreos-metadata[1869]: Jul 15 04:38:33.007 INFO Fetch failed with 404: resource not found Jul 15 04:38:33.010395 coreos-metadata[1869]: Jul 15 04:38:33.007 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Jul 15 04:38:33.016263 coreos-metadata[1869]: Jul 15 04:38:33.015 INFO Fetch successful Jul 15 04:38:33.016263 coreos-metadata[1869]: Jul 15 04:38:33.015 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Jul 15 04:38:33.020389 coreos-metadata[1869]: Jul 15 04:38:33.017 INFO Fetch successful Jul 15 04:38:33.020389 coreos-metadata[1869]: Jul 15 04:38:33.017 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Jul 15 04:38:33.023367 coreos-metadata[1869]: Jul 15 04:38:33.023 INFO Fetch successful Jul 15 04:38:33.023367 coreos-metadata[1869]: Jul 15 04:38:33.023 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Jul 15 04:38:33.029449 coreos-metadata[1869]: Jul 15 04:38:33.026 INFO Fetch successful Jul 15 04:38:33.029449 coreos-metadata[1869]: Jul 15 04:38:33.026 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Jul 15 04:38:33.036264 coreos-metadata[1869]: Jul 15 04:38:33.031 INFO Fetch successful Jul 15 04:38:33.041658 systemd[1]: Finished setup-oem.service - Setup OEM. Jul 15 04:38:33.095645 extend-filesystems[1873]: Resized partition /dev/nvme0n1p9 Jul 15 04:38:33.119188 extend-filesystems[1948]: resize2fs 1.47.2 (1-Jan-2025) Jul 15 04:38:33.144201 bash[1947]: Updated "/home/core/.ssh/authorized_keys" Jul 15 04:38:33.148943 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Jul 15 04:38:33.169627 systemd[1]: Starting sshkeys.service... Jul 15 04:38:33.207225 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Jul 15 04:38:33.226704 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Jul 15 04:38:33.243265 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Jul 15 04:38:33.248073 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Jul 15 04:38:33.255720 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Jul 15 04:38:33.258640 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Jul 15 04:38:33.277418 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Jul 15 04:38:33.347404 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Jul 15 04:38:33.369421 extend-filesystems[1948]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Jul 15 04:38:33.369421 extend-filesystems[1948]: old_desc_blocks = 1, new_desc_blocks = 1 Jul 15 04:38:33.369421 extend-filesystems[1948]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Jul 15 04:38:33.381418 extend-filesystems[1873]: Resized filesystem in /dev/nvme0n1p9 Jul 15 04:38:33.397411 systemd[1]: extend-filesystems.service: Deactivated successfully. Jul 15 04:38:33.397904 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Jul 15 04:38:33.427937 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Jul 15 04:38:33.446970 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Jul 15 04:38:33.480862 locksmithd[1925]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Jul 15 04:38:33.548391 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Jul 15 04:38:33.593625 coreos-metadata[1957]: Jul 15 04:38:33.593 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Jul 15 04:38:33.597575 coreos-metadata[1957]: Jul 15 04:38:33.597 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Jul 15 04:38:33.600946 coreos-metadata[1957]: Jul 15 04:38:33.600 INFO Fetch successful Jul 15 04:38:33.600946 coreos-metadata[1957]: Jul 15 04:38:33.600 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Jul 15 04:38:33.601920 coreos-metadata[1957]: Jul 15 04:38:33.601 INFO Fetch successful Jul 15 04:38:33.607347 unknown[1957]: wrote ssh authorized keys file for user: core Jul 15 04:38:33.680291 update-ssh-keys[1989]: Updated "/home/core/.ssh/authorized_keys" Jul 15 04:38:33.684973 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Jul 15 04:38:33.694344 systemd[1]: Finished sshkeys.service. Jul 15 04:38:33.767567 containerd[1902]: time="2025-07-15T04:38:33Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Jul 15 04:38:33.782279 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Jul 15 04:38:33.793341 containerd[1902]: time="2025-07-15T04:38:33.792026113Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Jul 15 04:38:33.843894 containerd[1902]: time="2025-07-15T04:38:33.843820070Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="14.592µs" Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846204026Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846280202Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846611186Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846664826Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846724670Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846858086Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Jul 15 04:38:33.847059 containerd[1902]: time="2025-07-15T04:38:33.846889958Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.866860862Z" level=info msg="skip loading plugin" 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" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.866922662Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.866959526Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.866982314Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.867246818Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.867679106Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.867750722Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.867776726Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Jul 15 04:38:33.868253 containerd[1902]: time="2025-07-15T04:38:33.867847994Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Jul 15 04:38:33.868722 containerd[1902]: time="2025-07-15T04:38:33.868425530Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Jul 15 04:38:33.868722 containerd[1902]: time="2025-07-15T04:38:33.868620242Z" level=info msg="metadata content store policy set" policy=shared Jul 15 04:38:33.884243 containerd[1902]: time="2025-07-15T04:38:33.884128334Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Jul 15 04:38:33.884475 containerd[1902]: time="2025-07-15T04:38:33.884293010Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Jul 15 04:38:33.884475 containerd[1902]: time="2025-07-15T04:38:33.884329058Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Jul 15 04:38:33.884475 containerd[1902]: time="2025-07-15T04:38:33.884359046Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Jul 15 04:38:33.884475 containerd[1902]: time="2025-07-15T04:38:33.884391710Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Jul 15 04:38:33.884475 containerd[1902]: time="2025-07-15T04:38:33.884441582Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884479550Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884509514Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884536622Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884562806Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884586494Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Jul 15 04:38:33.884669 containerd[1902]: time="2025-07-15T04:38:33.884625002Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Jul 15 04:38:33.884919 containerd[1902]: time="2025-07-15T04:38:33.884860850Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Jul 15 04:38:33.884919 containerd[1902]: time="2025-07-15T04:38:33.884900126Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Jul 15 04:38:33.885011 containerd[1902]: time="2025-07-15T04:38:33.884940218Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Jul 15 04:38:33.885011 containerd[1902]: time="2025-07-15T04:38:33.884970722Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Jul 15 04:38:33.885011 containerd[1902]: time="2025-07-15T04:38:33.885000074Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Jul 15 04:38:33.885122 containerd[1902]: time="2025-07-15T04:38:33.885027770Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Jul 15 04:38:33.885122 containerd[1902]: time="2025-07-15T04:38:33.885054482Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Jul 15 04:38:33.885122 containerd[1902]: time="2025-07-15T04:38:33.885081830Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Jul 15 04:38:33.885122 containerd[1902]: time="2025-07-15T04:38:33.885110222Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Jul 15 04:38:33.885384 containerd[1902]: time="2025-07-15T04:38:33.885136766Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Jul 15 04:38:33.888208 containerd[1902]: time="2025-07-15T04:38:33.886276070Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Jul 15 04:38:33.888208 containerd[1902]: time="2025-07-15T04:38:33.886707050Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Jul 15 04:38:33.888208 containerd[1902]: time="2025-07-15T04:38:33.886765718Z" level=info msg="Start snapshots syncer" Jul 15 04:38:33.888208 containerd[1902]: time="2025-07-15T04:38:33.886836566Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887293406Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"/opt/cni/bin\",\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"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\"}" Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887394638Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887531378Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887773754Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887818430Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887846354Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887872922Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887904590Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887932658Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.887959526Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.888010574Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.888038390Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Jul 15 04:38:33.888556 containerd[1902]: time="2025-07-15T04:38:33.888066074Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.888151646Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889007702Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889036298Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889062866Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889083506Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889110002Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.889137770Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.890342354Z" level=info msg="runtime interface created" Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.890373254Z" level=info msg="created NRI interface" Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.890397830Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.890431022Z" level=info msg="Connect containerd service" Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.890507990Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Jul 15 04:38:33.892487 containerd[1902]: time="2025-07-15T04:38:33.891819854Z" 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" Jul 15 04:38:34.045310 systemd-networkd[1730]: eth0: Gained IPv6LL Jul 15 04:38:34.056053 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Jul 15 04:38:34.059147 systemd[1]: Reached target network-online.target - Network is Online. Jul 15 04:38:34.065308 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Jul 15 04:38:34.071694 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Jul 15 04:38:34.077506 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Jul 15 04:38:34.128122 (-wrapper)[2091]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Jul 15 04:38:34.168893 ntpd[1875]: ntpd 4.2.8p17@1.4004-o Tue Jul 15 03:00:30 UTC 2025 (1): Starting Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: ntpd 4.2.8p17@1.4004-o Tue Jul 15 03:00:30 UTC 2025 (1): Starting Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: ---------------------------------------------------- Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: ntp-4 is maintained by Network Time Foundation, Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: corporation. Support and training for ntp-4 are Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: available at https://www.nwtime.org/support Jul 15 04:38:34.169782 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: ---------------------------------------------------- Jul 15 04:38:34.168968 ntpd[1875]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Jul 15 04:38:34.168987 ntpd[1875]: ---------------------------------------------------- Jul 15 04:38:34.169004 ntpd[1875]: ntp-4 is maintained by Network Time Foundation, Jul 15 04:38:34.169021 ntpd[1875]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Jul 15 04:38:34.169038 ntpd[1875]: corporation. Support and training for ntp-4 are Jul 15 04:38:34.169054 ntpd[1875]: available at https://www.nwtime.org/support Jul 15 04:38:34.169071 ntpd[1875]: ---------------------------------------------------- Jul 15 04:38:34.188850 ntpd[1875]: proto: precision = 0.096 usec (-23) Jul 15 04:38:34.189034 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: proto: precision = 0.096 usec (-23) Jul 15 04:38:34.193061 ntpd[1875]: basedate set to 2025-07-03 Jul 15 04:38:34.193359 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: basedate set to 2025-07-03 Jul 15 04:38:34.193359 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: gps base set to 2025-07-06 (week 2374) Jul 15 04:38:34.193117 ntpd[1875]: gps base set to 2025-07-06 (week 2374) Jul 15 04:38:34.211682 ntpd[1875]: Listen and drop on 0 v6wildcard [::]:123 Jul 15 04:38:34.211903 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen and drop on 0 v6wildcard [::]:123 Jul 15 04:38:34.212037 ntpd[1875]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen normally on 2 lo 127.0.0.1:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen normally on 3 eth0 172.31.29.20:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen normally on 4 lo [::1]:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listen normally on 5 eth0 [fe80::467:92ff:fea0:c71%2]:123 Jul 15 04:38:34.215227 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: Listening on routing socket on fd #22 for interface updates Jul 15 04:38:34.213741 ntpd[1875]: Listen normally on 2 lo 127.0.0.1:123 Jul 15 04:38:34.213817 ntpd[1875]: Listen normally on 3 eth0 172.31.29.20:123 Jul 15 04:38:34.213884 ntpd[1875]: Listen normally on 4 lo [::1]:123 Jul 15 04:38:34.213958 ntpd[1875]: Listen normally on 5 eth0 [fe80::467:92ff:fea0:c71%2]:123 Jul 15 04:38:34.214019 ntpd[1875]: Listening on routing socket on fd #22 for interface updates Jul 15 04:38:34.222779 ntpd[1875]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 15 04:38:34.223489 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 15 04:38:34.223489 ntpd[1875]: 15 Jul 04:38:34 ntpd[1875]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 15 04:38:34.222847 ntpd[1875]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 15 04:38:34.298616 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.358744236Z" level=info msg="Start subscribing containerd event" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.358937160Z" level=info msg="Start recovering state" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.359063556Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.359143644Z" level=info msg="Start event monitor" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.359209692Z" level=info msg="Start cni network conf syncer for default" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.359230344Z" level=info msg="Start streaming server" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.361197348Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.361242492Z" level=info msg="runtime interface starting up..." Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.361274064Z" level=info msg="starting plugins..." Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.361324560Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Jul 15 04:38:34.362964 containerd[1902]: time="2025-07-15T04:38:34.361712400Z" level=info msg=serving... address=/run/containerd/containerd.sock Jul 15 04:38:34.361973 systemd[1]: Started containerd.service - containerd container runtime. Jul 15 04:38:34.371485 containerd[1902]: time="2025-07-15T04:38:34.369675012Z" level=info msg="containerd successfully booted in 0.603652s" Jul 15 04:38:34.472189 amazon-ssm-agent[2090]: Initializing new seelog logger Jul 15 04:38:34.475207 amazon-ssm-agent[2090]: New Seelog Logger Creation Complete Jul 15 04:38:34.475207 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.475207 amazon-ssm-agent[2090]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.475207 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 processing appconfig overrides Jul 15 04:38:34.476469 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4741 INFO Proxy environment variables: Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 processing appconfig overrides Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.480643 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 processing appconfig overrides Jul 15 04:38:34.487405 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.487405 amazon-ssm-agent[2090]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:34.489345 amazon-ssm-agent[2090]: 2025/07/15 04:38:34 processing appconfig overrides Jul 15 04:38:34.580595 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4741 INFO https_proxy: Jul 15 04:38:34.653616 systemd-logind[1880]: Watching system buttons on /dev/input/event0 (Power Button) Jul 15 04:38:34.653665 systemd-logind[1880]: Watching system buttons on /dev/input/event1 (Sleep Button) Jul 15 04:38:34.654769 systemd-logind[1880]: New seat seat0. Jul 15 04:38:34.666326 systemd[1]: Started systemd-logind.service - User Login Management. Jul 15 04:38:34.685192 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4741 INFO http_proxy: Jul 15 04:38:34.781951 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4741 INFO no_proxy: Jul 15 04:38:34.786353 systemd[1]: Starting docker.service - Docker Application Container Engine... Jul 15 04:38:34.805834 (dockerd)[2124]: 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 Jul 15 04:38:34.812884 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Jul 15 04:38:34.821001 dbus-daemon[1870]: [system] Successfully activated service 'org.freedesktop.hostname1' Jul 15 04:38:34.824350 dbus-daemon[1870]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1921 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Jul 15 04:38:34.833448 systemd[1]: Starting polkit.service - Authorization Manager... Jul 15 04:38:34.883218 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4794 INFO Checking if agent identity type OnPrem can be assumed Jul 15 04:38:34.978933 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.4795 INFO Checking if agent identity type EC2 can be assumed Jul 15 04:38:35.078293 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7658 INFO Agent will take identity from EC2 Jul 15 04:38:35.090127 polkitd[2125]: Started polkitd version 126 Jul 15 04:38:35.102967 polkitd[2125]: Loading rules from directory /etc/polkit-1/rules.d Jul 15 04:38:35.103806 polkitd[2125]: Loading rules from directory /run/polkit-1/rules.d Jul 15 04:38:35.104045 polkitd[2125]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Jul 15 04:38:35.104835 polkitd[2125]: Loading rules from directory /usr/local/share/polkit-1/rules.d Jul 15 04:38:35.105091 polkitd[2125]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Jul 15 04:38:35.105341 polkitd[2125]: Loading rules from directory /usr/share/polkit-1/rules.d Jul 15 04:38:35.106427 polkitd[2125]: Finished loading, compiling and executing 2 rules Jul 15 04:38:35.107038 systemd[1]: Started polkit.service - Authorization Manager. Jul 15 04:38:35.113616 dbus-daemon[1870]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jul 15 04:38:35.115260 polkitd[2125]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Jul 15 04:38:35.156450 systemd-hostnamed[1921]: Hostname set to (transient) Jul 15 04:38:35.156622 systemd-resolved[1685]: System hostname changed to 'ip-172-31-29-20'. Jul 15 04:38:35.180208 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7677 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Jul 15 04:38:35.276960 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7677 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Jul 15 04:38:35.379319 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7678 INFO [amazon-ssm-agent] Starting Core Agent Jul 15 04:38:35.480272 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7678 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Jul 15 04:38:35.581343 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7678 INFO [Registrar] Starting registrar module Jul 15 04:38:35.602360 dockerd[2124]: time="2025-07-15T04:38:35.602109518Z" level=info msg="Starting up" Jul 15 04:38:35.604071 dockerd[2124]: time="2025-07-15T04:38:35.603945266Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Jul 15 04:38:35.681974 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7765 INFO [EC2Identity] Checking disk for registration info Jul 15 04:38:35.685573 dockerd[2124]: time="2025-07-15T04:38:35.682877259Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Jul 15 04:38:35.765134 systemd[1]: var-lib-docker-metacopy\x2dcheck40435059-merged.mount: Deactivated successfully. Jul 15 04:38:35.782336 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7766 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Jul 15 04:38:35.809644 dockerd[2124]: time="2025-07-15T04:38:35.808549311Z" level=info msg="Loading containers: start." Jul 15 04:38:35.828216 kernel: Initializing XFRM netlink socket Jul 15 04:38:35.845664 sshd_keygen[1918]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Jul 15 04:38:35.885211 amazon-ssm-agent[2090]: 2025-07-15 04:38:34.7766 INFO [EC2Identity] Generating registration keypair Jul 15 04:38:35.918338 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Jul 15 04:38:35.930350 systemd[1]: Starting issuegen.service - Generate /run/issue... Jul 15 04:38:35.938608 systemd[1]: Started sshd@0-172.31.29.20:22-139.178.89.65:40020.service - OpenSSH per-connection server daemon (139.178.89.65:40020). Jul 15 04:38:36.003963 systemd[1]: issuegen.service: Deactivated successfully. Jul 15 04:38:36.006280 systemd[1]: Finished issuegen.service - Generate /run/issue. Jul 15 04:38:36.014790 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Jul 15 04:38:36.079317 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Jul 15 04:38:36.087735 systemd[1]: Started getty@tty1.service - Getty on tty1. Jul 15 04:38:36.093701 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Jul 15 04:38:36.096676 systemd[1]: Reached target getty.target - Login Prompts. Jul 15 04:38:36.230562 sshd[2178]: Accepted publickey for core from 139.178.89.65 port 40020 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:36.238055 sshd-session[2178]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:36.255689 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Jul 15 04:38:36.261100 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Jul 15 04:38:36.290261 systemd-logind[1880]: New session 1 of user core. Jul 15 04:38:36.315232 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Jul 15 04:38:36.328334 systemd[1]: Starting user@500.service - User Manager for UID 500... Jul 15 04:38:36.362869 (systemd)[2252]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Jul 15 04:38:36.373551 systemd-logind[1880]: New session c1 of user core. Jul 15 04:38:36.771086 systemd[2252]: Queued start job for default target default.target. Jul 15 04:38:36.781796 systemd[2252]: Created slice app.slice - User Application Slice. Jul 15 04:38:36.782043 systemd[2252]: Reached target paths.target - Paths. Jul 15 04:38:36.782373 systemd[2252]: Reached target timers.target - Timers. Jul 15 04:38:36.788409 systemd[2252]: Starting dbus.socket - D-Bus User Message Bus Socket... Jul 15 04:38:36.820883 systemd-networkd[1730]: docker0: Link UP Jul 15 04:38:36.824543 systemd[2252]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jul 15 04:38:36.825546 systemd[2252]: Reached target sockets.target - Sockets. Jul 15 04:38:36.825648 systemd[2252]: Reached target basic.target - Basic System. Jul 15 04:38:36.825729 systemd[2252]: Reached target default.target - Main User Target. Jul 15 04:38:36.825976 systemd[1]: Started user@500.service - User Manager for UID 500. Jul 15 04:38:36.829260 systemd[2252]: Startup finished in 433ms. Jul 15 04:38:36.835732 systemd[1]: Started session-1.scope - Session 1 of User core. Jul 15 04:38:36.841944 dockerd[2124]: time="2025-07-15T04:38:36.839239973Z" level=info msg="Loading containers: done." Jul 15 04:38:36.874580 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck2662888395-merged.mount: Deactivated successfully. Jul 15 04:38:36.884487 dockerd[2124]: time="2025-07-15T04:38:36.884434721Z" 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 Jul 15 04:38:36.884792 dockerd[2124]: time="2025-07-15T04:38:36.884763029Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Jul 15 04:38:36.885018 dockerd[2124]: time="2025-07-15T04:38:36.884993285Z" level=info msg="Initializing buildkit" Jul 15 04:38:36.938697 dockerd[2124]: time="2025-07-15T04:38:36.937569989Z" level=info msg="Completed buildkit initialization" Jul 15 04:38:36.997475 dockerd[2124]: time="2025-07-15T04:38:36.997362305Z" level=info msg="Daemon has completed initialization" Jul 15 04:38:36.999440 systemd[1]: Started docker.service - Docker Application Container Engine. Jul 15 04:38:37.002128 dockerd[2124]: time="2025-07-15T04:38:36.997960181Z" level=info msg="API listen on /run/docker.sock" Jul 15 04:38:37.008822 systemd[1]: Started sshd@1-172.31.29.20:22-139.178.89.65:40036.service - OpenSSH per-connection server daemon (139.178.89.65:40036). Jul 15 04:38:37.027293 etcd-wrapper[2107]: Error response from daemon: No such container: etcd-member Jul 15 04:38:37.055468 etcd-wrapper[2365]: Error response from daemon: No such container: etcd-member Jul 15 04:38:37.134832 etcd-wrapper[2386]: Unable to find image 'quay.io/coreos/etcd:v3.5.16-arm64' locally Jul 15 04:38:37.157263 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.1570 INFO [EC2Identity] Checking write access before registering Jul 15 04:38:37.201532 amazon-ssm-agent[2090]: 2025/07/15 04:38:37 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:37.201532 amazon-ssm-agent[2090]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Jul 15 04:38:37.201748 amazon-ssm-agent[2090]: 2025/07/15 04:38:37 processing appconfig overrides Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.1584 INFO [EC2Identity] Registering EC2 instance with Systems Manager Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2010 INFO [EC2Identity] EC2 registration was successful. Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2010 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2013 INFO [CredentialRefresher] credentialRefresher has started Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2013 INFO [CredentialRefresher] Starting credentials refresher loop Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2356 INFO EC2RoleProvider Successfully connected with instance profile role credentials Jul 15 04:38:37.236194 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2359 INFO [CredentialRefresher] Credentials ready Jul 15 04:38:37.257840 amazon-ssm-agent[2090]: 2025-07-15 04:38:37.2361 INFO [CredentialRefresher] Next credential rotation will be in 29.9999923727 minutes Jul 15 04:38:37.261300 sshd[2364]: Accepted publickey for core from 139.178.89.65 port 40036 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:37.263821 sshd-session[2364]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:37.271786 systemd-logind[1880]: New session 2 of user core. Jul 15 04:38:37.281395 systemd[1]: Started session-2.scope - Session 2 of User core. Jul 15 04:38:37.412222 sshd[2394]: Connection closed by 139.178.89.65 port 40036 Jul 15 04:38:37.413035 sshd-session[2364]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:37.419646 systemd-logind[1880]: Session 2 logged out. Waiting for processes to exit. Jul 15 04:38:37.421240 systemd[1]: sshd@1-172.31.29.20:22-139.178.89.65:40036.service: Deactivated successfully. Jul 15 04:38:37.424864 systemd[1]: session-2.scope: Deactivated successfully. Jul 15 04:38:37.428721 systemd-logind[1880]: Removed session 2. Jul 15 04:38:37.448934 systemd[1]: Started sshd@2-172.31.29.20:22-139.178.89.65:40050.service - OpenSSH per-connection server daemon (139.178.89.65:40050). Jul 15 04:38:37.645113 sshd[2400]: Accepted publickey for core from 139.178.89.65 port 40050 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:37.647666 sshd-session[2400]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:37.658537 systemd-logind[1880]: New session 3 of user core. Jul 15 04:38:37.671698 systemd[1]: Started session-3.scope - Session 3 of User core. Jul 15 04:38:37.801393 sshd[2403]: Connection closed by 139.178.89.65 port 40050 Jul 15 04:38:37.802338 sshd-session[2400]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:37.810369 systemd[1]: sshd@2-172.31.29.20:22-139.178.89.65:40050.service: Deactivated successfully. Jul 15 04:38:37.815085 systemd[1]: session-3.scope: Deactivated successfully. Jul 15 04:38:37.818068 systemd-logind[1880]: Session 3 logged out. Waiting for processes to exit. Jul 15 04:38:37.821607 systemd-logind[1880]: Removed session 3. Jul 15 04:38:38.255683 etcd-wrapper[2386]: v3.5.16-arm64: Pulling from coreos/etcd Jul 15 04:38:38.258052 etcd-wrapper[2386]: d10f96ed9607: Pulling fs layer Jul 15 04:38:38.258052 etcd-wrapper[2386]: 2ae710cd8bfe: Pulling fs layer Jul 15 04:38:38.258052 etcd-wrapper[2386]: d462aa345367: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: 0f8b424aa0b9: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: d557676654e5: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: c8022d07192e: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: d858cbc252ad: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: 1069fc2daed1: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: b40161cd83fc: Pulling fs layer Jul 15 04:38:38.259664 etcd-wrapper[2386]: 5318d93a3a65: Pulling fs layer Jul 15 04:38:38.260425 etcd-wrapper[2386]: 307c1adadb60: Pulling fs layer Jul 15 04:38:38.260589 etcd-wrapper[2386]: f9b3c65df792: Pulling fs layer Jul 15 04:38:38.260810 etcd-wrapper[2386]: 5709b4a82c35: Pulling fs layer Jul 15 04:38:38.260810 etcd-wrapper[2386]: d5372e382b07: Pulling fs layer Jul 15 04:38:38.260810 etcd-wrapper[2386]: 9c3b5253dddc: Pulling fs layer Jul 15 04:38:38.261782 etcd-wrapper[2386]: 7a57323f7551: Pulling fs layer Jul 15 04:38:38.261782 etcd-wrapper[2386]: b40161cd83fc: Waiting Jul 15 04:38:38.261782 etcd-wrapper[2386]: 5318d93a3a65: Waiting Jul 15 04:38:38.261782 etcd-wrapper[2386]: 307c1adadb60: Waiting Jul 15 04:38:38.261782 etcd-wrapper[2386]: f9b3c65df792: Waiting Jul 15 04:38:38.261782 etcd-wrapper[2386]: 5709b4a82c35: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: d5372e382b07: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: 9c3b5253dddc: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: 7a57323f7551: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: 0f8b424aa0b9: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: d557676654e5: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: c8022d07192e: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: d858cbc252ad: Waiting Jul 15 04:38:38.264401 etcd-wrapper[2386]: 1069fc2daed1: Waiting Jul 15 04:38:38.277008 amazon-ssm-agent[2090]: 2025-07-15 04:38:38.2766 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Jul 15 04:38:38.378398 amazon-ssm-agent[2090]: 2025-07-15 04:38:38.2804 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2411) started Jul 15 04:38:38.478725 amazon-ssm-agent[2090]: 2025-07-15 04:38:38.2804 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Jul 15 04:38:38.492581 etcd-wrapper[2386]: 2ae710cd8bfe: Download complete Jul 15 04:38:38.496087 etcd-wrapper[2386]: d10f96ed9607: Verifying Checksum Jul 15 04:38:38.496087 etcd-wrapper[2386]: d10f96ed9607: Download complete Jul 15 04:38:38.527612 etcd-wrapper[2386]: d462aa345367: Verifying Checksum Jul 15 04:38:38.531351 etcd-wrapper[2386]: d462aa345367: Download complete Jul 15 04:38:38.584772 etcd-wrapper[2386]: d10f96ed9607: Pull complete Jul 15 04:38:38.626078 systemd[1]: var-lib-docker-overlay2-52f341a1aeecca451fd5441fa8cd2fb4b4af9f3d163479dd7ecf495562f56dbf-merged.mount: Deactivated successfully. Jul 15 04:38:38.665806 etcd-wrapper[2386]: 2ae710cd8bfe: Pull complete Jul 15 04:38:38.727031 etcd-wrapper[2386]: d557676654e5: Verifying Checksum Jul 15 04:38:38.727334 etcd-wrapper[2386]: d557676654e5: Download complete Jul 15 04:38:38.787620 etcd-wrapper[2386]: c8022d07192e: Verifying Checksum Jul 15 04:38:38.787620 etcd-wrapper[2386]: c8022d07192e: Download complete Jul 15 04:38:38.892534 etcd-wrapper[2386]: 0f8b424aa0b9: Verifying Checksum Jul 15 04:38:38.892879 etcd-wrapper[2386]: 0f8b424aa0b9: Download complete Jul 15 04:38:38.981633 etcd-wrapper[2386]: d858cbc252ad: Verifying Checksum Jul 15 04:38:38.981633 etcd-wrapper[2386]: d858cbc252ad: Download complete Jul 15 04:38:39.018550 etcd-wrapper[2386]: 1069fc2daed1: Verifying Checksum Jul 15 04:38:39.018716 etcd-wrapper[2386]: 1069fc2daed1: Download complete Jul 15 04:38:39.125287 etcd-wrapper[2386]: b40161cd83fc: Verifying Checksum Jul 15 04:38:39.125287 etcd-wrapper[2386]: b40161cd83fc: Download complete Jul 15 04:38:39.222020 etcd-wrapper[2386]: 5318d93a3a65: Verifying Checksum Jul 15 04:38:39.222211 etcd-wrapper[2386]: 5318d93a3a65: Download complete Jul 15 04:38:39.257540 etcd-wrapper[2386]: 307c1adadb60: Verifying Checksum Jul 15 04:38:39.258122 etcd-wrapper[2386]: 307c1adadb60: Download complete Jul 15 04:38:39.445249 etcd-wrapper[2386]: f9b3c65df792: Verifying Checksum Jul 15 04:38:39.445610 etcd-wrapper[2386]: f9b3c65df792: Download complete Jul 15 04:38:39.587506 etcd-wrapper[2386]: 5709b4a82c35: Verifying Checksum Jul 15 04:38:39.587818 etcd-wrapper[2386]: 5709b4a82c35: Download complete Jul 15 04:38:39.609911 etcd-wrapper[2386]: d5372e382b07: Verifying Checksum Jul 15 04:38:39.610217 etcd-wrapper[2386]: d5372e382b07: Download complete Jul 15 04:38:39.635822 systemd[1]: var-lib-docker-overlay2-964b6ac9f5255448256b93a886cac04e840e1ecbe1a79f9322ad701489913581-merged.mount: Deactivated successfully. Jul 15 04:38:39.693431 etcd-wrapper[2386]: 9c3b5253dddc: Verifying Checksum Jul 15 04:38:39.693726 etcd-wrapper[2386]: 9c3b5253dddc: Download complete Jul 15 04:38:39.722202 etcd-wrapper[2386]: d462aa345367: Pull complete Jul 15 04:38:39.746976 systemd[1]: var-lib-docker-overlay2-3384f30790204409b2cfd3effb43b4dc0279b2858a27b1dd3fbcad37f88cd9b1-merged.mount: Deactivated successfully. Jul 15 04:38:39.755089 etcd-wrapper[2386]: 0f8b424aa0b9: Pull complete Jul 15 04:38:39.781064 systemd[1]: var-lib-docker-overlay2-8fd5b584ed764e91c66221ba39d8940d5d1cc0cc0514b94170873c6ae7a2c8df-merged.mount: Deactivated successfully. Jul 15 04:38:39.794947 etcd-wrapper[2386]: d557676654e5: Pull complete Jul 15 04:38:39.821503 etcd-wrapper[2386]: c8022d07192e: Pull complete Jul 15 04:38:39.828746 etcd-wrapper[2386]: 7a57323f7551: Verifying Checksum Jul 15 04:38:39.829028 etcd-wrapper[2386]: 7a57323f7551: Download complete Jul 15 04:38:39.847230 etcd-wrapper[2386]: d858cbc252ad: Pull complete Jul 15 04:38:39.881406 etcd-wrapper[2386]: 1069fc2daed1: Pull complete Jul 15 04:38:39.920847 etcd-wrapper[2386]: b40161cd83fc: Pull complete Jul 15 04:38:39.968340 etcd-wrapper[2386]: 5318d93a3a65: Pull complete Jul 15 04:38:40.020389 etcd-wrapper[2386]: 307c1adadb60: Pull complete Jul 15 04:38:40.337902 etcd-wrapper[2386]: f9b3c65df792: Pull complete Jul 15 04:38:40.573625 etcd-wrapper[2386]: 5709b4a82c35: Pull complete Jul 15 04:38:40.740349 systemd[1]: var-lib-docker-overlay2-b6d824e5a4d0ab8829d7cfabbf59c8e1ff177b4480d904c3bd55e137145f46ed-merged.mount: Deactivated successfully. Jul 15 04:38:40.773317 etcd-wrapper[2386]: d5372e382b07: Pull complete Jul 15 04:38:40.806377 systemd[1]: var-lib-docker-overlay2-788a49ecebe4a077bf555a476834d54b355f423b8e8b0ae7e7b6f870d369867b-merged.mount: Deactivated successfully. Jul 15 04:38:40.816318 etcd-wrapper[2386]: 9c3b5253dddc: Pull complete Jul 15 04:38:40.843988 etcd-wrapper[2386]: 7a57323f7551: Pull complete Jul 15 04:38:40.866873 etcd-wrapper[2386]: Digest: sha256:bdb64177a9250b4d594af525f4225c2d0657a251a6e38102a2ead39f67370db2 Jul 15 04:38:40.870221 etcd-wrapper[2386]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16-arm64 Jul 15 04:38:40.934044 containerd[1902]: time="2025-07-15T04:38:40.933910521Z" level=info msg="connecting to shim 7bdc79ca08badf58333ccfbaf102671608546d0c94c60cc1f0de54b93abd6a70" address="unix:///run/containerd/s/01e03627d4c311e6970a6e45cbc3aca10c35e6f0d9699b3d2baa7affb7bb0e3e" namespace=moby protocol=ttrpc version=3 Jul 15 04:38:40.973435 systemd[1]: Started docker-7bdc79ca08badf58333ccfbaf102671608546d0c94c60cc1f0de54b93abd6a70.scope - libcontainer container 7bdc79ca08badf58333ccfbaf102671608546d0c94c60cc1f0de54b93abd6a70. Jul 15 04:38:41.112432 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.111923Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Jul 15 04:38:41.112962 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.112122Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec27f816bab735a4b3315e4bedc25686"} Jul 15 04:38:41.112962 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.112613Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.113222Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16-arm64"} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.113269Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.113285Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.113406Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.113456Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.31.29.20:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.31.29.20:2380","--advertise-client-urls=http://172.31.29.20:2379","--discovery=https://discovery.etcd.io/1b412d962253406209ba0eed6cbf159d"]} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.113568Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.113600Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://172.31.29.20:2380"]} Jul 15 04:38:41.114594 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.113844Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Jul 15 04:38:41.115304 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.114077Z","caller":"embed/etcd.go:311","msg":"starting an etcd server","etcd-version":"3.5.16","git-sha":"f20bbad","go-version":"go1.22.7","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec27f816bab735a4b3315e4bedc25686","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,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://172.31.29.20:2380"],"listen-peer-urls":["http://172.31.29.20:2380"],"advertise-client-urls":["http://172.31.29.20:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec27f816bab735a4b3315e4bedc25686=http://172.31.29.20:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/1b412d962253406209ba0eed6cbf159d","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"https://discovery.etcd.io/1b412d962253406209ba0eed6cbf159d","discovery-proxy":"","downgrade-check-interval":"5s"} Jul 15 04:38:41.118298 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.117800Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"1.750944ms"} Jul 15 04:38:41.644785 systemd[1]: var-lib-docker-overlay2-64c7f289abc558d833ed3a9bfab32fbf2be4a47dba5bda6eb8d5815ebbc368c5-merged.mount: Deactivated successfully. Jul 15 04:38:41.717512 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.717056Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"1c0055ce0bb76f86"} Jul 15 04:38:41.717512 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.717112Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"472bea4933ab11d4"} Jul 15 04:38:41.718553 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.717142Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"c9cb58b8e9d1faf7"} Jul 15 04:38:41.718553 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.717217Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Jul 15 04:38:41.722041 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.721707Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"c9cb58b8e9d1faf7","cluster-id":"28c956a9c9aa84a5"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=()"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722683Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became follower at term 0"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c9cb58b8e9d1faf7 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722722Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became follower at term 1"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722777Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158)"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722814Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158 5128450200811803092)"} Jul 15 04:38:41.723480 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.722846Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158 5128450200811803092 14540813373115857655)"} Jul 15 04:38:41.724766 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:41.724534Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Jul 15 04:38:41.726432 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.725980Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Jul 15 04:38:41.727421 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.727017Z","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"} Jul 15 04:38:41.729993 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.728070Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.729993 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.728348Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.730526 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.728997Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.731926 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.731610Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.732549 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.731716Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.732549 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.731605Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.732549 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.731654Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.733415 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733014Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86","remote-peer-urls":["http://172.31.31.24:2380"]} Jul 15 04:38:41.733415 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733210Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.734089 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733331Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.734089 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733697Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.734619 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733673Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.734619 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.733902Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.735652 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.735292Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.739253 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737010Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737398Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4","remote-peer-urls":["http://172.31.26.204:2380"]} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737459Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"c9cb58b8e9d1faf7","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737546Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737613Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737636Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737751Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737044Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737075Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.738674Z","caller":"etcdserver/server.go:773","msg":"starting initial election tick advance","election-ticks":10} Jul 15 04:38:41.739845 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.737257Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.740735 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739270Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158 5128450200811803092 14540813373115857655)"} Jul 15 04:38:41.740735 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739389Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"28c956a9c9aa84a5","local-member-id":"c9cb58b8e9d1faf7","added-peer-id":"1c0055ce0bb76f86","added-peer-peer-urls":["http://172.31.31.24:2380"]} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739528Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158 5128450200811803092 14540813373115857655)"} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739735Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"28c956a9c9aa84a5","local-member-id":"c9cb58b8e9d1faf7","added-peer-id":"472bea4933ab11d4","added-peer-peer-urls":["http://172.31.26.204:2380"]} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739869Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 switched to configuration voters=(2017706976510177158 5128450200811803092 14540813373115857655)"} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.739961Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"28c956a9c9aa84a5","local-member-id":"c9cb58b8e9d1faf7","added-peer-id":"c9cb58b8e9d1faf7","added-peer-peer-urls":["http://172.31.29.20:2380"]} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.740695Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.740761Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.741301 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.740857Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.743735 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.743408Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"172.31.29.20:2380"} Jul 15 04:38:41.743735 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.743449Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"172.31.29.20:2380"} Jul 15 04:38:41.744382 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.743980Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"c9cb58b8e9d1faf7","to":"472bea4933ab11d4","stream-type":"stream Message"} Jul 15 04:38:41.744382 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.744023Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.744911 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.744317Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"c9cb58b8e9d1faf7","to":"1c0055ce0bb76f86","stream-type":"stream Message"} Jul 15 04:38:41.744911 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.744378Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.744911 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.744609Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"c9cb58b8e9d1faf7","to":"1c0055ce0bb76f86","stream-type":"stream MsgApp v2"} Jul 15 04:38:41.744911 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.744633Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:38:41.745905 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.745614Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"c9cb58b8e9d1faf7","initial-advertise-peer-urls":["http://172.31.29.20:2380"],"listen-peer-urls":["http://172.31.29.20:2380"],"advertise-client-urls":["http://172.31.29.20:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Jul 15 04:38:41.746283 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.745858Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"c9cb58b8e9d1faf7","to":"472bea4933ab11d4","stream-type":"stream MsgApp v2"} Jul 15 04:38:41.746283 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.745925Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:38:41.789331 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:41.788878Z","caller":"etcdserver/server.go:796","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"c9cb58b8e9d1faf7","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Jul 15 04:38:42.237890 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.237334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 1c0055ce0bb76f86 [logterm: 1, index: 3] at term 1"} Jul 15 04:38:42.239410 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.238925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [term: 1] received a MsgVote message with higher term from 1c0055ce0bb76f86 [term: 2]"} Jul 15 04:38:42.239410 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.239054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became follower at term 2"} Jul 15 04:38:42.239410 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.239080Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 1, index: 3, vote: 0] cast MsgVote for 1c0055ce0bb76f86 [logterm: 1, index: 3] at term 2"} Jul 15 04:38:42.241351 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.241011Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 elected leader 1c0055ce0bb76f86 at term 2"} Jul 15 04:38:42.245046 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.243832Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"c9cb58b8e9d1faf7","local-member-attributes":"{Name:ec27f816bab735a4b3315e4bedc25686 ClientURLs:[http://172.31.29.20:2379]}","request-path":"/0/members/c9cb58b8e9d1faf7/attributes","cluster-id":"28c956a9c9aa84a5","publish-timeout":"7s"} Jul 15 04:38:42.245046 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.243860Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Jul 15 04:38:42.245605 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.244462Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Jul 15 04:38:42.245879 systemd[1]: Started etcd-member.service - etcd (System Application Container). Jul 15 04:38:42.246601 systemd[1]: Reached target multi-user.target - Multi-User System. Jul 15 04:38:42.247775 systemd[1]: Startup finished in 3.790s (kernel) + 9.239s (initrd) + 16.388s (userspace) = 29.417s. Jul 15 04:38:42.248957 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.245662Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Jul 15 04:38:42.248957 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.244835Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Jul 15 04:38:42.248957 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.246540Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Jul 15 04:38:42.251120 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.250711Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"28c956a9c9aa84a5","local-member-id":"c9cb58b8e9d1faf7","cluster-version":"3.5"} Jul 15 04:38:42.251120 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:42.250855Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Jul 15 04:38:47.837250 systemd[1]: Started sshd@3-172.31.29.20:22-139.178.89.65:42590.service - OpenSSH per-connection server daemon (139.178.89.65:42590). Jul 15 04:38:48.040328 sshd[2559]: Accepted publickey for core from 139.178.89.65 port 42590 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:48.042883 sshd-session[2559]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:48.051687 systemd-logind[1880]: New session 4 of user core. Jul 15 04:38:48.060523 systemd[1]: Started session-4.scope - Session 4 of User core. Jul 15 04:38:48.187596 sshd[2562]: Connection closed by 139.178.89.65 port 42590 Jul 15 04:38:48.188407 sshd-session[2559]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:48.195116 systemd-logind[1880]: Session 4 logged out. Waiting for processes to exit. Jul 15 04:38:48.196649 systemd[1]: sshd@3-172.31.29.20:22-139.178.89.65:42590.service: Deactivated successfully. Jul 15 04:38:48.200687 systemd[1]: session-4.scope: Deactivated successfully. Jul 15 04:38:48.204603 systemd-logind[1880]: Removed session 4. Jul 15 04:38:48.224595 systemd[1]: Started sshd@4-172.31.29.20:22-139.178.89.65:42606.service - OpenSSH per-connection server daemon (139.178.89.65:42606). Jul 15 04:38:48.432869 sshd[2568]: Accepted publickey for core from 139.178.89.65 port 42606 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:48.435351 sshd-session[2568]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:48.443018 systemd-logind[1880]: New session 5 of user core. Jul 15 04:38:48.450508 systemd[1]: Started session-5.scope - Session 5 of User core. Jul 15 04:38:48.573225 sshd[2571]: Connection closed by 139.178.89.65 port 42606 Jul 15 04:38:48.574077 sshd-session[2568]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:48.582489 systemd[1]: sshd@4-172.31.29.20:22-139.178.89.65:42606.service: Deactivated successfully. Jul 15 04:38:48.582552 systemd-logind[1880]: Session 5 logged out. Waiting for processes to exit. Jul 15 04:38:48.587034 systemd[1]: session-5.scope: Deactivated successfully. Jul 15 04:38:48.590773 systemd-logind[1880]: Removed session 5. Jul 15 04:38:48.610460 systemd[1]: Started sshd@5-172.31.29.20:22-139.178.89.65:42612.service - OpenSSH per-connection server daemon (139.178.89.65:42612). Jul 15 04:38:48.817786 sshd[2577]: Accepted publickey for core from 139.178.89.65 port 42612 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:48.820545 sshd-session[2577]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:48.828647 systemd-logind[1880]: New session 6 of user core. Jul 15 04:38:48.837463 systemd[1]: Started session-6.scope - Session 6 of User core. Jul 15 04:38:48.966519 sshd[2580]: Connection closed by 139.178.89.65 port 42612 Jul 15 04:38:48.967490 sshd-session[2577]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:48.975431 systemd[1]: sshd@5-172.31.29.20:22-139.178.89.65:42612.service: Deactivated successfully. Jul 15 04:38:48.979536 systemd[1]: session-6.scope: Deactivated successfully. Jul 15 04:38:48.981985 systemd-logind[1880]: Session 6 logged out. Waiting for processes to exit. Jul 15 04:38:48.985283 systemd-logind[1880]: Removed session 6. Jul 15 04:38:49.004542 systemd[1]: Started sshd@6-172.31.29.20:22-139.178.89.65:46686.service - OpenSSH per-connection server daemon (139.178.89.65:46686). Jul 15 04:38:49.204146 sshd[2586]: Accepted publickey for core from 139.178.89.65 port 46686 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:49.206552 sshd-session[2586]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:49.215441 systemd-logind[1880]: New session 7 of user core. Jul 15 04:38:49.228437 systemd[1]: Started session-7.scope - Session 7 of User core. Jul 15 04:38:49.352352 sudo[2590]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Jul 15 04:38:49.353081 sudo[2590]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 04:38:49.372392 sudo[2590]: pam_unix(sudo:session): session closed for user root Jul 15 04:38:49.397212 sshd[2589]: Connection closed by 139.178.89.65 port 46686 Jul 15 04:38:49.397288 sshd-session[2586]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:49.405036 systemd-logind[1880]: Session 7 logged out. Waiting for processes to exit. Jul 15 04:38:49.406571 systemd[1]: sshd@6-172.31.29.20:22-139.178.89.65:46686.service: Deactivated successfully. Jul 15 04:38:49.410455 systemd[1]: session-7.scope: Deactivated successfully. Jul 15 04:38:49.415909 systemd-logind[1880]: Removed session 7. Jul 15 04:38:49.435046 systemd[1]: Started sshd@7-172.31.29.20:22-139.178.89.65:46700.service - OpenSSH per-connection server daemon (139.178.89.65:46700). Jul 15 04:38:49.640432 sshd[2596]: Accepted publickey for core from 139.178.89.65 port 46700 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:49.642847 sshd-session[2596]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:49.650317 systemd-logind[1880]: New session 8 of user core. Jul 15 04:38:49.657428 systemd[1]: Started session-8.scope - Session 8 of User core. Jul 15 04:38:49.760942 sudo[2601]: 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 Jul 15 04:38:49.762265 sudo[2601]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 04:38:49.770216 sudo[2601]: pam_unix(sudo:session): session closed for user root Jul 15 04:38:49.779962 sudo[2600]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Jul 15 04:38:49.780603 sudo[2600]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Jul 15 04:38:49.796812 systemd[1]: Starting audit-rules.service - Load Audit Rules... Jul 15 04:38:49.856440 augenrules[2623]: No rules Jul 15 04:38:49.858621 systemd[1]: audit-rules.service: Deactivated successfully. Jul 15 04:38:49.860255 systemd[1]: Finished audit-rules.service - Load Audit Rules. Jul 15 04:38:49.862484 sudo[2600]: pam_unix(sudo:session): session closed for user root Jul 15 04:38:49.886094 sshd[2599]: Connection closed by 139.178.89.65 port 46700 Jul 15 04:38:49.886297 sshd-session[2596]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:49.891975 systemd[1]: sshd@7-172.31.29.20:22-139.178.89.65:46700.service: Deactivated successfully. Jul 15 04:38:49.895628 systemd[1]: session-8.scope: Deactivated successfully. Jul 15 04:38:49.899556 systemd-logind[1880]: Session 8 logged out. Waiting for processes to exit. Jul 15 04:38:49.901981 systemd-logind[1880]: Removed session 8. Jul 15 04:38:49.917647 systemd[1]: Started sshd@8-172.31.29.20:22-139.178.89.65:46716.service - OpenSSH per-connection server daemon (139.178.89.65:46716). Jul 15 04:38:50.106501 sshd[2632]: Accepted publickey for core from 139.178.89.65 port 46716 ssh2: RSA SHA256:OM8Z8cK0hFjQDS+avOAag4EvUCsx3+0prlBsjg6IecE Jul 15 04:38:50.108764 sshd-session[2632]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Jul 15 04:38:50.118487 systemd-logind[1880]: New session 9 of user core. Jul 15 04:38:50.124417 systemd[1]: Started session-9.scope - Session 9 of User core. Jul 15 04:38:50.347850 sshd[2635]: Connection closed by 139.178.89.65 port 46716 Jul 15 04:38:50.346908 sshd-session[2632]: pam_unix(sshd:session): session closed for user core Jul 15 04:38:50.353527 systemd[1]: sshd@8-172.31.29.20:22-139.178.89.65:46716.service: Deactivated successfully. Jul 15 04:38:50.356406 systemd[1]: session-9.scope: Deactivated successfully. Jul 15 04:38:50.360965 systemd-logind[1880]: Session 9 logged out. Waiting for processes to exit. Jul 15 04:38:50.362954 systemd-logind[1880]: Removed session 9. Jul 15 04:38:53.660875 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:53.660412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [term: 2] received a MsgVote message with higher term from 472bea4933ab11d4 [term: 3]"} Jul 15 04:38:53.660875 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:53.660459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became follower at term 3"} Jul 15 04:38:53.660875 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:53.660479Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 2, index: 11, vote: 0] cast MsgVote for 472bea4933ab11d4 [logterm: 2, index: 11] at term 3"} Jul 15 04:38:53.660875 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:53.660496Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 lost leader 1c0055ce0bb76f86 at term 3"} Jul 15 04:38:53.662677 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:38:53.662283Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 elected leader 472bea4933ab11d4 at term 3"} Jul 15 04:38:53.761695 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:53.761276Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86","error":"EOF"} Jul 15 04:38:53.762047 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:53.761505Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86","error":"EOF"} Jul 15 04:38:53.774300 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:38:53.773854Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"1c0055ce0bb76f86","error":"failed to dial 1c0055ce0bb76f86 on stream Message (peer 1c0055ce0bb76f86 failed to find local node c9cb58b8e9d1faf7)"} Jul 15 04:39:00.063319 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:00.062891Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:39:00.066176 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:00.065741Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"1c0055ce0bb76f86"} Jul 15 04:39:05.182456 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.567795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [term 3] received MsgTimeoutNow from 472bea4933ab11d4 and starts an election to get leadership."} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.567842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 3"} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.567863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became candidate at term 4"} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.567958Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.567989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 3, index: 12] sent MsgVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.568023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 3, index: 12] sent MsgVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:15.568419 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.568045Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 lost leader 472bea4933ab11d4 at term 4"} Jul 15 04:39:15.575245 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.574773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgVoteResp from 472bea4933ab11d4 at term 4"} Jul 15 04:39:15.575245 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.574825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 has received 2 MsgVoteResp votes and 0 vote rejections"} Jul 15 04:39:15.575245 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.574893Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became leader at term 4"} Jul 15 04:39:15.575245 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:15.574927Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 elected leader c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:15.671519 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:15.670858Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4","error":"EOF"} Jul 15 04:39:15.672201 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:15.671242Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4","error":"EOF"} Jul 15 04:39:15.675025 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:15.674707Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"472bea4933ab11d4","error":"failed to dial 472bea4933ab11d4 on stream Message (peer 472bea4933ab11d4 failed to find local node c9cb58b8e9d1faf7)"} Jul 15 04:39:16.024100 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:16.023711Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:39:16.733992 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:16.733514Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"1c0055ce0bb76f86","rtt":"362.089µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:16.733992 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:16.733614Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"1c0055ce0bb76f86","rtt":"683.92µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:17.523747 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:17.523284Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"c9cb58b8e9d1faf7 stepped down to follower since quorum is not active"} Jul 15 04:39:17.523747 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:17.523351Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became follower at term 4"} Jul 15 04:39:17.523747 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:17.523370Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c9cb58b8e9d1faf7 lost leader c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:17.581406 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:17.580457Z","caller":"etcdserver/cluster_util.go:294","msg":"failed to reach the peer URL","address":"http://172.31.31.24:2380/version","remote-member-id":"1c0055ce0bb76f86","error":"Get \"http://172.31.31.24:2380/version\": dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:17.581406 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:17.580525Z","caller":"etcdserver/cluster_util.go:158","msg":"failed to get version","remote-member-id":"1c0055ce0bb76f86","error":"Get \"http://172.31.31.24:2380/version\": dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:17.581406 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:17.580953Z","caller":"etcdserver/cluster_util.go:294","msg":"failed to reach the peer URL","address":"http://172.31.26.204:2380/version","remote-member-id":"472bea4933ab11d4","error":"Get \"http://172.31.26.204:2380/version\": dial tcp 172.31.26.204:2380: connect: connection refused"} Jul 15 04:39:17.581406 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:17.581118Z","caller":"etcdserver/cluster_util.go:158","msg":"failed to get version","remote-member-id":"472bea4933ab11d4","error":"Get \"http://172.31.26.204:2380/version\": dial tcp 172.31.26.204:2380: connect: connection refused"} Jul 15 04:39:17.843298 update_engine[1882]: I20250715 04:39:17.842860 1882 update_attempter.cc:509] Updating boot flags... Jul 15 04:39:19.223607 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:19.223241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 4"} Jul 15 04:39:19.223607 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:19.223295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became pre-candidate at term 4"} Jul 15 04:39:19.223607 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:19.223317Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgPreVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:19.224463 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:19.223622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:19.224463 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:19.223678Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:20.923600 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:20.923148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 4"} Jul 15 04:39:20.923600 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:20.923221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became pre-candidate at term 4"} Jul 15 04:39:20.923600 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:20.923244Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgPreVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:20.923600 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:20.923271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:20.924508 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:20.923301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:21.734478 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:21.733940Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"1c0055ce0bb76f86","rtt":"362.089µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:21.734478 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:21.734074Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"1c0055ce0bb76f86","rtt":"683.92µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:21.736665 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:21.736317Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"c9cb58b8e9d1faf7","remote-peer-id":"472bea4933ab11d4"} Jul 15 04:39:22.623725 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:22.623123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 4"} Jul 15 04:39:22.623725 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:22.623197Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became pre-candidate at term 4"} Jul 15 04:39:22.623725 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:22.623220Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgPreVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:22.623725 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:22.623248Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:22.623725 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:22.623321Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:24.324199 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:24.323467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 4"} Jul 15 04:39:24.324199 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:24.323518Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became pre-candidate at term 4"} Jul 15 04:39:24.324199 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:24.323547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgPreVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:24.324199 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:24.323574Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:24.324199 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:24.323592Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:26.024660 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:26.023942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 is starting a new election at term 4"} Jul 15 04:39:26.024660 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:26.023991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 became pre-candidate at term 4"} Jul 15 04:39:26.024660 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:26.024012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 received MsgPreVoteResp from c9cb58b8e9d1faf7 at term 4"} Jul 15 04:39:26.024660 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:26.024038Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 1c0055ce0bb76f86 at term 4"} Jul 15 04:39:26.024660 etcd-wrapper[2386]: {"level":"info","ts":"2025-07-15T04:39:26.024056Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c9cb58b8e9d1faf7 [logterm: 4, index: 13] sent MsgPreVote request to 472bea4933ab11d4 at term 4"} Jul 15 04:39:26.734692 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:26.734278Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"1c0055ce0bb76f86","rtt":"362.089µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"} Jul 15 04:39:26.734692 etcd-wrapper[2386]: {"level":"warn","ts":"2025-07-15T04:39:26.734300Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"1c0055ce0bb76f86","rtt":"683.92µs","error":"dial tcp 172.31.31.24:2380: i/o timeout"}