Aug 19 00:34:19.101725 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Aug 19 00:34:19.101767 kernel: Linux version 6.12.41-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 p4) 2.44.0) #1 SMP PREEMPT Mon Aug 18 22:15:14 -00 2025 Aug 19 00:34:19.101790 kernel: KASLR disabled due to lack of seed Aug 19 00:34:19.101807 kernel: efi: EFI v2.7 by EDK II Aug 19 00:34:19.101823 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a731a98 MEMRESERVE=0x78551598 Aug 19 00:34:19.101838 kernel: secureboot: Secure boot disabled Aug 19 00:34:19.101855 kernel: ACPI: Early table checksum verification disabled Aug 19 00:34:19.101870 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Aug 19 00:34:19.101886 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Aug 19 00:34:19.101901 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Aug 19 00:34:19.101917 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Aug 19 00:34:19.101936 kernel: ACPI: FACS 0x0000000078630000 000040 Aug 19 00:34:19.101951 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Aug 19 00:34:19.101966 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Aug 19 00:34:19.101984 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Aug 19 00:34:19.102000 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Aug 19 00:34:19.102020 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Aug 19 00:34:19.102036 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Aug 19 00:34:19.102052 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Aug 19 00:34:19.102068 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Aug 19 00:34:19.102084 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Aug 19 00:34:19.102100 kernel: printk: legacy bootconsole [uart0] enabled Aug 19 00:34:19.102116 kernel: ACPI: Use ACPI SPCR as default console: Yes Aug 19 00:34:19.102133 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Aug 19 00:34:19.102149 kernel: NODE_DATA(0) allocated [mem 0x4b584ca00-0x4b5853fff] Aug 19 00:34:19.102165 kernel: Zone ranges: Aug 19 00:34:19.102181 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Aug 19 00:34:19.102201 kernel: DMA32 empty Aug 19 00:34:19.102217 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Aug 19 00:34:19.102233 kernel: Device empty Aug 19 00:34:19.102248 kernel: Movable zone start for each node Aug 19 00:34:19.102264 kernel: Early memory node ranges Aug 19 00:34:19.102280 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Aug 19 00:34:19.102296 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Aug 19 00:34:19.102312 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Aug 19 00:34:19.102328 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Aug 19 00:34:19.103324 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Aug 19 00:34:19.103396 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Aug 19 00:34:19.103415 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Aug 19 00:34:19.103440 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Aug 19 00:34:19.103463 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Aug 19 00:34:19.103481 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Aug 19 00:34:19.103498 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Aug 19 00:34:19.103516 kernel: psci: probing for conduit method from ACPI. Aug 19 00:34:19.103537 kernel: psci: PSCIv1.0 detected in firmware. Aug 19 00:34:19.103554 kernel: psci: Using standard PSCI v0.2 function IDs Aug 19 00:34:19.103571 kernel: psci: Trusted OS migration not required Aug 19 00:34:19.103588 kernel: psci: SMC Calling Convention v1.1 Aug 19 00:34:19.103605 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Aug 19 00:34:19.103622 kernel: percpu: Embedded 33 pages/cpu s98200 r8192 d28776 u135168 Aug 19 00:34:19.103639 kernel: pcpu-alloc: s98200 r8192 d28776 u135168 alloc=33*4096 Aug 19 00:34:19.103656 kernel: pcpu-alloc: [0] 0 [0] 1 Aug 19 00:34:19.103674 kernel: Detected PIPT I-cache on CPU0 Aug 19 00:34:19.103691 kernel: CPU features: detected: GIC system register CPU interface Aug 19 00:34:19.103709 kernel: CPU features: detected: Spectre-v2 Aug 19 00:34:19.103730 kernel: CPU features: detected: Spectre-v3a Aug 19 00:34:19.103748 kernel: CPU features: detected: Spectre-BHB Aug 19 00:34:19.103766 kernel: CPU features: detected: ARM erratum 1742098 Aug 19 00:34:19.103783 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Aug 19 00:34:19.103800 kernel: alternatives: applying boot alternatives Aug 19 00:34:19.103820 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=a868ccde263e96e0a18737fdbf04ca04bbf30dfe23963f1ae3994966e8fc9468 Aug 19 00:34:19.103838 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Aug 19 00:34:19.103856 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Aug 19 00:34:19.103873 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Aug 19 00:34:19.103890 kernel: Fallback order for Node 0: 0 Aug 19 00:34:19.103910 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Aug 19 00:34:19.103927 kernel: Policy zone: Normal Aug 19 00:34:19.103944 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Aug 19 00:34:19.103961 kernel: software IO TLB: area num 2. Aug 19 00:34:19.103977 kernel: software IO TLB: mapped [mem 0x000000006c600000-0x0000000070600000] (64MB) Aug 19 00:34:19.103994 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Aug 19 00:34:19.104011 kernel: rcu: Preemptible hierarchical RCU implementation. Aug 19 00:34:19.104029 kernel: rcu: RCU event tracing is enabled. Aug 19 00:34:19.104046 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Aug 19 00:34:19.104064 kernel: Trampoline variant of Tasks RCU enabled. Aug 19 00:34:19.104081 kernel: Tracing variant of Tasks RCU enabled. Aug 19 00:34:19.104098 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Aug 19 00:34:19.104118 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Aug 19 00:34:19.104136 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 19 00:34:19.104153 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Aug 19 00:34:19.104169 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Aug 19 00:34:19.104186 kernel: GICv3: 96 SPIs implemented Aug 19 00:34:19.104203 kernel: GICv3: 0 Extended SPIs implemented Aug 19 00:34:19.104219 kernel: Root IRQ handler: gic_handle_irq Aug 19 00:34:19.104236 kernel: GICv3: GICv3 features: 16 PPIs Aug 19 00:34:19.104252 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Aug 19 00:34:19.104269 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Aug 19 00:34:19.104285 kernel: ITS [mem 0x10080000-0x1009ffff] Aug 19 00:34:19.104302 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000f0000 (indirect, esz 8, psz 64K, shr 1) Aug 19 00:34:19.104323 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @400100000 (flat, esz 8, psz 64K, shr 1) Aug 19 00:34:19.106376 kernel: GICv3: using LPI property table @0x0000000400110000 Aug 19 00:34:19.106423 kernel: ITS: Using hypervisor restricted LPI range [128] Aug 19 00:34:19.106442 kernel: GICv3: CPU0: using allocated LPI pending table @0x0000000400120000 Aug 19 00:34:19.106459 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Aug 19 00:34:19.106476 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Aug 19 00:34:19.106494 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Aug 19 00:34:19.106511 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Aug 19 00:34:19.106528 kernel: Console: colour dummy device 80x25 Aug 19 00:34:19.106546 kernel: printk: legacy console [tty1] enabled Aug 19 00:34:19.106564 kernel: ACPI: Core revision 20240827 Aug 19 00:34:19.106590 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Aug 19 00:34:19.106607 kernel: pid_max: default: 32768 minimum: 301 Aug 19 00:34:19.106624 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Aug 19 00:34:19.106641 kernel: landlock: Up and running. Aug 19 00:34:19.106658 kernel: SELinux: Initializing. Aug 19 00:34:19.106675 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 19 00:34:19.106693 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Aug 19 00:34:19.106709 kernel: rcu: Hierarchical SRCU implementation. Aug 19 00:34:19.106727 kernel: rcu: Max phase no-delay instances is 400. Aug 19 00:34:19.106771 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Aug 19 00:34:19.106789 kernel: Remapping and enabling EFI services. Aug 19 00:34:19.106806 kernel: smp: Bringing up secondary CPUs ... Aug 19 00:34:19.106823 kernel: Detected PIPT I-cache on CPU1 Aug 19 00:34:19.106840 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Aug 19 00:34:19.106857 kernel: GICv3: CPU1: using allocated LPI pending table @0x0000000400130000 Aug 19 00:34:19.106875 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Aug 19 00:34:19.106891 kernel: smp: Brought up 1 node, 2 CPUs Aug 19 00:34:19.106909 kernel: SMP: Total of 2 processors activated. Aug 19 00:34:19.106939 kernel: CPU: All CPU(s) started at EL1 Aug 19 00:34:19.106957 kernel: CPU features: detected: 32-bit EL0 Support Aug 19 00:34:19.106979 kernel: CPU features: detected: 32-bit EL1 Support Aug 19 00:34:19.106997 kernel: CPU features: detected: CRC32 instructions Aug 19 00:34:19.107014 kernel: alternatives: applying system-wide alternatives Aug 19 00:34:19.107033 kernel: Memory: 3797096K/4030464K available (11136K kernel code, 2436K rwdata, 9060K rodata, 38912K init, 1038K bss, 212024K reserved, 16384K cma-reserved) Aug 19 00:34:19.107051 kernel: devtmpfs: initialized Aug 19 00:34:19.107073 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Aug 19 00:34:19.107091 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Aug 19 00:34:19.107109 kernel: 17056 pages in range for non-PLT usage Aug 19 00:34:19.107127 kernel: 508576 pages in range for PLT usage Aug 19 00:34:19.107145 kernel: pinctrl core: initialized pinctrl subsystem Aug 19 00:34:19.107162 kernel: SMBIOS 3.0.0 present. Aug 19 00:34:19.107180 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Aug 19 00:34:19.107198 kernel: DMI: Memory slots populated: 0/0 Aug 19 00:34:19.107216 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Aug 19 00:34:19.107237 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Aug 19 00:34:19.107256 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Aug 19 00:34:19.107274 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Aug 19 00:34:19.107291 kernel: audit: initializing netlink subsys (disabled) Aug 19 00:34:19.107309 kernel: audit: type=2000 audit(0.229:1): state=initialized audit_enabled=0 res=1 Aug 19 00:34:19.107327 kernel: thermal_sys: Registered thermal governor 'step_wise' Aug 19 00:34:19.107496 kernel: cpuidle: using governor menu Aug 19 00:34:19.107518 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Aug 19 00:34:19.107536 kernel: ASID allocator initialised with 65536 entries Aug 19 00:34:19.107560 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Aug 19 00:34:19.107578 kernel: Serial: AMBA PL011 UART driver Aug 19 00:34:19.107596 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Aug 19 00:34:19.107614 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Aug 19 00:34:19.107632 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Aug 19 00:34:19.107650 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Aug 19 00:34:19.107668 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Aug 19 00:34:19.107686 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Aug 19 00:34:19.107704 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Aug 19 00:34:19.107725 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Aug 19 00:34:19.107743 kernel: ACPI: Added _OSI(Module Device) Aug 19 00:34:19.107761 kernel: ACPI: Added _OSI(Processor Device) Aug 19 00:34:19.107779 kernel: ACPI: Added _OSI(Processor Aggregator Device) Aug 19 00:34:19.107797 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Aug 19 00:34:19.107815 kernel: ACPI: Interpreter enabled Aug 19 00:34:19.107832 kernel: ACPI: Using GIC for interrupt routing Aug 19 00:34:19.107851 kernel: ACPI: MCFG table detected, 1 entries Aug 19 00:34:19.107868 kernel: ACPI: CPU0 has been hot-added Aug 19 00:34:19.107889 kernel: ACPI: CPU1 has been hot-added Aug 19 00:34:19.107908 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Aug 19 00:34:19.108191 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Aug 19 00:34:19.109467 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Aug 19 00:34:19.109683 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Aug 19 00:34:19.109868 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Aug 19 00:34:19.110047 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Aug 19 00:34:19.110079 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Aug 19 00:34:19.110098 kernel: acpiphp: Slot [1] registered Aug 19 00:34:19.110117 kernel: acpiphp: Slot [2] registered Aug 19 00:34:19.110134 kernel: acpiphp: Slot [3] registered Aug 19 00:34:19.110152 kernel: acpiphp: Slot [4] registered Aug 19 00:34:19.110170 kernel: acpiphp: Slot [5] registered Aug 19 00:34:19.110188 kernel: acpiphp: Slot [6] registered Aug 19 00:34:19.110206 kernel: acpiphp: Slot [7] registered Aug 19 00:34:19.110223 kernel: acpiphp: Slot [8] registered Aug 19 00:34:19.110241 kernel: acpiphp: Slot [9] registered Aug 19 00:34:19.110263 kernel: acpiphp: Slot [10] registered Aug 19 00:34:19.110281 kernel: acpiphp: Slot [11] registered Aug 19 00:34:19.110299 kernel: acpiphp: Slot [12] registered Aug 19 00:34:19.110317 kernel: acpiphp: Slot [13] registered Aug 19 00:34:19.110335 kernel: acpiphp: Slot [14] registered Aug 19 00:34:19.111439 kernel: acpiphp: Slot [15] registered Aug 19 00:34:19.111461 kernel: acpiphp: Slot [16] registered Aug 19 00:34:19.111480 kernel: acpiphp: Slot [17] registered Aug 19 00:34:19.111498 kernel: acpiphp: Slot [18] registered Aug 19 00:34:19.111524 kernel: acpiphp: Slot [19] registered Aug 19 00:34:19.111543 kernel: acpiphp: Slot [20] registered Aug 19 00:34:19.111561 kernel: acpiphp: Slot [21] registered Aug 19 00:34:19.111578 kernel: acpiphp: Slot [22] registered Aug 19 00:34:19.111596 kernel: acpiphp: Slot [23] registered Aug 19 00:34:19.111614 kernel: acpiphp: Slot [24] registered Aug 19 00:34:19.111632 kernel: acpiphp: Slot [25] registered Aug 19 00:34:19.111650 kernel: acpiphp: Slot [26] registered Aug 19 00:34:19.111667 kernel: acpiphp: Slot [27] registered Aug 19 00:34:19.111685 kernel: acpiphp: Slot [28] registered Aug 19 00:34:19.111707 kernel: acpiphp: Slot [29] registered Aug 19 00:34:19.111725 kernel: acpiphp: Slot [30] registered Aug 19 00:34:19.111742 kernel: acpiphp: Slot [31] registered Aug 19 00:34:19.111760 kernel: PCI host bridge to bus 0000:00 Aug 19 00:34:19.112017 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Aug 19 00:34:19.112188 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Aug 19 00:34:19.114473 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Aug 19 00:34:19.114701 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Aug 19 00:34:19.114955 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Aug 19 00:34:19.115181 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Aug 19 00:34:19.115419 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Aug 19 00:34:19.115632 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Aug 19 00:34:19.115822 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Aug 19 00:34:19.116021 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Aug 19 00:34:19.116237 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Aug 19 00:34:19.116466 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Aug 19 00:34:19.116659 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Aug 19 00:34:19.116847 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Aug 19 00:34:19.117032 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Aug 19 00:34:19.117220 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref]: assigned Aug 19 00:34:19.119500 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff]: assigned Aug 19 00:34:19.119743 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80110000-0x80113fff]: assigned Aug 19 00:34:19.119941 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80114000-0x80117fff]: assigned Aug 19 00:34:19.120142 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff]: assigned Aug 19 00:34:19.120466 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Aug 19 00:34:19.120635 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Aug 19 00:34:19.120801 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Aug 19 00:34:19.120826 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Aug 19 00:34:19.120853 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Aug 19 00:34:19.120872 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Aug 19 00:34:19.120890 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Aug 19 00:34:19.120908 kernel: iommu: Default domain type: Translated Aug 19 00:34:19.120925 kernel: iommu: DMA domain TLB invalidation policy: strict mode Aug 19 00:34:19.120943 kernel: efivars: Registered efivars operations Aug 19 00:34:19.120961 kernel: vgaarb: loaded Aug 19 00:34:19.120979 kernel: clocksource: Switched to clocksource arch_sys_counter Aug 19 00:34:19.120997 kernel: VFS: Disk quotas dquot_6.6.0 Aug 19 00:34:19.121018 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Aug 19 00:34:19.121036 kernel: pnp: PnP ACPI init Aug 19 00:34:19.121237 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Aug 19 00:34:19.121264 kernel: pnp: PnP ACPI: found 1 devices Aug 19 00:34:19.121282 kernel: NET: Registered PF_INET protocol family Aug 19 00:34:19.121300 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Aug 19 00:34:19.121318 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Aug 19 00:34:19.121336 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Aug 19 00:34:19.122776 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Aug 19 00:34:19.122797 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Aug 19 00:34:19.122816 kernel: TCP: Hash tables configured (established 32768 bind 32768) Aug 19 00:34:19.122834 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 19 00:34:19.122852 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Aug 19 00:34:19.122870 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Aug 19 00:34:19.122888 kernel: PCI: CLS 0 bytes, default 64 Aug 19 00:34:19.122906 kernel: kvm [1]: HYP mode not available Aug 19 00:34:19.122924 kernel: Initialise system trusted keyrings Aug 19 00:34:19.122948 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Aug 19 00:34:19.122966 kernel: Key type asymmetric registered Aug 19 00:34:19.122983 kernel: Asymmetric key parser 'x509' registered Aug 19 00:34:19.123001 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Aug 19 00:34:19.123019 kernel: io scheduler mq-deadline registered Aug 19 00:34:19.123037 kernel: io scheduler kyber registered Aug 19 00:34:19.123055 kernel: io scheduler bfq registered Aug 19 00:34:19.123304 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Aug 19 00:34:19.123335 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Aug 19 00:34:19.123377 kernel: ACPI: button: Power Button [PWRB] Aug 19 00:34:19.123396 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Aug 19 00:34:19.123414 kernel: ACPI: button: Sleep Button [SLPB] Aug 19 00:34:19.123432 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Aug 19 00:34:19.123451 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Aug 19 00:34:19.123646 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Aug 19 00:34:19.123671 kernel: printk: legacy console [ttyS0] disabled Aug 19 00:34:19.123690 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Aug 19 00:34:19.123714 kernel: printk: legacy console [ttyS0] enabled Aug 19 00:34:19.123732 kernel: printk: legacy bootconsole [uart0] disabled Aug 19 00:34:19.123750 kernel: thunder_xcv, ver 1.0 Aug 19 00:34:19.123768 kernel: thunder_bgx, ver 1.0 Aug 19 00:34:19.123785 kernel: nicpf, ver 1.0 Aug 19 00:34:19.123803 kernel: nicvf, ver 1.0 Aug 19 00:34:19.124011 kernel: rtc-efi rtc-efi.0: registered as rtc0 Aug 19 00:34:19.124193 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-08-19T00:34:18 UTC (1755563658) Aug 19 00:34:19.124222 kernel: hid: raw HID events driver (C) Jiri Kosina Aug 19 00:34:19.124241 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Aug 19 00:34:19.124259 kernel: NET: Registered PF_INET6 protocol family Aug 19 00:34:19.124277 kernel: watchdog: NMI not fully supported Aug 19 00:34:19.124295 kernel: watchdog: Hard watchdog permanently disabled Aug 19 00:34:19.124313 kernel: Segment Routing with IPv6 Aug 19 00:34:19.124331 kernel: In-situ OAM (IOAM) with IPv6 Aug 19 00:34:19.124840 kernel: NET: Registered PF_PACKET protocol family Aug 19 00:34:19.124863 kernel: Key type dns_resolver registered Aug 19 00:34:19.124889 kernel: registered taskstats version 1 Aug 19 00:34:19.124908 kernel: Loading compiled-in X.509 certificates Aug 19 00:34:19.124926 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.41-flatcar: becc5a61d1c5dcbcd174f4649c64b863031dbaa8' Aug 19 00:34:19.124944 kernel: Demotion targets for Node 0: null Aug 19 00:34:19.124962 kernel: Key type .fscrypt registered Aug 19 00:34:19.124979 kernel: Key type fscrypt-provisioning registered Aug 19 00:34:19.124997 kernel: ima: No TPM chip found, activating TPM-bypass! Aug 19 00:34:19.125015 kernel: ima: Allocated hash algorithm: sha1 Aug 19 00:34:19.125032 kernel: ima: No architecture policies found Aug 19 00:34:19.125054 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Aug 19 00:34:19.125072 kernel: clk: Disabling unused clocks Aug 19 00:34:19.125090 kernel: PM: genpd: Disabling unused power domains Aug 19 00:34:19.125108 kernel: Warning: unable to open an initial console. Aug 19 00:34:19.125126 kernel: Freeing unused kernel memory: 38912K Aug 19 00:34:19.125144 kernel: Run /init as init process Aug 19 00:34:19.125162 kernel: with arguments: Aug 19 00:34:19.125180 kernel: /init Aug 19 00:34:19.125197 kernel: with environment: Aug 19 00:34:19.125214 kernel: HOME=/ Aug 19 00:34:19.125236 kernel: TERM=linux Aug 19 00:34:19.125253 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Aug 19 00:34:19.125273 systemd[1]: Successfully made /usr/ read-only. Aug 19 00:34:19.125298 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) Aug 19 00:34:19.125318 systemd[1]: Detected virtualization amazon. Aug 19 00:34:19.125337 systemd[1]: Detected architecture arm64. Aug 19 00:34:19.128018 systemd[1]: Running in initrd. Aug 19 00:34:19.128399 systemd[1]: No hostname configured, using default hostname. Aug 19 00:34:19.128774 systemd[1]: Hostname set to . Aug 19 00:34:19.129139 systemd[1]: Initializing machine ID from VM UUID. Aug 19 00:34:19.131126 systemd[1]: Queued start job for default target initrd.target. Aug 19 00:34:19.131169 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:34:19.131190 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:34:19.131212 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Aug 19 00:34:19.131232 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 19 00:34:19.131260 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Aug 19 00:34:19.131282 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Aug 19 00:34:19.131304 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Aug 19 00:34:19.131325 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Aug 19 00:34:19.131368 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:34:19.131391 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:34:19.131411 systemd[1]: Reached target paths.target - Path Units. Aug 19 00:34:19.131436 systemd[1]: Reached target slices.target - Slice Units. Aug 19 00:34:19.131457 systemd[1]: Reached target swap.target - Swaps. Aug 19 00:34:19.131477 systemd[1]: Reached target timers.target - Timer Units. Aug 19 00:34:19.131496 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Aug 19 00:34:19.131515 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 19 00:34:19.131535 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Aug 19 00:34:19.131554 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Aug 19 00:34:19.131573 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:34:19.131596 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 19 00:34:19.131616 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:34:19.131636 systemd[1]: Reached target sockets.target - Socket Units. Aug 19 00:34:19.131656 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Aug 19 00:34:19.131676 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 19 00:34:19.131696 systemd[1]: Finished network-cleanup.service - Network Cleanup. Aug 19 00:34:19.131716 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). Aug 19 00:34:19.131736 systemd[1]: Starting systemd-fsck-usr.service... Aug 19 00:34:19.131755 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 19 00:34:19.131779 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 19 00:34:19.131799 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:34:19.131818 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Aug 19 00:34:19.131839 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:34:19.131863 systemd[1]: Finished systemd-fsck-usr.service. Aug 19 00:34:19.131883 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Aug 19 00:34:19.131949 systemd-journald[259]: Collecting audit messages is disabled. Aug 19 00:34:19.131992 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Aug 19 00:34:19.132018 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Aug 19 00:34:19.132051 systemd-journald[259]: Journal started Aug 19 00:34:19.132091 systemd-journald[259]: Runtime Journal (/run/log/journal/ec2da4aafec4a6c228cf4f069ad9ce6b) is 8M, max 75.3M, 67.3M free. Aug 19 00:34:19.094533 systemd-modules-load[260]: Inserted module 'overlay' Aug 19 00:34:19.140336 kernel: Bridge firewalling registered Aug 19 00:34:19.140390 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 19 00:34:19.134474 systemd-modules-load[260]: Inserted module 'br_netfilter' Aug 19 00:34:19.146870 systemd[1]: Started systemd-journald.service - Journal Service. Aug 19 00:34:19.148046 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 19 00:34:19.151885 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:34:19.161463 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Aug 19 00:34:19.168833 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 19 00:34:19.186563 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 19 00:34:19.199412 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:34:19.218444 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:34:19.225861 systemd-tmpfiles[280]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Aug 19 00:34:19.238911 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:34:19.246927 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 19 00:34:19.253122 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 19 00:34:19.260194 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Aug 19 00:34:19.305020 dracut-cmdline[299]: 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=a868ccde263e96e0a18737fdbf04ca04bbf30dfe23963f1ae3994966e8fc9468 Aug 19 00:34:19.358488 systemd-resolved[298]: Positive Trust Anchors: Aug 19 00:34:19.360728 systemd-resolved[298]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 19 00:34:19.367066 systemd-resolved[298]: 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 Aug 19 00:34:19.454387 kernel: SCSI subsystem initialized Aug 19 00:34:19.462394 kernel: Loading iSCSI transport class v2.0-870. Aug 19 00:34:19.474392 kernel: iscsi: registered transport (tcp) Aug 19 00:34:19.496396 kernel: iscsi: registered transport (qla4xxx) Aug 19 00:34:19.496477 kernel: QLogic iSCSI HBA Driver Aug 19 00:34:19.528837 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 19 00:34:19.556824 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:34:19.563794 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 19 00:34:19.638378 kernel: random: crng init done Aug 19 00:34:19.638751 systemd-resolved[298]: Defaulting to hostname 'linux'. Aug 19 00:34:19.642848 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 19 00:34:19.647829 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:34:19.671827 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Aug 19 00:34:19.678941 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Aug 19 00:34:19.772390 kernel: raid6: neonx8 gen() 6470 MB/s Aug 19 00:34:19.789377 kernel: raid6: neonx4 gen() 6476 MB/s Aug 19 00:34:19.806378 kernel: raid6: neonx2 gen() 5383 MB/s Aug 19 00:34:19.823377 kernel: raid6: neonx1 gen() 3914 MB/s Aug 19 00:34:19.840376 kernel: raid6: int64x8 gen() 3596 MB/s Aug 19 00:34:19.857377 kernel: raid6: int64x4 gen() 3689 MB/s Aug 19 00:34:19.874376 kernel: raid6: int64x2 gen() 3563 MB/s Aug 19 00:34:19.892366 kernel: raid6: int64x1 gen() 2746 MB/s Aug 19 00:34:19.892405 kernel: raid6: using algorithm neonx4 gen() 6476 MB/s Aug 19 00:34:19.911316 kernel: raid6: .... xor() 4885 MB/s, rmw enabled Aug 19 00:34:19.911399 kernel: raid6: using neon recovery algorithm Aug 19 00:34:19.920000 kernel: xor: measuring software checksum speed Aug 19 00:34:19.920058 kernel: 8regs : 12583 MB/sec Aug 19 00:34:19.921177 kernel: 32regs : 12648 MB/sec Aug 19 00:34:19.923469 kernel: arm64_neon : 8698 MB/sec Aug 19 00:34:19.923504 kernel: xor: using function: 32regs (12648 MB/sec) Aug 19 00:34:20.015399 kernel: Btrfs loaded, zoned=no, fsverity=no Aug 19 00:34:20.027176 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Aug 19 00:34:20.035901 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:34:20.085715 systemd-udevd[507]: Using default interface naming scheme 'v255'. Aug 19 00:34:20.096543 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:34:20.106869 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Aug 19 00:34:20.152204 dracut-pre-trigger[514]: rd.md=0: removing MD RAID activation Aug 19 00:34:20.196575 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Aug 19 00:34:20.202765 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 19 00:34:20.339773 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:34:20.344513 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Aug 19 00:34:20.507355 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Aug 19 00:34:20.507439 kernel: nvme nvme0: pci function 0000:00:04.0 Aug 19 00:34:20.515212 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Aug 19 00:34:20.515284 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Aug 19 00:34:20.515604 kernel: nvme nvme0: 2/0/0 default/read/poll queues Aug 19 00:34:20.523476 kernel: ena 0000:00:05.0: ENA device version: 0.10 Aug 19 00:34:20.523795 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Aug 19 00:34:20.524993 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 19 00:34:20.527548 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:34:20.530684 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Aug 19 00:34:20.531049 kernel: GPT:9289727 != 16777215 Aug 19 00:34:20.533022 kernel: GPT:Alternate GPT header not at the end of the disk. Aug 19 00:34:20.534142 kernel: GPT:9289727 != 16777215 Aug 19 00:34:20.535546 kernel: GPT: Use GNU Parted to correct GPT errors. Aug 19 00:34:20.536723 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 19 00:34:20.538650 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:34:20.546181 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:34:20.546898 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 19 00:34:20.563466 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:ef:f5:06:f8:3b Aug 19 00:34:20.567669 (udev-worker)[562]: Network interface NamePolicy= disabled on kernel command line. Aug 19 00:34:20.597954 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:34:20.672456 kernel: nvme nvme0: using unchecked data buffer Aug 19 00:34:20.809430 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Aug 19 00:34:20.898996 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Aug 19 00:34:20.943069 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Aug 19 00:34:20.969544 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Aug 19 00:34:20.991310 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Aug 19 00:34:20.994867 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Aug 19 00:34:21.004156 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Aug 19 00:34:21.006926 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:34:21.009620 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 19 00:34:21.020815 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Aug 19 00:34:21.026438 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Aug 19 00:34:21.052760 disk-uuid[685]: Primary Header is updated. Aug 19 00:34:21.052760 disk-uuid[685]: Secondary Entries is updated. Aug 19 00:34:21.052760 disk-uuid[685]: Secondary Header is updated. Aug 19 00:34:21.065421 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 19 00:34:21.070967 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Aug 19 00:34:22.090439 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Aug 19 00:34:22.091268 disk-uuid[687]: The operation has completed successfully. Aug 19 00:34:22.270549 systemd[1]: disk-uuid.service: Deactivated successfully. Aug 19 00:34:22.272719 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Aug 19 00:34:22.351111 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Aug 19 00:34:22.389629 sh[954]: Success Aug 19 00:34:22.422094 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Aug 19 00:34:22.422167 kernel: device-mapper: uevent: version 1.0.3 Aug 19 00:34:22.424254 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Aug 19 00:34:22.436397 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Aug 19 00:34:22.579108 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Aug 19 00:34:22.589485 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Aug 19 00:34:22.608298 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Aug 19 00:34:22.627396 kernel: BTRFS: device fsid 1e492084-d287-4a43-8dc6-ad086a072625 devid 1 transid 45 /dev/mapper/usr (254:0) scanned by mount (989) Aug 19 00:34:22.631529 kernel: BTRFS info (device dm-0): first mount of filesystem 1e492084-d287-4a43-8dc6-ad086a072625 Aug 19 00:34:22.631581 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:34:22.632773 kernel: BTRFS info (device dm-0): using free-space-tree Aug 19 00:34:23.211623 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Aug 19 00:34:23.215822 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Aug 19 00:34:23.218543 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Aug 19 00:34:23.222074 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Aug 19 00:34:23.231558 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Aug 19 00:34:23.284441 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1022) Aug 19 00:34:23.287368 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:34:23.290508 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:34:23.290569 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Aug 19 00:34:23.362649 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:34:23.363790 systemd[1]: Finished ignition-setup.service - Ignition (setup). Aug 19 00:34:23.368923 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Aug 19 00:34:23.417277 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 19 00:34:23.425477 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 19 00:34:23.493125 systemd-networkd[1158]: lo: Link UP Aug 19 00:34:23.493146 systemd-networkd[1158]: lo: Gained carrier Aug 19 00:34:23.498227 systemd-networkd[1158]: Enumeration completed Aug 19 00:34:23.498397 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 19 00:34:23.501586 systemd-networkd[1158]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:34:23.501593 systemd-networkd[1158]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 19 00:34:23.502142 systemd[1]: Reached target network.target - Network. Aug 19 00:34:23.514769 systemd-networkd[1158]: eth0: Link UP Aug 19 00:34:23.514776 systemd-networkd[1158]: eth0: Gained carrier Aug 19 00:34:23.514798 systemd-networkd[1158]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:34:23.537418 systemd-networkd[1158]: eth0: DHCPv4 address 172.31.17.62/20, gateway 172.31.16.1 acquired from 172.31.16.1 Aug 19 00:34:24.846650 systemd-networkd[1158]: eth0: Gained IPv6LL Aug 19 00:34:25.031835 ignition[1130]: Ignition 2.21.0 Aug 19 00:34:25.031866 ignition[1130]: Stage: fetch-offline Aug 19 00:34:25.035601 ignition[1130]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:25.035640 ignition[1130]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:25.040254 ignition[1130]: Ignition finished successfully Aug 19 00:34:25.044663 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Aug 19 00:34:25.049074 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Aug 19 00:34:25.086151 ignition[1170]: Ignition 2.21.0 Aug 19 00:34:25.086181 ignition[1170]: Stage: fetch Aug 19 00:34:25.087123 ignition[1170]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:25.087148 ignition[1170]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:25.087470 ignition[1170]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:25.102160 ignition[1170]: PUT result: OK Aug 19 00:34:25.108431 ignition[1170]: parsed url from cmdline: "" Aug 19 00:34:25.108454 ignition[1170]: no config URL provided Aug 19 00:34:25.108471 ignition[1170]: reading system config file "/usr/lib/ignition/user.ign" Aug 19 00:34:25.108496 ignition[1170]: no config at "/usr/lib/ignition/user.ign" Aug 19 00:34:25.108539 ignition[1170]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:25.110599 ignition[1170]: PUT result: OK Aug 19 00:34:25.110674 ignition[1170]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Aug 19 00:34:25.117329 ignition[1170]: GET result: OK Aug 19 00:34:25.117571 ignition[1170]: parsing config with SHA512: aac7a2d55ec3ed302b63360ad351a077f2c2c25e333156ace05b7c0785770721667ff39b8f165ff38d260612f5b98521585464880e25bda2a5ce5761c083d9d2 Aug 19 00:34:25.136547 unknown[1170]: fetched base config from "system" Aug 19 00:34:25.136576 unknown[1170]: fetched base config from "system" Aug 19 00:34:25.138595 ignition[1170]: fetch: fetch complete Aug 19 00:34:25.136593 unknown[1170]: fetched user config from "aws" Aug 19 00:34:25.138608 ignition[1170]: fetch: fetch passed Aug 19 00:34:25.138726 ignition[1170]: Ignition finished successfully Aug 19 00:34:25.150199 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Aug 19 00:34:25.154944 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Aug 19 00:34:25.199108 ignition[1176]: Ignition 2.21.0 Aug 19 00:34:25.199664 ignition[1176]: Stage: kargs Aug 19 00:34:25.200201 ignition[1176]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:25.200224 ignition[1176]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:25.200385 ignition[1176]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:25.210732 ignition[1176]: PUT result: OK Aug 19 00:34:25.217263 ignition[1176]: kargs: kargs passed Aug 19 00:34:25.218783 ignition[1176]: Ignition finished successfully Aug 19 00:34:25.223280 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Aug 19 00:34:25.230093 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Aug 19 00:34:25.268272 ignition[1184]: Ignition 2.21.0 Aug 19 00:34:25.268302 ignition[1184]: Stage: disks Aug 19 00:34:25.270037 ignition[1184]: no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:25.270078 ignition[1184]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:25.270237 ignition[1184]: PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:25.276105 ignition[1184]: PUT result: OK Aug 19 00:34:25.282651 ignition[1184]: disks: disks passed Aug 19 00:34:25.282797 ignition[1184]: Ignition finished successfully Aug 19 00:34:25.286611 systemd[1]: Finished ignition-disks.service - Ignition (disks). Aug 19 00:34:25.290360 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Aug 19 00:34:25.293902 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Aug 19 00:34:25.303451 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 19 00:34:25.308257 systemd[1]: Reached target sysinit.target - System Initialization. Aug 19 00:34:25.311229 systemd[1]: Reached target basic.target - Basic System. Aug 19 00:34:25.318930 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Aug 19 00:34:25.382542 systemd-fsck[1192]: ROOT: clean, 15/553520 files, 52789/553472 blocks Aug 19 00:34:25.386269 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Aug 19 00:34:25.395481 systemd[1]: Mounting sysroot.mount - /sysroot... Aug 19 00:34:25.548408 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 593a9299-85f8-44ab-a00f-cf95b7233713 r/w with ordered data mode. Quota mode: none. Aug 19 00:34:25.549522 systemd[1]: Mounted sysroot.mount - /sysroot. Aug 19 00:34:25.550818 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Aug 19 00:34:25.554259 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 19 00:34:25.558743 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Aug 19 00:34:25.562827 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Aug 19 00:34:25.562914 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Aug 19 00:34:25.562964 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Aug 19 00:34:25.598510 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Aug 19 00:34:25.601587 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Aug 19 00:34:25.617419 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1211) Aug 19 00:34:25.623476 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:34:25.623545 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:34:25.623571 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Aug 19 00:34:25.634658 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 19 00:34:26.609507 initrd-setup-root[1235]: cut: /sysroot/etc/passwd: No such file or directory Aug 19 00:34:26.663566 initrd-setup-root[1242]: cut: /sysroot/etc/group: No such file or directory Aug 19 00:34:26.671725 initrd-setup-root[1249]: cut: /sysroot/etc/shadow: No such file or directory Aug 19 00:34:26.680234 initrd-setup-root[1256]: cut: /sysroot/etc/gshadow: No such file or directory Aug 19 00:34:27.526298 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Aug 19 00:34:27.530990 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Aug 19 00:34:27.548696 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Aug 19 00:34:27.567042 systemd[1]: sysroot-oem.mount: Deactivated successfully. Aug 19 00:34:27.570917 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:34:27.614038 ignition[1324]: INFO : Ignition 2.21.0 Aug 19 00:34:27.615924 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Aug 19 00:34:27.620953 ignition[1324]: INFO : Stage: mount Aug 19 00:34:27.620953 ignition[1324]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:27.620953 ignition[1324]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:27.620953 ignition[1324]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:27.631707 ignition[1324]: INFO : PUT result: OK Aug 19 00:34:27.645174 ignition[1324]: INFO : mount: mount passed Aug 19 00:34:27.647201 ignition[1324]: INFO : Ignition finished successfully Aug 19 00:34:27.649622 systemd[1]: Finished ignition-mount.service - Ignition (mount). Aug 19 00:34:27.656479 systemd[1]: Starting ignition-files.service - Ignition (files)... Aug 19 00:34:27.687756 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Aug 19 00:34:27.721377 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1335) Aug 19 00:34:27.725198 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem de95eca0-5455-4710-9904-3d3a2312ef33 Aug 19 00:34:27.725235 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Aug 19 00:34:27.726584 kernel: BTRFS info (device nvme0n1p6): using free-space-tree Aug 19 00:34:27.735053 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Aug 19 00:34:27.779454 ignition[1352]: INFO : Ignition 2.21.0 Aug 19 00:34:27.779454 ignition[1352]: INFO : Stage: files Aug 19 00:34:27.783120 ignition[1352]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:27.783120 ignition[1352]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:27.783120 ignition[1352]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:27.790952 ignition[1352]: INFO : PUT result: OK Aug 19 00:34:27.794980 ignition[1352]: DEBUG : files: compiled without relabeling support, skipping Aug 19 00:34:27.799623 ignition[1352]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Aug 19 00:34:27.799623 ignition[1352]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Aug 19 00:34:27.908210 ignition[1352]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Aug 19 00:34:27.911875 ignition[1352]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Aug 19 00:34:27.911875 ignition[1352]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Aug 19 00:34:27.909111 unknown[1352]: wrote ssh authorized keys file for user: core Aug 19 00:34:27.924058 ignition[1352]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Aug 19 00:34:27.928122 ignition[1352]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Aug 19 00:34:27.928122 ignition[1352]: INFO : files: op(4): [started] processing unit "etcd-member.service" Aug 19 00:34:27.928122 ignition[1352]: 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" Aug 19 00:34:27.943377 ignition[1352]: 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" Aug 19 00:34:27.943377 ignition[1352]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Aug 19 00:34:27.943377 ignition[1352]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Aug 19 00:34:27.955465 ignition[1352]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Aug 19 00:34:27.955465 ignition[1352]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Aug 19 00:34:27.955465 ignition[1352]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Aug 19 00:34:27.955465 ignition[1352]: INFO : files: files passed Aug 19 00:34:27.955465 ignition[1352]: INFO : Ignition finished successfully Aug 19 00:34:27.969789 systemd[1]: Finished ignition-files.service - Ignition (files). Aug 19 00:34:27.976159 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Aug 19 00:34:27.980395 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Aug 19 00:34:28.006022 systemd[1]: ignition-quench.service: Deactivated successfully. Aug 19 00:34:28.008364 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Aug 19 00:34:28.024406 initrd-setup-root-after-ignition[1381]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:34:28.028763 initrd-setup-root-after-ignition[1381]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:34:28.033516 initrd-setup-root-after-ignition[1385]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Aug 19 00:34:28.037135 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 19 00:34:28.041593 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Aug 19 00:34:28.047277 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Aug 19 00:34:28.142263 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Aug 19 00:34:28.142490 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Aug 19 00:34:28.146784 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Aug 19 00:34:28.156219 systemd[1]: Reached target initrd.target - Initrd Default Target. Aug 19 00:34:28.160720 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Aug 19 00:34:28.162543 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Aug 19 00:34:28.204733 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 19 00:34:28.206337 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Aug 19 00:34:28.244467 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:34:28.249640 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:34:28.255199 systemd[1]: Stopped target timers.target - Timer Units. Aug 19 00:34:28.260546 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Aug 19 00:34:28.262262 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Aug 19 00:34:28.268237 systemd[1]: Stopped target initrd.target - Initrd Default Target. Aug 19 00:34:28.268578 systemd[1]: Stopped target basic.target - Basic System. Aug 19 00:34:28.274935 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Aug 19 00:34:28.277931 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Aug 19 00:34:28.282403 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Aug 19 00:34:28.287674 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Aug 19 00:34:28.292708 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Aug 19 00:34:28.300506 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Aug 19 00:34:28.305433 systemd[1]: Stopped target sysinit.target - System Initialization. Aug 19 00:34:28.313644 systemd[1]: Stopped target local-fs.target - Local File Systems. Aug 19 00:34:28.316135 systemd[1]: Stopped target swap.target - Swaps. Aug 19 00:34:28.322098 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Aug 19 00:34:28.322483 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Aug 19 00:34:28.329762 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:34:28.332447 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:34:28.340468 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Aug 19 00:34:28.346781 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:34:28.350135 systemd[1]: dracut-initqueue.service: Deactivated successfully. Aug 19 00:34:28.350377 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Aug 19 00:34:28.359662 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Aug 19 00:34:28.360021 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Aug 19 00:34:28.368553 systemd[1]: ignition-files.service: Deactivated successfully. Aug 19 00:34:28.369710 systemd[1]: Stopped ignition-files.service - Ignition (files). Aug 19 00:34:28.376949 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Aug 19 00:34:28.379782 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Aug 19 00:34:28.380129 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:34:28.403571 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Aug 19 00:34:28.408030 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Aug 19 00:34:28.408501 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:34:28.423695 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Aug 19 00:34:28.424843 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Aug 19 00:34:28.442274 systemd[1]: initrd-cleanup.service: Deactivated successfully. Aug 19 00:34:28.445071 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Aug 19 00:34:28.460380 ignition[1406]: INFO : Ignition 2.21.0 Aug 19 00:34:28.460380 ignition[1406]: INFO : Stage: umount Aug 19 00:34:28.465576 ignition[1406]: INFO : no configs at "/usr/lib/ignition/base.d" Aug 19 00:34:28.465576 ignition[1406]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Aug 19 00:34:28.465576 ignition[1406]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Aug 19 00:34:28.474134 ignition[1406]: INFO : PUT result: OK Aug 19 00:34:28.483796 ignition[1406]: INFO : umount: umount passed Aug 19 00:34:28.483796 ignition[1406]: INFO : Ignition finished successfully Aug 19 00:34:28.488383 systemd[1]: sysroot-boot.mount: Deactivated successfully. Aug 19 00:34:28.493481 systemd[1]: ignition-mount.service: Deactivated successfully. Aug 19 00:34:28.493905 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Aug 19 00:34:28.504454 systemd[1]: sysroot-boot.service: Deactivated successfully. Aug 19 00:34:28.506514 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Aug 19 00:34:28.510409 systemd[1]: ignition-disks.service: Deactivated successfully. Aug 19 00:34:28.510559 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Aug 19 00:34:28.514163 systemd[1]: ignition-kargs.service: Deactivated successfully. Aug 19 00:34:28.514260 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Aug 19 00:34:28.520452 systemd[1]: ignition-fetch.service: Deactivated successfully. Aug 19 00:34:28.520540 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Aug 19 00:34:28.523190 systemd[1]: Stopped target network.target - Network. Aug 19 00:34:28.529274 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Aug 19 00:34:28.529393 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Aug 19 00:34:28.536217 systemd[1]: Stopped target paths.target - Path Units. Aug 19 00:34:28.538608 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Aug 19 00:34:28.544480 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:34:28.547584 systemd[1]: Stopped target slices.target - Slice Units. Aug 19 00:34:28.549743 systemd[1]: Stopped target sockets.target - Socket Units. Aug 19 00:34:28.556226 systemd[1]: iscsid.socket: Deactivated successfully. Aug 19 00:34:28.556302 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Aug 19 00:34:28.558841 systemd[1]: iscsiuio.socket: Deactivated successfully. Aug 19 00:34:28.558907 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Aug 19 00:34:28.567286 systemd[1]: ignition-setup.service: Deactivated successfully. Aug 19 00:34:28.567417 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Aug 19 00:34:28.571832 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Aug 19 00:34:28.571924 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Aug 19 00:34:28.575768 systemd[1]: initrd-setup-root.service: Deactivated successfully. Aug 19 00:34:28.575863 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Aug 19 00:34:28.579761 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Aug 19 00:34:28.582740 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Aug 19 00:34:28.596049 systemd[1]: systemd-resolved.service: Deactivated successfully. Aug 19 00:34:28.596245 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Aug 19 00:34:28.651296 systemd[1]: run-credentials-systemd\x2dresolved.service.mount: Deactivated successfully. Aug 19 00:34:28.652006 systemd[1]: systemd-networkd.service: Deactivated successfully. Aug 19 00:34:28.652324 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Aug 19 00:34:28.669971 systemd[1]: run-credentials-systemd\x2dnetworkd.service.mount: Deactivated successfully. Aug 19 00:34:28.671607 systemd[1]: Stopped target network-pre.target - Preparation for Network. Aug 19 00:34:28.680990 systemd[1]: systemd-networkd.socket: Deactivated successfully. Aug 19 00:34:28.681092 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:34:28.687628 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Aug 19 00:34:28.695475 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Aug 19 00:34:28.695690 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Aug 19 00:34:28.706902 systemd[1]: systemd-sysctl.service: Deactivated successfully. Aug 19 00:34:28.707015 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:34:28.714623 systemd[1]: systemd-modules-load.service: Deactivated successfully. Aug 19 00:34:28.714875 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Aug 19 00:34:28.721889 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Aug 19 00:34:28.721984 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:34:28.727258 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:34:28.733607 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Aug 19 00:34:28.733742 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup.service.mount: Deactivated successfully. Aug 19 00:34:28.758829 systemd[1]: network-cleanup.service: Deactivated successfully. Aug 19 00:34:28.759247 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Aug 19 00:34:28.772827 systemd[1]: systemd-udevd.service: Deactivated successfully. Aug 19 00:34:28.774541 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:34:28.780988 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Aug 19 00:34:28.781077 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Aug 19 00:34:28.785285 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Aug 19 00:34:28.785373 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:34:28.792325 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Aug 19 00:34:28.792689 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Aug 19 00:34:28.799518 systemd[1]: dracut-cmdline.service: Deactivated successfully. Aug 19 00:34:28.799610 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Aug 19 00:34:28.808396 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Aug 19 00:34:28.808494 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Aug 19 00:34:28.813535 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Aug 19 00:34:28.819607 systemd[1]: systemd-network-generator.service: Deactivated successfully. Aug 19 00:34:28.820512 systemd[1]: Stopped systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:34:28.830769 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Aug 19 00:34:28.830885 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:34:28.833381 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Aug 19 00:34:28.833470 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:34:28.844771 systemd[1]: run-credentials-systemd\x2dnetwork\x2dgenerator.service.mount: Deactivated successfully. Aug 19 00:34:28.844883 systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dsetup\x2ddev.service.mount: Deactivated successfully. Aug 19 00:34:28.844966 systemd[1]: run-credentials-systemd\x2dvconsole\x2dsetup.service.mount: Deactivated successfully. Aug 19 00:34:28.868960 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Aug 19 00:34:28.871537 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Aug 19 00:34:28.874636 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Aug 19 00:34:28.883023 systemd[1]: Starting initrd-switch-root.service - Switch Root... Aug 19 00:34:28.913078 systemd[1]: Switching root. Aug 19 00:34:29.018620 systemd-journald[259]: Journal stopped Aug 19 00:34:33.033997 systemd-journald[259]: Received SIGTERM from PID 1 (systemd). Aug 19 00:34:33.034124 kernel: SELinux: policy capability network_peer_controls=1 Aug 19 00:34:33.034166 kernel: SELinux: policy capability open_perms=1 Aug 19 00:34:33.034197 kernel: SELinux: policy capability extended_socket_class=1 Aug 19 00:34:33.034231 kernel: SELinux: policy capability always_check_network=0 Aug 19 00:34:33.034260 kernel: SELinux: policy capability cgroup_seclabel=1 Aug 19 00:34:33.034288 kernel: SELinux: policy capability nnp_nosuid_transition=1 Aug 19 00:34:33.034316 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Aug 19 00:34:33.034373 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Aug 19 00:34:33.034409 kernel: SELinux: policy capability userspace_initial_context=0 Aug 19 00:34:33.034438 kernel: audit: type=1403 audit(1755563669.893:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Aug 19 00:34:33.034475 systemd[1]: Successfully loaded SELinux policy in 157.131ms. Aug 19 00:34:33.034519 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 15.095ms. Aug 19 00:34:33.034556 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) Aug 19 00:34:33.034589 systemd[1]: Detected virtualization amazon. Aug 19 00:34:33.034619 systemd[1]: Detected architecture arm64. Aug 19 00:34:33.034672 systemd[1]: Detected first boot. Aug 19 00:34:33.034703 systemd[1]: Initializing machine ID from VM UUID. Aug 19 00:34:33.034733 kernel: NET: Registered PF_VSOCK protocol family Aug 19 00:34:33.034760 zram_generator::config[1450]: No configuration found. Aug 19 00:34:33.034793 systemd[1]: Populated /etc with preset unit settings. Aug 19 00:34:33.034827 systemd[1]: run-credentials-systemd\x2djournald.service.mount: Deactivated successfully. Aug 19 00:34:33.034856 systemd[1]: initrd-switch-root.service: Deactivated successfully. Aug 19 00:34:33.034884 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Aug 19 00:34:33.034914 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Aug 19 00:34:33.034944 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Aug 19 00:34:33.034975 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Aug 19 00:34:33.035005 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Aug 19 00:34:33.035036 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Aug 19 00:34:33.035067 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Aug 19 00:34:33.035100 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Aug 19 00:34:33.035131 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Aug 19 00:34:33.040493 systemd[1]: Created slice user.slice - User and Session Slice. Aug 19 00:34:33.040540 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Aug 19 00:34:33.040571 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Aug 19 00:34:33.043003 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Aug 19 00:34:33.043038 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Aug 19 00:34:33.043070 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Aug 19 00:34:33.043122 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Aug 19 00:34:33.043156 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Aug 19 00:34:33.043188 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Aug 19 00:34:33.043218 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Aug 19 00:34:33.043248 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Aug 19 00:34:33.043277 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Aug 19 00:34:33.043307 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Aug 19 00:34:33.043337 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Aug 19 00:34:33.043391 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Aug 19 00:34:33.043423 systemd[1]: Reached target remote-fs.target - Remote File Systems. Aug 19 00:34:33.043453 systemd[1]: Reached target slices.target - Slice Units. Aug 19 00:34:33.043484 systemd[1]: Reached target swap.target - Swaps. Aug 19 00:34:33.043513 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Aug 19 00:34:33.043541 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Aug 19 00:34:33.043572 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Aug 19 00:34:33.043602 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Aug 19 00:34:33.043630 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Aug 19 00:34:33.043660 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Aug 19 00:34:33.043708 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Aug 19 00:34:33.043739 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Aug 19 00:34:33.043778 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Aug 19 00:34:33.043817 systemd[1]: Mounting media.mount - External Media Directory... Aug 19 00:34:33.043854 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Aug 19 00:34:33.043883 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Aug 19 00:34:33.043911 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Aug 19 00:34:33.043940 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Aug 19 00:34:33.043973 systemd[1]: Reached target machines.target - Containers. Aug 19 00:34:33.044003 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Aug 19 00:34:33.044032 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:34:33.044078 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Aug 19 00:34:33.044116 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Aug 19 00:34:33.044148 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 19 00:34:33.044176 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 19 00:34:33.044203 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 19 00:34:33.044234 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Aug 19 00:34:33.044269 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 19 00:34:33.044298 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Aug 19 00:34:33.044328 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Aug 19 00:34:33.049477 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Aug 19 00:34:33.049527 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Aug 19 00:34:33.049560 systemd[1]: Stopped systemd-fsck-usr.service. Aug 19 00:34:33.049591 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). Aug 19 00:34:33.049619 systemd[1]: Starting systemd-journald.service - Journal Service... Aug 19 00:34:33.049655 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Aug 19 00:34:33.049690 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Aug 19 00:34:33.049722 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Aug 19 00:34:33.049753 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Aug 19 00:34:33.049783 kernel: loop: module loaded Aug 19 00:34:33.049817 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Aug 19 00:34:33.049852 systemd[1]: verity-setup.service: Deactivated successfully. Aug 19 00:34:33.049882 systemd[1]: Stopped verity-setup.service. Aug 19 00:34:33.049910 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Aug 19 00:34:33.049939 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Aug 19 00:34:33.049979 systemd[1]: Mounted media.mount - External Media Directory. Aug 19 00:34:33.050007 kernel: fuse: init (API version 7.41) Aug 19 00:34:33.050035 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Aug 19 00:34:33.050064 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Aug 19 00:34:33.050096 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Aug 19 00:34:33.050125 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Aug 19 00:34:33.050154 systemd[1]: modprobe@configfs.service: Deactivated successfully. Aug 19 00:34:33.050185 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Aug 19 00:34:33.050214 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 19 00:34:33.050245 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 19 00:34:33.050274 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 19 00:34:33.050302 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 19 00:34:33.050331 systemd[1]: modprobe@fuse.service: Deactivated successfully. Aug 19 00:34:33.053417 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Aug 19 00:34:33.053462 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 19 00:34:33.053493 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 19 00:34:33.053521 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Aug 19 00:34:33.053550 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Aug 19 00:34:33.053585 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Aug 19 00:34:33.053616 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Aug 19 00:34:33.053647 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Aug 19 00:34:33.053675 systemd[1]: Reached target local-fs.target - Local File Systems. Aug 19 00:34:33.053704 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Aug 19 00:34:33.053732 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Aug 19 00:34:33.053770 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:34:33.053798 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Aug 19 00:34:33.053830 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 19 00:34:33.053859 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Aug 19 00:34:33.053887 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 19 00:34:33.053961 systemd-journald[1526]: Collecting audit messages is disabled. Aug 19 00:34:33.054012 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Aug 19 00:34:33.054045 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Aug 19 00:34:33.054075 kernel: ACPI: bus type drm_connector registered Aug 19 00:34:33.054103 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Aug 19 00:34:33.054130 systemd-journald[1526]: Journal started Aug 19 00:34:33.054176 systemd-journald[1526]: Runtime Journal (/run/log/journal/ec2da4aafec4a6c228cf4f069ad9ce6b) is 8M, max 75.3M, 67.3M free. Aug 19 00:34:32.308041 systemd[1]: Queued start job for default target multi-user.target. Aug 19 00:34:33.060215 systemd[1]: Started systemd-journald.service - Journal Service. Aug 19 00:34:32.325183 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Aug 19 00:34:32.326005 systemd[1]: systemd-journald.service: Deactivated successfully. Aug 19 00:34:33.064676 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 19 00:34:33.066415 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 19 00:34:33.071424 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Aug 19 00:34:33.076074 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Aug 19 00:34:33.078979 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Aug 19 00:34:33.113247 systemd[1]: Reached target network-pre.target - Preparation for Network. Aug 19 00:34:33.119157 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Aug 19 00:34:33.131067 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Aug 19 00:34:33.133932 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Aug 19 00:34:33.144681 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Aug 19 00:34:33.200419 kernel: loop0: detected capacity change from 0 to 61256 Aug 19 00:34:33.216385 systemd-journald[1526]: Time spent on flushing to /var/log/journal/ec2da4aafec4a6c228cf4f069ad9ce6b is 66.459ms for 910 entries. Aug 19 00:34:33.216385 systemd-journald[1526]: System Journal (/var/log/journal/ec2da4aafec4a6c228cf4f069ad9ce6b) is 8M, max 195.6M, 187.6M free. Aug 19 00:34:33.299825 systemd-journald[1526]: Received client request to flush runtime journal. Aug 19 00:34:33.220920 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Aug 19 00:34:33.228017 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Aug 19 00:34:33.237628 systemd[1]: Starting systemd-sysusers.service - Create System Users... Aug 19 00:34:33.294234 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Aug 19 00:34:33.306565 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Aug 19 00:34:33.329985 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Aug 19 00:34:33.349275 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Aug 19 00:34:33.364783 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Aug 19 00:34:33.435395 kernel: loop1: detected capacity change from 0 to 119320 Aug 19 00:34:33.437454 systemd[1]: Finished systemd-sysusers.service - Create System Users. Aug 19 00:34:33.444226 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Aug 19 00:34:33.499712 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Aug 19 00:34:33.500243 systemd-tmpfiles[1601]: ACLs are not supported, ignoring. Aug 19 00:34:33.515625 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Aug 19 00:34:33.793026 kernel: loop2: detected capacity change from 0 to 100608 Aug 19 00:34:33.960401 kernel: loop3: detected capacity change from 0 to 61256 Aug 19 00:34:33.981435 kernel: loop4: detected capacity change from 0 to 119320 Aug 19 00:34:34.000393 kernel: loop5: detected capacity change from 0 to 100608 Aug 19 00:34:34.018575 (sd-merge)[1606]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Aug 19 00:34:34.019547 (sd-merge)[1606]: Merged extensions into '/usr'. Aug 19 00:34:34.027457 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Aug 19 00:34:34.034609 systemd[1]: Starting ensure-sysext.service... Aug 19 00:34:34.042814 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Aug 19 00:34:34.078968 systemd-tmpfiles[1609]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Aug 19 00:34:34.079501 systemd-tmpfiles[1609]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Aug 19 00:34:34.081708 systemd-tmpfiles[1609]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Aug 19 00:34:34.082224 systemd-tmpfiles[1609]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Aug 19 00:34:34.087272 systemd-tmpfiles[1609]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Aug 19 00:34:34.087844 systemd-tmpfiles[1609]: ACLs are not supported, ignoring. Aug 19 00:34:34.087980 systemd-tmpfiles[1609]: ACLs are not supported, ignoring. Aug 19 00:34:34.098632 systemd-tmpfiles[1609]: Detected autofs mount point /boot during canonicalization of boot. Aug 19 00:34:34.098835 systemd-tmpfiles[1609]: Skipping /boot Aug 19 00:34:34.112611 systemd[1]: Reload requested from client PID 1608 ('systemctl') (unit ensure-sysext.service)... Aug 19 00:34:34.112643 systemd[1]: Reloading... Aug 19 00:34:34.116139 systemd-tmpfiles[1609]: Detected autofs mount point /boot during canonicalization of boot. Aug 19 00:34:34.116323 systemd-tmpfiles[1609]: Skipping /boot Aug 19 00:34:34.311408 zram_generator::config[1637]: No configuration found. Aug 19 00:34:34.710158 systemd[1]: Reloading finished in 596 ms. Aug 19 00:34:34.740739 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Aug 19 00:34:34.777878 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Aug 19 00:34:34.793008 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 19 00:34:34.800929 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Aug 19 00:34:34.807892 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Aug 19 00:34:34.820773 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Aug 19 00:34:34.829406 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Aug 19 00:34:34.839709 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Aug 19 00:34:34.848865 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:34:34.859404 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Aug 19 00:34:34.872893 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Aug 19 00:34:34.889125 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Aug 19 00:34:34.894158 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:34:34.894661 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). Aug 19 00:34:34.902241 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:34:34.902584 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:34:34.902785 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). Aug 19 00:34:34.911879 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Aug 19 00:34:34.922879 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Aug 19 00:34:34.934079 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Aug 19 00:34:34.939157 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Aug 19 00:34:34.939636 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). Aug 19 00:34:34.939986 systemd[1]: Reached target time-set.target - System Time Set. Aug 19 00:34:34.961457 systemd[1]: Finished ensure-sysext.service. Aug 19 00:34:34.970888 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Aug 19 00:34:34.979240 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Aug 19 00:34:34.986687 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Aug 19 00:34:34.992834 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Aug 19 00:34:35.022067 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Aug 19 00:34:35.024443 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Aug 19 00:34:35.031133 systemd[1]: modprobe@loop.service: Deactivated successfully. Aug 19 00:34:35.032022 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Aug 19 00:34:35.035379 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Aug 19 00:34:35.036228 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Aug 19 00:34:35.051887 systemd[1]: modprobe@drm.service: Deactivated successfully. Aug 19 00:34:35.053827 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Aug 19 00:34:35.079544 systemd-udevd[1695]: Using default interface naming scheme 'v255'. Aug 19 00:34:35.107054 augenrules[1729]: No rules Aug 19 00:34:35.110808 systemd[1]: audit-rules.service: Deactivated successfully. Aug 19 00:34:35.112491 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 19 00:34:35.126515 systemd[1]: Started systemd-userdbd.service - User Database Manager. Aug 19 00:34:35.132636 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Aug 19 00:34:35.139236 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Aug 19 00:34:35.197370 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Aug 19 00:34:35.210746 systemd[1]: Starting systemd-networkd.service - Network Configuration... Aug 19 00:34:35.359757 systemd-resolved[1694]: Positive Trust Anchors: Aug 19 00:34:35.359802 systemd-resolved[1694]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Aug 19 00:34:35.360336 systemd-resolved[1694]: 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 Aug 19 00:34:35.388102 systemd-resolved[1694]: Defaulting to hostname 'linux'. Aug 19 00:34:35.392985 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Aug 19 00:34:35.396096 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Aug 19 00:34:35.510054 (udev-worker)[1753]: Network interface NamePolicy= disabled on kernel command line. Aug 19 00:34:35.516801 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Aug 19 00:34:35.715788 systemd-networkd[1745]: lo: Link UP Aug 19 00:34:35.716256 systemd-networkd[1745]: lo: Gained carrier Aug 19 00:34:35.720256 systemd-networkd[1745]: Enumeration completed Aug 19 00:34:35.720462 systemd[1]: Started systemd-networkd.service - Network Configuration. Aug 19 00:34:35.726179 systemd[1]: Reached target network.target - Network. Aug 19 00:34:35.731594 systemd-networkd[1745]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:34:35.731618 systemd-networkd[1745]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Aug 19 00:34:35.734045 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Aug 19 00:34:35.742484 systemd-networkd[1745]: eth0: Link UP Aug 19 00:34:35.742902 systemd-networkd[1745]: eth0: Gained carrier Aug 19 00:34:35.742951 systemd-networkd[1745]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Aug 19 00:34:35.743938 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Aug 19 00:34:35.759514 systemd-networkd[1745]: eth0: DHCPv4 address 172.31.17.62/20, gateway 172.31.16.1 acquired from 172.31.16.1 Aug 19 00:34:35.802626 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Aug 19 00:34:36.013840 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Aug 19 00:34:36.275708 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Aug 19 00:34:36.284626 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Aug 19 00:34:36.300454 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Aug 19 00:34:36.305478 ldconfig[1550]: /sbin/ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Aug 19 00:34:36.314458 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Aug 19 00:34:36.321577 systemd[1]: Starting systemd-update-done.service - Update is Completed... Aug 19 00:34:36.344672 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Aug 19 00:34:36.361425 systemd[1]: Finished systemd-update-done.service - Update is Completed. Aug 19 00:34:36.364430 systemd[1]: Reached target sysinit.target - System Initialization. Aug 19 00:34:36.366951 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Aug 19 00:34:36.370036 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Aug 19 00:34:36.373162 systemd[1]: Started logrotate.timer - Daily rotation of log files. Aug 19 00:34:36.376724 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Aug 19 00:34:36.379540 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Aug 19 00:34:36.382268 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Aug 19 00:34:36.382320 systemd[1]: Reached target paths.target - Path Units. Aug 19 00:34:36.384330 systemd[1]: Reached target timers.target - Timer Units. Aug 19 00:34:36.388720 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Aug 19 00:34:36.393652 systemd[1]: Starting docker.socket - Docker Socket for the API... Aug 19 00:34:36.399889 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Aug 19 00:34:36.403160 systemd[1]: Listening on sshd-vsock.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_VSOCK). Aug 19 00:34:36.406004 systemd[1]: Reached target ssh-access.target - SSH Access Available. Aug 19 00:34:36.413264 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Aug 19 00:34:36.416805 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Aug 19 00:34:36.420549 systemd[1]: Listening on docker.socket - Docker Socket for the API. Aug 19 00:34:36.423271 systemd[1]: Reached target sockets.target - Socket Units. Aug 19 00:34:36.425414 systemd[1]: Reached target basic.target - Basic System. Aug 19 00:34:36.428538 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Aug 19 00:34:36.428699 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Aug 19 00:34:36.432498 systemd[1]: Starting containerd.service - containerd container runtime... Aug 19 00:34:36.440608 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Aug 19 00:34:36.446784 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Aug 19 00:34:36.452627 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Aug 19 00:34:36.461915 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Aug 19 00:34:36.473337 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Aug 19 00:34:36.475704 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS was skipped because of an unmet condition check (ConditionPathExists=/oem/bin/flatcar-setup-environment). Aug 19 00:34:36.480145 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Aug 19 00:34:36.486884 systemd[1]: Started ntpd.service - Network Time Service. Aug 19 00:34:36.495720 systemd[1]: Starting setup-oem.service - Setup OEM... Aug 19 00:34:36.503853 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Aug 19 00:34:36.512760 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Aug 19 00:34:36.526768 systemd[1]: Starting systemd-logind.service - User Login Management... Aug 19 00:34:36.530705 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Aug 19 00:34:36.533301 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Aug 19 00:34:36.536020 systemd[1]: Starting update-engine.service - Update Engine... Aug 19 00:34:36.541717 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Aug 19 00:34:36.552451 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Aug 19 00:34:36.590557 jq[1899]: false Aug 19 00:34:36.601245 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Aug 19 00:34:36.602163 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Aug 19 00:34:36.612429 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Aug 19 00:34:36.614986 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Aug 19 00:34:36.623697 jq[1908]: true Aug 19 00:34:36.637116 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Aug 19 00:34:36.649178 extend-filesystems[1900]: Found /dev/nvme0n1p6 Aug 19 00:34:36.673788 extend-filesystems[1900]: Found /dev/nvme0n1p9 Aug 19 00:34:36.684958 (ntainerd)[1920]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Aug 19 00:34:36.689453 extend-filesystems[1900]: Checking size of /dev/nvme0n1p9 Aug 19 00:34:36.704629 systemd[1]: motdgen.service: Deactivated successfully. Aug 19 00:34:36.705170 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Aug 19 00:34:36.731141 jq[1930]: true Aug 19 00:34:36.736221 update_engine[1907]: I20250819 00:34:36.735036 1907 main.cc:92] Flatcar Update Engine starting Aug 19 00:34:36.769818 extend-filesystems[1900]: Resized partition /dev/nvme0n1p9 Aug 19 00:34:36.786442 extend-filesystems[1949]: resize2fs 1.47.2 (1-Jan-2025) Aug 19 00:34:36.800374 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Aug 19 00:34:36.826157 systemd[1]: Finished setup-oem.service - Setup OEM. Aug 19 00:34:36.829747 systemd[1]: Started dbus.service - D-Bus System Message Bus. Aug 19 00:34:36.826986 dbus-daemon[1897]: [system] SELinux support is enabled Aug 19 00:34:36.838079 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/oem/cloud-config.yml was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Aug 19 00:34:36.838134 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Aug 19 00:34:36.841102 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Aug 19 00:34:36.841139 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Aug 19 00:34:36.869747 dbus-daemon[1897]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1745 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Aug 19 00:34:36.881876 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Aug 19 00:34:36.885932 ntpd[1902]: ntpd 4.2.8p17@1.4004-o Mon Aug 18 21:29:50 UTC 2025 (1): Starting Aug 19 00:34:36.887839 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: ntpd 4.2.8p17@1.4004-o Mon Aug 18 21:29:50 UTC 2025 (1): Starting Aug 19 00:34:36.887839 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Aug 19 00:34:36.885993 ntpd[1902]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Aug 19 00:34:36.888120 systemd[1]: Started update-engine.service - Update Engine. Aug 19 00:34:36.886011 ntpd[1902]: ---------------------------------------------------- Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: ---------------------------------------------------- Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: ntp-4 is maintained by Network Time Foundation, Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: corporation. Support and training for ntp-4 are Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: available at https://www.nwtime.org/support Aug 19 00:34:36.892373 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: ---------------------------------------------------- Aug 19 00:34:36.890825 ntpd[1902]: ntp-4 is maintained by Network Time Foundation, Aug 19 00:34:36.892840 update_engine[1907]: I20250819 00:34:36.892630 1907 update_check_scheduler.cc:74] Next update check in 10m24s Aug 19 00:34:36.890847 ntpd[1902]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Aug 19 00:34:36.890864 ntpd[1902]: corporation. Support and training for ntp-4 are Aug 19 00:34:36.890881 ntpd[1902]: available at https://www.nwtime.org/support Aug 19 00:34:36.890897 ntpd[1902]: ---------------------------------------------------- Aug 19 00:34:36.895810 systemd[1]: Started locksmithd.service - Cluster reboot manager. Aug 19 00:34:36.902516 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: proto: precision = 0.096 usec (-23) Aug 19 00:34:36.902516 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: basedate set to 2025-08-06 Aug 19 00:34:36.902516 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: gps base set to 2025-08-10 (week 2379) Aug 19 00:34:36.900306 ntpd[1902]: proto: precision = 0.096 usec (-23) Aug 19 00:34:36.901778 ntpd[1902]: basedate set to 2025-08-06 Aug 19 00:34:36.902207 ntpd[1902]: gps base set to 2025-08-10 (week 2379) Aug 19 00:34:36.909699 ntpd[1902]: Listen and drop on 0 v6wildcard [::]:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listen and drop on 0 v6wildcard [::]:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listen normally on 2 lo 127.0.0.1:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listen normally on 3 eth0 172.31.17.62:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listen normally on 4 lo [::1]:123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: bind(21) AF_INET6 fe80::4ef:f5ff:fe06:f83b%2#123 flags 0x11 failed: Cannot assign requested address Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: unable to create socket on eth0 (5) for fe80::4ef:f5ff:fe06:f83b%2#123 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: failed to init interface for address fe80::4ef:f5ff:fe06:f83b%2 Aug 19 00:34:36.912514 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: Listening on routing socket on fd #21 for interface updates Aug 19 00:34:36.909805 ntpd[1902]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Aug 19 00:34:36.910123 ntpd[1902]: Listen normally on 2 lo 127.0.0.1:123 Aug 19 00:34:36.910183 ntpd[1902]: Listen normally on 3 eth0 172.31.17.62:123 Aug 19 00:34:36.910244 ntpd[1902]: Listen normally on 4 lo [::1]:123 Aug 19 00:34:36.910316 ntpd[1902]: bind(21) AF_INET6 fe80::4ef:f5ff:fe06:f83b%2#123 flags 0x11 failed: Cannot assign requested address Aug 19 00:34:36.910377 ntpd[1902]: unable to create socket on eth0 (5) for fe80::4ef:f5ff:fe06:f83b%2#123 Aug 19 00:34:36.910405 ntpd[1902]: failed to init interface for address fe80::4ef:f5ff:fe06:f83b%2 Aug 19 00:34:36.910845 ntpd[1902]: Listening on routing socket on fd #21 for interface updates Aug 19 00:34:36.930184 ntpd[1902]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 19 00:34:36.934630 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 19 00:34:36.934630 ntpd[1902]: 19 Aug 00:34:36 ntpd[1902]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 19 00:34:36.930952 ntpd[1902]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Aug 19 00:34:36.945391 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Aug 19 00:34:36.969874 coreos-metadata[1896]: Aug 19 00:34:36.966 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Aug 19 00:34:36.973946 coreos-metadata[1896]: Aug 19 00:34:36.972 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Aug 19 00:34:36.974068 extend-filesystems[1949]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Aug 19 00:34:36.974068 extend-filesystems[1949]: old_desc_blocks = 1, new_desc_blocks = 1 Aug 19 00:34:36.974068 extend-filesystems[1949]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Aug 19 00:34:36.990827 extend-filesystems[1900]: Resized filesystem in /dev/nvme0n1p9 Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.981 INFO Fetch successful Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.981 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.983 INFO Fetch successful Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.986 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.992 INFO Fetch successful Aug 19 00:34:37.000329 coreos-metadata[1896]: Aug 19 00:34:36.992 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Aug 19 00:34:36.980913 systemd[1]: extend-filesystems.service: Deactivated successfully. Aug 19 00:34:36.981406 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Aug 19 00:34:37.007066 coreos-metadata[1896]: Aug 19 00:34:37.006 INFO Fetch successful Aug 19 00:34:37.007066 coreos-metadata[1896]: Aug 19 00:34:37.006 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Aug 19 00:34:37.008712 coreos-metadata[1896]: Aug 19 00:34:37.007 INFO Fetch failed with 404: resource not found Aug 19 00:34:37.009958 coreos-metadata[1896]: Aug 19 00:34:37.008 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Aug 19 00:34:37.016022 coreos-metadata[1896]: Aug 19 00:34:37.012 INFO Fetch successful Aug 19 00:34:37.016022 coreos-metadata[1896]: Aug 19 00:34:37.012 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Aug 19 00:34:37.018362 coreos-metadata[1896]: Aug 19 00:34:37.016 INFO Fetch successful Aug 19 00:34:37.018362 coreos-metadata[1896]: Aug 19 00:34:37.016 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Aug 19 00:34:37.020083 coreos-metadata[1896]: Aug 19 00:34:37.020 INFO Fetch successful Aug 19 00:34:37.030749 coreos-metadata[1896]: Aug 19 00:34:37.030 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Aug 19 00:34:37.032084 coreos-metadata[1896]: Aug 19 00:34:37.032 INFO Fetch successful Aug 19 00:34:37.032479 coreos-metadata[1896]: Aug 19 00:34:37.032 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Aug 19 00:34:37.034631 coreos-metadata[1896]: Aug 19 00:34:37.032 INFO Fetch successful Aug 19 00:34:37.059553 bash[1977]: Updated "/home/core/.ssh/authorized_keys" Aug 19 00:34:37.068618 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Aug 19 00:34:37.083746 systemd[1]: Starting sshkeys.service... Aug 19 00:34:37.129474 systemd-logind[1906]: Watching system buttons on /dev/input/event0 (Power Button) Aug 19 00:34:37.129534 systemd-logind[1906]: Watching system buttons on /dev/input/event1 (Sleep Button) Aug 19 00:34:37.130059 systemd-logind[1906]: New seat seat0. Aug 19 00:34:37.137000 systemd[1]: Started systemd-logind.service - User Login Management. Aug 19 00:34:37.206064 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Aug 19 00:34:37.211833 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Aug 19 00:34:37.281475 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Aug 19 00:34:37.284818 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Aug 19 00:34:37.387981 locksmithd[1960]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Aug 19 00:34:37.391430 systemd-networkd[1745]: eth0: Gained IPv6LL Aug 19 00:34:37.405016 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Aug 19 00:34:37.409053 systemd[1]: Reached target network-online.target - Network is Online. Aug 19 00:34:37.416202 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Aug 19 00:34:37.427053 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Aug 19 00:34:37.434462 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Aug 19 00:34:37.509077 (-wrapper)[2071]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Aug 19 00:34:37.572705 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Aug 19 00:34:37.588211 dbus-daemon[1897]: [system] Successfully activated service 'org.freedesktop.hostname1' Aug 19 00:34:37.597667 dbus-daemon[1897]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.7' (uid=0 pid=1958 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Aug 19 00:34:37.648994 systemd[1]: Starting polkit.service - Authorization Manager... Aug 19 00:34:37.664579 coreos-metadata[2023]: Aug 19 00:34:37.657 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Aug 19 00:34:37.664579 coreos-metadata[2023]: Aug 19 00:34:37.659 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Aug 19 00:34:37.665042 coreos-metadata[2023]: Aug 19 00:34:37.664 INFO Fetch successful Aug 19 00:34:37.665101 coreos-metadata[2023]: Aug 19 00:34:37.665 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Aug 19 00:34:37.667760 coreos-metadata[2023]: Aug 19 00:34:37.665 INFO Fetch successful Aug 19 00:34:37.673466 unknown[2023]: wrote ssh authorized keys file for user: core Aug 19 00:34:37.745371 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Aug 19 00:34:37.790371 update-ssh-keys[2096]: Updated "/home/core/.ssh/authorized_keys" Aug 19 00:34:37.794102 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Aug 19 00:34:37.808231 systemd[1]: Finished sshkeys.service. Aug 19 00:34:37.828258 amazon-ssm-agent[2068]: Initializing new seelog logger Aug 19 00:34:37.832642 amazon-ssm-agent[2068]: New Seelog Logger Creation Complete Aug 19 00:34:37.839118 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.839118 amazon-ssm-agent[2068]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.839753 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 processing appconfig overrides Aug 19 00:34:37.850679 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.850679 amazon-ssm-agent[2068]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.851562 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8475 INFO Proxy environment variables: Aug 19 00:34:37.857378 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 processing appconfig overrides Aug 19 00:34:37.857378 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.857378 amazon-ssm-agent[2068]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.857378 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 processing appconfig overrides Aug 19 00:34:37.871071 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.873401 amazon-ssm-agent[2068]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:37.882379 amazon-ssm-agent[2068]: 2025/08/19 00:34:37 processing appconfig overrides Aug 19 00:34:37.943809 containerd[1920]: time="2025-08-19T00:34:37Z" 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 Aug 19 00:34:37.950320 containerd[1920]: time="2025-08-19T00:34:37.950239000Z" level=info msg="starting containerd" revision=fb4c30d4ede3531652d86197bf3fc9515e5276d9 version=v2.0.5 Aug 19 00:34:37.956910 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8475 INFO https_proxy: Aug 19 00:34:37.993380 containerd[1920]: time="2025-08-19T00:34:37.992735788Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="14.112µs" Aug 19 00:34:37.993380 containerd[1920]: time="2025-08-19T00:34:37.992805736Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Aug 19 00:34:37.993380 containerd[1920]: time="2025-08-19T00:34:37.992854036Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.993166504Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.995854288Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.995936560Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996096724Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996122572Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996541660Z" 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 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996576268Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996603712Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996625528Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997041 containerd[1920]: time="2025-08-19T00:34:37.996794644Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997631 containerd[1920]: time="2025-08-19T00:34:37.997214308Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Aug 19 00:34:37.997631 containerd[1920]: time="2025-08-19T00:34:37.997276360Z" 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 Aug 19 00:34:37.997631 containerd[1920]: time="2025-08-19T00:34:37.997300624Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Aug 19 00:34:38.001499 containerd[1920]: time="2025-08-19T00:34:37.998677060Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Aug 19 00:34:38.001499 containerd[1920]: time="2025-08-19T00:34:37.999851068Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Aug 19 00:34:38.001499 containerd[1920]: time="2025-08-19T00:34:38.000035196Z" level=info msg="metadata content store policy set" policy=shared Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015306528Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015437328Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015471744Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015500328Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015536232Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015576756Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015605544Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015634956Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015666336Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015694440Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015719352Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015754500Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.015989808Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Aug 19 00:34:38.017497 containerd[1920]: time="2025-08-19T00:34:38.016028388Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016067280Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016094352Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016124124Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016158096Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016185384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016210872Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016238712Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016264632Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Aug 19 00:34:38.018133 containerd[1920]: time="2025-08-19T00:34:38.016291092Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Aug 19 00:34:38.020388 containerd[1920]: time="2025-08-19T00:34:38.018736008Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Aug 19 00:34:38.020388 containerd[1920]: time="2025-08-19T00:34:38.019428696Z" level=info msg="Start snapshots syncer" Aug 19 00:34:38.020388 containerd[1920]: time="2025-08-19T00:34:38.019558512Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Aug 19 00:34:38.023458 containerd[1920]: time="2025-08-19T00:34:38.021757680Z" 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\"}" Aug 19 00:34:38.023458 containerd[1920]: time="2025-08-19T00:34:38.021919608Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Aug 19 00:34:38.023749 containerd[1920]: time="2025-08-19T00:34:38.022118916Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024520092Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024640452Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024675456Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024731796Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024764868Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024816912Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024847572Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024939072Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.024994080Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.025027932Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.025122924Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.025180632Z" 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 Aug 19 00:34:38.026545 containerd[1920]: time="2025-08-19T00:34:38.025204776Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 19 00:34:38.027154 containerd[1920]: time="2025-08-19T00:34:38.025253520Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Aug 19 00:34:38.027154 containerd[1920]: time="2025-08-19T00:34:38.025278612Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Aug 19 00:34:38.027154 containerd[1920]: time="2025-08-19T00:34:38.025303500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Aug 19 00:34:38.027154 containerd[1920]: time="2025-08-19T00:34:38.025380720Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Aug 19 00:34:38.027487 containerd[1920]: time="2025-08-19T00:34:38.027391536Z" level=info msg="runtime interface created" Aug 19 00:34:38.027487 containerd[1920]: time="2025-08-19T00:34:38.027431508Z" level=info msg="created NRI interface" Aug 19 00:34:38.027599 containerd[1920]: time="2025-08-19T00:34:38.027483204Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Aug 19 00:34:38.027599 containerd[1920]: time="2025-08-19T00:34:38.027518520Z" level=info msg="Connect containerd service" Aug 19 00:34:38.027681 containerd[1920]: time="2025-08-19T00:34:38.027636888Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Aug 19 00:34:38.032744 containerd[1920]: time="2025-08-19T00:34:38.031476145Z" level=error msg="failed to load cni during init, please check CRI plugin status before setting up network for pods" error="cni config load failed: no network config found in /etc/cni/net.d: cni plugin not initialized: failed to load cni config" Aug 19 00:34:38.057236 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8475 INFO http_proxy: Aug 19 00:34:38.157587 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8475 INFO no_proxy: Aug 19 00:34:38.190848 polkitd[2089]: Started polkitd version 126 Aug 19 00:34:38.218024 polkitd[2089]: Loading rules from directory /etc/polkit-1/rules.d Aug 19 00:34:38.218701 polkitd[2089]: Loading rules from directory /run/polkit-1/rules.d Aug 19 00:34:38.218779 polkitd[2089]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Aug 19 00:34:38.221430 polkitd[2089]: Loading rules from directory /usr/local/share/polkit-1/rules.d Aug 19 00:34:38.221510 polkitd[2089]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Aug 19 00:34:38.221593 polkitd[2089]: Loading rules from directory /usr/share/polkit-1/rules.d Aug 19 00:34:38.224852 polkitd[2089]: Finished loading, compiling and executing 2 rules Aug 19 00:34:38.225314 systemd[1]: Started polkit.service - Authorization Manager. Aug 19 00:34:38.230843 dbus-daemon[1897]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Aug 19 00:34:38.232300 polkitd[2089]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Aug 19 00:34:38.255947 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8553 INFO Checking if agent identity type OnPrem can be assumed Aug 19 00:34:38.273564 systemd-hostnamed[1958]: Hostname set to (transient) Aug 19 00:34:38.273954 systemd-resolved[1694]: System hostname changed to 'ip-172-31-17-62'. Aug 19 00:34:38.355763 amazon-ssm-agent[2068]: 2025-08-19 00:34:37.8554 INFO Checking if agent identity type EC2 can be assumed Aug 19 00:34:38.455136 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1014 INFO Agent will take identity from EC2 Aug 19 00:34:38.554486 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1037 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600387579Z" level=info msg="Start subscribing containerd event" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600526107Z" level=info msg="Start recovering state" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600724683Z" level=info msg="Start event monitor" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600749619Z" level=info msg="Start cni network conf syncer for default" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600793863Z" level=info msg="Start streaming server" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600816039Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600832323Z" level=info msg="runtime interface starting up..." Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600847803Z" level=info msg="starting plugins..." Aug 19 00:34:38.601203 containerd[1920]: time="2025-08-19T00:34:38.600902835Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Aug 19 00:34:38.602170 containerd[1920]: time="2025-08-19T00:34:38.602119011Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Aug 19 00:34:38.602270 containerd[1920]: time="2025-08-19T00:34:38.602227719Z" level=info msg=serving... address=/run/containerd/containerd.sock Aug 19 00:34:38.606415 containerd[1920]: time="2025-08-19T00:34:38.602322675Z" level=info msg="containerd successfully booted in 0.659815s" Aug 19 00:34:38.602466 systemd[1]: Started containerd.service - containerd container runtime. Aug 19 00:34:38.609709 systemd[1]: Starting docker.service - Docker Application Container Engine... Aug 19 00:34:38.637923 (dockerd)[2143]: docker.service: Referenced but unset environment variable evaluates to an empty string: DOCKER_CGROUPS, DOCKER_OPTS, DOCKER_OPT_BIP, DOCKER_OPT_IPMASQ, DOCKER_OPT_MTU Aug 19 00:34:38.653705 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1038 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Aug 19 00:34:38.752933 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1038 INFO [amazon-ssm-agent] Starting Core Agent Aug 19 00:34:38.853296 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1038 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Aug 19 00:34:38.953008 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1038 INFO [Registrar] Starting registrar module Aug 19 00:34:38.970558 amazon-ssm-agent[2068]: 2025/08/19 00:34:38 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:38.970558 amazon-ssm-agent[2068]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Aug 19 00:34:38.970845 amazon-ssm-agent[2068]: 2025/08/19 00:34:38 processing appconfig overrides Aug 19 00:34:39.008809 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1152 INFO [EC2Identity] Checking disk for registration info Aug 19 00:34:39.008945 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1154 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Aug 19 00:34:39.008945 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.1154 INFO [EC2Identity] Generating registration keypair Aug 19 00:34:39.008945 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9243 INFO [EC2Identity] Checking write access before registering Aug 19 00:34:39.008945 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9250 INFO [EC2Identity] Registering EC2 instance with Systems Manager Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9702 INFO [EC2Identity] EC2 registration was successful. Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9703 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9704 INFO [CredentialRefresher] credentialRefresher has started Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:38.9704 INFO [CredentialRefresher] Starting credentials refresher loop Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:39.0061 INFO EC2RoleProvider Successfully connected with instance profile role credentials Aug 19 00:34:39.009118 amazon-ssm-agent[2068]: 2025-08-19 00:34:39.0086 INFO [CredentialRefresher] Credentials ready Aug 19 00:34:39.032462 sshd_keygen[1937]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Aug 19 00:34:39.053398 amazon-ssm-agent[2068]: 2025-08-19 00:34:39.0091 INFO [CredentialRefresher] Next credential rotation will be in 29.9999502946 minutes Aug 19 00:34:39.072441 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Aug 19 00:34:39.078142 systemd[1]: Starting issuegen.service - Generate /run/issue... Aug 19 00:34:39.088142 systemd[1]: Started sshd@0-172.31.17.62:22-147.75.109.163:43394.service - OpenSSH per-connection server daemon (147.75.109.163:43394). Aug 19 00:34:39.107259 systemd[1]: issuegen.service: Deactivated successfully. Aug 19 00:34:39.110399 systemd[1]: Finished issuegen.service - Generate /run/issue. Aug 19 00:34:39.116537 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Aug 19 00:34:39.149026 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Aug 19 00:34:39.158296 systemd[1]: Started getty@tty1.service - Getty on tty1. Aug 19 00:34:39.163938 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Aug 19 00:34:39.166860 systemd[1]: Reached target getty.target - Login Prompts. Aug 19 00:34:39.669483 sshd[2156]: Accepted publickey for core from 147.75.109.163 port 43394 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:39.672607 sshd-session[2156]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:39.698185 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Aug 19 00:34:39.705739 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Aug 19 00:34:39.717800 systemd-logind[1906]: New session 1 of user core. Aug 19 00:34:39.765461 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Aug 19 00:34:39.775063 systemd[1]: Starting user@500.service - User Manager for UID 500... Aug 19 00:34:39.800175 (systemd)[2169]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Aug 19 00:34:39.807651 systemd-logind[1906]: New session c1 of user core. Aug 19 00:34:39.849860 dockerd[2143]: time="2025-08-19T00:34:39.849761190Z" level=info msg="Starting up" Aug 19 00:34:39.851581 dockerd[2143]: time="2025-08-19T00:34:39.851480478Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Aug 19 00:34:39.874220 dockerd[2143]: time="2025-08-19T00:34:39.874143870Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Aug 19 00:34:39.894449 ntpd[1902]: Listen normally on 6 eth0 [fe80::4ef:f5ff:fe06:f83b%2]:123 Aug 19 00:34:39.895803 ntpd[1902]: 19 Aug 00:34:39 ntpd[1902]: Listen normally on 6 eth0 [fe80::4ef:f5ff:fe06:f83b%2]:123 Aug 19 00:34:39.940004 systemd[1]: var-lib-docker-metacopy\x2dcheck874459374-merged.mount: Deactivated successfully. Aug 19 00:34:39.961115 dockerd[2143]: time="2025-08-19T00:34:39.961055130Z" level=info msg="Loading containers: start." Aug 19 00:34:39.989509 kernel: Initializing XFRM netlink socket Aug 19 00:34:40.059315 amazon-ssm-agent[2068]: 2025-08-19 00:34:40.0590 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Aug 19 00:34:40.152299 systemd[2169]: Queued start job for default target default.target. Aug 19 00:34:40.162165 amazon-ssm-agent[2068]: 2025-08-19 00:34:40.0694 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2202) started Aug 19 00:34:40.162764 systemd[2169]: Created slice app.slice - User Application Slice. Aug 19 00:34:40.162832 systemd[2169]: Reached target paths.target - Paths. Aug 19 00:34:40.162925 systemd[2169]: Reached target timers.target - Timers. Aug 19 00:34:40.165956 systemd[2169]: Starting dbus.socket - D-Bus User Message Bus Socket... Aug 19 00:34:40.200515 systemd[2169]: Listening on dbus.socket - D-Bus User Message Bus Socket. Aug 19 00:34:40.200761 systemd[2169]: Reached target sockets.target - Sockets. Aug 19 00:34:40.200857 systemd[2169]: Reached target basic.target - Basic System. Aug 19 00:34:40.200942 systemd[2169]: Reached target default.target - Main User Target. Aug 19 00:34:40.201000 systemd[2169]: Startup finished in 377ms. Aug 19 00:34:40.201701 systemd[1]: Started user@500.service - User Manager for UID 500. Aug 19 00:34:40.213945 systemd[1]: Started session-1.scope - Session 1 of User core. Aug 19 00:34:40.262230 amazon-ssm-agent[2068]: 2025-08-19 00:34:40.0694 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Aug 19 00:34:40.387812 systemd[1]: Started sshd@1-172.31.17.62:22-147.75.109.163:52344.service - OpenSSH per-connection server daemon (147.75.109.163:52344). Aug 19 00:34:40.540068 (udev-worker)[1747]: Network interface NamePolicy= disabled on kernel command line. Aug 19 00:34:40.617788 sshd[2284]: Accepted publickey for core from 147.75.109.163 port 52344 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:40.620636 sshd-session[2284]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:40.621129 systemd-networkd[1745]: docker0: Link UP Aug 19 00:34:40.631667 systemd-logind[1906]: New session 2 of user core. Aug 19 00:34:40.637709 dockerd[2143]: time="2025-08-19T00:34:40.637637777Z" level=info msg="Loading containers: done." Aug 19 00:34:40.640637 systemd[1]: Started session-2.scope - Session 2 of User core. Aug 19 00:34:40.684629 dockerd[2143]: time="2025-08-19T00:34:40.684554274Z" level=warning msg="Not using native diff for overlay2, this may cause degraded performance for building images: kernel has CONFIG_OVERLAY_FS_REDIRECT_DIR enabled" storage-driver=overlay2 Aug 19 00:34:40.684829 dockerd[2143]: time="2025-08-19T00:34:40.684685230Z" level=info msg="Docker daemon" commit=6430e49a55babd9b8f4d08e70ecb2b68900770fe containerd-snapshotter=false storage-driver=overlay2 version=28.0.4 Aug 19 00:34:40.684884 dockerd[2143]: time="2025-08-19T00:34:40.684833694Z" level=info msg="Initializing buildkit" Aug 19 00:34:40.736830 dockerd[2143]: time="2025-08-19T00:34:40.736771914Z" level=info msg="Completed buildkit initialization" Aug 19 00:34:40.757718 dockerd[2143]: time="2025-08-19T00:34:40.757646790Z" level=info msg="Daemon has completed initialization" Aug 19 00:34:40.759982 dockerd[2143]: time="2025-08-19T00:34:40.757910742Z" level=info msg="API listen on /run/docker.sock" Aug 19 00:34:40.761193 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1025771456-merged.mount: Deactivated successfully. Aug 19 00:34:40.765876 etcd-wrapper[2087]: Error response from daemon: No such container: etcd-member Aug 19 00:34:40.763195 systemd[1]: Started docker.service - Docker Application Container Engine. Aug 19 00:34:40.773373 sshd[2370]: Connection closed by 147.75.109.163 port 52344 Aug 19 00:34:40.773510 sshd-session[2284]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:40.784032 systemd[1]: sshd@1-172.31.17.62:22-147.75.109.163:52344.service: Deactivated successfully. Aug 19 00:34:40.789513 systemd[1]: session-2.scope: Deactivated successfully. Aug 19 00:34:40.793514 systemd-logind[1906]: Session 2 logged out. Waiting for processes to exit. Aug 19 00:34:40.804688 etcd-wrapper[2392]: Error response from daemon: No such container: etcd-member Aug 19 00:34:40.810754 systemd[1]: Started sshd@2-172.31.17.62:22-147.75.109.163:52350.service - OpenSSH per-connection server daemon (147.75.109.163:52350). Aug 19 00:34:40.819838 systemd-logind[1906]: Removed session 2. Aug 19 00:34:40.880681 etcd-wrapper[2417]: Unable to find image 'quay.io/coreos/etcd:v3.5.16-arm64' locally Aug 19 00:34:41.008431 sshd[2403]: Accepted publickey for core from 147.75.109.163 port 52350 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:41.008589 sshd-session[2403]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:41.016120 systemd-logind[1906]: New session 3 of user core. Aug 19 00:34:41.024984 systemd[1]: Started session-3.scope - Session 3 of User core. Aug 19 00:34:41.156107 sshd[2425]: Connection closed by 147.75.109.163 port 52350 Aug 19 00:34:41.156638 sshd-session[2403]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:41.165418 systemd[1]: sshd@2-172.31.17.62:22-147.75.109.163:52350.service: Deactivated successfully. Aug 19 00:34:41.169675 systemd[1]: session-3.scope: Deactivated successfully. Aug 19 00:34:41.171454 systemd-logind[1906]: Session 3 logged out. Waiting for processes to exit. Aug 19 00:34:41.174318 systemd-logind[1906]: Removed session 3. Aug 19 00:34:41.915628 etcd-wrapper[2417]: v3.5.16-arm64: Pulling from coreos/etcd Aug 19 00:34:41.915628 etcd-wrapper[2417]: d10f96ed9607: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 2ae710cd8bfe: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: d462aa345367: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 0f8b424aa0b9: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: d557676654e5: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: c8022d07192e: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: d858cbc252ad: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 1069fc2daed1: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: b40161cd83fc: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 5318d93a3a65: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 307c1adadb60: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: f9b3c65df792: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 5709b4a82c35: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: d5372e382b07: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 9c3b5253dddc: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: 7a57323f7551: Pulling fs layer Aug 19 00:34:41.917714 etcd-wrapper[2417]: b40161cd83fc: Waiting Aug 19 00:34:41.917714 etcd-wrapper[2417]: 5318d93a3a65: Waiting Aug 19 00:34:41.917714 etcd-wrapper[2417]: 307c1adadb60: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: f9b3c65df792: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: 5709b4a82c35: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: d5372e382b07: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: 9c3b5253dddc: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: 7a57323f7551: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: 0f8b424aa0b9: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: d557676654e5: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: 1069fc2daed1: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: c8022d07192e: Waiting Aug 19 00:34:41.919691 etcd-wrapper[2417]: d858cbc252ad: Waiting Aug 19 00:34:42.153368 etcd-wrapper[2417]: 2ae710cd8bfe: Verifying Checksum Aug 19 00:34:42.153368 etcd-wrapper[2417]: 2ae710cd8bfe: Download complete Aug 19 00:34:42.175668 etcd-wrapper[2417]: d462aa345367: Verifying Checksum Aug 19 00:34:42.175668 etcd-wrapper[2417]: d462aa345367: Download complete Aug 19 00:34:42.299483 etcd-wrapper[2417]: d10f96ed9607: Download complete Aug 19 00:34:42.346117 etcd-wrapper[2417]: d10f96ed9607: Pull complete Aug 19 00:34:42.376419 systemd[1]: var-lib-docker-overlay2-c932f69b7ed5f0a134b5fa8cdcdc556f2d0bcaeabdef8eb1d0fe2d34ba65a1ee-merged.mount: Deactivated successfully. Aug 19 00:34:42.409101 etcd-wrapper[2417]: 2ae710cd8bfe: Pull complete Aug 19 00:34:42.427018 etcd-wrapper[2417]: d557676654e5: Download complete Aug 19 00:34:42.446898 etcd-wrapper[2417]: 0f8b424aa0b9: Verifying Checksum Aug 19 00:34:42.447165 etcd-wrapper[2417]: 0f8b424aa0b9: Download complete Aug 19 00:34:42.680505 etcd-wrapper[2417]: d858cbc252ad: Verifying Checksum Aug 19 00:34:42.680931 etcd-wrapper[2417]: d858cbc252ad: Download complete Aug 19 00:34:42.702175 etcd-wrapper[2417]: c8022d07192e: Verifying Checksum Aug 19 00:34:42.703071 etcd-wrapper[2417]: c8022d07192e: Download complete Aug 19 00:34:42.790122 etcd-wrapper[2417]: 1069fc2daed1: Verifying Checksum Aug 19 00:34:42.790565 etcd-wrapper[2417]: 1069fc2daed1: Download complete Aug 19 00:34:42.921366 etcd-wrapper[2417]: b40161cd83fc: Verifying Checksum Aug 19 00:34:42.922327 etcd-wrapper[2417]: b40161cd83fc: Download complete Aug 19 00:34:42.935457 etcd-wrapper[2417]: 5318d93a3a65: Verifying Checksum Aug 19 00:34:42.935457 etcd-wrapper[2417]: 5318d93a3a65: Download complete Aug 19 00:34:43.064763 etcd-wrapper[2417]: 307c1adadb60: Verifying Checksum Aug 19 00:34:43.064763 etcd-wrapper[2417]: 307c1adadb60: Download complete Aug 19 00:34:43.156734 systemd[1]: var-lib-docker-overlay2-8b33375aed40d87cbeafcee9b1c73c004f2af289c91a68b83241dfde6b6f34ca-merged.mount: Deactivated successfully. Aug 19 00:34:43.181387 etcd-wrapper[2417]: d462aa345367: Pull complete Aug 19 00:34:43.205628 kernel: overlayfs: lowerdir is in-use as upperdir/workdir of another mount, accessing files from both mounts will result in undefined behavior. Aug 19 00:34:43.304613 etcd-wrapper[2417]: 0f8b424aa0b9: Pull complete Aug 19 00:34:43.306109 etcd-wrapper[2417]: 5709b4a82c35: Verifying Checksum Aug 19 00:34:43.306496 etcd-wrapper[2417]: 5709b4a82c35: Download complete Aug 19 00:34:43.309673 etcd-wrapper[2417]: f9b3c65df792: Verifying Checksum Aug 19 00:34:43.310067 etcd-wrapper[2417]: f9b3c65df792: Download complete Aug 19 00:34:43.362462 etcd-wrapper[2417]: d557676654e5: Pull complete Aug 19 00:34:43.363148 systemd[1]: var-lib-docker-overlay2-e9fc5e8728ac38b0cbdf603d0ed0f4ce1330e8c2150d84a774824979785b244b-merged.mount: Deactivated successfully. Aug 19 00:34:43.379723 etcd-wrapper[2417]: d5372e382b07: Verifying Checksum Aug 19 00:34:43.380034 etcd-wrapper[2417]: d5372e382b07: Download complete Aug 19 00:34:43.392744 systemd[1]: var-lib-docker-overlay2-05e55b2c32bdab140efb4db22e6c00d1d55aa617c687f82311314a1f60a8864e-merged.mount: Deactivated successfully. Aug 19 00:34:43.416313 etcd-wrapper[2417]: c8022d07192e: Pull complete Aug 19 00:34:43.445716 systemd[1]: var-lib-docker-overlay2-3b5eae6e22e06400b9ae0d00ae2409e947fde226a96170019264f19ef14c95f1-merged.mount: Deactivated successfully. Aug 19 00:34:43.463808 etcd-wrapper[2417]: d858cbc252ad: Pull complete Aug 19 00:34:43.505267 etcd-wrapper[2417]: 1069fc2daed1: Pull complete Aug 19 00:34:43.552024 etcd-wrapper[2417]: b40161cd83fc: Pull complete Aug 19 00:34:43.557239 etcd-wrapper[2417]: 7a57323f7551: Verifying Checksum Aug 19 00:34:43.557239 etcd-wrapper[2417]: 7a57323f7551: Download complete Aug 19 00:34:43.595069 etcd-wrapper[2417]: 5318d93a3a65: Pull complete Aug 19 00:34:43.644049 etcd-wrapper[2417]: 307c1adadb60: Pull complete Aug 19 00:34:43.672325 etcd-wrapper[2417]: 9c3b5253dddc: Verifying Checksum Aug 19 00:34:43.672625 etcd-wrapper[2417]: 9c3b5253dddc: Download complete Aug 19 00:34:43.716434 systemd-resolved[1694]: Clock change detected. Flushing caches. Aug 19 00:34:43.769121 etcd-wrapper[2417]: f9b3c65df792: Pull complete Aug 19 00:34:43.984982 etcd-wrapper[2417]: 5709b4a82c35: Pull complete Aug 19 00:34:44.196063 etcd-wrapper[2417]: d5372e382b07: Pull complete Aug 19 00:34:44.215861 systemd[1]: var-lib-docker-overlay2-6e40ee0c71072366063f4eb43a27d8f219d7f9d4ff70e34a48a40486794f94b9-merged.mount: Deactivated successfully. Aug 19 00:34:44.230532 etcd-wrapper[2417]: 9c3b5253dddc: Pull complete Aug 19 00:34:44.259646 systemd[1]: var-lib-docker-overlay2-e5715e3642767d85547269a85972df29ce16ef8fb48c933f3ab1dc180dcf4da3-merged.mount: Deactivated successfully. Aug 19 00:34:44.281103 etcd-wrapper[2417]: 7a57323f7551: Pull complete Aug 19 00:34:44.297500 etcd-wrapper[2417]: Digest: sha256:bdb64177a9250b4d594af525f4225c2d0657a251a6e38102a2ead39f67370db2 Aug 19 00:34:44.304309 etcd-wrapper[2417]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16-arm64 Aug 19 00:34:44.406197 containerd[1920]: time="2025-08-19T00:34:44.406054355Z" level=info msg="connecting to shim 6638fea5a44aa54f5acc424937636aee891aa2f081d764967542b6f52ac32173" address="unix:///run/containerd/s/eebaddd650c1c5f5ddb9e942b7468ae207128232305939b2146603510898f651" namespace=moby protocol=ttrpc version=3 Aug 19 00:34:44.457431 systemd[1]: Started docker-6638fea5a44aa54f5acc424937636aee891aa2f081d764967542b6f52ac32173.scope - libcontainer container 6638fea5a44aa54f5acc424937636aee891aa2f081d764967542b6f52ac32173. Aug 19 00:34:44.584577 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.583973Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Aug 19 00:34:44.585258 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.584214Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec2da4aafec4a6c228cf4f069ad9ce6b"} Aug 19 00:34:44.585258 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.584298Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Aug 19 00:34:44.585258 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.584318Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16-arm64"} Aug 19 00:34:44.585513 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.584463Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Aug 19 00:34:44.585513 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.584741Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Aug 19 00:34:44.585513 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.585032Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 19 00:34:44.585513 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.585091Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.31.17.62:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.31.17.62:2380","--advertise-client-urls=http://172.31.17.62:2379","--discovery=https://discovery.etcd.io/26203863383d341f2f880938dc7a0c60"]} Aug 19 00:34:44.586360 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:44.585876Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Aug 19 00:34:44.586360 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.585922Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://172.31.17.62:2380"]} Aug 19 00:34:44.586859 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.586221Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Aug 19 00:34:44.587623 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.587155Z","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":"ec2da4aafec4a6c228cf4f069ad9ce6b","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.17.62:2380"],"listen-peer-urls":["http://172.31.17.62:2380"],"advertise-client-urls":["http://172.31.17.62:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec2da4aafec4a6c228cf4f069ad9ce6b=http://172.31.17.62:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/26203863383d341f2f880938dc7a0c60","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/26203863383d341f2f880938dc7a0c60","discovery-proxy":"","downgrade-check-interval":"5s"} Aug 19 00:34:44.592271 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:44.591802Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.476376ms"} Aug 19 00:34:45.135419 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.133977Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"d843cf10611c7a0e"} Aug 19 00:34:45.135419 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.134025Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.135419 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.134042Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"ee19089ee8921d28"} Aug 19 00:34:45.135419 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.134056Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Aug 19 00:34:45.141407 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141069Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"ee19089ee8921d28","cluster-id":"7dac9fc9e63a5538"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141741Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=()"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141788Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became follower at term 0"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft ee19089ee8921d28 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became follower at term 1"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975)"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141906Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975 15583526804887730702)"} Aug 19 00:34:45.142511 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.141936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975 15583526804887730702 17156753734044359976)"} Aug 19 00:34:45.144530 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:45.144255Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Aug 19 00:34:45.147041 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.146783Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Aug 19 00:34:45.149368 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.149044Z","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"} Aug 19 00:34:45.151660 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.151278Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.152221 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.151438Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.153551 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.152429Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.154409 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154051Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.155138 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154125Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7","remote-peer-urls":["http://172.31.26.79:2380"]} Aug 19 00:34:45.156465 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154058Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.156465 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154213Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.156465 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154476Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.156465 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154699Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.156465 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.154245Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.157751 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.157055Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.159584 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159070Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159427Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159965Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.160013Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159524Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159819Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159854Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.159926Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e","remote-peer-urls":["http://172.31.30.144:2380"]} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.160343Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"ee19089ee8921d28","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Aug 19 00:34:45.161301 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.160632Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.161998Z","caller":"etcdserver/server.go:773","msg":"starting initial election tick advance","election-ticks":10} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162152Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162224Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162243Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975 15583526804887730702 17156753734044359976)"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162622Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7dac9fc9e63a5538","local-member-id":"ee19089ee8921d28","added-peer-id":"d6a6a5f05ca4ceb7","added-peer-peer-urls":["http://172.31.26.79:2380"]} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162700Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975 15583526804887730702 17156753734044359976)"} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162756Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7dac9fc9e63a5538","local-member-id":"ee19089ee8921d28","added-peer-id":"d843cf10611c7a0e","added-peer-peer-urls":["http://172.31.30.144:2380"]} Aug 19 00:34:45.163631 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162830Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 switched to configuration voters=(15467232422015585975 15583526804887730702 17156753734044359976)"} Aug 19 00:34:45.164271 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.162880Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"7dac9fc9e63a5538","local-member-id":"ee19089ee8921d28","added-peer-id":"ee19089ee8921d28","added-peer-peer-urls":["http://172.31.17.62:2380"]} Aug 19 00:34:45.165467 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.164263Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"ee19089ee8921d28","initial-advertise-peer-urls":["http://172.31.17.62:2380"],"listen-peer-urls":["http://172.31.17.62:2380"],"advertise-client-urls":["http://172.31.17.62:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Aug 19 00:34:45.165467 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.164439Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"172.31.17.62:2380"} Aug 19 00:34:45.165467 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.164471Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"172.31.17.62:2380"} Aug 19 00:34:45.165467 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.164813Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.165467 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.165016Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.167224 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.166834Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ee19089ee8921d28","to":"d843cf10611c7a0e","stream-type":"stream Message"} Aug 19 00:34:45.167224 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.166892Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.169444 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.168339Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ee19089ee8921d28","to":"d6a6a5f05ca4ceb7","stream-type":"stream MsgApp v2"} Aug 19 00:34:45.169444 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.168419Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.169444 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.168724Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ee19089ee8921d28","to":"d843cf10611c7a0e","stream-type":"stream MsgApp v2"} Aug 19 00:34:45.169444 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.168755Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.169444 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.168934Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:34:45.170310 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.169230Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"ee19089ee8921d28","to":"d6a6a5f05ca4ceb7","stream-type":"stream Message"} Aug 19 00:34:45.170310 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.169523Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:34:45.206401 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.205914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 1, index: 3, vote: 0] cast MsgPreVote for d843cf10611c7a0e [logterm: 1, index: 3] at term 1"} Aug 19 00:34:45.207825 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.207482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [term: 1] received a MsgVote message with higher term from d843cf10611c7a0e [term: 2]"} Aug 19 00:34:45.207825 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.207537Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became follower at term 2"} Aug 19 00:34:45.208052 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.207561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 1, index: 3, vote: 0] cast MsgVote for d843cf10611c7a0e [logterm: 1, index: 3] at term 2"} Aug 19 00:34:45.210330 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.209994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 elected leader d843cf10611c7a0e at term 2"} Aug 19 00:34:45.213066 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.212664Z","caller":"etcdserver/server.go:796","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"ee19089ee8921d28","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Aug 19 00:34:45.216675 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.215726Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Aug 19 00:34:45.217202 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.216500Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Aug 19 00:34:45.217202 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.216631Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Aug 19 00:34:45.217446 systemd[1]: Started etcd-member.service - etcd (System Application Container). Aug 19 00:34:45.218486 systemd[1]: Reached target multi-user.target - Multi-User System. Aug 19 00:34:45.219315 systemd[1]: Startup finished in 3.662s (kernel) + 11.115s (initrd) + 15.661s (userspace) = 30.439s. Aug 19 00:34:45.221720 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.215736Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"ee19089ee8921d28","local-member-attributes":"{Name:ec2da4aafec4a6c228cf4f069ad9ce6b ClientURLs:[http://172.31.17.62:2379]}","request-path":"/0/members/ee19089ee8921d28/attributes","cluster-id":"7dac9fc9e63a5538","publish-timeout":"7s"} Aug 19 00:34:45.221720 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.217938Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Aug 19 00:34:45.221720 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.218615Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Aug 19 00:34:45.224327 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.223946Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"7dac9fc9e63a5538","local-member-id":"ee19089ee8921d28","cluster-version":"3.5"} Aug 19 00:34:45.224843 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:45.224602Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Aug 19 00:34:51.015462 systemd[1]: Started sshd@3-172.31.17.62:22-147.75.109.163:39258.service - OpenSSH per-connection server daemon (147.75.109.163:39258). Aug 19 00:34:51.207125 sshd[2570]: Accepted publickey for core from 147.75.109.163 port 39258 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:51.209460 sshd-session[2570]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:51.217158 systemd-logind[1906]: New session 4 of user core. Aug 19 00:34:51.231446 systemd[1]: Started session-4.scope - Session 4 of User core. Aug 19 00:34:51.355245 sshd[2573]: Connection closed by 147.75.109.163 port 39258 Aug 19 00:34:51.356363 sshd-session[2570]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:51.363276 systemd-logind[1906]: Session 4 logged out. Waiting for processes to exit. Aug 19 00:34:51.363851 systemd[1]: sshd@3-172.31.17.62:22-147.75.109.163:39258.service: Deactivated successfully. Aug 19 00:34:51.367859 systemd[1]: session-4.scope: Deactivated successfully. Aug 19 00:34:51.370959 systemd-logind[1906]: Removed session 4. Aug 19 00:34:51.389384 systemd[1]: Started sshd@4-172.31.17.62:22-147.75.109.163:39272.service - OpenSSH per-connection server daemon (147.75.109.163:39272). Aug 19 00:34:51.579414 sshd[2579]: Accepted publickey for core from 147.75.109.163 port 39272 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:51.581713 sshd-session[2579]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:51.591260 systemd-logind[1906]: New session 5 of user core. Aug 19 00:34:51.596486 systemd[1]: Started session-5.scope - Session 5 of User core. Aug 19 00:34:51.713415 sshd[2582]: Connection closed by 147.75.109.163 port 39272 Aug 19 00:34:51.714223 sshd-session[2579]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:51.721696 systemd[1]: sshd@4-172.31.17.62:22-147.75.109.163:39272.service: Deactivated successfully. Aug 19 00:34:51.724888 systemd[1]: session-5.scope: Deactivated successfully. Aug 19 00:34:51.726459 systemd-logind[1906]: Session 5 logged out. Waiting for processes to exit. Aug 19 00:34:51.728828 systemd-logind[1906]: Removed session 5. Aug 19 00:34:51.751348 systemd[1]: Started sshd@5-172.31.17.62:22-147.75.109.163:39288.service - OpenSSH per-connection server daemon (147.75.109.163:39288). Aug 19 00:34:51.953109 sshd[2589]: Accepted publickey for core from 147.75.109.163 port 39288 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:51.955420 sshd-session[2589]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:51.964255 systemd-logind[1906]: New session 6 of user core. Aug 19 00:34:51.971464 systemd[1]: Started session-6.scope - Session 6 of User core. Aug 19 00:34:52.098209 sshd[2592]: Connection closed by 147.75.109.163 port 39288 Aug 19 00:34:52.098128 sshd-session[2589]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:52.105053 systemd[1]: sshd@5-172.31.17.62:22-147.75.109.163:39288.service: Deactivated successfully. Aug 19 00:34:52.108643 systemd[1]: session-6.scope: Deactivated successfully. Aug 19 00:34:52.110254 systemd-logind[1906]: Session 6 logged out. Waiting for processes to exit. Aug 19 00:34:52.113034 systemd-logind[1906]: Removed session 6. Aug 19 00:34:52.138134 systemd[1]: Started sshd@6-172.31.17.62:22-147.75.109.163:39300.service - OpenSSH per-connection server daemon (147.75.109.163:39300). Aug 19 00:34:52.325194 sshd[2598]: Accepted publickey for core from 147.75.109.163 port 39300 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:52.327497 sshd-session[2598]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:52.336255 systemd-logind[1906]: New session 7 of user core. Aug 19 00:34:52.344452 systemd[1]: Started session-7.scope - Session 7 of User core. Aug 19 00:34:52.479773 sudo[2602]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Aug 19 00:34:52.480386 sudo[2602]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 19 00:34:52.496462 sudo[2602]: pam_unix(sudo:session): session closed for user root Aug 19 00:34:52.520206 sshd[2601]: Connection closed by 147.75.109.163 port 39300 Aug 19 00:34:52.519554 sshd-session[2598]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:52.525590 systemd[1]: sshd@6-172.31.17.62:22-147.75.109.163:39300.service: Deactivated successfully. Aug 19 00:34:52.528790 systemd[1]: session-7.scope: Deactivated successfully. Aug 19 00:34:52.534956 systemd-logind[1906]: Session 7 logged out. Waiting for processes to exit. Aug 19 00:34:52.537520 systemd-logind[1906]: Removed session 7. Aug 19 00:34:52.558536 systemd[1]: Started sshd@7-172.31.17.62:22-147.75.109.163:39314.service - OpenSSH per-connection server daemon (147.75.109.163:39314). Aug 19 00:34:52.761224 sshd[2608]: Accepted publickey for core from 147.75.109.163 port 39314 ssh2: RSA SHA256:+jhdm8e3OD9bkQQ/U7a3GQMay4jpjK/QNIiwSV4ITyc Aug 19 00:34:52.763648 sshd-session[2608]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Aug 19 00:34:52.771345 systemd-logind[1906]: New session 8 of user core. Aug 19 00:34:52.778395 systemd[1]: Started session-8.scope - Session 8 of User core. Aug 19 00:34:52.882077 sudo[2613]: 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 Aug 19 00:34:52.882716 sudo[2613]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 19 00:34:52.891201 sudo[2613]: pam_unix(sudo:session): session closed for user root Aug 19 00:34:52.900945 sudo[2612]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/systemctl restart audit-rules Aug 19 00:34:52.902016 sudo[2612]: pam_unix(sudo:session): session opened for user root(uid=0) by core(uid=500) Aug 19 00:34:52.918543 systemd[1]: Starting audit-rules.service - Load Audit Rules... Aug 19 00:34:52.976599 augenrules[2635]: No rules Aug 19 00:34:52.979017 systemd[1]: audit-rules.service: Deactivated successfully. Aug 19 00:34:52.979668 systemd[1]: Finished audit-rules.service - Load Audit Rules. Aug 19 00:34:52.982491 sudo[2612]: pam_unix(sudo:session): session closed for user root Aug 19 00:34:53.005821 sshd[2611]: Connection closed by 147.75.109.163 port 39314 Aug 19 00:34:53.006918 sshd-session[2608]: pam_unix(sshd:session): session closed for user core Aug 19 00:34:53.012943 systemd[1]: sshd@7-172.31.17.62:22-147.75.109.163:39314.service: Deactivated successfully. Aug 19 00:34:53.016919 systemd[1]: session-8.scope: Deactivated successfully. Aug 19 00:34:53.019390 systemd-logind[1906]: Session 8 logged out. Waiting for processes to exit. Aug 19 00:34:53.024382 systemd-logind[1906]: Removed session 8. Aug 19 00:34:58.990234 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:58.989844Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [term: 2] received a MsgVote message with higher term from d6a6a5f05ca4ceb7 [term: 3]"} Aug 19 00:34:58.990234 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:58.989896Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became follower at term 3"} Aug 19 00:34:58.991270 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:58.989919Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 2, index: 11, vote: 0] cast MsgVote for d6a6a5f05ca4ceb7 [logterm: 2, index: 11] at term 3"} Aug 19 00:34:58.991270 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:58.989936Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 lost leader d843cf10611c7a0e at term 3"} Aug 19 00:34:58.992314 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:34:58.991994Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 elected leader d6a6a5f05ca4ceb7 at term 3"} Aug 19 00:34:59.102518 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:59.102080Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e","error":"EOF"} Aug 19 00:34:59.103338 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:59.102887Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e","error":"EOF"} Aug 19 00:34:59.106833 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:34:59.106462Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"d843cf10611c7a0e","error":"failed to dial d843cf10611c7a0e on stream MsgApp v2 (peer d843cf10611c7a0e failed to find local node ee19089ee8921d28)"} Aug 19 00:35:05.157639 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:05.157276Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:35:05.161468 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:05.160934Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d843cf10611c7a0e"} Aug 19 00:35:08.111632 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Aug 19 00:35:20.161794 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:20.161223Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"d843cf10611c7a0e","rtt":"356.496µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:20.161794 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:20.161234Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"d843cf10611c7a0e","rtt":"248.298µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:21.238835 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238469Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [term 3] received MsgTimeoutNow from d6a6a5f05ca4ceb7 and starts an election to get leadership."} Aug 19 00:35:21.238835 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 3"} Aug 19 00:35:21.238835 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became candidate at term 4"} Aug 19 00:35:21.239680 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238562Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:21.239680 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238586Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 3, index: 12] sent MsgVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:21.239680 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238604Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 3, index: 12] sent MsgVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:21.239680 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.238622Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 lost leader d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:21.243037 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.242716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgVoteResp from d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:21.243453 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.242825Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 has received 2 MsgVoteResp votes and 0 vote rejections"} Aug 19 00:35:21.243453 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.243155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became leader at term 4"} Aug 19 00:35:21.243882 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:21.243399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 elected leader ee19089ee8921d28 at term 4"} Aug 19 00:35:21.340235 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:21.339776Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7","error":"EOF"} Aug 19 00:35:21.340912 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:21.340136Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7","error":"EOF"} Aug 19 00:35:21.345302 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:21.344827Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"d6a6a5f05ca4ceb7","error":"failed to dial d6a6a5f05ca4ceb7 on stream Message (peer d6a6a5f05ca4ceb7 failed to find local node ee19089ee8921d28)"} Aug 19 00:35:21.642753 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:21.642351Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:35:21.794228 update_engine[1907]: I20250819 00:35:21.793884 1907 update_attempter.cc:509] Updating boot flags... Aug 19 00:35:23.243125 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:23.242710Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"ee19089ee8921d28 stepped down to follower since quorum is not active"} Aug 19 00:35:23.243125 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:23.242764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became follower at term 4"} Aug 19 00:35:23.243125 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:23.242786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: ee19089ee8921d28 lost leader ee19089ee8921d28 at term 4"} Aug 19 00:35:23.255661 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:23.255298Z","caller":"etcdserver/cluster_util.go:294","msg":"failed to reach the peer URL","address":"http://172.31.30.144:2380/version","remote-member-id":"d843cf10611c7a0e","error":"Get \"http://172.31.30.144:2380/version\": dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:23.255661 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:23.255441Z","caller":"etcdserver/cluster_util.go:158","msg":"failed to get version","remote-member-id":"d843cf10611c7a0e","error":"Get \"http://172.31.30.144:2380/version\": dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:24.243514 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:24.242803Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:24.243514 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:24.242853Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:24.243514 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:24.242875Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:24.243514 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:24.242900Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:24.243514 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:24.243001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:25.162002 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:25.161592Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"d843cf10611c7a0e","rtt":"248.298µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:25.162002 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:25.161663Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"d843cf10611c7a0e","rtt":"356.496µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:25.243035 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:25.242482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:25.243035 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:25.242532Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:25.243035 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:25.242554Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:25.243035 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:25.242580Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:25.243035 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:25.242618Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:26.243575 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:26.242895Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:26.243575 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:26.242944Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:26.243575 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:26.242963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:26.243575 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:26.242987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:26.243575 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:26.243005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:26.819574 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:26.819189Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"ee19089ee8921d28","remote-peer-id":"d6a6a5f05ca4ceb7"} Aug 19 00:35:27.243486 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:27.242424Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:27.243486 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:27.242468Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:27.243486 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:27.242488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:27.243486 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:27.242523Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:27.243486 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:27.242541Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:28.243781 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:28.243212Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:28.243781 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:28.243257Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:28.243781 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:28.243277Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:28.243781 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:28.243302Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:28.243781 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:28.243320Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:29.243457 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:29.242731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:29.243457 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:29.242784Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:29.243457 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:29.242808Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:29.243457 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:29.242834Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:29.243457 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:29.242914Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:30.162371 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:30.161959Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"d843cf10611c7a0e","rtt":"356.496µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:30.162371 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:30.161986Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"d843cf10611c7a0e","rtt":"248.298µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:30.243506 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:30.243089Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:30.243506 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:30.243140Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:30.243732 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:30.243182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:30.243732 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:30.243267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:30.243732 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:30.243364Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:31.243267 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:31.242602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:31.243267 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:31.242664Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:31.243267 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:31.242687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:31.243267 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:31.242731Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:31.243267 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:31.242761Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:32.243294 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:32.242717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:32.243294 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:32.242765Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:32.243294 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:32.242786Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:32.243294 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:32.242812Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:32.243294 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:32.242830Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:33.243400 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:33.242640Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:33.243400 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:33.242687Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:33.243400 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:33.242708Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:33.243400 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:33.242733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:33.243400 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:33.242751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:34.243642 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:34.242938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:34.243642 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:34.243008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:34.243642 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:34.243030Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:34.243642 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:34.243054Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:34.243642 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:34.243072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:35.163086 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:35.162687Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"d843cf10611c7a0e","rtt":"248.298µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:35.163086 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:35.162755Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"d843cf10611c7a0e","rtt":"356.496µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:35.243529 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:35.242845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:35.243529 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:35.242899Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:35.243529 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:35.242923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:35.243529 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:35.242975Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:35.244394 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:35.243010Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:36.243206 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:36.242721Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:36.243206 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:36.242773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:36.243206 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:36.242797Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:36.243206 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:36.242823Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:36.243562 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:36.242842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:37.243722 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:37.243076Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:37.243722 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:37.243129Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:37.243722 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:37.243152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:37.243722 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:37.243200Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:37.243722 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:37.243400Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:38.243609 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:38.242931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:38.243609 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:38.242998Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:38.243609 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:38.243021Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:38.243609 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:38.243048Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:38.243609 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:38.243067Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:39.243014 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:39.242544Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:39.243014 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:39.242594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:39.243513 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:39.242617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:39.243513 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:39.242649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:39.243513 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:39.242669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:40.163497 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:40.163100Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"d843cf10611c7a0e","rtt":"356.496µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:40.163497 etcd-wrapper[2417]: {"level":"warn","ts":"2025-08-19T00:35:40.163123Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"d843cf10611c7a0e","rtt":"248.298µs","error":"dial tcp 172.31.30.144:2380: i/o timeout"} Aug 19 00:35:40.243778 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:40.243103Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:40.243959 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:40.243243Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:40.243959 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:40.243285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:40.243959 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:40.243314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:40.243959 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:40.243332Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:41.243774 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:41.243113Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:41.243774 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:41.243188Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:41.243774 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:41.243213Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:41.243774 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:41.243240Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:41.243774 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:41.243259Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"} Aug 19 00:35:42.243655 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:42.242793Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 is starting a new election at term 4"} Aug 19 00:35:42.243655 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:42.242842Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 became pre-candidate at term 4"} Aug 19 00:35:42.243655 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:42.242863Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 received MsgPreVoteResp from ee19089ee8921d28 at term 4"} Aug 19 00:35:42.243655 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:42.242889Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d6a6a5f05ca4ceb7 at term 4"} Aug 19 00:35:42.243655 etcd-wrapper[2417]: {"level":"info","ts":"2025-08-19T00:35:42.242926Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"ee19089ee8921d28 [logterm: 4, index: 13] sent MsgPreVote request to d843cf10611c7a0e at term 4"}