Sep 11 18:01:42.765615 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Sep 11 18:01:42.765667 kernel: Linux version 6.12.109-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 15.2.1_p20260214 p5) 15.2.1 20260214, GNU ld (Gentoo 2.46.0 p1) 2.46.0) #1 SMP PREEMPT Fri Sep 11 15:57:01 -00 2026 Sep 11 18:01:42.765688 kernel: KASLR disabled due to lack of seed Sep 11 18:01:42.765704 kernel: efi: EFI v2.7 by EDK II Sep 11 18:01:42.765719 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7a73ca98 MEMRESERVE=0x78551798 Sep 11 18:01:42.765739 kernel: secureboot: Secure boot disabled Sep 11 18:01:42.765757 kernel: ACPI: Early table checksum verification disabled Sep 11 18:01:42.765772 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Sep 11 18:01:42.765788 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Sep 11 18:01:42.765804 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Sep 11 18:01:42.765819 kernel: ACPI: DSDT 0x0000000078640000 0013D2 (v02 AMAZON AMZNDSDT 00000001 AMZN 00000001) Sep 11 18:01:42.765835 kernel: ACPI: FACS 0x0000000078630000 000040 Sep 11 18:01:42.765850 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Sep 11 18:01:42.765870 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Sep 11 18:01:42.765888 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Sep 11 18:01:42.765904 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Sep 11 18:01:42.765921 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Sep 11 18:01:42.765941 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Sep 11 18:01:42.765957 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Sep 11 18:01:42.765973 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Sep 11 18:01:42.765989 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Sep 11 18:01:42.766006 kernel: printk: legacy bootconsole [uart0] enabled Sep 11 18:01:42.766022 kernel: ACPI: Use ACPI SPCR as default console: Yes Sep 11 18:01:42.766038 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Sep 11 18:01:42.766054 kernel: NODE_DATA(0) allocated [mem 0x4b584ea00-0x4b5855fff] Sep 11 18:01:42.766070 kernel: Zone ranges: Sep 11 18:01:42.766086 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Sep 11 18:01:42.766102 kernel: DMA32 empty Sep 11 18:01:42.766122 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Sep 11 18:01:42.766138 kernel: Device empty Sep 11 18:01:42.766154 kernel: Movable zone start for each node Sep 11 18:01:42.766170 kernel: Early memory node ranges Sep 11 18:01:42.766186 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Sep 11 18:01:42.766202 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Sep 11 18:01:42.766218 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Sep 11 18:01:42.766234 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Sep 11 18:01:42.766250 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Sep 11 18:01:42.766266 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Sep 11 18:01:42.766281 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Sep 11 18:01:42.766302 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Sep 11 18:01:42.766325 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Sep 11 18:01:42.766342 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Sep 11 18:01:42.766359 kernel: cma: Reserved 16 MiB at 0x000000007f000000 on node -1 Sep 11 18:01:42.766402 kernel: psci: probing for conduit method from ACPI. Sep 11 18:01:42.766422 kernel: psci: PSCIv1.0 detected in firmware. Sep 11 18:01:42.766439 kernel: psci: Using standard PSCI v0.2 function IDs Sep 11 18:01:42.766457 kernel: psci: Trusted OS migration not required Sep 11 18:01:42.766474 kernel: psci: SMC Calling Convention v1.1 Sep 11 18:01:42.766491 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Sep 11 18:01:42.766508 kernel: percpu: Embedded 34 pages/cpu s98904 r8192 d32168 u139264 Sep 11 18:01:42.766525 kernel: pcpu-alloc: s98904 r8192 d32168 u139264 alloc=34*4096 Sep 11 18:01:42.766542 kernel: pcpu-alloc: [0] 0 [0] 1 Sep 11 18:01:42.766559 kernel: Detected PIPT I-cache on CPU0 Sep 11 18:01:42.766582 kernel: CPU features: detected: GIC system register CPU interface Sep 11 18:01:42.766599 kernel: CPU features: detected: Spectre-v2 Sep 11 18:01:42.766616 kernel: CPU features: detected: Spectre-v3a Sep 11 18:01:42.766633 kernel: CPU features: detected: Spectre-BHB Sep 11 18:01:42.766649 kernel: CPU features: detected: ARM erratum 1742098 Sep 11 18:01:42.766666 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Sep 11 18:01:42.766683 kernel: alternatives: applying boot alternatives Sep 11 18:01:42.766702 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=e278d2ee3e1ca15d773bdd2fc3be23329d4a88fc4e69b96f0e2fa58396309744 Sep 11 18:01:42.766720 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Sep 11 18:01:42.766737 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Sep 11 18:01:42.766758 kernel: Fallback order for Node 0: 0 Sep 11 18:01:42.766775 kernel: Built 1 zonelists, mobility grouping on. Total pages: 1007616 Sep 11 18:01:42.766792 kernel: Policy zone: Normal Sep 11 18:01:42.766809 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Sep 11 18:01:42.766825 kernel: software IO TLB: area num 2. Sep 11 18:01:42.766842 kernel: software IO TLB: mapped [mem 0x0000000074551000-0x0000000078551000] (64MB) Sep 11 18:01:42.766859 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Sep 11 18:01:42.766876 kernel: ftrace: allocating 41360 entries in 162 pages Sep 11 18:01:42.766892 kernel: ftrace: allocated 162 pages with 3 groups Sep 11 18:01:42.766909 kernel: rcu: Preemptible hierarchical RCU implementation. Sep 11 18:01:42.766927 kernel: rcu: RCU event tracing is enabled. Sep 11 18:01:42.766949 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Sep 11 18:01:42.766966 kernel: Trampoline variant of Tasks RCU enabled. Sep 11 18:01:42.766983 kernel: Rude variant of Tasks RCU enabled. Sep 11 18:01:42.767000 kernel: Tracing variant of Tasks RCU enabled. Sep 11 18:01:42.767017 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Sep 11 18:01:42.767034 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Sep 11 18:01:42.767051 kernel: RCU Tasks: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 11 18:01:42.767068 kernel: RCU Tasks Rude: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 11 18:01:42.767085 kernel: RCU Tasks Trace: Setting shift to 1 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=2. Sep 11 18:01:42.767102 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Sep 11 18:01:42.767119 kernel: GICv3: 96 SPIs implemented Sep 11 18:01:42.767139 kernel: GICv3: 0 Extended SPIs implemented Sep 11 18:01:42.767156 kernel: Root IRQ handler: gic_handle_irq Sep 11 18:01:42.767173 kernel: GICv3: GICv3 features: 16 PPIs Sep 11 18:01:42.767189 kernel: GICv3: GICD_CTRL.DS=1, SCR_EL3.FIQ=0 Sep 11 18:01:42.767206 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Sep 11 18:01:42.767222 kernel: ITS [mem 0x10080000-0x1009ffff] Sep 11 18:01:42.767239 kernel: ITS@0x0000000010080000: allocated 8192 Devices @400190000 (indirect, esz 8, psz 64K, shr 1) Sep 11 18:01:42.767256 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4001a0000 (flat, esz 8, psz 64K, shr 1) Sep 11 18:01:42.767273 kernel: GICv3: using LPI property table @0x00000004001b0000 Sep 11 18:01:42.767290 kernel: ITS: Using hypervisor restricted LPI range [128] Sep 11 18:01:42.767307 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004001d0000 Sep 11 18:01:42.767328 kernel: rcu: srcu_init: Setting srcu_struct sizes based on contention. Sep 11 18:01:42.767345 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Sep 11 18:01:42.767362 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Sep 11 18:01:42.767418 kernel: clocksource: arch_sys_counter: mask: 0x1ffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Sep 11 18:01:42.767440 kernel: sched_clock: 57 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Sep 11 18:01:42.767457 kernel: Console: colour dummy device 80x25 Sep 11 18:01:42.767475 kernel: printk: legacy console [tty1] enabled Sep 11 18:01:42.767493 kernel: ACPI: Core revision 20240827 Sep 11 18:01:42.767511 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Sep 11 18:01:42.767534 kernel: pid_max: default: 32768 minimum: 301 Sep 11 18:01:42.767552 kernel: LSM: initializing lsm=lockdown,capability,landlock,selinux,ima Sep 11 18:01:42.767570 kernel: landlock: Up and running. Sep 11 18:01:42.767587 kernel: SELinux: Initializing. Sep 11 18:01:42.767604 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 11 18:01:42.767622 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Sep 11 18:01:42.767640 kernel: rcu: Hierarchical SRCU implementation. Sep 11 18:01:42.767658 kernel: rcu: Max phase no-delay instances is 400. Sep 11 18:01:42.767680 kernel: Timer migration: 1 hierarchy levels; 8 children per group; 1 crossnode level Sep 11 18:01:42.767697 kernel: Remapping and enabling EFI services. Sep 11 18:01:42.767714 kernel: smp: Bringing up secondary CPUs ... Sep 11 18:01:42.767731 kernel: Detected PIPT I-cache on CPU1 Sep 11 18:01:42.767749 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Sep 11 18:01:42.767779 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004001e0000 Sep 11 18:01:42.767798 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Sep 11 18:01:42.767816 kernel: smp: Brought up 1 node, 2 CPUs Sep 11 18:01:42.767835 kernel: SMP: Total of 2 processors activated. Sep 11 18:01:42.767857 kernel: CPU: All CPU(s) started at EL1 Sep 11 18:01:42.767875 kernel: CPU features: detected: 32-bit EL0 Support Sep 11 18:01:42.767893 kernel: CPU features: detected: 32-bit EL1 Support Sep 11 18:01:42.767911 kernel: CPU features: detected: CRC32 instructions Sep 11 18:01:42.767933 kernel: alternatives: applying system-wide alternatives Sep 11 18:01:42.767952 kernel: Memory: 3819892K/4030464K available (12544K kernel code, 2480K rwdata, 9572K rodata, 13376K init, 1040K bss, 188472K reserved, 16384K cma-reserved) Sep 11 18:01:42.767971 kernel: devtmpfs: initialized Sep 11 18:01:42.767989 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Sep 11 18:01:42.768007 kernel: 22960 pages in range for non-PLT usage Sep 11 18:01:42.768025 kernel: 514480 pages in range for PLT usage Sep 11 18:01:42.768043 kernel: pinctrl core: initialized pinctrl subsystem Sep 11 18:01:42.768065 kernel: SMBIOS 3.0.0 present. Sep 11 18:01:42.768083 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Sep 11 18:01:42.768101 kernel: DMI: Memory slots populated: 0/0 Sep 11 18:01:42.768120 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Sep 11 18:01:42.768138 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Sep 11 18:01:42.768156 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Sep 11 18:01:42.768175 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Sep 11 18:01:42.768197 kernel: audit: initializing netlink subsys (disabled) Sep 11 18:01:42.768215 kernel: audit: type=2000 audit(0.243:1): state=initialized audit_enabled=0 res=1 Sep 11 18:01:42.768233 kernel: thermal_sys: Registered thermal governor 'step_wise' Sep 11 18:01:42.768251 kernel: cpuidle: using governor menu Sep 11 18:01:42.768269 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Sep 11 18:01:42.768288 kernel: ASID allocator initialised with 65536 entries Sep 11 18:01:42.768306 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Sep 11 18:01:42.768328 kernel: Serial: AMBA PL011 UART driver Sep 11 18:01:42.768347 kernel: HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages Sep 11 18:01:42.768365 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page Sep 11 18:01:42.768425 kernel: HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages Sep 11 18:01:42.768448 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page Sep 11 18:01:42.768467 kernel: HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages Sep 11 18:01:42.768486 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page Sep 11 18:01:42.768510 kernel: HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages Sep 11 18:01:42.768529 kernel: HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page Sep 11 18:01:42.768547 kernel: ACPI: Added _OSI(Module Device) Sep 11 18:01:42.768653 kernel: ACPI: Added _OSI(Processor Device) Sep 11 18:01:42.768851 kernel: ACPI: Added _OSI(Processor Aggregator Device) Sep 11 18:01:42.768870 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Sep 11 18:01:42.768888 kernel: ACPI: Interpreter enabled Sep 11 18:01:42.768906 kernel: ACPI: Using GIC for interrupt routing Sep 11 18:01:42.768930 kernel: ACPI: MCFG table detected, 1 entries Sep 11 18:01:42.768949 kernel: ACPI: CPU0 has been hot-added Sep 11 18:01:42.768966 kernel: ACPI: CPU1 has been hot-added Sep 11 18:01:42.768984 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00]) Sep 11 18:01:42.769512 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Sep 11 18:01:42.769868 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Sep 11 18:01:42.770208 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Sep 11 18:01:42.770581 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x200fffff] reserved by PNP0C02:00 Sep 11 18:01:42.770915 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x200fffff] for [bus 00] Sep 11 18:01:42.770940 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Sep 11 18:01:42.770959 kernel: acpiphp: Slot [1] registered Sep 11 18:01:42.770978 kernel: acpiphp: Slot [2] registered Sep 11 18:01:42.771002 kernel: acpiphp: Slot [3] registered Sep 11 18:01:42.771020 kernel: acpiphp: Slot [4] registered Sep 11 18:01:42.771039 kernel: acpiphp: Slot [5] registered Sep 11 18:01:42.771058 kernel: acpiphp: Slot [6] registered Sep 11 18:01:42.771077 kernel: acpiphp: Slot [7] registered Sep 11 18:01:42.771096 kernel: acpiphp: Slot [8] registered Sep 11 18:01:42.771114 kernel: acpiphp: Slot [9] registered Sep 11 18:01:42.771132 kernel: acpiphp: Slot [10] registered Sep 11 18:01:42.771155 kernel: acpiphp: Slot [11] registered Sep 11 18:01:42.771173 kernel: acpiphp: Slot [12] registered Sep 11 18:01:42.771191 kernel: acpiphp: Slot [13] registered Sep 11 18:01:42.771209 kernel: acpiphp: Slot [14] registered Sep 11 18:01:42.771227 kernel: acpiphp: Slot [15] registered Sep 11 18:01:42.771245 kernel: acpiphp: Slot [16] registered Sep 11 18:01:42.771263 kernel: acpiphp: Slot [17] registered Sep 11 18:01:42.771285 kernel: acpiphp: Slot [18] registered Sep 11 18:01:42.771304 kernel: acpiphp: Slot [19] registered Sep 11 18:01:42.771322 kernel: acpiphp: Slot [20] registered Sep 11 18:01:42.771340 kernel: acpiphp: Slot [21] registered Sep 11 18:01:42.771358 kernel: acpiphp: Slot [22] registered Sep 11 18:01:42.771398 kernel: acpiphp: Slot [23] registered Sep 11 18:01:42.771420 kernel: acpiphp: Slot [24] registered Sep 11 18:01:42.771438 kernel: acpiphp: Slot [25] registered Sep 11 18:01:42.771462 kernel: acpiphp: Slot [26] registered Sep 11 18:01:42.771479 kernel: acpiphp: Slot [27] registered Sep 11 18:01:42.771498 kernel: acpiphp: Slot [28] registered Sep 11 18:01:42.771515 kernel: acpiphp: Slot [29] registered Sep 11 18:01:42.771533 kernel: acpiphp: Slot [30] registered Sep 11 18:01:42.771552 kernel: acpiphp: Slot [31] registered Sep 11 18:01:42.771570 kernel: PCI host bridge to bus 0000:00 Sep 11 18:01:42.771911 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Sep 11 18:01:42.772220 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Sep 11 18:01:42.772552 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Sep 11 18:01:42.772860 kernel: pci_bus 0000:00: root bus resource [bus 00] Sep 11 18:01:42.773323 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 conventional PCI endpoint Sep 11 18:01:42.773742 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 conventional PCI endpoint Sep 11 18:01:42.774084 kernel: pci 0000:00:01.0: BAR 0 [mem 0x80118000-0x80118fff] Sep 11 18:01:42.778768 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 PCIe Root Complex Integrated Endpoint Sep 11 18:01:42.779124 kernel: pci 0000:00:04.0: BAR 0 [mem 0x80114000-0x80117fff] Sep 11 18:01:42.779490 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 11 18:01:42.779849 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 PCIe Root Complex Integrated Endpoint Sep 11 18:01:42.780187 kernel: pci 0000:00:05.0: BAR 0 [mem 0x80110000-0x80113fff] Sep 11 18:01:42.780564 kernel: pci 0000:00:05.0: BAR 2 [mem 0x80000000-0x800fffff pref] Sep 11 18:01:42.780898 kernel: pci 0000:00:05.0: BAR 4 [mem 0x80100000-0x8010ffff] Sep 11 18:01:42.781247 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Sep 11 18:01:42.781619 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Sep 11 18:01:42.781926 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Sep 11 18:01:42.782239 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Sep 11 18:01:42.782265 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Sep 11 18:01:42.782284 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Sep 11 18:01:42.782303 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Sep 11 18:01:42.782322 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Sep 11 18:01:42.782340 kernel: iommu: Default domain type: Translated Sep 11 18:01:42.782363 kernel: iommu: DMA domain TLB invalidation policy: strict mode Sep 11 18:01:42.782419 kernel: efivars: Registered efivars operations Sep 11 18:01:42.782439 kernel: vgaarb: loaded Sep 11 18:01:42.782458 kernel: clocksource: Switched to clocksource arch_sys_counter Sep 11 18:01:42.782476 kernel: VFS: Disk quotas dquot_6.6.0 Sep 11 18:01:42.782494 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Sep 11 18:01:42.782513 kernel: pnp: PnP ACPI init Sep 11 18:01:42.782873 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Sep 11 18:01:42.782901 kernel: pnp: PnP ACPI: found 1 devices Sep 11 18:01:42.782921 kernel: NET: Registered PF_INET protocol family Sep 11 18:01:42.782940 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Sep 11 18:01:42.782958 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Sep 11 18:01:42.782977 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Sep 11 18:01:42.782995 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Sep 11 18:01:42.783020 kernel: TCP bind hash table entries: 32768 (order: 8, 1048576 bytes, linear) Sep 11 18:01:42.783039 kernel: TCP: Hash tables configured (established 32768 bind 32768) Sep 11 18:01:42.783057 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 11 18:01:42.783076 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Sep 11 18:01:42.783094 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Sep 11 18:01:42.783112 kernel: PCI: CLS 0 bytes, default 64 Sep 11 18:01:42.783130 kernel: kvm [1]: HYP mode not available Sep 11 18:01:42.783153 kernel: Initialise system trusted keyrings Sep 11 18:01:42.783171 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Sep 11 18:01:42.783189 kernel: Key type asymmetric registered Sep 11 18:01:42.783207 kernel: Asymmetric key parser 'x509' registered Sep 11 18:01:42.783226 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Sep 11 18:01:42.783244 kernel: io scheduler mq-deadline registered Sep 11 18:01:42.783262 kernel: io scheduler kyber registered Sep 11 18:01:42.783285 kernel: io scheduler bfq registered Sep 11 18:01:42.783677 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Sep 11 18:01:42.783705 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Sep 11 18:01:42.783724 kernel: ACPI: button: Power Button [PWRB] Sep 11 18:01:42.783743 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Sep 11 18:01:42.783761 kernel: ACPI: button: Sleep Button [SLPB] Sep 11 18:01:42.783779 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Sep 11 18:01:42.783805 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Sep 11 18:01:42.784142 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Sep 11 18:01:42.784168 kernel: printk: legacy console [ttyS0] disabled Sep 11 18:01:42.784188 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Sep 11 18:01:42.784206 kernel: printk: legacy console [ttyS0] enabled Sep 11 18:01:42.784225 kernel: printk: legacy bootconsole [uart0] disabled Sep 11 18:01:42.784243 kernel: ACPI: bus type drm_connector registered Sep 11 18:01:42.784266 kernel: thunder_xcv, ver 1.0 Sep 11 18:01:42.784284 kernel: thunder_bgx, ver 1.0 Sep 11 18:01:42.784302 kernel: nicpf, ver 1.0 Sep 11 18:01:42.784320 kernel: nicvf, ver 1.0 Sep 11 18:01:42.784686 kernel: rtc-efi rtc-efi.0: registered as rtc0 Sep 11 18:01:42.785003 kernel: rtc-efi rtc-efi.0: setting system clock to 2026-09-11T18:01:38 UTC (1789149698) Sep 11 18:01:42.785034 kernel: hid: raw HID events driver (C) Jiri Kosina Sep 11 18:01:42.785053 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 (0,80000003) counters available Sep 11 18:01:42.785072 kernel: watchdog: NMI not fully supported Sep 11 18:01:42.785091 kernel: NET: Registered PF_INET6 protocol family Sep 11 18:01:42.785123 kernel: watchdog: Hard watchdog permanently disabled Sep 11 18:01:42.785148 kernel: Segment Routing with IPv6 Sep 11 18:01:42.785166 kernel: In-situ OAM (IOAM) with IPv6 Sep 11 18:01:42.785190 kernel: NET: Registered PF_PACKET protocol family Sep 11 18:01:42.785209 kernel: Key type dns_resolver registered Sep 11 18:01:42.785226 kernel: registered taskstats version 1 Sep 11 18:01:42.785244 kernel: Loading compiled-in X.509 certificates Sep 11 18:01:42.785263 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 6.12.109-flatcar: bce2cfee41fe53b52a167ed4ad48ddd99dbfe47b' Sep 11 18:01:42.785281 kernel: Demotion targets for Node 0: null Sep 11 18:01:42.785300 kernel: Key type .fscrypt registered Sep 11 18:01:42.785322 kernel: Key type fscrypt-provisioning registered Sep 11 18:01:42.785340 kernel: ima: No TPM chip found, activating TPM-bypass! Sep 11 18:01:42.785358 kernel: ima: Allocated hash algorithm: sha1 Sep 11 18:01:42.785395 kernel: ima: No architecture policies found Sep 11 18:01:42.785417 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Sep 11 18:01:42.785435 kernel: clk: Disabling unused clocks Sep 11 18:01:42.785453 kernel: PM: genpd: Disabling unused power domains Sep 11 18:01:42.785472 kernel: Freeing unused kernel memory: 13376K Sep 11 18:01:42.785495 kernel: Run /init as init process Sep 11 18:01:42.785514 kernel: with arguments: Sep 11 18:01:42.785532 kernel: /init Sep 11 18:01:42.785549 kernel: with environment: Sep 11 18:01:42.785567 kernel: HOME=/ Sep 11 18:01:42.785585 kernel: TERM=linux Sep 11 18:01:42.785603 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Sep 11 18:01:42.785902 kernel: nvme nvme0: pci function 0000:00:04.0 Sep 11 18:01:42.788413 kernel: nvme nvme0: 2/0/0 default/read/poll queues Sep 11 18:01:42.788575 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Sep 11 18:01:42.788597 kernel: GPT:25804799 != 33554431 Sep 11 18:01:42.788616 kernel: GPT:Alternate GPT header not at the end of the disk. Sep 11 18:01:42.788635 kernel: GPT:25804799 != 33554431 Sep 11 18:01:42.792811 kernel: GPT: Use GNU Parted to correct GPT errors. Sep 11 18:01:42.792831 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Sep 11 18:01:42.792851 kernel: SCSI subsystem initialized Sep 11 18:01:42.792870 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Sep 11 18:01:42.792888 kernel: device-mapper: uevent: version 1.0.3 Sep 11 18:01:42.792907 kernel: device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev Sep 11 18:01:42.792925 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:42.792948 kernel: raid6: neonx8 gen() 6591 MB/s Sep 11 18:01:42.792966 kernel: raid6: neonx4 gen() 6512 MB/s Sep 11 18:01:42.792984 kernel: raid6: neonx2 gen() 5494 MB/s Sep 11 18:01:42.793001 kernel: raid6: neonx1 gen() 3991 MB/s Sep 11 18:01:42.793019 kernel: raid6: int64x8 gen() 3215 MB/s Sep 11 18:01:42.793038 kernel: raid6: int64x4 gen() 3711 MB/s Sep 11 18:01:42.793056 kernel: raid6: int64x2 gen() 3659 MB/s Sep 11 18:01:42.793077 kernel: raid6: int64x1 gen() 2750 MB/s Sep 11 18:01:42.793095 kernel: raid6: using algorithm neonx8 gen() 6591 MB/s Sep 11 18:01:42.793131 kernel: raid6: .... xor() 4548 MB/s, rmw enabled Sep 11 18:01:42.793152 kernel: raid6: using neon recovery algorithm Sep 11 18:01:42.793170 kernel: xor: measuring software checksum speed Sep 11 18:01:42.793188 kernel: 8regs : 10501 MB/sec Sep 11 18:01:42.793207 kernel: 32regs : 10660 MB/sec Sep 11 18:01:42.793224 kernel: arm64_neon : 9146 MB/sec Sep 11 18:01:42.793248 kernel: xor: using function: 32regs (10660 MB/sec) Sep 11 18:01:42.793266 kernel: Btrfs loaded, zoned=no, fsverity=no Sep 11 18:01:42.793285 kernel: BTRFS: device fsid 519dcf6a-1e68-4900-97f8-894b302e835e devid 1 transid 38 /dev/mapper/usr (254:0) scanned by mount (223) Sep 11 18:01:42.793303 kernel: BTRFS info (device dm-0): first mount of filesystem 519dcf6a-1e68-4900-97f8-894b302e835e Sep 11 18:01:42.793322 kernel: BTRFS info (device dm-0): using crc32c (crc32c-generic) checksum algorithm Sep 11 18:01:42.793340 kernel: BTRFS info (device dm-0 state E): enabling ssd optimizations Sep 11 18:01:42.793358 kernel: BTRFS info (device dm-0 state E): disabling log replay at mount time Sep 11 18:01:42.793411 kernel: BTRFS info (device dm-0 state E): enabling free space tree Sep 11 18:01:42.793432 kernel: loop: module loaded Sep 11 18:01:42.793451 kernel: loop0: detected capacity change from 0 to 99912 Sep 11 18:01:42.793469 kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Sep 11 18:01:42.793491 systemd[1]: Successfully made /usr/ read-only. Sep 11 18:01:42.793517 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 11 18:01:42.793546 systemd[1]: Detected virtualization amazon. Sep 11 18:01:42.793591 systemd[1]: Detected architecture arm64. Sep 11 18:01:42.793633 systemd[1]: Running in initrd. Sep 11 18:01:42.793675 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Sep 11 18:01:42.793699 systemd[1]: No hostname configured, using default hostname. Sep 11 18:01:42.793718 systemd[1]: Hostname set to . Sep 11 18:01:42.793744 systemd[1]: Queued start job for default target initrd.target. Sep 11 18:01:42.793778 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 18:01:42.793803 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 18:01:42.793825 systemd[1]: Expecting device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - /dev/disk/by-label/EFI-SYSTEM... Sep 11 18:01:42.793846 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 11 18:01:42.793871 systemd[1]: Expecting device dev-disk-by\x2dlabel-ROOT.device - /dev/disk/by-label/ROOT... Sep 11 18:01:42.793893 systemd[1]: Expecting device dev-disk-by\x2dpartlabel-USR\x2dA.device - /dev/disk/by-partlabel/USR-A... Sep 11 18:01:42.793914 systemd[1]: Expecting device dev-mapper-usr.device - /dev/mapper/usr... Sep 11 18:01:42.793934 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 18:01:42.793955 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 11 18:01:42.793981 systemd[1]: Reached target initrd-usr-fs.target - Initrd /usr File System. Sep 11 18:01:42.794001 systemd[1]: Reached target paths.target - Path Units. Sep 11 18:01:42.794022 systemd[1]: Reached target slices.target - Slice Units. Sep 11 18:01:42.794046 systemd[1]: Reached target swap.target - Swaps. Sep 11 18:01:42.794067 systemd[1]: Reached target timers.target - Timer Units. Sep 11 18:01:42.794088 systemd[1]: Listening on iscsid.socket - Open-iSCSI iscsid Socket. Sep 11 18:01:42.794108 systemd[1]: Listening on iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 11 18:01:42.794133 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 11 18:01:42.794154 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 11 18:01:42.794174 systemd[1]: Listening on systemd-journald-dev-log.socket - Journal Socket (/dev/log). Sep 11 18:01:42.794194 systemd[1]: Listening on systemd-journald.socket - Journal Sockets. Sep 11 18:01:42.794215 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 11 18:01:42.794235 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 11 18:01:42.794256 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 11 18:01:42.794280 systemd[1]: Listening on systemd-udevd-kernel.socket - udev Kernel Socket. Sep 11 18:01:42.794301 systemd[1]: Reached target sockets.target - Socket Units. Sep 11 18:01:42.794322 systemd[1]: afterburn-network-kargs.service - Afterburn Initrd Setup Network Kernel Arguments skipped, no trigger condition checks were met. Sep 11 18:01:42.794343 systemd[1]: Starting ignition-setup-pre.service - Ignition env setup... Sep 11 18:01:42.794363 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 11 18:01:42.794413 systemd[1]: Finished network-cleanup.service - Network Cleanup. Sep 11 18:01:42.794436 systemd[1]: systemd-battery-check.service - Early Battery Level Check skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/class/power_supply Sep 11 18:01:42.794456 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 11 18:01:42.794478 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 11 18:01:42.794505 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 18:01:42.794526 systemd[1]: Finished ignition-setup-pre.service - Ignition env setup. Sep 11 18:01:42.794547 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 18:01:42.794567 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 11 18:01:42.794655 systemd-journald[336]: Collecting audit messages is enabled. Sep 11 18:01:42.794701 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 11 18:01:42.794723 kernel: audit: type=1130 audit(1789149702.771:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.794744 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 18:01:42.794768 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 11 18:01:42.794789 kernel: audit: type=1130 audit(1789149702.787:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.794807 kernel: Bridge firewalling registered Sep 11 18:01:42.794829 systemd-journald[336]: Journal started Sep 11 18:01:42.794866 systemd-journald[336]: Runtime Journal (/run/log/journal/ec20d9574696453c452a6a34a645f3a2) is 8M, max 75.3M, 67.3M free. Sep 11 18:01:42.771000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.787000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.660792 systemd-modules-load[339]: Using 2 probe threads Sep 11 18:01:42.764947 systemd-vconsole-setup[341]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 11 18:01:42.795126 systemd-modules-load[339]: Inserted module 'br_netfilter' Sep 11 18:01:42.810471 systemd[1]: Starting dracut-cmdline-ask.service - dracut ask for additional cmdline parameters... Sep 11 18:01:42.818399 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 11 18:01:42.825576 systemd[1]: Started systemd-journald.service - Journal Service. Sep 11 18:01:42.825000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.832517 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 11 18:01:42.831000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.842644 kernel: audit: type=1130 audit(1789149702.825:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.842680 kernel: audit: type=1130 audit(1789149702.831:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.847656 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 11 18:01:42.855695 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 11 18:01:42.868000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.869800 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 18:01:42.883746 kernel: audit: type=1130 audit(1789149702.868:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.890846 systemd-tmpfiles[354]: /usr/lib/tmpfiles.d/systemd.conf:30: Duplicate line for path "/var/lib/systemd", ignoring. Sep 11 18:01:42.894453 systemd-tmpfiles[354]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 11 18:01:42.908529 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 18:01:42.912000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.916538 systemd[1]: systemd-sysctl.service: Deactivated successfully. Sep 11 18:01:42.916909 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 11 18:01:42.920493 kernel: audit: type=1130 audit(1789149702.912:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.919000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.919000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.929152 kernel: audit: type=1130 audit(1789149702.919:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.929898 kernel: audit: type=1131 audit(1789149702.919:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.933000 audit: BPF prog-id=5 op=LOAD Sep 11 18:01:42.937481 kernel: audit: type=1334 audit(1789149702.933:10): prog-id=5 op=LOAD Sep 11 18:01:42.937607 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 11 18:01:42.943575 systemd[1]: Finished dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 11 18:01:42.950000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.958437 kernel: audit: type=1130 audit(1789149702.950:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:42.964579 systemd[1]: Starting dracut-cmdline.service - dracut cmdline hook... Sep 11 18:01:43.006018 dracut-cmdline[370]: dracut-110 Sep 11 18:01:43.016632 dracut-cmdline[370]: Using kernel command line parameters: SYSTEMD_SULOGIN_FORCE=1 BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=e278d2ee3e1ca15d773bdd2fc3be23329d4a88fc4e69b96f0e2fa58396309744 Sep 11 18:01:43.084596 systemd-resolved[368]: Positive Trust Anchors: Sep 11 18:01:43.085997 systemd-resolved[368]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 11 18:01:43.086357 systemd-resolved[368]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 11 18:01:43.086755 systemd-resolved[368]: 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 11 18:01:43.299467 kernel: Loading iSCSI transport class v2.0-870. Sep 11 18:01:43.366405 kernel: random: crng init done Sep 11 18:01:43.374021 systemd-resolved[368]: Defaulting to hostname 'linux'. Sep 11 18:01:43.376346 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 11 18:01:43.384560 kernel: iscsi: registered transport (tcp) Sep 11 18:01:43.387281 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 11 18:01:43.385000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.418078 kernel: iscsi: registered transport (qla4xxx) Sep 11 18:01:43.418160 kernel: QLogic iSCSI HBA Driver Sep 11 18:01:43.459769 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 11 18:01:43.486986 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 11 18:01:43.489000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.493650 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 11 18:01:43.579649 systemd[1]: Finished dracut-cmdline.service - dracut cmdline hook. Sep 11 18:01:43.583000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.587517 systemd[1]: Starting dracut-pre-udev.service - dracut pre-udev hook... Sep 11 18:01:43.593861 systemd[1]: Starting parse-ip-for-networkd.service - Write systemd-networkd units from cmdline... Sep 11 18:01:43.664218 systemd[1]: Finished dracut-pre-udev.service - dracut pre-udev hook. Sep 11 18:01:43.665000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.669000 audit: BPF prog-id=6 op=LOAD Sep 11 18:01:43.670000 audit: BPF prog-id=7 op=LOAD Sep 11 18:01:43.673710 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 18:01:43.791696 systemd-udevd[606]: Using default interface naming scheme 'v260'. Sep 11 18:01:43.813057 systemd[1]: Finished parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 11 18:01:43.818000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.868787 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 18:01:43.873000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:43.880620 systemd[1]: Starting dracut-pre-trigger.service - dracut pre-trigger hook... Sep 11 18:01:43.892000 audit: BPF prog-id=8 op=LOAD Sep 11 18:01:43.900105 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 11 18:01:43.955033 dracut-pre-trigger[702]: rd.md=0: removing MD RAID activation Sep 11 18:01:43.995869 systemd-networkd[719]: Failed to open nftables netlink socket. IPMasquerade= and NFTSet= settings will not be applied. Ignoring: Protocol not supported Sep 11 18:01:44.015210 systemd-networkd[719]: lo: Link UP Sep 11 18:01:44.015231 systemd-networkd[719]: lo: Gained carrier Sep 11 18:01:44.020549 systemd[1]: Started systemd-networkd.service - Network Management. Sep 11 18:01:44.025000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:44.027360 systemd[1]: Reached target network.target - Network. Sep 11 18:01:44.041459 systemd[1]: Finished dracut-pre-trigger.service - dracut pre-trigger hook. Sep 11 18:01:44.045000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:44.050795 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 11 18:01:44.326873 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 18:01:44.331000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:44.343764 systemd[1]: Starting dracut-initqueue.service - dracut initqueue hook... Sep 11 18:01:44.705736 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Sep 11 18:01:44.705812 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Sep 11 18:01:44.710782 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 11 18:01:44.716000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:44.728001 kernel: ena 0000:00:05.0: ENA device version: 0.10 Sep 11 18:01:44.711019 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 18:01:44.733699 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Sep 11 18:01:44.718131 systemd[1]: Stopping systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 18:01:44.739648 kernel: nvme nvme0: using unchecked data buffer Sep 11 18:01:44.728161 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 18:01:44.742773 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80110000, mac addr 06:ff:fd:82:f7:ed Sep 11 18:01:44.755504 (udev-worker)[767]: Network interface NamePolicy= disabled on kernel command line. Sep 11 18:01:44.785517 systemd-networkd[719]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 11 18:01:44.785532 systemd-networkd[719]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 11 18:01:44.800781 systemd-vconsole-setup[798]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 11 18:01:44.806683 systemd-networkd[719]: eth0: Link UP Sep 11 18:01:44.806988 systemd-networkd[719]: eth0: Gained carrier Sep 11 18:01:44.807011 systemd-networkd[719]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 11 18:01:44.821000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:44.817356 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 18:01:44.839504 systemd-networkd[719]: eth0: DHCPv4 address 172.31.21.19/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 11 18:01:44.930898 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device - Amazon Elastic Block Store USR-A. Sep 11 18:01:44.961669 systemd[1]: Starting disk-uuid.service - Generate new UUID for disk GPT if necessary... Sep 11 18:01:44.999055 disk-uuid[839]: Primary Header is updated. Sep 11 18:01:44.999055 disk-uuid[839]: Secondary Entries is updated. Sep 11 18:01:44.999055 disk-uuid[839]: Secondary Header is updated. Sep 11 18:01:45.129688 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device - Amazon Elastic Block Store ROOT. Sep 11 18:01:45.174679 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device - Amazon Elastic Block Store EFI-SYSTEM. Sep 11 18:01:45.620508 systemd[1]: Finished dracut-initqueue.service - dracut initqueue hook. Sep 11 18:01:45.622000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:45.660067 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 11 18:01:45.668036 systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Sep 11 18:01:45.673349 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 18:01:45.678409 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 11 18:01:45.685575 systemd[1]: Mounting oem.mount - /oem... Sep 11 18:01:45.691729 systemd[1]: Starting dracut-pre-mount.service - dracut pre-mount hook... Sep 11 18:01:45.716523 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1063) Sep 11 18:01:45.722179 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1dcbde6c-024c-4510-9399-656ec731e032 Sep 11 18:01:45.722270 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 11 18:01:45.732513 systemd[1]: Finished dracut-pre-mount.service - dracut pre-mount hook. Sep 11 18:01:45.738000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:45.763496 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 11 18:01:45.763582 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 11 18:01:45.766071 systemd[1]: Mounted oem.mount - /oem. Sep 11 18:01:45.771291 systemd[1]: Starting ignition-fetch-offline.service - Ignition (fetch-offline)... Sep 11 18:01:46.095795 disk-uuid[846]: Warning: The kernel is still using the old partition table. Sep 11 18:01:46.095795 disk-uuid[846]: The new table will be used at the next reboot or after you Sep 11 18:01:46.095795 disk-uuid[846]: run partprobe(8) or kpartx(8) Sep 11 18:01:46.095795 disk-uuid[846]: The operation has completed successfully. Sep 11 18:01:46.117624 systemd[1]: disk-uuid.service: Deactivated successfully. Sep 11 18:01:46.121000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:46.121000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=disk-uuid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:46.117915 systemd[1]: Finished disk-uuid.service - Generate new UUID for disk GPT if necessary. Sep 11 18:01:46.125164 systemd[1]: Mounting boot.mount - Boot partition... Sep 11 18:01:46.257757 systemd[1]: Mounted boot.mount - Boot partition. Sep 11 18:01:46.845640 systemd-networkd[719]: eth0: Gained IPv6LL Sep 11 18:01:47.362036 ignition[1088]: Ignition 2.24.0 Sep 11 18:01:47.362066 ignition[1088]: Stage: fetch-offline Sep 11 18:01:47.363394 ignition[1088]: no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:47.363429 ignition[1088]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:47.363802 ignition[1088]: Ignition finished successfully Sep 11 18:01:47.372878 systemd[1]: Finished ignition-fetch-offline.service - Ignition (fetch-offline). Sep 11 18:01:47.377000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.381651 systemd[1]: Starting ignition-fetch.service - Ignition (fetch)... Sep 11 18:01:47.421941 ignition[1102]: Ignition 2.24.0 Sep 11 18:01:47.421972 ignition[1102]: Stage: fetch Sep 11 18:01:47.422286 ignition[1102]: no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:47.422307 ignition[1102]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:47.422455 ignition[1102]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:47.465900 ignition[1102]: PUT result: OK Sep 11 18:01:47.473502 ignition[1102]: parsed url from cmdline: "" Sep 11 18:01:47.473520 ignition[1102]: no config URL provided Sep 11 18:01:47.473536 ignition[1102]: reading system config file "/usr/lib/ignition/user.ign" Sep 11 18:01:47.473612 ignition[1102]: no config at "/usr/lib/ignition/user.ign" Sep 11 18:01:47.473646 ignition[1102]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:47.477956 ignition[1102]: PUT result: OK Sep 11 18:01:47.478057 ignition[1102]: GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Sep 11 18:01:47.482665 ignition[1102]: GET result: OK Sep 11 18:01:47.482746 ignition[1102]: parsing config with SHA512: 869a3ea861aaea7c34e9db7f87e47e42da39e5b709f61ea3cc501f8733801473ba39459ce3722ccf03162f637f63064dda60057f6fd66aee1d6360202a3aec1f Sep 11 18:01:47.498064 unknown[1102]: fetched base config from "system" Sep 11 18:01:47.498096 unknown[1102]: fetched base config from "system" Sep 11 18:01:47.498628 ignition[1102]: fetch: fetch complete Sep 11 18:01:47.498121 unknown[1102]: fetched user config from "aws" Sep 11 18:01:47.498640 ignition[1102]: fetch: fetch passed Sep 11 18:01:47.498728 ignition[1102]: Ignition finished successfully Sep 11 18:01:47.512124 systemd[1]: Finished ignition-fetch.service - Ignition (fetch). Sep 11 18:01:47.514000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.518055 systemd[1]: Starting ignition-kargs.service - Ignition (kargs)... Sep 11 18:01:47.559684 ignition[1108]: Ignition 2.24.0 Sep 11 18:01:47.560258 ignition[1108]: Stage: kargs Sep 11 18:01:47.560608 ignition[1108]: no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:47.560655 ignition[1108]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:47.560780 ignition[1108]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:47.573321 ignition[1108]: PUT result: OK Sep 11 18:01:47.579548 ignition[1108]: kargs: kargs passed Sep 11 18:01:47.579653 ignition[1108]: Ignition finished successfully Sep 11 18:01:47.585192 systemd[1]: Finished ignition-kargs.service - Ignition (kargs). Sep 11 18:01:47.588000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.591222 systemd[1]: Starting ignition-disks.service - Ignition (disks)... Sep 11 18:01:47.633691 systemd[1]: ignition-kargs.service: Deactivated successfully. Sep 11 18:01:47.634199 systemd[1]: Stopped ignition-kargs.service - Ignition (kargs). Sep 11 18:01:47.639000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-kargs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.641490 systemd[1]: ignition-fetch.service: Deactivated successfully. Sep 11 18:01:47.643000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.647000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-fetch-offline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.641705 systemd[1]: Stopped ignition-fetch.service - Ignition (fetch). Sep 11 18:01:47.644719 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Sep 11 18:01:47.644914 systemd[1]: Stopped ignition-fetch-offline.service - Ignition (fetch-offline). Sep 11 18:01:47.650239 systemd[1]: Unmounting oem.mount - /oem... Sep 11 18:01:47.686400 kernel: BTRFS info (device nvme0n1p6): last unmount of filesystem 1dcbde6c-024c-4510-9399-656ec731e032 Sep 11 18:01:47.689636 systemd[1]: oem.mount: Deactivated successfully. Sep 11 18:01:47.691909 systemd[1]: Unmounted oem.mount - /oem. Sep 11 18:01:47.738214 ignition[1119]: Ignition 2.24.0 Sep 11 18:01:47.738822 ignition[1119]: Stage: disks Sep 11 18:01:47.739159 ignition[1119]: no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:47.739179 ignition[1119]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:47.739329 ignition[1119]: PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:47.744117 ignition[1119]: PUT result: OK Sep 11 18:01:47.754941 ignition[1119]: disks: disks passed Sep 11 18:01:47.755068 ignition[1119]: Ignition finished successfully Sep 11 18:01:47.759928 systemd[1]: Finished ignition-disks.service - Ignition (disks). Sep 11 18:01:47.765843 systemd[1]: Reached target initrd-root-device.target - Initrd Root Device. Sep 11 18:01:47.764000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.771314 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 11 18:01:47.777048 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 11 18:01:47.779796 systemd[1]: Reached target sysinit.target - System Initialization. Sep 11 18:01:47.788131 systemd[1]: Reached target basic.target - Basic System. Sep 11 18:01:47.796801 systemd[1]: Starting systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT... Sep 11 18:01:47.969624 systemd-fsck[1127]: ROOT: clean, 15/1631200 files, 112378/1617920 blocks Sep 11 18:01:47.978606 systemd[1]: Finished systemd-fsck-root.service - File System Check on /dev/disk/by-label/ROOT. Sep 11 18:01:47.987566 systemd[1]: Mounting sysroot.mount - /sysroot... Sep 11 18:01:47.981000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:47.991669 kernel: kauditd_printk_skb: 25 callbacks suppressed Sep 11 18:01:47.991747 kernel: audit: type=1130 audit(1789149707.981:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:48.214403 kernel: EXT4-fs (nvme0n1p9): mounted filesystem 763318fe-8bd7-485d-aab7-cf527ed66142 r/w with ordered data mode. Quota mode: none. Sep 11 18:01:48.216350 systemd[1]: Mounted sysroot.mount - /sysroot. Sep 11 18:01:48.220917 systemd[1]: Reached target initrd-root-fs.target - Initrd Root File System. Sep 11 18:01:48.254171 systemd[1]: Mounting sysroot-usr.mount - /sysroot/usr... Sep 11 18:01:48.261966 systemd[1]: flatcar-metadata-hostname.service - Flatcar Metadata Hostname Agent skipped, no trigger condition checks were met. Sep 11 18:01:48.262040 systemd[1]: ignition-remount-sysroot.service - Remount /sysroot read-write for Ignition skipped, unmet condition check ConditionPathIsReadWrite=!/sysroot Sep 11 18:01:48.262099 systemd[1]: Reached target ignition-diskful.target - Ignition Boot Disk Setup. Sep 11 18:01:48.287223 systemd[1]: Mounted sysroot-usr.mount - /sysroot/usr. Sep 11 18:01:48.293487 systemd[1]: Starting initrd-setup-root.service - Root filesystem setup... Sep 11 18:01:48.589032 systemd-tmpfiles[1165]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:1: Duplicate line for path "/sysroot/var", ignoring. Sep 11 18:01:48.589128 systemd-tmpfiles[1165]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:7: Duplicate line for path "/sysroot/var/empty", ignoring. Sep 11 18:01:48.589340 systemd-tmpfiles[1165]: /sysroot/usr/lib/tmpfiles.d/base_image_var.conf:28: Duplicate line for path "/sysroot/var/log", ignoring. Sep 11 18:01:49.906427 kernel: loop1: detected capacity change from 0 to 44360 Sep 11 18:01:49.914521 kernel: loop1: p1 p2 p3 Sep 11 18:01:50.253440 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:50.253499 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:50.257201 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:50.258555 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:50.260451 systemd-confext[1219]: device-mapper: reload ioctl on loop1p1-12-verity (254:1) failed: Invalid argument Sep 11 18:01:50.308684 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:50.396425 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 11 18:01:50.448428 kernel: loop2: detected capacity change from 0 to 44360 Sep 11 18:01:50.459246 kernel: loop2: p1 p2 p3 Sep 11 18:01:50.465150 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:50.465212 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:50.465238 kernel: device-mapper: table: 254:1: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:50.468428 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:50.468272 (sd-merge)[1230]: device-mapper: reload ioctl on loop2p1-16-verity (254:1) failed: Invalid argument Sep 11 18:01:50.476419 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:50.519444 kernel: erofs: (device dm-1): mounted with root inode @ nid 40. Sep 11 18:01:50.519475 (sd-merge)[1230]: Using extensions '00-flatcar-default.raw'. Sep 11 18:01:50.523099 (sd-merge)[1230]: Merged extensions into '/sysroot/etc'. Sep 11 18:01:50.532797 initrd-setup-root[1238]: /etc 00-flatcar-default Fri 2026-09-11 18:01:42 UTC Sep 11 18:01:50.537479 systemd[1]: Finished initrd-setup-root.service - Root filesystem setup. Sep 11 18:01:50.541000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.545568 systemd[1]: Starting ignition-mount.service - Ignition (mount)... Sep 11 18:01:50.553158 kernel: audit: type=1130 audit(1789149710.541:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.614356 ignition[1243]: INFO : Ignition 2.24.0 Sep 11 18:01:50.614356 ignition[1243]: INFO : Stage: mount Sep 11 18:01:50.614356 ignition[1243]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:50.614356 ignition[1243]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:50.614356 ignition[1243]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:50.626982 ignition[1243]: INFO : PUT result: OK Sep 11 18:01:50.632059 ignition[1243]: INFO : mount: mount passed Sep 11 18:01:50.632059 ignition[1243]: INFO : Ignition finished successfully Sep 11 18:01:50.632000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.630637 systemd[1]: Finished ignition-mount.service - Ignition (mount). Sep 11 18:01:50.636551 systemd[1]: Starting ignition-files.service - Ignition (files)... Sep 11 18:01:50.648237 kernel: audit: type=1130 audit(1789149710.632:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.671635 systemd[1]: Mounting oem.mount - /oem... Sep 11 18:01:50.698431 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 (259:5) scanned by mount (1250) Sep 11 18:01:50.705049 kernel: BTRFS info (device nvme0n1p6): first mount of filesystem 1dcbde6c-024c-4510-9399-656ec731e032 Sep 11 18:01:50.705116 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Sep 11 18:01:50.718005 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Sep 11 18:01:50.718075 kernel: BTRFS info (device nvme0n1p6): enabling free space tree Sep 11 18:01:50.722341 systemd[1]: Mounted oem.mount - /oem. Sep 11 18:01:50.728621 systemd[1]: Mounting sysroot-oem.mount - /sysroot/oem... Sep 11 18:01:50.751481 systemd[1]: Mounted sysroot-oem.mount - /sysroot/oem. Sep 11 18:01:50.795111 ignition[1267]: INFO : Ignition 2.24.0 Sep 11 18:01:50.797367 ignition[1267]: INFO : Stage: files Sep 11 18:01:50.797367 ignition[1267]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:50.797367 ignition[1267]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:50.797367 ignition[1267]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:50.808565 ignition[1267]: INFO : PUT result: OK Sep 11 18:01:50.812696 ignition[1267]: DEBUG : files: compiled without relabeling support, skipping Sep 11 18:01:50.816671 ignition[1267]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Sep 11 18:01:50.816671 ignition[1267]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Sep 11 18:01:50.827527 ignition[1267]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Sep 11 18:01:50.830648 ignition[1267]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Sep 11 18:01:50.834777 unknown[1267]: wrote ssh authorized keys file for user: core Sep 11 18:01:50.837006 ignition[1267]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Sep 11 18:01:50.840632 ignition[1267]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/flatcar/update.conf" Sep 11 18:01:50.844662 ignition[1267]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/flatcar/update.conf" Sep 11 18:01:50.848642 ignition[1267]: INFO : files: op(4): [started] processing unit "etcd-member.service" Sep 11 18:01:50.852586 ignition[1267]: 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 11 18:01:50.858358 ignition[1267]: 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 11 18:01:50.858358 ignition[1267]: INFO : files: op(4): [finished] processing unit "etcd-member.service" Sep 11 18:01:50.858358 ignition[1267]: INFO : files: op(6): [started] setting preset to enabled for "etcd-member.service" Sep 11 18:01:50.869678 ignition[1267]: INFO : files: op(6): [finished] setting preset to enabled for "etcd-member.service" Sep 11 18:01:50.869678 ignition[1267]: INFO : files: createResultFile: createFiles: op(7): [started] writing file "/sysroot/etc/.ignition-result.json" Sep 11 18:01:50.876767 ignition[1267]: INFO : files: createResultFile: createFiles: op(7): [finished] writing file "/sysroot/etc/.ignition-result.json" Sep 11 18:01:50.876767 ignition[1267]: INFO : files: files passed Sep 11 18:01:50.882327 ignition[1267]: INFO : Ignition finished successfully Sep 11 18:01:50.886624 systemd[1]: Finished ignition-files.service - Ignition (files). Sep 11 18:01:50.889000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.898427 kernel: audit: type=1130 audit(1789149710.889:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.898709 systemd[1]: Starting ignition-quench.service - Ignition (record completion)... Sep 11 18:01:50.905582 systemd[1]: Starting initrd-setup-root-after-ignition.service - Root filesystem completion... Sep 11 18:01:50.929366 systemd[1]: ignition-quench.service: Deactivated successfully. Sep 11 18:01:50.929796 systemd[1]: Finished ignition-quench.service - Ignition (record completion). Sep 11 18:01:50.935000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.935000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.945598 kernel: audit: type=1130 audit(1789149710.935:41): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.945674 kernel: audit: type=1131 audit(1789149710.935:42): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-quench comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:50.983426 initrd-setup-root-after-ignition[1301]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 11 18:01:50.983426 initrd-setup-root-after-ignition[1301]: grep: /sysroot/usr/share/flatcar/enabled-sysext.conf: No such file or directory Sep 11 18:01:50.990550 initrd-setup-root-after-ignition[1304]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Sep 11 18:01:51.003424 kernel: loop3: detected capacity change from 0 to 44360 Sep 11 18:01:51.014507 kernel: loop3: p1 p2 p3 Sep 11 18:01:51.034095 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.034164 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:51.037424 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:51.037488 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:51.038879 systemd-confext[1307]: device-mapper: reload ioctl on loop3p1-19-verity (254:2) failed: Invalid argument Sep 11 18:01:51.059453 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.097425 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 11 18:01:51.128609 kernel: loop4: detected capacity change from 0 to 44360 Sep 11 18:01:51.135410 kernel: loop4: p1 p2 p3 Sep 11 18:01:51.147476 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.147538 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:51.149453 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:51.150942 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:51.151040 (sd-merge)[1315]: device-mapper: reload ioctl on loop4p1-23-verity (254:2) failed: Invalid argument Sep 11 18:01:51.159771 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.207949 kernel: erofs: (device dm-2): mounted with root inode @ nid 40. Sep 11 18:01:51.207490 (sd-merge)[1315]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 11 18:01:51.301432 kernel: loop4: detected capacity change from 0 to 281976 Sep 11 18:01:51.342434 kernel: loop4: p1 p2 p3 Sep 11 18:01:51.564486 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.564577 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:51.566467 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:51.570423 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:51.571510 systemd-sysext[1323]: device-mapper: reload ioctl on loop4p1-27-verity (254:2) failed: Invalid argument Sep 11 18:01:51.600844 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.704423 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 11 18:01:51.729670 kernel: loop5: detected capacity change from 0 to 364432 Sep 11 18:01:51.779529 kernel: loop5: p1 p2 p3 Sep 11 18:01:51.975607 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:51.975673 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:51.975700 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:51.977797 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:51.979259 systemd-sysext[1323]: device-mapper: reload ioctl on loop5p1-31-verity (254:2) failed: Invalid argument Sep 11 18:01:51.987409 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.152431 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 11 18:01:52.282485 kernel: loop6: detected capacity change from 0 to 172472 Sep 11 18:01:52.293531 kernel: loop6: p1 p2 p3 Sep 11 18:01:52.557192 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.557253 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:52.561173 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:52.564720 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:52.565567 systemd-sysext[1323]: device-mapper: reload ioctl on loop6p1-35-verity (254:2) failed: Invalid argument Sep 11 18:01:52.578506 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.711434 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 11 18:01:52.740430 kernel: loop7: detected capacity change from 0 to 281976 Sep 11 18:01:52.751591 kernel: loop7: p1 p2 p3 Sep 11 18:01:52.771428 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.771496 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:52.774336 kernel: device-mapper: table: 254:2: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:52.776307 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:52.777441 (sd-merge)[1347]: device-mapper: reload ioctl on loop7p1-39-verity (254:2) failed: Invalid argument Sep 11 18:01:52.784436 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.874414 kernel: erofs: (device dm-2): mounted with root inode @ nid 39. Sep 11 18:01:52.879421 kernel: loop1: detected capacity change from 0 to 364432 Sep 11 18:01:52.891479 kernel: loop1: p1 p2 p3 Sep 11 18:01:52.908739 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:52.908821 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:52.910679 kernel: device-mapper: table: 254:3: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:52.911988 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:52.912100 (sd-merge)[1347]: device-mapper: reload ioctl on loop1p1-43-verity (254:3) failed: Invalid argument Sep 11 18:01:52.920403 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:53.021419 kernel: erofs: (device dm-3): mounted with root inode @ nid 39. Sep 11 18:01:53.027412 kernel: loop3: detected capacity change from 0 to 172472 Sep 11 18:01:53.036413 kernel: loop3: p1 p2 p3 Sep 11 18:01:53.056908 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:53.056977 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:01:53.058928 kernel: device-mapper: table: 254:4: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:01:53.060767 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:01:53.062466 (sd-merge)[1347]: device-mapper: reload ioctl on loop3p1-47-verity (254:4) failed: Invalid argument Sep 11 18:01:53.078412 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:01:53.144440 kernel: erofs: (device dm-4): mounted with root inode @ nid 39. Sep 11 18:01:53.143498 (sd-merge)[1347]: Using extensions 'containerd-flatcar.raw', 'docker-flatcar.raw', 'oem-ami-4757.2.0.raw'. Sep 11 18:01:53.149299 (sd-merge)[1347]: Merged extensions into '/sysroot/usr'. Sep 11 18:01:53.155577 systemd[1]: Finished initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 11 18:01:53.157000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.168787 kernel: audit: type=1130 audit(1789149713.157:43): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.168654 systemd[1]: Starting initrd-parse-etc.service - Mountpoints Configured in the Real Root... Sep 11 18:01:53.212647 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Sep 11 18:01:53.215150 systemd[1]: Finished initrd-parse-etc.service - Mountpoints Configured in the Real Root. Sep 11 18:01:53.221021 systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies. Sep 11 18:01:53.219000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.228721 systemd[1]: Reached target initrd-fs.target - Initrd File Systems. Sep 11 18:01:53.219000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.238541 kernel: audit: type=1130 audit(1789149713.219:44): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.238577 kernel: audit: type=1131 audit(1789149713.219:45): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-parse-etc comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.239577 systemd[1]: Starting dracut-mount.service - dracut mount hook... Sep 11 18:01:53.712737 systemd[1]: Finished dracut-mount.service - dracut mount hook. Sep 11 18:01:53.719000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.723782 systemd[1]: Starting dracut-pre-pivot.service - dracut pre-pivot and cleanup hook... Sep 11 18:01:53.730632 kernel: audit: type=1130 audit(1789149713.719:46): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.768840 systemd[1]: Finished dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 11 18:01:53.773000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.777626 systemd[1]: Starting initrd-cleanup.service - Cleaning Up and Shutting Down Daemons... Sep 11 18:01:53.779769 kernel: audit: type=1130 audit(1789149713.773:47): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.817258 systemd[1]: Stopped target basic.target - Basic System. Sep 11 18:01:53.819929 systemd[1]: Stopped target ignition-diskful.target - Ignition Boot Disk Setup. Sep 11 18:01:53.825260 systemd[1]: Stopped target initrd-root-device.target - Initrd Root Device. Sep 11 18:01:53.830452 systemd[1]: Stopped target initrd-usr-fs.target - Initrd /usr File System. Sep 11 18:01:53.838135 systemd[1]: Stopped target nss-lookup.target - Host and Network Name Lookups. Sep 11 18:01:53.841300 systemd[1]: Stopped target paths.target - Path Units. Sep 11 18:01:53.848027 systemd[1]: Stopped target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 18:01:53.852350 systemd[1]: Stopped target slices.target - Slice Units. Sep 11 18:01:53.858893 systemd[1]: Stopped target sockets.target - Socket Units. Sep 11 18:01:53.862058 systemd[1]: Stopped target sysinit.target - System Initialization. Sep 11 18:01:53.867522 systemd[1]: Stopped target local-fs.target - Local File Systems. Sep 11 18:01:53.871940 systemd[1]: Stopped target local-fs-pre.target - Preparation for Local File Systems. Sep 11 18:01:53.879981 systemd[1]: Stopped target swap.target - Swaps. Sep 11 18:01:53.883477 systemd[1]: Stopped target timers.target - Timer Units. Sep 11 18:01:53.889021 systemd[1]: iscsid.socket: Deactivated successfully. Sep 11 18:01:53.889572 systemd[1]: Closed iscsid.socket - Open-iSCSI iscsid Socket. Sep 11 18:01:53.897167 systemd[1]: iscsiuio.socket: Deactivated successfully. Sep 11 18:01:53.897760 systemd[1]: Closed iscsiuio.socket - Open-iSCSI iscsiuio Socket. Sep 11 18:01:53.902436 systemd[1]: systemd-coredump.socket: Deactivated successfully. Sep 11 18:01:53.902702 systemd[1]: Closed systemd-coredump.socket - Process Core Dump Socket. Sep 11 18:01:53.909470 systemd[1]: systemd-journald-audit.socket: Deactivated successfully. Sep 11 18:01:53.917000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.926976 kernel: audit: type=1131 audit(1789149713.917:48): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-pivot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.909685 systemd[1]: Closed systemd-journald-audit.socket - Journal Audit Socket. Sep 11 18:01:53.913906 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Sep 11 18:01:53.914273 systemd[1]: Stopped dracut-pre-pivot.service - dracut pre-pivot and cleanup hook. Sep 11 18:01:53.935000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.944995 kernel: audit: type=1131 audit(1789149713.935:49): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.923956 systemd[1]: Stopped target remote-fs.target - Remote File Systems. Sep 11 18:01:53.946000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.928422 systemd[1]: Stopped target remote-fs-pre.target - Preparation for Remote File Systems. Sep 11 18:01:53.932974 systemd[1]: dracut-mount.service: Deactivated successfully. Sep 11 18:01:53.962537 kernel: audit: type=1131 audit(1789149713.946:50): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.933290 systemd[1]: Stopped dracut-mount.service - dracut mount hook. Sep 11 18:01:53.937527 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Sep 11 18:01:53.937916 systemd[1]: Stopped dracut-pre-mount.service - dracut pre-mount hook. Sep 11 18:01:53.948185 systemd[1]: Stopped target cryptsetup.target - Local Encrypted Volumes. Sep 11 18:01:53.960348 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Sep 11 18:01:53.961027 systemd[1]: Stopped systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 18:01:53.971424 systemd[1]: Stopped target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 18:01:53.980254 systemd[1]: clevis-luks-askpass.path: Deactivated successfully. Sep 11 18:01:53.980960 systemd[1]: Stopped clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 18:01:53.996000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.009481 kernel: audit: type=1131 audit(1789149713.996:51): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.989745 systemd[1]: dracut-initqueue.service: Deactivated successfully. Sep 11 18:01:54.011000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.020129 kernel: audit: type=1131 audit(1789149714.011:52): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root-after-ignition comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.990075 systemd[1]: Stopped dracut-initqueue.service - dracut initqueue hook. Sep 11 18:01:54.021000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-files comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:53.998267 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Sep 11 18:01:53.998563 systemd[1]: Stopped initrd-setup-root-after-ignition.service - Root filesystem completion. Sep 11 18:01:54.012816 systemd[1]: ignition-files.service: Deactivated successfully. Sep 11 18:01:54.018159 systemd[1]: Stopped ignition-files.service - Ignition (files). Sep 11 18:01:54.029925 systemd[1]: Stopping ignition-mount.service - Ignition (mount)... Sep 11 18:01:54.040092 systemd[1]: systemd-modules-load.service: Deactivated successfully. Sep 11 18:01:54.041477 systemd[1]: Stopped systemd-modules-load.service - Load Kernel Modules. Sep 11 18:01:54.047000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.048897 systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully. Sep 11 18:01:54.052320 systemd[1]: Stopped systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 18:01:54.058000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.060235 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Sep 11 18:01:54.061608 systemd[1]: Stopped systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 18:01:54.066000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.068482 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Sep 11 18:01:54.068973 systemd[1]: Stopped dracut-pre-trigger.service - dracut pre-trigger hook. Sep 11 18:01:54.078000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.091685 systemd[1]: initrd-cleanup.service: Deactivated successfully. Sep 11 18:01:54.094822 systemd[1]: Finished initrd-cleanup.service - Cleaning Up and Shutting Down Daemons. Sep 11 18:01:54.099000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.100000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.109604 ignition[1389]: INFO : Ignition 2.24.0 Sep 11 18:01:54.112432 ignition[1389]: INFO : Stage: umount Sep 11 18:01:54.112432 ignition[1389]: INFO : no config dir at "/usr/lib/ignition/base.d" Sep 11 18:01:54.112432 ignition[1389]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Sep 11 18:01:54.112432 ignition[1389]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Sep 11 18:01:54.127510 ignition[1389]: INFO : PUT result: OK Sep 11 18:01:54.137637 ignition[1389]: INFO : umount: umount passed Sep 11 18:01:54.139613 ignition[1389]: INFO : Ignition finished successfully Sep 11 18:01:54.142733 systemd[1]: ignition-mount.service: Deactivated successfully. Sep 11 18:01:54.143240 systemd[1]: Stopped ignition-mount.service - Ignition (mount). Sep 11 18:01:54.148000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.150246 systemd[1]: Stopped target network.target - Network. Sep 11 18:01:54.154225 systemd[1]: ignition-disks.service: Deactivated successfully. Sep 11 18:01:54.155000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-disks comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.154311 systemd[1]: Stopped ignition-disks.service - Ignition (disks). Sep 11 18:01:54.160000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup-pre comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.157257 systemd[1]: ignition-setup-pre.service: Deactivated successfully. Sep 11 18:01:54.157326 systemd[1]: Stopped ignition-setup-pre.service - Ignition env setup. Sep 11 18:01:54.167000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-setup-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.161969 systemd[1]: initrd-setup-root.service: Deactivated successfully. Sep 11 18:01:54.162043 systemd[1]: Stopped initrd-setup-root.service - Root filesystem setup. Sep 11 18:01:54.169629 systemd[1]: Stopping systemd-networkd.service - Network Management... Sep 11 18:01:54.177242 systemd[1]: Stopping systemd-resolved.service - Network Name Resolution... Sep 11 18:01:54.191594 systemd[1]: systemd-resolved.service: Deactivated successfully. Sep 11 18:01:54.191858 systemd[1]: Stopped systemd-resolved.service - Network Name Resolution. Sep 11 18:01:54.194000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.200000 audit: BPF prog-id=5 op=UNLOAD Sep 11 18:01:54.203020 systemd[1]: systemd-networkd.service: Deactivated successfully. Sep 11 18:01:54.205478 systemd[1]: Stopped systemd-networkd.service - Network Management. Sep 11 18:01:54.211000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.215000 audit: BPF prog-id=8 op=UNLOAD Sep 11 18:01:54.217621 systemd[1]: systemd-networkd-resolve-hook.socket: Deactivated successfully. Sep 11 18:01:54.217725 systemd[1]: Closed systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 11 18:01:54.223029 systemd[1]: Stopped target network-pre.target - Preparation for Network. Sep 11 18:01:54.225630 systemd[1]: systemd-networkd.socket: Deactivated successfully. Sep 11 18:01:54.225701 systemd[1]: Closed systemd-networkd.socket - Network Management Netlink Socket. Sep 11 18:01:54.240836 systemd[1]: Stopping network-cleanup.service - Network Cleanup... Sep 11 18:01:54.247000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=parse-ip-for-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.242904 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Sep 11 18:01:54.242986 systemd[1]: Stopped parse-ip-for-networkd.service - Write systemd-networkd units from cmdline. Sep 11 18:01:54.248716 systemd[1]: Stopping systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 18:01:54.297537 systemd[1]: systemd-udevd.service: Deactivated successfully. Sep 11 18:01:54.306618 systemd[1]: Stopped systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 18:01:54.309000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.310933 systemd[1]: systemd-udevd.service: Consumed 2.653s CPU time over 10.623s wall clock time. Sep 11 18:01:54.317000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.318000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.318000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.311852 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Sep 11 18:01:54.312000 systemd[1]: Closed systemd-udevd-control.socket - udev Control Socket. Sep 11 18:01:54.318468 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Sep 11 18:01:54.318558 systemd[1]: Stopped dracut-pre-udev.service - dracut pre-udev hook. Sep 11 18:01:54.319193 systemd[1]: dracut-cmdline.service: Deactivated successfully. Sep 11 18:01:54.319252 systemd[1]: Stopped dracut-cmdline.service - dracut cmdline hook. Sep 11 18:01:54.347000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.319876 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Sep 11 18:01:54.319934 systemd[1]: Stopped dracut-cmdline-ask.service - dracut ask for additional cmdline parameters. Sep 11 18:01:54.355000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.330693 systemd[1]: Starting initrd-udevadm-cleanup-db.service - Cleanup udev Database... Sep 11 18:01:54.336162 systemd[1]: systemd-network-generator.service: Deactivated successfully. Sep 11 18:01:54.364000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.336266 systemd[1]: Stopped systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 11 18:01:54.349587 systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully. Sep 11 18:01:54.372000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.349686 systemd[1]: Stopped systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 18:01:54.377000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.357108 systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully. Sep 11 18:01:54.357187 systemd[1]: Stopped systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 11 18:01:54.366684 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Sep 11 18:01:54.388000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=network-cleanup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.366752 systemd[1]: Stopped kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 18:01:54.374874 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Sep 11 18:01:54.374943 systemd[1]: Stopped systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 18:01:54.380731 systemd[1]: network-cleanup.service: Deactivated successfully. Sep 11 18:01:54.382571 systemd[1]: Stopped network-cleanup.service - Network Cleanup. Sep 11 18:01:54.420842 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Sep 11 18:01:54.421340 systemd[1]: Finished initrd-udevadm-cleanup-db.service - Cleanup udev Database. Sep 11 18:01:54.429000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.429000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=initrd-udevadm-cleanup-db comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:54.431093 systemd[1]: Reached target initrd-switch-root.target - Switch Root. Sep 11 18:01:54.434654 systemd[1]: Starting initrd-switch-root.service - Switch Root... Sep 11 18:01:54.468770 systemd[1]: Switching root. Sep 11 18:01:54.512334 systemd-journald[336]: Journal stopped Sep 11 18:01:59.609988 systemd-journald[336]: Received SIGTERM from PID 1 (systemd). Sep 11 18:01:59.610117 kernel: SELinux: policy capability network_peer_controls=1 Sep 11 18:01:59.610167 kernel: SELinux: policy capability open_perms=1 Sep 11 18:01:59.610208 kernel: SELinux: policy capability extended_socket_class=1 Sep 11 18:01:59.610242 kernel: SELinux: policy capability always_check_network=0 Sep 11 18:01:59.610274 kernel: SELinux: policy capability cgroup_seclabel=1 Sep 11 18:01:59.610305 kernel: SELinux: policy capability nnp_nosuid_transition=1 Sep 11 18:01:59.610336 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Sep 11 18:01:59.610366 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Sep 11 18:01:59.620131 kernel: SELinux: policy capability userspace_initial_context=0 Sep 11 18:01:59.622469 systemd[1]: Successfully loaded SELinux policy in 150.561ms. Sep 11 18:01:59.622533 systemd[1]: Relabeled /dev/, /dev/shm/, /run/ in 21.804ms. Sep 11 18:01:59.622571 systemd[1]: systemd 260.4 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +IPE +SMACK +SECCOMP -GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL +ELFUTILS -FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE) Sep 11 18:01:59.622605 systemd[1]: Detected virtualization amazon. Sep 11 18:01:59.622636 systemd[1]: Detected architecture arm64. Sep 11 18:01:59.622666 systemd[1]: Detected first boot. Sep 11 18:01:59.622704 systemd[1]: Initializing machine ID from SMBIOS/DMI UUID. Sep 11 18:01:59.622736 zram_generator::config[1431]: No configuration found. Sep 11 18:01:59.622790 kernel: NET: Registered PF_VSOCK protocol family Sep 11 18:01:59.622822 systemd[1]: Applying preset policy. Sep 11 18:01:59.622856 systemd[1]: Created symlink '/etc/systemd/system/multi-user.target.wants/etcd-member.service' → '/usr/lib/systemd/system/etcd-member.service'. Sep 11 18:01:59.622896 systemd[1]: Populated /etc with preset unit settings. Sep 11 18:01:59.622930 kernel: kauditd_printk_skb: 32 callbacks suppressed Sep 11 18:01:59.622962 kernel: audit: type=1334 audit(1789149718.853:85): prog-id=10 op=LOAD Sep 11 18:01:59.622993 kernel: audit: type=1334 audit(1789149718.856:86): prog-id=2 op=UNLOAD Sep 11 18:01:59.623023 kernel: audit: type=1334 audit(1789149718.857:87): prog-id=11 op=LOAD Sep 11 18:01:59.623052 kernel: audit: type=1334 audit(1789149718.857:88): prog-id=12 op=LOAD Sep 11 18:01:59.623080 kernel: audit: type=1334 audit(1789149718.857:89): prog-id=3 op=UNLOAD Sep 11 18:01:59.623107 kernel: audit: type=1334 audit(1789149718.857:90): prog-id=4 op=UNLOAD Sep 11 18:01:59.623146 kernel: audit: type=1334 audit(1789149718.859:91): prog-id=13 op=LOAD Sep 11 18:01:59.623178 kernel: audit: type=1334 audit(1789149718.859:92): prog-id=10 op=UNLOAD Sep 11 18:01:59.623211 kernel: audit: type=1334 audit(1789149718.860:93): prog-id=14 op=LOAD Sep 11 18:01:59.623240 kernel: audit: type=1334 audit(1789149718.862:94): prog-id=15 op=LOAD Sep 11 18:01:59.623270 systemd[1]: initrd-switch-root.service: Deactivated successfully. Sep 11 18:01:59.623302 systemd[1]: Stopped initrd-switch-root.service - Switch Root. Sep 11 18:01:59.623336 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Sep 11 18:01:59.623370 systemd[1]: Created slice system-addon\x2dconfig.slice - Slice /system/addon-config. Sep 11 18:01:59.623426 systemd[1]: Created slice system-addon\x2drun.slice - Slice /system/addon-run. Sep 11 18:01:59.623456 systemd[1]: Created slice system-getty.slice - Slice /system/getty. Sep 11 18:01:59.623488 systemd[1]: Created slice system-modprobe.slice - Slice /system/modprobe. Sep 11 18:01:59.623521 systemd[1]: Created slice system-serial\x2dgetty.slice - Slice /system/serial-getty. Sep 11 18:01:59.623551 systemd[1]: Created slice system-system\x2dcloudinit.slice - Slice /system/system-cloudinit. Sep 11 18:01:59.623586 systemd[1]: Created slice system-systemd\x2dfsck.slice - Slice /system/systemd-fsck. Sep 11 18:01:59.623619 systemd[1]: Created slice user.slice - User and Session Slice. Sep 11 18:01:59.623649 systemd[1]: Started clevis-luks-askpass.path - Forward Password Requests to Clevis Directory Watch. Sep 11 18:01:59.623681 systemd[1]: Started systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch. Sep 11 18:01:59.623711 systemd[1]: Started systemd-ask-password-wall.path - Forward Password Requests to Wall Directory Watch. Sep 11 18:01:59.623744 systemd[1]: Set up automount boot.automount - Boot partition Automount Point. Sep 11 18:01:59.623775 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount - Arbitrary Executable File Formats File System Automount Point. Sep 11 18:01:59.623812 systemd[1]: Expecting device dev-disk-by\x2dlabel-OEM.device - /dev/disk/by-label/OEM... Sep 11 18:01:59.623846 systemd[1]: Expecting device dev-ttyS0.device - /dev/ttyS0... Sep 11 18:01:59.623877 systemd[1]: Reached target cryptsetup-pre.target - Local Encrypted Volumes (Pre). Sep 11 18:01:59.623909 systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Sep 11 18:01:59.623939 systemd[1]: Reached target imports.target - Image Downloads. Sep 11 18:01:59.623969 systemd[1]: Stopped target initrd-switch-root.target - Switch Root. Sep 11 18:01:59.624002 systemd[1]: Stopped target initrd-fs.target - Initrd File Systems. Sep 11 18:01:59.624035 systemd[1]: Stopped target initrd-root-fs.target - Initrd Root File System. Sep 11 18:01:59.624068 systemd[1]: Reached target integritysetup.target - Local Integrity Protected Volumes. Sep 11 18:01:59.624098 systemd[1]: Reached target remote-cryptsetup.target - Remote Encrypted Volumes. Sep 11 18:01:59.624129 systemd[1]: Reached target remote-fs.target - Remote File Systems. Sep 11 18:01:59.624159 systemd[1]: Reached target remote-integritysetup.target - Remote Integrity Protected Volumes. Sep 11 18:01:59.624192 systemd[1]: Reached target remote-veritysetup.target - Remote Verity Protected Volumes. Sep 11 18:01:59.624221 systemd[1]: Reached target slices.target - Slice Units. Sep 11 18:01:59.624255 systemd[1]: Reached target swap.target - Swaps. Sep 11 18:01:59.624285 systemd[1]: Reached target veritysetup.target - Local Verity Protected Volumes. Sep 11 18:01:59.624314 systemd[1]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 11 18:01:59.624344 systemd[1]: Listening on systemd-coredump.socket - Process Core Dump Socket. Sep 11 18:01:59.628419 systemd[1]: Listening on systemd-creds.socket - Credential Encryption/Decryption. Sep 11 18:01:59.628488 systemd[1]: Listening on systemd-factory-reset.socket - Factory Reset Management. Sep 11 18:01:59.628519 systemd[1]: Listening on systemd-journald-audit.socket - Journal Audit Socket. Sep 11 18:01:59.628561 systemd[1]: Listening on systemd-mountfsd.socket - DDI File System Mounter Socket. Sep 11 18:01:59.628593 systemd[1]: Listening on systemd-mute-console.socket - Console Output Muting Service Socket. Sep 11 18:01:59.628624 systemd[1]: Listening on systemd-networkd-varlink-metrics.socket - Network Management Metrics Varlink Socket. Sep 11 18:01:59.628653 systemd[1]: Listening on systemd-networkd-varlink.socket - Network Management Varlink Socket. Sep 11 18:01:59.628685 systemd[1]: Listening on systemd-networkd.socket - Network Management Netlink Socket. Sep 11 18:01:59.628714 systemd[1]: Listening on systemd-nsresourced.socket - Namespace Resource Manager Socket. Sep 11 18:01:59.628747 systemd[1]: Listening on systemd-oomd.socket - Userspace Out-Of-Memory (OOM) Killer Socket. Sep 11 18:01:59.628780 systemd[1]: Listening on systemd-repart.socket - Disk Repartitioning Service Socket. Sep 11 18:01:59.628810 systemd[1]: Listening on systemd-resolved-monitor.socket - Resolve Monitor Varlink Socket. Sep 11 18:01:59.628841 systemd[1]: Listening on systemd-resolved-varlink.socket - Resolve Service Varlink Socket. Sep 11 18:01:59.628872 systemd[1]: Listening on systemd-udevd-control.socket - udev Control Socket. Sep 11 18:01:59.628904 systemd[1]: Listening on systemd-udevd-varlink.socket - udev Varlink Socket. Sep 11 18:01:59.628933 systemd[1]: Listening on systemd-userdbd.socket - User Database Manager Socket. Sep 11 18:01:59.628965 systemd[1]: Mounting dev-hugepages.mount - Huge Pages File System... Sep 11 18:01:59.629001 systemd[1]: Mounting dev-mqueue.mount - POSIX Message Queue File System... Sep 11 18:01:59.629031 systemd[1]: Mounting media.mount - External Media Directory... Sep 11 18:01:59.629115 systemd[1]: Mounting sys-kernel-debug.mount - Kernel Debug File System... Sep 11 18:01:59.629149 systemd[1]: Mounting sys-kernel-tracing.mount - Kernel Trace File System... Sep 11 18:01:59.629179 systemd[1]: tmp.mount: x-systemd.graceful-option=usrquota specified, but option is not available, suppressing. Sep 11 18:01:59.629208 systemd[1]: Mounting tmp.mount - Temporary Directory /tmp... Sep 11 18:01:59.629237 systemd[1]: Starting flatcar-tmpfiles.service - Create missing system files... Sep 11 18:01:59.629277 systemd[1]: ignition-delete-config.service - Ignition (delete config) skipped, no trigger condition checks were met. Sep 11 18:01:59.629315 systemd[1]: Starting kmod-static-nodes.service - Create List of Static Device Nodes... Sep 11 18:01:59.629349 systemd[1]: Starting modprobe@configfs.service - Load Kernel Module configfs... Sep 11 18:01:59.629409 systemd[1]: modprobe@drm.service - Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm Sep 11 18:01:59.629445 systemd[1]: Starting modprobe@efi_pstore.service - Load Kernel Module efi_pstore... Sep 11 18:01:59.629477 systemd[1]: Starting modprobe@fuse.service - Load Kernel Module fuse... Sep 11 18:01:59.629507 systemd[1]: setup-nsswitch.service - Create /etc/nsswitch.conf skipped, unmet condition check ConditionPathExists=!/etc/nsswitch.conf Sep 11 18:01:59.629544 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Sep 11 18:01:59.629574 systemd[1]: Stopped systemd-fsck-root.service - File System Check on Root Device. Sep 11 18:01:59.629605 systemd[1]: systemd-hibernate-clear.service - Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67 Sep 11 18:01:59.629637 systemd[1]: Starting systemd-journald.service - Journal Service... Sep 11 18:01:59.629667 systemd[1]: Starting systemd-modules-load.service - Load Kernel Modules... Sep 11 18:01:59.629699 systemd[1]: Starting systemd-network-generator.service - Generate Network Units from Kernel Command Line... Sep 11 18:01:59.629731 systemd[1]: Reached target time-set.target - System Time Set. Sep 11 18:01:59.629764 systemd[1]: Starting systemd-remount-fs.service - Remount Root and Kernel File Systems... Sep 11 18:01:59.629797 systemd[1]: Starting systemd-udev-load-credentials.service - Load udev Rules from Credentials... Sep 11 18:01:59.629826 systemd[1]: Starting systemd-udev-trigger.service - Coldplug All udev Devices... Sep 11 18:01:59.629860 systemd[1]: Mounted dev-hugepages.mount - Huge Pages File System. Sep 11 18:01:59.629890 systemd[1]: Mounted dev-mqueue.mount - POSIX Message Queue File System. Sep 11 18:01:59.629919 systemd[1]: Mounted media.mount - External Media Directory. Sep 11 18:01:59.629954 systemd[1]: Mounted sys-kernel-debug.mount - Kernel Debug File System. Sep 11 18:01:59.629984 systemd[1]: Mounted sys-kernel-tracing.mount - Kernel Trace File System. Sep 11 18:01:59.630014 systemd[1]: Mounted tmp.mount - Temporary Directory /tmp. Sep 11 18:01:59.630043 systemd[1]: Finished kmod-static-nodes.service - Create List of Static Device Nodes. Sep 11 18:01:59.630075 systemd[1]: modprobe@configfs.service: Deactivated successfully. Sep 11 18:01:59.630112 systemd[1]: Finished modprobe@configfs.service - Load Kernel Module configfs. Sep 11 18:01:59.630146 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Sep 11 18:01:59.630177 systemd[1]: Finished modprobe@efi_pstore.service - Load Kernel Module efi_pstore. Sep 11 18:01:59.630206 kernel: fuse: init (API version 7.41) Sep 11 18:01:59.630243 systemd[1]: Finished systemd-network-generator.service - Generate Network Units from Kernel Command Line. Sep 11 18:01:59.630273 systemd[1]: modprobe@fuse.service: Deactivated successfully. Sep 11 18:01:59.630305 systemd[1]: Finished modprobe@fuse.service - Load Kernel Module fuse. Sep 11 18:01:59.630337 systemd[1]: Finished systemd-modules-load.service - Load Kernel Modules. Sep 11 18:01:59.630367 systemd[1]: Finished systemd-remount-fs.service - Remount Root and Kernel File Systems. Sep 11 18:01:59.634540 systemd-journald[1503]: Collecting audit messages is enabled. Sep 11 18:01:59.634616 systemd[1]: Reached target network-pre.target - Preparation for Network. Sep 11 18:01:59.634655 systemd[1]: Listening on systemd-networkd-resolve-hook.socket - Network Management Resolve Hook Socket. Sep 11 18:01:59.634686 systemd[1]: Mounting sys-fs-fuse-connections.mount - FUSE Control File System... Sep 11 18:01:59.634722 systemd-journald[1503]: Journal started Sep 11 18:01:59.634769 systemd-journald[1503]: Runtime Journal (/run/log/journal/ec20d9574696453c452a6a34a645f3a2) is 8M, max 75.3M, 67.3M free. Sep 11 18:01:59.159000 audit[1]: EVENT_LISTENER pid=1 uid=0 auid=4294967295 tty=(none) ses=4294967295 subj=system_u:system_r:kernel_t:s0 comm="systemd" exe="/usr/lib/systemd/systemd" nl-mcgrp=1 op=connect res=1 Sep 11 18:01:59.390000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.403000 audit: BPF prog-id=18 op=UNLOAD Sep 11 18:01:59.403000 audit: BPF prog-id=17 op=UNLOAD Sep 11 18:01:59.404000 audit: BPF prog-id=19 op=LOAD Sep 11 18:01:59.404000 audit: BPF prog-id=20 op=LOAD Sep 11 18:01:59.405000 audit: BPF prog-id=21 op=LOAD Sep 11 18:01:59.539000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.555000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.555000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@configfs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.566000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.566000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@efi_pstore comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.575000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-network-generator comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.586000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.586000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@fuse comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.594000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.601000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Sep 11 18:01:59.601000 audit[1503]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=4 a1=fffff5fdd310 a2=4000 a3=0 items=0 ppid=1 pid=1503 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="systemd-journal" exe="/usr/lib/systemd/systemd-journald" subj=system_u:system_r:kernel_t:s0 key=(null) Sep 11 18:01:59.601000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Sep 11 18:01:59.606000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-remount-fs comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:58.843145 systemd[1]: Queued start job for default target multi-user.target. Sep 11 18:01:58.871255 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device - /dev/nvme0n1p6. Sep 11 18:01:58.872066 systemd[1]: systemd-journald.service: Deactivated successfully. Sep 11 18:01:59.642659 systemd[1]: Mounting sys-kernel-config.mount - Kernel Configuration File System... Sep 11 18:01:59.519794 systemd-modules-load[1504]: Using 2 probe threads Sep 11 18:01:59.643026 systemd[1]: remount-root.service - Remount Root File System skipped, unmet condition check ConditionPathIsReadWrite=!/ Sep 11 18:01:59.658610 systemd[1]: Starting systemd-hwdb-update.service - Rebuild Hardware Database... Sep 11 18:01:59.666796 systemd[1]: systemd-pstore.service - Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore Sep 11 18:01:59.681015 systemd[1]: Starting systemd-random-seed.service - Load/Save OS Random Seed... Sep 11 18:01:59.693527 systemd[1]: Starting systemd-sysctl.service - Apply Kernel Variables... Sep 11 18:01:59.703424 systemd[1]: Starting systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully... Sep 11 18:01:59.710000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.712535 systemd[1]: Started systemd-journald.service - Journal Service. Sep 11 18:01:59.719000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.717069 systemd[1]: Finished systemd-udev-load-credentials.service - Load udev Rules from Credentials. Sep 11 18:01:59.723787 systemd[1]: Mounted sys-fs-fuse-connections.mount - FUSE Control File System. Sep 11 18:01:59.728126 systemd[1]: Mounted sys-kernel-config.mount - Kernel Configuration File System. Sep 11 18:01:59.783068 systemd[1]: Starting systemd-journal-flush.service - Flush Journal to Persistent Storage... Sep 11 18:01:59.800000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-random-seed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.798939 systemd[1]: Finished systemd-random-seed.service - Load/Save OS Random Seed. Sep 11 18:01:59.802259 systemd[1]: Reached target first-boot-complete.target - First Boot Complete. Sep 11 18:01:59.886863 systemd-journald[1503]: Time spent on flushing to /var/log/journal/ec20d9574696453c452a6a34a645f3a2 is 72.149ms for 1134 entries. Sep 11 18:01:59.886863 systemd-journald[1503]: System Journal (/var/log/journal/ec20d9574696453c452a6a34a645f3a2) is 8M, max 588.1M, 580.1M free. Sep 11 18:01:59.929000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.938000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:01:59.907657 systemd-tmpfiles[1524]: ACLs are not supported, ignoring. Sep 11 18:01:59.999054 systemd-journald[1503]: Received client request to flush runtime journal. Sep 11 18:01:59.907682 systemd-tmpfiles[1524]: ACLs are not supported, ignoring. Sep 11 18:01:59.927684 systemd[1]: Finished systemd-sysctl.service - Apply Kernel Variables. Sep 11 18:01:59.936593 systemd[1]: Finished systemd-tmpfiles-setup-dev-early.service - Create Static Device Nodes in /dev gracefully. Sep 11 18:02:00.004662 systemd[1]: Finished systemd-journal-flush.service - Flush Journal to Persistent Storage. Sep 11 18:02:00.008000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-flush comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.131247 systemd[1]: Finished flatcar-tmpfiles.service - Create missing system files. Sep 11 18:02:00.132000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=flatcar-tmpfiles comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.139770 systemd[1]: Starting systemd-sysusers.service - Create System Users... Sep 11 18:02:00.168610 systemd[1]: Finished systemd-udev-trigger.service - Coldplug All udev Devices. Sep 11 18:02:00.170000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.234760 systemd[1]: Finished systemd-sysusers.service - Create System Users. Sep 11 18:02:00.237000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysusers comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.245853 systemd[1]: Starting systemd-journalctl.socket - Journal Log Access Socket... Sep 11 18:02:00.254000 audit: BPF prog-id=22 op=LOAD Sep 11 18:02:00.255000 audit: BPF prog-id=23 op=LOAD Sep 11 18:02:00.255000 audit: BPF prog-id=24 op=LOAD Sep 11 18:02:00.259737 systemd[1]: Starting systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer... Sep 11 18:02:00.264000 audit: BPF prog-id=25 op=LOAD Sep 11 18:02:00.268031 systemd[1]: Starting systemd-resolved.service - Network Name Resolution... Sep 11 18:02:00.280822 systemd[1]: Starting systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev... Sep 11 18:02:00.284625 systemd[1]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 11 18:02:00.301000 audit: BPF prog-id=26 op=LOAD Sep 11 18:02:00.302000 audit: BPF prog-id=27 op=LOAD Sep 11 18:02:00.304000 audit: BPF prog-id=28 op=LOAD Sep 11 18:02:00.307935 systemd[1]: Starting systemd-userdbd.service - User Database Manager... Sep 11 18:02:00.320924 systemd[1]: Starting modprobe@tun.service - Load Kernel Module tun... Sep 11 18:02:00.371542 systemd-tmpfiles[1573]: ACLs are not supported, ignoring. Sep 11 18:02:00.371585 systemd-tmpfiles[1573]: ACLs are not supported, ignoring. Sep 11 18:02:00.381841 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 1574 ((systemd-userd)) Sep 11 18:02:00.384544 systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Sep 11 18:02:00.391640 systemd[1]: Finished systemd-tmpfiles-setup-dev.service - Create Static Device Nodes in /dev. Sep 11 18:02:00.393000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.400835 systemd[1]: Reached target local-fs-pre.target - Preparation for Local File Systems. Sep 11 18:02:00.403888 systemd[1]: var-lib-machines.mount - Virtual Machine and Container Storage (Compatibility) skipped, unmet condition check ConditionPathExists=/var/lib/machines.raw Sep 11 18:02:00.403962 systemd[1]: Reached target local-fs.target - Local File Systems. Sep 11 18:02:00.406551 systemd[1]: Reached target machines.target - Virtual Machines and Containers. Sep 11 18:02:00.411175 systemd[1]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 11 18:02:00.418709 systemd[1]: Listening on systemd-sysext.socket - System Extension Image Management. Sep 11 18:02:00.427317 systemd[1]: Starting systemd-confext.service - Merge System Configuration Images into /etc/... Sep 11 18:02:00.430875 kernel: tun: Universal TUN/TAP device driver, 1.6 Sep 11 18:02:00.437924 systemd[1]: Starting systemd-machine-id-commit.service - Save Transient machine-id to Disk... Sep 11 18:02:00.440910 systemd[1]: systemd-repart.service - Repartition Root Disk skipped, no trigger condition checks were met. Sep 11 18:02:00.457000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.457000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@tun comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.447898 systemd[1]: Starting systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials... Sep 11 18:02:00.452866 systemd[1]: modprobe@tun.service: Deactivated successfully. Sep 11 18:02:00.455529 systemd[1]: Finished modprobe@tun.service - Load Kernel Module tun. Sep 11 18:02:00.464000 audit: BPF prog-id=29 op=LOAD Sep 11 18:02:00.464000 audit: BPF prog-id=30 op=LOAD Sep 11 18:02:00.464000 audit: BPF prog-id=31 op=LOAD Sep 11 18:02:00.471922 systemd[1]: Starting systemd-nsresourced.service - Namespace Resource Manager... Sep 11 18:02:00.480035 systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Sep 11 18:02:00.485931 systemd[1]: systemd-binfmt.service - Set Up Additional Binary Formats skipped, no trigger condition checks were met. Sep 11 18:02:00.568789 systemd[1]: Finished systemd-machine-id-commit.service - Save Transient machine-id to Disk. Sep 11 18:02:00.567000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-machine-id-commit comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.600651 systemd[1]: Finished systemd-userdb-load-credentials.service - Load JSON user/group Records from Credentials. Sep 11 18:02:00.602000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdb-load-credentials comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.607000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-userdbd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.604052 systemd[1]: Started systemd-userdbd.service - User Database Manager. Sep 11 18:02:00.624437 kernel: loop4: detected capacity change from 0 to 44360 Sep 11 18:02:00.637976 kernel: loop4: p1 p2 p3 Sep 11 18:02:00.682055 systemd-nsresourced[1583]: Not setting up BPF subsystem, as functionality has been disabled at compile time. Sep 11 18:02:00.685652 systemd[1]: Started systemd-nsresourced.service - Namespace Resource Manager. Sep 11 18:02:00.687000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-nsresourced comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.712436 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:00.712567 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:00.714460 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:00.717723 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:00.717912 systemd-confext[1587]: device-mapper: reload ioctl on loop4p1-51-verity (254:5) failed: Invalid argument Sep 11 18:02:00.731452 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:00.880101 systemd-resolved[1572]: Positive Trust Anchors: Sep 11 18:02:00.880911 systemd-resolved[1572]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Sep 11 18:02:00.881035 systemd-resolved[1572]: . IN DS 38696 8 2 683d2d0acb8c9b712a1948b27f741219298d0a450d612c483af444a4c0fb2b16 Sep 11 18:02:00.881216 systemd-resolved[1572]: 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 11 18:02:00.886969 systemd-oomd[1571]: No swap; memory pressure usage will be degraded Sep 11 18:02:00.891106 systemd[1]: Started systemd-oomd.service - Userspace Out-Of-Memory (OOM) Killer. Sep 11 18:02:00.892000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-oomd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.895659 systemd-resolved[1572]: Defaulting to hostname 'linux'. Sep 11 18:02:00.898967 systemd[1]: Started systemd-resolved.service - Network Name Resolution. Sep 11 18:02:00.901895 systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Sep 11 18:02:00.900000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-resolved comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:00.985264 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Sep 11 18:02:01.203556 systemd[1]: Finished systemd-hwdb-update.service - Rebuild Hardware Database. Sep 11 18:02:01.204000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hwdb-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:01.206000 audit: BPF prog-id=7 op=UNLOAD Sep 11 18:02:01.206000 audit: BPF prog-id=6 op=UNLOAD Sep 11 18:02:01.207000 audit: BPF prog-id=32 op=LOAD Sep 11 18:02:01.207000 audit: BPF prog-id=33 op=LOAD Sep 11 18:02:01.210493 systemd[1]: Starting systemd-udevd.service - Rule-based Manager for Device Events and Files... Sep 11 18:02:01.397645 systemd-udevd[1607]: Using default interface naming scheme 'v260'. Sep 11 18:02:01.659518 systemd[1]: Started systemd-udevd.service - Rule-based Manager for Device Events and Files. Sep 11 18:02:01.662000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:01.667000 audit: BPF prog-id=34 op=LOAD Sep 11 18:02:01.673740 systemd[1]: Starting systemd-networkd.service - Network Management... Sep 11 18:02:01.927645 (udev-worker)[1620]: Network interface NamePolicy= disabled on kernel command line. Sep 11 18:02:01.928155 systemd[1]: Condition check resulted in dev-ttyS0.device - /dev/ttyS0 being skipped. Sep 11 18:02:01.948050 systemd-networkd[1609]: lo: Link UP Sep 11 18:02:01.948075 systemd-networkd[1609]: lo: Gained carrier Sep 11 18:02:01.951000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:01.950176 systemd[1]: Started systemd-networkd.service - Network Management. Sep 11 18:02:01.952883 systemd[1]: Reached target network.target - Network. Sep 11 18:02:01.957908 systemd[1]: Starting systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd... Sep 11 18:02:01.969821 systemd[1]: Starting systemd-networkd-wait-online.service - Wait for Network to be Online... Sep 11 18:02:02.066519 systemd[1]: Finished systemd-networkd-persistent-storage.service - Enable Persistent Storage in systemd-networkd. Sep 11 18:02:02.068000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-persistent-storage comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:02.118824 systemd-networkd[1609]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 11 18:02:02.118852 systemd-networkd[1609]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Sep 11 18:02:02.139935 systemd-networkd[1609]: eth0: Link UP Sep 11 18:02:02.140241 systemd-networkd[1609]: eth0: Gained carrier Sep 11 18:02:02.140279 systemd-networkd[1609]: eth0: Found matching .network file, based on potentially unpredictable interface name: /usr/lib/systemd/network/zz-default.network Sep 11 18:02:02.151537 systemd-networkd[1609]: eth0: DHCPv4 address 172.31.21.19/20, gateway 172.31.16.1 acquired from 172.31.16.1 Sep 11 18:02:02.410914 systemd[1]: Starting systemd-vconsole-setup.service - Virtual Console Setup... Sep 11 18:02:02.718988 systemd-vconsole-setup[1664]: Configuration of first virtual console was skipped, ignoring remaining ones. Sep 11 18:02:02.736429 systemd[1]: Finished systemd-vconsole-setup.service - Virtual Console Setup. Sep 11 18:02:02.738000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:02.785158 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 11 18:02:02.825719 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device - Amazon Elastic Block Store OEM. Sep 11 18:02:02.832706 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM... Sep 11 18:02:02.858505 kernel: loop4: detected capacity change from 0 to 44360 Sep 11 18:02:02.871599 kernel: loop4: p1 p2 p3 Sep 11 18:02:02.893451 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:02.893548 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:02.899331 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:02.904720 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:02.905555 (sd-merge)[1752]: device-mapper: reload ioctl on loop4p1-56-verity (254:5) failed: Invalid argument Sep 11 18:02:02.915478 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:02.927621 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service - File System Check on /dev/disk/by-label/OEM. Sep 11 18:02:02.929000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck@dev-disk-by\x2dlabel-OEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:02.959468 kernel: erofs: (device dm-5): mounted with root inode @ nid 40. Sep 11 18:02:02.960634 (sd-merge)[1752]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 11 18:02:02.968187 systemd[1]: Finished systemd-confext.service - Merge System Configuration Images into /etc/. Sep 11 18:02:02.967000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-confext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:02.981508 systemd[1]: Starting systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/... Sep 11 18:02:03.022444 kernel: loop4: detected capacity change from 0 to 364432 Sep 11 18:02:03.032450 kernel: loop4: p1 p2 p3 Sep 11 18:02:03.055662 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.055807 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.057774 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.059212 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.059438 systemd-sysext[1763]: device-mapper: reload ioctl on loop4p1-60-verity (254:5) failed: Invalid argument Sep 11 18:02:03.073411 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.150687 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 11 18:02:03.183438 kernel: loop4: detected capacity change from 0 to 281976 Sep 11 18:02:03.191525 kernel: loop4: p1 p2 p3 Sep 11 18:02:03.205844 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.205986 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.208024 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.210034 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.209987 systemd-sysext[1763]: device-mapper: reload ioctl on loop4p1-65-verity (254:5) failed: Invalid argument Sep 11 18:02:03.220452 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.303521 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 11 18:02:03.337454 kernel: loop4: detected capacity change from 0 to 172472 Sep 11 18:02:03.343678 kernel: loop4: p1 p2 p3 Sep 11 18:02:03.357611 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.357746 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.357799 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.359483 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.362493 systemd-sysext[1763]: device-mapper: reload ioctl on loop4p1-70-verity (254:5) failed: Invalid argument Sep 11 18:02:03.370499 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.437449 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 11 18:02:03.469443 kernel: loop4: detected capacity change from 0 to 364432 Sep 11 18:02:03.479429 kernel: loop4: p1 p2 p3 Sep 11 18:02:03.504613 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.504719 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.507633 kernel: device-mapper: table: 254:5: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.509232 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.509470 (sd-merge)[1788]: device-mapper: reload ioctl on loop4p1-75-verity (254:5) failed: Invalid argument Sep 11 18:02:03.519932 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.589658 kernel: erofs: (device dm-5): mounted with root inode @ nid 39. Sep 11 18:02:03.598433 kernel: loop5: detected capacity change from 0 to 281976 Sep 11 18:02:03.606272 kernel: loop5: p1 p2 p3 Sep 11 18:02:03.613579 systemd-networkd[1609]: eth0: Gained IPv6LL Sep 11 18:02:03.623483 systemd[1]: Finished systemd-networkd-wait-online.service - Wait for Network to be Online. Sep 11 18:02:03.623918 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.623977 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.624116 (sd-merge)[1788]: device-mapper: reload ioctl on loop5p1-79-verity (254:6) failed: Invalid argument Sep 11 18:02:03.625580 kernel: device-mapper: table: 254:6: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.625637 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.633524 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.632000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-networkd-wait-online comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:03.633997 systemd[1]: Reached target network-online.target - Network is Online. Sep 11 18:02:03.707432 kernel: erofs: (device dm-6): mounted with root inode @ nid 39. Sep 11 18:02:03.715420 kernel: loop6: detected capacity change from 0 to 172472 Sep 11 18:02:03.725442 kernel: loop6: p1 p2 p3 Sep 11 18:02:03.740131 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.740220 kernel: device-mapper: verity: Unrecognized verity feature request: root_hash_sig_key_desc Sep 11 18:02:03.742244 kernel: device-mapper: table: 254:7: verity: Unrecognized verity feature request (-EINVAL) Sep 11 18:02:03.743689 kernel: device-mapper: ioctl: error adding target to table Sep 11 18:02:03.743809 (sd-merge)[1788]: device-mapper: reload ioctl on loop6p1-83-verity (254:7) failed: Invalid argument Sep 11 18:02:03.753498 kernel: device-mapper: verity: sha256 using shash "sha256-ce" Sep 11 18:02:03.814424 kernel: erofs: (device dm-7): mounted with root inode @ nid 39. Sep 11 18:02:03.814198 (sd-merge)[1788]: Skipping extension refresh because no change was found, use --always-refresh=yes to always do a refresh. Sep 11 18:02:03.819764 systemd[1]: Finished systemd-sysext.service - Merge System Extension Images into /usr/ and /opt/. Sep 11 18:02:03.822000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-sysext comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:03.828619 systemd[1]: Starting systemd-tmpfiles-setup.service - Create System Files and Directories... Sep 11 18:02:03.887854 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/base_image_var.conf:29: Duplicate line for path "/var/log/audit", ignoring. Sep 11 18:02:03.892144 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/base_image_var_late.conf:44: Duplicate line for path "/var/log/audit", ignoring. Sep 11 18:02:03.893895 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/baselayout.conf:15: Duplicate line for path "/var", ignoring. Sep 11 18:02:03.893938 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/baselayout.conf:16: Duplicate line for path "/var/empty", ignoring. Sep 11 18:02:03.893978 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/baselayout.conf:21: Duplicate line for path "/var/log", ignoring. Sep 11 18:02:03.894239 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/dbus.conf:5: Duplicate line for path "/var/lib/dbus", ignoring. Sep 11 18:02:03.895300 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/nfs-utils.conf:2: Duplicate line for path "/var/lib/nfs/v4recovery", ignoring. Sep 11 18:02:03.897468 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/nfs-utils.conf:6: Duplicate line for path "/var/lib/nfs/sm", ignoring. Sep 11 18:02:03.897539 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/nfs-utils.conf:7: Duplicate line for path "/var/lib/nfs/sm.bak", ignoring. Sep 11 18:02:03.898115 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Sep 11 18:02:03.901111 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/tpm2-tss-fapi.conf:2: Duplicate line for path "/var/lib/tpm2-tss/system/keystore", ignoring. Sep 11 18:02:03.901151 systemd-tmpfiles[1813]: ACLs are not supported, ignoring. Sep 11 18:02:03.901310 systemd-tmpfiles[1813]: ACLs are not supported, ignoring. Sep 11 18:02:03.903212 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/var.conf:10: Duplicate line for path "/var", ignoring. Sep 11 18:02:03.903266 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/var.conf:14: Duplicate line for path "/var/log", ignoring. Sep 11 18:02:03.903579 systemd-tmpfiles[1813]: /usr/lib/tmpfiles.d/var.conf:21: Duplicate line for path "/var/lib", ignoring. Sep 11 18:02:03.913824 systemd-tmpfiles[1813]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 11 18:02:03.913850 systemd-tmpfiles[1813]: Skipping /boot Sep 11 18:02:03.938526 systemd-tmpfiles[1813]: Detected autofs mount point '/boot' during canonicalization of 'boot'. Sep 11 18:02:03.938725 systemd-tmpfiles[1813]: Skipping /boot Sep 11 18:02:03.970676 systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Sep 11 18:02:03.972000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:03.978322 kernel: kauditd_printk_skb: 74 callbacks suppressed Sep 11 18:02:03.978466 kernel: audit: type=1130 audit(1789149723.972:167): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-tmpfiles-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:03.982765 systemd[1]: Starting audit-rules.service - Load Audit Rules... Sep 11 18:02:03.991506 systemd[1]: Starting clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs... Sep 11 18:02:04.001709 systemd[1]: Starting ldconfig.service - Rebuild Dynamic Linker Cache... Sep 11 18:02:04.013952 systemd[1]: Starting systemd-journal-catalog-update.service - Rebuild Journal Catalog... Sep 11 18:02:04.022653 systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Sep 11 18:02:04.067000 audit[1819]: AUDIT1127 pid=1819 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.076507 kernel: audit: type=1127 audit(1789149724.067:168): pid=1819 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg=' comm="systemd-update-utmp" exe="/usr/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.080528 systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Sep 11 18:02:04.082000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.089430 kernel: audit: type=1130 audit(1789149724.082:169): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-update-utmp comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.120137 systemd[1]: Finished systemd-journal-catalog-update.service - Rebuild Journal Catalog. Sep 11 18:02:04.119000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.135775 kernel: audit: type=1130 audit(1789149724.119:170): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-journal-catalog-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.221622 systemd[1]: Finished clean-ca-certificates.service - Clean up broken links in /etc/ssl/certs. Sep 11 18:02:04.220000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.225161 systemd[1]: update-ca-certificates.service - Update CA bundle at /etc/ssl/certs/ca-certificates.crt skipped, unmet condition check ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt Sep 11 18:02:04.231447 kernel: audit: type=1130 audit(1789149724.220:171): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=clean-ca-certificates comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Sep 11 18:02:04.254000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 11 18:02:04.256650 augenrules[1843]: No rules Sep 11 18:02:04.254000 audit[1843]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffed3fd20 a2=420 a3=0 items=0 ppid=1815 pid=1843 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Sep 11 18:02:04.263137 systemd[1]: audit-rules.service: Deactivated successfully. Sep 11 18:02:04.264085 systemd[1]: Finished audit-rules.service - Load Audit Rules. Sep 11 18:02:04.254000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 11 18:02:04.266619 kernel: audit: type=1305 audit(1789149724.254:172): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Sep 11 18:02:04.266695 kernel: audit: type=1300 audit(1789149724.254:172): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=fffffed3fd20 a2=420 a3=0 items=0 ppid=1815 pid=1843 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="auditctl" exe="/usr/bin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Sep 11 18:02:04.266748 kernel: audit: type=1327 audit(1789149724.254:172): proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Sep 11 18:02:07.341971 ldconfig[1817]: ldconfig: /usr/lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Sep 11 18:02:07.350483 systemd[1]: Finished ldconfig.service - Rebuild Dynamic Linker Cache. Sep 11 18:02:07.356271 systemd[1]: Starting systemd-update-done.service - Update is Completed... Sep 11 18:02:07.385937 systemd[1]: Finished systemd-update-done.service - Update is Completed. Sep 11 18:02:07.389952 systemd[1]: Reached target sysinit.target - System Initialization. Sep 11 18:02:07.392591 systemd[1]: Started motdgen.path - Watch for update engine configuration changes. Sep 11 18:02:07.395463 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 11 18:02:07.398718 systemd[1]: Started logrotate.timer - Daily rotation of log files. Sep 11 18:02:07.401361 systemd[1]: Started mdadm.timer - Weekly check for MD array's redundancy information.. Sep 11 18:02:07.404195 systemd[1]: Started systemd-sysupdate-reboot.timer - Reboot Automatically After System Update. Sep 11 18:02:07.407802 systemd[1]: Started systemd-sysupdate.timer - Automatic System Update. Sep 11 18:02:07.410226 systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Sep 11 18:02:07.412923 systemd[1]: update-engine-stub.timer - Update Engine Stub Timer skipped, unmet condition check ConditionPathExists=/usr/.noupdate Sep 11 18:02:07.412975 systemd[1]: Reached target paths.target - Path Units. Sep 11 18:02:07.414975 systemd[1]: Reached target timers.target - Timer Units. Sep 11 18:02:07.418619 systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Sep 11 18:02:07.424167 systemd[1]: Starting docker.socket - Docker Socket for the API... Sep 11 18:02:07.430745 systemd[1]: Listening on sshd-unix-local.socket - OpenSSH Server Socket (systemd-ssh-generator, AF_UNIX Local). Sep 11 18:02:07.440421 systemd[1]: Listening on sshd.socket - OpenSSH Server Socket. Sep 11 18:02:07.443331 systemd[1]: Listening on systemd-hostnamed.socket - Hostname Service Socket. Sep 11 18:02:07.450348 systemd[1]: Listening on systemd-logind-varlink.socket - User Login Management Varlink Socket. Sep 11 18:02:07.453962 systemd[1]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 11 18:02:07.458248 systemd[1]: Listening on docker.socket - Docker Socket for the API. Sep 11 18:02:07.460886 systemd[1]: Reached target sockets.target - Socket Units. Sep 11 18:02:07.463177 systemd[1]: Reached target basic.target - Basic System. Sep 11 18:02:07.465440 systemd[1]: addon-config@oem.service - Configure Addon /oem skipped, no trigger condition checks were met. Sep 11 18:02:07.465516 systemd[1]: addon-run@oem.service - Run Addon /oem skipped, no trigger condition checks were met. Sep 11 18:02:07.467413 systemd[1]: Starting containerd.service - containerd container runtime... Sep 11 18:02:07.485869 systemd[1]: Starting coreos-metadata.service - Flatcar Metadata Agent... Sep 11 18:02:07.493837 systemd[1]: Starting dbus.service - D-Bus System Message Bus... Sep 11 18:02:07.501647 systemd[1]: Starting dracut-shutdown.service - Restore /run/initramfs on shutdown... Sep 11 18:02:07.514135 systemd[1]: Starting enable-oem-cloudinit.service - Enable cloudinit... Sep 11 18:02:07.520825 systemd[1]: Starting extend-filesystems.service - Extend Filesystems... Sep 11 18:02:07.523466 systemd[1]: flatcar-setup-environment.service - Modifies /etc/environment for CoreOS skipped, unmet condition check ConditionPathExists=/oem/bin/flatcar-setup-environment Sep 11 18:02:07.530758 systemd[1]: Starting motdgen.service - Generate /run/flatcar/motd... Sep 11 18:02:07.536350 systemd[1]: Started ntpd.service - Network Time Service. Sep 11 18:02:07.547810 systemd[1]: Starting nvidia.service - NVIDIA Configure Service... Sep 11 18:02:07.555781 systemd[1]: Starting setup-oem.service - Setup OEM... Sep 11 18:02:07.562889 systemd[1]: Starting ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline... Sep 11 18:02:07.570620 systemd[1]: Starting sshd-keygen.service - Generate sshd host keys... Sep 11 18:02:07.586417 systemd[1]: Starting systemd-logind.service - User Login Management... Sep 11 18:02:07.589818 systemd[1]: tcsd.service - TCG Core Services Daemon skipped, unmet condition check ConditionPathExists=/dev/tpm0 Sep 11 18:02:07.601781 systemd[1]: Starting update-engine.service - Update Engine... Sep 11 18:02:07.616577 systemd[1]: Starting update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition... Sep 11 18:02:07.626424 jq[1858]: false Sep 11 18:02:07.644068 systemd[1]: Finished dracut-shutdown.service - Restore /run/initramfs on shutdown. Sep 11 18:02:07.651314 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Sep 11 18:02:07.661679 motdgen[1879]: /oem/oem-release: line 2: EC2: command not found Sep 11 18:02:07.661885 jq[1869]: true Sep 11 18:02:07.653521 systemd[1]: Condition check resulted in enable-oem-cloudinit.service - Enable cloudinit being skipped. Sep 11 18:02:07.688133 systemd[1]: motdgen.service: Deactivated successfully. Sep 11 18:02:07.691719 systemd[1]: Finished motdgen.service - Generate /run/flatcar/motd. Sep 11 18:02:07.758068 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Sep 11 18:02:07.758977 systemd[1]: Finished ssh-key-proc-cmdline.service - Install an ssh key from /proc/cmdline. Sep 11 18:02:07.766426 extend-filesystems[1859]: Found /dev/nvme0n1p6 Sep 11 18:02:07.789073 jq[1880]: true Sep 11 18:02:07.792942 extend-filesystems[1859]: Found /dev/nvme0n1p9 Sep 11 18:02:07.811961 systemd[1]: Finished setup-oem.service - Setup OEM. Sep 11 18:02:07.816557 extend-filesystems[1859]: Checking size of /dev/nvme0n1p9 Sep 11 18:02:07.839988 systemd[1]: Started amazon-ssm-agent.service - amazon-ssm-agent. Sep 11 18:02:07.842957 ntpd[1861]: ntpd 4.2.8p18@1.4062-o Fri Sep 11 15:48:46 UTC 2026 (1): Starting Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: ntpd 4.2.8p18@1.4062-o Fri Sep 11 15:48:46 UTC 2026 (1): Starting Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: ---------------------------------------------------- Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: ntp-4 is maintained by Network Time Foundation, Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: corporation. Support and training for ntp-4 are Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: available at https://www.nwtime.org/support Sep 11 18:02:07.847170 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: ---------------------------------------------------- Sep 11 18:02:07.843057 ntpd[1861]: Command line: /usr/sbin/ntpd -g -n -u ntp:ntp Sep 11 18:02:07.843077 ntpd[1861]: ---------------------------------------------------- Sep 11 18:02:07.843094 ntpd[1861]: ntp-4 is maintained by Network Time Foundation, Sep 11 18:02:07.843110 ntpd[1861]: Inc. (NTF), a non-profit 501(c)(3) public-benefit Sep 11 18:02:07.843128 ntpd[1861]: corporation. Support and training for ntp-4 are Sep 11 18:02:07.843145 ntpd[1861]: available at https://www.nwtime.org/support Sep 11 18:02:07.843162 ntpd[1861]: ---------------------------------------------------- Sep 11 18:02:07.851017 ntpd[1861]: proto: precision = 0.096 usec (-23) Sep 11 18:02:07.853610 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: proto: precision = 0.096 usec (-23) Sep 11 18:02:07.853610 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: basedate set to 2026-08-30 Sep 11 18:02:07.853610 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: gps base set to 2026-08-30 (week 2434) Sep 11 18:02:07.853610 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen and drop on 0 v6wildcard [::]:123 Sep 11 18:02:07.853610 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 11 18:02:07.851459 ntpd[1861]: basedate set to 2026-08-30 Sep 11 18:02:07.851483 ntpd[1861]: gps base set to 2026-08-30 (week 2434) Sep 11 18:02:07.851663 ntpd[1861]: Listen and drop on 0 v6wildcard [::]:123 Sep 11 18:02:07.851708 ntpd[1861]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 11 18:02:07.854355 ntpd[1861]: Listen normally on 2 lo 127.0.0.1:123 Sep 11 18:02:07.856117 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen normally on 2 lo 127.0.0.1:123 Sep 11 18:02:07.856117 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen normally on 3 eth0 172.31.21.19:123 Sep 11 18:02:07.856117 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen normally on 4 lo [::1]:123 Sep 11 18:02:07.856117 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listen normally on 5 eth0 [fe80::4ff:fdff:fe82:f7ed%2]:123 Sep 11 18:02:07.856117 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: Listening on routing socket on fd #22 for interface updates Sep 11 18:02:07.854457 ntpd[1861]: Listen normally on 3 eth0 172.31.21.19:123 Sep 11 18:02:07.854511 ntpd[1861]: Listen normally on 4 lo [::1]:123 Sep 11 18:02:07.857213 systemd[1]: Finished nvidia.service - NVIDIA Configure Service. Sep 11 18:02:07.854559 ntpd[1861]: Listen normally on 5 eth0 [fe80::4ff:fdff:fe82:f7ed%2]:123 Sep 11 18:02:07.854606 ntpd[1861]: Listening on routing socket on fd #22 for interface updates Sep 11 18:02:07.880529 ntpd[1861]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 18:02:07.880722 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 18:02:07.880842 ntpd[1861]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 18:02:07.880943 ntpd[1861]: 11 Sep 18:02:07 ntpd[1861]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 11 18:02:07.895406 extend-filesystems[1859]: Resized partition /dev/nvme0n1p9 Sep 11 18:02:07.912844 update_engine[1868]: I20260911 18:02:07.909299 1868 main.cc:92] Flatcar Update Engine starting Sep 11 18:02:07.912475 systemd[1]: Started dbus.service - D-Bus System Message Bus. Sep 11 18:02:07.911973 dbus-daemon[1856]: [system] SELinux support is enabled Sep 11 18:02:07.915414 systemd[1]: system-cloudinit@usr-share-coreos-cloud\x2dconfig.yml.service - Load cloud-config from /usr/share/coreos/cloud-config.yml skipped, unmet condition check ConditionFileNotEmpty=/usr/share/coreos/cloud-config.yml Sep 11 18:02:07.915475 systemd[1]: Reached target system-config.target - Load system-provided cloud configs. Sep 11 18:02:07.918416 systemd[1]: user-cloudinit-proc-cmdline.service - Load cloud-config from url defined in /proc/cmdline skipped, unmet condition check ConditionKernelCommandLine=cloud-config-url Sep 11 18:02:07.918469 systemd[1]: Reached target user-config.target - Load user-provided cloud configs. Sep 11 18:02:07.940829 extend-filesystems[1926]: resize2fs 1.47.4 (6-Mar-2025) Sep 11 18:02:07.951679 systemd[1]: Started update-engine.service - Update Engine. Sep 11 18:02:07.961920 update_engine[1868]: I20260911 18:02:07.956394 1868 update_check_scheduler.cc:74] Next update check in 9m52s Sep 11 18:02:07.957061 systemd[1]: Started locksmithd.service - Cluster reboot manager. Sep 11 18:02:07.962478 dbus-daemon[1856]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=244 pid=1609 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Sep 11 18:02:07.982026 systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Sep 11 18:02:08.000919 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 1617920 to 2604027 blocks Sep 11 18:02:08.028074 coreos-metadata[1855]: Sep 11 18:02:08.027 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 11 18:02:08.030402 coreos-metadata[1855]: Sep 11 18:02:08.029 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-id: Attempt #1 Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.033 INFO Fetch successful Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.033 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/instance-type: Attempt #1 Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.034 INFO Fetch successful Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.034 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/local-ipv4: Attempt #1 Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.037 INFO Fetch successful Sep 11 18:02:08.038414 coreos-metadata[1855]: Sep 11 18:02:08.037 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-ipv4: Attempt #1 Sep 11 18:02:08.049554 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 2604027 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.038 INFO Fetch successful Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.038 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/ipv6: Attempt #1 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.040 INFO Fetch failed with 404: resource not found Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.040 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone: Attempt #1 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.042 INFO Fetch successful Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.042 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/placement/availability-zone-id: Attempt #1 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.044 INFO Fetch successful Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.044 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/hostname: Attempt #1 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.046 INFO Fetch successful Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.046 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-hostname: Attempt #1 Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.049 INFO Fetch successful Sep 11 18:02:08.049620 coreos-metadata[1855]: Sep 11 18:02:08.049 INFO Fetching http://169.254.169.254/2021-01-03/dynamic/instance-identity/document: Attempt #1 Sep 11 18:02:08.050761 coreos-metadata[1855]: Sep 11 18:02:08.050 INFO Fetch successful Sep 11 18:02:08.057241 extend-filesystems[1926]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Sep 11 18:02:08.057241 extend-filesystems[1926]: old_desc_blocks = 1, new_desc_blocks = 2 Sep 11 18:02:08.057241 extend-filesystems[1926]: The filesystem on /dev/nvme0n1p9 is now 2604027 (4k) blocks long. Sep 11 18:02:08.068909 systemd[1]: extend-filesystems.service: Deactivated successfully. Sep 11 18:02:08.081191 extend-filesystems[1859]: Resized filesystem in /dev/nvme0n1p9 Sep 11 18:02:08.069530 systemd[1]: Finished extend-filesystems.service - Extend Filesystems. Sep 11 18:02:08.156930 bash[1946]: Updated "/home/core/.ssh/authorized_keys" Sep 11 18:02:08.172537 systemd[1]: Finished update-ssh-keys-after-ignition.service - Run update-ssh-keys once after Ignition. Sep 11 18:02:08.192818 systemd[1]: Starting sshkeys.service... Sep 11 18:02:08.259187 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice - Slice /system/coreos-metadata-sshkeys. Sep 11 18:02:08.269202 systemd[1]: Starting coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys)... Sep 11 18:02:08.291164 systemd-logind[1867]: Watching system buttons on /dev/input/event0 (Power Button) Sep 11 18:02:08.291220 systemd-logind[1867]: Watching system buttons on /dev/input/event1 (Sleep Button) Sep 11 18:02:08.300605 systemd-logind[1867]: New seat seat0. Sep 11 18:02:08.318049 systemd[1]: Started systemd-logind.service - User Login Management. Sep 11 18:02:08.348803 systemd[1]: Finished coreos-metadata.service - Flatcar Metadata Agent. Sep 11 18:02:08.370595 systemd[1]: Starting etcd-member.service - etcd (System Application Container)... Sep 11 18:02:08.421920 (etcd-wrapper)[1972]: etcd-member.service: Referenced but unset environment variable evaluates to an empty string: ETCD_OPTS Sep 11 18:02:08.461556 systemd[1]: Started systemd-hostnamed.service - Hostname Service. Sep 11 18:02:08.480262 dbus-daemon[1856]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 11 18:02:08.485534 dbus-daemon[1856]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1935 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Sep 11 18:02:08.507731 systemd[1]: Starting polkit.service - Authorization Manager... Sep 11 18:02:08.656432 amazon-ssm-agent[1919]: Initializing new seelog logger Sep 11 18:02:08.656432 amazon-ssm-agent[1919]: New Seelog Logger Creation Complete Sep 11 18:02:08.656432 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.656432 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.664963 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 processing appconfig overrides Sep 11 18:02:08.664963 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.664963 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.667925 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 processing appconfig overrides Sep 11 18:02:08.668517 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.668517 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.675500 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 processing appconfig overrides Sep 11 18:02:08.675500 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6646 INFO Proxy environment variables: Sep 11 18:02:08.705067 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.705585 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:08.705946 amazon-ssm-agent[1919]: 2026/09/11 18:02:08 processing appconfig overrides Sep 11 18:02:08.750235 coreos-metadata[1966]: Sep 11 18:02:08.750 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Sep 11 18:02:08.753762 coreos-metadata[1966]: Sep 11 18:02:08.753 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys: Attempt #1 Sep 11 18:02:08.754697 coreos-metadata[1966]: Sep 11 18:02:08.754 INFO Fetch successful Sep 11 18:02:08.754697 coreos-metadata[1966]: Sep 11 18:02:08.754 INFO Fetching http://169.254.169.254/2021-01-03/meta-data/public-keys/0/openssh-key: Attempt #1 Sep 11 18:02:08.757010 coreos-metadata[1966]: Sep 11 18:02:08.756 INFO Fetch successful Sep 11 18:02:08.761320 unknown[1966]: wrote ssh authorized keys file for user: core Sep 11 18:02:08.778765 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6646 INFO https_proxy: Sep 11 18:02:08.891085 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6646 INFO http_proxy: Sep 11 18:02:08.902405 update-ssh-keys[2044]: Updated "/home/core/.ssh/authorized_keys" Sep 11 18:02:08.904870 systemd[1]: Finished coreos-metadata-sshkeys@core.service - Flatcar Metadata Agent (SSH Keys). Sep 11 18:02:08.916886 systemd[1]: Finished sshkeys.service. Sep 11 18:02:08.949533 locksmithd[1931]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Sep 11 18:02:08.992583 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6646 INFO no_proxy: Sep 11 18:02:09.094523 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6665 INFO Checking if agent identity type OnPrem can be assumed Sep 11 18:02:09.195417 amazon-ssm-agent[1919]: 2026-09-11 18:02:08.6669 INFO Checking if agent identity type EC2 can be assumed Sep 11 18:02:09.235091 polkitd[1990]: Started polkitd version 126 Sep 11 18:02:09.260625 polkitd[1990]: Loading rules from directory /etc/polkit-1/rules.d Sep 11 18:02:09.261247 polkitd[1990]: Loading rules from directory /run/polkit-1/rules.d Sep 11 18:02:09.263451 polkitd[1990]: Error opening rules directory: Error opening directory “/run/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 11 18:02:09.265244 polkitd[1990]: Loading rules from directory /usr/local/share/polkit-1/rules.d Sep 11 18:02:09.266553 polkitd[1990]: Error opening rules directory: Error opening directory “/usr/local/share/polkit-1/rules.d”: No such file or directory (g-file-error-quark, 4) Sep 11 18:02:09.266648 polkitd[1990]: Loading rules from directory /usr/share/polkit-1/rules.d Sep 11 18:02:09.273778 polkitd[1990]: Finished loading, compiling and executing 5 rules Sep 11 18:02:09.277738 systemd[1]: Started polkit.service - Authorization Manager. Sep 11 18:02:09.282314 sshd_keygen[1900]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 MLDSA44-ED25519 Sep 11 18:02:09.286355 dbus-daemon[1856]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Sep 11 18:02:09.288529 polkitd[1990]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Sep 11 18:02:09.294075 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0604 INFO Agent will take identity from EC2 Sep 11 18:02:09.365690 systemd-hostnamed[1935]: Hostname set to (transient) Sep 11 18:02:09.366545 systemd-resolved[1572]: System hostname changed to 'ip-172-31-21-19'. Sep 11 18:02:09.393641 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0631 INFO [amazon-ssm-agent] amazon-ssm-agent - v3.3.0.0 Sep 11 18:02:09.406668 systemd[1]: Finished sshd-keygen.service - Generate sshd host keys. Sep 11 18:02:09.416941 systemd[1]: Starting issuegen.service - Generate /run/issue... Sep 11 18:02:09.446990 systemd[1]: issuegen.service: Deactivated successfully. Sep 11 18:02:09.447671 systemd[1]: Finished issuegen.service - Generate /run/issue. Sep 11 18:02:09.455932 systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Sep 11 18:02:09.492725 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0631 INFO [amazon-ssm-agent] OS: linux, Arch: arm64 Sep 11 18:02:09.505447 systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Sep 11 18:02:09.518150 systemd[1]: Started getty@tty1.service - Getty on tty1. Sep 11 18:02:09.528784 systemd[1]: Started serial-getty@ttyS0.service - Serial Getty on ttyS0. Sep 11 18:02:09.536148 systemd[1]: Reached target getty.target - Login Prompts. Sep 11 18:02:09.592571 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0707 INFO [amazon-ssm-agent] Starting Core Agent Sep 11 18:02:09.692835 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0707 INFO [amazon-ssm-agent] Registrar detected. Attempting registration Sep 11 18:02:09.793221 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0707 INFO [Registrar] Starting registrar module Sep 11 18:02:09.897157 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0768 INFO [EC2Identity] Checking disk for registration info Sep 11 18:02:09.902874 containerd[1908]: time="2026-09-11T18:02:09Z" level=warning msg="Ignoring unknown key in TOML" column=1 error="strict mode: fields in the document are missing in the target struct" file=/usr/share/containerd/config.toml key=subreaper row=8 Sep 11 18:02:09.911419 containerd[1908]: time="2026-09-11T18:02:09.910134568Z" level=info msg="starting containerd" revision=e53c7c1516c3b2bff98eb76f1f4117477e6f4e66 version=v2.2.5 Sep 11 18:02:09.944341 containerd[1908]: time="2026-09-11T18:02:09.944248036Z" level=warning msg="Configuration migrated from version 2, use `containerd config migrate` to avoid migration" t="16.236µs" Sep 11 18:02:09.945803 containerd[1908]: time="2026-09-11T18:02:09.945463132Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1 Sep 11 18:02:09.946038 containerd[1908]: time="2026-09-11T18:02:09.946000240Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1 Sep 11 18:02:09.946156 containerd[1908]: time="2026-09-11T18:02:09.946127260Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1 Sep 11 18:02:09.946704 containerd[1908]: time="2026-09-11T18:02:09.946652668Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1 Sep 11 18:02:09.946869 containerd[1908]: time="2026-09-11T18:02:09.946839172Z" level=info msg="loading plugin" id=io.containerd.mount-handler.v1.erofs type=io.containerd.mount-handler.v1 Sep 11 18:02:09.946981 containerd[1908]: time="2026-09-11T18:02:09.946952368Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 11 18:02:09.947237 containerd[1908]: time="2026-09-11T18:02:09.947193112Z" level=info msg="skip loading plugin" error="no scratch file generator: skip plugin" id=io.containerd.snapshotter.v1.blockfile type=io.containerd.snapshotter.v1 Sep 11 18:02:09.947445 containerd[1908]: time="2026-09-11T18:02:09.947367952Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.947998 containerd[1908]: time="2026-09-11T18:02:09.947939224Z" level=info msg="skip loading plugin" error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" id=io.containerd.snapshotter.v1.btrfs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.948198 containerd[1908]: time="2026-09-11T18:02:09.948162904Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 11 18:02:09.948322 containerd[1908]: time="2026-09-11T18:02:09.948290020Z" level=info msg="skip loading plugin" error="devmapper not configured: skip plugin" id=io.containerd.snapshotter.v1.devmapper type=io.containerd.snapshotter.v1 Sep 11 18:02:09.949621 containerd[1908]: time="2026-09-11T18:02:09.948435388Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.erofs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.949621 containerd[1908]: time="2026-09-11T18:02:09.948890572Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.native type=io.containerd.snapshotter.v1 Sep 11 18:02:09.949621 containerd[1908]: time="2026-09-11T18:02:09.949090756Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.overlayfs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.949951 containerd[1908]: time="2026-09-11T18:02:09.949901032Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.950133 containerd[1908]: time="2026-09-11T18:02:09.950093908Z" level=info msg="skip loading plugin" error="lstat /var/lib/containerd/io.containerd.snapshotter.v1.zfs: no such file or directory: skip plugin" id=io.containerd.snapshotter.v1.zfs type=io.containerd.snapshotter.v1 Sep 11 18:02:09.950245 containerd[1908]: time="2026-09-11T18:02:09.950217856Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1 Sep 11 18:02:09.951729 containerd[1908]: time="2026-09-11T18:02:09.951166648Z" level=info msg="loading plugin" id=io.containerd.monitor.task.v1.cgroups type=io.containerd.monitor.task.v1 Sep 11 18:02:09.954175 containerd[1908]: time="2026-09-11T18:02:09.954118528Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1 Sep 11 18:02:09.954537 containerd[1908]: time="2026-09-11T18:02:09.954500344Z" level=info msg="metadata content store policy set" policy=shared Sep 11 18:02:09.974805 containerd[1908]: time="2026-09-11T18:02:09.974745964Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1 Sep 11 18:02:09.975234 containerd[1908]: time="2026-09-11T18:02:09.975184816Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1 Sep 11 18:02:09.976616 containerd[1908]: time="2026-09-11T18:02:09.976551724Z" level=info msg="built-in NRI default validator is disabled" Sep 11 18:02:09.976822 containerd[1908]: time="2026-09-11T18:02:09.976794388Z" level=info msg="runtime interface created" Sep 11 18:02:09.976996 containerd[1908]: time="2026-09-11T18:02:09.976881328Z" level=info msg="created NRI interface" Sep 11 18:02:09.976996 containerd[1908]: time="2026-09-11T18:02:09.976921108Z" level=info msg="loading plugin" id=io.containerd.differ.v1.erofs type=io.containerd.differ.v1 Sep 11 18:02:09.986658 containerd[1908]: time="2026-09-11T18:02:09.986570632Z" level=info msg="loading plugin" id=io.containerd.mount-manager.v1.bolt type=io.containerd.mount-manager.v1 Sep 11 18:02:09.986978 containerd[1908]: time="2026-09-11T18:02:09.986916892Z" level=info msg="loading plugin" id=io.containerd.differ.v1.walking type=io.containerd.differ.v1 Sep 11 18:02:09.987106 containerd[1908]: time="2026-09-11T18:02:09.986976484Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1 Sep 11 18:02:09.987106 containerd[1908]: time="2026-09-11T18:02:09.987010264Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1 Sep 11 18:02:09.987106 containerd[1908]: time="2026-09-11T18:02:09.987045784Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1 Sep 11 18:02:09.987106 containerd[1908]: time="2026-09-11T18:02:09.987073036Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1 Sep 11 18:02:09.987267 containerd[1908]: time="2026-09-11T18:02:09.987136540Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1 Sep 11 18:02:09.987267 containerd[1908]: time="2026-09-11T18:02:09.987171796Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1 Sep 11 18:02:09.987267 containerd[1908]: time="2026-09-11T18:02:09.987201628Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1 Sep 11 18:02:09.987267 containerd[1908]: time="2026-09-11T18:02:09.987228316Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1 Sep 11 18:02:09.987267 containerd[1908]: time="2026-09-11T18:02:09.987252088Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1 Sep 11 18:02:09.987669 containerd[1908]: time="2026-09-11T18:02:09.987282220Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2 Sep 11 18:02:09.987669 containerd[1908]: time="2026-09-11T18:02:09.987593320Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1 Sep 11 18:02:09.987669 containerd[1908]: time="2026-09-11T18:02:09.987646384Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987677968Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987713224Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987741952Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987766804Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987796516Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987823828Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987851308Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.mounts type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987876652Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987906556Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1 Sep 11 18:02:09.987944 containerd[1908]: time="2026-09-11T18:02:09.987932488Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1 Sep 11 18:02:09.988634 containerd[1908]: time="2026-09-11T18:02:09.987996244Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1 Sep 11 18:02:09.992298 containerd[1908]: time="2026-09-11T18:02:09.992156368Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\" for snapshotter \"overlayfs\"" Sep 11 18:02:09.992298 containerd[1908]: time="2026-09-11T18:02:09.992255116Z" level=info msg="Start snapshots syncer" Sep 11 18:02:09.992695 containerd[1908]: time="2026-09-11T18:02:09.992433604Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1 Sep 11 18:02:09.995020 containerd[1908]: time="2026-09-11T18:02:09.994748812Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runc\",\"runtimes\":{\"runc\":{\"runtimeType\":\"io.containerd.runc.v2\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":null,\"options\":{\"BinaryName\":\"\",\"CriuImagePath\":\"\",\"CriuWorkPath\":\"\",\"IoGid\":0,\"IoUid\":0,\"NoNewKeyring\":false,\"Root\":\"\",\"ShimCgroup\":\"\",\"SystemdCgroup\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"cgroupWritable\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"\",\"binDirs\":[\"/opt/cni/bin\"],\"confDir\":\"/etc/cni/net.d\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":true,\"selinuxCategoryRange\":1024,\"maxContainerLogLineSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":true,\"disableHugetlbController\":true,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":true,\"enableUnprivilegedICMP\":true,\"enableCDI\":true,\"cdiSpecDirs\":[\"/etc/cdi\",\"/var/run/cdi\"],\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"/var/lib/containerd\",\"containerdEndpoint\":\"/run/containerd/containerd.sock\",\"rootDir\":\"/var/lib/containerd/io.containerd.grpc.v1.cri\",\"stateDir\":\"/run/containerd/io.containerd.grpc.v1.cri\"}" Sep 11 18:02:09.995020 containerd[1908]: time="2026-09-11T18:02:09.994869088Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1 Sep 11 18:02:09.995746 containerd[1908]: time="2026-09-11T18:02:09.995691580Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1 Sep 11 18:02:09.996423 containerd[1908]: time="2026-09-11T18:02:09.996327604Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1 Sep 11 18:02:09.996845 containerd[1908]: time="2026-09-11T18:02:09.996767584Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1 Sep 11 18:02:09.997086 containerd[1908]: time="2026-09-11T18:02:09.997052680Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997173916Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997210120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997238248Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997267000Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997300120Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1 Sep 11 18:02:09.997477 containerd[1908]: time="2026-09-11T18:02:09.997330804Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.997823140Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998080312Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998108080Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998152972Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998178424Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998209756Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998238388Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.cri type=io.containerd.grpc.v1 Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998266456Z" level=info msg="Connect containerd service" Sep 11 18:02:09.998428 containerd[1908]: time="2026-09-11T18:02:09.998325856Z" level=info msg="using experimental NRI integration - disable nri plugin to prevent this" Sep 11 18:02:10.000155 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0769 INFO [EC2Identity] No registration info found for ec2 instance, attempting registration Sep 11 18:02:10.004830 containerd[1908]: time="2026-09-11T18:02:10.004750248Z" 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 11 18:02:10.100423 amazon-ssm-agent[1919]: 2026-09-11 18:02:09.0769 INFO [EC2Identity] Generating registration keypair Sep 11 18:02:10.316967 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3167 INFO [EC2Identity] Checking write access before registering Sep 11 18:02:10.363544 amazon-ssm-agent[1919]: 2026/09/11 18:02:10 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:10.363544 amazon-ssm-agent[1919]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Sep 11 18:02:10.363706 amazon-ssm-agent[1919]: 2026/09/11 18:02:10 processing appconfig overrides Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3177 INFO [EC2Identity] Registering EC2 instance with Systems Manager Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3628 INFO [EC2Identity] EC2 registration was successful. Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3628 INFO [amazon-ssm-agent] Registration attempted. Resuming core agent startup. Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3633 INFO [CredentialRefresher] credentialRefresher has started Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3633 INFO [CredentialRefresher] Starting credentials refresher loop Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3895 INFO EC2RoleProvider Successfully connected with instance profile role credentials Sep 11 18:02:10.390176 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3898 INFO [CredentialRefresher] Credentials ready Sep 11 18:02:10.418082 amazon-ssm-agent[1919]: 2026-09-11 18:02:10.3900 INFO [CredentialRefresher] Next credential rotation will be in 29.9999921127 minutes Sep 11 18:02:10.639291 containerd[1908]: time="2026-09-11T18:02:10.639012591Z" level=info msg="Start subscribing containerd event" Sep 11 18:02:10.639766 containerd[1908]: time="2026-09-11T18:02:10.639511071Z" level=info msg="Start recovering state" Sep 11 18:02:10.639962 containerd[1908]: time="2026-09-11T18:02:10.639729615Z" level=info msg="Start event monitor" Sep 11 18:02:10.639962 containerd[1908]: time="2026-09-11T18:02:10.639898527Z" level=info msg="Start cni network conf syncer for default" Sep 11 18:02:10.639962 containerd[1908]: time="2026-09-11T18:02:10.639924075Z" level=info msg="Start streaming server" Sep 11 18:02:10.640346 containerd[1908]: time="2026-09-11T18:02:10.640200879Z" level=info msg="Registered namespace \"k8s.io\" with NRI" Sep 11 18:02:10.640346 containerd[1908]: time="2026-09-11T18:02:10.640265559Z" level=info msg="runtime interface starting up..." Sep 11 18:02:10.640346 containerd[1908]: time="2026-09-11T18:02:10.640285023Z" level=info msg="starting plugins..." Sep 11 18:02:10.640762 containerd[1908]: time="2026-09-11T18:02:10.640585899Z" level=info msg="Synchronizing NRI (plugin) with current runtime state" Sep 11 18:02:10.641135 containerd[1908]: time="2026-09-11T18:02:10.641029071Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Sep 11 18:02:10.641231 containerd[1908]: time="2026-09-11T18:02:10.641193591Z" level=info msg=serving... address=/run/containerd/containerd.sock Sep 11 18:02:10.645854 containerd[1908]: time="2026-09-11T18:02:10.645782595Z" level=info msg="containerd successfully booted in 0.743460s" Sep 11 18:02:10.646021 systemd[1]: Started containerd.service - containerd container runtime. Sep 11 18:02:10.657882 systemd[1]: Starting docker.service - Docker Application Container Engine... Sep 11 18:02:10.682867 (dockerd)[2155]: 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 11 18:02:11.422317 amazon-ssm-agent[1919]: 2026-09-11 18:02:11.4197 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker is not running, starting worker process Sep 11 18:02:11.522626 amazon-ssm-agent[1919]: 2026-09-11 18:02:11.4211 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] [WorkerProvider] Worker ssm-agent-worker (pid:2162) started Sep 11 18:02:11.623098 amazon-ssm-agent[1919]: 2026-09-11 18:02:11.4213 INFO [amazon-ssm-agent] [LongRunningWorkerContainer] Monitor long running worker health every 60 seconds Sep 11 18:02:13.394340 dockerd[2155]: time="2026-09-11T18:02:13.394245065Z" level=info msg="Starting up" Sep 11 18:02:13.400225 dockerd[2155]: time="2026-09-11T18:02:13.400123865Z" level=info msg="OTEL tracing is not configured, using no-op tracer provider" Sep 11 18:02:13.427842 dockerd[2155]: time="2026-09-11T18:02:13.427750841Z" level=info msg="Creating a containerd client" address=/var/run/docker/libcontainerd/docker-containerd.sock timeout=1m0s Sep 11 18:02:13.509749 systemd[1]: Created slice system-sshd.slice - Slice /system/sshd. Sep 11 18:02:13.516986 systemd[1]: Started sshd@0-1-172.31.21.19:22-20.61.25.254:54804.service - OpenSSH per-connection server daemon (20.61.25.254:54804). Sep 11 18:02:13.526662 dockerd[2155]: time="2026-09-11T18:02:13.526533065Z" level=info msg="Loading containers: start." Sep 11 18:02:13.547431 kernel: Initializing XFRM netlink socket Sep 11 18:02:14.137796 (udev-worker)[2192]: Network interface NamePolicy= disabled on kernel command line. Sep 11 18:02:14.225845 systemd-networkd[1609]: docker0: Link UP Sep 11 18:02:14.232841 dockerd[2155]: time="2026-09-11T18:02:14.232710977Z" level=info msg="Loading containers: done." Sep 11 18:02:14.265917 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3500106156-merged.mount: Deactivated successfully. Sep 11 18:02:14.300035 dockerd[2155]: time="2026-09-11T18:02:14.299925209Z" 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 11 18:02:14.300275 dockerd[2155]: time="2026-09-11T18:02:14.300175121Z" level=info msg="Docker daemon" commit=45873be4ae3f5488c9498b3d9f17deaddaf609f4 containerd-snapshotter=false storage-driver=overlay2 version=28.2.2 Sep 11 18:02:14.300839 dockerd[2155]: time="2026-09-11T18:02:14.300766817Z" level=info msg="Initializing buildkit" Sep 11 18:02:14.325483 dockerd[2155]: time="2026-09-11T18:02:14.325346105Z" level=warning msg="CDI setup error /var/run/cdi: failed to monitor for changes: no such file or directory" Sep 11 18:02:14.325483 dockerd[2155]: time="2026-09-11T18:02:14.325458041Z" level=warning msg="CDI setup error /etc/cdi: failed to monitor for changes: no such file or directory" Sep 11 18:02:14.370860 dockerd[2155]: time="2026-09-11T18:02:14.370803450Z" level=info msg="Completed buildkit initialization" Sep 11 18:02:14.381719 dockerd[2155]: time="2026-09-11T18:02:14.381622830Z" level=info msg="Daemon has completed initialization" Sep 11 18:02:14.382342 dockerd[2155]: time="2026-09-11T18:02:14.381948558Z" level=info msg="API listen on /run/docker.sock" Sep 11 18:02:14.382908 systemd[1]: Started docker.service - Docker Application Container Engine. Sep 11 18:02:14.390829 etcd-wrapper[1996]: Error response from daemon: No such container: etcd-member Sep 11 18:02:14.417724 etcd-wrapper[2368]: Error response from daemon: No such container: etcd-member Sep 11 18:02:14.508596 etcd-wrapper[2386]: Unable to find image 'quay.io/coreos/etcd:v3.5.24' locally Sep 11 18:02:14.546278 sshd[2190]: Accepted publickey for core from 20.61.25.254 port 54804 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:14.552242 sshd-session[2190]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:14.584051 systemd[1]: Created slice user-500.slice - User Slice of UID 500. Sep 11 18:02:14.587751 systemd[1]: Starting user-runtime-dir@500.service - User Runtime Directory /run/user/500... Sep 11 18:02:14.597854 systemd-logind[1867]: New session '1' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:14.634987 systemd[1]: Finished user-runtime-dir@500.service - User Runtime Directory /run/user/500. Sep 11 18:02:14.641937 systemd[1]: Starting user@500.service - User Manager for UID 500... Sep 11 18:02:14.674685 (systemd)[2397]: pam_unix(systemd-user:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:14.680861 systemd-logind[1867]: New session '2' of user 'core' with class 'manager-early' and type 'unspecified'. Sep 11 18:02:14.425547 systemd-resolved[1572]: Clock change detected. Flushing caches. Sep 11 18:02:14.460525 systemd-journald[1503]: Time jumped backwards, rotating. Sep 11 18:02:14.809064 systemd[2397]: Queued start job for default target default.target. Sep 11 18:02:14.824638 systemd[2397]: Created slice app.slice - User Application Slice. Sep 11 18:02:14.825300 systemd[2397]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of User's Temporary Directories. Sep 11 18:02:14.825497 systemd[2397]: Reached target machines.target - Virtual Machines and Containers. Sep 11 18:02:14.826014 systemd[2397]: Reached target paths.target - Paths. Sep 11 18:02:14.826095 systemd[2397]: Reached target timers.target - Timers. Sep 11 18:02:14.829558 systemd[2397]: Starting dbus.socket - D-Bus User Message Bus Socket... Sep 11 18:02:14.833347 systemd[2397]: Listening on systemd-ask-password.socket - Query the User Interactively for a Password. Sep 11 18:02:14.834090 systemd[2397]: Listening on systemd-importd.socket - Disk Image Download Service Socket. Sep 11 18:02:14.836513 systemd[2397]: Listening on systemd-journalctl.socket - Journal Log Access Socket. Sep 11 18:02:14.837376 systemd[2397]: Listening on systemd-machined.socket - Virtual Machine and Container Registration Service Socket. Sep 11 18:02:14.851703 systemd[2397]: Starting systemd-tmpfiles-setup.service - Create User Files and Directories... Sep 11 18:02:14.868048 systemd[2397]: Listening on dbus.socket - D-Bus User Message Bus Socket. Sep 11 18:02:14.868421 systemd[2397]: Reached target sockets.target - Sockets. Sep 11 18:02:14.888050 systemd[2397]: Finished systemd-tmpfiles-setup.service - Create User Files and Directories. Sep 11 18:02:14.888313 systemd[2397]: Reached target basic.target - Basic System. Sep 11 18:02:14.888495 systemd[2397]: Reached target default.target - Main User Target. Sep 11 18:02:14.888573 systemd[2397]: Startup finished in 617ms. Sep 11 18:02:14.888801 systemd[1]: Started user@500.service - User Manager for UID 500. Sep 11 18:02:14.908056 systemd[1]: Started session-1.scope - Session 1 of User core. Sep 11 18:02:15.143834 etcd-wrapper[2386]: v3.5.24: Pulling from coreos/etcd Sep 11 18:02:15.402555 systemd[1]: Started sshd@1-4097-172.31.21.19:22-20.61.25.254:54812.service - OpenSSH per-connection server daemon (20.61.25.254:54812). Sep 11 18:02:15.685946 etcd-wrapper[2386]: d10f96ed9607: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 2ae710cd8bfe: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: d462aa345367: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 0f8b424aa0b9: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: d557676654e5: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: c8022d07192e: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: d858cbc252ad: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 1069fc2daed1: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: b40161cd83fc: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 5318d93a3a65: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 307c1adadb60: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: d28d4aa02c9a: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 564a832d7b24: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: b5e058125d2e: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: afae8b8aae79: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: d7c7ccc36d88: Pulling fs layer Sep 11 18:02:15.685946 etcd-wrapper[2386]: 0f8b424aa0b9: Waiting Sep 11 18:02:15.685946 etcd-wrapper[2386]: d557676654e5: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: c8022d07192e: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: d858cbc252ad: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: 1069fc2daed1: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: b40161cd83fc: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: 5318d93a3a65: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: 307c1adadb60: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: d28d4aa02c9a: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: 564a832d7b24: Waiting Sep 11 18:02:15.687544 etcd-wrapper[2386]: b5e058125d2e: Waiting Sep 11 18:02:15.688063 etcd-wrapper[2386]: afae8b8aae79: Waiting Sep 11 18:02:15.688063 etcd-wrapper[2386]: d7c7ccc36d88: Waiting Sep 11 18:02:15.996130 etcd-wrapper[2386]: 2ae710cd8bfe: Verifying Checksum Sep 11 18:02:15.996130 etcd-wrapper[2386]: 2ae710cd8bfe: Download complete Sep 11 18:02:16.142264 etcd-wrapper[2386]: d10f96ed9607: Verifying Checksum Sep 11 18:02:16.142264 etcd-wrapper[2386]: d10f96ed9607: Download complete Sep 11 18:02:16.157277 etcd-wrapper[2386]: d462aa345367: Verifying Checksum Sep 11 18:02:16.157980 etcd-wrapper[2386]: d462aa345367: Download complete Sep 11 18:02:16.206348 etcd-wrapper[2386]: d10f96ed9607: Pull complete Sep 11 18:02:16.242226 systemd[1]: var-lib-docker-overlay2-bcc8448c99668e4d1046f90d0829fbee0df0f83a98fe12c3d45a6bb5d30b74b0-merged.mount: Deactivated successfully. Sep 11 18:02:16.266530 etcd-wrapper[2386]: 2ae710cd8bfe: Pull complete Sep 11 18:02:16.274137 sshd[2413]: Accepted publickey for core from 20.61.25.254 port 54812 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:16.279017 sshd-session[2413]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:16.305083 systemd-logind[1867]: New session '3' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:16.314189 systemd[1]: Started session-3.scope - Session 3 of User core. Sep 11 18:02:16.357892 etcd-wrapper[2386]: 0f8b424aa0b9: Verifying Checksum Sep 11 18:02:16.358270 etcd-wrapper[2386]: 0f8b424aa0b9: Download complete Sep 11 18:02:16.427323 etcd-wrapper[2386]: d557676654e5: Verifying Checksum Sep 11 18:02:16.427600 etcd-wrapper[2386]: d557676654e5: Download complete Sep 11 18:02:16.552116 etcd-wrapper[2386]: c8022d07192e: Verifying Checksum Sep 11 18:02:16.552116 etcd-wrapper[2386]: c8022d07192e: Download complete Sep 11 18:02:16.637854 etcd-wrapper[2386]: d858cbc252ad: Verifying Checksum Sep 11 18:02:16.638371 etcd-wrapper[2386]: d858cbc252ad: Download complete Sep 11 18:02:16.760273 sshd[2433]: Connection closed by 20.61.25.254 port 54812 Sep 11 18:02:16.763651 sshd-session[2413]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:16.772299 systemd[1]: sshd@1-4097-172.31.21.19:22-20.61.25.254:54812.service: Deactivated successfully. Sep 11 18:02:16.779750 systemd[1]: session-3.scope: Deactivated successfully. Sep 11 18:02:16.783939 systemd-logind[1867]: Session 3 logged out. Waiting for processes to exit. Sep 11 18:02:16.787706 systemd-logind[1867]: Removed session 3. Sep 11 18:02:16.913149 etcd-wrapper[2386]: 5318d93a3a65: Verifying Checksum Sep 11 18:02:16.913149 etcd-wrapper[2386]: 5318d93a3a65: Download complete Sep 11 18:02:16.932902 systemd[1]: Started sshd@2-2-172.31.21.19:22-20.61.25.254:58654.service - OpenSSH per-connection server daemon (20.61.25.254:58654). Sep 11 18:02:17.315685 systemd[1]: var-lib-docker-overlay2-9484a6ff84650062c5042778f8f8681a00e39d67bdedc9135251601f1cfb906e-merged.mount: Deactivated successfully. Sep 11 18:02:17.409113 etcd-wrapper[2386]: d462aa345367: Pull complete Sep 11 18:02:17.435371 systemd[1]: var-lib-docker-overlay2-4cf70dd28ccb9583d362eb1df05fd0f0b1aeb2f5ceb71f730fe30078f959f720-merged.mount: Deactivated successfully. Sep 11 18:02:17.449902 etcd-wrapper[2386]: 0f8b424aa0b9: Pull complete Sep 11 18:02:17.479276 systemd[1]: var-lib-docker-overlay2-8bb502a57193bb82c380604597522dc8aa27c4c7ab12b109ff6ab3eaeb9d0b0c-merged.mount: Deactivated successfully. Sep 11 18:02:17.486745 etcd-wrapper[2386]: d557676654e5: Pull complete Sep 11 18:02:17.521731 etcd-wrapper[2386]: c8022d07192e: Pull complete Sep 11 18:02:17.551644 etcd-wrapper[2386]: d858cbc252ad: Pull complete Sep 11 18:02:17.761223 etcd-wrapper[2386]: 1069fc2daed1: Verifying Checksum Sep 11 18:02:17.761223 etcd-wrapper[2386]: 1069fc2daed1: Download complete Sep 11 18:02:17.784707 etcd-wrapper[2386]: 1069fc2daed1: Pull complete Sep 11 18:02:17.824980 sshd[2441]: Accepted publickey for core from 20.61.25.254 port 58654 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:17.826565 sshd-session[2441]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:17.836269 etcd-wrapper[2386]: b40161cd83fc: Verifying Checksum Sep 11 18:02:17.836269 etcd-wrapper[2386]: b40161cd83fc: Download complete Sep 11 18:02:17.839547 systemd-logind[1867]: New session '4' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:17.843829 systemd[1]: Started session-4.scope - Session 4 of User core. Sep 11 18:02:17.871141 etcd-wrapper[2386]: b40161cd83fc: Pull complete Sep 11 18:02:17.906071 etcd-wrapper[2386]: 5318d93a3a65: Pull complete Sep 11 18:02:18.219420 etcd-wrapper[2386]: 307c1adadb60: Verifying Checksum Sep 11 18:02:18.220440 etcd-wrapper[2386]: 307c1adadb60: Download complete Sep 11 18:02:18.266258 etcd-wrapper[2386]: 307c1adadb60: Pull complete Sep 11 18:02:18.294681 etcd-wrapper[2386]: d28d4aa02c9a: Verifying Checksum Sep 11 18:02:18.294681 etcd-wrapper[2386]: d28d4aa02c9a: Download complete Sep 11 18:02:18.302515 sshd[2472]: Connection closed by 20.61.25.254 port 58654 Sep 11 18:02:18.302043 sshd-session[2441]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:18.318664 systemd[1]: sshd@2-2-172.31.21.19:22-20.61.25.254:58654.service: Deactivated successfully. Sep 11 18:02:18.338017 systemd[1]: session-4.scope: Deactivated successfully. Sep 11 18:02:18.345592 systemd-logind[1867]: Session 4 logged out. Waiting for processes to exit. Sep 11 18:02:18.352748 systemd-logind[1867]: Removed session 4. Sep 11 18:02:18.373093 etcd-wrapper[2386]: 564a832d7b24: Verifying Checksum Sep 11 18:02:18.373743 etcd-wrapper[2386]: 564a832d7b24: Download complete Sep 11 18:02:18.758169 systemd[1]: var-lib-docker-overlay2-a51aeb045d936846f15c4d1cd8962f66e249c703a736f2baf53b62131ae0616a-merged.mount: Deactivated successfully. Sep 11 18:02:18.781837 etcd-wrapper[2386]: d7c7ccc36d88: Verifying Checksum Sep 11 18:02:18.782958 etcd-wrapper[2386]: d7c7ccc36d88: Download complete Sep 11 18:02:18.807641 etcd-wrapper[2386]: b5e058125d2e: Verifying Checksum Sep 11 18:02:18.808012 etcd-wrapper[2386]: b5e058125d2e: Download complete Sep 11 18:02:18.836312 etcd-wrapper[2386]: d28d4aa02c9a: Pull complete Sep 11 18:02:18.839900 etcd-wrapper[2386]: afae8b8aae79: Verifying Checksum Sep 11 18:02:18.840191 etcd-wrapper[2386]: afae8b8aae79: Download complete Sep 11 18:02:19.105367 systemd[1]: var-lib-docker-overlay2-dadd672b78f0a44cfd5eaac2329842a5d0a23a6510fcae8b0129d9f4d45e3cd2-merged.mount: Deactivated successfully. Sep 11 18:02:19.160053 etcd-wrapper[2386]: 564a832d7b24: Pull complete Sep 11 18:02:19.375759 systemd[1]: var-lib-docker-overlay2-a2b4e2266a49ce1e6b2c85610698c6a7207cdf6b7a47af1b3e6a39c21d5284db-merged.mount: Deactivated successfully. Sep 11 18:02:19.410624 etcd-wrapper[2386]: b5e058125d2e: Pull complete Sep 11 18:02:19.438522 systemd[1]: var-lib-docker-overlay2-335a753c45afa41e1f5fcc0169fc4b707189c83111759af44011cb17a583b132-merged.mount: Deactivated successfully. Sep 11 18:02:19.448806 etcd-wrapper[2386]: afae8b8aae79: Pull complete Sep 11 18:02:19.484435 etcd-wrapper[2386]: d7c7ccc36d88: Pull complete Sep 11 18:02:19.497757 etcd-wrapper[2386]: Digest: sha256:a193bdd3c1d1d11de961b6600231b2b3b4c4e092848dbb7d4c0e03b709ac7594 Sep 11 18:02:19.502155 etcd-wrapper[2386]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.24 Sep 11 18:02:19.590764 containerd[1908]: time="2026-09-11T18:02:19.590678497Z" level=info msg="connecting to shim 416e4816cdff889648ff6dc30c5c8848ee994a440de77d3e17548c9a0e1acf88" address="unix:///run/containerd/s/9fc9ce2cd24cb9596a6cc1729dddd85a89c5c2341871e7ac4167b0963044e82e" namespace=moby protocol=ttrpc version=3 Sep 11 18:02:19.640786 systemd[1]: Started docker-416e4816cdff889648ff6dc30c5c8848ee994a440de77d3e17548c9a0e1acf88.scope - libcontainer container 416e4816cdff889648ff6dc30c5c8848ee994a440de77d3e17548c9a0e1acf88. Sep 11 18:02:19.769003 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.768481Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Sep 11 18:02:19.769354 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.768735Z","caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec20d9574696453c452a6a34a645f3a2"} Sep 11 18:02:19.769354 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.768796Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Sep 11 18:02:19.769354 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.768816Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.24"} Sep 11 18:02:19.769354 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.768831Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Sep 11 18:02:19.771516 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.768843Z","caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Sep 11 18:02:19.771516 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.769584Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 11 18:02:19.771516 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.769634Z","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.21.19:2379"]} Sep 11 18:02:19.771516 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.769742Z","caller":"embed/config.go:689","msg":"Running http and grpc server on single port. This is not recommended for production."} Sep 11 18:02:19.771516 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.769772Z","caller":"embed/etcd.go:140","msg":"configuring peer listeners","listen-peer-urls":["http://localhost:2380"]} Sep 11 18:02:19.775202 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.774885Z","caller":"embed/etcd.go:148","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Sep 11 18:02:19.775737 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.775401Z","caller":"embed/etcd.go:323","msg":"starting an etcd server","etcd-version":"3.5.24","git-sha":"e72f3c2","go-version":"go1.24.9","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec20d9574696453c452a6a34a645f3a2","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.21.19:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec20d9574696453c452a6a34a645f3a2=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 11 18:02:19.779363 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.779018Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.787084ms"} Sep 11 18:02:19.785396 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.785090Z","caller":"etcdserver/raft.go:507","msg":"starting local member","local-member-id":"8e9e05c52164694d","cluster-id":"cdf818194e3a8c32"} Sep 11 18:02:19.786187 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.785630Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=()"} Sep 11 18:02:19.786187 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.785881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 0"} Sep 11 18:02:19.786696 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.786064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8e9e05c52164694d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Sep 11 18:02:19.786696 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.786328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became follower at term 1"} Sep 11 18:02:19.787034 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.786612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 11 18:02:19.791769 etcd-wrapper[2386]: {"level":"warn","ts":"2026-09-11T18:02:19.791336Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} Sep 11 18:02:19.793156 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.792897Z","caller":"mvcc/kvstore.go:425","msg":"kvstore restored","current-rev":1} Sep 11 18:02:19.793421 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.793104Z","caller":"etcdserver/server.go:628","msg":"restore consistentIndex","index":0} Sep 11 18:02:19.794501 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.794242Z","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 11 18:02:19.796114 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.795549Z","caller":"etcdserver/server.go:875","msg":"starting etcd server","local-member-id":"8e9e05c52164694d","local-server-version":"3.5.24","cluster-version":"to_be_decided"} Sep 11 18:02:19.796888 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.795783Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} Sep 11 18:02:19.796888 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.795844Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} Sep 11 18:02:19.796888 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.795865Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} Sep 11 18:02:19.796888 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.796096Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 11 18:02:19.797523 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.797212Z","caller":"etcdserver/server.go:759","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 11 18:02:19.798410 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.798065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d switched to configuration voters=(10276657743932975437)"} Sep 11 18:02:19.802858 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.802515Z","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"],"added-peer-is-learner":false} Sep 11 18:02:19.803724 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.803175Z","caller":"embed/etcd.go:292","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.21.19:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Sep 11 18:02:19.803724 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.803284Z","caller":"embed/etcd.go:633","msg":"serving peer traffic","address":"127.0.0.1:2380"} Sep 11 18:02:19.803724 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:19.803310Z","caller":"embed/etcd.go:603","msg":"cmux::serve","address":"127.0.0.1:2380"} Sep 11 18:02:20.317334 systemd[1]: var-lib-docker-overlay2-0b9f596b0b4a7dc48688568bdee5a8c7cfdf228186d31548cc590a0deb80b53b-merged.mount: Deactivated successfully. Sep 11 18:02:20.488177 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.487800Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d is starting a new election at term 1"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.487858Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became pre-candidate at term 1"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.487937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgPreVoteResp from 8e9e05c52164694d at term 1"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.487985Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became candidate at term 2"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.488002Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 2"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.488023Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8e9e05c52164694d became leader at term 2"} Sep 11 18:02:20.488564 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.488041Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 2"} Sep 11 18:02:20.489325 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.489000Z","caller":"etcdserver/server.go:2711","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} Sep 11 18:02:20.489930 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.489302Z","caller":"etcdserver/server.go:2158","msg":"published local member to cluster through raft","local-member-id":"8e9e05c52164694d","local-member-attributes":"{Name:ec20d9574696453c452a6a34a645f3a2 ClientURLs:[http://172.31.21.19:2379]}","request-path":"/0/members/8e9e05c52164694d/attributes","cluster-id":"cdf818194e3a8c32","publish-timeout":"7s"} Sep 11 18:02:20.490228 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.489756Z","caller":"membership/cluster.go:587","msg":"set initial cluster version","cluster-id":"cdf818194e3a8c32","local-member-id":"8e9e05c52164694d","cluster-version":"3.5"} Sep 11 18:02:20.490626 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.489869Z","caller":"embed/serve.go:124","msg":"ready to serve client requests"} Sep 11 18:02:20.490626 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.490123Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Sep 11 18:02:20.491777 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.490224Z","caller":"etcdserver/server.go:2735","msg":"cluster version is updated","cluster-version":"3.5"} Sep 11 18:02:20.491167 systemd[1]: Started etcd-member.service - etcd (System Application Container). Sep 11 18:02:20.493425 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.490552Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} Sep 11 18:02:20.493425 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.490732Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} Sep 11 18:02:20.492644 systemd[1]: Reached target multi-user.target - Multi-User System. Sep 11 18:02:20.494038 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.491985Z","caller":"v3rpc/health.go:61","msg":"grpc service status changed","service":"","status":"SERVING"} Sep 11 18:02:20.493155 systemd[1]: Startup finished in 3.854s (kernel) + 14.536s (initrd) + 25.885s (userspace) = 44.276s. Sep 11 18:02:20.495820 etcd-wrapper[2386]: {"level":"info","ts":"2026-09-11T18:02:20.494713Z","caller":"embed/serve.go:210","msg":"serving client traffic insecurely; this is strongly discouraged!","traffic":"grpc+http","address":"[::]:2379"} Sep 11 18:02:28.472429 systemd[1]: Started sshd@3-4098-172.31.21.19:22-20.61.25.254:49352.service - OpenSSH per-connection server daemon (20.61.25.254:49352). Sep 11 18:02:29.330089 sshd[2574]: Accepted publickey for core from 20.61.25.254 port 49352 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:29.332181 sshd-session[2574]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:29.341911 systemd-logind[1867]: New session '5' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:29.344742 systemd[1]: Started session-5.scope - Session 5 of User core. Sep 11 18:02:29.804868 sshd[2578]: Connection closed by 20.61.25.254 port 49352 Sep 11 18:02:29.804774 sshd-session[2574]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:29.811360 systemd[1]: sshd@3-4098-172.31.21.19:22-20.61.25.254:49352.service: Deactivated successfully. Sep 11 18:02:29.815776 systemd[1]: session-5.scope: Deactivated successfully. Sep 11 18:02:29.818957 systemd-logind[1867]: Session 5 logged out. Waiting for processes to exit. Sep 11 18:02:29.821631 systemd-logind[1867]: Removed session 5. Sep 11 18:02:29.979038 systemd[1]: Started sshd@4-4099-172.31.21.19:22-20.61.25.254:49368.service - OpenSSH per-connection server daemon (20.61.25.254:49368). Sep 11 18:02:30.836151 sshd[2584]: Accepted publickey for core from 20.61.25.254 port 49368 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:30.838654 sshd-session[2584]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:30.847021 systemd-logind[1867]: New session '6' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:30.857744 systemd[1]: Started session-6.scope - Session 6 of User core. Sep 11 18:02:31.309490 sshd[2588]: Connection closed by 20.61.25.254 port 49368 Sep 11 18:02:31.308438 sshd-session[2584]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:31.313646 systemd[1]: sshd@4-4099-172.31.21.19:22-20.61.25.254:49368.service: Deactivated successfully. Sep 11 18:02:31.317022 systemd[1]: session-6.scope: Deactivated successfully. Sep 11 18:02:31.321020 systemd-logind[1867]: Session 6 logged out. Waiting for processes to exit. Sep 11 18:02:31.322892 systemd-logind[1867]: Removed session 6. Sep 11 18:02:31.481912 systemd[1]: Started sshd@5-4100-172.31.21.19:22-20.61.25.254:49376.service - OpenSSH per-connection server daemon (20.61.25.254:49376). Sep 11 18:02:32.347974 sshd[2594]: Accepted publickey for core from 20.61.25.254 port 49376 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:32.350516 sshd-session[2594]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:32.359070 systemd-logind[1867]: New session '7' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:32.368762 systemd[1]: Started session-7.scope - Session 7 of User core. Sep 11 18:02:32.828000 sshd[2598]: Connection closed by 20.61.25.254 port 49376 Sep 11 18:02:32.828994 sshd-session[2594]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:32.834084 systemd[1]: sshd@5-4100-172.31.21.19:22-20.61.25.254:49376.service: Deactivated successfully. Sep 11 18:02:32.837149 systemd[1]: session-7.scope: Deactivated successfully. Sep 11 18:02:32.838931 systemd-logind[1867]: Session 7 logged out. Waiting for processes to exit. Sep 11 18:02:32.841929 systemd-logind[1867]: Removed session 7. Sep 11 18:02:32.997285 systemd[1]: Started sshd@6-3-172.31.21.19:22-20.61.25.254:49388.service - OpenSSH per-connection server daemon (20.61.25.254:49388). Sep 11 18:02:33.862529 sshd[2604]: Accepted publickey for core from 20.61.25.254 port 49388 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:33.865119 sshd-session[2604]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:33.873072 systemd-logind[1867]: New session '8' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:33.885751 systemd[1]: Started session-8.scope - Session 8 of User core. Sep 11 18:02:34.336490 sshd[2608]: Connection closed by 20.61.25.254 port 49388 Sep 11 18:02:34.335415 sshd-session[2604]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:34.341291 systemd[1]: sshd@6-3-172.31.21.19:22-20.61.25.254:49388.service: Deactivated successfully. Sep 11 18:02:34.344982 systemd[1]: session-8.scope: Deactivated successfully. Sep 11 18:02:34.348276 systemd-logind[1867]: Session 8 logged out. Waiting for processes to exit. Sep 11 18:02:34.350049 systemd-logind[1867]: Removed session 8. Sep 11 18:02:34.507938 systemd[1]: Started sshd@7-4101-172.31.21.19:22-20.61.25.254:49398.service - OpenSSH per-connection server daemon (20.61.25.254:49398). Sep 11 18:02:35.370234 sshd[2614]: Accepted publickey for core from 20.61.25.254 port 49398 ssh2: RSA SHA256:yHydLrZ3KGtNrhb77DYN8JFP0tGJP2CpDlkHWo2sNco Sep 11 18:02:35.372220 sshd-session[2614]: pam_unix(sshd:session): session opened for user core(uid=500) by core(uid=0) Sep 11 18:02:35.380708 systemd-logind[1867]: New session '9' of user 'core' with class 'user' and type 'tty'. Sep 11 18:02:35.394736 systemd[1]: Started session-9.scope - Session 9 of User core. Sep 11 18:02:36.335501 sshd[2619]: Connection closed by 20.61.25.254 port 49398 Sep 11 18:02:36.335385 sshd-session[2614]: pam_unix(sshd:session): session closed for user core Sep 11 18:02:36.341629 systemd[1]: sshd@7-4101-172.31.21.19:22-20.61.25.254:49398.service: Deactivated successfully. Sep 11 18:02:36.345002 systemd[1]: session-9.scope: Deactivated successfully. Sep 11 18:02:36.349246 systemd-logind[1867]: Session 9 logged out. Waiting for processes to exit. Sep 11 18:02:36.351956 systemd-logind[1867]: Removed session 9. Sep 11 18:02:38.972722 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Sep 11 18:02:53.218864 update_engine[1868]: I20260911 18:02:53.218066 1868 update_attempter.cc:509] Updating boot flags...