Sep 12 23:53:02.249763 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 12 23:53:02.249808 kernel: Linux version 6.6.106-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 13.3.1_p20240614 p17) 13.3.1 20240614, GNU ld (Gentoo 2.42 p3) 2.42.0) #1 SMP PREEMPT Fri Sep 12 22:36:20 -00 2025 Sep 12 23:53:02.249833 kernel: KASLR disabled due to lack of seed Sep 12 23:53:02.249850 kernel: efi: EFI v2.7 by EDK II Sep 12 23:53:02.249866 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7affea98 MEMRESERVE=0x7852ee18 Sep 12 23:53:02.249882 kernel: ACPI: Early table checksum verification disabled Sep 12 23:53:02.249900 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 12 23:53:02.249916 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 12 23:53:02.249932 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 12 23:53:02.249948 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Sep 12 23:53:02.249969 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 12 23:53:02.249985 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 12 23:53:02.250000 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 12 23:53:02.250016 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 12 23:53:02.250035 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 12 23:53:02.250057 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 12 23:53:02.250074 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 12 23:53:02.250091 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 12 23:53:02.250107 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 12 23:53:02.250124 kernel: printk: bootconsole [uart0] enabled Sep 12 23:53:02.250140 kernel: NUMA: Failed to initialise from firmware Sep 12 23:53:02.250157 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 12 23:53:02.250173 kernel: NUMA: NODE_DATA [mem 0x4b583f800-0x4b5844fff] Sep 12 23:53:02.250190 kernel: Zone ranges: Sep 12 23:53:02.250206 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 12 23:53:02.250222 kernel: DMA32 empty Sep 12 23:53:02.250243 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 12 23:53:02.250260 kernel: Movable zone start for each node Sep 12 23:53:02.250277 kernel: Early memory node ranges Sep 12 23:53:02.250293 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 12 23:53:02.250310 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 12 23:53:02.250326 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 12 23:53:02.250343 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 12 23:53:02.250359 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 12 23:53:02.250375 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 12 23:53:02.250392 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 12 23:53:02.250471 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 12 23:53:02.250491 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 12 23:53:02.250515 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 12 23:53:02.250533 kernel: psci: probing for conduit method from ACPI. Sep 12 23:53:02.250557 kernel: psci: PSCIv1.0 detected in firmware. Sep 12 23:53:02.250574 kernel: psci: Using standard PSCI v0.2 function IDs Sep 12 23:53:02.250592 kernel: psci: Trusted OS migration not required Sep 12 23:53:02.250613 kernel: psci: SMC Calling Convention v1.1 Sep 12 23:53:02.250632 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 12 23:53:02.250649 kernel: percpu: Embedded 31 pages/cpu s86632 r8192 d32152 u126976 Sep 12 23:53:02.250667 kernel: pcpu-alloc: s86632 r8192 d32152 u126976 alloc=31*4096 Sep 12 23:53:02.250684 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 12 23:53:02.250702 kernel: Detected PIPT I-cache on CPU0 Sep 12 23:53:02.250719 kernel: CPU features: detected: GIC system register CPU interface Sep 12 23:53:02.250737 kernel: CPU features: detected: Spectre-v2 Sep 12 23:53:02.250754 kernel: CPU features: detected: Spectre-v3a Sep 12 23:53:02.250771 kernel: CPU features: detected: Spectre-BHB Sep 12 23:53:02.250789 kernel: CPU features: detected: ARM erratum 1742098 Sep 12 23:53:02.250810 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 12 23:53:02.250828 kernel: alternatives: applying boot alternatives Sep 12 23:53:02.250848 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=e1b46f3c9e154636c32f6cde6e746a00a6b37ca7432cb4e16d172c05f584a8c9 Sep 12 23:53:02.250867 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Sep 12 23:53:02.250884 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 12 23:53:02.250902 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 12 23:53:02.250919 kernel: Fallback order for Node 0: 0 Sep 12 23:53:02.250937 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Sep 12 23:53:02.250954 kernel: Policy zone: Normal Sep 12 23:53:02.250972 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 12 23:53:02.250989 kernel: software IO TLB: area num 2. Sep 12 23:53:02.251011 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Sep 12 23:53:02.251030 kernel: Memory: 3820024K/4030464K available (10304K kernel code, 2186K rwdata, 8108K rodata, 39488K init, 897K bss, 210440K reserved, 0K cma-reserved) Sep 12 23:53:02.251047 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 12 23:53:02.251065 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 12 23:53:02.251083 kernel: rcu: RCU event tracing is enabled. Sep 12 23:53:02.251101 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 12 23:53:02.251119 kernel: Trampoline variant of Tasks RCU enabled. Sep 12 23:53:02.251137 kernel: Tracing variant of Tasks RCU enabled. Sep 12 23:53:02.251154 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 12 23:53:02.251172 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 12 23:53:02.251189 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 12 23:53:02.251211 kernel: GICv3: 96 SPIs implemented Sep 12 23:53:02.251229 kernel: GICv3: 0 Extended SPIs implemented Sep 12 23:53:02.251246 kernel: Root IRQ handler: gic_handle_irq Sep 12 23:53:02.251263 kernel: GICv3: GICv3 features: 16 PPIs Sep 12 23:53:02.251280 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 12 23:53:02.251298 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 12 23:53:02.251315 kernel: ITS@0x0000000010080000: allocated 8192 Devices @4000b0000 (indirect, esz 8, psz 64K, shr 1) Sep 12 23:53:02.251333 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000c0000 (flat, esz 8, psz 64K, shr 1) Sep 12 23:53:02.251351 kernel: GICv3: using LPI property table @0x00000004000d0000 Sep 12 23:53:02.251368 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 12 23:53:02.251385 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000e0000 Sep 12 23:53:02.251422 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 12 23:53:02.251450 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 12 23:53:02.251468 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 12 23:53:02.251486 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 12 23:53:02.251504 kernel: Console: colour dummy device 80x25 Sep 12 23:53:02.251522 kernel: printk: console [tty1] enabled Sep 12 23:53:02.251540 kernel: ACPI: Core revision 20230628 Sep 12 23:53:02.251558 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 12 23:53:02.251575 kernel: pid_max: default: 32768 minimum: 301 Sep 12 23:53:02.251594 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,integrity Sep 12 23:53:02.251616 kernel: landlock: Up and running. Sep 12 23:53:02.251635 kernel: SELinux: Initializing. Sep 12 23:53:02.251654 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 12 23:53:02.251672 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 12 23:53:02.251691 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 12 23:53:02.251709 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 12 23:53:02.251727 kernel: rcu: Hierarchical SRCU implementation. Sep 12 23:53:02.251745 kernel: rcu: Max phase no-delay instances is 400. Sep 12 23:53:02.251763 kernel: Platform MSI: ITS@0x10080000 domain created Sep 12 23:53:02.251786 kernel: PCI/MSI: ITS@0x10080000 domain created Sep 12 23:53:02.251804 kernel: Remapping and enabling EFI services. Sep 12 23:53:02.251822 kernel: smp: Bringing up secondary CPUs ... Sep 12 23:53:02.251840 kernel: Detected PIPT I-cache on CPU1 Sep 12 23:53:02.251858 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 12 23:53:02.251876 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000f0000 Sep 12 23:53:02.251894 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 12 23:53:02.251911 kernel: smp: Brought up 1 node, 2 CPUs Sep 12 23:53:02.251929 kernel: SMP: Total of 2 processors activated. Sep 12 23:53:02.251947 kernel: CPU features: detected: 32-bit EL0 Support Sep 12 23:53:02.251970 kernel: CPU features: detected: 32-bit EL1 Support Sep 12 23:53:02.251988 kernel: CPU features: detected: CRC32 instructions Sep 12 23:53:02.252018 kernel: CPU: All CPU(s) started at EL1 Sep 12 23:53:02.252041 kernel: alternatives: applying system-wide alternatives Sep 12 23:53:02.252060 kernel: devtmpfs: initialized Sep 12 23:53:02.252079 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 12 23:53:02.252097 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 12 23:53:02.252116 kernel: pinctrl core: initialized pinctrl subsystem Sep 12 23:53:02.252135 kernel: SMBIOS 3.0.0 present. Sep 12 23:53:02.252158 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 12 23:53:02.252177 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 12 23:53:02.252195 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 12 23:53:02.252214 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 12 23:53:02.252233 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 12 23:53:02.252251 kernel: audit: initializing netlink subsys (disabled) Sep 12 23:53:02.252270 kernel: audit: type=2000 audit(0.286:1): state=initialized audit_enabled=0 res=1 Sep 12 23:53:02.252293 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 12 23:53:02.252312 kernel: cpuidle: using governor menu Sep 12 23:53:02.252330 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 12 23:53:02.252349 kernel: ASID allocator initialised with 65536 entries Sep 12 23:53:02.252367 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 12 23:53:02.252386 kernel: Serial: AMBA PL011 UART driver Sep 12 23:53:02.252432 kernel: Modules: 17472 pages in range for non-PLT usage Sep 12 23:53:02.252455 kernel: Modules: 508992 pages in range for PLT usage Sep 12 23:53:02.252474 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 12 23:53:02.252500 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 12 23:53:02.252519 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 12 23:53:02.252538 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 12 23:53:02.252556 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 12 23:53:02.252575 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 12 23:53:02.252593 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 12 23:53:02.252612 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 12 23:53:02.252630 kernel: ACPI: Added _OSI(Module Device) Sep 12 23:53:02.252648 kernel: ACPI: Added _OSI(Processor Device) Sep 12 23:53:02.252672 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 12 23:53:02.252691 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 12 23:53:02.252709 kernel: ACPI: Interpreter enabled Sep 12 23:53:02.252746 kernel: ACPI: Using GIC for interrupt routing Sep 12 23:53:02.252769 kernel: ACPI: MCFG table detected, 1 entries Sep 12 23:53:02.252791 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Sep 12 23:53:02.253115 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 12 23:53:02.253336 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 12 23:53:02.254031 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 12 23:53:02.255985 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Sep 12 23:53:02.256196 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Sep 12 23:53:02.256223 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 12 23:53:02.256243 kernel: acpiphp: Slot [1] registered Sep 12 23:53:02.256262 kernel: acpiphp: Slot [2] registered Sep 12 23:53:02.256280 kernel: acpiphp: Slot [3] registered Sep 12 23:53:02.256299 kernel: acpiphp: Slot [4] registered Sep 12 23:53:02.256326 kernel: acpiphp: Slot [5] registered Sep 12 23:53:02.256345 kernel: acpiphp: Slot [6] registered Sep 12 23:53:02.256363 kernel: acpiphp: Slot [7] registered Sep 12 23:53:02.256381 kernel: acpiphp: Slot [8] registered Sep 12 23:53:02.256429 kernel: acpiphp: Slot [9] registered Sep 12 23:53:02.256454 kernel: acpiphp: Slot [10] registered Sep 12 23:53:02.256474 kernel: acpiphp: Slot [11] registered Sep 12 23:53:02.256493 kernel: acpiphp: Slot [12] registered Sep 12 23:53:02.256511 kernel: acpiphp: Slot [13] registered Sep 12 23:53:02.256529 kernel: acpiphp: Slot [14] registered Sep 12 23:53:02.256554 kernel: acpiphp: Slot [15] registered Sep 12 23:53:02.256573 kernel: acpiphp: Slot [16] registered Sep 12 23:53:02.256592 kernel: acpiphp: Slot [17] registered Sep 12 23:53:02.256610 kernel: acpiphp: Slot [18] registered Sep 12 23:53:02.256628 kernel: acpiphp: Slot [19] registered Sep 12 23:53:02.256647 kernel: acpiphp: Slot [20] registered Sep 12 23:53:02.256665 kernel: acpiphp: Slot [21] registered Sep 12 23:53:02.256684 kernel: acpiphp: Slot [22] registered Sep 12 23:53:02.256702 kernel: acpiphp: Slot [23] registered Sep 12 23:53:02.256741 kernel: acpiphp: Slot [24] registered Sep 12 23:53:02.256766 kernel: acpiphp: Slot [25] registered Sep 12 23:53:02.256785 kernel: acpiphp: Slot [26] registered Sep 12 23:53:02.256803 kernel: acpiphp: Slot [27] registered Sep 12 23:53:02.256822 kernel: acpiphp: Slot [28] registered Sep 12 23:53:02.256840 kernel: acpiphp: Slot [29] registered Sep 12 23:53:02.256858 kernel: acpiphp: Slot [30] registered Sep 12 23:53:02.256877 kernel: acpiphp: Slot [31] registered Sep 12 23:53:02.256895 kernel: PCI host bridge to bus 0000:00 Sep 12 23:53:02.257115 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 12 23:53:02.257313 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 12 23:53:02.257545 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 12 23:53:02.257732 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Sep 12 23:53:02.257971 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Sep 12 23:53:02.258203 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Sep 12 23:53:02.258445 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Sep 12 23:53:02.258693 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Sep 12 23:53:02.258908 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Sep 12 23:53:02.259122 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 12 23:53:02.259351 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Sep 12 23:53:02.259738 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Sep 12 23:53:02.259964 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Sep 12 23:53:02.260183 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Sep 12 23:53:02.260395 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 12 23:53:02.260655 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Sep 12 23:53:02.260895 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Sep 12 23:53:02.261108 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Sep 12 23:53:02.261316 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Sep 12 23:53:02.261578 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Sep 12 23:53:02.261778 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 12 23:53:02.261977 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 12 23:53:02.262168 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 12 23:53:02.262194 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 12 23:53:02.262214 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 12 23:53:02.262234 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 12 23:53:02.262253 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 12 23:53:02.262272 kernel: iommu: Default domain type: Translated Sep 12 23:53:02.262291 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 12 23:53:02.262316 kernel: efivars: Registered efivars operations Sep 12 23:53:02.262335 kernel: vgaarb: loaded Sep 12 23:53:02.262353 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 12 23:53:02.262372 kernel: VFS: Disk quotas dquot_6.6.0 Sep 12 23:53:02.262391 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 12 23:53:02.262433 kernel: pnp: PnP ACPI init Sep 12 23:53:02.262681 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 12 23:53:02.262714 kernel: pnp: PnP ACPI: found 1 devices Sep 12 23:53:02.262743 kernel: NET: Registered PF_INET protocol family Sep 12 23:53:02.262765 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 12 23:53:02.262785 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 12 23:53:02.262805 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 12 23:53:02.262827 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 12 23:53:02.262846 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 12 23:53:02.262866 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 12 23:53:02.262885 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 12 23:53:02.262906 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 12 23:53:02.262931 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 12 23:53:02.262951 kernel: PCI: CLS 0 bytes, default 64 Sep 12 23:53:02.262971 kernel: kvm [1]: HYP mode not available Sep 12 23:53:02.262990 kernel: Initialise system trusted keyrings Sep 12 23:53:02.263011 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 12 23:53:02.263030 kernel: Key type asymmetric registered Sep 12 23:53:02.263049 kernel: Asymmetric key parser 'x509' registered Sep 12 23:53:02.263068 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250) Sep 12 23:53:02.263090 kernel: io scheduler mq-deadline registered Sep 12 23:53:02.263115 kernel: io scheduler kyber registered Sep 12 23:53:02.263134 kernel: io scheduler bfq registered Sep 12 23:53:02.263396 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 12 23:53:02.263462 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 12 23:53:02.263482 kernel: ACPI: button: Power Button [PWRB] Sep 12 23:53:02.263501 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 12 23:53:02.263520 kernel: ACPI: button: Sleep Button [SLPB] Sep 12 23:53:02.263538 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 12 23:53:02.263568 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 12 23:53:02.263811 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 12 23:53:02.263839 kernel: printk: console [ttyS0] disabled Sep 12 23:53:02.263858 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 12 23:53:02.263877 kernel: printk: console [ttyS0] enabled Sep 12 23:53:02.263896 kernel: printk: bootconsole [uart0] disabled Sep 12 23:53:02.263914 kernel: thunder_xcv, ver 1.0 Sep 12 23:53:02.263933 kernel: thunder_bgx, ver 1.0 Sep 12 23:53:02.263951 kernel: nicpf, ver 1.0 Sep 12 23:53:02.263976 kernel: nicvf, ver 1.0 Sep 12 23:53:02.264212 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 12 23:53:02.264512 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-09-12T23:53:01 UTC (1757721181) Sep 12 23:53:02.264542 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 12 23:53:02.264562 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Sep 12 23:53:02.264581 kernel: watchdog: Delayed init of the lockup detector failed: -19 Sep 12 23:53:02.264600 kernel: watchdog: Hard watchdog permanently disabled Sep 12 23:53:02.264619 kernel: NET: Registered PF_INET6 protocol family Sep 12 23:53:02.264645 kernel: Segment Routing with IPv6 Sep 12 23:53:02.264664 kernel: In-situ OAM (IOAM) with IPv6 Sep 12 23:53:02.264683 kernel: NET: Registered PF_PACKET protocol family Sep 12 23:53:02.264701 kernel: Key type dns_resolver registered Sep 12 23:53:02.264720 kernel: registered taskstats version 1 Sep 12 23:53:02.264761 kernel: Loading compiled-in X.509 certificates Sep 12 23:53:02.264781 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.6.106-flatcar: 036ad4721a31543be5c000f2896b40d1e5515c6e' Sep 12 23:53:02.264800 kernel: Key type .fscrypt registered Sep 12 23:53:02.264818 kernel: Key type fscrypt-provisioning registered Sep 12 23:53:02.264843 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 12 23:53:02.264862 kernel: ima: Allocated hash algorithm: sha1 Sep 12 23:53:02.264881 kernel: ima: No architecture policies found Sep 12 23:53:02.264900 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 12 23:53:02.264918 kernel: clk: Disabling unused clocks Sep 12 23:53:02.264937 kernel: Freeing unused kernel memory: 39488K Sep 12 23:53:02.264955 kernel: Run /init as init process Sep 12 23:53:02.264973 kernel: with arguments: Sep 12 23:53:02.264992 kernel: /init Sep 12 23:53:02.265011 kernel: with environment: Sep 12 23:53:02.265036 kernel: HOME=/ Sep 12 23:53:02.265056 kernel: TERM=linux Sep 12 23:53:02.265075 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Sep 12 23:53:02.265100 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 12 23:53:02.265125 systemd[1]: Detected virtualization amazon. Sep 12 23:53:02.265147 systemd[1]: Detected architecture arm64. Sep 12 23:53:02.265167 systemd[1]: Running in initrd. Sep 12 23:53:02.265192 systemd[1]: No hostname configured, using default hostname. Sep 12 23:53:02.265213 systemd[1]: Hostname set to . Sep 12 23:53:02.265234 systemd[1]: Initializing machine ID from VM UUID. Sep 12 23:53:02.265255 systemd[1]: Queued start job for default target initrd.target. Sep 12 23:53:02.265275 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 23:53:02.265296 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 23:53:02.265319 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 12 23:53:02.265341 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 12 23:53:02.265367 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 12 23:53:02.265390 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 12 23:53:02.265507 systemd[1]: Expecting device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - /dev/disk/by-partuuid/7130c94a-213a-4e5a-8e26-6cce9662f132... Sep 12 23:53:02.265532 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 12 23:53:02.265554 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 23:53:02.265575 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 12 23:53:02.265595 systemd[1]: Reached target paths.target - Path Units. Sep 12 23:53:02.265624 systemd[1]: Reached target slices.target - Slice Units. Sep 12 23:53:02.265645 systemd[1]: Reached target swap.target - Swaps. Sep 12 23:53:02.265666 systemd[1]: Reached target timers.target - Timer Units. Sep 12 23:53:02.265687 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 12 23:53:02.265709 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 12 23:53:02.265729 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 12 23:53:02.265750 systemd[1]: Listening on systemd-journald.socket - Journal Socket. Sep 12 23:53:02.265772 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 12 23:53:02.265793 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 12 23:53:02.265820 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 23:53:02.265841 systemd[1]: Reached target sockets.target - Socket Units. Sep 12 23:53:02.265861 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 12 23:53:02.265882 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 12 23:53:02.265902 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 12 23:53:02.265922 systemd[1]: Starting systemd-fsck-usr.service... Sep 12 23:53:02.265943 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 12 23:53:02.265963 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 12 23:53:02.265991 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 23:53:02.266012 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 12 23:53:02.266032 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 23:53:02.266052 systemd[1]: Finished systemd-fsck-usr.service. Sep 12 23:53:02.266074 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 12 23:53:02.266144 systemd-journald[250]: Collecting audit messages is disabled. Sep 12 23:53:02.266188 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Sep 12 23:53:02.266208 kernel: Bridge firewalling registered Sep 12 23:53:02.266228 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 23:53:02.266255 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 12 23:53:02.266276 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 12 23:53:02.266296 systemd-journald[250]: Journal started Sep 12 23:53:02.266333 systemd-journald[250]: Runtime Journal (/run/log/journal/ec279867c0f6348127bec3ec0583fbc1) is 8.0M, max 75.3M, 67.3M free. Sep 12 23:53:02.206201 systemd-modules-load[251]: Inserted module 'overlay' Sep 12 23:53:02.242260 systemd-modules-load[251]: Inserted module 'br_netfilter' Sep 12 23:53:02.288080 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 12 23:53:02.290460 systemd[1]: Started systemd-journald.service - Journal Service. Sep 12 23:53:02.291028 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 12 23:53:02.317737 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 12 23:53:02.324658 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 12 23:53:02.326016 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 12 23:53:02.349489 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 23:53:02.357723 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 23:53:02.364679 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 12 23:53:02.383000 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 23:53:02.394687 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 12 23:53:02.424442 dracut-cmdline[284]: dracut-dracut-053 Sep 12 23:53:02.428545 dracut-cmdline[284]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=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=e1b46f3c9e154636c32f6cde6e746a00a6b37ca7432cb4e16d172c05f584a8c9 Sep 12 23:53:02.484502 systemd-resolved[287]: Positive Trust Anchors: Sep 12 23:53:02.486556 systemd-resolved[287]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 12 23:53:02.486621 systemd-resolved[287]: 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 Sep 12 23:53:02.577440 kernel: SCSI subsystem initialized Sep 12 23:53:02.584428 kernel: Loading iSCSI transport class v2.0-870. Sep 12 23:53:02.597818 kernel: iscsi: registered transport (tcp) Sep 12 23:53:02.619822 kernel: iscsi: registered transport (qla4xxx) Sep 12 23:53:02.619895 kernel: QLogic iSCSI HBA Driver Sep 12 23:53:02.717428 kernel: random: crng init done Sep 12 23:53:02.717692 systemd-resolved[287]: Defaulting to hostname 'linux'. Sep 12 23:53:02.721745 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 12 23:53:02.729054 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 12 23:53:02.749376 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 12 23:53:02.759785 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 12 23:53:02.799131 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 12 23:53:02.799262 kernel: device-mapper: uevent: version 1.0.3 Sep 12 23:53:02.799292 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@redhat.com Sep 12 23:53:02.866463 kernel: raid6: neonx8 gen() 6766 MB/s Sep 12 23:53:02.883435 kernel: raid6: neonx4 gen() 6575 MB/s Sep 12 23:53:02.900435 kernel: raid6: neonx2 gen() 5471 MB/s Sep 12 23:53:02.917434 kernel: raid6: neonx1 gen() 3988 MB/s Sep 12 23:53:02.934434 kernel: raid6: int64x8 gen() 3826 MB/s Sep 12 23:53:02.951435 kernel: raid6: int64x4 gen() 3708 MB/s Sep 12 23:53:02.968436 kernel: raid6: int64x2 gen() 3609 MB/s Sep 12 23:53:02.986392 kernel: raid6: int64x1 gen() 2767 MB/s Sep 12 23:53:02.986442 kernel: raid6: using algorithm neonx8 gen() 6766 MB/s Sep 12 23:53:03.004440 kernel: raid6: .... xor() 4849 MB/s, rmw enabled Sep 12 23:53:03.004476 kernel: raid6: using neon recovery algorithm Sep 12 23:53:03.013328 kernel: xor: measuring software checksum speed Sep 12 23:53:03.013380 kernel: 8regs : 10972 MB/sec Sep 12 23:53:03.015777 kernel: 32regs : 11426 MB/sec Sep 12 23:53:03.015810 kernel: arm64_neon : 9564 MB/sec Sep 12 23:53:03.015835 kernel: xor: using function: 32regs (11426 MB/sec) Sep 12 23:53:03.101450 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 12 23:53:03.120196 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 12 23:53:03.130716 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 23:53:03.173341 systemd-udevd[469]: Using default interface naming scheme 'v255'. Sep 12 23:53:03.181556 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 23:53:03.205308 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 12 23:53:03.231267 dracut-pre-trigger[482]: rd.md=0: removing MD RAID activation Sep 12 23:53:03.287032 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 12 23:53:03.297726 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 12 23:53:03.421165 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 23:53:03.435836 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 12 23:53:03.482861 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 12 23:53:03.489333 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 12 23:53:03.500927 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 23:53:03.504272 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 12 23:53:03.520681 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 12 23:53:03.561098 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 12 23:53:03.632394 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 12 23:53:03.632528 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 12 23:53:03.638176 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 12 23:53:03.649552 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 12 23:53:03.649859 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 12 23:53:03.638427 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 23:53:03.649668 systemd[1]: Stopping dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 12 23:53:03.663074 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 12 23:53:03.672880 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 23:53:03.674425 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:a1:0c:17:33:27 Sep 12 23:53:03.676889 (udev-worker)[523]: Network interface NamePolicy= disabled on kernel command line. Sep 12 23:53:03.693245 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 23:53:03.719464 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 12 23:53:03.719922 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 23:53:03.728273 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 12 23:53:03.738438 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 12 23:53:03.747973 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 23:53:03.755792 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 12 23:53:03.755828 kernel: GPT:9289727 != 16777215 Sep 12 23:53:03.755853 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 12 23:53:03.755877 kernel: GPT:9289727 != 16777215 Sep 12 23:53:03.755901 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 12 23:53:03.760198 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 12 23:53:03.769812 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 12 23:53:03.801841 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 23:53:03.877442 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (536) Sep 12 23:53:03.890446 kernel: BTRFS: device fsid 29bc4da8-c689-46a2-a16a-b7bbc722db77 devid 1 transid 37 /dev/nvme0n1p3 scanned by (udev-worker) (529) Sep 12 23:53:03.964155 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 12 23:53:04.001109 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 12 23:53:04.019479 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 12 23:53:04.033766 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 12 23:53:04.039284 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device - Amazon Elastic Block Store USR-A. Sep 12 23:53:04.056702 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 12 23:53:04.071472 disk-uuid[665]: Primary Header is updated. Sep 12 23:53:04.071472 disk-uuid[665]: Secondary Entries is updated. Sep 12 23:53:04.071472 disk-uuid[665]: Secondary Header is updated. Sep 12 23:53:04.084643 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 12 23:53:04.099445 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 12 23:53:05.116183 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 12 23:53:05.118775 disk-uuid[666]: The operation has completed successfully. Sep 12 23:53:05.290294 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 12 23:53:05.290538 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 12 23:53:05.349729 systemd[1]: Starting verity-setup.service - Verity Setup for /dev/mapper/usr... Sep 12 23:53:05.373027 sh[924]: Success Sep 12 23:53:05.394483 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Sep 12 23:53:05.514496 systemd[1]: Found device dev-mapper-usr.device - /dev/mapper/usr. Sep 12 23:53:05.520913 systemd[1]: Finished verity-setup.service - Verity Setup for /dev/mapper/usr. Sep 12 23:53:05.529659 systemd[1]: Mounting sysusr-usr.mount - /sysusr/usr... Sep 12 23:53:05.573949 kernel: BTRFS info (device dm-0): first mount of filesystem 29bc4da8-c689-46a2-a16a-b7bbc722db77 Sep 12 23:53:05.574009 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 12 23:53:05.574036 kernel: BTRFS warning (device dm-0): 'nologreplay' is deprecated, use 'rescue=nologreplay' instead Sep 12 23:53:05.577125 kernel: BTRFS info (device dm-0): disabling log replay at mount time Sep 12 23:53:05.577168 kernel: BTRFS info (device dm-0): using free space tree Sep 12 23:53:05.659448 kernel: BTRFS info (device dm-0): enabling ssd optimizations Sep 12 23:53:05.682723 systemd[1]: Mounted sysusr-usr.mount - /sysusr/usr. Sep 12 23:53:05.687134 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments was skipped because no trigger condition checks were met. Sep 12 23:53:05.700666 systemd[1]: Starting ignition-setup.service - Ignition (setup)... Sep 12 23:53:05.709751 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 12 23:53:05.738045 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem abbcf5a1-cc71-42ce-94f9-860f3aeda368 Sep 12 23:53:05.738115 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 12 23:53:05.738155 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 12 23:53:05.754994 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 12 23:53:05.772580 systemd[1]: mnt-oem.mount: Deactivated successfully. Sep 12 23:53:05.775083 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem abbcf5a1-cc71-42ce-94f9-860f3aeda368 Sep 12 23:53:05.785723 systemd[1]: Finished ignition-setup.service - Ignition (setup). Sep 12 23:53:05.797764 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 12 23:53:05.897217 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 12 23:53:05.913588 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 12 23:53:05.968369 systemd-networkd[1117]: lo: Link UP Sep 12 23:53:05.968384 systemd-networkd[1117]: lo: Gained carrier Sep 12 23:53:05.973800 systemd-networkd[1117]: Enumeration completed Sep 12 23:53:05.974605 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 12 23:53:05.974808 systemd-networkd[1117]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 23:53:05.974815 systemd-networkd[1117]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 23:53:05.979386 systemd[1]: Reached target network.target - Network. Sep 12 23:53:05.994811 systemd-networkd[1117]: eth0: Link UP Sep 12 23:53:05.994831 systemd-networkd[1117]: eth0: Gained carrier Sep 12 23:53:05.994849 systemd-networkd[1117]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 23:53:06.017483 systemd-networkd[1117]: eth0: DHCPv4 address 172.31.24.207/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 12 23:53:06.258078 ignition[1033]: Ignition 2.19.0 Sep 12 23:53:06.258643 ignition[1033]: Stage: fetch-offline Sep 12 23:53:06.260228 ignition[1033]: no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:06.260254 ignition[1033]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:06.262165 ignition[1033]: Ignition finished successfully Sep 12 23:53:06.270281 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 12 23:53:06.279910 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 12 23:53:06.304932 ignition[1127]: Ignition 2.19.0 Sep 12 23:53:06.304959 ignition[1127]: Stage: fetch Sep 12 23:53:06.305631 ignition[1127]: no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:06.305656 ignition[1127]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:06.305819 ignition[1127]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:06.319380 ignition[1127]: PUT result: OK Sep 12 23:53:06.323014 ignition[1127]: parsed url from cmdline: "" Sep 12 23:53:06.323039 ignition[1127]: no config URL provided Sep 12 23:53:06.323059 ignition[1127]: reading system config file "/usr/lib/ignition/user.ign" Sep 12 23:53:06.323112 ignition[1127]: no config at "/usr/lib/ignition/user.ign" Sep 12 23:53:06.323146 ignition[1127]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:06.327189 ignition[1127]: PUT result: OK Sep 12 23:53:06.331450 ignition[1127]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 12 23:53:06.335368 ignition[1127]: GET result: OK Sep 12 23:53:06.335467 ignition[1127]: parsing config with SHA512: c4f410a1abf8eb96ebaf57e50736796d35fa453f4585c495f424c732b1f560a7fa751a055a5da7077fdb78d7f8e1ac1ad6b1a141ad93ffe32f16d7c50fa52691 Sep 12 23:53:06.351611 unknown[1127]: fetched base config from "system" Sep 12 23:53:06.351651 unknown[1127]: fetched base config from "system" Sep 12 23:53:06.351668 unknown[1127]: fetched user config from "aws" Sep 12 23:53:06.360982 ignition[1127]: fetch: fetch complete Sep 12 23:53:06.361007 ignition[1127]: fetch: fetch passed Sep 12 23:53:06.361101 ignition[1127]: Ignition finished successfully Sep 12 23:53:06.366160 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 12 23:53:06.375720 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 12 23:53:06.411245 ignition[1133]: Ignition 2.19.0 Sep 12 23:53:06.411274 ignition[1133]: Stage: kargs Sep 12 23:53:06.413033 ignition[1133]: no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:06.413079 ignition[1133]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:06.413248 ignition[1133]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:06.421696 ignition[1133]: PUT result: OK Sep 12 23:53:06.425785 ignition[1133]: kargs: kargs passed Sep 12 23:53:06.425881 ignition[1133]: Ignition finished successfully Sep 12 23:53:06.432472 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 12 23:53:06.444705 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 12 23:53:06.471639 ignition[1140]: Ignition 2.19.0 Sep 12 23:53:06.471660 ignition[1140]: Stage: disks Sep 12 23:53:06.472250 ignition[1140]: no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:06.472275 ignition[1140]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:06.472458 ignition[1140]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:06.475919 ignition[1140]: PUT result: OK Sep 12 23:53:06.488698 ignition[1140]: disks: disks passed Sep 12 23:53:06.488803 ignition[1140]: Ignition finished successfully Sep 12 23:53:06.492996 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 12 23:53:06.498956 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 12 23:53:06.503855 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 12 23:53:06.507014 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 12 23:53:06.514025 systemd[1]: Reached target sysinit.target - System Initialization. Sep 12 23:53:06.516938 systemd[1]: Reached target basic.target - Basic System. Sep 12 23:53:06.532671 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 12 23:53:06.581248 systemd-fsck[1148]: ROOT: clean, 14/553520 files, 52654/553472 blocks Sep 12 23:53:06.585206 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 12 23:53:06.597723 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 12 23:53:06.696448 kernel: EXT4-fs (nvme0n1p9): mounted filesystem d35fd879-6758-447b-9fdd-bb21dd7c5b2b r/w with ordered data mode. Quota mode: none. Sep 12 23:53:06.698000 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 12 23:53:06.701397 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 12 23:53:06.719578 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 12 23:53:06.732713 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 12 23:53:06.733929 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent was skipped because no trigger condition checks were met. Sep 12 23:53:06.758436 kernel: BTRFS: device label OEM devid 1 transid 10 /dev/nvme0n1p6 scanned by mount (1167) Sep 12 23:53:06.758475 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem abbcf5a1-cc71-42ce-94f9-860f3aeda368 Sep 12 23:53:06.758503 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 12 23:53:06.734014 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Sep 12 23:53:06.771252 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 12 23:53:06.734063 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 12 23:53:06.749762 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 12 23:53:06.764674 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 12 23:53:06.789441 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 12 23:53:06.792352 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 12 23:53:07.203364 initrd-setup-root[1191]: cut: /sysroot/etc/passwd: No such file or directory Sep 12 23:53:07.213448 initrd-setup-root[1198]: cut: /sysroot/etc/group: No such file or directory Sep 12 23:53:07.222946 initrd-setup-root[1205]: cut: /sysroot/etc/shadow: No such file or directory Sep 12 23:53:07.231925 initrd-setup-root[1212]: cut: /sysroot/etc/gshadow: No such file or directory Sep 12 23:53:07.557999 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 12 23:53:07.571721 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 12 23:53:07.576265 systemd[1]: Starting sysroot-boot.service - /sysroot/boot... Sep 12 23:53:07.589540 systemd-networkd[1117]: eth0: Gained IPv6LL Sep 12 23:53:07.599301 systemd[1]: sysroot-oem.mount: Deactivated successfully. Sep 12 23:53:07.603343 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem abbcf5a1-cc71-42ce-94f9-860f3aeda368 Sep 12 23:53:07.643554 systemd[1]: Finished sysroot-boot.service - /sysroot/boot. Sep 12 23:53:07.656421 ignition[1280]: INFO : Ignition 2.19.0 Sep 12 23:53:07.656421 ignition[1280]: INFO : Stage: mount Sep 12 23:53:07.656421 ignition[1280]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:07.656421 ignition[1280]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:07.656421 ignition[1280]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:07.667817 ignition[1280]: INFO : PUT result: OK Sep 12 23:53:07.672039 ignition[1280]: INFO : mount: mount passed Sep 12 23:53:07.674219 ignition[1280]: INFO : Ignition finished successfully Sep 12 23:53:07.675103 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 12 23:53:07.683672 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 12 23:53:07.709753 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 12 23:53:07.734441 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1291) Sep 12 23:53:07.738925 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem abbcf5a1-cc71-42ce-94f9-860f3aeda368 Sep 12 23:53:07.738973 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 12 23:53:07.740232 kernel: BTRFS info (device nvme0n1p6): using free space tree Sep 12 23:53:07.745439 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 12 23:53:07.749174 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 12 23:53:07.788322 ignition[1308]: INFO : Ignition 2.19.0 Sep 12 23:53:07.788322 ignition[1308]: INFO : Stage: files Sep 12 23:53:07.792397 ignition[1308]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:07.792397 ignition[1308]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:07.792397 ignition[1308]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:07.800095 ignition[1308]: INFO : PUT result: OK Sep 12 23:53:07.804749 ignition[1308]: DEBUG : files: compiled without relabeling support, skipping Sep 12 23:53:07.817159 ignition[1308]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 12 23:53:07.817159 ignition[1308]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 12 23:53:07.844143 ignition[1308]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 12 23:53:07.847384 ignition[1308]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 12 23:53:07.850539 unknown[1308]: wrote ssh authorized keys file for user: core Sep 12 23:53:07.852919 ignition[1308]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 12 23:53:07.866314 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 12 23:53:07.871031 ignition[1308]: 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" Sep 12 23:53:07.871031 ignition[1308]: 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" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 12 23:53:07.871031 ignition[1308]: INFO : files: files passed Sep 12 23:53:07.871031 ignition[1308]: INFO : Ignition finished successfully Sep 12 23:53:07.908196 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 12 23:53:07.921349 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 12 23:53:07.928953 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 12 23:53:07.936257 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 12 23:53:07.938350 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 12 23:53:07.967973 initrd-setup-root-after-ignition[1337]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 12 23:53:07.967973 initrd-setup-root-after-ignition[1337]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 12 23:53:07.977084 initrd-setup-root-after-ignition[1341]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 12 23:53:07.983514 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 12 23:53:07.986871 systemd[1]: Reached target ignition-complete.target - Ignition Complete. Sep 12 23:53:08.001727 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 12 23:53:08.064254 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 12 23:53:08.064509 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 12 23:53:08.069524 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 12 23:53:08.071840 systemd[1]: Reached target initrd.target - Initrd Default Target. Sep 12 23:53:08.074165 systemd[1]: dracut-mount.service - dracut mount hook was skipped because no trigger condition checks were met. Sep 12 23:53:08.089733 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 12 23:53:08.126620 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 12 23:53:08.141687 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 12 23:53:08.168676 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 12 23:53:08.174349 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 23:53:08.177779 systemd[1]: Stopped target timers.target - Timer Units. Sep 12 23:53:08.181938 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 12 23:53:08.182251 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 12 23:53:08.190815 systemd[1]: Stopped target initrd.target - Initrd Default Target. Sep 12 23:53:08.193984 systemd[1]: Stopped target basic.target - Basic System. Sep 12 23:53:08.199646 systemd[1]: Stopped target ignition-complete.target - Ignition Complete. Sep 12 23:53:08.202379 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 12 23:53:08.205191 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 12 23:53:08.210464 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 12 23:53:08.215331 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 12 23:53:08.225012 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 12 23:53:08.228203 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 12 23:53:08.234087 systemd[1]: Stopped target swap.target - Swaps. Sep 12 23:53:08.236186 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 12 23:53:08.236508 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 12 23:53:08.245266 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 12 23:53:08.247867 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 23:53:08.255188 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 12 23:53:08.255954 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 23:53:08.263034 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 12 23:53:08.263456 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 12 23:53:08.270478 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 12 23:53:08.270900 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 12 23:53:08.278947 systemd[1]: ignition-files.service: Deactivated successfully. Sep 12 23:53:08.279366 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 12 23:53:08.295476 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 12 23:53:08.302732 systemd[1]: Stopping sysroot-boot.service - /sysroot/boot... Sep 12 23:53:08.305696 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 12 23:53:08.306015 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 23:53:08.308982 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 12 23:53:08.309222 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 12 23:53:08.335859 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 12 23:53:08.338849 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 12 23:53:08.351677 ignition[1361]: INFO : Ignition 2.19.0 Sep 12 23:53:08.351677 ignition[1361]: INFO : Stage: umount Sep 12 23:53:08.356797 ignition[1361]: INFO : no configs at "/usr/lib/ignition/base.d" Sep 12 23:53:08.356797 ignition[1361]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 12 23:53:08.365587 ignition[1361]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 12 23:53:08.370647 ignition[1361]: INFO : PUT result: OK Sep 12 23:53:08.373914 systemd[1]: sysroot-boot.mount: Deactivated successfully. Sep 12 23:53:08.378287 ignition[1361]: INFO : umount: umount passed Sep 12 23:53:08.380890 ignition[1361]: INFO : Ignition finished successfully Sep 12 23:53:08.383853 systemd[1]: sysroot-boot.service: Deactivated successfully. Sep 12 23:53:08.386045 systemd[1]: Stopped sysroot-boot.service - /sysroot/boot. Sep 12 23:53:08.390478 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 12 23:53:08.390685 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 12 23:53:08.398433 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 12 23:53:08.398554 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 12 23:53:08.400888 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 12 23:53:08.400974 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 12 23:53:08.403177 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 12 23:53:08.403252 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 12 23:53:08.405653 systemd[1]: Stopped target network.target - Network. Sep 12 23:53:08.407593 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 12 23:53:08.407672 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 12 23:53:08.410290 systemd[1]: Stopped target paths.target - Path Units. Sep 12 23:53:08.412266 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 12 23:53:08.414548 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 23:53:08.417242 systemd[1]: Stopped target slices.target - Slice Units. Sep 12 23:53:08.421035 systemd[1]: Stopped target sockets.target - Socket Units. Sep 12 23:53:08.425545 systemd[1]: iscsid.socket: Deactivated successfully. Sep 12 23:53:08.425628 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 12 23:53:08.436890 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 12 23:53:08.436971 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 12 23:53:08.441661 systemd[1]: ignition-setup.service: Deactivated successfully. Sep 12 23:53:08.441749 systemd[1]: Stopped ignition-setup.service - Ignition (setup). Sep 12 23:53:08.445481 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 12 23:53:08.445562 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 12 23:53:08.448325 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 12 23:53:08.448426 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 12 23:53:08.452760 systemd[1]: Stopping systemd-networkd.service - Network Configuration... Sep 12 23:53:08.459269 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 12 23:53:08.467787 systemd-networkd[1117]: eth0: DHCPv6 lease lost Sep 12 23:53:08.471124 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 12 23:53:08.471342 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 12 23:53:08.478901 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 12 23:53:08.480200 systemd[1]: Stopped systemd-networkd.service - Network Configuration. Sep 12 23:53:08.484208 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 12 23:53:08.484335 systemd[1]: Closed systemd-networkd.socket - Network Service Netlink Socket. Sep 12 23:53:08.505343 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 12 23:53:08.531148 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 12 23:53:08.531272 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 12 23:53:08.534230 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 12 23:53:08.534314 systemd[1]: Stopped systemd-sysctl.service - Apply Kernel Variables. Sep 12 23:53:08.536959 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 12 23:53:08.537037 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 12 23:53:08.539708 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 12 23:53:08.539787 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 23:53:08.542854 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 23:53:08.584142 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 12 23:53:08.584854 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 23:53:08.592397 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 12 23:53:08.592514 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 12 23:53:08.596106 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Sep 12 23:53:08.596179 systemd[1]: Closed systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 23:53:08.596419 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 12 23:53:08.596506 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 12 23:53:08.597169 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 12 23:53:08.597246 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 12 23:53:08.599987 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 12 23:53:08.600067 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 12 23:53:08.627057 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 12 23:53:08.632158 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 12 23:53:08.632286 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 23:53:08.635264 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 12 23:53:08.635358 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 12 23:53:08.647831 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 12 23:53:08.647946 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 23:53:08.651848 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 12 23:53:08.651953 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 23:53:08.659955 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 12 23:53:08.662819 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 12 23:53:08.671385 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 12 23:53:08.671914 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 12 23:53:08.684901 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 12 23:53:08.697785 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 12 23:53:08.714653 systemd[1]: Switching root. Sep 12 23:53:08.771274 systemd-journald[250]: Journal stopped Sep 12 23:53:11.113526 systemd-journald[250]: Received SIGTERM from PID 1 (systemd). Sep 12 23:53:11.113652 kernel: SELinux: policy capability network_peer_controls=1 Sep 12 23:53:11.113703 kernel: SELinux: policy capability open_perms=1 Sep 12 23:53:11.113742 kernel: SELinux: policy capability extended_socket_class=1 Sep 12 23:53:11.113771 kernel: SELinux: policy capability always_check_network=0 Sep 12 23:53:11.113801 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 12 23:53:11.113832 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 12 23:53:11.113862 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 12 23:53:11.113901 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 12 23:53:11.113930 kernel: audit: type=1403 audit(1757721189.222:2): auid=4294967295 ses=4294967295 lsm=selinux res=1 Sep 12 23:53:11.113971 systemd[1]: Successfully loaded SELinux policy in 91.552ms. Sep 12 23:53:11.114020 systemd[1]: Relabeled /dev, /dev/shm, /run, /sys/fs/cgroup in 23.134ms. Sep 12 23:53:11.114051 systemd[1]: systemd 255 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP -SYSVINIT default-hierarchy=unified) Sep 12 23:53:11.114081 systemd[1]: Detected virtualization amazon. Sep 12 23:53:11.114112 systemd[1]: Detected architecture arm64. Sep 12 23:53:11.114140 systemd[1]: Detected first boot. Sep 12 23:53:11.114172 systemd[1]: Initializing machine ID from VM UUID. Sep 12 23:53:11.114204 zram_generator::config[1403]: No configuration found. Sep 12 23:53:11.114248 systemd[1]: Populated /etc with preset unit settings. Sep 12 23:53:11.114285 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 12 23:53:11.114320 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 12 23:53:11.114353 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 12 23:53:11.114386 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 12 23:53:11.114442 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 12 23:53:11.114480 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 12 23:53:11.114514 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 12 23:53:11.114547 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 12 23:53:11.114577 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 12 23:53:11.114609 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 12 23:53:11.114642 systemd[1]: Created slice user.slice - User and Session Slice. Sep 12 23:53:11.114672 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 12 23:53:11.114702 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 12 23:53:11.114732 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 12 23:53:11.114767 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 12 23:53:11.114799 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 12 23:53:11.114830 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 12 23:53:11.114860 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 12 23:53:11.114901 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 12 23:53:11.114932 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 12 23:53:11.114964 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 12 23:53:11.114993 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 12 23:53:11.115028 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 12 23:53:11.115060 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 12 23:53:11.115092 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 12 23:53:11.115124 systemd[1]: Reached target slices.target - Slice Units. Sep 12 23:53:11.115155 systemd[1]: Reached target swap.target - Swaps. Sep 12 23:53:11.115184 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 12 23:53:11.115214 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 12 23:53:11.115244 systemd[1]: Listening on systemd-networkd.socket - Network Service Netlink Socket. Sep 12 23:53:11.115273 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 12 23:53:11.115309 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 12 23:53:11.115339 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 12 23:53:11.115370 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 12 23:53:11.115428 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 12 23:53:11.115467 systemd[1]: Mounting media.mount - External Media Directory... Sep 12 23:53:11.115500 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 12 23:53:11.115533 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 12 23:53:11.115562 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 12 23:53:11.115596 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). Sep 12 23:53:11.115631 systemd[1]: Reached target machines.target - Containers. Sep 12 23:53:11.115660 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 12 23:53:11.115690 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 23:53:11.115719 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 12 23:53:11.115749 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 12 23:53:11.115778 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 23:53:11.115810 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 12 23:53:11.115841 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 23:53:11.115875 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 12 23:53:11.115911 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 23:53:11.115944 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Sep 12 23:53:11.115975 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 12 23:53:11.116005 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 12 23:53:11.116034 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Sep 12 23:53:11.116065 systemd[1]: Stopped systemd-fsck-usr.service. Sep 12 23:53:11.116095 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 12 23:53:11.116124 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 12 23:53:11.116157 kernel: fuse: init (API version 7.39) Sep 12 23:53:11.116188 systemd[1]: Starting systemd-network-generator.service - Generate network units from Kernel command line... Sep 12 23:53:11.116220 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 12 23:53:11.116250 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 12 23:53:11.116281 systemd[1]: verity-setup.service: Deactivated successfully. Sep 12 23:53:11.116310 systemd[1]: Stopped verity-setup.service. Sep 12 23:53:11.116338 kernel: loop: module loaded Sep 12 23:53:11.116366 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 12 23:53:11.116397 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 12 23:53:11.116507 systemd[1]: Mounted media.mount - External Media Directory. Sep 12 23:53:11.116538 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 12 23:53:11.116568 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 12 23:53:11.116598 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 12 23:53:11.116648 kernel: ACPI: bus type drm_connector registered Sep 12 23:53:11.116683 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 12 23:53:11.116713 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 12 23:53:11.116786 systemd-journald[1492]: Collecting audit messages is disabled. Sep 12 23:53:11.116836 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 12 23:53:11.116901 systemd-journald[1492]: Journal started Sep 12 23:53:11.116959 systemd-journald[1492]: Runtime Journal (/run/log/journal/ec279867c0f6348127bec3ec0583fbc1) is 8.0M, max 75.3M, 67.3M free. Sep 12 23:53:10.498887 systemd[1]: Queued start job for default target multi-user.target. Sep 12 23:53:10.550372 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 12 23:53:10.551150 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 12 23:53:11.132788 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 12 23:53:11.132875 systemd[1]: Started systemd-journald.service - Journal Service. Sep 12 23:53:11.133376 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 23:53:11.133872 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 23:53:11.138108 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 12 23:53:11.138377 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 12 23:53:11.141631 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 23:53:11.141978 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 23:53:11.145688 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 12 23:53:11.146006 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 12 23:53:11.149130 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 23:53:11.149421 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 23:53:11.152611 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 12 23:53:11.156020 systemd[1]: Finished systemd-network-generator.service - Generate network units from Kernel command line. Sep 12 23:53:11.159699 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 12 23:53:11.189152 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 12 23:53:11.198653 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 12 23:53:11.211583 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 12 23:53:11.215628 systemd[1]: remount-root.service - Remount Root File System was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Sep 12 23:53:11.215696 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 12 23:53:11.220193 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management (Varlink). Sep 12 23:53:11.230741 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 12 23:53:11.239889 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 12 23:53:11.242760 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 23:53:11.250763 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 12 23:53:11.255901 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 12 23:53:11.258759 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 12 23:53:11.261760 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 12 23:53:11.264434 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 12 23:53:11.269259 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 12 23:53:11.290002 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 12 23:53:11.295788 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 12 23:53:11.302919 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 12 23:53:11.305838 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 12 23:53:11.310181 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 12 23:53:11.341487 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 12 23:53:11.344834 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 12 23:53:11.361674 systemd[1]: Starting systemd-machine-id-commit.service - Commit a transient machine-id on disk... Sep 12 23:53:11.396251 systemd-journald[1492]: Time spent on flushing to /var/log/journal/ec279867c0f6348127bec3ec0583fbc1 is 65.690ms for 892 entries. Sep 12 23:53:11.396251 systemd-journald[1492]: System Journal (/var/log/journal/ec279867c0f6348127bec3ec0583fbc1) is 8.0M, max 195.6M, 187.6M free. Sep 12 23:53:11.476589 kernel: loop0: detected capacity change from 0 to 114328 Sep 12 23:53:11.476688 systemd-journald[1492]: Received client request to flush runtime journal. Sep 12 23:53:11.464095 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 12 23:53:11.483296 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 12 23:53:11.499751 systemd-tmpfiles[1533]: ACLs are not supported, ignoring. Sep 12 23:53:11.500446 systemd-tmpfiles[1533]: ACLs are not supported, ignoring. Sep 12 23:53:11.503879 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 12 23:53:11.511509 systemd[1]: Finished systemd-machine-id-commit.service - Commit a transient machine-id on disk. Sep 12 23:53:11.526485 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 12 23:53:11.529223 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 12 23:53:11.542578 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 12 23:53:11.569464 kernel: loop1: detected capacity change from 0 to 114432 Sep 12 23:53:11.630056 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 12 23:53:11.639936 systemd[1]: Starting systemd-udev-settle.service - Wait for udev To Complete Device Initialization... Sep 12 23:53:11.658050 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 12 23:53:11.669465 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 12 23:53:11.683510 kernel: loop2: detected capacity change from 0 to 52536 Sep 12 23:53:11.724144 udevadm[1553]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Sep 12 23:53:11.752154 systemd-tmpfiles[1556]: ACLs are not supported, ignoring. Sep 12 23:53:11.752197 systemd-tmpfiles[1556]: ACLs are not supported, ignoring. Sep 12 23:53:11.772587 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 12 23:53:11.803579 kernel: loop3: detected capacity change from 0 to 114328 Sep 12 23:53:11.831755 kernel: loop4: detected capacity change from 0 to 114432 Sep 12 23:53:11.850830 kernel: loop5: detected capacity change from 0 to 52536 Sep 12 23:53:11.860160 (sd-merge)[1561]: Using extensions 'containerd-flatcar', 'docker-flatcar', 'oem-ami'. Sep 12 23:53:11.861715 (sd-merge)[1561]: Merged extensions into '/usr'. Sep 12 23:53:11.873128 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 12 23:53:11.889183 systemd[1]: Starting ensure-sysext.service... Sep 12 23:53:11.902650 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 12 23:53:11.939651 systemd[1]: Reloading requested from client PID 1563 ('systemctl') (unit ensure-sysext.service)... Sep 12 23:53:11.939824 systemd[1]: Reloading... Sep 12 23:53:11.981866 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 12 23:53:11.984188 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/systemd-flatcar.conf:6: Duplicate line for path "/var/log/journal", ignoring. Sep 12 23:53:11.990358 systemd-tmpfiles[1564]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Sep 12 23:53:11.990926 systemd-tmpfiles[1564]: ACLs are not supported, ignoring. Sep 12 23:53:11.991057 systemd-tmpfiles[1564]: ACLs are not supported, ignoring. Sep 12 23:53:12.005330 systemd-tmpfiles[1564]: Detected autofs mount point /boot during canonicalization of boot. Sep 12 23:53:12.005360 systemd-tmpfiles[1564]: Skipping /boot Sep 12 23:53:12.070254 systemd-tmpfiles[1564]: Detected autofs mount point /boot during canonicalization of boot. Sep 12 23:53:12.070288 systemd-tmpfiles[1564]: Skipping /boot Sep 12 23:53:12.132464 zram_generator::config[1592]: No configuration found. Sep 12 23:53:12.419079 systemd[1]: /usr/lib/systemd/system/docker.socket:6: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Sep 12 23:53:12.533167 systemd[1]: Reloading finished in 592 ms. Sep 12 23:53:12.592769 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 12 23:53:12.638773 systemd[1]: Starting audit-rules.service - Load Security Auditing Rules... Sep 12 23:53:12.649751 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 12 23:53:12.658313 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 12 23:53:12.667813 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 12 23:53:12.673960 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 12 23:53:12.686942 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 23:53:12.703007 systemd[1]: Starting modprobe@dm_mod.service - Load Kernel Module dm_mod... Sep 12 23:53:12.709989 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 12 23:53:12.725953 systemd[1]: Starting modprobe@loop.service - Load Kernel Module loop... Sep 12 23:53:12.728534 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 23:53:12.738008 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 23:53:12.738379 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 23:53:12.745546 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 12 23:53:12.757238 systemd[1]: ignition-delete-config.service - Ignition (delete config) was skipped because no trigger condition checks were met. Sep 12 23:53:12.762357 systemd[1]: Starting modprobe@drm.service - Load Kernel Module drm... Sep 12 23:53:12.764895 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats was skipped because no trigger condition checks were met. Sep 12 23:53:12.765267 systemd[1]: Reached target time-set.target - System Time Set. Sep 12 23:53:12.768923 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Sep 12 23:53:12.771528 systemd[1]: Finished modprobe@dm_mod.service - Load Kernel Module dm_mod. Sep 12 23:53:12.791494 systemd[1]: Finished ensure-sysext.service. Sep 12 23:53:12.832823 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 12 23:53:12.836257 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 12 23:53:12.838769 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 12 23:53:12.842084 systemd[1]: modprobe@loop.service: Deactivated successfully. Sep 12 23:53:12.842377 systemd[1]: Finished modprobe@loop.service - Load Kernel Module loop. Sep 12 23:53:12.848436 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Sep 12 23:53:12.848598 systemd[1]: systemd-repart.service - Repartition Root Disk was skipped because no trigger condition checks were met. Sep 12 23:53:12.855281 ldconfig[1527]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 12 23:53:12.861709 systemd[1]: modprobe@drm.service: Deactivated successfully. Sep 12 23:53:12.862304 systemd[1]: Finished modprobe@drm.service - Load Kernel Module drm. Sep 12 23:53:12.885649 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 12 23:53:12.912006 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 12 23:53:12.915087 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). Sep 12 23:53:12.931911 augenrules[1678]: No rules Sep 12 23:53:12.937534 systemd[1]: Finished audit-rules.service - Load Security Auditing Rules. Sep 12 23:53:12.943502 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 12 23:53:12.989776 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 12 23:53:13.033849 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 12 23:53:13.050651 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 12 23:53:13.063655 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 12 23:53:13.124891 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 12 23:53:13.135648 systemd-udevd[1691]: Using default interface naming scheme 'v255'. Sep 12 23:53:13.156379 systemd-resolved[1649]: Positive Trust Anchors: Sep 12 23:53:13.156434 systemd-resolved[1649]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 12 23:53:13.156499 systemd-resolved[1649]: 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 Sep 12 23:53:13.170458 systemd-resolved[1649]: Defaulting to hostname 'linux'. Sep 12 23:53:13.173475 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 12 23:53:13.179208 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 12 23:53:13.185747 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 12 23:53:13.199745 systemd[1]: Starting systemd-networkd.service - Network Configuration... Sep 12 23:53:13.348910 systemd-networkd[1700]: lo: Link UP Sep 12 23:53:13.348932 systemd-networkd[1700]: lo: Gained carrier Sep 12 23:53:13.350296 systemd-networkd[1700]: Enumeration completed Sep 12 23:53:13.350511 systemd[1]: Started systemd-networkd.service - Network Configuration. Sep 12 23:53:13.353967 systemd[1]: Reached target network.target - Network. Sep 12 23:53:13.373078 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Configured... Sep 12 23:53:13.389462 (udev-worker)[1710]: Network interface NamePolicy= disabled on kernel command line. Sep 12 23:53:13.401090 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 12 23:53:13.454102 systemd-networkd[1700]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 23:53:13.454127 systemd-networkd[1700]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 12 23:53:13.464064 systemd-networkd[1700]: eth0: Link UP Sep 12 23:53:13.464471 systemd-networkd[1700]: eth0: Gained carrier Sep 12 23:53:13.464520 systemd-networkd[1700]: eth0: found matching network '/usr/lib/systemd/network/zz-default.network', based on potentially unpredictable interface name. Sep 12 23:53:13.478513 systemd-networkd[1700]: eth0: DHCPv4 address 172.31.24.207/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 12 23:53:13.559494 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (1720) Sep 12 23:53:13.626654 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 12 23:53:13.793995 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 12 23:53:13.805074 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 12 23:53:13.811738 systemd[1]: Finished systemd-udev-settle.service - Wait for udev To Complete Device Initialization. Sep 12 23:53:13.817558 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 12 23:53:13.830901 systemd[1]: Starting lvm2-activation-early.service - Activation of LVM2 logical volumes... Sep 12 23:53:13.844282 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 12 23:53:13.863461 lvm[1818]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 12 23:53:13.905157 systemd[1]: Finished lvm2-activation-early.service - Activation of LVM2 logical volumes. Sep 12 23:53:13.908438 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 12 23:53:13.910950 systemd[1]: Reached target sysinit.target - System Initialization. Sep 12 23:53:13.913528 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 12 23:53:13.916263 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path - Watch for a cloud-config at /var/lib/flatcar-install/user_data. Sep 12 23:53:13.919358 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 12 23:53:13.921979 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 12 23:53:13.924821 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 12 23:53:13.927594 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Sep 12 23:53:13.927662 systemd[1]: Reached target paths.target - Path Units. Sep 12 23:53:13.929751 systemd[1]: Reached target timers.target - Timer Units. Sep 12 23:53:13.933024 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 12 23:53:13.938048 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 12 23:53:13.948719 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 12 23:53:13.953221 systemd[1]: Starting lvm2-activation.service - Activation of LVM2 logical volumes... Sep 12 23:53:13.961761 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 12 23:53:13.971698 lvm[1824]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Sep 12 23:53:13.967213 systemd[1]: Reached target sockets.target - Socket Units. Sep 12 23:53:13.972826 systemd[1]: Reached target basic.target - Basic System. Sep 12 23:53:13.977579 systemd[1]: addon-config@oem.service - Configure Addon /oem was skipped because no trigger condition checks were met. Sep 12 23:53:13.977627 systemd[1]: addon-run@oem.service - Run Addon /oem was skipped because no trigger condition checks were met. Sep 12 23:53:13.982657 systemd[1]: Starting containerd.service - containerd container runtime... Sep 12 23:53:13.999786 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 12 23:53:14.018010 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 12 23:53:14.025675 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 12 23:53:14.050725 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 12 23:53:14.054609 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). Sep 12 23:53:14.059578 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 12 23:53:14.069531 jq[1828]: false Sep 12 23:53:14.069361 systemd[1]: Started ntpd.service - Network Time Service. Sep 12 23:53:14.082701 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 12 23:53:14.090676 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 12 23:53:14.103818 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 12 23:53:14.118499 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 12 23:53:14.124362 systemd[1]: tcsd.service - TCG Core Services Daemon was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Sep 12 23:53:14.125320 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Sep 12 23:53:14.141709 systemd[1]: Starting update-engine.service - Update Engine... Sep 12 23:53:14.160245 extend-filesystems[1829]: Found loop3 Sep 12 23:53:14.160245 extend-filesystems[1829]: Found loop4 Sep 12 23:53:14.160245 extend-filesystems[1829]: Found loop5 Sep 12 23:53:14.146107 dbus-daemon[1827]: [system] SELinux support is enabled Sep 12 23:53:14.150539 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 12 23:53:14.209725 extend-filesystems[1829]: Found nvme0n1 Sep 12 23:53:14.209725 extend-filesystems[1829]: Found nvme0n1p1 Sep 12 23:53:14.209725 extend-filesystems[1829]: Found nvme0n1p2 Sep 12 23:53:14.209725 extend-filesystems[1829]: Found nvme0n1p7 Sep 12 23:53:14.209725 extend-filesystems[1829]: Found nvme0n1p9 Sep 12 23:53:14.209725 extend-filesystems[1829]: Checking size of /dev/nvme0n1p9 Sep 12 23:53:14.157832 dbus-daemon[1827]: [system] Activating systemd to hand-off: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.0' (uid=244 pid=1700 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 12 23:53:14.157898 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 12 23:53:14.212910 dbus-daemon[1827]: [system] Successfully activated service 'org.freedesktop.systemd1' Sep 12 23:53:14.169765 systemd[1]: Finished lvm2-activation.service - Activation of LVM2 logical volumes. Sep 12 23:53:14.196481 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 12 23:53:14.197017 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 12 23:53:14.205945 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). Sep 12 23:53:14.205998 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 12 23:53:14.210661 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). Sep 12 23:53:14.210703 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 12 23:53:14.227748 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 12 23:53:14.282715 extend-filesystems[1829]: Resized partition /dev/nvme0n1p9 Sep 12 23:53:14.279266 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 12 23:53:14.279738 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 12 23:53:14.304544 jq[1841]: true Sep 12 23:53:14.304787 extend-filesystems[1862]: resize2fs 1.47.1 (20-May-2024) Sep 12 23:53:14.330579 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 1489915 blocks Sep 12 23:53:14.336071 (ntainerd)[1857]: containerd.service: Referenced but unset environment variable evaluates to an empty string: TORCX_IMAGEDIR, TORCX_UNPACKDIR Sep 12 23:53:14.358259 systemd[1]: motdgen.service: Deactivated successfully. Sep 12 23:53:14.359711 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 12 23:53:14.397947 jq[1865]: true Sep 12 23:53:14.434217 ntpd[1833]: ntpd 4.2.8p17@1.4004-o Fri Sep 12 22:00:00 UTC 2025 (1): Starting Sep 12 23:53:14.441453 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 1489915 Sep 12 23:53:14.441533 coreos-metadata[1826]: Sep 12 23:53:14.439 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 12 23:53:14.436801 ntpd[1833]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: ntpd 4.2.8p17@1.4004-o Fri Sep 12 22:00:00 UTC 2025 (1): Starting Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: ---------------------------------------------------- Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: ntp-4 is maintained by Network Time Foundation, Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: corporation. Support and training for ntp-4 are Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: available at https://www.nwtime.org/support Sep 12 23:53:14.456682 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: ---------------------------------------------------- Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.443 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.444 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.444 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.446 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.446 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.447 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.448 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.449 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.450 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.453 INFO Fetch failed with 404: resource not found Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.453 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.454 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.454 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.455 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.455 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.456 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.458 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.459 INFO Fetch successful Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.459 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 12 23:53:14.483672 coreos-metadata[1826]: Sep 12 23:53:14.461 INFO Fetch successful Sep 12 23:53:14.436825 ntpd[1833]: ---------------------------------------------------- Sep 12 23:53:14.482707 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 12 23:53:14.485088 extend-filesystems[1862]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 12 23:53:14.485088 extend-filesystems[1862]: old_desc_blocks = 1, new_desc_blocks = 1 Sep 12 23:53:14.485088 extend-filesystems[1862]: The filesystem on /dev/nvme0n1p9 is now 1489915 (4k) blocks long. Sep 12 23:53:14.523307 update_engine[1839]: I20250912 23:53:14.465855 1839 main.cc:92] Flatcar Update Engine starting Sep 12 23:53:14.523307 update_engine[1839]: I20250912 23:53:14.492924 1839 update_check_scheduler.cc:74] Next update check in 10m13s Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: proto: precision = 0.096 usec (-23) Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: basedate set to 2025-08-31 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: gps base set to 2025-08-31 (week 2382) Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listen and drop on 0 v6wildcard [::]:123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listen normally on 2 lo 127.0.0.1:123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listen normally on 3 eth0 172.31.24.207:123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listen normally on 4 lo [::1]:123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: bind(21) AF_INET6 fe80::4a1:cff:fe17:3327%2#123 flags 0x11 failed: Cannot assign requested address Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: unable to create socket on eth0 (5) for fe80::4a1:cff:fe17:3327%2#123 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: failed to init interface for address fe80::4a1:cff:fe17:3327%2 Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: Listening on routing socket on fd #21 for interface updates Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 12 23:53:14.523791 ntpd[1833]: 12 Sep 23:53:14 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 12 23:53:14.436845 ntpd[1833]: ntp-4 is maintained by Network Time Foundation, Sep 12 23:53:14.488053 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 12 23:53:14.524667 extend-filesystems[1829]: Resized filesystem in /dev/nvme0n1p9 Sep 12 23:53:14.524667 extend-filesystems[1829]: Found nvme0n1p3 Sep 12 23:53:14.524667 extend-filesystems[1829]: Found usr Sep 12 23:53:14.524667 extend-filesystems[1829]: Found nvme0n1p4 Sep 12 23:53:14.524667 extend-filesystems[1829]: Found nvme0n1p6 Sep 12 23:53:14.436864 ntpd[1833]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 12 23:53:14.511474 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 12 23:53:14.436882 ntpd[1833]: corporation. Support and training for ntp-4 are Sep 12 23:53:14.516007 systemd[1]: Started update-engine.service - Update Engine. Sep 12 23:53:14.436901 ntpd[1833]: available at https://www.nwtime.org/support Sep 12 23:53:14.533372 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 12 23:53:14.436923 ntpd[1833]: ---------------------------------------------------- Sep 12 23:53:14.468031 ntpd[1833]: proto: precision = 0.096 usec (-23) Sep 12 23:53:14.472764 ntpd[1833]: basedate set to 2025-08-31 Sep 12 23:53:14.472796 ntpd[1833]: gps base set to 2025-08-31 (week 2382) Sep 12 23:53:14.476362 ntpd[1833]: Listen and drop on 0 v6wildcard [::]:123 Sep 12 23:53:14.476464 ntpd[1833]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 12 23:53:14.476758 ntpd[1833]: Listen normally on 2 lo 127.0.0.1:123 Sep 12 23:53:14.476830 ntpd[1833]: Listen normally on 3 eth0 172.31.24.207:123 Sep 12 23:53:14.476900 ntpd[1833]: Listen normally on 4 lo [::1]:123 Sep 12 23:53:14.476972 ntpd[1833]: bind(21) AF_INET6 fe80::4a1:cff:fe17:3327%2#123 flags 0x11 failed: Cannot assign requested address Sep 12 23:53:14.477010 ntpd[1833]: unable to create socket on eth0 (5) for fe80::4a1:cff:fe17:3327%2#123 Sep 12 23:53:14.477042 ntpd[1833]: failed to init interface for address fe80::4a1:cff:fe17:3327%2 Sep 12 23:53:14.477094 ntpd[1833]: Listening on routing socket on fd #21 for interface updates Sep 12 23:53:14.515507 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 12 23:53:14.515558 ntpd[1833]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 12 23:53:14.633436 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (1710) Sep 12 23:53:14.642588 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 12 23:53:14.645607 systemd[1]: packet-phone-home.service - Report Success to Packet was skipped because no trigger condition checks were met. Sep 12 23:53:14.646306 systemd-logind[1838]: Watching system buttons on /dev/input/event0 (Power Button) Sep 12 23:53:14.646342 systemd-logind[1838]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 12 23:53:14.648901 systemd-logind[1838]: New seat seat0. Sep 12 23:53:14.653556 systemd[1]: Started systemd-logind.service - User Login Management. Sep 12 23:53:14.718657 bash[1909]: Updated "/home/core/.ssh/authorized_keys" Sep 12 23:53:14.723309 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 12 23:53:14.752460 systemd[1]: Starting sshkeys.service... Sep 12 23:53:14.796038 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 12 23:53:14.819026 dbus-daemon[1827]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 12 23:53:14.821566 dbus-daemon[1827]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.5' (uid=0 pid=1853 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 12 23:53:14.838638 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 12 23:53:14.842003 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 12 23:53:14.861594 systemd[1]: Starting polkit.service - Authorization Manager... Sep 12 23:53:14.947688 polkitd[1941]: Started polkitd version 121 Sep 12 23:53:14.989827 polkitd[1941]: Loading rules from directory /etc/polkit-1/rules.d Sep 12 23:53:14.989962 polkitd[1941]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 12 23:53:14.997643 polkitd[1941]: Finished loading, compiling and executing 2 rules Sep 12 23:53:15.000760 dbus-daemon[1827]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 12 23:53:15.001053 systemd[1]: Started polkit.service - Authorization Manager. Sep 12 23:53:15.006677 polkitd[1941]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 12 23:53:15.063285 systemd-hostnamed[1853]: Hostname set to (transient) Sep 12 23:53:15.063308 systemd-resolved[1649]: System hostname changed to 'ip-172-31-24-207'. Sep 12 23:53:15.087445 containerd[1857]: time="2025-09-12T23:53:15.085738027Z" level=info msg="starting containerd" revision=174e0d1785eeda18dc2beba45e1d5a188771636b version=v1.7.21 Sep 12 23:53:15.161504 coreos-metadata[1929]: Sep 12 23:53:15.159 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 12 23:53:15.162678 coreos-metadata[1929]: Sep 12 23:53:15.162 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 12 23:53:15.163436 coreos-metadata[1929]: Sep 12 23:53:15.163 INFO Fetch successful Sep 12 23:53:15.163634 coreos-metadata[1929]: Sep 12 23:53:15.163 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 12 23:53:15.164766 coreos-metadata[1929]: Sep 12 23:53:15.164 INFO Fetch successful Sep 12 23:53:15.183565 unknown[1929]: wrote ssh authorized keys file for user: core Sep 12 23:53:15.273920 update-ssh-keys[2010]: Updated "/home/core/.ssh/authorized_keys" Sep 12 23:53:15.275627 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 12 23:53:15.291495 systemd[1]: Finished sshkeys.service. Sep 12 23:53:15.293433 locksmithd[1888]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 12 23:53:15.327721 containerd[1857]: time="2025-09-12T23:53:15.327638336Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.335790656Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/6.6.106-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.335855288Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.335890640Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336187076Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336221600Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336337004Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.blockfile\"..." error="no scratch file generator: skip plugin" type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336365132Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336714056Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336747416Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336777260Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." error="devmapper not configured: skip plugin" type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339430 containerd[1857]: time="2025-09-12T23:53:15.336802280Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339988 containerd[1857]: time="2025-09-12T23:53:15.336987176Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.339988 containerd[1857]: time="2025-09-12T23:53:15.337362284Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Sep 12 23:53:15.341870 containerd[1857]: time="2025-09-12T23:53:15.341821808Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Sep 12 23:53:15.342693 containerd[1857]: time="2025-09-12T23:53:15.342662276Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Sep 12 23:53:15.343109 containerd[1857]: time="2025-09-12T23:53:15.343077764Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Sep 12 23:53:15.343976 containerd[1857]: time="2025-09-12T23:53:15.343947092Z" level=info msg="metadata content store policy set" policy=shared Sep 12 23:53:15.354120 containerd[1857]: time="2025-09-12T23:53:15.354074924Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Sep 12 23:53:15.354396 containerd[1857]: time="2025-09-12T23:53:15.354298340Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Sep 12 23:53:15.354554 containerd[1857]: time="2025-09-12T23:53:15.354526496Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1 Sep 12 23:53:15.354685 containerd[1857]: time="2025-09-12T23:53:15.354658748Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1 Sep 12 23:53:15.354841 containerd[1857]: time="2025-09-12T23:53:15.354813428Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Sep 12 23:53:15.355236 containerd[1857]: time="2025-09-12T23:53:15.355205936Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Sep 12 23:53:15.355912 containerd[1857]: time="2025-09-12T23:53:15.355870208Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Sep 12 23:53:15.356261 containerd[1857]: time="2025-09-12T23:53:15.356212880Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2 Sep 12 23:53:15.356390 containerd[1857]: time="2025-09-12T23:53:15.356363312Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1 Sep 12 23:53:15.356539 containerd[1857]: time="2025-09-12T23:53:15.356511608Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1 Sep 12 23:53:15.356711 containerd[1857]: time="2025-09-12T23:53:15.356681696Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.356837 containerd[1857]: time="2025-09-12T23:53:15.356810456Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357000 containerd[1857]: time="2025-09-12T23:53:15.356903456Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357084 containerd[1857]: time="2025-09-12T23:53:15.356938436Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357246 containerd[1857]: time="2025-09-12T23:53:15.357174896Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357325 containerd[1857]: time="2025-09-12T23:53:15.357208592Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357497 containerd[1857]: time="2025-09-12T23:53:15.357444356Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.357646 containerd[1857]: time="2025-09-12T23:53:15.357576332Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357727688Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357766556Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357814316Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357846728Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357876944Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357907616Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357937064Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357966848Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.357996236Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358029452Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358057520Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358090004Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358119308Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358154000Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1 Sep 12 23:53:15.359432 containerd[1857]: time="2025-09-12T23:53:15.358211960Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358242824Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358270460Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358517972Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358557212Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358582784Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358611812Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358637408Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358667696Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1 Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358691120Z" level=info msg="NRI interface is disabled by configuration." Sep 12 23:53:15.360208 containerd[1857]: time="2025-09-12T23:53:15.358716824Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Sep 12 23:53:15.360737 containerd[1857]: time="2025-09-12T23:53:15.359332544Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false PrivilegedWithoutHostDevicesAllDevicesAllowed:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0 Snapshotter: SandboxMode:podsandbox}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreBlockIONotEnabledErrors:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginSetupSerially:false NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.8 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false EnableCDI:false CDISpecDirs:[/etc/cdi /var/run/cdi] ImagePullProgressTimeout:5m0s DrainExecSyncIOTimeout:0s ImagePullWithSyncFs:false IgnoreDeprecationWarnings:[]} ContainerdRootDir:/var/lib/containerd ContainerdEndpoint:/run/containerd/containerd.sock RootDir:/var/lib/containerd/io.containerd.grpc.v1.cri StateDir:/run/containerd/io.containerd.grpc.v1.cri}" Sep 12 23:53:15.361071 containerd[1857]: time="2025-09-12T23:53:15.361025588Z" level=info msg="Connect containerd service" Sep 12 23:53:15.361249 containerd[1857]: time="2025-09-12T23:53:15.361202528Z" level=info msg="using legacy CRI server" Sep 12 23:53:15.361364 containerd[1857]: time="2025-09-12T23:53:15.361338572Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 12 23:53:15.361755 containerd[1857]: time="2025-09-12T23:53:15.361728260Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Sep 12 23:53:15.363454 containerd[1857]: time="2025-09-12T23:53:15.363316832Z" 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" Sep 12 23:53:15.363974 containerd[1857]: time="2025-09-12T23:53:15.363847652Z" level=info msg="Start subscribing containerd event" Sep 12 23:53:15.363974 containerd[1857]: time="2025-09-12T23:53:15.363943004Z" level=info msg="Start recovering state" Sep 12 23:53:15.364120 containerd[1857]: time="2025-09-12T23:53:15.364066232Z" level=info msg="Start event monitor" Sep 12 23:53:15.364120 containerd[1857]: time="2025-09-12T23:53:15.364090388Z" level=info msg="Start snapshots syncer" Sep 12 23:53:15.364120 containerd[1857]: time="2025-09-12T23:53:15.364111376Z" level=info msg="Start cni network conf syncer for default" Sep 12 23:53:15.364259 containerd[1857]: time="2025-09-12T23:53:15.364130660Z" level=info msg="Start streaming server" Sep 12 23:53:15.366530 containerd[1857]: time="2025-09-12T23:53:15.365366720Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 12 23:53:15.366530 containerd[1857]: time="2025-09-12T23:53:15.365500484Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 12 23:53:15.366206 systemd[1]: Started containerd.service - containerd container runtime. Sep 12 23:53:15.372445 containerd[1857]: time="2025-09-12T23:53:15.371469956Z" level=info msg="containerd successfully booted in 0.293359s" Sep 12 23:53:15.397566 systemd-networkd[1700]: eth0: Gained IPv6LL Sep 12 23:53:15.403666 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Configured. Sep 12 23:53:15.410087 systemd[1]: Reached target network-online.target - Network is Online. Sep 12 23:53:15.422807 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 12 23:53:15.434481 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 12 23:53:15.442978 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 12 23:53:15.449750 (-wrapper)[2028]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 12 23:53:15.548473 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 12 23:53:15.566866 amazon-ssm-agent[2027]: Initializing new seelog logger Sep 12 23:53:15.568555 amazon-ssm-agent[2027]: New Seelog Logger Creation Complete Sep 12 23:53:15.568555 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.568555 amazon-ssm-agent[2027]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 processing appconfig overrides Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 processing appconfig overrides Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.572433 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 processing appconfig overrides Sep 12 23:53:15.573929 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO Proxy environment variables: Sep 12 23:53:15.579290 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.579874 amazon-ssm-agent[2027]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 12 23:53:15.580245 amazon-ssm-agent[2027]: 2025/09/12 23:53:15 processing appconfig overrides Sep 12 23:53:15.678762 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO https_proxy: Sep 12 23:53:15.778364 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO http_proxy: Sep 12 23:53:15.830864 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 12 23:53:15.859890 (dockerd)[2049]: 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 Sep 12 23:53:15.879750 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO no_proxy: Sep 12 23:53:15.977683 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO Checking if agent identity type OnPrem can be assumed Sep 12 23:53:16.076633 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO Checking if agent identity type EC2 can be assumed Sep 12 23:53:16.175441 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO Agent will take identity from EC2 Sep 12 23:53:16.275545 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 12 23:53:16.376425 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 12 23:53:16.446730 dockerd[2049]: time="2025-09-12T23:53:16.446647558Z" level=info msg="Starting up" Sep 12 23:53:16.476427 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] using named pipe channel for IPC Sep 12 23:53:16.576610 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.2.0.0 Sep 12 23:53:16.642502 dockerd[2049]: time="2025-09-12T23:53:16.639256331Z" level=info msg="Loading containers: start." Sep 12 23:53:16.678912 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 12 23:53:16.779609 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] Starting Core Agent Sep 12 23:53:16.880257 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [amazon-ssm-agent] registrar detected. Attempting registration Sep 12 23:53:16.963460 kernel: Initializing XFRM netlink socket Sep 12 23:53:16.980550 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [Registrar] Starting registrar module Sep 12 23:53:17.021772 sshd_keygen[1868]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Sep 12 23:53:17.032996 (udev-worker)[1708]: Network interface NamePolicy= disabled on kernel command line. Sep 12 23:53:17.080863 amazon-ssm-agent[2027]: 2025-09-12 23:53:15 INFO [EC2Identity] no registration info found for ec2 instance, attempting registration Sep 12 23:53:17.101479 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 12 23:53:17.117152 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 12 23:53:17.142869 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 12 23:53:17.154998 systemd[1]: Started sshd@0-172.31.24.207:22-147.75.109.163:37156.service - OpenSSH per-connection server daemon (147.75.109.163:37156). Sep 12 23:53:17.174301 systemd[1]: issuegen.service: Deactivated successfully. Sep 12 23:53:17.175509 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 12 23:53:17.186909 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 12 23:53:17.234524 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 12 23:53:17.242849 systemd-networkd[1700]: docker0: Link UP Sep 12 23:53:17.249961 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 12 23:53:17.258502 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 12 23:53:17.261969 systemd[1]: Reached target getty.target - Login Prompts. Sep 12 23:53:17.292963 dockerd[2049]: time="2025-09-12T23:53:17.292848346Z" level=info msg="Loading containers: done." Sep 12 23:53:17.321030 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck1531569422-merged.mount: Deactivated successfully. Sep 12 23:53:17.336449 dockerd[2049]: time="2025-09-12T23:53:17.334780114Z" 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 Sep 12 23:53:17.336449 dockerd[2049]: time="2025-09-12T23:53:17.335190886Z" level=info msg="Docker daemon" commit=061aa95809be396a6b5542618d8a34b02a21ff77 containerd-snapshotter=false storage-driver=overlay2 version=26.1.0 Sep 12 23:53:17.336449 dockerd[2049]: time="2025-09-12T23:53:17.335449030Z" level=info msg="Daemon has completed initialization" Sep 12 23:53:17.393102 sshd[2147]: Accepted publickey for core from 147.75.109.163 port 37156 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:17.394664 sshd[2147]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:17.418850 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 12 23:53:17.432026 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 12 23:53:17.444449 systemd-logind[1838]: New session 1 of user core. Sep 12 23:53:17.457679 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 12 23:53:17.463579 dockerd[2049]: time="2025-09-12T23:53:17.457388939Z" level=info msg="API listen on /run/docker.sock" Sep 12 23:53:17.468941 etcd-wrapper[2036]: Error response from daemon: No such container: etcd-member Sep 12 23:53:17.484736 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 12 23:53:17.502635 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 12 23:53:17.515762 etcd-wrapper[2197]: Error response from daemon: No such container: etcd-member Sep 12 23:53:17.523601 (systemd)[2200]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Sep 12 23:53:17.606518 etcd-wrapper[2215]: Unable to find image 'quay.io/coreos/etcd:v3.5.16' locally Sep 12 23:53:17.775504 systemd[2200]: Queued start job for default target default.target. Sep 12 23:53:17.786026 systemd[2200]: Created slice app.slice - User Application Slice. Sep 12 23:53:17.786292 systemd[2200]: Reached target paths.target - Paths. Sep 12 23:53:17.786326 systemd[2200]: Reached target timers.target - Timers. Sep 12 23:53:17.790329 systemd[2200]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 12 23:53:17.824833 systemd[2200]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 12 23:53:17.827206 systemd[2200]: Reached target sockets.target - Sockets. Sep 12 23:53:17.827805 systemd[2200]: Reached target basic.target - Basic System. Sep 12 23:53:17.828071 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 12 23:53:17.830502 systemd[2200]: Reached target default.target - Main User Target. Sep 12 23:53:17.830580 systemd[2200]: Startup finished in 291ms. Sep 12 23:53:17.838732 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 12 23:53:18.007946 systemd[1]: Started sshd@1-172.31.24.207:22-147.75.109.163:37166.service - OpenSSH per-connection server daemon (147.75.109.163:37166). Sep 12 23:53:18.204117 sshd[2230]: Accepted publickey for core from 147.75.109.163 port 37166 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:18.206850 sshd[2230]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:18.218508 systemd-logind[1838]: New session 2 of user core. Sep 12 23:53:18.230695 systemd[1]: Started session-2.scope - Session 2 of User core. Sep 12 23:53:18.362487 sshd[2230]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:18.368846 systemd[1]: sshd@1-172.31.24.207:22-147.75.109.163:37166.service: Deactivated successfully. Sep 12 23:53:18.369782 systemd-logind[1838]: Session 2 logged out. Waiting for processes to exit. Sep 12 23:53:18.373047 systemd[1]: session-2.scope: Deactivated successfully. Sep 12 23:53:18.378196 systemd-logind[1838]: Removed session 2. Sep 12 23:53:18.407581 systemd[1]: Started sshd@2-172.31.24.207:22-147.75.109.163:37178.service - OpenSSH per-connection server daemon (147.75.109.163:37178). Sep 12 23:53:18.592181 sshd[2237]: Accepted publickey for core from 147.75.109.163 port 37178 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:18.594911 sshd[2237]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:18.605613 systemd-logind[1838]: New session 3 of user core. Sep 12 23:53:18.607592 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 12 23:53:18.738772 sshd[2237]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:18.744919 systemd[1]: sshd@2-172.31.24.207:22-147.75.109.163:37178.service: Deactivated successfully. Sep 12 23:53:18.748070 systemd[1]: session-3.scope: Deactivated successfully. Sep 12 23:53:18.749323 systemd-logind[1838]: Session 3 logged out. Waiting for processes to exit. Sep 12 23:53:18.752784 amazon-ssm-agent[2027]: 2025-09-12 23:53:18 INFO [EC2Identity] EC2 registration was successful. Sep 12 23:53:18.753717 systemd-logind[1838]: Removed session 3. Sep 12 23:53:18.792917 amazon-ssm-agent[2027]: 2025-09-12 23:53:18 INFO [CredentialRefresher] credentialRefresher has started Sep 12 23:53:18.792917 amazon-ssm-agent[2027]: 2025-09-12 23:53:18 INFO [CredentialRefresher] Starting credentials refresher loop Sep 12 23:53:18.792917 amazon-ssm-agent[2027]: 2025-09-12 23:53:18 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 12 23:53:18.812592 etcd-wrapper[2215]: v3.5.16: Pulling from coreos/etcd Sep 12 23:53:18.852353 amazon-ssm-agent[2027]: 2025-09-12 23:53:18 INFO [CredentialRefresher] Next credential rotation will be in 30.491658252466667 minutes Sep 12 23:53:19.058034 etcd-wrapper[2215]: d10f96ed9607: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 2ae710cd8bfe: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: d462aa345367: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 0f8b424aa0b9: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: d557676654e5: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: c8022d07192e: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: d858cbc252ad: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 1069fc2daed1: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: b40161cd83fc: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 5318d93a3a65: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 307c1adadb60: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: f9b3c65df792: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 5709b4a82c35: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: d5372e382b07: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 9c3b5253dddc: Pulling fs layer Sep 12 23:53:19.058034 etcd-wrapper[2215]: 7a57323f7551: Pulling fs layer Sep 12 23:53:19.058843 etcd-wrapper[2215]: 0f8b424aa0b9: Waiting Sep 12 23:53:19.059329 etcd-wrapper[2215]: d557676654e5: Waiting Sep 12 23:53:19.059329 etcd-wrapper[2215]: c8022d07192e: Waiting Sep 12 23:53:19.059329 etcd-wrapper[2215]: b40161cd83fc: Waiting Sep 12 23:53:19.059701 etcd-wrapper[2215]: d858cbc252ad: Waiting Sep 12 23:53:19.059701 etcd-wrapper[2215]: 1069fc2daed1: Waiting Sep 12 23:53:19.059701 etcd-wrapper[2215]: 5318d93a3a65: Waiting Sep 12 23:53:19.059701 etcd-wrapper[2215]: 307c1adadb60: Waiting Sep 12 23:53:19.060251 etcd-wrapper[2215]: f9b3c65df792: Waiting Sep 12 23:53:19.060251 etcd-wrapper[2215]: 9c3b5253dddc: Waiting Sep 12 23:53:19.060251 etcd-wrapper[2215]: 5709b4a82c35: Waiting Sep 12 23:53:19.060575 etcd-wrapper[2215]: d5372e382b07: Waiting Sep 12 23:53:19.302607 etcd-wrapper[2215]: d10f96ed9607: Verifying Checksum Sep 12 23:53:19.302607 etcd-wrapper[2215]: d10f96ed9607: Download complete Sep 12 23:53:19.306320 etcd-wrapper[2215]: 2ae710cd8bfe: Verifying Checksum Sep 12 23:53:19.306320 etcd-wrapper[2215]: 2ae710cd8bfe: Download complete Sep 12 23:53:19.325598 etcd-wrapper[2215]: d462aa345367: Verifying Checksum Sep 12 23:53:19.327010 etcd-wrapper[2215]: d462aa345367: Download complete Sep 12 23:53:19.350141 etcd-wrapper[2215]: d10f96ed9607: Pull complete Sep 12 23:53:19.375716 systemd[1]: var-lib-docker-overlay2-18f42f81e7e519b73e75641de62c49dd1ed14b0facaa781d1476988a12783292-merged.mount: Deactivated successfully. Sep 12 23:53:19.428018 etcd-wrapper[2215]: 2ae710cd8bfe: Pull complete Sep 12 23:53:19.438023 ntpd[1833]: Listen normally on 6 eth0 [fe80::4a1:cff:fe17:3327%2]:123 Sep 12 23:53:19.439570 ntpd[1833]: 12 Sep 23:53:19 ntpd[1833]: Listen normally on 6 eth0 [fe80::4a1:cff:fe17:3327%2]:123 Sep 12 23:53:19.561161 etcd-wrapper[2215]: d557676654e5: Verifying Checksum Sep 12 23:53:19.561161 etcd-wrapper[2215]: d557676654e5: Download complete Sep 12 23:53:19.575339 etcd-wrapper[2215]: 0f8b424aa0b9: Verifying Checksum Sep 12 23:53:19.575339 etcd-wrapper[2215]: 0f8b424aa0b9: Download complete Sep 12 23:53:19.589203 etcd-wrapper[2215]: c8022d07192e: Verifying Checksum Sep 12 23:53:19.589203 etcd-wrapper[2215]: c8022d07192e: Download complete Sep 12 23:53:19.809750 etcd-wrapper[2215]: d858cbc252ad: Verifying Checksum Sep 12 23:53:19.809750 etcd-wrapper[2215]: d858cbc252ad: Download complete Sep 12 23:53:19.825990 etcd-wrapper[2215]: 1069fc2daed1: Verifying Checksum Sep 12 23:53:19.826647 etcd-wrapper[2215]: 1069fc2daed1: Download complete Sep 12 23:53:19.831128 amazon-ssm-agent[2027]: 2025-09-12 23:53:19 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 12 23:53:19.842436 etcd-wrapper[2215]: b40161cd83fc: Verifying Checksum Sep 12 23:53:19.842436 etcd-wrapper[2215]: b40161cd83fc: Download complete Sep 12 23:53:19.934569 amazon-ssm-agent[2027]: 2025-09-12 23:53:19 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2262) started Sep 12 23:53:20.032983 amazon-ssm-agent[2027]: 2025-09-12 23:53:19 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 12 23:53:20.076329 etcd-wrapper[2215]: 5318d93a3a65: Verifying Checksum Sep 12 23:53:20.076504 etcd-wrapper[2215]: 5318d93a3a65: Download complete Sep 12 23:53:20.092303 etcd-wrapper[2215]: 307c1adadb60: Verifying Checksum Sep 12 23:53:20.092564 etcd-wrapper[2215]: 307c1adadb60: Download complete Sep 12 23:53:20.294099 etcd-wrapper[2215]: f9b3c65df792: Verifying Checksum Sep 12 23:53:20.294099 etcd-wrapper[2215]: f9b3c65df792: Download complete Sep 12 23:53:20.344243 systemd[1]: var-lib-docker-overlay2-e319cc27bc892e9ef8c8a37c5fb13bb9ad9f8d4b35d227cee76a00f5eb2f1175-merged.mount: Deactivated successfully. Sep 12 23:53:20.394776 etcd-wrapper[2215]: d5372e382b07: Verifying Checksum Sep 12 23:53:20.394776 etcd-wrapper[2215]: d5372e382b07: Download complete Sep 12 23:53:20.476916 etcd-wrapper[2215]: 5709b4a82c35: Verifying Checksum Sep 12 23:53:20.476916 etcd-wrapper[2215]: 5709b4a82c35: Download complete Sep 12 23:53:20.486390 etcd-wrapper[2215]: d462aa345367: Pull complete Sep 12 23:53:20.509964 systemd[1]: var-lib-docker-overlay2-613991a98eed99a157bac4d7a75d806440cdb39b7703f81cd55daf6f76ccf557-merged.mount: Deactivated successfully. Sep 12 23:53:20.533077 etcd-wrapper[2215]: 9c3b5253dddc: Verifying Checksum Sep 12 23:53:20.533390 etcd-wrapper[2215]: 9c3b5253dddc: Download complete Sep 12 23:53:20.534086 etcd-wrapper[2215]: 0f8b424aa0b9: Pull complete Sep 12 23:53:20.569387 systemd[1]: var-lib-docker-overlay2-6e9cd50db7b7e056c4aed7838fafaa4b40ff72396d143e4e67cf66b3a882fded-merged.mount: Deactivated successfully. Sep 12 23:53:20.588324 etcd-wrapper[2215]: d557676654e5: Pull complete Sep 12 23:53:20.631048 etcd-wrapper[2215]: 7a57323f7551: Verifying Checksum Sep 12 23:53:20.631048 etcd-wrapper[2215]: 7a57323f7551: Download complete Sep 12 23:53:20.631048 etcd-wrapper[2215]: c8022d07192e: Pull complete Sep 12 23:53:20.676093 etcd-wrapper[2215]: d858cbc252ad: Pull complete Sep 12 23:53:20.722183 etcd-wrapper[2215]: 1069fc2daed1: Pull complete Sep 12 23:53:20.775353 etcd-wrapper[2215]: b40161cd83fc: Pull complete Sep 12 23:53:20.818939 etcd-wrapper[2215]: 5318d93a3a65: Pull complete Sep 12 23:53:20.878766 etcd-wrapper[2215]: 307c1adadb60: Pull complete Sep 12 23:53:21.170862 etcd-wrapper[2215]: f9b3c65df792: Pull complete Sep 12 23:53:21.430052 etcd-wrapper[2215]: 5709b4a82c35: Pull complete Sep 12 23:53:21.797914 systemd-resolved[1649]: Clock change detected. Flushing caches. Sep 12 23:53:21.864012 systemd[1]: var-lib-docker-overlay2-efe630934a251e66bc6ec9d0e3739566a90beb1630de8bdcf9cb26833536948e-merged.mount: Deactivated successfully. Sep 12 23:53:21.974340 systemd[1]: var-lib-docker-overlay2-6c804438c37353b3304e82526bfd2c98543be7472dc490c8a0fbdc85dcb83b41-merged.mount: Deactivated successfully. Sep 12 23:53:22.003149 etcd-wrapper[2215]: d5372e382b07: Pull complete Sep 12 23:53:22.021122 systemd[1]: var-lib-docker-overlay2-3b0456544c90f7ffbb31f3b36bf2704fa7cdf3ec45c9366e628c86b4251e214d-merged.mount: Deactivated successfully. Sep 12 23:53:22.034541 etcd-wrapper[2215]: 9c3b5253dddc: Pull complete Sep 12 23:53:22.094101 etcd-wrapper[2215]: 7a57323f7551: Pull complete Sep 12 23:53:22.112711 etcd-wrapper[2215]: Digest: sha256:d967d98a12dc220a1a290794711dba7eba04b8ce465e12b02383d1bfbb33e159 Sep 12 23:53:22.119856 etcd-wrapper[2215]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.16 Sep 12 23:53:22.355120 containerd[1857]: time="2025-09-12T23:53:22.354535234Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Sep 12 23:53:22.355120 containerd[1857]: time="2025-09-12T23:53:22.354643606Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Sep 12 23:53:22.355120 containerd[1857]: time="2025-09-12T23:53:22.354733474Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 12 23:53:22.356772 containerd[1857]: time="2025-09-12T23:53:22.355063882Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.pause\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Sep 12 23:53:22.387561 systemd[1]: Started docker-8f971fcbf24b894b9006bf8af6c8cb904ee0556fbb083ba18223802ff11856af.scope - libcontainer container 8f971fcbf24b894b9006bf8af6c8cb904ee0556fbb083ba18223802ff11856af. Sep 12 23:53:22.495739 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.495240Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.495753Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec279867c0f6348127bec3ec0583fbc1"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.495825Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.495845Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.16"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.495860Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.495872Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.495928Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.495974Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-client-urls=http://0.0.0.0:2379","--advertise-client-urls=http://172.31.24.207:2379"]} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.496079Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.496101Z","caller":"embed/etcd.go:128","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Sep 12 23:53:22.497756 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.496818Z","caller":"embed/etcd.go:136","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 12 23:53:22.498399 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.497035Z","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":"ec279867c0f6348127bec3ec0583fbc1","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://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.207:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec279867c0f6348127bec3ec0583fbc1=http://localhost:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","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":"","discovery-proxy":"","downgrade-check-interval":"5s"} Sep 12 23:53:22.503045 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.502580Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.416084ms"} Sep 12 23:53:22.512785 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.512350Z","caller":"etcdserver/raft.go:505","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Sep 12 23:53:22.513224 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.512973Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Sep 12 23:53:22.513224 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.513037Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Sep 12 23:53:22.513686 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.513059Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 12 23:53:22.513686 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.513264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Sep 12 23:53:22.513686 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.513377Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 12 23:53:22.521611 etcd-wrapper[2215]: {"level":"warn","ts":"2025-09-12T23:53:22.521255Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Sep 12 23:53:22.524424 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.524110Z","caller":"mvcc/kvstore.go:423","msg":"kvstore restored","current-rev":1} Sep 12 23:53:22.526749 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.526517Z","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"} Sep 12 23:53:22.531197 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.528737Z","caller":"etcdserver/server.go:873","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.16","cluster-version":"to_be_decided"} Sep 12 23:53:22.531197 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.529193Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 12 23:53:22.531197 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530202Z","caller":"etcdserver/server.go:757","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8e9e05c52164694d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} Sep 12 23:53:22.531716 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530517Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Sep 12 23:53:22.531716 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530560Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Sep 12 23:53:22.531716 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530580Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Sep 12 23:53:22.531716 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 12 23:53:22.531716 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.530963Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","added-peer-id":"8e9e05c52164694d","added-peer-peer-urls":["http://localhost:2380"]} Sep 12 23:53:22.535090 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.534771Z","caller":"embed/etcd.go:280","msg":"now serving peer/client/metrics","local-member-id":"8e9e05c52164694d","initial-advertise-peer-urls":["http://localhost:2380"],"listen-peer-urls":["http://localhost:2380"],"advertise-client-urls":["http://172.31.24.207:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 12 23:53:22.535439 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.534818Z","caller":"embed/etcd.go:600","msg":"serving peer traffic","address":"127.0.0.1:2380"} Sep 12 23:53:22.535752 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:22.535568Z","caller":"embed/etcd.go:572","msg":"cmux::serve","address":"127.0.0.1:2380"} Sep 12 23:53:22.864084 systemd[1]: var-lib-docker-overlay2-f870790ca3197eaaa31daa7ba623ad532a97ebb3cacb5945180566657d429682-merged.mount: Deactivated successfully. Sep 12 23:53:23.014671 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014167Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Sep 12 23:53:23.014671 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014221Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Sep 12 23:53:23.015084 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Sep 12 23:53:23.015084 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014599Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Sep 12 23:53:23.015084 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014636Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Sep 12 23:53:23.015423 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014661Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Sep 12 23:53:23.015423 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.014689Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Sep 12 23:53:23.016310 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.015970Z","caller":"etcdserver/server.go:2140","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec279867c0f6348127bec3ec0583fbc1 ClientURLs:[http://172.31.24.207:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Sep 12 23:53:23.016310 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.016024Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} Sep 12 23:53:23.016662 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.016330Z","caller":"etcdserver/server.go:2651","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Sep 12 23:53:23.018204 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.017396Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 12 23:53:23.019131 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.018866Z","caller":"embed/serve.go:187","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Sep 12 23:53:23.019410 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.019156Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Sep 12 23:53:23.019926 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 12 23:53:23.020551 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 12 23:53:23.021549 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.019470Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Sep 12 23:53:23.022936 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.017514Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Sep 12 23:53:23.023599 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.022603Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 12 23:53:23.023870 etcd-wrapper[2215]: {"level":"info","ts":"2025-09-12T23:53:23.023424Z","caller":"etcdserver/server.go:2675","msg":"cluster version is updated","cluster-version":"3.5"} Sep 12 23:53:23.024443 systemd[1]: Startup finished in 1.178s (kernel) + 7.370s (initrd) + 13.533s (userspace) = 22.082s. Sep 12 23:53:29.132236 systemd[1]: Started sshd@3-172.31.24.207:22-147.75.109.163:40490.service - OpenSSH per-connection server daemon (147.75.109.163:40490). Sep 12 23:53:29.310116 sshd[2392]: Accepted publickey for core from 147.75.109.163 port 40490 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:29.312746 sshd[2392]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:29.320379 systemd-logind[1838]: New session 4 of user core. Sep 12 23:53:29.327568 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 12 23:53:29.451826 sshd[2392]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:29.458211 systemd[1]: sshd@3-172.31.24.207:22-147.75.109.163:40490.service: Deactivated successfully. Sep 12 23:53:29.462023 systemd[1]: session-4.scope: Deactivated successfully. Sep 12 23:53:29.464184 systemd-logind[1838]: Session 4 logged out. Waiting for processes to exit. Sep 12 23:53:29.465890 systemd-logind[1838]: Removed session 4. Sep 12 23:53:29.493790 systemd[1]: Started sshd@4-172.31.24.207:22-147.75.109.163:40494.service - OpenSSH per-connection server daemon (147.75.109.163:40494). Sep 12 23:53:29.657707 sshd[2399]: Accepted publickey for core from 147.75.109.163 port 40494 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:29.660315 sshd[2399]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:29.668162 systemd-logind[1838]: New session 5 of user core. Sep 12 23:53:29.678532 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 12 23:53:29.795202 sshd[2399]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:29.800692 systemd[1]: sshd@4-172.31.24.207:22-147.75.109.163:40494.service: Deactivated successfully. Sep 12 23:53:29.801312 systemd-logind[1838]: Session 5 logged out. Waiting for processes to exit. Sep 12 23:53:29.803939 systemd[1]: session-5.scope: Deactivated successfully. Sep 12 23:53:29.808752 systemd-logind[1838]: Removed session 5. Sep 12 23:53:29.839737 systemd[1]: Started sshd@5-172.31.24.207:22-147.75.109.163:40496.service - OpenSSH per-connection server daemon (147.75.109.163:40496). Sep 12 23:53:29.999728 sshd[2406]: Accepted publickey for core from 147.75.109.163 port 40496 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:30.002348 sshd[2406]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:30.009730 systemd-logind[1838]: New session 6 of user core. Sep 12 23:53:30.020532 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 12 23:53:30.145054 sshd[2406]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:30.151218 systemd[1]: sshd@5-172.31.24.207:22-147.75.109.163:40496.service: Deactivated successfully. Sep 12 23:53:30.152082 systemd-logind[1838]: Session 6 logged out. Waiting for processes to exit. Sep 12 23:53:30.154992 systemd[1]: session-6.scope: Deactivated successfully. Sep 12 23:53:30.159876 systemd-logind[1838]: Removed session 6. Sep 12 23:53:30.184812 systemd[1]: Started sshd@6-172.31.24.207:22-147.75.109.163:36632.service - OpenSSH per-connection server daemon (147.75.109.163:36632). Sep 12 23:53:30.348108 sshd[2413]: Accepted publickey for core from 147.75.109.163 port 36632 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:30.350721 sshd[2413]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:30.358306 systemd-logind[1838]: New session 7 of user core. Sep 12 23:53:30.370562 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 12 23:53:30.489194 sshd[2413]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:30.495467 systemd-logind[1838]: Session 7 logged out. Waiting for processes to exit. Sep 12 23:53:30.496919 systemd[1]: sshd@6-172.31.24.207:22-147.75.109.163:36632.service: Deactivated successfully. Sep 12 23:53:30.500212 systemd[1]: session-7.scope: Deactivated successfully. Sep 12 23:53:30.502076 systemd-logind[1838]: Removed session 7. Sep 12 23:53:30.525819 systemd[1]: Started sshd@7-172.31.24.207:22-147.75.109.163:36646.service - OpenSSH per-connection server daemon (147.75.109.163:36646). Sep 12 23:53:30.699845 sshd[2422]: Accepted publickey for core from 147.75.109.163 port 36646 ssh2: RSA SHA256:hzqoQUQMDNGIX4spfLoTi9cnhX+EaAcejntAjTQoGoc Sep 12 23:53:30.702439 sshd[2422]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 12 23:53:30.709734 systemd-logind[1838]: New session 8 of user core. Sep 12 23:53:30.716545 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 12 23:53:30.932992 sshd[2422]: pam_unix(sshd:session): session closed for user core Sep 12 23:53:30.937972 systemd[1]: sshd@7-172.31.24.207:22-147.75.109.163:36646.service: Deactivated successfully. Sep 12 23:53:30.941580 systemd[1]: session-8.scope: Deactivated successfully. Sep 12 23:53:30.944238 systemd-logind[1838]: Session 8 logged out. Waiting for processes to exit. Sep 12 23:53:30.946515 systemd-logind[1838]: Removed session 8. Sep 12 23:53:45.455932 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 12 23:53:59.957692 update_engine[1839]: I20250912 23:53:59.957588 1839 update_attempter.cc:509] Updating boot flags... Sep 12 23:54:00.041367 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (2450) Sep 12 23:54:00.276044 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (2452) Sep 12 23:54:00.499306 kernel: BTRFS warning: duplicate device /dev/nvme0n1p3 devid 1 generation 37 scanned by (udev-worker) (2452)