Nov 1 00:11:10.005705 kernel: Booting Linux on physical CPU 0x0000000000 [0x410fd083] Nov 1 00:11:10.005741 kernel: Linux version 5.15.192-flatcar (build@pony-truck.infra.kinvolk.io) (aarch64-cros-linux-gnu-gcc (Gentoo Hardened 11.3.1_p20221209 p3) 11.3.1 20221209, GNU ld (Gentoo 2.39 p5) 2.39.0) #1 SMP PREEMPT Fri Oct 31 23:12:38 -00 2025 Nov 1 00:11:10.005786 kernel: efi: EFI v2.70 by EDK II Nov 1 00:11:10.005802 kernel: efi: SMBIOS=0x7bed0000 SMBIOS 3.0=0x7beb0000 ACPI=0x786e0000 ACPI 2.0=0x786e0014 MEMATTR=0x7affea98 MEMRESERVE=0x716fcf98 Nov 1 00:11:10.005816 kernel: ACPI: Early table checksum verification disabled Nov 1 00:11:10.005830 kernel: ACPI: RSDP 0x00000000786E0014 000024 (v02 AMAZON) Nov 1 00:11:10.005846 kernel: ACPI: XSDT 0x00000000786D00E8 000064 (v01 AMAZON AMZNFACP 00000001 01000013) Nov 1 00:11:10.005860 kernel: ACPI: FACP 0x00000000786B0000 000114 (v06 AMAZON AMZNFACP 00000001 AMZN 00000001) Nov 1 00:11:10.005874 kernel: ACPI: DSDT 0x0000000078640000 00159D (v02 AMAZON AMZNDSDT 00000001 INTL 20160527) Nov 1 00:11:10.005888 kernel: ACPI: APIC 0x00000000786C0000 000108 (v04 AMAZON AMZNAPIC 00000001 AMZN 00000001) Nov 1 00:11:10.005906 kernel: ACPI: SPCR 0x00000000786A0000 000050 (v02 AMAZON AMZNSPCR 00000001 AMZN 00000001) Nov 1 00:11:10.005920 kernel: ACPI: GTDT 0x0000000078690000 000060 (v02 AMAZON AMZNGTDT 00000001 AMZN 00000001) Nov 1 00:11:10.005934 kernel: ACPI: MCFG 0x0000000078680000 00003C (v02 AMAZON AMZNMCFG 00000001 AMZN 00000001) Nov 1 00:11:10.005948 kernel: ACPI: SLIT 0x0000000078670000 00002D (v01 AMAZON AMZNSLIT 00000001 AMZN 00000001) Nov 1 00:11:10.005965 kernel: ACPI: IORT 0x0000000078660000 000078 (v01 AMAZON AMZNIORT 00000001 AMZN 00000001) Nov 1 00:11:10.005984 kernel: ACPI: PPTT 0x0000000078650000 0000EC (v01 AMAZON AMZNPPTT 00000001 AMZN 00000001) Nov 1 00:11:10.005999 kernel: ACPI: SPCR: console: uart,mmio,0x90a0000,115200 Nov 1 00:11:10.006013 kernel: earlycon: uart0 at MMIO 0x00000000090a0000 (options '115200') Nov 1 00:11:10.006028 kernel: printk: bootconsole [uart0] enabled Nov 1 00:11:10.006042 kernel: NUMA: Failed to initialise from firmware Nov 1 00:11:10.006057 kernel: NUMA: Faking a node at [mem 0x0000000040000000-0x00000004b5ffffff] Nov 1 00:11:10.006071 kernel: NUMA: NODE_DATA [mem 0x4b5843900-0x4b5848fff] Nov 1 00:11:10.006086 kernel: Zone ranges: Nov 1 00:11:10.006100 kernel: DMA [mem 0x0000000040000000-0x00000000ffffffff] Nov 1 00:11:10.006115 kernel: DMA32 empty Nov 1 00:11:10.006129 kernel: Normal [mem 0x0000000100000000-0x00000004b5ffffff] Nov 1 00:11:10.006147 kernel: Movable zone start for each node Nov 1 00:11:10.006162 kernel: Early memory node ranges Nov 1 00:11:10.006176 kernel: node 0: [mem 0x0000000040000000-0x000000007862ffff] Nov 1 00:11:10.006191 kernel: node 0: [mem 0x0000000078630000-0x000000007863ffff] Nov 1 00:11:10.006205 kernel: node 0: [mem 0x0000000078640000-0x00000000786effff] Nov 1 00:11:10.006219 kernel: node 0: [mem 0x00000000786f0000-0x000000007872ffff] Nov 1 00:11:10.006233 kernel: node 0: [mem 0x0000000078730000-0x000000007bbfffff] Nov 1 00:11:10.006247 kernel: node 0: [mem 0x000000007bc00000-0x000000007bfdffff] Nov 1 00:11:10.006262 kernel: node 0: [mem 0x000000007bfe0000-0x000000007fffffff] Nov 1 00:11:10.006276 kernel: node 0: [mem 0x0000000400000000-0x00000004b5ffffff] Nov 1 00:11:10.006290 kernel: Initmem setup node 0 [mem 0x0000000040000000-0x00000004b5ffffff] Nov 1 00:11:10.006304 kernel: On node 0, zone Normal: 8192 pages in unavailable ranges Nov 1 00:11:10.006323 kernel: psci: probing for conduit method from ACPI. Nov 1 00:11:10.006337 kernel: psci: PSCIv1.0 detected in firmware. Nov 1 00:11:10.006358 kernel: psci: Using standard PSCI v0.2 function IDs Nov 1 00:11:10.006373 kernel: psci: Trusted OS migration not required Nov 1 00:11:10.006388 kernel: psci: SMC Calling Convention v1.1 Nov 1 00:11:10.006407 kernel: smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000001) Nov 1 00:11:10.006422 kernel: ACPI: SRAT not present Nov 1 00:11:10.006438 kernel: percpu: Embedded 30 pages/cpu s83032 r8192 d31656 u122880 Nov 1 00:11:10.006454 kernel: pcpu-alloc: s83032 r8192 d31656 u122880 alloc=30*4096 Nov 1 00:11:10.006469 kernel: pcpu-alloc: [0] 0 [0] 1 Nov 1 00:11:10.006484 kernel: Detected PIPT I-cache on CPU0 Nov 1 00:11:10.006499 kernel: CPU features: detected: GIC system register CPU interface Nov 1 00:11:10.006514 kernel: CPU features: detected: Spectre-v2 Nov 1 00:11:10.006529 kernel: CPU features: detected: Spectre-v3a Nov 1 00:11:10.006544 kernel: CPU features: detected: Spectre-BHB Nov 1 00:11:10.006559 kernel: CPU features: kernel page table isolation forced ON by KASLR Nov 1 00:11:10.006578 kernel: CPU features: detected: Kernel page table isolation (KPTI) Nov 1 00:11:10.006593 kernel: CPU features: detected: ARM erratum 1742098 Nov 1 00:11:10.006609 kernel: CPU features: detected: ARM errata 1165522, 1319367, or 1530923 Nov 1 00:11:10.006624 kernel: Built 1 zonelists, mobility grouping on. Total pages: 991872 Nov 1 00:11:10.006639 kernel: Policy zone: Normal Nov 1 00:11:10.006656 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=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:11:10.006673 kernel: Unknown kernel command line parameters "BOOT_IMAGE=/flatcar/vmlinuz-a", will be passed to user space. Nov 1 00:11:10.006689 kernel: Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes, linear) Nov 1 00:11:10.006704 kernel: Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes, linear) Nov 1 00:11:10.006719 kernel: mem auto-init: stack:off, heap alloc:off, heap free:off Nov 1 00:11:10.006738 kernel: software IO TLB: mapped [mem 0x000000007c000000-0x0000000080000000] (64MB) Nov 1 00:11:10.006783 kernel: Memory: 3824460K/4030464K available (9792K kernel code, 2094K rwdata, 7592K rodata, 36416K init, 777K bss, 206004K reserved, 0K cma-reserved) Nov 1 00:11:10.006802 kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 Nov 1 00:11:10.006817 kernel: trace event string verifier disabled Nov 1 00:11:10.006832 kernel: rcu: Preemptible hierarchical RCU implementation. Nov 1 00:11:10.006848 kernel: rcu: RCU event tracing is enabled. Nov 1 00:11:10.006864 kernel: rcu: RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=2. Nov 1 00:11:10.006879 kernel: Trampoline variant of Tasks RCU enabled. Nov 1 00:11:10.006895 kernel: Tracing variant of Tasks RCU enabled. Nov 1 00:11:10.006910 kernel: rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. Nov 1 00:11:10.006925 kernel: rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 Nov 1 00:11:10.006940 kernel: NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 Nov 1 00:11:10.006962 kernel: GICv3: 96 SPIs implemented Nov 1 00:11:10.006977 kernel: GICv3: 0 Extended SPIs implemented Nov 1 00:11:10.006992 kernel: GICv3: Distributor has no Range Selector support Nov 1 00:11:10.007007 kernel: Root IRQ handler: gic_handle_irq Nov 1 00:11:10.007022 kernel: GICv3: 16 PPIs implemented Nov 1 00:11:10.007037 kernel: GICv3: CPU0: found redistributor 0 region 0:0x0000000010200000 Nov 1 00:11:10.007052 kernel: ACPI: SRAT not present Nov 1 00:11:10.007066 kernel: ITS [mem 0x10080000-0x1009ffff] Nov 1 00:11:10.007082 kernel: ITS@0x0000000010080000: allocated 8192 Devices @400090000 (indirect, esz 8, psz 64K, shr 1) Nov 1 00:11:10.007097 kernel: ITS@0x0000000010080000: allocated 8192 Interrupt Collections @4000a0000 (flat, esz 8, psz 64K, shr 1) Nov 1 00:11:10.007113 kernel: GICv3: using LPI property table @0x00000004000b0000 Nov 1 00:11:10.007133 kernel: ITS: Using hypervisor restricted LPI range [128] Nov 1 00:11:10.007149 kernel: GICv3: CPU0: using allocated LPI pending table @0x00000004000d0000 Nov 1 00:11:10.007165 kernel: arch_timer: cp15 timer(s) running at 83.33MHz (virt). Nov 1 00:11:10.007181 kernel: clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x13381ebeec, max_idle_ns: 440795203145 ns Nov 1 00:11:10.007197 kernel: sched_clock: 56 bits at 83MHz, resolution 12ns, wraps every 4398046511100ns Nov 1 00:11:10.007212 kernel: Console: colour dummy device 80x25 Nov 1 00:11:10.007228 kernel: printk: console [tty1] enabled Nov 1 00:11:10.007244 kernel: ACPI: Core revision 20210730 Nov 1 00:11:10.007260 kernel: Calibrating delay loop (skipped), value calculated using timer frequency.. 166.66 BogoMIPS (lpj=83333) Nov 1 00:11:10.007275 kernel: pid_max: default: 32768 minimum: 301 Nov 1 00:11:10.007295 kernel: LSM: Security Framework initializing Nov 1 00:11:10.007311 kernel: SELinux: Initializing. Nov 1 00:11:10.007327 kernel: Mount-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:11:10.007343 kernel: Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes, linear) Nov 1 00:11:10.007358 kernel: rcu: Hierarchical SRCU implementation. Nov 1 00:11:10.007374 kernel: Platform MSI: ITS@0x10080000 domain created Nov 1 00:11:10.007389 kernel: PCI/MSI: ITS@0x10080000 domain created Nov 1 00:11:10.007405 kernel: Remapping and enabling EFI services. Nov 1 00:11:10.007420 kernel: smp: Bringing up secondary CPUs ... Nov 1 00:11:10.007435 kernel: Detected PIPT I-cache on CPU1 Nov 1 00:11:10.007456 kernel: GICv3: CPU1: found redistributor 1 region 0:0x0000000010220000 Nov 1 00:11:10.007472 kernel: GICv3: CPU1: using allocated LPI pending table @0x00000004000e0000 Nov 1 00:11:10.007487 kernel: CPU1: Booted secondary processor 0x0000000001 [0x410fd083] Nov 1 00:11:10.007503 kernel: smp: Brought up 1 node, 2 CPUs Nov 1 00:11:10.007518 kernel: SMP: Total of 2 processors activated. Nov 1 00:11:10.007534 kernel: CPU features: detected: 32-bit EL0 Support Nov 1 00:11:10.007549 kernel: CPU features: detected: 32-bit EL1 Support Nov 1 00:11:10.007565 kernel: CPU features: detected: CRC32 instructions Nov 1 00:11:10.007580 kernel: CPU: All CPU(s) started at EL1 Nov 1 00:11:10.007600 kernel: alternatives: patching kernel code Nov 1 00:11:10.007616 kernel: devtmpfs: initialized Nov 1 00:11:10.007641 kernel: KASLR disabled due to lack of seed Nov 1 00:11:10.007662 kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns Nov 1 00:11:10.007678 kernel: futex hash table entries: 512 (order: 3, 32768 bytes, linear) Nov 1 00:11:10.007695 kernel: pinctrl core: initialized pinctrl subsystem Nov 1 00:11:10.007711 kernel: SMBIOS 3.0.0 present. Nov 1 00:11:10.007727 kernel: DMI: Amazon EC2 a1.large/, BIOS 1.0 11/1/2018 Nov 1 00:11:10.007743 kernel: NET: Registered PF_NETLINK/PF_ROUTE protocol family Nov 1 00:11:10.007781 kernel: DMA: preallocated 512 KiB GFP_KERNEL pool for atomic allocations Nov 1 00:11:10.007799 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations Nov 1 00:11:10.007821 kernel: DMA: preallocated 512 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations Nov 1 00:11:10.007837 kernel: audit: initializing netlink subsys (disabled) Nov 1 00:11:10.007853 kernel: audit: type=2000 audit(0.299:1): state=initialized audit_enabled=0 res=1 Nov 1 00:11:10.007869 kernel: thermal_sys: Registered thermal governor 'step_wise' Nov 1 00:11:10.007885 kernel: cpuidle: using governor menu Nov 1 00:11:10.007905 kernel: hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. Nov 1 00:11:10.007921 kernel: ASID allocator initialised with 32768 entries Nov 1 00:11:10.007937 kernel: ACPI: bus type PCI registered Nov 1 00:11:10.007953 kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Nov 1 00:11:10.007969 kernel: Serial: AMBA PL011 UART driver Nov 1 00:11:10.007985 kernel: HugeTLB registered 1.00 GiB page size, pre-allocated 0 pages Nov 1 00:11:10.008002 kernel: HugeTLB registered 32.0 MiB page size, pre-allocated 0 pages Nov 1 00:11:10.008018 kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Nov 1 00:11:10.008034 kernel: HugeTLB registered 64.0 KiB page size, pre-allocated 0 pages Nov 1 00:11:10.008054 kernel: cryptd: max_cpu_qlen set to 1000 Nov 1 00:11:10.008071 kernel: alg: No test for fips(ansi_cprng) (fips_ansi_cprng) Nov 1 00:11:10.008087 kernel: ACPI: Added _OSI(Module Device) Nov 1 00:11:10.008103 kernel: ACPI: Added _OSI(Processor Device) Nov 1 00:11:10.008119 kernel: ACPI: Added _OSI(Processor Aggregator Device) Nov 1 00:11:10.008136 kernel: ACPI: Added _OSI(Linux-Dell-Video) Nov 1 00:11:10.008152 kernel: ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) Nov 1 00:11:10.008169 kernel: ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) Nov 1 00:11:10.008185 kernel: ACPI: 1 ACPI AML tables successfully acquired and loaded Nov 1 00:11:10.008202 kernel: ACPI: Interpreter enabled Nov 1 00:11:10.008222 kernel: ACPI: Using GIC for interrupt routing Nov 1 00:11:10.008238 kernel: ACPI: MCFG table detected, 1 entries Nov 1 00:11:10.008254 kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-0f]) Nov 1 00:11:10.008555 kernel: acpi PNP0A08:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] Nov 1 00:11:10.017858 kernel: acpi PNP0A08:00: _OSC: platform does not support [LTR] Nov 1 00:11:10.018123 kernel: acpi PNP0A08:00: _OSC: OS now controls [PCIeHotplug PME AER PCIeCapability] Nov 1 00:11:10.018321 kernel: acpi PNP0A08:00: ECAM area [mem 0x20000000-0x20ffffff] reserved by PNP0C02:00 Nov 1 00:11:10.018529 kernel: acpi PNP0A08:00: ECAM at [mem 0x20000000-0x20ffffff] for [bus 00-0f] Nov 1 00:11:10.018552 kernel: ACPI: Remapped I/O 0x000000001fff0000 to [io 0x0000-0xffff window] Nov 1 00:11:10.018570 kernel: acpiphp: Slot [1] registered Nov 1 00:11:10.018587 kernel: acpiphp: Slot [2] registered Nov 1 00:11:10.018604 kernel: acpiphp: Slot [3] registered Nov 1 00:11:10.018621 kernel: acpiphp: Slot [4] registered Nov 1 00:11:10.018637 kernel: acpiphp: Slot [5] registered Nov 1 00:11:10.018653 kernel: acpiphp: Slot [6] registered Nov 1 00:11:10.018669 kernel: acpiphp: Slot [7] registered Nov 1 00:11:10.018691 kernel: acpiphp: Slot [8] registered Nov 1 00:11:10.018707 kernel: acpiphp: Slot [9] registered Nov 1 00:11:10.018723 kernel: acpiphp: Slot [10] registered Nov 1 00:11:10.018740 kernel: acpiphp: Slot [11] registered Nov 1 00:11:10.025822 kernel: acpiphp: Slot [12] registered Nov 1 00:11:10.025849 kernel: acpiphp: Slot [13] registered Nov 1 00:11:10.025867 kernel: acpiphp: Slot [14] registered Nov 1 00:11:10.025884 kernel: acpiphp: Slot [15] registered Nov 1 00:11:10.025901 kernel: acpiphp: Slot [16] registered Nov 1 00:11:10.025927 kernel: acpiphp: Slot [17] registered Nov 1 00:11:10.025945 kernel: acpiphp: Slot [18] registered Nov 1 00:11:10.025962 kernel: acpiphp: Slot [19] registered Nov 1 00:11:10.025978 kernel: acpiphp: Slot [20] registered Nov 1 00:11:10.025994 kernel: acpiphp: Slot [21] registered Nov 1 00:11:10.026011 kernel: acpiphp: Slot [22] registered Nov 1 00:11:10.026027 kernel: acpiphp: Slot [23] registered Nov 1 00:11:10.026043 kernel: acpiphp: Slot [24] registered Nov 1 00:11:10.026059 kernel: acpiphp: Slot [25] registered Nov 1 00:11:10.026075 kernel: acpiphp: Slot [26] registered Nov 1 00:11:10.026096 kernel: acpiphp: Slot [27] registered Nov 1 00:11:10.026112 kernel: acpiphp: Slot [28] registered Nov 1 00:11:10.026128 kernel: acpiphp: Slot [29] registered Nov 1 00:11:10.026144 kernel: acpiphp: Slot [30] registered Nov 1 00:11:10.026160 kernel: acpiphp: Slot [31] registered Nov 1 00:11:10.026176 kernel: PCI host bridge to bus 0000:00 Nov 1 00:11:10.026421 kernel: pci_bus 0000:00: root bus resource [mem 0x80000000-0xffffffff window] Nov 1 00:11:10.027079 kernel: pci_bus 0000:00: root bus resource [io 0x0000-0xffff window] Nov 1 00:11:10.027277 kernel: pci_bus 0000:00: root bus resource [mem 0x400000000000-0x407fffffffff window] Nov 1 00:11:10.027457 kernel: pci_bus 0000:00: root bus resource [bus 00-0f] Nov 1 00:11:10.027702 kernel: pci 0000:00:00.0: [1d0f:0200] type 00 class 0x060000 Nov 1 00:11:10.027978 kernel: pci 0000:00:01.0: [1d0f:8250] type 00 class 0x070003 Nov 1 00:11:10.028186 kernel: pci 0000:00:01.0: reg 0x10: [mem 0x80118000-0x80118fff] Nov 1 00:11:10.028399 kernel: pci 0000:00:04.0: [1d0f:8061] type 00 class 0x010802 Nov 1 00:11:10.028630 kernel: pci 0000:00:04.0: reg 0x10: [mem 0x80114000-0x80117fff] Nov 1 00:11:10.029073 kernel: pci 0000:00:04.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 1 00:11:10.029305 kernel: pci 0000:00:05.0: [1d0f:ec20] type 00 class 0x020000 Nov 1 00:11:10.029505 kernel: pci 0000:00:05.0: reg 0x10: [mem 0x80110000-0x80113fff] Nov 1 00:11:10.029710 kernel: pci 0000:00:05.0: reg 0x18: [mem 0x80000000-0x800fffff pref] Nov 1 00:11:10.029944 kernel: pci 0000:00:05.0: reg 0x20: [mem 0x80100000-0x8010ffff] Nov 1 00:11:10.030153 kernel: pci 0000:00:05.0: PME# supported from D0 D1 D2 D3hot D3cold Nov 1 00:11:10.030367 kernel: pci 0000:00:05.0: BAR 2: assigned [mem 0x80000000-0x800fffff pref] Nov 1 00:11:10.030571 kernel: pci 0000:00:05.0: BAR 4: assigned [mem 0x80100000-0x8010ffff] Nov 1 00:11:10.030798 kernel: pci 0000:00:04.0: BAR 0: assigned [mem 0x80110000-0x80113fff] Nov 1 00:11:10.030999 kernel: pci 0000:00:05.0: BAR 0: assigned [mem 0x80114000-0x80117fff] Nov 1 00:11:10.031208 kernel: pci 0000:00:01.0: BAR 0: assigned [mem 0x80118000-0x80118fff] Nov 1 00:11:10.031398 kernel: pci_bus 0000:00: resource 4 [mem 0x80000000-0xffffffff window] Nov 1 00:11:10.031581 kernel: pci_bus 0000:00: resource 5 [io 0x0000-0xffff window] Nov 1 00:11:10.031805 kernel: pci_bus 0000:00: resource 6 [mem 0x400000000000-0x407fffffffff window] Nov 1 00:11:10.031829 kernel: ACPI: PCI: Interrupt link GSI0 configured for IRQ 35 Nov 1 00:11:10.031846 kernel: ACPI: PCI: Interrupt link GSI1 configured for IRQ 36 Nov 1 00:11:10.031863 kernel: ACPI: PCI: Interrupt link GSI2 configured for IRQ 37 Nov 1 00:11:10.031880 kernel: ACPI: PCI: Interrupt link GSI3 configured for IRQ 38 Nov 1 00:11:10.031896 kernel: iommu: Default domain type: Translated Nov 1 00:11:10.031912 kernel: iommu: DMA domain TLB invalidation policy: strict mode Nov 1 00:11:10.031929 kernel: vgaarb: loaded Nov 1 00:11:10.031945 kernel: pps_core: LinuxPPS API ver. 1 registered Nov 1 00:11:10.031967 kernel: pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti Nov 1 00:11:10.031984 kernel: PTP clock support registered Nov 1 00:11:10.032000 kernel: Registered efivars operations Nov 1 00:11:10.032016 kernel: clocksource: Switched to clocksource arch_sys_counter Nov 1 00:11:10.032032 kernel: VFS: Disk quotas dquot_6.6.0 Nov 1 00:11:10.032049 kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Nov 1 00:11:10.032065 kernel: pnp: PnP ACPI init Nov 1 00:11:10.032307 kernel: system 00:00: [mem 0x20000000-0x2fffffff] could not be reserved Nov 1 00:11:10.032338 kernel: pnp: PnP ACPI: found 1 devices Nov 1 00:11:10.032355 kernel: NET: Registered PF_INET protocol family Nov 1 00:11:10.032372 kernel: IP idents hash table entries: 65536 (order: 7, 524288 bytes, linear) Nov 1 00:11:10.032389 kernel: tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes, linear) Nov 1 00:11:10.032406 kernel: Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) Nov 1 00:11:10.032423 kernel: TCP established hash table entries: 32768 (order: 6, 262144 bytes, linear) Nov 1 00:11:10.032439 kernel: TCP bind hash table entries: 32768 (order: 7, 524288 bytes, linear) Nov 1 00:11:10.032456 kernel: TCP: Hash tables configured (established 32768 bind 32768) Nov 1 00:11:10.032473 kernel: UDP hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:11:10.032495 kernel: UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes, linear) Nov 1 00:11:10.032538 kernel: NET: Registered PF_UNIX/PF_LOCAL protocol family Nov 1 00:11:10.032557 kernel: PCI: CLS 0 bytes, default 64 Nov 1 00:11:10.032573 kernel: hw perfevents: enabled with armv8_pmuv3_0 PMU driver, 3 counters available Nov 1 00:11:10.032590 kernel: kvm [1]: HYP mode not available Nov 1 00:11:10.032606 kernel: Initialise system trusted keyrings Nov 1 00:11:10.032622 kernel: workingset: timestamp_bits=39 max_order=20 bucket_order=0 Nov 1 00:11:10.032638 kernel: Key type asymmetric registered Nov 1 00:11:10.032654 kernel: Asymmetric key parser 'x509' registered Nov 1 00:11:10.032675 kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249) Nov 1 00:11:10.032692 kernel: io scheduler mq-deadline registered Nov 1 00:11:10.032708 kernel: io scheduler kyber registered Nov 1 00:11:10.032724 kernel: io scheduler bfq registered Nov 1 00:11:10.032968 kernel: pl061_gpio ARMH0061:00: PL061 GPIO chip registered Nov 1 00:11:10.032995 kernel: input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input0 Nov 1 00:11:10.033012 kernel: ACPI: button: Power Button [PWRB] Nov 1 00:11:10.033029 kernel: input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1 Nov 1 00:11:10.033045 kernel: ACPI: button: Sleep Button [SLPB] Nov 1 00:11:10.033068 kernel: Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled Nov 1 00:11:10.033085 kernel: ACPI: \_SB_.PCI0.GSI2: Enabled at IRQ 37 Nov 1 00:11:10.033280 kernel: serial 0000:00:01.0: enabling device (0010 -> 0012) Nov 1 00:11:10.033303 kernel: printk: console [ttyS0] disabled Nov 1 00:11:10.033320 kernel: 0000:00:01.0: ttyS0 at MMIO 0x80118000 (irq = 14, base_baud = 115200) is a 16550A Nov 1 00:11:10.033337 kernel: printk: console [ttyS0] enabled Nov 1 00:11:10.033353 kernel: printk: bootconsole [uart0] disabled Nov 1 00:11:10.033370 kernel: thunder_xcv, ver 1.0 Nov 1 00:11:10.033386 kernel: thunder_bgx, ver 1.0 Nov 1 00:11:10.033407 kernel: nicpf, ver 1.0 Nov 1 00:11:10.033423 kernel: nicvf, ver 1.0 Nov 1 00:11:10.033636 kernel: rtc-efi rtc-efi.0: registered as rtc0 Nov 1 00:11:10.044968 kernel: rtc-efi rtc-efi.0: setting system clock to 2025-11-01T00:11:09 UTC (1761955869) Nov 1 00:11:10.045014 kernel: hid: raw HID events driver (C) Jiri Kosina Nov 1 00:11:10.045033 kernel: NET: Registered PF_INET6 protocol family Nov 1 00:11:10.045050 kernel: Segment Routing with IPv6 Nov 1 00:11:10.045066 kernel: In-situ OAM (IOAM) with IPv6 Nov 1 00:11:10.045092 kernel: NET: Registered PF_PACKET protocol family Nov 1 00:11:10.045109 kernel: Key type dns_resolver registered Nov 1 00:11:10.045126 kernel: registered taskstats version 1 Nov 1 00:11:10.045142 kernel: Loading compiled-in X.509 certificates Nov 1 00:11:10.045159 kernel: Loaded X.509 cert 'Kinvolk GmbH: Module signing key for 5.15.192-flatcar: 4aa5071b9a6f96878595e36d4bd5862a671c915d' Nov 1 00:11:10.045176 kernel: Key type .fscrypt registered Nov 1 00:11:10.045192 kernel: Key type fscrypt-provisioning registered Nov 1 00:11:10.045209 kernel: ima: No TPM chip found, activating TPM-bypass! Nov 1 00:11:10.045225 kernel: ima: Allocated hash algorithm: sha1 Nov 1 00:11:10.045247 kernel: ima: No architecture policies found Nov 1 00:11:10.045263 kernel: clk: Disabling unused clocks Nov 1 00:11:10.045279 kernel: Freeing unused kernel memory: 36416K Nov 1 00:11:10.045296 kernel: Run /init as init process Nov 1 00:11:10.045312 kernel: with arguments: Nov 1 00:11:10.045328 kernel: /init Nov 1 00:11:10.045344 kernel: with environment: Nov 1 00:11:10.045360 kernel: HOME=/ Nov 1 00:11:10.045376 kernel: TERM=linux Nov 1 00:11:10.045397 kernel: BOOT_IMAGE=/flatcar/vmlinuz-a Nov 1 00:11:10.045419 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 1 00:11:10.045440 systemd[1]: Detected virtualization amazon. Nov 1 00:11:10.045458 systemd[1]: Detected architecture arm64. Nov 1 00:11:10.045476 systemd[1]: Running in initrd. Nov 1 00:11:10.045494 systemd[1]: No hostname configured, using default hostname. Nov 1 00:11:10.045511 systemd[1]: Hostname set to . Nov 1 00:11:10.045533 systemd[1]: Initializing machine ID from VM UUID. Nov 1 00:11:10.045551 systemd[1]: Queued start job for default target initrd.target. Nov 1 00:11:10.045590 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:11:10.045616 systemd[1]: Reached target cryptsetup.target. Nov 1 00:11:10.045635 systemd[1]: Reached target paths.target. Nov 1 00:11:10.045653 systemd[1]: Reached target slices.target. Nov 1 00:11:10.045670 systemd[1]: Reached target swap.target. Nov 1 00:11:10.045688 systemd[1]: Reached target timers.target. Nov 1 00:11:10.045712 systemd[1]: Listening on iscsid.socket. Nov 1 00:11:10.045731 systemd[1]: Listening on iscsiuio.socket. Nov 1 00:11:10.052611 systemd[1]: Listening on systemd-journald-audit.socket. Nov 1 00:11:10.052643 systemd[1]: Listening on systemd-journald-dev-log.socket. Nov 1 00:11:10.052661 systemd[1]: Listening on systemd-journald.socket. Nov 1 00:11:10.052679 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:11:10.052696 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:11:10.052714 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:11:10.052740 systemd[1]: Reached target sockets.target. Nov 1 00:11:10.052788 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:11:10.052808 systemd[1]: Finished network-cleanup.service. Nov 1 00:11:10.052826 systemd[1]: Starting systemd-fsck-usr.service... Nov 1 00:11:10.052844 systemd[1]: Starting systemd-journald.service... Nov 1 00:11:10.052861 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:11:10.052879 systemd[1]: Starting systemd-resolved.service... Nov 1 00:11:10.052897 systemd[1]: Starting systemd-vconsole-setup.service... Nov 1 00:11:10.052915 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:11:10.052938 systemd[1]: Finished systemd-fsck-usr.service. Nov 1 00:11:10.052958 kernel: audit: type=1130 audit(1761955870.000:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:10.052977 systemd[1]: Finished systemd-vconsole-setup.service. Nov 1 00:11:10.052995 kernel: audit: type=1130 audit(1761955870.015: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' Nov 1 00:11:10.053013 systemd[1]: Starting dracut-cmdline-ask.service... Nov 1 00:11:10.053031 systemd[1]: Starting systemd-tmpfiles-setup-dev.service... Nov 1 00:11:10.053053 systemd-journald[310]: Journal started Nov 1 00:11:10.053164 systemd-journald[310]: Runtime Journal (/run/log/journal/ec287366509f292a56e48654bf382e4c) is 8.0M, max 75.4M, 67.4M free. Nov 1 00:11:10.000000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:10.015000 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' Nov 1 00:11:09.993693 systemd-modules-load[311]: Inserted module 'overlay' Nov 1 00:11:10.065928 systemd[1]: Started systemd-journald.service. Nov 1 00:11:10.068000 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' Nov 1 00:11:10.081838 systemd[1]: Finished systemd-tmpfiles-setup-dev.service. Nov 1 00:11:10.094633 kernel: audit: type=1130 audit(1761955870.068: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' Nov 1 00:11:10.094671 kernel: audit: type=1130 audit(1761955870.080:5): 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' Nov 1 00:11:10.080000 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' Nov 1 00:11:10.092280 systemd-resolved[312]: Positive Trust Anchors: Nov 1 00:11:10.092294 systemd-resolved[312]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:11:10.092348 systemd-resolved[312]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 1 00:11:10.126960 kernel: bridge: filtering via arp/ip/ip6tables is no longer available by default. Update your scripts to load br_netfilter if you need this. Nov 1 00:11:10.127463 systemd[1]: Finished dracut-cmdline-ask.service. Nov 1 00:11:10.127000 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' Nov 1 00:11:10.140842 systemd[1]: Starting dracut-cmdline.service... Nov 1 00:11:10.144852 kernel: audit: type=1130 audit(1761955870.127:6): 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' Nov 1 00:11:10.158475 kernel: Bridge firewalling registered Nov 1 00:11:10.157775 systemd-modules-load[311]: Inserted module 'br_netfilter' Nov 1 00:11:10.177883 dracut-cmdline[327]: dracut-dracut-053 Nov 1 00:11:10.189501 kernel: SCSI subsystem initialized Nov 1 00:11:10.189797 dracut-cmdline[327]: Using kernel command line parameters: rd.driver.pre=btrfs BOOT_IMAGE=/flatcar/vmlinuz-a mount.usr=/dev/mapper/usr verity.usr=PARTUUID=7130c94a-213a-4e5a-8e26-6cce9662f132 rootflags=rw mount.usrflags=ro consoleblank=0 root=LABEL=ROOT console=tty1 console=ttyS0,115200n8 earlycon flatcar.first_boot=detected acpi=force flatcar.oem.id=ec2 modprobe.blacklist=xen_fbfront net.ifnames=0 nvme_core.io_timeout=4294967295 verity.usrhash=284392058f112e827cd7c521dcce1be27e1367d0030df494642d12e41e342e29 Nov 1 00:11:10.212316 kernel: device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log. Nov 1 00:11:10.212377 kernel: device-mapper: uevent: version 1.0.3 Nov 1 00:11:10.217091 kernel: device-mapper: ioctl: 4.45.0-ioctl (2021-03-22) initialised: dm-devel@redhat.com Nov 1 00:11:10.231006 systemd-modules-load[311]: Inserted module 'dm_multipath' Nov 1 00:11:10.235420 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:11:10.235000 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' Nov 1 00:11:10.248959 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:11:10.267783 kernel: audit: type=1130 audit(1761955870.235:7): 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' Nov 1 00:11:10.280009 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:11:10.278000 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' Nov 1 00:11:10.290792 kernel: audit: type=1130 audit(1761955870.278: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' Nov 1 00:11:10.361780 kernel: Loading iSCSI transport class v2.0-870. Nov 1 00:11:10.381784 kernel: iscsi: registered transport (tcp) Nov 1 00:11:10.409353 kernel: iscsi: registered transport (qla4xxx) Nov 1 00:11:10.409423 kernel: QLogic iSCSI HBA Driver Nov 1 00:11:10.591849 kernel: random: crng init done Nov 1 00:11:10.592207 systemd-resolved[312]: Defaulting to hostname 'linux'. Nov 1 00:11:10.595714 systemd[1]: Started systemd-resolved.service. Nov 1 00:11:10.611421 kernel: audit: type=1130 audit(1761955870.596:9): 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' Nov 1 00:11:10.596000 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' Nov 1 00:11:10.597968 systemd[1]: Reached target nss-lookup.target. Nov 1 00:11:10.627551 systemd[1]: Finished dracut-cmdline.service. Nov 1 00:11:10.631472 systemd[1]: Starting dracut-pre-udev.service... Nov 1 00:11:10.627000 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' Nov 1 00:11:10.648800 kernel: audit: type=1130 audit(1761955870.627:10): 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' Nov 1 00:11:10.699790 kernel: raid6: neonx8 gen() 6383 MB/s Nov 1 00:11:10.717788 kernel: raid6: neonx8 xor() 4746 MB/s Nov 1 00:11:10.735787 kernel: raid6: neonx4 gen() 6534 MB/s Nov 1 00:11:10.753787 kernel: raid6: neonx4 xor() 5000 MB/s Nov 1 00:11:10.771787 kernel: raid6: neonx2 gen() 5789 MB/s Nov 1 00:11:10.789788 kernel: raid6: neonx2 xor() 4552 MB/s Nov 1 00:11:10.807790 kernel: raid6: neonx1 gen() 4464 MB/s Nov 1 00:11:10.825788 kernel: raid6: neonx1 xor() 3664 MB/s Nov 1 00:11:10.843789 kernel: raid6: int64x8 gen() 3437 MB/s Nov 1 00:11:10.861786 kernel: raid6: int64x8 xor() 2081 MB/s Nov 1 00:11:10.879788 kernel: raid6: int64x4 gen() 3820 MB/s Nov 1 00:11:10.897787 kernel: raid6: int64x4 xor() 2185 MB/s Nov 1 00:11:10.915790 kernel: raid6: int64x2 gen() 3580 MB/s Nov 1 00:11:10.934788 kernel: raid6: int64x2 xor() 1933 MB/s Nov 1 00:11:10.952788 kernel: raid6: int64x1 gen() 2759 MB/s Nov 1 00:11:10.972470 kernel: raid6: int64x1 xor() 1450 MB/s Nov 1 00:11:10.972515 kernel: raid6: using algorithm neonx4 gen() 6534 MB/s Nov 1 00:11:10.972543 kernel: raid6: .... xor() 5000 MB/s, rmw enabled Nov 1 00:11:10.974408 kernel: raid6: using neon recovery algorithm Nov 1 00:11:10.995013 kernel: xor: measuring software checksum speed Nov 1 00:11:10.995074 kernel: 8regs : 9291 MB/sec Nov 1 00:11:10.997119 kernel: 32regs : 11107 MB/sec Nov 1 00:11:10.999446 kernel: arm64_neon : 9577 MB/sec Nov 1 00:11:10.999476 kernel: xor: using function: 32regs (11107 MB/sec) Nov 1 00:11:11.098805 kernel: Btrfs loaded, crc32c=crc32c-generic, zoned=no, fsverity=no Nov 1 00:11:11.117473 systemd[1]: Finished dracut-pre-udev.service. Nov 1 00:11:11.117000 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' Nov 1 00:11:11.118000 audit: BPF prog-id=7 op=LOAD Nov 1 00:11:11.118000 audit: BPF prog-id=8 op=LOAD Nov 1 00:11:11.122920 systemd[1]: Starting systemd-udevd.service... Nov 1 00:11:11.152653 systemd-udevd[509]: Using default interface naming scheme 'v252'. Nov 1 00:11:11.161857 systemd[1]: Started systemd-udevd.service. Nov 1 00:11:11.171000 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' Nov 1 00:11:11.174914 systemd[1]: Starting dracut-pre-trigger.service... Nov 1 00:11:11.206162 dracut-pre-trigger[524]: rd.md=0: removing MD RAID activation Nov 1 00:11:11.269143 systemd[1]: Finished dracut-pre-trigger.service. Nov 1 00:11:11.267000 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' Nov 1 00:11:11.270682 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:11:11.373321 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:11:11.371000 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' Nov 1 00:11:11.490556 kernel: ACPI: \_SB_.PCI0.GSI1: Enabled at IRQ 36 Nov 1 00:11:11.490627 kernel: ena 0000:00:05.0: enabling device (0010 -> 0012) Nov 1 00:11:11.514638 kernel: ena 0000:00:05.0: ENA device version: 0.10 Nov 1 00:11:11.514970 kernel: ena 0000:00:05.0: ENA controller version: 0.0.1 implementation version 1 Nov 1 00:11:11.515198 kernel: ena 0000:00:05.0: Elastic Network Adapter (ENA) found at mem 80114000, mac addr 06:8f:be:00:f0:2f Nov 1 00:11:11.517732 (udev-worker)[564]: Network interface NamePolicy= disabled on kernel command line. Nov 1 00:11:11.532792 kernel: ACPI: \_SB_.PCI0.GSI0: Enabled at IRQ 35 Nov 1 00:11:11.537029 kernel: nvme nvme0: pci function 0000:00:04.0 Nov 1 00:11:11.545798 kernel: nvme nvme0: 2/0/0 default/read/poll queues Nov 1 00:11:11.553092 kernel: GPT:Primary header thinks Alt. header is not at the end of the disk. Nov 1 00:11:11.553141 kernel: GPT:9289727 != 33554431 Nov 1 00:11:11.553165 kernel: GPT:Alternate GPT header not at the end of the disk. Nov 1 00:11:11.556660 kernel: GPT:9289727 != 33554431 Nov 1 00:11:11.556693 kernel: GPT: Use GNU Parted to correct GPT errors. Nov 1 00:11:11.558995 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 1 00:11:11.626805 kernel: BTRFS: device label OEM devid 1 transid 9 /dev/nvme0n1p6 scanned by (udev-worker) (559) Nov 1 00:11:11.706605 systemd[1]: Found device dev-disk-by\x2dlabel-EFI\x2dSYSTEM.device. Nov 1 00:11:11.736196 systemd[1]: Found device dev-disk-by\x2dlabel-ROOT.device. Nov 1 00:11:11.751265 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:11:11.763955 systemd[1]: Found device dev-disk-by\x2dpartuuid-7130c94a\x2d213a\x2d4e5a\x2d8e26\x2d6cce9662f132.device. Nov 1 00:11:11.770200 systemd[1]: Found device dev-disk-by\x2dpartlabel-USR\x2dA.device. Nov 1 00:11:11.784845 systemd[1]: Starting disk-uuid.service... Nov 1 00:11:11.796843 disk-uuid[671]: Primary Header is updated. Nov 1 00:11:11.796843 disk-uuid[671]: Secondary Entries is updated. Nov 1 00:11:11.796843 disk-uuid[671]: Secondary Header is updated. Nov 1 00:11:11.806803 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 1 00:11:12.828789 kernel: nvme0n1: p1 p2 p3 p4 p6 p7 p9 Nov 1 00:11:12.828900 disk-uuid[672]: The operation has completed successfully. Nov 1 00:11:12.988669 systemd[1]: disk-uuid.service: Deactivated successfully. Nov 1 00:11:12.989279 systemd[1]: Finished disk-uuid.service. Nov 1 00:11:12.991000 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' Nov 1 00:11:12.991000 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' Nov 1 00:11:13.024011 systemd[1]: Starting verity-setup.service... Nov 1 00:11:13.063811 kernel: device-mapper: verity: sha256 using implementation "sha256-ce" Nov 1 00:11:13.156731 systemd[1]: Found device dev-mapper-usr.device. Nov 1 00:11:13.162056 systemd[1]: Mounting sysusr-usr.mount... Nov 1 00:11:13.166624 systemd[1]: Finished verity-setup.service. Nov 1 00:11:13.169000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:13.259788 kernel: EXT4-fs (dm-0): mounted filesystem without journal. Opts: norecovery. Quota mode: none. Nov 1 00:11:13.260293 systemd[1]: Mounted sysusr-usr.mount. Nov 1 00:11:13.263823 systemd[1]: afterburn-network-kargs.service was skipped because no trigger condition checks were met. Nov 1 00:11:13.268053 systemd[1]: Starting ignition-setup.service... Nov 1 00:11:13.279175 systemd[1]: Starting parse-ip-for-networkd.service... Nov 1 00:11:13.304035 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:11:13.304099 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 1 00:11:13.306336 kernel: BTRFS info (device nvme0n1p6): has skinny extents Nov 1 00:11:13.317820 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 1 00:11:13.335799 systemd[1]: mnt-oem.mount: Deactivated successfully. Nov 1 00:11:13.353439 systemd[1]: Finished ignition-setup.service. Nov 1 00:11:13.354000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:13.357086 systemd[1]: Starting ignition-fetch-offline.service... Nov 1 00:11:13.425865 systemd[1]: Finished parse-ip-for-networkd.service. Nov 1 00:11:13.426000 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' Nov 1 00:11:13.430000 audit: BPF prog-id=9 op=LOAD Nov 1 00:11:13.432498 systemd[1]: Starting systemd-networkd.service... Nov 1 00:11:13.480746 systemd-networkd[1185]: lo: Link UP Nov 1 00:11:13.480835 systemd-networkd[1185]: lo: Gained carrier Nov 1 00:11:13.482347 systemd-networkd[1185]: Enumeration completed Nov 1 00:11:13.483240 systemd-networkd[1185]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:11:13.490000 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' Nov 1 00:11:13.484588 systemd[1]: Started systemd-networkd.service. Nov 1 00:11:13.492901 systemd[1]: Reached target network.target. Nov 1 00:11:13.498210 systemd[1]: Starting iscsiuio.service... Nov 1 00:11:13.500870 systemd-networkd[1185]: eth0: Link UP Nov 1 00:11:13.500879 systemd-networkd[1185]: eth0: Gained carrier Nov 1 00:11:13.518628 systemd[1]: Started iscsiuio.service. Nov 1 00:11:13.520000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:13.522928 systemd-networkd[1185]: eth0: DHCPv4 address 172.31.30.50/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 1 00:11:13.529415 systemd[1]: Starting iscsid.service... Nov 1 00:11:13.541705 iscsid[1190]: iscsid: can't open InitiatorName configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:11:13.541705 iscsid[1190]: iscsid: Warning: InitiatorName file /etc/iscsi/initiatorname.iscsi does not exist or does not contain a properly formatted InitiatorName. If using software iscsi (iscsi_tcp or ib_iser) or partial offload (bnx2i or cxgbi iscsi), you may not be able to log into or discover targets. Please create a file /etc/iscsi/initiatorname.iscsi that contains a sting with the format: InitiatorName=iqn.yyyy-mm.[:identifier]. Nov 1 00:11:13.541705 iscsid[1190]: Example: InitiatorName=iqn.2001-04.com.redhat:fc6. Nov 1 00:11:13.541705 iscsid[1190]: If using hardware iscsi like qla4xxx this message can be ignored. Nov 1 00:11:13.541705 iscsid[1190]: iscsid: can't open InitiatorAlias configuration file /etc/iscsi/initiatorname.iscsi Nov 1 00:11:13.562000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:13.571928 iscsid[1190]: iscsid: can't open iscsid.safe_logout configuration file /etc/iscsi/iscsid.conf Nov 1 00:11:13.548945 systemd[1]: Started iscsid.service. Nov 1 00:11:13.565905 systemd[1]: Starting dracut-initqueue.service... Nov 1 00:11:13.596294 systemd[1]: Finished dracut-initqueue.service. Nov 1 00:11:13.600000 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' Nov 1 00:11:13.602029 systemd[1]: Reached target remote-fs-pre.target. Nov 1 00:11:13.605669 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:11:13.609424 systemd[1]: Reached target remote-fs.target. Nov 1 00:11:13.614009 systemd[1]: Starting dracut-pre-mount.service... Nov 1 00:11:13.632322 systemd[1]: Finished dracut-pre-mount.service. Nov 1 00:11:13.633000 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' Nov 1 00:11:14.143568 ignition[1126]: Ignition 2.14.0 Nov 1 00:11:14.143596 ignition[1126]: Stage: fetch-offline Nov 1 00:11:14.144228 ignition[1126]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:14.144498 ignition[1126]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:14.167723 ignition[1126]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:14.168696 ignition[1126]: Ignition finished successfully Nov 1 00:11:14.174701 systemd[1]: Finished ignition-fetch-offline.service. Nov 1 00:11:14.194557 kernel: kauditd_printk_skb: 17 callbacks suppressed Nov 1 00:11:14.194598 kernel: audit: type=1130 audit(1761955874.175:28): 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' Nov 1 00:11:14.175000 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' Nov 1 00:11:14.186027 systemd[1]: Starting ignition-fetch.service... Nov 1 00:11:14.200771 ignition[1209]: Ignition 2.14.0 Nov 1 00:11:14.200804 ignition[1209]: Stage: fetch Nov 1 00:11:14.201116 ignition[1209]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:14.201169 ignition[1209]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:14.217450 ignition[1209]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:14.220657 ignition[1209]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:14.254196 ignition[1209]: INFO : PUT result: OK Nov 1 00:11:14.259037 ignition[1209]: DEBUG : parsed url from cmdline: "" Nov 1 00:11:14.261463 ignition[1209]: INFO : no config URL provided Nov 1 00:11:14.261463 ignition[1209]: INFO : reading system config file "/usr/lib/ignition/user.ign" Nov 1 00:11:14.261463 ignition[1209]: INFO : no config at "/usr/lib/ignition/user.ign" Nov 1 00:11:14.261463 ignition[1209]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:14.272203 ignition[1209]: INFO : PUT result: OK Nov 1 00:11:14.272203 ignition[1209]: INFO : GET http://169.254.169.254/2019-10-01/user-data: attempt #1 Nov 1 00:11:14.277221 ignition[1209]: INFO : GET result: OK Nov 1 00:11:14.280158 ignition[1209]: DEBUG : parsing config with SHA512: c6adc0b08a957ef636e00cadef13830f932834efb4fba7da8f7715a81246d9d608e52d1a9790cb289e4f65cd98323a995aca44fa2ffb48577c3cd7fad95b7fd0 Nov 1 00:11:14.288793 unknown[1209]: fetched base config from "system" Nov 1 00:11:14.288821 unknown[1209]: fetched base config from "system" Nov 1 00:11:14.288837 unknown[1209]: fetched user config from "aws" Nov 1 00:11:14.293644 ignition[1209]: fetch: fetch complete Nov 1 00:11:14.293657 ignition[1209]: fetch: fetch passed Nov 1 00:11:14.293779 ignition[1209]: Ignition finished successfully Nov 1 00:11:14.299864 systemd[1]: Finished ignition-fetch.service. Nov 1 00:11:14.305000 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' Nov 1 00:11:14.308497 systemd[1]: Starting ignition-kargs.service... Nov 1 00:11:14.320926 kernel: audit: type=1130 audit(1761955874.305:29): 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' Nov 1 00:11:14.334184 ignition[1215]: Ignition 2.14.0 Nov 1 00:11:14.334213 ignition[1215]: Stage: kargs Nov 1 00:11:14.334513 ignition[1215]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:14.334567 ignition[1215]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:14.350319 ignition[1215]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:14.353338 ignition[1215]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:14.357410 ignition[1215]: INFO : PUT result: OK Nov 1 00:11:14.362050 ignition[1215]: kargs: kargs passed Nov 1 00:11:14.362346 ignition[1215]: Ignition finished successfully Nov 1 00:11:14.368312 systemd[1]: Finished ignition-kargs.service. Nov 1 00:11:14.370002 systemd[1]: Starting ignition-disks.service... Nov 1 00:11:14.386951 kernel: audit: type=1130 audit(1761955874.366:30): 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' Nov 1 00:11:14.366000 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' Nov 1 00:11:14.394936 ignition[1221]: Ignition 2.14.0 Nov 1 00:11:14.394963 ignition[1221]: Stage: disks Nov 1 00:11:14.395284 ignition[1221]: reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:14.395346 ignition[1221]: parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:14.414535 ignition[1221]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:14.414535 ignition[1221]: INFO : PUT result: OK Nov 1 00:11:14.412377 ignition[1221]: no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:14.424817 ignition[1221]: disks: disks passed Nov 1 00:11:14.424921 ignition[1221]: Ignition finished successfully Nov 1 00:11:14.445430 kernel: audit: type=1130 audit(1761955874.425:31): 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' Nov 1 00:11:14.425000 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' Nov 1 00:11:14.426489 systemd[1]: Finished ignition-disks.service. Nov 1 00:11:14.429222 systemd[1]: Reached target initrd-root-device.target. Nov 1 00:11:14.441371 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:11:14.445447 systemd[1]: Reached target local-fs.target. Nov 1 00:11:14.447696 systemd[1]: Reached target sysinit.target. Nov 1 00:11:14.451617 systemd[1]: Reached target basic.target. Nov 1 00:11:14.457284 systemd[1]: Starting systemd-fsck-root.service... Nov 1 00:11:14.500944 systemd-fsck[1229]: ROOT: clean, 637/553520 files, 56031/553472 blocks Nov 1 00:11:14.505496 systemd[1]: Finished systemd-fsck-root.service. Nov 1 00:11:14.505000 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' Nov 1 00:11:14.520811 kernel: audit: type=1130 audit(1761955874.505:32): 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' Nov 1 00:11:14.509687 systemd[1]: Mounting sysroot.mount... Nov 1 00:11:14.544542 kernel: EXT4-fs (nvme0n1p9): mounted filesystem with ordered data mode. Opts: (null). Quota mode: none. Nov 1 00:11:14.544728 systemd[1]: Mounted sysroot.mount. Nov 1 00:11:14.550343 systemd[1]: Reached target initrd-root-fs.target. Nov 1 00:11:14.556594 systemd[1]: Mounting sysroot-usr.mount... Nov 1 00:11:14.565960 systemd[1]: flatcar-metadata-hostname.service was skipped because no trigger condition checks were met. Nov 1 00:11:14.566090 systemd[1]: ignition-remount-sysroot.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/sysroot). Nov 1 00:11:14.566238 systemd[1]: Reached target ignition-diskful.target. Nov 1 00:11:14.579202 systemd[1]: Mounted sysroot-usr.mount. Nov 1 00:11:14.604999 systemd[1]: Mounting sysroot-usr-share-oem.mount... Nov 1 00:11:14.614380 systemd[1]: Starting initrd-setup-root.service... Nov 1 00:11:14.630539 initrd-setup-root[1251]: cut: /sysroot/etc/passwd: No such file or directory Nov 1 00:11:14.647023 kernel: BTRFS: device label OEM devid 1 transid 11 /dev/nvme0n1p6 scanned by mount (1246) Nov 1 00:11:14.650254 initrd-setup-root[1259]: cut: /sysroot/etc/group: No such file or directory Nov 1 00:11:14.660284 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:11:14.660323 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 1 00:11:14.660347 kernel: BTRFS info (device nvme0n1p6): has skinny extents Nov 1 00:11:14.665905 initrd-setup-root[1283]: cut: /sysroot/etc/shadow: No such file or directory Nov 1 00:11:14.672938 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 1 00:11:14.676237 systemd[1]: Mounted sysroot-usr-share-oem.mount. Nov 1 00:11:14.683996 initrd-setup-root[1293]: cut: /sysroot/etc/gshadow: No such file or directory Nov 1 00:11:14.822041 systemd-networkd[1185]: eth0: Gained IPv6LL Nov 1 00:11:14.871472 systemd[1]: Finished initrd-setup-root.service. Nov 1 00:11:14.890393 kernel: audit: type=1130 audit(1761955874.872:33): 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' Nov 1 00:11:14.872000 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' Nov 1 00:11:14.874914 systemd[1]: Starting ignition-mount.service... Nov 1 00:11:14.892846 systemd[1]: Starting sysroot-boot.service... Nov 1 00:11:14.897860 systemd[1]: sysusr-usr-share-oem.mount: Deactivated successfully. Nov 1 00:11:14.898043 systemd[1]: sysroot-usr-share-oem.mount: Deactivated successfully. Nov 1 00:11:14.926029 ignition[1311]: INFO : Ignition 2.14.0 Nov 1 00:11:14.926029 ignition[1311]: INFO : Stage: mount Nov 1 00:11:14.931913 ignition[1311]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:14.931913 ignition[1311]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:14.950312 ignition[1311]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:14.954130 ignition[1311]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:14.960611 ignition[1311]: INFO : PUT result: OK Nov 1 00:11:14.965577 ignition[1311]: INFO : mount: mount passed Nov 1 00:11:14.967431 ignition[1311]: INFO : Ignition finished successfully Nov 1 00:11:14.974421 systemd[1]: Finished ignition-mount.service. Nov 1 00:11:14.978000 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' Nov 1 00:11:14.989122 systemd[1]: Starting ignition-files.service... Nov 1 00:11:15.003415 kernel: audit: type=1130 audit(1761955874.978:34): 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' Nov 1 00:11:15.000573 systemd[1]: Finished sysroot-boot.service. Nov 1 00:11:15.002000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.009813 systemd[1]: Mounting sysroot-usr-share-oem.mount... Nov 1 00:11:15.017793 kernel: audit: type=1130 audit(1761955875.002:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.034157 kernel: BTRFS: device label OEM devid 1 transid 12 /dev/nvme0n1p6 scanned by mount (1321) Nov 1 00:11:15.040157 kernel: BTRFS info (device nvme0n1p6): using crc32c (crc32c-generic) checksum algorithm Nov 1 00:11:15.040200 kernel: BTRFS info (device nvme0n1p6): using free space tree Nov 1 00:11:15.040225 kernel: BTRFS info (device nvme0n1p6): has skinny extents Nov 1 00:11:15.049787 kernel: BTRFS info (device nvme0n1p6): enabling ssd optimizations Nov 1 00:11:15.055127 systemd[1]: Mounted sysroot-usr-share-oem.mount. Nov 1 00:11:15.074330 ignition[1340]: INFO : Ignition 2.14.0 Nov 1 00:11:15.074330 ignition[1340]: INFO : Stage: files Nov 1 00:11:15.078029 ignition[1340]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:15.078029 ignition[1340]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:15.094862 ignition[1340]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:15.098104 ignition[1340]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:15.101772 ignition[1340]: INFO : PUT result: OK Nov 1 00:11:15.106774 ignition[1340]: DEBUG : files: compiled without relabeling support, skipping Nov 1 00:11:15.110897 ignition[1340]: INFO : files: ensureUsers: op(1): [started] creating or modifying user "core" Nov 1 00:11:15.110897 ignition[1340]: DEBUG : files: ensureUsers: op(1): executing: "usermod" "--root" "/sysroot" "core" Nov 1 00:11:15.153736 ignition[1340]: INFO : files: ensureUsers: op(1): [finished] creating or modifying user "core" Nov 1 00:11:15.157023 ignition[1340]: INFO : files: ensureUsers: op(2): [started] adding ssh keys to user "core" Nov 1 00:11:15.161445 unknown[1340]: wrote ssh authorized keys file for user: core Nov 1 00:11:15.164014 ignition[1340]: INFO : files: ensureUsers: op(2): [finished] adding ssh keys to user "core" Nov 1 00:11:15.167794 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(3): [started] writing file "/sysroot/etc/eks/bootstrap.sh" Nov 1 00:11:15.171874 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:11:15.192528 ignition[1340]: INFO : op(1): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2344380414" Nov 1 00:11:15.196033 ignition[1340]: CRITICAL : op(1): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2344380414": device or resource busy Nov 1 00:11:15.196033 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem2344380414", trying btrfs: device or resource busy Nov 1 00:11:15.196033 ignition[1340]: INFO : op(2): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2344380414" Nov 1 00:11:15.207027 ignition[1340]: INFO : op(2): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem2344380414" Nov 1 00:11:15.212187 ignition[1340]: INFO : op(3): [started] unmounting "/mnt/oem2344380414" Nov 1 00:11:15.214701 ignition[1340]: INFO : op(3): [finished] unmounting "/mnt/oem2344380414" Nov 1 00:11:15.214701 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(3): [finished] writing file "/sysroot/etc/eks/bootstrap.sh" Nov 1 00:11:15.221235 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(4): [started] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 00:11:15.225439 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(4): [finished] writing file "/sysroot/etc/flatcar/update.conf" Nov 1 00:11:15.229355 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(5): [started] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Nov 1 00:11:15.233798 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:11:15.246287 ignition[1340]: INFO : op(4): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3850425957" Nov 1 00:11:15.249649 ignition[1340]: CRITICAL : op(4): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3850425957": device or resource busy Nov 1 00:11:15.249649 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3850425957", trying btrfs: device or resource busy Nov 1 00:11:15.249649 ignition[1340]: INFO : op(5): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3850425957" Nov 1 00:11:15.249649 ignition[1340]: INFO : op(5): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3850425957" Nov 1 00:11:15.264170 ignition[1340]: INFO : op(6): [started] unmounting "/mnt/oem3850425957" Nov 1 00:11:15.264170 ignition[1340]: INFO : op(6): [finished] unmounting "/mnt/oem3850425957" Nov 1 00:11:15.269226 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(5): [finished] writing file "/sysroot/etc/amazon/ssm/amazon-ssm-agent.json" Nov 1 00:11:15.274782 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(6): [started] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Nov 1 00:11:15.274782 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:11:15.294006 ignition[1340]: INFO : op(7): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3999114631" Nov 1 00:11:15.297332 ignition[1340]: CRITICAL : op(7): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3999114631": device or resource busy Nov 1 00:11:15.301110 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3999114631", trying btrfs: device or resource busy Nov 1 00:11:15.301110 ignition[1340]: INFO : op(8): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3999114631" Nov 1 00:11:15.301110 ignition[1340]: INFO : op(8): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3999114631" Nov 1 00:11:15.312066 ignition[1340]: INFO : op(9): [started] unmounting "/mnt/oem3999114631" Nov 1 00:11:15.312066 ignition[1340]: INFO : op(9): [finished] unmounting "/mnt/oem3999114631" Nov 1 00:11:15.312066 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(6): [finished] writing file "/sysroot/etc/amazon/ssm/seelog.xml" Nov 1 00:11:15.312066 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(7): [started] writing file "/sysroot/etc/systemd/system/nvidia.service" Nov 1 00:11:15.312066 ignition[1340]: INFO : oem config not found in "/usr/share/oem", looking on oem partition Nov 1 00:11:15.341090 ignition[1340]: INFO : op(a): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3971830675" Nov 1 00:11:15.344710 ignition[1340]: CRITICAL : op(a): [failed] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3971830675": device or resource busy Nov 1 00:11:15.344710 ignition[1340]: ERROR : failed to mount ext4 device "/dev/disk/by-label/OEM" at "/mnt/oem3971830675", trying btrfs: device or resource busy Nov 1 00:11:15.344710 ignition[1340]: INFO : op(b): [started] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3971830675" Nov 1 00:11:15.356376 ignition[1340]: INFO : op(b): [finished] mounting "/dev/disk/by-label/OEM" at "/mnt/oem3971830675" Nov 1 00:11:15.356376 ignition[1340]: INFO : op(c): [started] unmounting "/mnt/oem3971830675" Nov 1 00:11:15.356376 ignition[1340]: INFO : op(c): [finished] unmounting "/mnt/oem3971830675" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: createFilesystemsFiles: createFiles: op(7): [finished] writing file "/sysroot/etc/systemd/system/nvidia.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(8): [started] processing unit "coreos-metadata-sshkeys@.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(8): [finished] processing unit "coreos-metadata-sshkeys@.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(9): [started] processing unit "amazon-ssm-agent.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(9): op(a): [started] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(9): op(a): [finished] writing unit "amazon-ssm-agent.service" at "/sysroot/etc/systemd/system/amazon-ssm-agent.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(9): [finished] processing unit "amazon-ssm-agent.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(b): [started] processing unit "nvidia.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(b): [finished] processing unit "nvidia.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(c): [started] processing unit "etcd-member.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(c): op(d): [started] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(c): op(d): [finished] writing systemd drop-in "20-clct-etcd-member.conf" at "/sysroot/etc/systemd/system/etcd-member.service.d/20-clct-etcd-member.conf" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(c): [finished] processing unit "etcd-member.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(e): [started] setting preset to enabled for "nvidia.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(e): [finished] setting preset to enabled for "nvidia.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(f): [started] setting preset to enabled for "etcd-member.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(f): [finished] setting preset to enabled for "etcd-member.service" Nov 1 00:11:15.356376 ignition[1340]: INFO : files: op(10): [started] setting preset to enabled for "coreos-metadata-sshkeys@.service " Nov 1 00:11:15.428037 ignition[1340]: INFO : files: op(10): [finished] setting preset to enabled for "coreos-metadata-sshkeys@.service " Nov 1 00:11:15.428037 ignition[1340]: INFO : files: op(11): [started] setting preset to enabled for "amazon-ssm-agent.service" Nov 1 00:11:15.428037 ignition[1340]: INFO : files: op(11): [finished] setting preset to enabled for "amazon-ssm-agent.service" Nov 1 00:11:15.443513 ignition[1340]: INFO : files: createResultFile: createFiles: op(12): [started] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:11:15.443513 ignition[1340]: INFO : files: createResultFile: createFiles: op(12): [finished] writing file "/sysroot/etc/.ignition-result.json" Nov 1 00:11:15.443513 ignition[1340]: INFO : files: files passed Nov 1 00:11:15.443513 ignition[1340]: INFO : Ignition finished successfully Nov 1 00:11:15.459823 systemd[1]: Finished ignition-files.service. Nov 1 00:11:15.472662 kernel: audit: type=1130 audit(1761955875.460:36): 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' Nov 1 00:11:15.460000 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' Nov 1 00:11:15.473085 systemd[1]: Starting initrd-setup-root-after-ignition.service... Nov 1 00:11:15.475408 systemd[1]: torcx-profile-populate.service was skipped because of an unmet condition check (ConditionPathExists=/sysroot/etc/torcx/next-profile). Nov 1 00:11:15.476943 systemd[1]: Starting ignition-quench.service... Nov 1 00:11:15.493377 systemd[1]: ignition-quench.service: Deactivated successfully. Nov 1 00:11:15.493617 systemd[1]: Finished ignition-quench.service. Nov 1 00:11:15.497000 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' Nov 1 00:11:15.504554 initrd-setup-root-after-ignition[1365]: grep: /sysroot/etc/flatcar/enabled-sysext.conf: No such file or directory Nov 1 00:11:15.512438 kernel: audit: type=1130 audit(1761955875.497:37): 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' Nov 1 00:11:15.500000 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' Nov 1 00:11:15.506084 systemd[1]: Finished initrd-setup-root-after-ignition.service. Nov 1 00:11:15.511000 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' Nov 1 00:11:15.512636 systemd[1]: Reached target ignition-complete.target. Nov 1 00:11:15.518150 systemd[1]: Starting initrd-parse-etc.service... Nov 1 00:11:15.551042 systemd[1]: initrd-parse-etc.service: Deactivated successfully. Nov 1 00:11:15.553219 systemd[1]: Finished initrd-parse-etc.service. Nov 1 00:11:15.553000 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' Nov 1 00:11:15.553000 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' Nov 1 00:11:15.556951 systemd[1]: Reached target initrd-fs.target. Nov 1 00:11:15.558834 systemd[1]: Reached target initrd.target. Nov 1 00:11:15.563714 systemd[1]: dracut-mount.service was skipped because no trigger condition checks were met. Nov 1 00:11:15.568016 systemd[1]: Starting dracut-pre-pivot.service... Nov 1 00:11:15.591349 systemd[1]: Finished dracut-pre-pivot.service. Nov 1 00:11:15.591000 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' Nov 1 00:11:15.595040 systemd[1]: Starting initrd-cleanup.service... Nov 1 00:11:15.616805 systemd[1]: Stopped target nss-lookup.target. Nov 1 00:11:15.620672 systemd[1]: Stopped target remote-cryptsetup.target. Nov 1 00:11:15.624836 systemd[1]: Stopped target timers.target. Nov 1 00:11:15.628390 systemd[1]: dracut-pre-pivot.service: Deactivated successfully. Nov 1 00:11:15.630802 systemd[1]: Stopped dracut-pre-pivot.service. Nov 1 00:11:15.633000 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' Nov 1 00:11:15.634873 systemd[1]: Stopped target initrd.target. Nov 1 00:11:15.638375 systemd[1]: Stopped target basic.target. Nov 1 00:11:15.641667 systemd[1]: Stopped target ignition-complete.target. Nov 1 00:11:15.645508 systemd[1]: Stopped target ignition-diskful.target. Nov 1 00:11:15.649258 systemd[1]: Stopped target initrd-root-device.target. Nov 1 00:11:15.654585 systemd[1]: Stopped target remote-fs.target. Nov 1 00:11:15.658204 systemd[1]: Stopped target remote-fs-pre.target. Nov 1 00:11:15.661856 systemd[1]: Stopped target sysinit.target. Nov 1 00:11:15.669712 systemd[1]: Stopped target local-fs.target. Nov 1 00:11:15.673159 systemd[1]: Stopped target local-fs-pre.target. Nov 1 00:11:15.678603 systemd[1]: Stopped target swap.target. Nov 1 00:11:15.680414 systemd[1]: dracut-pre-mount.service: Deactivated successfully. Nov 1 00:11:15.682095 systemd[1]: Stopped dracut-pre-mount.service. Nov 1 00:11:15.690000 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' Nov 1 00:11:15.691618 systemd[1]: Stopped target cryptsetup.target. Nov 1 00:11:15.698390 systemd[1]: dracut-initqueue.service: Deactivated successfully. Nov 1 00:11:15.700664 systemd[1]: Stopped dracut-initqueue.service. Nov 1 00:11:15.703000 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' Nov 1 00:11:15.704399 systemd[1]: initrd-setup-root-after-ignition.service: Deactivated successfully. Nov 1 00:11:15.707119 systemd[1]: Stopped initrd-setup-root-after-ignition.service. Nov 1 00:11:15.710000 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' Nov 1 00:11:15.711564 systemd[1]: ignition-files.service: Deactivated successfully. Nov 1 00:11:15.713824 systemd[1]: Stopped ignition-files.service. Nov 1 00:11:15.715000 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' Nov 1 00:11:15.718698 systemd[1]: Stopping ignition-mount.service... Nov 1 00:11:15.728000 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' Nov 1 00:11:15.739031 iscsid[1190]: iscsid shutting down. Nov 1 00:11:15.722300 systemd[1]: Stopping iscsid.service... Nov 1 00:11:15.729123 systemd[1]: kmod-static-nodes.service: Deactivated successfully. Nov 1 00:11:15.729429 systemd[1]: Stopped kmod-static-nodes.service. Nov 1 00:11:15.754000 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' Nov 1 00:11:15.745778 systemd[1]: Stopping sysroot-boot.service... Nov 1 00:11:15.762998 ignition[1378]: INFO : Ignition 2.14.0 Nov 1 00:11:15.762998 ignition[1378]: INFO : Stage: umount Nov 1 00:11:15.762998 ignition[1378]: INFO : reading system config file "/usr/lib/ignition/base.d/base.ign" Nov 1 00:11:15.762998 ignition[1378]: DEBUG : parsing config with SHA512: 6629d8e825d60c9c9d4629d8547ef9a0b839d6b01b7f61a481a1f23308c924b8b0bbf10cae7f7fe3bcaf88b23d1a81baa7771c3670728d4d2a1e665216a1de7b Nov 1 00:11:15.769000 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' Nov 1 00:11:15.747397 systemd[1]: systemd-udev-trigger.service: Deactivated successfully. Nov 1 00:11:15.747822 systemd[1]: Stopped systemd-udev-trigger.service. Nov 1 00:11:15.756402 systemd[1]: dracut-pre-trigger.service: Deactivated successfully. Nov 1 00:11:15.763069 systemd[1]: Stopped dracut-pre-trigger.service. Nov 1 00:11:15.790809 systemd[1]: iscsid.service: Deactivated successfully. Nov 1 00:11:15.792781 systemd[1]: Stopped iscsid.service. Nov 1 00:11:15.795000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsid comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.797398 systemd[1]: Stopping iscsiuio.service... Nov 1 00:11:15.806294 ignition[1378]: INFO : no config dir at "/usr/lib/ignition/base.platform.d/aws" Nov 1 00:11:15.806294 ignition[1378]: INFO : PUT http://169.254.169.254/latest/api/token: attempt #1 Nov 1 00:11:15.814000 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' Nov 1 00:11:15.814000 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' Nov 1 00:11:15.803568 systemd[1]: initrd-cleanup.service: Deactivated successfully. Nov 1 00:11:15.803797 systemd[1]: Finished initrd-cleanup.service. Nov 1 00:11:15.819000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=iscsiuio comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.826826 ignition[1378]: INFO : PUT result: OK Nov 1 00:11:15.826826 ignition[1378]: INFO : umount: umount passed Nov 1 00:11:15.826826 ignition[1378]: INFO : Ignition finished successfully Nov 1 00:11:15.831000 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' Nov 1 00:11:15.816728 systemd[1]: iscsiuio.service: Deactivated successfully. Nov 1 00:11:15.816962 systemd[1]: Stopped iscsiuio.service. Nov 1 00:11:15.822671 systemd[1]: sysroot-boot.mount: Deactivated successfully. Nov 1 00:11:15.829344 systemd[1]: ignition-mount.service: Deactivated successfully. Nov 1 00:11:15.829554 systemd[1]: Stopped ignition-mount.service. Nov 1 00:11:15.833329 systemd[1]: ignition-disks.service: Deactivated successfully. Nov 1 00:11:15.833417 systemd[1]: Stopped ignition-disks.service. Nov 1 00:11:15.849000 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' Nov 1 00:11:15.850656 systemd[1]: ignition-kargs.service: Deactivated successfully. Nov 1 00:11:15.851449 systemd[1]: Stopped ignition-kargs.service. Nov 1 00:11:15.855000 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' Nov 1 00:11:15.856803 systemd[1]: ignition-fetch.service: Deactivated successfully. Nov 1 00:11:15.855000 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' Nov 1 00:11:15.856906 systemd[1]: Stopped ignition-fetch.service. Nov 1 00:11:15.858910 systemd[1]: Stopped target network.target. Nov 1 00:11:15.865955 systemd[1]: ignition-fetch-offline.service: Deactivated successfully. Nov 1 00:11:15.867000 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' Nov 1 00:11:15.866059 systemd[1]: Stopped ignition-fetch-offline.service. Nov 1 00:11:15.868335 systemd[1]: Stopped target paths.target. Nov 1 00:11:15.876006 systemd[1]: systemd-ask-password-console.path: Deactivated successfully. Nov 1 00:11:15.882816 systemd[1]: Stopped systemd-ask-password-console.path. Nov 1 00:11:15.890000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.884827 systemd[1]: Stopped target slices.target. Nov 1 00:11:15.886561 systemd[1]: Stopped target sockets.target. Nov 1 00:11:15.888379 systemd[1]: iscsid.socket: Deactivated successfully. Nov 1 00:11:15.888453 systemd[1]: Closed iscsid.socket. Nov 1 00:11:15.889999 systemd[1]: iscsiuio.socket: Deactivated successfully. Nov 1 00:11:15.890067 systemd[1]: Closed iscsiuio.socket. Nov 1 00:11:15.891602 systemd[1]: ignition-setup.service: Deactivated successfully. Nov 1 00:11:15.891688 systemd[1]: Stopped ignition-setup.service. Nov 1 00:11:15.892981 systemd[1]: Stopping systemd-networkd.service... Nov 1 00:11:15.912806 systemd-networkd[1185]: eth0: DHCPv6 lease lost Nov 1 00:11:15.913067 systemd[1]: Stopping systemd-resolved.service... Nov 1 00:11:15.923000 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' Nov 1 00:11:15.921098 systemd[1]: systemd-networkd.service: Deactivated successfully. Nov 1 00:11:15.928000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=sysroot-boot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:15.921300 systemd[1]: Stopped systemd-networkd.service. Nov 1 00:11:15.925521 systemd[1]: sysroot-boot.service: Deactivated successfully. Nov 1 00:11:15.925718 systemd[1]: Stopped sysroot-boot.service. Nov 1 00:11:15.935847 systemd[1]: systemd-resolved.service: Deactivated successfully. Nov 1 00:11:15.939742 systemd[1]: Stopped systemd-resolved.service. Nov 1 00:11:15.942000 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' Nov 1 00:11:15.942000 audit: BPF prog-id=9 op=UNLOAD Nov 1 00:11:15.942000 audit: BPF prog-id=6 op=UNLOAD Nov 1 00:11:15.943900 systemd[1]: systemd-networkd.socket: Deactivated successfully. Nov 1 00:11:15.943987 systemd[1]: Closed systemd-networkd.socket. Nov 1 00:11:15.947738 systemd[1]: initrd-setup-root.service: Deactivated successfully. Nov 1 00:11:15.949324 systemd[1]: Stopped initrd-setup-root.service. Nov 1 00:11:15.952000 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' Nov 1 00:11:15.956119 systemd[1]: Stopping network-cleanup.service... Nov 1 00:11:15.960903 systemd[1]: parse-ip-for-networkd.service: Deactivated successfully. Nov 1 00:11:15.965000 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' Nov 1 00:11:15.961038 systemd[1]: Stopped parse-ip-for-networkd.service. Nov 1 00:11:15.969000 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' Nov 1 00:11:15.966953 systemd[1]: systemd-sysctl.service: Deactivated successfully. Nov 1 00:11:15.973000 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' Nov 1 00:11:15.967042 systemd[1]: Stopped systemd-sysctl.service. Nov 1 00:11:15.971384 systemd[1]: systemd-modules-load.service: Deactivated successfully. Nov 1 00:11:15.971469 systemd[1]: Stopped systemd-modules-load.service. Nov 1 00:11:15.975036 systemd[1]: Stopping systemd-udevd.service... Nov 1 00:11:15.982597 systemd[1]: run-credentials-systemd\x2dsysctl.service.mount: Deactivated successfully. Nov 1 00:11:16.003068 systemd[1]: network-cleanup.service: Deactivated successfully. Nov 1 00:11:16.004876 systemd[1]: Stopped network-cleanup.service. Nov 1 00:11:16.006000 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' Nov 1 00:11:16.012831 systemd[1]: systemd-udevd.service: Deactivated successfully. Nov 1 00:11:16.013155 systemd[1]: Stopped systemd-udevd.service. Nov 1 00:11:16.019078 systemd[1]: systemd-udevd-control.socket: Deactivated successfully. Nov 1 00:11:16.017000 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' Nov 1 00:11:16.019179 systemd[1]: Closed systemd-udevd-control.socket. Nov 1 00:11:16.024824 systemd[1]: systemd-udevd-kernel.socket: Deactivated successfully. Nov 1 00:11:16.024906 systemd[1]: Closed systemd-udevd-kernel.socket. Nov 1 00:11:16.030223 systemd[1]: dracut-pre-udev.service: Deactivated successfully. Nov 1 00:11:16.030323 systemd[1]: Stopped dracut-pre-udev.service. Nov 1 00:11:16.032000 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' Nov 1 00:11:16.034108 systemd[1]: dracut-cmdline.service: Deactivated successfully. Nov 1 00:11:16.036000 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' Nov 1 00:11:16.035694 systemd[1]: Stopped dracut-cmdline.service. Nov 1 00:11:16.041129 systemd[1]: dracut-cmdline-ask.service: Deactivated successfully. Nov 1 00:11:16.041217 systemd[1]: Stopped dracut-cmdline-ask.service. Nov 1 00:11:16.045000 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' Nov 1 00:11:16.047834 systemd[1]: Starting initrd-udevadm-cleanup-db.service... Nov 1 00:11:16.060359 systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. Nov 1 00:11:16.061000 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' Nov 1 00:11:16.060472 systemd[1]: Stopped systemd-vconsole-setup.service. Nov 1 00:11:16.068262 systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully. Nov 1 00:11:16.070812 systemd[1]: Finished initrd-udevadm-cleanup-db.service. Nov 1 00:11:16.073000 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' Nov 1 00:11:16.073000 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' Nov 1 00:11:16.075021 systemd[1]: Reached target initrd-switch-root.target. Nov 1 00:11:16.080328 systemd[1]: Starting initrd-switch-root.service... Nov 1 00:11:16.094591 systemd[1]: Switching root. Nov 1 00:11:16.121155 systemd-journald[310]: Journal stopped Nov 1 00:11:22.036830 systemd-journald[310]: Received SIGTERM from PID 1 (systemd). Nov 1 00:11:22.036960 kernel: SELinux: Class mctp_socket not defined in policy. Nov 1 00:11:22.037006 kernel: SELinux: Class anon_inode not defined in policy. Nov 1 00:11:22.037044 kernel: SELinux: the above unknown classes and permissions will be allowed Nov 1 00:11:22.037083 kernel: SELinux: policy capability network_peer_controls=1 Nov 1 00:11:22.037124 kernel: SELinux: policy capability open_perms=1 Nov 1 00:11:22.037155 kernel: SELinux: policy capability extended_socket_class=1 Nov 1 00:11:22.037185 kernel: SELinux: policy capability always_check_network=0 Nov 1 00:11:22.037214 kernel: SELinux: policy capability cgroup_seclabel=1 Nov 1 00:11:22.037244 kernel: SELinux: policy capability nnp_nosuid_transition=1 Nov 1 00:11:22.037274 kernel: SELinux: policy capability genfs_seclabel_symlinks=0 Nov 1 00:11:22.037306 kernel: SELinux: policy capability ioctl_skip_cloexec=0 Nov 1 00:11:22.037339 systemd[1]: Successfully loaded SELinux policy in 113.623ms. Nov 1 00:11:22.037376 systemd[1]: Relabelled /dev, /dev/shm, /run, /sys/fs/cgroup in 19.746ms. Nov 1 00:11:22.037413 systemd[1]: systemd 252 running in system mode (+PAM +AUDIT +SELINUX -APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL -ACL +BLKID +CURL -ELFUTILS -FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY -P11KIT -QRENCODE -TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Nov 1 00:11:22.037446 systemd[1]: Detected virtualization amazon. Nov 1 00:11:22.037477 systemd[1]: Detected architecture arm64. Nov 1 00:11:22.037508 systemd[1]: Detected first boot. Nov 1 00:11:22.037540 systemd[1]: Initializing machine ID from VM UUID. Nov 1 00:11:22.037572 kernel: SELinux: Context system_u:object_r:container_file_t:s0:c1022,c1023 is not valid (left unmapped). Nov 1 00:11:22.037605 systemd[1]: Populated /etc with preset unit settings. Nov 1 00:11:22.037645 systemd[1]: /usr/lib/systemd/system/locksmithd.service:8: Unit uses CPUShares=; please use CPUWeight= instead. Support for CPUShares= will be removed soon. Nov 1 00:11:22.037680 systemd[1]: /usr/lib/systemd/system/locksmithd.service:9: Unit uses MemoryLimit=; please use MemoryMax= instead. Support for MemoryLimit= will be removed soon. Nov 1 00:11:22.037723 systemd[1]: /run/systemd/system/docker.socket:8: ListenStream= references a path below legacy directory /var/run/, updating /var/run/docker.sock → /run/docker.sock; please update the unit file accordingly. Nov 1 00:11:22.044866 kernel: kauditd_printk_skb: 56 callbacks suppressed Nov 1 00:11:22.044909 kernel: audit: type=1334 audit(1761955881.476:87): prog-id=12 op=LOAD Nov 1 00:11:22.044942 kernel: audit: type=1334 audit(1761955881.476:88): prog-id=3 op=UNLOAD Nov 1 00:11:22.044971 kernel: audit: type=1334 audit(1761955881.478:89): prog-id=13 op=LOAD Nov 1 00:11:22.045018 systemd[1]: initrd-switch-root.service: Deactivated successfully. Nov 1 00:11:22.045051 kernel: audit: type=1334 audit(1761955881.481:90): prog-id=14 op=LOAD Nov 1 00:11:22.045081 kernel: audit: type=1334 audit(1761955881.481:91): prog-id=4 op=UNLOAD Nov 1 00:11:22.045110 systemd[1]: Stopped initrd-switch-root.service. Nov 1 00:11:22.045144 kernel: audit: type=1334 audit(1761955881.481:92): prog-id=5 op=UNLOAD Nov 1 00:11:22.045177 kernel: audit: type=1131 audit(1761955881.483:93): 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' Nov 1 00:11:22.045205 kernel: audit: type=1334 audit(1761955881.510:94): prog-id=12 op=UNLOAD Nov 1 00:11:22.045233 kernel: audit: type=1130 audit(1761955881.515:95): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:22.045266 systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1. Nov 1 00:11:22.045298 kernel: audit: type=1131 audit(1761955881.515:96): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:22.045327 systemd[1]: Created slice system-addon\x2dconfig.slice. Nov 1 00:11:22.045360 systemd[1]: Created slice system-addon\x2drun.slice. Nov 1 00:11:22.045393 systemd[1]: Created slice system-coreos\x2dmetadata\x2dsshkeys.slice. Nov 1 00:11:22.045423 systemd[1]: Created slice system-getty.slice. Nov 1 00:11:22.045454 systemd[1]: Created slice system-modprobe.slice. Nov 1 00:11:22.045489 systemd[1]: Created slice system-serial\x2dgetty.slice. Nov 1 00:11:22.045522 systemd[1]: Created slice system-system\x2dcloudinit.slice. Nov 1 00:11:22.045556 systemd[1]: Created slice system-systemd\x2dfsck.slice. Nov 1 00:11:22.045585 systemd[1]: Created slice user.slice. Nov 1 00:11:22.045616 systemd[1]: Started systemd-ask-password-console.path. Nov 1 00:11:22.045646 systemd[1]: Started systemd-ask-password-wall.path. Nov 1 00:11:22.045675 systemd[1]: Set up automount boot.automount. Nov 1 00:11:22.045707 systemd[1]: Set up automount proc-sys-fs-binfmt_misc.automount. Nov 1 00:11:22.045736 systemd[1]: Stopped target initrd-switch-root.target. Nov 1 00:11:22.045793 systemd[1]: Stopped target initrd-fs.target. Nov 1 00:11:22.045825 systemd[1]: Stopped target initrd-root-fs.target. Nov 1 00:11:22.045858 systemd[1]: Reached target integritysetup.target. Nov 1 00:11:22.045890 systemd[1]: Reached target remote-cryptsetup.target. Nov 1 00:11:22.045921 systemd[1]: Reached target remote-fs.target. Nov 1 00:11:22.045952 systemd[1]: Reached target slices.target. Nov 1 00:11:22.045982 systemd[1]: Reached target swap.target. Nov 1 00:11:22.046012 systemd[1]: Reached target torcx.target. Nov 1 00:11:22.046044 systemd[1]: Reached target veritysetup.target. Nov 1 00:11:22.046074 systemd[1]: Listening on systemd-coredump.socket. Nov 1 00:11:22.046107 systemd[1]: Listening on systemd-initctl.socket. Nov 1 00:11:22.046145 systemd[1]: Listening on systemd-networkd.socket. Nov 1 00:11:22.046176 systemd[1]: Listening on systemd-udevd-control.socket. Nov 1 00:11:22.046207 systemd[1]: Listening on systemd-udevd-kernel.socket. Nov 1 00:11:22.046236 systemd[1]: Listening on systemd-userdbd.socket. Nov 1 00:11:22.046266 systemd[1]: Mounting dev-hugepages.mount... Nov 1 00:11:22.046295 systemd[1]: Mounting dev-mqueue.mount... Nov 1 00:11:22.046324 systemd[1]: Mounting media.mount... Nov 1 00:11:22.046353 systemd[1]: Mounting sys-kernel-debug.mount... Nov 1 00:11:22.046388 systemd[1]: Mounting sys-kernel-tracing.mount... Nov 1 00:11:22.046417 systemd[1]: Mounting tmp.mount... Nov 1 00:11:22.046446 systemd[1]: Starting flatcar-tmpfiles.service... Nov 1 00:11:22.046478 systemd[1]: ignition-delete-config.service was skipped because no trigger condition checks were met. Nov 1 00:11:22.046507 systemd[1]: Starting kmod-static-nodes.service... Nov 1 00:11:22.046538 systemd[1]: Starting modprobe@configfs.service... Nov 1 00:11:22.046570 systemd[1]: Starting modprobe@dm_mod.service... Nov 1 00:11:22.046600 systemd[1]: Starting modprobe@drm.service... Nov 1 00:11:22.046629 systemd[1]: Starting modprobe@efi_pstore.service... Nov 1 00:11:22.046662 systemd[1]: Starting modprobe@fuse.service... Nov 1 00:11:22.046692 systemd[1]: Starting modprobe@loop.service... Nov 1 00:11:22.046724 systemd[1]: setup-nsswitch.service was skipped because of an unmet condition check (ConditionPathExists=!/etc/nsswitch.conf). Nov 1 00:11:22.046772 systemd[1]: systemd-fsck-root.service: Deactivated successfully. Nov 1 00:11:22.046810 systemd[1]: Stopped systemd-fsck-root.service. Nov 1 00:11:22.046843 systemd[1]: systemd-fsck-usr.service: Deactivated successfully. Nov 1 00:11:22.046874 systemd[1]: Stopped systemd-fsck-usr.service. Nov 1 00:11:22.046913 systemd[1]: Stopped systemd-journald.service. Nov 1 00:11:22.046942 systemd[1]: Starting systemd-journald.service... Nov 1 00:11:22.046977 systemd[1]: Starting systemd-modules-load.service... Nov 1 00:11:22.047008 systemd[1]: Starting systemd-network-generator.service... Nov 1 00:11:22.047038 systemd[1]: Starting systemd-remount-fs.service... Nov 1 00:11:22.047067 systemd[1]: Starting systemd-udev-trigger.service... Nov 1 00:11:22.047100 systemd[1]: verity-setup.service: Deactivated successfully. Nov 1 00:11:22.047132 systemd[1]: Stopped verity-setup.service. Nov 1 00:11:22.047162 systemd[1]: Mounted dev-hugepages.mount. Nov 1 00:11:22.047191 kernel: fuse: init (API version 7.34) Nov 1 00:11:22.047219 systemd[1]: Mounted dev-mqueue.mount. Nov 1 00:11:22.047253 systemd[1]: Mounted media.mount. Nov 1 00:11:22.047284 systemd[1]: Mounted sys-kernel-debug.mount. Nov 1 00:11:22.047317 systemd[1]: Mounted sys-kernel-tracing.mount. Nov 1 00:11:22.047347 systemd[1]: Mounted tmp.mount. Nov 1 00:11:22.047377 systemd[1]: Finished kmod-static-nodes.service. Nov 1 00:11:22.047407 systemd[1]: modprobe@configfs.service: Deactivated successfully. Nov 1 00:11:22.047437 systemd[1]: Finished modprobe@configfs.service. Nov 1 00:11:22.047470 systemd[1]: modprobe@dm_mod.service: Deactivated successfully. Nov 1 00:11:22.047502 kernel: loop: module loaded Nov 1 00:11:22.047535 systemd[1]: Finished modprobe@dm_mod.service. Nov 1 00:11:22.047566 systemd[1]: modprobe@drm.service: Deactivated successfully. Nov 1 00:11:22.047596 systemd[1]: Finished modprobe@drm.service. Nov 1 00:11:22.047626 systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. Nov 1 00:11:22.047659 systemd[1]: Finished modprobe@efi_pstore.service. Nov 1 00:11:22.047696 systemd[1]: modprobe@fuse.service: Deactivated successfully. Nov 1 00:11:22.047726 systemd[1]: Finished modprobe@fuse.service. Nov 1 00:11:22.047778 systemd[1]: modprobe@loop.service: Deactivated successfully. Nov 1 00:11:22.047812 systemd[1]: Finished modprobe@loop.service. Nov 1 00:11:22.047842 systemd[1]: Finished systemd-modules-load.service. Nov 1 00:11:22.047874 systemd[1]: Finished systemd-network-generator.service. Nov 1 00:11:22.047906 systemd[1]: Finished systemd-remount-fs.service. Nov 1 00:11:22.047940 systemd[1]: Reached target network-pre.target. Nov 1 00:11:22.047970 systemd[1]: Mounting sys-fs-fuse-connections.mount... Nov 1 00:11:22.055778 systemd[1]: Mounting sys-kernel-config.mount... Nov 1 00:11:22.056272 systemd[1]: remount-root.service was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). Nov 1 00:11:22.056321 systemd[1]: Starting systemd-hwdb-update.service... Nov 1 00:11:22.056354 systemd[1]: systemd-pstore.service was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). Nov 1 00:11:22.056386 systemd[1]: Starting systemd-random-seed.service... Nov 1 00:11:22.056529 systemd[1]: systemd-repart.service was skipped because no trigger condition checks were met. Nov 1 00:11:22.056596 systemd-journald[1489]: Journal started Nov 1 00:11:22.056708 systemd-journald[1489]: Runtime Journal (/run/log/journal/ec287366509f292a56e48654bf382e4c) is 8.0M, max 75.4M, 67.4M free. Nov 1 00:11:16.912000 audit: MAC_POLICY_LOAD auid=4294967295 ses=4294967295 lsm=selinux res=1 Nov 1 00:11:17.082000 audit[1]: AVC avc: denied { bpf } for pid=1 comm="systemd" capability=39 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 1 00:11:17.082000 audit[1]: AVC avc: denied { perfmon } for pid=1 comm="systemd" capability=38 scontext=system_u:system_r:kernel_t:s0 tcontext=system_u:system_r:kernel_t:s0 tclass=capability2 permissive=1 Nov 1 00:11:17.082000 audit: BPF prog-id=10 op=LOAD Nov 1 00:11:17.082000 audit: BPF prog-id=10 op=UNLOAD Nov 1 00:11:17.082000 audit: BPF prog-id=11 op=LOAD Nov 1 00:11:17.082000 audit: BPF prog-id=11 op=UNLOAD Nov 1 00:11:17.297000 audit[1411]: AVC avc: denied { associate } for pid=1411 comm="torcx-generator" name="docker" dev="tmpfs" ino=2 scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 srawcon="system_u:object_r:container_file_t:s0:c1022,c1023" Nov 1 00:11:17.297000 audit[1411]: SYSCALL arch=c00000b7 syscall=5 success=yes exit=0 a0=400014589c a1=40000c6de0 a2=40000cd0c0 a3=32 items=0 ppid=1394 pid=1411 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:11:17.297000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Nov 1 00:11:17.301000 audit[1411]: AVC avc: denied { associate } for pid=1411 comm="torcx-generator" name="bin" scontext=system_u:object_r:unlabeled_t:s0 tcontext=system_u:object_r:tmpfs_t:s0 tclass=filesystem permissive=1 Nov 1 00:11:17.301000 audit[1411]: SYSCALL arch=c00000b7 syscall=34 success=yes exit=0 a0=ffffffffffffff9c a1=4000145979 a2=1ed a3=0 items=2 ppid=1394 pid=1411 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="torcx-generator" exe="/usr/lib/systemd/system-generators/torcx-generator" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:11:17.301000 audit: CWD cwd="/" Nov 1 00:11:17.301000 audit: PATH item=0 name=(null) inode=2 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=PARENT cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:11:17.301000 audit: PATH item=1 name=(null) inode=3 dev=00:1c mode=040755 ouid=0 ogid=0 rdev=00:00 obj=system_u:object_r:unlabeled_t:s0 nametype=CREATE cap_fp=0 cap_fi=0 cap_fe=0 cap_fver=0 cap_frootid=0 Nov 1 00:11:17.301000 audit: PROCTITLE proctitle=2F7573722F6C69622F73797374656D642F73797374656D2D67656E657261746F72732F746F7263782D67656E657261746F72002F72756E2F73797374656D642F67656E657261746F72002F72756E2F73797374656D642F67656E657261746F722E6561726C79002F72756E2F73797374656D642F67656E657261746F722E6C61 Nov 1 00:11:21.476000 audit: BPF prog-id=12 op=LOAD Nov 1 00:11:21.476000 audit: BPF prog-id=3 op=UNLOAD Nov 1 00:11:21.478000 audit: BPF prog-id=13 op=LOAD Nov 1 00:11:21.481000 audit: BPF prog-id=14 op=LOAD Nov 1 00:11:21.481000 audit: BPF prog-id=4 op=UNLOAD Nov 1 00:11:21.481000 audit: BPF prog-id=5 op=UNLOAD Nov 1 00:11:21.483000 audit[1]: SERVICE_STOP 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' Nov 1 00:11:21.510000 audit: BPF prog-id=12 op=UNLOAD Nov 1 00:11:21.515000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.515000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=initrd-switch-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.797000 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' Nov 1 00:11:21.804000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-fsck-usr comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:22.066499 systemd[1]: Starting systemd-sysctl.service... Nov 1 00:11:22.066576 systemd[1]: Started systemd-journald.service. Nov 1 00:11:21.806000 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' Nov 1 00:11:21.806000 audit[1]: SERVICE_STOP 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' Nov 1 00:11:21.811000 audit: BPF prog-id=15 op=LOAD Nov 1 00:11:21.811000 audit: BPF prog-id=16 op=LOAD Nov 1 00:11:21.811000 audit: BPF prog-id=17 op=LOAD Nov 1 00:11:21.811000 audit: BPF prog-id=13 op=UNLOAD Nov 1 00:11:21.811000 audit: BPF prog-id=14 op=UNLOAD Nov 1 00:11:21.868000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=verity-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.915000 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' Nov 1 00:11:21.921000 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' Nov 1 00:11:21.921000 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' Nov 1 00:11:21.935000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.935000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@dm_mod comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.946000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.946000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@drm comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.955000 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' Nov 1 00:11:21.955000 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' Nov 1 00:11:21.963000 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' Nov 1 00:11:21.963000 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' Nov 1 00:11:21.973000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.973000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=modprobe@loop comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:21.981000 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' Nov 1 00:11:21.989000 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' Nov 1 00:11:21.996000 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' Nov 1 00:11:22.031000 audit: CONFIG_CHANGE op=set audit_enabled=1 old=1 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 res=1 Nov 1 00:11:22.031000 audit[1489]: SYSCALL arch=c00000b7 syscall=211 success=yes exit=60 a0=3 a1=fffffb1487d0 a2=4000 a3=1 items=0 ppid=1 pid=1489 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) Nov 1 00:11:22.031000 audit: PROCTITLE proctitle="/usr/lib/systemd/systemd-journald" Nov 1 00:11:21.472906 systemd[1]: Queued start job for default target multi-user.target. Nov 1 00:11:22.071000 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' Nov 1 00:11:17.287176 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="common configuration parsed" base_dir=/var/lib/torcx/ conf_dir=/etc/torcx/ run_dir=/run/torcx/ store_paths="[/usr/share/torcx/store /usr/share/oem/torcx/store/3510.3.8 /usr/share/oem/torcx/store /var/lib/torcx/store/3510.3.8 /var/lib/torcx/store]" Nov 1 00:11:21.472927 systemd[1]: Unnecessary job was removed for dev-nvme0n1p6.device. Nov 1 00:11:17.287782 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 1 00:11:21.484249 systemd[1]: systemd-journald.service: Deactivated successfully. Nov 1 00:11:17.287835 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 1 00:11:22.073422 systemd[1]: Mounted sys-fs-fuse-connections.mount. Nov 1 00:11:17.287902 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=info msg="no vendor profile selected by /etc/flatcar/docker-1.12" Nov 1 00:11:22.075658 systemd[1]: Mounted sys-kernel-config.mount. Nov 1 00:11:17.287928 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="skipped missing lower profile" missing profile=oem Nov 1 00:11:17.287989 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=warning msg="no next profile: unable to read profile file: open /etc/torcx/next-profile: no such file or directory" Nov 1 00:11:17.288019 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="apply configuration parsed" lower profiles (vendor/oem)="[vendor]" upper profile (user)= Nov 1 00:11:17.288424 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="mounted tmpfs" target=/run/torcx/unpack Nov 1 00:11:17.288520 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="profile found" name=docker-1.12-no path=/usr/share/torcx/profiles/docker-1.12-no.json Nov 1 00:11:17.288560 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="profile found" name=vendor path=/usr/share/torcx/profiles/vendor.json Nov 1 00:11:17.289455 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:20.10.torcx.tgz" reference=20.10 Nov 1 00:11:17.289534 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=debug msg="new archive/reference added to cache" format=tgz name=docker path="/usr/share/torcx/store/docker:com.coreos.cl.torcx.tgz" reference=com.coreos.cl Nov 1 00:11:17.289581 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store/3510.3.8: no such file or directory" path=/usr/share/oem/torcx/store/3510.3.8 Nov 1 00:11:17.289622 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=info msg="store skipped" err="open /usr/share/oem/torcx/store: no such file or directory" path=/usr/share/oem/torcx/store Nov 1 00:11:17.289720 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=info msg="store skipped" err="open /var/lib/torcx/store/3510.3.8: no such file or directory" path=/var/lib/torcx/store/3510.3.8 Nov 1 00:11:17.289792 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:17Z" level=info msg="store skipped" err="open /var/lib/torcx/store: no such file or directory" path=/var/lib/torcx/store Nov 1 00:11:20.557408 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="image unpacked" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 1 00:11:20.557959 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="binaries propagated" assets="[/bin/containerd /bin/containerd-shim /bin/ctr /bin/docker /bin/docker-containerd /bin/docker-containerd-shim /bin/docker-init /bin/docker-proxy /bin/docker-runc /bin/dockerd /bin/runc /bin/tini]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 1 00:11:22.092404 systemd[1]: Starting systemd-journal-flush.service... Nov 1 00:11:20.558196 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="networkd units propagated" assets="[/lib/systemd/network/50-docker.network /lib/systemd/network/90-docker-veth.network]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 1 00:11:20.558631 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="systemd units propagated" assets="[/lib/systemd/system/containerd.service /lib/systemd/system/docker.service /lib/systemd/system/docker.socket /lib/systemd/system/sockets.target.wants /lib/systemd/system/multi-user.target.wants]" image=docker path=/run/torcx/unpack/docker reference=com.coreos.cl Nov 1 00:11:20.558740 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="profile applied" sealed profile=/run/torcx/profile.json upper profile= Nov 1 00:11:20.558911 /usr/lib/systemd/system-generators/torcx-generator[1411]: time="2025-11-01T00:11:20Z" level=debug msg="system state sealed" content="[TORCX_LOWER_PROFILES=\"vendor\" TORCX_UPPER_PROFILE=\"\" TORCX_PROFILE_PATH=\"/run/torcx/profile.json\" TORCX_BINDIR=\"/run/torcx/bin\" TORCX_UNPACKDIR=\"/run/torcx/unpack\"]" path=/run/metadata/torcx Nov 1 00:11:22.107480 systemd[1]: Finished systemd-random-seed.service. Nov 1 00:11:22.108000 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' Nov 1 00:11:22.109809 systemd[1]: Reached target first-boot-complete.target. Nov 1 00:11:22.122704 systemd-journald[1489]: Time spent on flushing to /var/log/journal/ec287366509f292a56e48654bf382e4c is 42.978ms for 1109 entries. Nov 1 00:11:22.122704 systemd-journald[1489]: System Journal (/var/log/journal/ec287366509f292a56e48654bf382e4c) is 8.0M, max 195.6M, 187.6M free. Nov 1 00:11:22.183976 systemd-journald[1489]: Received client request to flush runtime journal. Nov 1 00:11:22.131000 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' Nov 1 00:11:22.159000 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' Nov 1 00:11:22.133137 systemd[1]: Finished systemd-sysctl.service. Nov 1 00:11:22.158220 systemd[1]: Finished flatcar-tmpfiles.service. Nov 1 00:11:22.193000 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' Nov 1 00:11:22.162457 systemd[1]: Starting systemd-sysusers.service... Nov 1 00:11:22.192470 systemd[1]: Finished systemd-journal-flush.service. Nov 1 00:11:22.224382 systemd[1]: Finished systemd-udev-trigger.service. Nov 1 00:11:22.225000 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' Nov 1 00:11:22.228884 systemd[1]: Starting systemd-udev-settle.service... Nov 1 00:11:22.244703 udevadm[1529]: systemd-udev-settle.service is deprecated. Please fix lvm2-activation-early.service, lvm2-activation.service not to pull it in. Nov 1 00:11:22.393070 systemd[1]: Finished systemd-sysusers.service. Nov 1 00:11:22.393000 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' Nov 1 00:11:22.962000 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' Nov 1 00:11:22.964000 audit: BPF prog-id=18 op=LOAD Nov 1 00:11:22.964000 audit: BPF prog-id=19 op=LOAD Nov 1 00:11:22.964000 audit: BPF prog-id=7 op=UNLOAD Nov 1 00:11:22.964000 audit: BPF prog-id=8 op=UNLOAD Nov 1 00:11:22.962483 systemd[1]: Finished systemd-hwdb-update.service. Nov 1 00:11:22.967065 systemd[1]: Starting systemd-udevd.service... Nov 1 00:11:23.006409 systemd-udevd[1530]: Using default interface naming scheme 'v252'. Nov 1 00:11:23.070272 systemd[1]: Started systemd-udevd.service. Nov 1 00:11:23.070000 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' Nov 1 00:11:23.074000 audit: BPF prog-id=20 op=LOAD Nov 1 00:11:23.077885 systemd[1]: Starting systemd-networkd.service... Nov 1 00:11:23.095000 audit: BPF prog-id=21 op=LOAD Nov 1 00:11:23.095000 audit: BPF prog-id=22 op=LOAD Nov 1 00:11:23.095000 audit: BPF prog-id=23 op=LOAD Nov 1 00:11:23.098361 systemd[1]: Starting systemd-userdbd.service... Nov 1 00:11:23.176845 systemd[1]: Started systemd-userdbd.service. Nov 1 00:11:23.179000 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' Nov 1 00:11:23.186095 systemd[1]: Condition check resulted in dev-ttyS0.device being skipped. Nov 1 00:11:23.191387 (udev-worker)[1537]: Network interface NamePolicy= disabled on kernel command line. Nov 1 00:11:23.361876 systemd-networkd[1534]: lo: Link UP Nov 1 00:11:23.362396 systemd-networkd[1534]: lo: Gained carrier Nov 1 00:11:23.363555 systemd-networkd[1534]: Enumeration completed Nov 1 00:11:23.364097 systemd[1]: Started systemd-networkd.service. Nov 1 00:11:23.365000 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' Nov 1 00:11:23.372885 systemd[1]: Starting systemd-networkd-wait-online.service... Nov 1 00:11:23.380144 systemd-networkd[1534]: eth0: Configuring with /usr/lib/systemd/network/zz-default.network. Nov 1 00:11:23.392799 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready Nov 1 00:11:23.392931 systemd-networkd[1534]: eth0: Link UP Nov 1 00:11:23.393442 systemd-networkd[1534]: eth0: Gained carrier Nov 1 00:11:23.422022 systemd-networkd[1534]: eth0: DHCPv4 address 172.31.30.50/20, gateway 172.31.16.1 acquired from 172.31.16.1 Nov 1 00:11:23.558227 systemd[1]: Found device dev-disk-by\x2dlabel-OEM.device. Nov 1 00:11:23.561081 systemd[1]: Finished systemd-udev-settle.service. Nov 1 00:11:23.562000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-udev-settle comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:23.565651 systemd[1]: Starting lvm2-activation-early.service... Nov 1 00:11:23.611548 lvm[1649]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:11:23.650492 systemd[1]: Finished lvm2-activation-early.service. Nov 1 00:11:23.650000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation-early comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:23.652879 systemd[1]: Reached target cryptsetup.target. Nov 1 00:11:23.657060 systemd[1]: Starting lvm2-activation.service... Nov 1 00:11:23.665946 lvm[1650]: WARNING: Failed to connect to lvmetad. Falling back to device scanning. Nov 1 00:11:23.697495 systemd[1]: Finished lvm2-activation.service. Nov 1 00:11:23.698000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=lvm2-activation comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:23.700022 systemd[1]: Reached target local-fs-pre.target. Nov 1 00:11:23.702118 systemd[1]: var-lib-machines.mount was skipped because of an unmet condition check (ConditionPathExists=/var/lib/machines.raw). Nov 1 00:11:23.702177 systemd[1]: Reached target local-fs.target. Nov 1 00:11:23.704135 systemd[1]: Reached target machines.target. Nov 1 00:11:23.708408 systemd[1]: Starting ldconfig.service... Nov 1 00:11:23.711300 systemd[1]: systemd-binfmt.service was skipped because no trigger condition checks were met. Nov 1 00:11:23.711463 systemd[1]: systemd-boot-system-token.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/LoaderFeatures-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Nov 1 00:11:23.713864 systemd[1]: Starting systemd-boot-update.service... Nov 1 00:11:23.717847 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-OEM.service... Nov 1 00:11:23.723560 systemd[1]: Starting systemd-machine-id-commit.service... Nov 1 00:11:23.728197 systemd[1]: systemd-sysext.service was skipped because no trigger condition checks were met. Nov 1 00:11:23.728351 systemd[1]: ensure-sysext.service was skipped because no trigger condition checks were met. Nov 1 00:11:23.730682 systemd[1]: Starting systemd-tmpfiles-setup.service... Nov 1 00:11:23.757807 systemd[1]: boot.automount: Got automount request for /boot, triggered by 1652 (bootctl) Nov 1 00:11:23.760321 systemd[1]: Starting systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service... Nov 1 00:11:23.776116 systemd[1]: etc-machine\x2did.mount: Deactivated successfully. Nov 1 00:11:23.779000 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' Nov 1 00:11:23.778852 systemd[1]: Finished systemd-machine-id-commit.service. Nov 1 00:11:23.797000 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' Nov 1 00:11:23.795706 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-OEM.service. Nov 1 00:11:23.802369 systemd-tmpfiles[1655]: /usr/lib/tmpfiles.d/legacy.conf:13: Duplicate line for path "/run/lock", ignoring. Nov 1 00:11:23.848877 systemd-tmpfiles[1655]: /usr/lib/tmpfiles.d/provision.conf:20: Duplicate line for path "/root", ignoring. Nov 1 00:11:23.873949 systemd-tmpfiles[1655]: /usr/lib/tmpfiles.d/systemd.conf:29: Duplicate line for path "/var/lib/systemd", ignoring. Nov 1 00:11:23.890962 systemd-fsck[1660]: fsck.fat 4.2 (2021-01-31) Nov 1 00:11:23.890962 systemd-fsck[1660]: /dev/nvme0n1p1: 236 files, 117310/258078 clusters Nov 1 00:11:23.894907 systemd[1]: Finished systemd-fsck@dev-disk-by\x2dlabel-EFI\x2dSYSTEM.service. Nov 1 00:11:23.895000 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-EFI\x2dSYSTEM comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:23.899678 systemd[1]: Mounting boot.mount... Nov 1 00:11:23.920052 systemd[1]: Mounted boot.mount. Nov 1 00:11:23.952000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-boot-update comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:23.951716 systemd[1]: Finished systemd-boot-update.service. Nov 1 00:11:24.243387 systemd[1]: Finished systemd-tmpfiles-setup.service. Nov 1 00:11:24.248289 systemd[1]: Starting audit-rules.service... Nov 1 00:11:24.242000 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' Nov 1 00:11:24.256040 systemd[1]: Starting clean-ca-certificates.service... Nov 1 00:11:24.263000 audit: BPF prog-id=24 op=LOAD Nov 1 00:11:24.271000 audit: BPF prog-id=25 op=LOAD Nov 1 00:11:24.260723 systemd[1]: Starting systemd-journal-catalog-update.service... Nov 1 00:11:24.269149 systemd[1]: Starting systemd-resolved.service... Nov 1 00:11:24.276167 systemd[1]: Starting systemd-timesyncd.service... Nov 1 00:11:24.282555 systemd[1]: Starting systemd-update-utmp.service... Nov 1 00:11:24.306870 systemd[1]: Finished clean-ca-certificates.service. Nov 1 00:11:24.308000 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' Nov 1 00:11:24.309437 systemd[1]: update-ca-certificates.service was skipped because of an unmet condition check (ConditionPathIsSymbolicLink=!/etc/ssl/certs/ca-certificates.crt). Nov 1 00:11:24.319000 audit[1680]: SYSTEM_BOOT pid=1680 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' Nov 1 00:11:24.325338 systemd[1]: Finished systemd-update-utmp.service. Nov 1 00:11:24.323000 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' Nov 1 00:11:24.371410 systemd[1]: Finished systemd-journal-catalog-update.service. Nov 1 00:11:24.369000 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' Nov 1 00:11:24.437000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=add_rule key=(null) list=5 res=1 Nov 1 00:11:24.437000 audit[1694]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffd689f1d0 a2=420 a3=0 items=0 ppid=1674 pid=1694 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/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:11:24.437000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D52002F6574632F61756469742F61756469742E72756C6573 Nov 1 00:11:24.439985 augenrules[1694]: No rules Nov 1 00:11:24.441158 systemd[1]: Finished audit-rules.service. Nov 1 00:11:24.455152 systemd[1]: Started systemd-timesyncd.service. Nov 1 00:11:24.457386 systemd[1]: Reached target time-set.target. Nov 1 00:11:24.484790 systemd-resolved[1678]: Positive Trust Anchors: Nov 1 00:11:24.484816 systemd-resolved[1678]: . IN DS 20326 8 2 e06d44b80b8f1d39a95c0b0d7c65d08458e880409bbc683457104237c7f8ec8d Nov 1 00:11:24.484868 systemd-resolved[1678]: 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 168.192.in-addr.arpa d.f.ip6.arpa corp home internal intranet lan local private test Nov 1 00:11:24.538913 systemd-resolved[1678]: Defaulting to hostname 'linux'. Nov 1 00:11:24.542089 systemd[1]: Started systemd-resolved.service. Nov 1 00:11:24.544343 systemd[1]: Reached target network.target. Nov 1 00:11:24.546278 systemd[1]: Reached target nss-lookup.target. Nov 1 00:11:25.043633 ldconfig[1651]: /sbin/ldconfig: /lib/ld.so.conf is not an ELF file - it has the wrong magic bytes at the start. Nov 1 00:11:25.049947 systemd[1]: Finished ldconfig.service. Nov 1 00:11:25.054375 systemd[1]: Starting systemd-update-done.service... Nov 1 00:11:25.069361 systemd[1]: Finished systemd-update-done.service. Nov 1 00:11:25.071626 systemd[1]: Reached target sysinit.target. Nov 1 00:11:25.073650 systemd[1]: Started motdgen.path. Nov 1 00:11:25.075317 systemd[1]: Started user-cloudinit@var-lib-flatcar\x2dinstall-user_data.path. Nov 1 00:11:25.078160 systemd[1]: Started logrotate.timer. Nov 1 00:11:25.080036 systemd[1]: Started mdadm.timer. Nov 1 00:11:25.081665 systemd[1]: Started systemd-tmpfiles-clean.timer. Nov 1 00:11:25.083597 systemd[1]: update-engine-stub.timer was skipped because of an unmet condition check (ConditionPathExists=/usr/.noupdate). Nov 1 00:11:25.083654 systemd[1]: Reached target paths.target. Nov 1 00:11:25.085315 systemd[1]: Reached target timers.target. Nov 1 00:11:25.088080 systemd[1]: Listening on dbus.socket. Nov 1 00:11:25.091928 systemd[1]: Starting docker.socket... Nov 1 00:11:25.099047 systemd[1]: Listening on sshd.socket. Nov 1 00:11:25.101044 systemd[1]: systemd-pcrphase-sysinit.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Nov 1 00:11:25.101992 systemd[1]: Listening on docker.socket. Nov 1 00:11:25.104045 systemd[1]: Reached target sockets.target. Nov 1 00:11:25.105947 systemd[1]: Reached target basic.target. Nov 1 00:11:25.107808 systemd[1]: addon-config@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:11:25.107864 systemd[1]: addon-run@usr-share-oem.service was skipped because no trigger condition checks were met. Nov 1 00:11:25.110034 systemd[1]: Starting containerd.service... Nov 1 00:11:25.114974 systemd[1]: Starting coreos-metadata-sshkeys@core.service... Nov 1 00:11:25.119576 systemd[1]: Starting coreos-metadata.service... Nov 1 00:11:25.126010 systemd-networkd[1534]: eth0: Gained IPv6LL Nov 1 00:11:25.126835 systemd[1]: Starting dbus.service... Nov 1 00:11:25.128473 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:25.132914 systemd[1]: Starting enable-oem-cloudinit.service... Nov 1 00:11:25.137994 systemd[1]: Starting extend-filesystems.service... Nov 1 00:11:25.139971 systemd[1]: flatcar-setup-environment.service was skipped because of an unmet condition check (ConditionPathExists=/usr/share/oem/bin/flatcar-setup-environment). Nov 1 00:11:25.142898 systemd[1]: Starting motdgen.service... Nov 1 00:11:25.150440 systemd[1]: Starting ssh-key-proc-cmdline.service... Nov 1 00:11:25.194923 jq[1707]: false Nov 1 00:11:25.154835 systemd[1]: Starting sshd-keygen.service... Nov 1 00:11:25.163742 systemd[1]: Starting systemd-logind.service... Nov 1 00:11:25.165607 systemd[1]: systemd-pcrphase.service was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Nov 1 00:11:25.165735 systemd[1]: tcsd.service was skipped because of an unmet condition check (ConditionPathExists=/dev/tpm0). Nov 1 00:11:25.319012 jq[1714]: true Nov 1 00:11:25.166696 systemd[1]: cgroup compatibility translation between legacy and unified hierarchy settings activated. See cgroup-compat debug messages for details. Nov 1 00:11:25.171075 systemd[1]: Starting update-engine.service... Nov 1 00:11:25.175737 systemd[1]: Starting update-ssh-keys-after-ignition.service... Nov 1 00:11:25.179920 systemd[1]: Finished systemd-networkd-wait-online.service. Nov 1 00:11:25.184318 systemd[1]: Reached target network-online.target. Nov 1 00:11:25.191081 systemd[1]: Started amazon-ssm-agent.service. Nov 1 00:11:25.195931 systemd[1]: Started nvidia.service. Nov 1 00:11:25.206462 systemd[1]: enable-oem-cloudinit.service: Skipped due to 'exec-condition'. Nov 1 00:11:25.206856 systemd[1]: Condition check resulted in enable-oem-cloudinit.service being skipped. Nov 1 00:11:25.246897 systemd[1]: ssh-key-proc-cmdline.service: Deactivated successfully. Nov 1 00:11:25.247294 systemd[1]: Finished ssh-key-proc-cmdline.service. Nov 1 00:11:25.359198 jq[1719]: true Nov 1 00:11:25.403302 extend-filesystems[1708]: Found nvme0n1 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p1 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p2 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p3 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found usr Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p4 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p6 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p7 Nov 1 00:11:25.405409 extend-filesystems[1708]: Found nvme0n1p9 Nov 1 00:11:25.405409 extend-filesystems[1708]: Checking size of /dev/nvme0n1p9 Nov 1 00:11:25.458257 systemd[1]: motdgen.service: Deactivated successfully. Nov 1 00:11:25.458671 systemd[1]: Finished motdgen.service. Nov 1 00:11:25.478845 extend-filesystems[1708]: Resized partition /dev/nvme0n1p9 Nov 1 00:11:25.506439 dbus-daemon[1706]: [system] SELinux support is enabled Nov 1 00:11:25.509084 extend-filesystems[1749]: resize2fs 1.46.5 (30-Dec-2021) Nov 1 00:11:25.506798 systemd[1]: Started dbus.service. Nov 1 00:11:25.514099 systemd[1]: system-cloudinit@usr-share-oem-cloud\x2dconfig.yml.service was skipped because of an unmet condition check (ConditionFileNotEmpty=/usr/share/oem/cloud-config.yml). Nov 1 00:11:25.514160 systemd[1]: Reached target system-config.target. Nov 1 00:11:25.524554 systemd[1]: user-cloudinit-proc-cmdline.service was skipped because of an unmet condition check (ConditionKernelCommandLine=cloud-config-url). Nov 1 00:11:25.524606 systemd[1]: Reached target user-config.target. Nov 1 00:11:25.539801 kernel: EXT4-fs (nvme0n1p9): resizing filesystem from 553472 to 3587067 blocks Nov 1 00:11:25.553878 dbus-daemon[1706]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.2' (uid=244 pid=1534 comm="/usr/lib/systemd/systemd-networkd" label="system_u:system_r:kernel_t:s0") Nov 1 00:11:25.560216 systemd[1]: Starting systemd-hostnamed.service... Nov 1 00:11:25.648827 kernel: EXT4-fs (nvme0n1p9): resized filesystem to 3587067 Nov 1 00:11:25.657854 amazon-ssm-agent[1716]: 2025/11/01 00:11:25 Failed to load instance info from vault. RegistrationKey does not exist. Nov 1 00:11:25.660450 extend-filesystems[1749]: Filesystem at /dev/nvme0n1p9 is mounted on /; on-line resizing required Nov 1 00:11:25.660450 extend-filesystems[1749]: old_desc_blocks = 1, new_desc_blocks = 2 Nov 1 00:11:25.660450 extend-filesystems[1749]: The filesystem on /dev/nvme0n1p9 is now 3587067 (4k) blocks long. Nov 1 00:11:25.673541 extend-filesystems[1708]: Resized filesystem in /dev/nvme0n1p9 Nov 1 00:11:25.676734 bash[1777]: Updated "/home/core/.ssh/authorized_keys" Nov 1 00:11:25.666256 systemd[1]: extend-filesystems.service: Deactivated successfully. Nov 1 00:11:25.666603 systemd[1]: Finished extend-filesystems.service. Nov 1 00:11:25.676478 systemd[1]: Finished update-ssh-keys-after-ignition.service. Nov 1 00:11:25.700045 update_engine[1713]: I1101 00:11:25.699501 1713 main.cc:92] Flatcar Update Engine starting Nov 1 00:11:25.709545 amazon-ssm-agent[1716]: Initializing new seelog logger Nov 1 00:11:25.715865 systemd[1]: Started update-engine.service. Nov 1 00:11:25.720911 systemd[1]: Started locksmithd.service. Nov 1 00:11:25.724644 update_engine[1713]: I1101 00:11:25.721722 1713 update_check_scheduler.cc:74] Next update check in 2m36s Nov 1 00:11:25.734176 amazon-ssm-agent[1716]: New Seelog Logger Creation Complete Nov 1 00:11:25.735052 amazon-ssm-agent[1716]: 2025/11/01 00:11:25 Found config file at /etc/amazon/ssm/amazon-ssm-agent.json. Nov 1 00:11:25.735982 amazon-ssm-agent[1716]: Applying config override from /etc/amazon/ssm/amazon-ssm-agent.json. Nov 1 00:11:25.736664 amazon-ssm-agent[1716]: 2025/11/01 00:11:25 processing appconfig overrides Nov 1 00:11:25.837929 systemd-logind[1712]: Watching system buttons on /dev/input/event0 (Power Button) Nov 1 00:11:25.839312 systemd-logind[1712]: Watching system buttons on /dev/input/event1 (Sleep Button) Nov 1 00:11:25.845950 systemd-logind[1712]: New seat seat0. Nov 1 00:11:25.861433 systemd[1]: Started systemd-logind.service. Nov 1 00:11:25.870626 systemd[1]: nvidia.service: Deactivated successfully. Nov 1 00:11:25.916730 env[1726]: time="2025-11-01T00:11:25.916581733Z" level=info msg="starting containerd" revision=92b3a9d6f1b3bcc6dc74875cfdea653fe39f09c2 version=1.6.16 Nov 1 00:11:26.008060 dbus-daemon[1706]: [system] Successfully activated service 'org.freedesktop.hostname1' Nov 1 00:11:26.008305 systemd[1]: Started systemd-hostnamed.service. Nov 1 00:11:26.011598 dbus-daemon[1706]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.6' (uid=0 pid=1765 comm="/usr/lib/systemd/systemd-hostnamed" label="system_u:system_r:kernel_t:s0") Nov 1 00:11:26.016947 systemd[1]: Starting polkit.service... Nov 1 00:11:26.077214 polkitd[1817]: Started polkitd version 121 Nov 1 00:11:26.089693 env[1726]: time="2025-11-01T00:11:26.089627014Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1 Nov 1 00:11:26.090162 env[1726]: time="2025-11-01T00:11:26.090121222Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.aufs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.097877 env[1726]: time="2025-11-01T00:11:26.097744906Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.aufs\"..." error="aufs is not supported (modprobe aufs failed: exit status 1 \"modprobe: FATAL: Module aufs not found in directory /lib/modules/5.15.192-flatcar\\n\"): skip plugin" type=io.containerd.snapshotter.v1 Nov 1 00:11:26.098089 env[1726]: time="2025-11-01T00:11:26.098051350Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.098649 env[1726]: time="2025-11-01T00:11:26.098603758Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.btrfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.btrfs (ext4) must be a btrfs filesystem to be used with the btrfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 1 00:11:26.099333 env[1726]: time="2025-11-01T00:11:26.099295078Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.devmapper\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.099484 env[1726]: time="2025-11-01T00:11:26.099452254Z" level=warning msg="failed to load plugin io.containerd.snapshotter.v1.devmapper" error="devmapper not configured" Nov 1 00:11:26.099597 env[1726]: time="2025-11-01T00:11:26.099567826Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.native\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.099938 env[1726]: time="2025-11-01T00:11:26.099905182Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.overlayfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.101513 env[1726]: time="2025-11-01T00:11:26.101461630Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.zfs\"..." type=io.containerd.snapshotter.v1 Nov 1 00:11:26.105738 env[1726]: time="2025-11-01T00:11:26.105676546Z" level=info msg="skip loading plugin \"io.containerd.snapshotter.v1.zfs\"..." error="path /var/lib/containerd/io.containerd.snapshotter.v1.zfs must be a zfs filesystem to be used with the zfs snapshotter: skip plugin" type=io.containerd.snapshotter.v1 Nov 1 00:11:26.106899 env[1726]: time="2025-11-01T00:11:26.106845670Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1 Nov 1 00:11:26.107394 env[1726]: time="2025-11-01T00:11:26.107350642Z" level=warning msg="could not use snapshotter devmapper in metadata plugin" error="devmapper not configured" Nov 1 00:11:26.107843 env[1726]: time="2025-11-01T00:11:26.107806402Z" level=info msg="metadata content store policy set" policy=shared Nov 1 00:11:26.114487 env[1726]: time="2025-11-01T00:11:26.114426814Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1 Nov 1 00:11:26.114705 env[1726]: time="2025-11-01T00:11:26.114672322Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1 Nov 1 00:11:26.114884 env[1726]: time="2025-11-01T00:11:26.114852070Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1 Nov 1 00:11:26.115055 env[1726]: time="2025-11-01T00:11:26.115021462Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.115324 env[1726]: time="2025-11-01T00:11:26.115287466Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.115464 env[1726]: time="2025-11-01T00:11:26.115434490Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.115592 env[1726]: time="2025-11-01T00:11:26.115562734Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.116298 env[1726]: time="2025-11-01T00:11:26.116244094Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.116512 env[1726]: time="2025-11-01T00:11:26.116460058Z" level=info msg="loading plugin \"io.containerd.service.v1.leases-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.116646 env[1726]: time="2025-11-01T00:11:26.116615650Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.116844 env[1726]: time="2025-11-01T00:11:26.116813734Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.116967 env[1726]: time="2025-11-01T00:11:26.116938330Z" level=info msg="loading plugin \"io.containerd.runtime.v1.linux\"..." type=io.containerd.runtime.v1 Nov 1 00:11:26.117301 env[1726]: time="2025-11-01T00:11:26.117266818Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2 Nov 1 00:11:26.117604 env[1726]: time="2025-11-01T00:11:26.117570586Z" level=info msg="loading plugin \"io.containerd.monitor.v1.cgroups\"..." type=io.containerd.monitor.v1 Nov 1 00:11:26.118453 env[1726]: time="2025-11-01T00:11:26.118387198Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1 Nov 1 00:11:26.118566 env[1726]: time="2025-11-01T00:11:26.118469674Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118566 env[1726]: time="2025-11-01T00:11:26.118505086Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1 Nov 1 00:11:26.118806 env[1726]: time="2025-11-01T00:11:26.118731406Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118875 env[1726]: time="2025-11-01T00:11:26.118806562Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118875 env[1726]: time="2025-11-01T00:11:26.118840942Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118978 env[1726]: time="2025-11-01T00:11:26.118871890Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118978 env[1726]: time="2025-11-01T00:11:26.118902994Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118978 env[1726]: time="2025-11-01T00:11:26.118934278Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.118978 env[1726]: time="2025-11-01T00:11:26.118964614Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.119182 env[1726]: time="2025-11-01T00:11:26.118995442Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.119182 env[1726]: time="2025-11-01T00:11:26.119029354Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1 Nov 1 00:11:26.119370 env[1726]: time="2025-11-01T00:11:26.119325190Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.119447 env[1726]: time="2025-11-01T00:11:26.119374114Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.119447 env[1726]: time="2025-11-01T00:11:26.119410390Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.119550 env[1726]: time="2025-11-01T00:11:26.119440642Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1 Nov 1 00:11:26.119550 env[1726]: time="2025-11-01T00:11:26.119476666Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="no OpenTelemetry endpoint: skip plugin" type=io.containerd.tracing.processor.v1 Nov 1 00:11:26.119550 env[1726]: time="2025-11-01T00:11:26.119503906Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1 Nov 1 00:11:26.119550 env[1726]: time="2025-11-01T00:11:26.119538958Z" level=error msg="failed to initialize a tracing processor \"otlp\"" error="no OpenTelemetry endpoint: skip plugin" Nov 1 00:11:26.119742 env[1726]: time="2025-11-01T00:11:26.119603794Z" level=info msg="loading plugin \"io.containerd.grpc.v1.cri\"..." type=io.containerd.grpc.v1 Nov 1 00:11:26.120086 env[1726]: time="2025-11-01T00:11:26.119964142Z" level=info msg="Start cri plugin with config {PluginConfig:{ContainerdConfig:{Snapshotter:overlayfs DefaultRuntimeName:runc DefaultRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} UntrustedWorkloadRuntime:{Type: Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0} Runtimes:map[runc:{Type:io.containerd.runc.v2 Path: Engine: PodAnnotations:[] ContainerAnnotations:[] Root: Options:map[SystemdCgroup:true] PrivilegedWithoutHostDevices:false BaseRuntimeSpec: NetworkPluginConfDir: NetworkPluginMaxConfNum:0}] NoPivot:false DisableSnapshotAnnotations:true DiscardUnpackedLayers:false IgnoreRdtNotEnabledErrors:false} CniConfig:{NetworkPluginBinDir:/opt/cni/bin NetworkPluginConfDir:/etc/cni/net.d NetworkPluginMaxConfNum:1 NetworkPluginConfTemplate: IPPreference:} Registry:{ConfigPath: Mirrors:map[] Configs:map[] Auths:map[] Headers:map[]} ImageDecryption:{KeyModel:node} DisableTCPService:true StreamServerAddress:127.0.0.1 StreamServerPort:0 StreamIdleTimeout:4h0m0s EnableSelinux:true SelinuxCategoryRange:1024 SandboxImage:registry.k8s.io/pause:3.6 StatsCollectPeriod:10 SystemdCgroup:false EnableTLSStreaming:false X509KeyPairStreaming:{TLSCertFile: TLSKeyFile:} MaxContainerLogLineSize:16384 DisableCgroup:false DisableApparmor:false RestrictOOMScoreAdj:false MaxConcurrentDownloads:3 DisableProcMount:false UnsetSeccompProfile: TolerateMissingHugetlbController:true DisableHugetlbController:true DeviceOwnershipFromSecurityContext:false IgnoreImageDefinedVolumes:false NetNSMountsUnderStateDir:false EnableUnprivilegedPorts:false EnableUnprivilegedICMP:false} 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}" Nov 1 00:11:26.122242 env[1726]: time="2025-11-01T00:11:26.120089566Z" level=info msg="Connect containerd service" Nov 1 00:11:26.122242 env[1726]: time="2025-11-01T00:11:26.120155374Z" level=info msg="Get image filesystem path \"/var/lib/containerd/io.containerd.snapshotter.v1.overlayfs\"" Nov 1 00:11:26.122242 env[1726]: time="2025-11-01T00:11:26.121435150Z" 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" Nov 1 00:11:26.122515 polkitd[1817]: Loading rules from directory /etc/polkit-1/rules.d Nov 1 00:11:26.122624 polkitd[1817]: Loading rules from directory /usr/share/polkit-1/rules.d Nov 1 00:11:26.124866 env[1726]: time="2025-11-01T00:11:26.124795654Z" level=info msg=serving... address=/run/containerd/containerd.sock.ttrpc Nov 1 00:11:26.125000 env[1726]: time="2025-11-01T00:11:26.124937902Z" level=info msg=serving... address=/run/containerd/containerd.sock Nov 1 00:11:26.125146 systemd[1]: Started containerd.service. Nov 1 00:11:26.128941 env[1726]: time="2025-11-01T00:11:26.128726950Z" level=info msg="containerd successfully booted in 0.213631s" Nov 1 00:11:26.129517 env[1726]: time="2025-11-01T00:11:26.129456574Z" level=info msg="Start subscribing containerd event" Nov 1 00:11:26.129685 env[1726]: time="2025-11-01T00:11:26.129655630Z" level=info msg="Start recovering state" Nov 1 00:11:26.129935 env[1726]: time="2025-11-01T00:11:26.129907594Z" level=info msg="Start event monitor" Nov 1 00:11:26.133908 env[1726]: time="2025-11-01T00:11:26.133847338Z" level=info msg="Start snapshots syncer" Nov 1 00:11:26.134113 env[1726]: time="2025-11-01T00:11:26.134080354Z" level=info msg="Start cni network conf syncer for default" Nov 1 00:11:26.134234 env[1726]: time="2025-11-01T00:11:26.134204938Z" level=info msg="Start streaming server" Nov 1 00:11:26.136146 polkitd[1817]: Finished loading, compiling and executing 2 rules Nov 1 00:11:26.139506 dbus-daemon[1706]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Nov 1 00:11:26.139817 systemd[1]: Started polkit.service. Nov 1 00:11:26.142127 polkitd[1817]: Acquired the name org.freedesktop.PolicyKit1 on the system bus Nov 1 00:11:26.195909 systemd-resolved[1678]: System hostname changed to 'ip-172-31-30-50'. Nov 1 00:11:26.195919 systemd-hostnamed[1765]: Hostname set to (transient) Nov 1 00:11:26.266947 coreos-metadata[1704]: Nov 01 00:11:26.266 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 1 00:11:26.268700 coreos-metadata[1704]: Nov 01 00:11:26.268 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys: Attempt #1 Nov 1 00:11:26.270794 coreos-metadata[1704]: Nov 01 00:11:26.270 INFO Fetch successful Nov 1 00:11:26.271147 coreos-metadata[1704]: Nov 01 00:11:26.270 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-keys/0/openssh-key: Attempt #1 Nov 1 00:11:26.272866 coreos-metadata[1704]: Nov 01 00:11:26.272 INFO Fetch successful Nov 1 00:11:26.277354 unknown[1704]: wrote ssh authorized keys file for user: core Nov 1 00:11:26.297291 update-ssh-keys[1879]: Updated "/home/core/.ssh/authorized_keys" Nov 1 00:11:26.298308 systemd[1]: Finished coreos-metadata-sshkeys@core.service. Nov 1 00:11:26.308307 coreos-metadata[1705]: Nov 01 00:11:26.308 INFO Putting http://169.254.169.254/latest/api/token: Attempt #1 Nov 1 00:11:26.309535 coreos-metadata[1705]: Nov 01 00:11:26.309 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-id: Attempt #1 Nov 1 00:11:26.311024 coreos-metadata[1705]: Nov 01 00:11:26.310 INFO Fetch successful Nov 1 00:11:26.311024 coreos-metadata[1705]: Nov 01 00:11:26.310 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/instance-type: Attempt #1 Nov 1 00:11:26.312006 coreos-metadata[1705]: Nov 01 00:11:26.311 INFO Fetch successful Nov 1 00:11:26.312006 coreos-metadata[1705]: Nov 01 00:11:26.311 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/local-ipv4: Attempt #1 Nov 1 00:11:26.313170 coreos-metadata[1705]: Nov 01 00:11:26.313 INFO Fetch successful Nov 1 00:11:26.313170 coreos-metadata[1705]: Nov 01 00:11:26.313 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-ipv4: Attempt #1 Nov 1 00:11:26.314096 coreos-metadata[1705]: Nov 01 00:11:26.314 INFO Fetch successful Nov 1 00:11:26.314096 coreos-metadata[1705]: Nov 01 00:11:26.314 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/placement/availability-zone: Attempt #1 Nov 1 00:11:26.314968 coreos-metadata[1705]: Nov 01 00:11:26.314 INFO Fetch successful Nov 1 00:11:26.314968 coreos-metadata[1705]: Nov 01 00:11:26.314 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/hostname: Attempt #1 Nov 1 00:11:26.315941 coreos-metadata[1705]: Nov 01 00:11:26.315 INFO Fetch successful Nov 1 00:11:26.315941 coreos-metadata[1705]: Nov 01 00:11:26.315 INFO Fetching http://169.254.169.254/2019-10-01/meta-data/public-hostname: Attempt #1 Nov 1 00:11:26.316730 coreos-metadata[1705]: Nov 01 00:11:26.316 INFO Fetch successful Nov 1 00:11:26.316730 coreos-metadata[1705]: Nov 01 00:11:26.316 INFO Fetching http://169.254.169.254/2019-10-01/dynamic/instance-identity/document: Attempt #1 Nov 1 00:11:26.317666 coreos-metadata[1705]: Nov 01 00:11:26.317 INFO Fetch successful Nov 1 00:11:26.333356 systemd[1]: Finished coreos-metadata.service. Nov 1 00:11:26.338635 systemd[1]: Starting etcd-member.service... Nov 1 00:11:26.556676 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Create new startup processor Nov 1 00:11:26.562180 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [LongRunningPluginsManager] registered plugins: {} Nov 1 00:11:26.562180 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing bookkeeping folders Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO removing the completed state files Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing bookkeeping folders for long running plugins Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing replies folder for MDS reply requests that couldn't reach the service Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing healthcheck folders for long running plugins Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing locations for inventory plugin Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing default location for custom inventory Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing default location for file inventory Nov 1 00:11:26.562393 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Initializing default location for role inventory Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Init the cloudwatchlogs publisher Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:refreshAssociation Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:runDocument Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:configurePackage Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:downloadContent Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:softwareInventory Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:runPowerShellScript Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:updateSsmAgent Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:configureDocker Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform independent plugin aws:runDockerAction Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Successfully loaded platform dependent plugin aws:runShellScript Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO Starting Agent: amazon-ssm-agent - v2.3.1319.0 Nov 1 00:11:26.562824 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO OS: linux, Arch: arm64 Nov 1 00:11:26.564278 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] Starting document processing engine... Nov 1 00:11:26.569299 amazon-ssm-agent[1716]: datastore file /var/lib/amazon/ssm/i-0b437f92f428184e6/longrunningplugins/datastore/store doesn't exist - no long running plugins to execute Nov 1 00:11:26.600469 systemd[1]: Starting docker.service... Nov 1 00:11:26.662986 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [EngineProcessor] Starting Nov 1 00:11:26.758174 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [EngineProcessor] Initial processing Nov 1 00:11:26.763380 env[1908]: time="2025-11-01T00:11:26.763311157Z" level=info msg="Starting up" Nov 1 00:11:26.767361 env[1908]: time="2025-11-01T00:11:26.767314321Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 1 00:11:26.767536 env[1908]: time="2025-11-01T00:11:26.767507617Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 1 00:11:26.767671 env[1908]: time="2025-11-01T00:11:26.767638525Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Nov 1 00:11:26.767835 env[1908]: time="2025-11-01T00:11:26.767779237Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 1 00:11:26.772350 env[1908]: time="2025-11-01T00:11:26.772297381Z" level=info msg="parsed scheme: \"unix\"" module=grpc Nov 1 00:11:26.772558 env[1908]: time="2025-11-01T00:11:26.772527613Z" level=info msg="scheme \"unix\" not registered, fallback to default scheme" module=grpc Nov 1 00:11:26.772682 env[1908]: time="2025-11-01T00:11:26.772650985Z" level=info msg="ccResolverWrapper: sending update to cc: {[{unix:///var/run/docker/libcontainerd/docker-containerd.sock 0 }] }" module=grpc Nov 1 00:11:26.772827 env[1908]: time="2025-11-01T00:11:26.772799185Z" level=info msg="ClientConn switching balancer to \"pick_first\"" module=grpc Nov 1 00:11:26.829677 env[1908]: time="2025-11-01T00:11:26.829545158Z" level=info msg="Loading containers: start." Nov 1 00:11:26.852720 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] Starting message polling Nov 1 00:11:26.947459 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] Starting send replies to MDS Nov 1 00:11:27.014028 locksmithd[1784]: locksmithd starting currentOperation="UPDATE_STATUS_IDLE" strategy="reboot" Nov 1 00:11:27.042372 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [instanceID=i-0b437f92f428184e6] Starting association polling Nov 1 00:11:27.137573 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Starting Nov 1 00:11:27.162789 kernel: Initializing XFRM netlink socket Nov 1 00:11:27.232790 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [Association] Launching response handler Nov 1 00:11:27.241081 env[1908]: time="2025-11-01T00:11:27.241019844Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address" Nov 1 00:11:27.243829 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:27.244046 (udev-worker)[1540]: Network interface NamePolicy= disabled on kernel command line. Nov 1 00:11:27.253731 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:27.258861 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:27.261404 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:27.328348 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [Association] [EngineProcessor] Initial processing Nov 1 00:11:27.355426 systemd-networkd[1534]: docker0: Link UP Nov 1 00:11:27.356154 systemd-timesyncd[1679]: Network configuration changed, trying to establish connection. Nov 1 00:11:27.394296 env[1908]: time="2025-11-01T00:11:27.394183656Z" level=info msg="Loading containers: done." Nov 1 00:11:27.424057 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [Association] Initializing association scheduling service Nov 1 00:11:27.426521 systemd[1]: var-lib-docker-overlay2-opaque\x2dbug\x2dcheck3222741155-merged.mount: Deactivated successfully. Nov 1 00:11:27.453062 env[1908]: time="2025-11-01T00:11:27.453005077Z" 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 Nov 1 00:11:27.453801 env[1908]: time="2025-11-01T00:11:27.453741565Z" level=info msg="Docker daemon" commit=112bdf3343 graphdriver(s)=overlay2 version=20.10.23 Nov 1 00:11:27.454219 env[1908]: time="2025-11-01T00:11:27.454168609Z" level=info msg="Daemon has completed initialization" Nov 1 00:11:27.479731 systemd[1]: Started docker.service. Nov 1 00:11:27.491443 env[1908]: time="2025-11-01T00:11:27.491344861Z" level=info msg="API listen on /run/docker.sock" Nov 1 00:11:27.493965 etcd-wrapper[1888]: Error response from daemon: No such container: etcd-member Nov 1 00:11:27.519937 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessagingDeliveryService] [Association] Association scheduling service initialized Nov 1 00:11:27.534201 etcd-wrapper[2022]: Error: No such container: etcd-member Nov 1 00:11:27.616095 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [HealthCheck] HealthCheck reporting agent health. Nov 1 00:11:27.638717 etcd-wrapper[2040]: Unable to find image 'quay.io/coreos/etcd:v3.5.0-arm64' locally Nov 1 00:11:27.712509 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] Starting session document processing engine... Nov 1 00:11:27.808910 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] [EngineProcessor] Starting Nov 1 00:11:27.905702 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] SSM Agent is trying to setup control channel for Session Manager module. Nov 1 00:11:28.002660 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] Setting up websocket for controlchannel for instance: i-0b437f92f428184e6, requestId: ef42ba9d-ed21-407d-9241-f83097b1e35b Nov 1 00:11:28.099675 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [OfflineService] Starting document processing engine... Nov 1 00:11:28.196909 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [OfflineService] [EngineProcessor] Starting Nov 1 00:11:28.294428 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [OfflineService] [EngineProcessor] Initial processing Nov 1 00:11:28.392038 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [OfflineService] Starting message polling Nov 1 00:11:28.489906 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [OfflineService] Starting send replies to MDS Nov 1 00:11:28.587967 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [LongRunningPluginsManager] starting long running plugin manager Nov 1 00:11:28.686154 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [LongRunningPluginsManager] there aren't any long running plugin to execute Nov 1 00:11:28.784623 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] listening reply. Nov 1 00:11:28.883366 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [LongRunningPluginsManager] There are no long running plugins currently getting executed - skipping their healthcheck Nov 1 00:11:28.974061 etcd-wrapper[2040]: v3.5.0-arm64: Pulling from coreos/etcd Nov 1 00:11:28.976719 etcd-wrapper[2040]: 6022c6b01d76: Pulling fs layer Nov 1 00:11:28.978322 etcd-wrapper[2040]: 1d97b1ec77fc: Pulling fs layer Nov 1 00:11:28.978842 etcd-wrapper[2040]: 99ef4b690837: Pulling fs layer Nov 1 00:11:28.979269 etcd-wrapper[2040]: 435b7bf0967c: Pulling fs layer Nov 1 00:11:28.979560 etcd-wrapper[2040]: 17e4a5f7c1b5: Pulling fs layer Nov 1 00:11:28.979944 etcd-wrapper[2040]: 5b0292999756: Pulling fs layer Nov 1 00:11:28.980271 etcd-wrapper[2040]: 435b7bf0967c: Waiting Nov 1 00:11:28.980796 etcd-wrapper[2040]: 17e4a5f7c1b5: Waiting Nov 1 00:11:28.981103 etcd-wrapper[2040]: 5b0292999756: Waiting Nov 1 00:11:28.982122 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [StartupProcessor] Executing startup processor tasks Nov 1 00:11:29.081201 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [StartupProcessor] Write to serial port: Amazon SSM Agent v2.3.1319.0 is running Nov 1 00:11:29.180554 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [StartupProcessor] Write to serial port: OsProductName: Flatcar Container Linux by Kinvolk Nov 1 00:11:29.280007 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [StartupProcessor] Write to serial port: OsVersion: 3510.3.8 Nov 1 00:11:29.379650 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] Opening websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0b437f92f428184e6?role=subscribe&stream=input Nov 1 00:11:29.458982 etcd-wrapper[2040]: 99ef4b690837: Verifying Checksum Nov 1 00:11:29.459341 etcd-wrapper[2040]: 99ef4b690837: Download complete Nov 1 00:11:29.467083 etcd-wrapper[2040]: 1d97b1ec77fc: Verifying Checksum Nov 1 00:11:29.467480 etcd-wrapper[2040]: 1d97b1ec77fc: Download complete Nov 1 00:11:29.479539 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] Successfully opened websocket connection to: wss://ssmmessages.us-west-2.amazonaws.com/v1/control-channel/i-0b437f92f428184e6?role=subscribe&stream=input Nov 1 00:11:29.579597 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] Starting receiving message from control channel Nov 1 00:11:29.679838 amazon-ssm-agent[1716]: 2025-11-01 00:11:26 INFO [MessageGatewayService] [EngineProcessor] Initial processing Nov 1 00:11:30.051734 etcd-wrapper[2040]: 17e4a5f7c1b5: Verifying Checksum Nov 1 00:11:30.052730 etcd-wrapper[2040]: 17e4a5f7c1b5: Download complete Nov 1 00:11:30.104118 sshd_keygen[1736]: ssh-keygen: generating new host keys: RSA ECDSA ED25519 Nov 1 00:11:30.143057 systemd[1]: Finished sshd-keygen.service. Nov 1 00:11:30.149211 systemd[1]: Starting issuegen.service... Nov 1 00:11:30.160252 systemd[1]: issuegen.service: Deactivated successfully. Nov 1 00:11:30.160653 systemd[1]: Finished issuegen.service. Nov 1 00:11:30.165453 systemd[1]: Starting systemd-user-sessions.service... Nov 1 00:11:30.181697 systemd[1]: Finished systemd-user-sessions.service. Nov 1 00:11:30.186662 systemd[1]: Started getty@tty1.service. Nov 1 00:11:30.191536 systemd[1]: Started serial-getty@ttyS0.service. Nov 1 00:11:30.194077 systemd[1]: Reached target getty.target. Nov 1 00:11:30.616889 etcd-wrapper[2040]: 5b0292999756: Verifying Checksum Nov 1 00:11:30.617069 etcd-wrapper[2040]: 5b0292999756: Download complete Nov 1 00:11:30.618469 etcd-wrapper[2040]: 435b7bf0967c: Verifying Checksum Nov 1 00:11:30.618649 etcd-wrapper[2040]: 435b7bf0967c: Download complete Nov 1 00:11:31.992516 etcd-wrapper[2040]: 6022c6b01d76: Verifying Checksum Nov 1 00:11:31.993206 etcd-wrapper[2040]: 6022c6b01d76: Download complete Nov 1 00:11:33.829781 etcd-wrapper[2040]: 6022c6b01d76: Pull complete Nov 1 00:11:34.325788 systemd[1]: var-lib-docker-overlay2-6de332f3f7ba8d0de9deafa8bb206308f264c994886e96af3f4c2c9f99ffe191-merged.mount: Deactivated successfully. Nov 1 00:11:34.535220 etcd-wrapper[2040]: 1d97b1ec77fc: Pull complete Nov 1 00:11:34.607741 systemd[1]: Created slice system-sshd.slice. Nov 1 00:11:34.612803 systemd[1]: Started sshd@0-172.31.30.50:22-147.75.109.163:35194.service. Nov 1 00:11:34.966187 systemd[1]: var-lib-docker-overlay2-6082fa6957d858d45bc7d34f4fcc6bed9b26c3a969c8a19942d5188de25f612e-merged.mount: Deactivated successfully. Nov 1 00:11:35.014157 etcd-wrapper[2040]: 99ef4b690837: Pull complete Nov 1 00:11:35.069784 sshd[2082]: Accepted publickey for core from 147.75.109.163 port 35194 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:35.074084 sshd[2082]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:35.097228 systemd[1]: Created slice user-500.slice. Nov 1 00:11:35.102510 systemd[1]: Starting user-runtime-dir@500.service... Nov 1 00:11:35.113389 systemd-logind[1712]: New session 1 of user core. Nov 1 00:11:35.134891 systemd[1]: Finished user-runtime-dir@500.service. Nov 1 00:11:35.140595 systemd[1]: Starting user@500.service... Nov 1 00:11:35.151310 (systemd)[2091]: pam_unix(systemd-user:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:35.354252 systemd[2091]: Queued start job for default target default.target. Nov 1 00:11:35.355453 systemd[2091]: Reached target paths.target. Nov 1 00:11:35.355512 systemd[2091]: Reached target sockets.target. Nov 1 00:11:35.355547 systemd[2091]: Reached target timers.target. Nov 1 00:11:35.355579 systemd[2091]: Reached target basic.target. Nov 1 00:11:35.355812 systemd[1]: Started user@500.service. Nov 1 00:11:35.357904 systemd[1]: Started session-1.scope. Nov 1 00:11:35.360310 systemd[2091]: Reached target default.target. Nov 1 00:11:35.360829 systemd[2091]: Startup finished in 196ms. Nov 1 00:11:35.508233 systemd[1]: Started sshd@1-172.31.30.50:22-147.75.109.163:35204.service. Nov 1 00:11:35.592035 systemd[1]: var-lib-docker-overlay2-a4b97e74e10795379a52232bca18d6f15a1e1ab5ace3c3dcec9a006d7b845f7a-merged.mount: Deactivated successfully. Nov 1 00:11:35.633390 etcd-wrapper[2040]: 435b7bf0967c: Pull complete Nov 1 00:11:35.722854 sshd[2100]: Accepted publickey for core from 147.75.109.163 port 35204 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:35.724091 sshd[2100]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:35.735702 systemd[1]: Started session-2.scope. Nov 1 00:11:35.736571 systemd-logind[1712]: New session 2 of user core. Nov 1 00:11:35.751082 etcd-wrapper[2040]: 17e4a5f7c1b5: Pull complete Nov 1 00:11:35.868840 etcd-wrapper[2040]: 5b0292999756: Pull complete Nov 1 00:11:35.878987 etcd-wrapper[2040]: Digest: sha256:96255d1ad67e7afcea46b4dc1b7e74024b9f6971193cb7316b093b3b5671efb0 Nov 1 00:11:35.882528 etcd-wrapper[2040]: Status: Downloaded newer image for quay.io/coreos/etcd:v3.5.0-arm64 Nov 1 00:11:35.888497 sshd[2100]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:35.894809 systemd[1]: session-2.scope: Deactivated successfully. Nov 1 00:11:35.896058 systemd-logind[1712]: Session 2 logged out. Waiting for processes to exit. Nov 1 00:11:35.896327 systemd[1]: sshd@1-172.31.30.50:22-147.75.109.163:35204.service: Deactivated successfully. Nov 1 00:11:35.898622 systemd-logind[1712]: Removed session 2. Nov 1 00:11:35.916997 systemd[1]: Started sshd@2-172.31.30.50:22-147.75.109.163:35218.service. Nov 1 00:11:35.967839 systemd[1]: var-lib-docker-overlay2-24fc7ee946df462730ff1c4f8c0ceab78effe0e41804aee2cf43a2963bc4b3c9-merged.mount: Deactivated successfully. Nov 1 00:11:36.082534 env[1726]: time="2025-11-01T00:11:36.082408472Z" level=info msg="loading plugin \"io.containerd.event.v1.publisher\"..." runtime=io.containerd.runc.v2 type=io.containerd.event.v1 Nov 1 00:11:36.083358 env[1726]: time="2025-11-01T00:11:36.083284352Z" level=info msg="loading plugin \"io.containerd.internal.v1.shutdown\"..." runtime=io.containerd.runc.v2 type=io.containerd.internal.v1 Nov 1 00:11:36.083558 env[1726]: time="2025-11-01T00:11:36.083498120Z" level=info msg="loading plugin \"io.containerd.ttrpc.v1.task\"..." runtime=io.containerd.runc.v2 type=io.containerd.ttrpc.v1 Nov 1 00:11:36.084243 env[1726]: time="2025-11-01T00:11:36.084134708Z" level=info msg="starting signal loop" namespace=moby path=/run/containerd/io.containerd.runtime.v2.task/moby/d40a86fe001fd0eda03882b82164a73c700eb239a111aefee8784d8285517b73 pid=2133 runtime=io.containerd.runc.v2 Nov 1 00:11:36.101556 sshd[2118]: Accepted publickey for core from 147.75.109.163 port 35218 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:36.105854 sshd[2118]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:36.117201 systemd[1]: Started docker-d40a86fe001fd0eda03882b82164a73c700eb239a111aefee8784d8285517b73.scope. Nov 1 00:11:36.125262 systemd-logind[1712]: New session 3 of user core. Nov 1 00:11:36.128359 systemd[1]: Started session-3.scope. Nov 1 00:11:36.266367 sshd[2118]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:36.270803 systemd[1]: sshd@2-172.31.30.50:22-147.75.109.163:35218.service: Deactivated successfully. Nov 1 00:11:36.272060 systemd[1]: session-3.scope: Deactivated successfully. Nov 1 00:11:36.273287 systemd-logind[1712]: Session 3 logged out. Waiting for processes to exit. Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"info","ts":1761955896.2684555,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_DATA_DIR","variable-value":"/var/lib/etcd"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"info","ts":1761955896.2686121,"caller":"flags/flag.go:113","msg":"recognized and used environment variable","variable-name":"ETCD_NAME","variable-value":"ec287366509f292a56e48654bf382e4c"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"warn","ts":1761955896.2686653,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_URL=quay.io/coreos/etcd"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"warn","ts":1761955896.26873,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_IMAGE_TAG=v3.5.0-arm64"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"warn","ts":1761955896.268747,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_USER=etcd"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"warn","ts":1761955896.268794,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_SSL_DIR=/etc/ssl/certs"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"warn","ts":1761955896.268812,"caller":"flags/flag.go:93","msg":"unrecognized environment variable","environment-variable":"ETCD_UNSUPPORTED_ARCH=arm64"} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:36.268Z","caller":"etcdmain/etcd.go:72","msg":"Running: ","args":["/usr/local/bin/etcd","--listen-peer-urls=http://172.31.30.50:2380","--listen-client-urls=http://0.0.0.0:2379","--initial-advertise-peer-urls=http://172.31.30.50:2380","--advertise-client-urls=http://172.31.30.50:2379","--discovery=https://discovery.etcd.io/c2518d6f875ce35375eee7f849a09c7b"]} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:36.269Z","caller":"embed/etcd.go:131","msg":"configuring peer listeners","listen-peer-urls":["http://172.31.30.50:2380"]} Nov 1 00:11:36.274144 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:36.269Z","caller":"embed/etcd.go:139","msg":"configuring client listeners","listen-client-urls":["http://0.0.0.0:2379"]} Nov 1 00:11:36.276547 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:36.269Z","caller":"embed/etcd.go:307","msg":"starting an etcd server","etcd-version":"3.5.0","git-sha":"946a5a6f2","go-version":"go1.16.3","go-os":"linux","go-arch":"arm64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"ec287366509f292a56e48654bf382e4c","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":100000,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["http://172.31.30.50:2380"],"listen-peer-urls":["http://172.31.30.50:2380"],"advertise-client-urls":["http://172.31.30.50:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"ec287366509f292a56e48654bf382e4c=http://172.31.30.50:2380","initial-cluster-state":"new","initial-cluster-token":"https://discovery.etcd.io/c2518d6f875ce35375eee7f849a09c7b","quota-size-bytes":2147483648,"pre-vote":true,"initial-corrupt-check":false,"corrupt-check-time-interval":"0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"https://discovery.etcd.io/c2518d6f875ce35375eee7f849a09c7b","discovery-proxy":"","downgrade-check-interval":"5s"} Nov 1 00:11:36.275429 systemd-logind[1712]: Removed session 3. Nov 1 00:11:36.279770 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:36.279Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.101044ms"} Nov 1 00:11:37.035042 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.034Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"55711a79ce0f4fad"} Nov 1 00:11:37.035042 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.034Z","caller":"v2discovery/discovery.go:336","msg":"found self from discovery server","discovery-url":"https://discovery.etcd.io","self":"5a560ca1eff52c8c"} Nov 1 00:11:37.035631 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.034Z","caller":"v2discovery/discovery.go:342","msg":"found peer from discovery server","discovery-url":"https://discovery.etcd.io","peer":"c59812c78fc18b54"} Nov 1 00:11:37.035631 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.034Z","caller":"v2discovery/discovery.go:378","msg":"found all needed peers from discovery server","discovery-url":"https://discovery.etcd.io","found-peers":3} Nov 1 00:11:37.039651 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","caller":"etcdserver/raft.go:448","msg":"starting local member","local-member-id":"5a560ca1eff52c8c","cluster-id":"8d4ea35519623d65"} Nov 1 00:11:37.040094 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=()"} Nov 1 00:11:37.040094 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became follower at term 0"} Nov 1 00:11:37.040094 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5a560ca1eff52c8c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} Nov 1 00:11:37.040094 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became follower at term 1"} Nov 1 00:11:37.040658 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613)"} Nov 1 00:11:37.040658 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613 6509404201065720972)"} Nov 1 00:11:37.040658 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.040Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613 6509404201065720972 14238150870251440980)"} Nov 1 00:11:37.042207 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:37.041Z","caller":"auth/store.go:1220","msg":"simple token is not cryptographically signed"} Nov 1 00:11:37.045358 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.045Z","caller":"mvcc/kvstore.go:415","msg":"kvstore restored","current-rev":1} Nov 1 00:11:37.047530 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.047Z","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"} Nov 1 00:11:37.049000 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.048Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.049395 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.048Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.050092 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.049Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.050852 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.050Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.051502 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.051Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad","remote-peer-urls":["http://172.31.31.16:2380"]} Nov 1 00:11:37.051502 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.051Z","caller":"rafthttp/peer.go:133","msg":"starting remote peer","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.052142 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.050Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.052142 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.050Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.052677 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.050Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.053280 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.052Z","caller":"rafthttp/pipeline.go:72","msg":"started HTTP pipelining with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.056699 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.056Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.057339 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.056Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.059454 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.059Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.060367 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.059Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.061043 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.060Z","caller":"rafthttp/stream.go:169","msg":"started stream writer with remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.061590 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.060Z","caller":"rafthttp/peer.go:137","msg":"started remote peer","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.061590 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.061Z","caller":"rafthttp/transport.go:317","msg":"added remote peer","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54","remote-peer-urls":["http://172.31.18.19:2380"]} Nov 1 00:11:37.061590 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.061Z","caller":"etcdserver/server.go:843","msg":"starting etcd server","local-member-id":"5a560ca1eff52c8c","local-server-version":"3.5.0","cluster-version":"to_be_decided"} Nov 1 00:11:37.063459 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.063Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.064334 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.063Z","caller":"rafthttp/stream.go:395","msg":"started stream reader with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.065829 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613 6509404201065720972 14238150870251440980)"} Nov 1 00:11:37.066534 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.066Z","caller":"embed/etcd.go:276","msg":"now serving peer/client/metrics","local-member-id":"5a560ca1eff52c8c","initial-advertise-peer-urls":["http://172.31.30.50:2380"],"listen-peer-urls":["http://172.31.30.50:2380"],"advertise-client-urls":["http://172.31.30.50:2379"],"listen-client-urls":["http://0.0.0.0:2379"],"listen-metrics-urls":[]} Nov 1 00:11:37.067264 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.066Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"8d4ea35519623d65","local-member-id":"5a560ca1eff52c8c","added-peer-id":"55711a79ce0f4fad","added-peer-peer-urls":["http://172.31.31.16:2380"]} Nov 1 00:11:37.067877 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.067Z","caller":"embed/etcd.go:580","msg":"serving peer traffic","address":"172.31.30.50:2380"} Nov 1 00:11:37.067877 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.067Z","caller":"embed/etcd.go:552","msg":"cmux::serve","address":"172.31.30.50:2380"} Nov 1 00:11:37.068741 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.068Z","caller":"etcdserver/server.go:744","msg":"starting initial election tick advance","election-ticks":10} Nov 1 00:11:37.069375 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.068Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"5a560ca1eff52c8c","to":"55711a79ce0f4fad","stream-type":"stream MsgApp v2"} Nov 1 00:11:37.069375 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.068Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.070165 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.069Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613 6509404201065720972 14238150870251440980)"} Nov 1 00:11:37.070165 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.069Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"5a560ca1eff52c8c","to":"55711a79ce0f4fad","stream-type":"stream Message"} Nov 1 00:11:37.071107 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.070Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:11:37.071107 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.070Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"5a560ca1eff52c8c","to":"c59812c78fc18b54","stream-type":"stream MsgApp v2"} Nov 1 00:11:37.071107 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.070Z","caller":"rafthttp/peer_status.go:53","msg":"peer became active","peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.072093 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.071Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.072576 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.071Z","caller":"rafthttp/stream.go:249","msg":"set message encoder","from":"5a560ca1eff52c8c","to":"c59812c78fc18b54","stream-type":"stream Message"} Nov 1 00:11:37.073135 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.072Z","caller":"rafthttp/stream.go:274","msg":"established TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.073135 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.071Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"8d4ea35519623d65","local-member-id":"5a560ca1eff52c8c","added-peer-id":"5a560ca1eff52c8c","added-peer-peer-urls":["http://172.31.30.50:2380"]} Nov 1 00:11:37.074038 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c switched to configuration voters=(6156731276042653613 6509404201065720972 14238150870251440980)"} Nov 1 00:11:37.074865 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.073Z","caller":"membership/cluster.go:393","msg":"added member","cluster-id":"8d4ea35519623d65","local-member-id":"5a560ca1eff52c8c","added-peer-id":"c59812c78fc18b54","added-peer-peer-urls":["http://172.31.18.19:2380"]} Nov 1 00:11:37.075609 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.074Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.076893 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.076Z","caller":"rafthttp/stream.go:412","msg":"established TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:37.118876 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.118Z","caller":"etcdserver/server.go:767","msg":"initialized peer connections; fast-forwarding election ticks","local-member-id":"5a560ca1eff52c8c","forward-ticks":8,"forward-duration":"800ms","election-ticks":10,"election-timeout":"1s","active-remote-members":2} Nov 1 00:11:37.455253 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.454Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 1, index: 3, vote: 0] cast MsgPreVote for 55711a79ce0f4fad [logterm: 1, index: 3] at term 1"} Nov 1 00:11:37.459855 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [term: 1] received a MsgVote message with higher term from 55711a79ce0f4fad [term: 2]"} Nov 1 00:11:37.459855 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became follower at term 2"} Nov 1 00:11:37.459855 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 1, index: 3, vote: 0] cast MsgVote for 55711a79ce0f4fad [logterm: 1, index: 3] at term 2"} Nov 1 00:11:37.461403 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a560ca1eff52c8c elected leader 55711a79ce0f4fad at term 2"} Nov 1 00:11:37.465622 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.465Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"} Nov 1 00:11:37.467004 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.466Z","caller":"embed/serve.go:140","msg":"serving client traffic insecurely; this is strongly discouraged!","address":"[::]:2379"} Nov 1 00:11:37.467688 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.465Z","caller":"etcdserver/server.go:2027","msg":"published local member to cluster through raft","local-member-id":"5a560ca1eff52c8c","local-member-attributes":"{Name:ec287366509f292a56e48654bf382e4c ClientURLs:[http://172.31.30.50:2379]}","request-path":"/0/members/5a560ca1eff52c8c/attributes","cluster-id":"8d4ea35519623d65","publish-timeout":"7s"} Nov 1 00:11:37.468283 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.467Z","caller":"etcdmain/main.go:47","msg":"notifying init daemon"} Nov 1 00:11:37.468273 systemd[1]: Started etcd-member.service. Nov 1 00:11:37.468946 systemd[1]: Reached target multi-user.target. Nov 1 00:11:37.471777 systemd[1]: Starting systemd-update-utmp-runlevel.service... Nov 1 00:11:37.476128 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.472Z","caller":"etcdmain/main.go:53","msg":"successfully notified init daemon"} Nov 1 00:11:37.476128 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.474Z","caller":"membership/cluster.go:531","msg":"set initial cluster version","cluster-id":"8d4ea35519623d65","local-member-id":"5a560ca1eff52c8c","cluster-version":"3.5"} Nov 1 00:11:37.476128 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:11:37.475Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} Nov 1 00:11:37.488169 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Nov 1 00:11:37.488639 systemd[1]: Finished systemd-update-utmp-runlevel.service. Nov 1 00:11:37.492048 systemd[1]: Startup finished in 1.215s (kernel) + 7.176s (initrd) + 20.708s (userspace) = 29.101s. Nov 1 00:11:39.447529 amazon-ssm-agent[1716]: 2025-11-01 00:11:39 INFO [MessagingDeliveryService] [Association] No associations on boot. Requerying for associations after 30 seconds. Nov 1 00:11:46.293799 systemd[1]: Started sshd@3-172.31.30.50:22-147.75.109.163:53738.service. Nov 1 00:11:46.465599 sshd[2179]: Accepted publickey for core from 147.75.109.163 port 53738 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:46.468046 sshd[2179]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:46.476727 systemd[1]: Started session-4.scope. Nov 1 00:11:46.477541 systemd-logind[1712]: New session 4 of user core. Nov 1 00:11:46.607210 sshd[2179]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:46.612529 systemd[1]: sshd@3-172.31.30.50:22-147.75.109.163:53738.service: Deactivated successfully. Nov 1 00:11:46.613738 systemd[1]: session-4.scope: Deactivated successfully. Nov 1 00:11:46.614967 systemd-logind[1712]: Session 4 logged out. Waiting for processes to exit. Nov 1 00:11:46.616811 systemd-logind[1712]: Removed session 4. Nov 1 00:11:46.634690 systemd[1]: Started sshd@4-172.31.30.50:22-147.75.109.163:53750.service. Nov 1 00:11:46.806893 sshd[2185]: Accepted publickey for core from 147.75.109.163 port 53750 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:46.808517 sshd[2185]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:46.817531 systemd[1]: Started session-5.scope. Nov 1 00:11:46.818508 systemd-logind[1712]: New session 5 of user core. Nov 1 00:11:46.937443 sshd[2185]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:46.942263 systemd[1]: session-5.scope: Deactivated successfully. Nov 1 00:11:46.943425 systemd[1]: sshd@4-172.31.30.50:22-147.75.109.163:53750.service: Deactivated successfully. Nov 1 00:11:46.945054 systemd-logind[1712]: Session 5 logged out. Waiting for processes to exit. Nov 1 00:11:46.947347 systemd-logind[1712]: Removed session 5. Nov 1 00:11:46.965065 systemd[1]: Started sshd@5-172.31.30.50:22-147.75.109.163:53754.service. Nov 1 00:11:47.138178 sshd[2191]: Accepted publickey for core from 147.75.109.163 port 53754 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:47.140793 sshd[2191]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:47.149938 systemd[1]: Started session-6.scope. Nov 1 00:11:47.150874 systemd-logind[1712]: New session 6 of user core. Nov 1 00:11:47.279671 sshd[2191]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:47.284618 systemd-logind[1712]: Session 6 logged out. Waiting for processes to exit. Nov 1 00:11:47.285052 systemd[1]: sshd@5-172.31.30.50:22-147.75.109.163:53754.service: Deactivated successfully. Nov 1 00:11:47.286430 systemd[1]: session-6.scope: Deactivated successfully. Nov 1 00:11:47.287823 systemd-logind[1712]: Removed session 6. Nov 1 00:11:47.308647 systemd[1]: Started sshd@6-172.31.30.50:22-147.75.109.163:53760.service. Nov 1 00:11:47.485795 sshd[2198]: Accepted publickey for core from 147.75.109.163 port 53760 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:47.488695 sshd[2198]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:47.496934 systemd[1]: Started session-7.scope. Nov 1 00:11:47.497944 systemd-logind[1712]: New session 7 of user core. Nov 1 00:11:47.627431 sudo[2201]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/sbin/setenforce 1 Nov 1 00:11:47.628694 sudo[2201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:11:47.642008 dbus-daemon[1706]: avc: received setenforce notice (enforcing=1) Nov 1 00:11:47.645697 sudo[2201]: pam_unix(sudo:session): session closed for user root Nov 1 00:11:47.672141 sshd[2198]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:47.678110 systemd-logind[1712]: Session 7 logged out. Waiting for processes to exit. Nov 1 00:11:47.679255 systemd[1]: sshd@6-172.31.30.50:22-147.75.109.163:53760.service: Deactivated successfully. Nov 1 00:11:47.680613 systemd[1]: session-7.scope: Deactivated successfully. Nov 1 00:11:47.682199 systemd-logind[1712]: Removed session 7. Nov 1 00:11:47.699886 systemd[1]: Started sshd@7-172.31.30.50:22-147.75.109.163:53770.service. Nov 1 00:11:47.875473 sshd[2205]: Accepted publickey for core from 147.75.109.163 port 53770 ssh2: RSA SHA256:l10clL99NTgBLZDdAUsIsAniCj4DES+0hQanxvSOioM Nov 1 00:11:47.878082 sshd[2205]: pam_unix(sshd:session): session opened for user core(uid=500) by (uid=0) Nov 1 00:11:47.885847 systemd-logind[1712]: New session 8 of user core. Nov 1 00:11:47.887141 systemd[1]: Started session-8.scope. Nov 1 00:11:47.994224 sudo[2209]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/rm -rf /etc/audit/rules.d/80-selinux.rules /etc/audit/rules.d/99-default.rules Nov 1 00:11:47.995212 sudo[2209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:11:48.001050 sudo[2209]: pam_unix(sudo:session): session closed for user root Nov 1 00:11:48.010291 sudo[2208]: core : PWD=/home/core ; USER=root ; COMMAND=/usr/bin/systemctl restart audit-rules Nov 1 00:11:48.011289 sudo[2208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=500) Nov 1 00:11:48.028835 systemd[1]: Stopping audit-rules.service... Nov 1 00:11:48.029000 audit: CONFIG_CHANGE auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 1 00:11:48.033185 kernel: kauditd_printk_skb: 65 callbacks suppressed Nov 1 00:11:48.033291 kernel: audit: type=1305 audit(1761955908.029:158): auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 op=remove_rule key=(null) list=5 res=1 Nov 1 00:11:48.029000 audit[2212]: SYSCALL arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffed667400 a2=420 a3=0 items=0 ppid=1 pid=2212 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/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:11:48.038907 auditctl[2212]: No rules Nov 1 00:11:48.039960 systemd[1]: audit-rules.service: Deactivated successfully. Nov 1 00:11:48.040353 systemd[1]: Stopped audit-rules.service. Nov 1 00:11:48.049662 kernel: audit: type=1300 audit(1761955908.029:158): arch=c00000b7 syscall=206 success=yes exit=1056 a0=3 a1=ffffed667400 a2=420 a3=0 items=0 ppid=1 pid=2212 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/sbin/auditctl" subj=system_u:system_r:kernel_t:s0 key=(null) Nov 1 00:11:48.051335 systemd[1]: Starting audit-rules.service... Nov 1 00:11:48.029000 audit: PROCTITLE proctitle=2F7362696E2F617564697463746C002D44 Nov 1 00:11:48.056838 kernel: audit: type=1327 audit(1761955908.029:158): proctitle=2F7362696E2F617564697463746C002D44 Nov 1 00:11:48.038000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.065736 kernel: audit: type=1131 audit(1761955908.038:159): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.085166 augenrules[2229]: No rules Nov 1 00:11:48.086832 systemd[1]: Finished audit-rules.service. Nov 1 00:11:48.085000 audit[1]: SERVICE_START pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.089114 sudo[2208]: pam_unix(sudo:session): session closed for user root Nov 1 00:11:48.087000 audit[2208]: USER_END pid=2208 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.106331 kernel: audit: type=1130 audit(1761955908.085:160): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=audit-rules comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.106426 kernel: audit: type=1106 audit(1761955908.087:161): pid=2208 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_limits,pam_env,pam_unix,pam_permit,pam_systemd acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.106489 kernel: audit: type=1104 audit(1761955908.087:162): pid=2208 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.087000 audit[2208]: CRED_DISP pid=2208 uid=500 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="root" exe="/usr/bin/sudo" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.118743 sshd[2205]: pam_unix(sshd:session): session closed for user core Nov 1 00:11:48.119000 audit[2205]: USER_END pid=2205 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=147.75.109.163 addr=147.75.109.163 terminal=ssh res=success' Nov 1 00:11:48.124913 systemd[1]: sshd@7-172.31.30.50:22-147.75.109.163:53770.service: Deactivated successfully. Nov 1 00:11:48.126104 systemd[1]: session-8.scope: Deactivated successfully. Nov 1 00:11:48.127843 systemd-logind[1712]: Session 8 logged out. Waiting for processes to exit. Nov 1 00:11:48.129569 systemd-logind[1712]: Removed session 8. Nov 1 00:11:48.119000 audit[2205]: CRED_DISP pid=2205 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=147.75.109.163 addr=147.75.109.163 terminal=ssh res=success' Nov 1 00:11:48.142396 kernel: audit: type=1106 audit(1761955908.119:163): pid=2205 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:session_close grantors=pam_loginuid,pam_env,pam_lastlog,pam_limits,pam_env,pam_unix,pam_permit,pam_systemd,pam_mail acct="core" exe="/usr/sbin/sshd" hostname=147.75.109.163 addr=147.75.109.163 terminal=ssh res=success' Nov 1 00:11:48.142490 kernel: audit: type=1104 audit(1761955908.119:164): pid=2205 uid=0 auid=500 ses=8 subj=system_u:system_r:kernel_t:s0 msg='op=PAM:setcred grantors=pam_env,pam_faillock,pam_unix acct="core" exe="/usr/sbin/sshd" hostname=147.75.109.163 addr=147.75.109.163 terminal=ssh res=success' Nov 1 00:11:48.123000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.30.50:22-147.75.109.163:53770 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:48.151713 kernel: audit: type=1131 audit(1761955908.123:165): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=sshd@7-172.31.30.50:22-147.75.109.163:53770 comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:52.655031 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:52.654Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54","error":"EOF"} Nov 1 00:11:52.656610 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:52.654Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54","error":"EOF"} Nov 1 00:11:52.680313 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:52.679Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"c59812c78fc18b54","error":"failed to dial c59812c78fc18b54 on stream MsgApp v2 (peer c59812c78fc18b54 failed to find local node 5a560ca1eff52c8c)"} Nov 1 00:11:56.200486 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Nov 1 00:11:56.199000 audit[1]: SERVICE_STOP pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:56.209807 kernel: audit: type=1131 audit(1761955916.199:166): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=system_u:system_r:kernel_t:s0 msg='unit=systemd-hostnamed comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' Nov 1 00:11:56.236000 audit: BPF prog-id=31 op=UNLOAD Nov 1 00:11:56.236000 audit: BPF prog-id=30 op=UNLOAD Nov 1 00:11:56.243225 kernel: audit: type=1334 audit(1761955916.236:167): prog-id=31 op=UNLOAD Nov 1 00:11:56.243284 kernel: audit: type=1334 audit(1761955916.236:168): prog-id=30 op=UNLOAD Nov 1 00:11:56.243325 kernel: audit: type=1334 audit(1761955916.236:169): prog-id=29 op=UNLOAD Nov 1 00:11:56.236000 audit: BPF prog-id=29 op=UNLOAD Nov 1 00:11:57.588207 systemd-timesyncd[1679]: Contacted time server 129.146.193.200:123 (2.flatcar.pool.ntp.org). Nov 1 00:11:57.588616 systemd-timesyncd[1679]: Initial clock synchronization to Sat 2025-11-01 00:11:57.661583 UTC. Nov 1 00:11:58.727619 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:58.727Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:11:58.728476 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:11:58.727Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"c59812c78fc18b54"} Nov 1 00:12:09.469848 amazon-ssm-agent[1716]: 2025-11-01 00:12:09 INFO [MessagingDeliveryService] [Association] Schedule manager refreshed with 0 associations, 0 new associations associated Nov 1 00:12:11.406970 update_engine[1713]: I1101 00:12:11.406893 1713 update_attempter.cc:509] Updating boot flags... Nov 1 00:12:12.066209 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:12.065Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"c59812c78fc18b54","rtt":"203.101µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:12.066209 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:12.065Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"c59812c78fc18b54","rtt":"322.282µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:12.565122 amazon-ssm-agent[1716]: 2025-11-01 00:12:12 INFO [HealthCheck] HealthCheck reporting agent health. Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.015Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [term 2] received MsgTimeoutNow from 55711a79ce0f4fad and starts an election to get leadership."} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 2"} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became candidate at term 3"} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 2, index: 11] sent MsgVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 2, index: 11] sent MsgVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:15.016469 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.016Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a560ca1eff52c8c lost leader 55711a79ce0f4fad at term 3"} Nov 1 00:12:15.018812 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgVoteResp from 55711a79ce0f4fad at term 3"} Nov 1 00:12:15.018812 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c has received 2 MsgVoteResp votes and 0 vote rejections"} Nov 1 00:12:15.019197 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.018Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became leader at term 3"} Nov 1 00:12:15.019581 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:15.019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a560ca1eff52c8c elected leader 5a560ca1eff52c8c at term 3"} Nov 1 00:12:15.555862 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:15.555Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad","error":"EOF"} Nov 1 00:12:15.556780 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:15.556Z","caller":"rafthttp/stream.go:421","msg":"lost TCP streaming connection with remote peer","stream-reader-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad","error":"EOF"} Nov 1 00:12:15.561216 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:15.560Z","caller":"rafthttp/peer_status.go:66","msg":"peer became inactive (message send to peer failed)","peer-id":"55711a79ce0f4fad","error":"failed to dial 55711a79ce0f4fad on stream MsgApp v2 (peer 55711a79ce0f4fad failed to find local node 5a560ca1eff52c8c)"} Nov 1 00:12:15.942046 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:15.941Z","caller":"rafthttp/stream.go:223","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream Message","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:12:16.941575 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:16.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:85","msg":"5a560ca1eff52c8c stepped down to follower since quorum is not active"} Nov 1 00:12:16.942500 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:16.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became follower at term 3"} Nov 1 00:12:16.942500 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:16.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5a560ca1eff52c8c lost leader 5a560ca1eff52c8c at term 3"} Nov 1 00:12:17.023182 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:17.022Z","caller":"etcdserver/cluster_util.go:288","msg":"failed to reach the peer URL","address":"http://172.31.18.19:2380/version","remote-member-id":"c59812c78fc18b54","error":"Get \"http://172.31.18.19:2380/version\": dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:17.023570 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:17.023Z","caller":"etcdserver/cluster_util.go:155","msg":"failed to get version","remote-member-id":"c59812c78fc18b54","error":"Get \"http://172.31.18.19:2380/version\": dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:17.067156 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:17.066Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"c59812c78fc18b54","rtt":"322.282µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:17.067156 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:17.066Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"c59812c78fc18b54","rtt":"203.101µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:18.441786 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:18.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:18.441786 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:18.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:18.441786 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:18.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:18.442622 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:18.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:18.442622 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:18.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:19.941703 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:19.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:19.942370 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:19.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:19.942458 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:19.942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:19.942823 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:19.942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:19.943202 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:19.942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:21.441774 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:21.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:21.441774 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:21.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:21.441774 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:21.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:21.441774 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:21.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:21.441774 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:21.441Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:22.051002 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:22.050Z","caller":"rafthttp/stream.go:194","msg":"lost TCP streaming connection with remote peer","stream-writer-type":"stream MsgApp v2","local-member-id":"5a560ca1eff52c8c","remote-peer-id":"55711a79ce0f4fad"} Nov 1 00:12:22.068257 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:22.067Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_SNAPSHOT","remote-peer-id":"c59812c78fc18b54","rtt":"203.101µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:22.068257 etcd-wrapper[2040]: {"level":"warn","ts":"2025-11-01T00:12:22.067Z","caller":"rafthttp/probing_status.go:68","msg":"prober detected unhealthy status","round-tripper-name":"ROUND_TRIPPER_RAFT_MESSAGE","remote-peer-id":"c59812c78fc18b54","rtt":"322.282µs","error":"dial tcp 172.31.18.19:2380: i/o timeout"} Nov 1 00:12:22.941270 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:22.940Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:22.941270 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:22.940Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:22.941270 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:22.940Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:22.942112 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:22.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:22.942112 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:22.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:24.441088 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:24.440Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:24.441088 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:24.440Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:24.441088 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:24.440Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:24.441088 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:24.440Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:24.441088 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:24.440Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"} Nov 1 00:12:25.941600 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:25.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c is starting a new election at term 3"} Nov 1 00:12:25.941600 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:25.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c became pre-candidate at term 3"} Nov 1 00:12:25.941600 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:25.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c received MsgPreVoteResp from 5a560ca1eff52c8c at term 3"} Nov 1 00:12:25.942540 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:25.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to 55711a79ce0f4fad at term 3"} Nov 1 00:12:25.942540 etcd-wrapper[2040]: {"level":"info","ts":"2025-11-01T00:12:25.941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5a560ca1eff52c8c [logterm: 3, index: 12] sent MsgPreVote request to c59812c78fc18b54 at term 3"}